Jobsub ID 33073.127@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
:03.285] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.42 sec
[18:44:03.285] I [ timer ] Timer: WireCell::Gen::Drifter : 0.41 sec
[18:44:03.285] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.41 sec
[18:44:03.285] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.41 sec
[18:44:03.285] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.41 sec
[18:44:03.285] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.35 sec
[18:44:03.285] I [ timer ] Timer: WireCell::Gen::Reframer : 0.35 sec
[18:44:03.285] I [ timer ] Timer: WireCell::Gen::Reframer : 0.34 sec
[18:44:03.285] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.34 sec
[18:44:03.285] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.33 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.31 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.3 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.29 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.29 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.28 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.28 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.27 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.26 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.26 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.26 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.26 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Retagger : 0.23 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::Reframer : 0.23 sec
[18:44:03.286] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.2 sec
[18:44:03.286] I [ timer ] Timer: wcls::FrameSaver : 0.16 sec
[18:44:03.286] I [ timer ] Timer: wcls::SimDepoSource : 0.08 sec
[18:44:03.286] I [ timer ] Timer: Total node execution : 102.8600005209446 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 1860 subRun: 0 event: 29710 at 26-Aug-2025 18:44:14 CEST
SimDepoSource got 81504 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 81504 depos spanning: [-2243, 2245.94]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 10.27 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 9.67 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 9.1 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 9.08 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.87 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.73 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.61 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.54 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.3 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.22 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 6.95 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoTransform : 5.58 sec
[18:46:32.383] I [ timer ] Timer: wcls::SimChannelSink : 0.88 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.55 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.54 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.53 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.53 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.49 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.49 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.49 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.49 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Drifter : 0.48 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.48 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.46 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.46 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.45 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.45 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.45 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.45 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.43 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.43 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.43 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.43 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.42 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.4 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.38 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.37 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.35 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.35 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.33 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.33 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.33 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.33 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.33 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.31 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.3 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.3 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.29 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Reframer : 0.29 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::Retagger : 0.28 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.28 sec
[18:46:32.383] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.25 sec
[18:46:32.383] I [ timer ] Timer: wcls::FrameSaver : 0.23 sec
[18:46:32.383] I [ timer ] Timer: wcls::SimDepoSource : 0.07 sec
[18:46:32.383] I [ timer ] Timer: Total node execution : 120.39000006765127 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
26-Aug-2025 18:46:44 CEST Closed output file "prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250826T161314Z_gen_002971_supernova_g4_detsim.root"
26-Aug-2025 18:46:44 CEST Closed input file "prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250826T161314Z_gen_002971_supernova_g4.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 126.382 136.561 148.588 134.937 8.08134 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.0013313 0.00549699 0.0275322 0.0035201 0.00738034 10
simulate:tpcrawdecoder:WireCellToolkit 118.129 127.605 140.077 125.632 7.94724 10
simulate:opdigi:OpDetDigitizerDUNE 1.37927 1.53429 1.65779 1.557 0.098412 10
simulate:rns:RandomNumberSaver 3.2059e-05 6.55163e-05 0.000304662 3.98555e-05 7.98162e-05 10
[art]:TriggerResults:TriggerResultInserter 1.2589e-05 2.05101e-05 4.8504e-05 1.686e-05 1.02326e-05 10
end_path:out1:RootOutput 5.448e-06 8.503e-06 2.4708e-05 6.916e-06 5.43693e-06 10
end_path:out1:RootOutput(write) 6.83775 7.41525 8.87076 7.20592 0.622611 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4987.4 MB
Peak resident set size usage (VmHWM): 3298.68 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250826T161314Z_gen_002971.root 22086146
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250826T161314Z_gen_002971_supernova_g4.root 130714685
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250826T161314Z_gen_002971_supernova_g4_detsim.root 2142711011
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250826T161314Z_gen_002971_supernova_g4_detsim.root.ext.json 1575
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250826T161314Z_gen_002971_supernova_g4_detsim.root.json 1841
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250826T161314Z_gen_002971_supernova_g4_detsim.root.temp.json 1841
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250826T161314Z_gen_002971_supernova_g4_detsim_hist.root 519