Jobsub ID 33489.67@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
:15.905] I [ timer ] Timer: wcls::SimChannelSink : 0.13 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.13 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.05 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.05 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Drifter : 0.04 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Retagger : 0.03 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.03 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.01 sec
[10:33:15.905] I [ timer ] Timer: wcls::FrameSaver : 0.01 sec
[10:33:15.905] I [ timer ] Timer: wcls::SimDepoSource : 0 sec
[10:33:15.905] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0 sec
[10:33:15.905] I [ timer ] Timer: Total node execution : 10.90999992750585 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 1879 subRun: 0 event: 4270 at 27-Aug-2025 10:33:23 BST
SimDepoSource got 937 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 937 depos spanning: [1.00054, 1.00258]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.61 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.4 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.39 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.39 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.38 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.35 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.35 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.19 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.19 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.13 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.08 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.08 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.02 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.01 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.01 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Drifter : 0.01 sec
[10:33:32.394] I [ timer ] Timer: wcls::SimChannelSink : 0.01 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.01 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0.01 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Reframer : 0.01 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.01 sec
[10:33:32.394] I [ timer ] Timer: wcls::SimDepoSource : 0 sec
[10:33:32.394] I [ timer ] Timer: WireCell::Gen::Retagger : 0 sec
[10:33:32.394] I [ timer ] Timer: wcls::FrameSaver : 0 sec
[10:33:32.394] I [ timer ] Timer: Total node execution : 8.550000069662929 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
27-Aug-2025 10:33:40 BST Closed output file "prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092617Z_gen_000427_g4_detsim.root"
27-Aug-2025 10:33:40 BST Closed input file "prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092617Z_gen_000427_g4.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 16.0921 17.9736 19.79 17.8101 1.37505 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000431612 0.000852449 0.0011059 0.000893246 0.000231176 10
simulate:tpcrawdecoder:WireCellToolkit 10.4197 12.178 14.1284 11.9023 1.34752 10
simulate:opdigi:OpDetDigitizerDUNE 0.000103806 0.0530831 0.0922933 0.0517104 0.0259163 10
simulate:rns:RandomNumberSaver 1.5519e-05 3.68092e-05 0.000198814 1.6446e-05 5.41457e-05 10
[art]:TriggerResults:TriggerResultInserter 8.636e-06 1.24243e-05 3.8553e-05 9.598e-06 8.72098e-06 10
end_path:out1:RootOutput 2.645e-06 4.9154e-06 2.084e-05 2.8305e-06 5.3794e-06 10
end_path:out1:RootOutput(write) 5.60255 5.74138 5.99574 5.71492 0.123651 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4756.87 MB
Peak resident set size usage (VmHWM): 3048.83 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092617Z_gen_000427.root 99215
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092617Z_gen_000427_g4.root 4067965
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092617Z_gen_000427_g4_detsim.root 1801866181
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092617Z_gen_000427_g4_detsim.root.ext.json 1465
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092617Z_gen_000427_g4_detsim.root.json 1767
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092617Z_gen_000427_g4_detsim.root.temp.json 1767
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092617Z_gen_000427_g4_detsim_hist.root 519