Jobsub ID 208658.20@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
imer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.75 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.75 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.75 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.74 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.74 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.72 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.72 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.71 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.7 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.68 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.66 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.66 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.66 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.63 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.63 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.62 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.6 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.59 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.57 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.55 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.54 sec
[00:26:46.706] I [ timer ] Timer: wcls::FrameSaver : 0.54 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.5 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Reframer : 0.49 sec
[00:26:46.706] I [ timer ] Timer: WireCell::Gen::Retagger : 0.47 sec
[00:26:46.706] I [ timer ] Timer: wcls::SimDepoSource : 0.28 sec
[00:26:46.706] I [ timer ] Timer: Total node execution : 198.64999997615814 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 8191 subRun: 0 event: 96210 at 29-Sep-2025 00:26:59 CEST
SimDepoSource got 139386 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 139386 depos spanning: [-2245.9, 2245.64]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 17.61 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 17.51 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 17.07 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 16.27 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 15.56 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 15.46 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 15.03 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 14.95 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 14.2 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 12.96 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 12.02 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::DepoTransform : 8.42 sec
[00:31:06.742] I [ timer ] Timer: wcls::SimChannelSink : 2.14 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.09 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.01 sec
[00:31:06.742] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.98 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.92 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.88 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.88 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.88 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.88 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Drifter : 0.87 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.87 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.86 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.83 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Reframer : 0.81 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.8 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.8 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.79 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.78 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.77 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.74 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.74 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.74 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Reframer : 0.74 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::Reframer : 0.73 sec
[00:31:06.743] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.73 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.72 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Reframer : 0.71 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.71 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.7 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Reframer : 0.68 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Reframer : 0.66 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Reframer : 0.66 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Reframer : 0.64 sec
[00:31:06.744] I [ timer ] Timer: wcls::FrameSaver : 0.63 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Reframer : 0.62 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.61 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.61 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.6 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Reframer : 0.6 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Reframer : 0.59 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Retagger : 0.57 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.56 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::Reframer : 0.54 sec
[00:31:06.744] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.45 sec
[00:31:06.744] I [ timer ] Timer: wcls::SimDepoSource : 0.21 sec
[00:31:06.744] I [ timer ] Timer: Total node execution : 211.3900016695261 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
29-Sep-2025 00:31:20 CEST Closed output file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250928T213940Z_gen_009621_supernova_g4_detsim.root"
29-Sep-2025 00:31:20 CEST Closed input file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250928T213940Z_gen_009621_supernova_g4.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 232.619 245.41 259.279 246.607 8.36125 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00067843 0.00492339 0.00839169 0.00494893 0.00183755 10
simulate:tpcrawdecoder:WireCellToolkit 223.272 235.375 249.189 236.344 8.27122 10
simulate:opdigi:OpDetDigitizerDUNE 2.35827 2.51974 2.9237 2.45807 0.169652 10
simulate:rns:RandomNumberSaver 3.1579e-05 7.40788e-05 0.000361467 3.49805e-05 9.68779e-05 10
[art]:TriggerResults:TriggerResultInserter 1.1351e-05 1.73211e-05 3.5756e-05 1.40915e-05 7.6102e-06 10
end_path:out1:RootOutput 4.207e-06 6.5471e-06 1.8484e-05 4.859e-06 4.08935e-06 10
end_path:out1:RootOutput(write) 6.9541 7.50946 7.9944 7.64919 0.367693 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5234.9 MB
Peak resident set size usage (VmHWM): 3520.41 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250928T213940Z_gen_009621.root 21925682
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250928T213940Z_gen_009621_supernova_g4.root 180716045
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250928T213940Z_gen_009621_supernova_g4_detsim.root 2352546765
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250928T213940Z_gen_009621_supernova_g4_detsim.root.ext.json 1561
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250928T213940Z_gen_009621_supernova_g4_detsim.root.json 1827
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250928T213940Z_gen_009621_supernova_g4_detsim.root.temp.json 1827
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250928T213940Z_gen_009621_supernova_g4_detsim_hist.root 519