Jobsub ID 33039.15@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
[ timer ] Timer: WireCell::Gen::Reframer : 0.66 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.65 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.61 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.61 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.6 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.59 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.59 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.58 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.58 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.58 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.55 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.55 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.55 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.54 sec
[16:15:50.677] I [ timer ] Timer: wcls::FrameSaver : 0.53 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.53 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.53 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.51 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.51 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Retagger : 0.5 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.5 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.48 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.47 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.43 sec
[16:15:50.677] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.39 sec
[16:15:50.677] I [ timer ] Timer: wcls::SimDepoSource : 0.14 sec
[16:15:50.677] I [ timer ] Timer: Total node execution : 208.19000126421452 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 1854 subRun: 0 event: 49910 at 26-Aug-2025 16:16:03 CEST
SimDepoSource got 138903 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 138903 depos spanning: [-2245.59, 2244.79]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 19.55 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 18.71 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 17.54 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 17.48 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 16.55 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 15.28 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 14.32 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 13.55 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 13.15 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 12.74 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 11.87 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.32 sec
[16:20:03.254] I [ timer ] Timer: wcls::SimChannelSink : 1.58 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.93 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Drifter : 0.92 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.81 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.8 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.78 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.78 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.76 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.74 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.73 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.73 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.72 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.71 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.71 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.71 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.7 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.69 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.69 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.69 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.69 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.66 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.66 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.66 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.66 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.65 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.64 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.64 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.63 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.63 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.63 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.59 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.59 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.59 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.57 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.54 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.53 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Retagger : 0.53 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.53 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.52 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.51 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.51 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.48 sec
[16:20:03.254] I [ timer ] Timer: WireCell::Gen::Reframer : 0.46 sec
[16:20:03.254] I [ timer ] Timer: wcls::FrameSaver : 0.35 sec
[16:20:03.254] I [ timer ] Timer: wcls::SimDepoSource : 0.26 sec
[16:20:03.254] I [ timer ] Timer: Total node execution : 208.9499964416027 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
26-Aug-2025 16:20:18 CEST Closed output file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250826T132431Z_gen_004991_supernova_g4_detsim.root"
26-Aug-2025 16:20:18 CEST Closed input file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250826T132431Z_gen_004991_supernova_g4.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 246.186 261.641 297.692 255.893 14.6036 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00101591 0.00600499 0.0114182 0.00557697 0.00260891 10
simulate:tpcrawdecoder:WireCellToolkit 234.525 250.792 285.309 245.344 14.1353 10
simulate:opdigi:OpDetDigitizerDUNE 2.32937 2.58227 2.82005 2.57419 0.156495 10
simulate:rns:RandomNumberSaver 3.314e-05 6.0725e-05 0.000245512 4.1638e-05 6.1799e-05 10
[art]:TriggerResults:TriggerResultInserter 1.27e-05 1.82449e-05 4.3877e-05 1.56535e-05 8.74278e-06 10
end_path:out1:RootOutput 4.366e-06 6.7172e-06 2.1773e-05 5.243e-06 5.04289e-06 10
end_path:out1:RootOutput(write) 7.53325 8.26093 9.64053 8.06253 0.673981 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5206.16 MB
Peak resident set size usage (VmHWM): 3500.34 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250826T132431Z_gen_004991.root 21977611
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250826T132431Z_gen_004991_supernova_g4.root 180674351
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250826T132431Z_gen_004991_supernova_g4_detsim.root 2353047765
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250826T132431Z_gen_004991_supernova_g4_detsim.root.ext.json 1561
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250826T132431Z_gen_004991_supernova_g4_detsim.root.json 1827
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250826T132431Z_gen_004991_supernova_g4_detsim.root.temp.json 1827
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250826T132431Z_gen_004991_supernova_g4_detsim_hist.root 519