Jobsub ID 263766.32@justin-prod-sched01.dune.hep.ac.uk
Jobsub ID | 263766.32@justin-prod-sched01.dune.hep.ac.uk |
Workflow ID | 3453 |
Stage ID | 1 |
User name | calcuttj@fnal.gov |
HTCondor Group | group_dune.prod_mcsim |
Requested | Processors | 1 |
RSS bytes | 4193255424 (3999 MiB) |
Wall seconds limit | 18000 (5 hours) |
Submitted time | 2024-09-26 13:24:55 |
Site | UK_Sheffield |
Entry | DUNE_UK_Sheffield_lcgce1 |
Last heartbeat | 2024-09-26 14:50:47 |
From worker node | Hostname | wn002.hep |
cpuinfo | Intel(R) Core(TM) i7-5960X CPU @ 3.00GHz |
OS release | Scientific Linux release 7.9 (Nitrogen) |
Processors | 1 |
RSS bytes | 4193255424 (3999 MiB) |
Wall seconds limit | 257400 (71 hours) |
Inner Apptainer? | True |
Job state | jobscript_error |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2024-09-26 13:26:41 |
Input files | hd-protodune:np04hd_raw_run029107_3594_dataflow7_datawriter_0_20240909T035246.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 14:50:47 |
Saved logs | justin-logs:263766.32-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
TPC 4
4665 hits in TPC 5
5797 hits in TPC 6
3746 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 2787 XUs and 1906 XVs -> 303 XUVs
C:0 T:1 216 XUs and 292 XVs -> 18 XUVs
C:0 T:2 16030 XUs and 10859 XVs -> 335 XUVs
C:0 T:3 438 XUs and 350 XVs -> 11 XUVs
C:0 T:4 104 XUs and 111 XVs -> 9 XUVs
C:0 T:5 29266 XUs and 39348 XVs -> 1123 XUVs
C:0 T:6 42997 XUs and 19309 XVs -> 955 XUVs
C:0 T:7 89 XUs and 113 XVs -> 1 XUVs
2755 XUVs total
1199 collection wire objects
2755 potential space points
Neighbour search...
78645 tests to find 44582 neighbours
Iterating with no regularization...
Begin: 1.36774e+07
0 1.24955e+07
1 1.23248e+07
2 1.23173e+07
Now with regularization...
Begin: 1.17065e+07
0 1.17046e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 29th record. run: 29107 subRun: 1 event: 862831 at 26-Sep-2024 15:46:38 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 44897 traces, 44897 summary
Retagger: tagging trace set: gauss with 33051 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 33051 traces tagged "gauss"
FrameSaver: q=707350 n=621406 tag=gauss
wclsFrameSaver: saving 44897 traces tagged "wiener"
FrameSaver: q=751367 n=559521 tag=wiener
2085 hits in TPC 0
2695 hits in TPC 1
2690 hits in TPC 2
1905 hits in TPC 3
1225 hits in TPC 4
2736 hits in TPC 5
4341 hits in TPC 6
4744 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 56 XUs and 126 XVs -> 0 XUVs
C:0 T:2 3344 XUs and 10538 XVs -> 253 XUVs
C:0 T:3 26 XUs and 16 XVs -> 0 XUVs
C:0 T:4 18 XUs and 9 XVs -> 0 XUVs
C:0 T:5 4037 XUs and 4314 XVs -> 99 XUVs
C:0 T:6 14407 XUs and 14172 XVs -> 1230 XUVs
C:0 T:7 16 XUs and 15 XVs -> 2 XUVs
1584 XUVs total
656 collection wire objects
1584 potential space points
Neighbour search...
37600 tests to find 23918 neighbours
Iterating with no regularization...
Begin: 4.34438e+06
0 4.12987e+06
1 4.10922e+06
2 4.10607e+06
Now with regularization...
Begin: 3.79462e+06
0 3.79363e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 30th record. run: 29107 subRun: 1 event: 862839 at 26-Sep-2024 15:48:19 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 87623 traces, 87623 summary
Retagger: tagging trace set: gauss with 65658 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 65658 traces tagged "gauss"
FrameSaver: q=1.43728e+06 n=1187929 tag=gauss
wclsFrameSaver: saving 87623 traces tagged "wiener"
FrameSaver: q=1.56296e+06 n=1083995 tag=wiener
3883 hits in TPC 0
5186 hits in TPC 1
4800 hits in TPC 2
3172 hits in TPC 3
6516 hits in TPC 4
11428 hits in TPC 5
5828 hits in TPC 6
3615 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 10320 XUs and 8277 XVs -> 317 XUVs
C:0 T:2 15276 XUs and 17232 XVs -> 763 XUVs
C:0 T:3 27 XUs and 47 XVs -> 1 XUVs
C:0 T:4 417 XUs and 474 XVs -> 24 XUVs
C:0 T:5 52032 XUs and 66067 XVs -> 2431 XUVs
C:0 T:6 38194 XUs and 102206 XVs -> 1456 XUVs
C:0 T:7 1962 XUs and 1051 XVs -> 167 XUVs
5159 XUVs total
2093 collection wire objects
5159 potential space points
Neighbour search...
232859 tests to find 130442 neighbours
Iterating with no regularization...
Begin: 2.04066e+07
0 1.90628e+07
1 1.8973e+07
2 1.89605e+07
Now with regularization...
Begin: 1.80468e+07
0 1.80425e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 0 event 862839 TrkackID 7 startx, y, z 208.263 552.374 10.2853 wireno, peakt tpcno 203 2607.64 2 dist 111.52min T, max_T4.23087 2646.53
no of hits closeby 0 event 862839 TrkackID 7 startx, y, z 208.263 552.374 10.2853 wireno, peakt tpcno 203 2607.64 2 dist 111.52min T, max_T4.23087 2646.53
26-Sep-2024 15:50:26 BST Closed output file "np04hd_raw_run029107_3594_dataflow7_datawriter_0_20240909T035246_reco_stage1_reco_stage2_20240926T145026_keepup.root"
26-Sep-2024 15:50:26 BST Closed input file "np04hd_raw_run029107_3594_dataflow7_datawriter_0_20240909T035246_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 81.8041 110.361 147.045 108.056 17.197 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000385422 0.00171803 0.00356289 0.00147626 0.000811464 30
produce:fembfilter:PDHDFEMBFilter 0.526797 0.566831 0.845328 0.546326 0.0631402 30
produce:wclsdatahd:WireCellToolkit 54.1641 56.2701 59.3022 56.1096 1.13768 30
produce:gaushit:GausHitFinder 0.363545 0.692941 0.996672 0.680264 0.160321 30
produce:nhitsfilter:NumberOfHitsFilter 0.000218897 0.000330745 0.000558446 0.000319487 7.28054e-05 30
produce:reco3d:SpacePointSolver 0.175901 0.8777 4.35835 0.70833 0.816531 30
produce:hitpdune:DisambigFromSpacePoints 0.129405 0.575812 1.3018 0.477171 0.315682 30
produce:pandora:StandardPandora 4.17193 13.2004 27.9929 11.1658 5.63756 30
produce:pandoraWriter:StandardPandora 0.0776103 0.140078 0.197378 0.13533 0.0313796 30
produce:pandoraTrack:LArPandoraTrackCreation 0.63144 1.53013 3.36368 1.46689 0.703364 30
produce:pandoraShower:LArPandoraShowerCreation 0.410189 1.71965 5.01384 1.43324 0.997412 30
produce:pandoracalo:Calorimetry 0.300617 0.765435 1.75568 0.764262 0.328345 30
produce:pandoracalonosce:Calorimetry 0.277074 0.717957 1.5821 0.700191 0.31972 30
produce:pandorapid:Chi2ParticleID 0.00107919 0.00161076 0.0030148 0.00154314 0.000400844 30
produce:pandoraShowercalo:ShowerCalorimetry 0.363648 1.70858 4.03627 1.46932 0.884866 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.36385 1.64941 3.88579 1.40003 0.844547 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0760632 0.131007 0.210554 0.125337 0.0331173 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0280158 0.0495837 0.0797802 0.0474258 0.0117161 30
produce:emtrkmichelid:EmTrackMichelId 16.3921 28.1782 39.4998 28.389 6.47597 30
[art]:TriggerResults:TriggerResultInserter 1.6339e-05 2.98408e-05 7.0381e-05 2.7749e-05 1.10485e-05 30
end_path:out1:RootOutput 3.338e-06 6.10903e-06 2.0389e-05 4.468e-06 4.00457e-06 30
end_path:michelremoving:michelremoving 0.0176691 0.108378 0.417917 0.0438178 0.0999282 30
end_path:michelremovinggnocchi:michelremoving 0.0169451 0.101686 0.405249 0.0389792 0.0950495 30
end_path:calibanagnocchi:CalibAnaTree 0.223833 0.572789 1.17517 0.516189 0.26216 30
end_path:out1:RootOutput(write) 0.389621 0.682325 1.47719 0.639303 0.205706 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4921.25 MB
Peak resident set size usage (VmHWM): 2339.45 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_3594_dataflow7_datawriter_0_20240909T035246_reco_stage1_reco_stage2_20240926T145026_keepup.root
\tHists: np04hd_raw_run029107_3594_dataflow7_datawriter_0_20240909T035246_reco_stage1_reco_stage2_20240926T145026_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