Jobsub ID 208713.82@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
Timer: WireCell::Gen::IncoherentAddNoise : 0.76 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Drifter : 0.75 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.74 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.74 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.72 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.71 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.7 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.7 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.69 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.69 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.68 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.68 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.66 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.63 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.61 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.61 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.59 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.59 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.59 sec
[03:39:22.849] I [ timer ] Timer: wcls::FrameSaver : 0.57 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.53 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Retagger : 0.53 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.49 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.44 sec
[03:39:22.849] I [ timer ] Timer: WireCell::Gen::Reframer : 0.41 sec
[03:39:22.849] I [ timer ] Timer: wcls::SimDepoSource : 0.17 sec
[03:39:22.849] I [ timer ] Timer: Total node execution : 235.60000129044056 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 8191 subRun: 0 event: 7220 at 29-Sep-2025 03:39:35 CEST
SimDepoSource got 144260 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 144260 depos spanning: [-2245.94, 2245.94]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 20.81 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 20.81 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 20.03 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 19.83 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 18.74 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 18.7 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 17.87 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 17.75 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 17.04 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 16.26 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 14.31 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoTransform : 13.36 sec
[03:44:21.241] I [ timer ] Timer: wcls::SimChannelSink : 1.89 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.19 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.17 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.13 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.1 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.03 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.02 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.02 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Drifter : 1 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.93 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.92 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.91 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.89 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.88 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.87 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.87 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.84 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.8 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.78 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.75 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.73 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.73 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.73 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.72 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.72 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.71 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.7 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.68 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.67 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.66 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.65 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.65 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.64 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.62 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.61 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.61 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.6 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.6 sec
[03:44:21.241] I [ timer ] Timer: wcls::FrameSaver : 0.56 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.54 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Retagger : 0.54 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::Reframer : 0.52 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.5 sec
[03:44:21.241] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.49 sec
[03:44:21.241] I [ timer ] Timer: wcls::SimDepoSource : 0.18 sec
[03:44:21.241] I [ timer ] Timer: Total node execution : 250.86000227928162 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
29-Sep-2025 03:44:33 CEST Closed output file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250929T004410Z_gen_000722_supernova_g4_detsim.root"
29-Sep-2025 03:44:33 CEST Closed input file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250929T004410Z_gen_000722_supernova_g4.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 267.875 276.552 297.685 275.12 8.28659 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000686314 0.00507795 0.00910704 0.00509652 0.00217389 10
simulate:tpcrawdecoder:WireCellToolkit 257.946 266.629 287.943 265.095 8.3105 10
simulate:opdigi:OpDetDigitizerDUNE 2.44769 2.55314 2.6952 2.55723 0.0776073 10
simulate:rns:RandomNumberSaver 1.8841e-05 3.84642e-05 0.000196677 2.106e-05 5.27545e-05 10
[art]:TriggerResults:TriggerResultInserter 9.19e-06 1.23983e-05 3.4581e-05 9.83e-06 7.41898e-06 10
end_path:out1:RootOutput 2.38e-06 4.4851e-06 1.751e-05 3.095e-06 4.35203e-06 10
end_path:out1:RootOutput(write) 7.15782 7.36451 7.69877 7.31226 0.152374 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5222.42 MB
Peak resident set size usage (VmHWM): 3521.54 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250929T004410Z_gen_000722.root 22038432
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250929T004410Z_gen_000722_supernova_g4.root 181630610
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250929T004410Z_gen_000722_supernova_g4_detsim.root 2356903824
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250929T004410Z_gen_000722_supernova_g4_detsim.root.ext.json 1557
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250929T004410Z_gen_000722_supernova_g4_detsim.root.json 1823
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250929T004410Z_gen_000722_supernova_g4_detsim.root.temp.json 1823
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250929T004410Z_gen_000722_supernova_g4_detsim_hist.root 519