Jobsub ID 293531.3@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
[ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.009999 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.9999989 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.9899993 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.979999 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.9699991 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.9399992 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.9199991 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.919999 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.9099991 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.8999994 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::DumpFrames : 1.7899987 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7499988 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.6899992 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.6899989 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.6699989 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.6199989 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.5699989 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.5599989 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.529999 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.509999 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.479999 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Retagger : 1.479999 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::FrameFanin : 1.479999 sec
[11:48:45.293] I [ timer ] Timer: wcls::FrameSaver : 1.459999 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.409999 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.3799992 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::Reframer : 1.3599991 sec
[11:48:45.293] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 1.2199992 sec
[11:48:45.293] I [ timer ] Timer: wcls::SimDepoSource : 1.1899992 sec
[11:48:45.293] I [ timer ] Timer: Total node execution : 720.0595400333405 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 5th record. run: 5082 subRun: 0 event: 111405 at 22-Jan-2026 11:48:53 UTC
SimDepoSource got 142504 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 142504 depos spanning: [-2245.73, 1.4951e+16]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[11:52:37.002] I [ timer ] Timer: WireCell::Gen::DepoTransform : 81.21004 sec
[11:52:37.002] I [ timer ] Timer: WireCell::Gen::DepoTransform : 80.00988 sec
[11:52:37.002] I [ timer ] Timer: WireCell::Gen::DepoTransform : 76.73991 sec
[11:52:37.002] I [ timer ] Timer: WireCell::Gen::DepoTransform : 73.31991 sec
[11:52:37.002] I [ timer ] Timer: WireCell::Gen::DepoTransform : 71.88991 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DepoTransform : 70.999916 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DepoTransform : 67.70989 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DepoTransform : 64.26991 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DepoTransform : 62.31991 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DepoTransform : 59.8699 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DepoTransform : 58.609898 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DepoTransform : 42.89997 sec
[11:52:37.003] I [ timer ] Timer: wcls::SimChannelSink : 8.350096 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Drifter : 3.8299968 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DepoBagger : 3.1699975 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.8799987 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.8499987 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.7499988 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.7499986 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.7499986 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.7499986 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.6799986 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.6699986 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.6399987 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.609999 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.5999987 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.5799987 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.5399988 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.5299988 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.4999988 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.479999 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.4799988 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.4799988 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.4799988 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.449999 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.4499989 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.399999 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.359999 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.249999 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DumpFrames : 2.2299984 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 2.1399984 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 2.1199985 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 2.0799985 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 1.9899985 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 1.9799986 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 1.9799985 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 1.9499986 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 1.9199986 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::FrameFanin : 1.8199986 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7799989 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7699987 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Retagger : 1.7699987 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7599987 sec
[11:52:37.003] I [ timer ] Timer: wcls::FrameSaver : 1.7099987 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::Reframer : 1.6899987 sec
[11:52:37.003] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 1.5999988 sec
[11:52:37.003] I [ timer ] Timer: wcls::SimDepoSource : 1.5499989 sec
[11:52:37.003] I [ timer ] Timer: Total node execution : 920.949073433876 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
22-Jan-2026 11:52:46 UTC Closed output file "prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250206T130546Z_gen_002229_supernova_g4_detsim_reco_20250724T131737Z_reco2_detsim_2026-01-22T_113424Z.root"
22-Jan-2026 11:52:46 UTC Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/ad/81/prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250206T130546Z_gen_002229_supernova_g4_detsim_reco_20250724T131737Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 209.19 214.621 231.602 211.028 8.52383 5
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00135987 0.00411825 0.00583028 0.00416215 0.00158325 5
simulate:tpcrawdecoder:WireCellToolkit 202.041 207.654 224.419 204.243 8.43155 5
simulate:rns:RandomNumberSaver 4.5578e-05 8.6041e-05 0.000239849 4.8263e-05 7.69164e-05 5
[art]:TriggerResults:TriggerResultInserter 2.086e-05 9.57834e-05 0.00037091 2.2353e-05 0.000137807 5
end_path:out1:RootOutput 4.779e-06 7.909e-06 1.8465e-05 5.35e-06 5.28695e-06 5
end_path:out1:RootOutput(write) 6.70457 6.96232 7.17868 7.00184 0.190861 5
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5909.99 MB
Peak resident set size usage (VmHWM): 4283.92 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 9578
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 498136753
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 63735795
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
lar exit code 0