Jobsub ID 78830.69@justin-prod-sched02.dune.hep.ac.uk
Jobsub ID | 78830.69@justin-prod-sched02.dune.hep.ac.uk |
Workflow ID | 3449 |
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:07:16 |
Site | UK_Durham |
Entry | DUNE_UK_SGridDurham_ce4 |
Last heartbeat | 2024-09-26 14:45:01 |
From worker node | Hostname | n204.dur.scotgrid.ac.uk |
cpuinfo | Intel(R) Xeon(R) Gold 5220 CPU @ 2.20GHz |
OS release | Scientific Linux release 7.9 (Nitrogen) |
Processors | 1 |
RSS bytes | 4193255424 (3999 MiB) |
Wall seconds limit | 171000 (47 hours) |
Inner Apptainer? | True |
Job state | jobscript_error |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2024-09-26 13:08:20 |
Input files | hd-protodune:np04hd_raw_run029107_0752_dataflow7_datawriter_0_20240907T031834.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 14:45:01 |
Saved logs | justin-logs:78830.69-justin-prod-sched02.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
----------------------------------------
no of hits closeby 12 event 180719 TrkackID 0 startx, y, z 332.934 608.891 143.279 wireno, peakt tpcno 461 2278.94 5 dist 0min T, max_T150.101 4400.62
no of hits closeby 0 event 180719 TrkackID 16 startx, y, z -365.583 579.343 392.241 wireno, peakt tpcno 182 5854.58 5 dist 0.917679min T, max_T5058 5855.17
no of hits closeby 12 event 180719 TrkackID 0 startx, y, z 332.934 608.891 143.279 wireno, peakt tpcno 461 2278.94 5 dist 0min T, max_T150.101 4400.62
no of hits closeby 0 event 180719 TrkackID 16 startx, y, z -365.583 579.343 392.241 wireno, peakt tpcno 182 5854.58 5 dist 0.917679min T, max_T5058 5855.17
Begin processing the 29th record. run: 29107 subRun: 1 event: 180727 at 26-Sep-2024 15:42:09 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 56252 traces, 56252 summary
Retagger: tagging trace set: gauss with 41565 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 41565 traces tagged "gauss"
FrameSaver: q=933554 n=748190 tag=gauss
wclsFrameSaver: saving 56252 traces tagged "wiener"
FrameSaver: q=1.01381e+06 n=681037 tag=wiener
1557 hits in TPC 0
2805 hits in TPC 1
3182 hits in TPC 2
2156 hits in TPC 3
4868 hits in TPC 4
6223 hits in TPC 5
5816 hits in TPC 6
2709 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 175 XUs and 88 XVs -> 21 XUVs
C:0 T:2 8601 XUs and 19439 XVs -> 903 XUVs
C:0 T:3 16 XUs and 32 XVs -> 0 XUVs
C:0 T:4 166 XUs and 189 XVs -> 3 XUVs
C:0 T:5 29004 XUs and 35295 XVs -> 1180 XUVs
C:0 T:6 9934 XUs and 14433 XVs -> 1190 XUVs
C:0 T:7 175 XUs and 246 XVs -> 8 XUVs
3305 XUVs total
1624 collection wire objects
3305 potential space points
Neighbour search...
99131 tests to find 48618 neighbours
Iterating with no regularization...
Begin: 9.58778e+06
0 8.63423e+06
1 8.58464e+06
2 8.57909e+06
Now with regularization...
Begin: 7.84436e+06
0 7.84213e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 0 event 180727 TrkackID 4 startx, y, z 16.8045 592.782 354.201 wireno, peakt tpcno 97 8.89023 5 dist 0min T, max_T5.4043 1416.16
no of hits closeby 0 event 180727 TrkackID 6 startx, y, z 151.076 147.298 459.703 wireno, peakt tpcno 326 2996.75 5 dist 0min T, max_T2550.05 4458.5
no of hits closeby 0 event 180727 TrkackID 4 startx, y, z 16.8045 592.782 354.201 wireno, peakt tpcno 97 8.89023 5 dist 0min T, max_T5.4043 1416.16
no of hits closeby 0 event 180727 TrkackID 6 startx, y, z 151.076 147.298 459.703 wireno, peakt tpcno 326 2996.75 5 dist 0min T, max_T2550.05 4458.5
Begin processing the 30th record. run: 29107 subRun: 1 event: 180735 at 26-Sep-2024 15:43:30 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 26792 traces, 26792 summary
Retagger: tagging trace set: gauss with 19632 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 19632 traces tagged "gauss"
FrameSaver: q=439516 n=372352 tag=gauss
wclsFrameSaver: saving 26792 traces tagged "wiener"
FrameSaver: q=475017 n=334550 tag=wiener
1628 hits in TPC 0
2167 hits in TPC 1
3264 hits in TPC 2
2387 hits in TPC 3
618 hits in TPC 4
590 hits in TPC 5
2995 hits in TPC 6
1897 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 2 XUs and 3 XVs -> 0 XUVs
C:0 T:2 14709 XUs and 29971 XVs -> 895 XUVs
C:0 T:3 9 XUs and 14 XVs -> 1 XUVs
C:0 T:4 85 XUs and 51 XVs -> 6 XUVs
C:0 T:5 237 XUs and 152 XVs -> 3 XUVs
C:0 T:6 17596 XUs and 44810 XVs -> 1307 XUVs
C:0 T:7 2 XUs and 1 XVs -> 0 XUVs
2212 XUVs total
764 collection wire objects
2212 potential space points
Neighbour search...
100902 tests to find 60014 neighbours
Iterating with no regularization...
Begin: 4.3532e+06
0 3.76099e+06
1 3.70944e+06
2 3.70126e+06
3 3.69888e+06
Now with regularization...
Begin: 3.51129e+06
0 3.50988e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 15:44:36 BST Closed output file "np04hd_raw_run029107_0752_dataflow7_datawriter_0_20240907T031834_reco_stage1_reco_stage2_20240926T144436_keepup.root"
26-Sep-2024 15:44:36 BST Closed input file "np04hd_raw_run029107_0752_dataflow7_datawriter_0_20240907T031834_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 65.4632 88.2312 128.759 85.0953 13.8077 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000333508 0.000924548 0.00235968 0.000786615 0.000538484 30
produce:fembfilter:PDHDFEMBFilter 0.690834 0.706002 0.751237 0.704878 0.011292 30
produce:wclsdatahd:WireCellToolkit 42.079 44.3314 49.0245 44.3007 1.19374 30
produce:gaushit:GausHitFinder 0.321741 0.759473 1.09101 0.717041 0.178377 30
produce:nhitsfilter:NumberOfHitsFilter 0.000199687 0.000353566 0.000488188 0.000346997 6.90101e-05 30
produce:reco3d:SpacePointSolver 0.249849 0.880528 4.01563 0.541477 0.771011 30
produce:hitpdune:DisambigFromSpacePoints 0.139667 0.58123 1.42047 0.489559 0.272047 30
produce:pandora:StandardPandora 6.66722 13.3093 30.0476 11.6115 5.46336 30
produce:pandoraWriter:StandardPandora 0.102336 0.15487 0.23573 0.155629 0.0310036 30
produce:pandoraTrack:LArPandoraTrackCreation 0.365716 1.49368 3.15676 1.39312 0.62482 30
produce:pandoraShower:LArPandoraShowerCreation 0.442074 1.70577 4.00297 1.54967 0.826669 30
produce:pandoracalo:Calorimetry 0.19664 0.691665 1.29822 0.679881 0.247443 30
produce:pandoracalonosce:Calorimetry 0.181316 0.625446 1.21066 0.608431 0.225826 30
produce:pandorapid:Chi2ParticleID 0.000949875 0.00184599 0.00416755 0.00178856 0.000543671 30
produce:pandoraShowercalo:ShowerCalorimetry 0.336225 1.46421 3.05515 1.22416 0.684512 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.334204 1.45305 3.02915 1.20868 0.688383 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0422677 0.129755 0.206968 0.123916 0.0330051 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0218765 0.0497319 0.0753799 0.0498391 0.0114035 30
produce:emtrkmichelid:EmTrackMichelId 11.8288 18.2243 27.1144 18.484 3.4892 30
[art]:TriggerResults:TriggerResultInserter 2.5121e-05 3.22416e-05 7.0125e-05 3.0312e-05 7.81786e-06 30
end_path:out1:RootOutput 6.172e-06 1.35486e-05 0.000177651 7.3955e-06 3.05742e-05 30
end_path:michelremoving:michelremoving 0.0173713 0.0946519 0.355718 0.040354 0.0906421 30
end_path:michelremovinggnocchi:michelremoving 0.0162138 0.0918825 0.351635 0.0367804 0.0909547 30
end_path:calibanagnocchi:CalibAnaTree 0.132848 0.527326 1.11362 0.494241 0.211144 30
end_path:out1:RootOutput(write) 0.382109 0.805042 1.25794 0.775037 0.184655 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5835.3 MB
Peak resident set size usage (VmHWM): 2959.97 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_0752_dataflow7_datawriter_0_20240907T031834_reco_stage1_reco_stage2_20240926T144436_keepup.root
\tHists: np04hd_raw_run029107_0752_dataflow7_datawriter_0_20240907T031834_reco_stage1_reco_stage2_20240926T144436_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