Jobsub ID 209029.145@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
] Timer: WireCell::Gen::IncoherentAddNoise : 0.39 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.38 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.37 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.36 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.35 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.33 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Drifter : 0.29 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.22 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.21 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.19 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.18 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.17 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.16 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.16 sec
[15:29:29.603] I [ timer ] Timer: wcls::FrameSaver : 0.15 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.15 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.14 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.13 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.13 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.12 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.12 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.11 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Retagger : 0.11 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.11 sec
[15:29:29.603] I [ timer ] Timer: WireCell::Gen::Reframer : 0.09 sec
[15:29:29.603] I [ timer ] Timer: wcls::SimDepoSource : 0.05 sec
[15:29:29.603] I [ timer ] Timer: Total node execution : 138.95999879017472 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 8202 subRun: 0 event: 87340 at 29-Sep-2025 15:29:43 BST
SimDepoSource got 82266 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 82266 depos spanning: [-2245.39, 2244.33]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 12.69 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 12.66 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 12.47 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 10.47 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 10.28 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 10.01 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.75 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.56 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.45 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 7.05 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 6.05 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoTransform : 5.61 sec
[15:32:03.277] I [ timer ] Timer: wcls::SimChannelSink : 1.21 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.95 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.93 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.9 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.88 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.88 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.86 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.84 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.84 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.83 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.83 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.81 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.8 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.49 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.42 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.4 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.38 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.37 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.37 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.36 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.36 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.36 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Drifter : 0.35 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.35 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.34 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.32 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.21 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.21 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.2 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.19 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.18 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.18 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.18 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.16 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.15 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.15 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.15 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.12 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.11 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Retagger : 0.11 sec
[15:32:03.277] I [ timer ] Timer: wcls::FrameSaver : 0.11 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.11 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::Reframer : 0.11 sec
[15:32:03.277] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.08 sec
[15:32:03.277] I [ timer ] Timer: wcls::SimDepoSource : 0.07 sec
[15:32:03.277] I [ timer ] Timer: Total node execution : 132.2600006610155 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
29-Sep-2025 15:32:20 BST Closed output file "prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T135345Z_gen_008734_supernova_g4_detsim.root"
29-Sep-2025 15:32:20 BST Closed input file "prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T135345Z_gen_008734_supernova_g4.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 145.277 158.155 173.223 156.551 7.40814 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00138774 0.0025772 0.00472762 0.00253884 0.00102556 10
simulate:tpcrawdecoder:WireCellToolkit 134.885 147.772 162.115 145.88 7.2259 10
simulate:opdigi:OpDetDigitizerDUNE 1.79229 1.88337 1.98099 1.87458 0.0541491 10
simulate:rns:RandomNumberSaver 3.2141e-05 6.06953e-05 0.000215946 3.90075e-05 5.41293e-05 10
[art]:TriggerResults:TriggerResultInserter 1.3088e-05 1.90269e-05 4.401e-05 1.6049e-05 8.68355e-06 10
end_path:out1:RootOutput 4.925e-06 7.8162e-06 1.6689e-05 5.57e-06 3.91195e-06 10
end_path:out1:RootOutput(write) 8.11538 8.49626 9.32114 8.32575 0.411805 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4967.31 MB
Peak resident set size usage (VmHWM): 3317.53 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T135345Z_gen_008734.root 22090120
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T135345Z_gen_008734_supernova_g4.root 130887720
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T135345Z_gen_008734_supernova_g4_detsim.root 2142349580
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T135345Z_gen_008734_supernova_g4_detsim.root.ext.json 1575
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T135345Z_gen_008734_supernova_g4_detsim.root.json 1841
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T135345Z_gen_008734_supernova_g4_detsim.root.temp.json 1841
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T135345Z_gen_008734_supernova_g4_detsim_hist.root 519