Jobsub ID 33489.170@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
timer ] Timer: WireCell::Gen::DepoTransform : 0.14 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.13 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[10:33:56.688] I [ timer ] Timer: wcls::SimChannelSink : 0.12 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.07 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.07 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.06 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.05 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.05 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.03 sec
[10:33:56.688] I [ timer ] Timer: wcls::FrameSaver : 0.03 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.03 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Retagger : 0.02 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.02 sec
[10:33:56.688] I [ timer ] Timer: wcls::SimDepoSource : 0.01 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::Drifter : 0.01 sec
[10:33:56.688] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.01 sec
[10:33:56.688] I [ timer ] Timer: Total node execution : 10.859999952837825 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 1879 subRun: 0 event: 4960 at 27-Aug-2025 10:34:04 BST
SimDepoSource got 3056 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 3056 depos spanning: [1.00053, 1.00759]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.88 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.41 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.41 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.38 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.38 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.37 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.37 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.37 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.35 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.35 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.35 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.24 sec
[10:34:14.676] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.21 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.21 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.19 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.07 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.06 sec
[10:34:14.677] I [ timer ] Timer: wcls::SimChannelSink : 0.06 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Retagger : 0.02 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.02 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.01 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.01 sec
[10:34:14.677] I [ timer ] Timer: wcls::FrameSaver : 0.01 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Drifter : 0.01 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.01 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::Reframer : 0.01 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.01 sec
[10:34:14.677] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0 sec
[10:34:14.677] I [ timer ] Timer: wcls::SimDepoSource : 0 sec
[10:34:14.677] I [ timer ] Timer: Total node execution : 9.440000005066395 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
27-Aug-2025 10:34:22 BST Closed output file "prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092650Z_gen_000496_g4_detsim.root"
27-Aug-2025 10:34:22 BST Closed input file "prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092650Z_gen_000496_g4.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 16.3169 18.9681 22.6011 18.9155 1.57396 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000420271 0.00095596 0.00133043 0.00100606 0.000244112 10
simulate:tpcrawdecoder:WireCellToolkit 10.6774 13.1584 16.271 13.1534 1.40933 10
simulate:opdigi:OpDetDigitizerDUNE 0.0386343 0.0778807 0.108338 0.0783198 0.0209 10
simulate:rns:RandomNumberSaver 1.61e-05 3.68194e-05 0.000182424 1.83295e-05 4.88937e-05 10
[art]:TriggerResults:TriggerResultInserter 8.816e-06 1.24895e-05 3.9575e-05 9.3075e-06 9.04402e-06 10
end_path:out1:RootOutput 2.765e-06 5.2591e-06 2.2843e-05 3.036e-06 5.91034e-06 10
end_path:out1:RootOutput(write) 5.59966 5.7306 6.27136 5.65458 0.195908 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4772.3 MB
Peak resident set size usage (VmHWM): 3053.59 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092650Z_gen_000496.root 99171
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092650Z_gen_000496_g4.root 6957626
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092650Z_gen_000496_g4_detsim.root 1806664140
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092650Z_gen_000496_g4_detsim.root.ext.json 1465
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092650Z_gen_000496_g4_detsim.root.json 1767
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092650Z_gen_000496_g4_detsim.root.temp.json 1767
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092650Z_gen_000496_g4_detsim_hist.root 519