Jobsub ID 293531.1@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
l::Gen::IncoherentAddNoise : 1.9799991 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.969999 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.9499991 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.929999 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.9199994 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.919999 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.8799994 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.8299992 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::DumpFrames : 1.8099986 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.7899991 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::Digitizer : 1.7599995 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 1.7499993 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::Reframer : 1.6799989 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::Reframer : 1.6499989 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::Reframer : 1.5599989 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::Reframer : 1.479999 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::FrameFanin : 1.459999 sec
[11:47:33.925] I [ timer ] Timer: WireCell::Gen::Reframer : 1.459999 sec
[11:47:33.926] I [ timer ] Timer: WireCell::Gen::Reframer : 1.4299991 sec
[11:47:33.926] I [ timer ] Timer: WireCell::Gen::Reframer : 1.3899992 sec
[11:47:33.926] I [ timer ] Timer: WireCell::Gen::Reframer : 1.3899992 sec
[11:47:33.926] I [ timer ] Timer: WireCell::Gen::Reframer : 1.3799992 sec
[11:47:33.926] I [ timer ] Timer: WireCell::Gen::Reframer : 1.3799992 sec
[11:47:33.926] I [ timer ] Timer: WireCell::Gen::Reframer : 1.3599992 sec
[11:47:33.926] I [ timer ] Timer: WireCell::Gen::Reframer : 1.3099992 sec
[11:47:33.926] I [ timer ] Timer: wcls::FrameSaver : 1.3099991 sec
[11:47:33.926] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 1.2799991 sec
[11:47:33.926] I [ timer ] Timer: WireCell::Gen::Retagger : 1.1199993 sec
[11:47:33.926] I [ timer ] Timer: wcls::SimDepoSource : 1.1199993 sec
[11:47:33.926] I [ timer ] Timer: Total node execution : 647.1096458435059 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 5th record. run: 5082 subRun: 0 event: 74205 at 22-Jan-2026 11:47:42 UTC
SimDepoSource got 141681 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 141681 depos spanning: [-2245.36, 5.70198e+22]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[11:50:50.093] I [ timer ] Timer: WireCell::Gen::DepoTransform : 68.88991 sec
[11:50:50.093] I [ timer ] Timer: WireCell::Gen::DepoTransform : 63.529896 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 63.059917 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 62.85989 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 60.879917 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 60.129898 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 58.919914 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 58.099934 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 57.289936 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 56.569904 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 50.969913 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoTransform : 46.009968 sec
[11:50:50.094] I [ timer ] Timer: wcls::SimChannelSink : 7.8700852 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Drifter : 3.8399968 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoBagger : 3.2499974 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.8099985 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.7699986 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.7199988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.6799986 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.659999 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.6499987 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.619999 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.5499988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.539999 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.5199988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.499999 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.4999988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.4899988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.4799988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.4799988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.4799988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.4599988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.419999 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.3399992 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.329999 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Digitizer : 2.2899992 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.269999 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.259999 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::IncoherentAddNoise : 2.179999 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DumpFrames : 2.1599984 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 2.0199986 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.9699986 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.9399985 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.8299987 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.8299986 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7799988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7799988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7599988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7499988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7199988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.7199987 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Reframer : 1.6699989 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::FrameFanin : 1.6599988 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 1.6099988 sec
[11:50:50.094] I [ timer ] Timer: wcls::FrameSaver : 1.5699989 sec
[11:50:50.094] I [ timer ] Timer: wcls::SimDepoSource : 1.5199989 sec
[11:50:50.094] I [ timer ] Timer: WireCell::Gen::Retagger : 1.469999 sec
[11:50:50.094] I [ timer ] Timer: Total node execution : 813.9290256500244 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
22-Jan-2026 11:50:58 UTC Closed output file "prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250206T104034Z_gen_001485_supernova_g4_detsim_reco_20250724T141933Z_reco2_detsim_2026-01-22T_113433Z.root"
22-Jan-2026 11:50:59 UTC Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/13/23/prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250206T104034Z_gen_001485_supernova_g4_detsim_reco_20250724T141933Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 186.356 191.621 197.836 190.007 4.35904 5
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000887768 0.00434448 0.00631259 0.00455212 0.00186501 5
simulate:tpcrawdecoder:WireCellToolkit 178.989 184.812 191.165 183.218 4.54966 5
simulate:rns:RandomNumberSaver 4.6159e-05 8.76496e-05 0.000248576 4.743e-05 8.04681e-05 5
[art]:TriggerResults:TriggerResultInserter 1.587e-05 2.37736e-05 4.0778e-05 2.2243e-05 8.89797e-06 5
end_path:out1:RootOutput 5.3e-06 8.3158e-06 1.9848e-05 5.4e-06 5.7675e-06 5
end_path:out1:RootOutput(write) 6.58487 6.80455 7.36499 6.66509 0.288036 5
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5899.99 MB
Peak resident set size usage (VmHWM): 4287.63 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 784782672
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 471016198
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 739866313
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
lar exit code 0