Jobsub ID 214652.177@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
er ] Timer: WireCell::Gen::IncoherentAddNoise : 0.58 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.55 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.54 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Drifter : 0.43 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.41 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.33 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.33 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.32 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.3 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.29 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.27 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.27 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.27 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.26 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.26 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.25 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Retagger : 0.24 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.24 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.24 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.22 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.22 sec
[18:08:20.333] I [ timer ] Timer: wcls::FrameSaver : 0.21 sec
[18:08:20.333] I [ timer ] Timer: WireCell::Gen::Reframer : 0.19 sec
[18:08:20.333] I [ timer ] Timer: wcls::SimDepoSource : 0.04 sec
[18:08:20.333] I [ timer ] Timer: Total node execution : 165.49999956041574 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 8215 subRun: 0 event: 86900 at 29-Sep-2025 18:08:42 CEST
SimDepoSource got 81147 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 81147 depos spanning: [-2245.62, 1.03532e+10]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 12.91 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 11.6 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 10.89 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 9.79 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 9.7 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 9.64 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 9.44 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.55 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 7.54 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 7.35 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 6.99 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::DepoTransform : 6.72 sec
[18:11:12.735] I [ timer ] Timer: wcls::SimChannelSink : 1.7 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.05 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.97 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.93 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.92 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.9 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.9 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.9 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.87 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.86 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.86 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.84 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.82 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.71 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.65 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.63 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.6 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.59 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.55 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.53 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.5 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.49 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.48 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.47 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Drifter : 0.44 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Reframer : 0.31 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Reframer : 0.31 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Reframer : 0.3 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Reframer : 0.29 sec
[18:11:12.735] I [ timer ] Timer: WireCell::Gen::Reframer : 0.29 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.29 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::Reframer : 0.28 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::Retagger : 0.28 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::Reframer : 0.28 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.28 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::Reframer : 0.28 sec
[18:11:12.736] I [ timer ] Timer: wcls::FrameSaver : 0.27 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::Reframer : 0.27 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.27 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::Reframer : 0.23 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::Reframer : 0.22 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::Reframer : 0.2 sec
[18:11:12.736] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.18 sec
[18:11:12.736] I [ timer ] Timer: wcls::SimDepoSource : 0.11 sec
[18:11:12.736] I [ timer ] Timer: Total node execution : 135.73999981582165 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
29-Sep-2025 18:11:30 CEST Closed output file "prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T151815Z_gen_008690_supernova_g4_detsim.root"
29-Sep-2025 18:11:30 CEST Closed input file "prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T151815Z_gen_008690_supernova_g4.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 166.649 199.832 242.681 199.204 20.7316 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00121001 0.00261232 0.00337028 0.0027431 0.000698168 10
simulate:tpcrawdecoder:WireCellToolkit 154.12 183.826 222.717 182.027 18.783 10
simulate:opdigi:OpDetDigitizerDUNE 2.28688 2.67173 3.19004 2.63485 0.298023 10
simulate:rns:RandomNumberSaver 3.5308e-05 7.44074e-05 0.00032147 4.6007e-05 8.28885e-05 10
[art]:TriggerResults:TriggerResultInserter 1.4074e-05 2.23175e-05 5.6445e-05 1.8537e-05 1.17157e-05 10
end_path:out1:RootOutput 4.527e-06 7.4367e-06 2.3176e-05 6.0055e-06 5.28751e-06 10
end_path:out1:RootOutput(write) 10.1613 13.3315 16.7811 13.5828 1.93066 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4973.69 MB
Peak resident set size usage (VmHWM): 3312.96 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T151815Z_gen_008690.root 22106242
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T151815Z_gen_008690_supernova_g4.root 130978176
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T151815Z_gen_008690_supernova_g4_detsim.root 2143150809
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T151815Z_gen_008690_supernova_g4_detsim.root.ext.json 1575
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T151815Z_gen_008690_supernova_g4_detsim.root.json 1841
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T151815Z_gen_008690_supernova_g4_detsim.root.temp.json 1841
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250929T151815Z_gen_008690_supernova_g4_detsim_hist.root 519