Jobsub ID 33489.88@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
m : 0.1 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.08 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.08 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.08 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:33:23.595] I [ timer ] Timer: wcls::SimChannelSink : 0.04 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Reframer : 0.01 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Drifter : 0 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::Retagger : 0 sec
[10:33:23.595] I [ timer ] Timer: wcls::FrameSaver : 0 sec
[10:33:23.595] I [ timer ] Timer: wcls::SimDepoSource : 0 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0 sec
[10:33:23.595] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0 sec
[10:33:23.595] I [ timer ] Timer: Total node execution : 8.280000058934093 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 1879 subRun: 0 event: 4560 at 27-Aug-2025 10:33:31 BST
SimDepoSource got 3168 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 3168 depos spanning: [1.00094, 1.00534]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.99 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.4 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.4 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.39 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.38 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.38 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.38 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.36 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.35 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.35 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::Digitizer : 0.35 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.23 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.21 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.21 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.21 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.21 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.2 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 0.19 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[10:33:42.014] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.1 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoTransform : 0.09 sec
[10:33:42.015] I [ timer ] Timer: wcls::SimChannelSink : 0.07 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.06 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.06 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.05 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.04 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.03 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.02 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::FrameFanin : 0.02 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DumpFrames : 0.01 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoBagger : 0.01 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Reframer : 0.01 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Drifter : 0 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::Retagger : 0 sec
[10:33:42.015] I [ timer ] Timer: wcls::FrameSaver : 0 sec
[10:33:42.015] I [ timer ] Timer: wcls::SimDepoSource : 0 sec
[10:33:42.015] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 0 sec
[10:33:42.015] I [ timer ] Timer: Total node execution : 9.639999998733401 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
27-Aug-2025 10:33:50 BST Closed output file "prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092627Z_gen_000456_g4_detsim.root"
27-Aug-2025 10:33:50 BST Closed input file "prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092627Z_gen_000456_g4.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 16.2477 18.0852 20.5544 17.7874 1.49336 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000444156 0.00082484 0.00149692 0.000773126 0.000281193 10
simulate:tpcrawdecoder:WireCellToolkit 10.3469 12.308 14.8043 12.0916 1.50089 10
simulate:opdigi:OpDetDigitizerDUNE 0.0415345 0.0798231 0.11367 0.0808564 0.0204799 10
simulate:rns:RandomNumberSaver 1.5549e-05 3.65987e-05 0.000185419 2.10245e-05 4.97347e-05 10
[art]:TriggerResults:TriggerResultInserter 8.006e-06 1.17342e-05 3.5758e-05 9.122e-06 8.02567e-06 10
end_path:out1:RootOutput 2.926e-06 4.739e-06 1.8114e-05 3.3515e-06 4.46172e-06 10
end_path:out1:RootOutput(write) 5.59136 5.69626 5.89015 5.66129 0.0941122 10
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4755.96 MB
Peak resident set size usage (VmHWM): 3043.48 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092627Z_gen_000456.root 99183
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092627Z_gen_000456_g4.root 5253893
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092627Z_gen_000456_g4_detsim.root 1804101559
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092627Z_gen_000456_g4_detsim.root.ext.json 1465
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092627Z_gen_000456_g4_detsim.root.json 1767
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092627Z_gen_000456_g4_detsim.root.temp.json 1767
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20250827T092627Z_gen_000456_g4_detsim_hist.root 519