justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 78475.56@justin-prod-sched02.dune.hep.ac.uk

Jobsub ID78475.56@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3448
Stage ID1
User namecalcuttj@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2024-09-26 10:03:54
SiteUK_Sheffield
EntryDUNE_UK_Sheffield_lcgce1
Last heartbeat2024-09-26 12:27:05
From worker nodeHostnamewn017.hep
cpuinfoIntel(R) Core(TM) i7-5960X CPU @ 3.00GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job stateoutputting_failed
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 10:32:48
Input fileshd-protodune:np04hd_raw_run029097_0147_dataflow7_datawriter_0_20240906T133250.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 12:27:05
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

eighbours
Iterating with no regularization...
Begin: 8.31666e+06
0 6.36235e+06
1 6.26756e+06
2 6.25482e+06
3 6.2519e+06
Now with regularization...
Begin: 5.57797e+06
0 5.57375e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  4   event 35511 TrkackID 19 startx, y, z -45.4471 83.0662 232.923  wireno, peakt tpcno 160 793.775 6 dist 0min T, max_T357.145 939.835
no of hits closeby  4   event 35511 TrkackID 19 startx, y, z -45.4471 83.0662 232.923  wireno, peakt tpcno 160 793.775 6 dist 0min T, max_T357.145 939.835
Begin processing the 29th record. run: 29097 subRun: 1 event: 35519 at 26-Sep-2024 12:52:33 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 83323 traces, 83323 summary
Retagger: tagging trace set: gauss with 59723 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 59723 traces tagged "gauss"
FrameSaver: q=1.32192e+06 n=1051607 tag=gauss
wclsFrameSaver: saving 83323 traces tagged "wiener"
FrameSaver: q=1.43818e+06 n=943030 tag=wiener
4454 hits in TPC 0
5484 hits in TPC 1
5729 hits in TPC 2
2402 hits in TPC 3
4621 hits in TPC 4
8206 hits in TPC 5
7801 hits in TPC 6
4292 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1265 XUs and 1079 XVs -> 73 XUVs
C:0 T:2 22171 XUs and 59747 XVs -> 1213 XUVs
C:0 T:3 75 XUs and 107 XVs -> 3 XUVs
C:0 T:4 180 XUs and 136 XVs -> 4 XUVs
C:0 T:5 39964 XUs and 34271 XVs -> 2712 XUVs
C:0 T:6 42431 XUs and 63498 XVs -> 2249 XUVs
C:0 T:7 18 XUs and 19 XVs -> 0 XUVs
6254 XUVs total
1997 collection wire objects
6254 potential space points
Neighbour search...
450166 tests to find 249664 neighbours
Iterating with no regularization...
Begin: 1.64994e+07
0 1.43583e+07
1 1.41879e+07
2 1.4166e+07
3 1.41606e+07
Now with regularization...
Begin: 1.34284e+07
0 1.34246e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29097 subRun: 1 event: 35527 at 26-Sep-2024 12:54:58 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 89768 traces, 89768 summary
Retagger: tagging trace set: gauss with 63890 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 63890 traces tagged "gauss"
FrameSaver: q=1.44679e+06 n=1146254 tag=gauss
wclsFrameSaver: saving 89768 traces tagged "wiener"
FrameSaver: q=1.58272e+06 n=1032345 tag=wiener
2824 hits in TPC 0
3842 hits in TPC 1
9266 hits in TPC 2
5552 hits in TPC 3
3114 hits in TPC 4
6441 hits in TPC 5
9667 hits in TPC 6
4892 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 165 XUs and 77 XVs -> 4 XUVs
C:0 T:2 63207 XUs and 117861 XVs -> 5241 XUVs
C:0 T:3 974 XUs and 1316 XVs -> 31 XUVs
C:0 T:4 40 XUs and 82 XVs -> 2 XUVs
C:0 T:5 34492 XUs and 42403 XVs -> 3473 XUVs
C:0 T:6 60861 XUs and 70171 XVs -> 1145 XUVs
C:0 T:7 131 XUs and 114 XVs -> 3 XUVs
9899 XUVs total
2127 collection wire objects
9899 potential space points
Neighbour search...
1529137 tests to find 721344 neighbours
Iterating with no regularization...
Begin: 3.21881e+07
0 2.80905e+07
1 2.77378e+07
2 2.76971e+07
3 2.76841e+07
Now with regularization...
Begin: 2.69341e+07
0 2.69236e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 35527 TrkackID 8 startx, y, z 130.319 598.801 128.542  wireno, peakt tpcno 305 3599.42 2 dist 368.613min T, max_T11.2992 3642
no of hits closeby  0   event 35527 TrkackID 8 startx, y, z 130.319 598.801 128.542  wireno, peakt tpcno 305 3599.42 2 dist 368.613min T, max_T11.2992 3642
26-Sep-2024 12:57:36 BST  Closed output file "np04hd_raw_run029097_0147_dataflow7_datawriter_0_20240906T133250_reco_stage1_reco_stage2_20240926T115736_keepup.root"
26-Sep-2024 12:57:36 BST  Closed input file "np04hd_raw_run029097_0147_dataflow7_datawriter_0_20240906T133250_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              80.2075       114.366       156.631       110.467       17.3684        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000438498   0.00188776    0.00376013    0.00196482    0.000861459      30     
produce:fembfilter:PDHDFEMBFilter                      0.543697      0.726975       1.04393       0.65767      0.193719        30     
produce:wclsdatahd:WireCellToolkit                      52.4212       58.1499       67.7955       57.9621       3.46306        30     
produce:gaushit:GausHitFinder                          0.429118      0.671517      0.977459      0.644313      0.144062        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000142509   0.000326425   0.00050389    0.000326101   6.57645e-05      30     
produce:reco3d:SpacePointSolver                        0.166852      0.929496       3.59356      0.697348      0.709734        30     
produce:hitpdune:DisambigFromSpacePoints               0.173116      0.519754       1.19344      0.464242      0.259813        30     
produce:pandora:StandardPandora                         5.47838       13.2639       25.791        12.9069       4.8253         30     
produce:pandoraWriter:StandardPandora                  0.0756304     0.144844      0.260314      0.140106      0.0374646       30     
produce:pandoraTrack:LArPandoraTrackCreation            0.55462       1.5886        3.28103       1.4038       0.691816        30     
produce:pandoraShower:LArPandoraShowerCreation         0.449679       1.87377       4.8295        1.51537       1.09104        30     
produce:pandoracalo:Calorimetry                        0.356162      0.817478       1.66582      0.766495      0.317111        30     
produce:pandoracalonosce:Calorimetry                   0.293794      0.760419       1.37114      0.723849      0.298437        30     
produce:pandorapid:Chi2ParticleID                     0.00105838    0.00169791    0.00308528     0.0016424    0.000430605      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.492756       1.74593       3.74466       1.55105      0.852073        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.499355       1.68705       3.37204       1.50244      0.781553        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0777146      0.13289      0.302395       0.12766      0.0432695       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry      0.02742      0.0453438     0.106864      0.0411318     0.0154497       30     
produce:emtrkmichelid:EmTrackMichelId                   17.0638       29.705        45.9861       28.5927       6.03341        30     
[art]:TriggerResults:TriggerResultInserter            1.6237e-05    3.22117e-05   6.8794e-05    3.0068e-05    1.38382e-05      30     
end_path:out1:RootOutput                               3.432e-06    5.6191e-06    1.9765e-05    4.5455e-06    3.27311e-06      30     
end_path:michelremoving:michelremoving                 0.0217651     0.0777775     0.389256      0.0414574     0.0800337       30     
end_path:michelremovinggnocchi:michelremoving          0.0211064     0.0743144     0.339351      0.0432502     0.0718546       30     
end_path:calibanagnocchi:CalibAnaTree                  0.197843      0.637628       1.41194      0.608558      0.268236        30     
end_path:out1:RootOutput(write)                        0.403918      0.696948       1.12442      0.674127      0.163812        30     
========================================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 4955.56 MB
  Peak resident set size usage (VmHWM): 2373.91 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029097_0147_dataflow7_datawriter_0_20240906T133250_reco_stage1_reco_stage2_20240926T115736_keepup.root
\tHists: np04hd_raw_run029097_0147_dataflow7_datawriter_0_20240906T133250_reco_stage1_reco_stage2_20240926T115736_keepup_hists.root
Forming reco metadata
/cvmfs/larsoft.opensciencegrid.org/products/python/v3_9_15/Linux64bit+3.10-2.17/bin/python: No module named meta_maker
Error in reco metadata
justIN time: 2024-11-17 05:15:06 UTC       justIN version: 01.01.09