Jobsub ID 213661.106@dunegpschedd01.fnal.gov
| Jobsub ID | 213661.106@dunegpschedd01.fnal.gov | 
| Workflow ID | 8146 | 
| Stage ID | 1 | 
| User name | epennacc@fnal.gov | 
| HTCondor Group | group_dune.prod_mcsim | 
| Requested | Processors | 1 | 
| GPU | No | 
| RSS bytes | 4194304000 (4000 MiB) | 
| Wall seconds limit | 80000 (22 hours) | 
| Submitted time | 2025-09-27 11:26:45 | 
| Site | UK_Lancaster | 
| Entry | UBoone_UK_Lancaster_HEC_grendel_ce02 | 
| Last heartbeat | 2025-09-27 14:15:13 | 
| From worker node | Hostname | comp19-06 | 
| cpuinfo | Intel(R) Xeon(R) Gold 6148 CPU @ 2.40GHz | 
| OS release | Scientific Linux release 7.9 (Nitrogen) | 
| Processors | 1 | 
| RSS bytes | 4194304000 (4000 MiB) | 
| Wall seconds limit | 257400 (71 hours) | 
| GPU |  | 
| Inner Apptainer? | True | 
| Job state | outputting_failed | 
| Started | 2025-09-27 12:30:17 | 
| Input files | monte-carlo-008146-008607
  | 
| Jobscript | Exit code | 0 | 
| Real time | 51m (3092s) | 
| CPU time | 51m (3078s = 99%) | 
| Max RSS bytes | 3516260352 (3353 MiB) | 
| Outputting started | 2025-09-27 13:21:50 | 
| Output files |  | 
| Finished | 2025-09-27 14:15:13 | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
er  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.62 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.62 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.61 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.59 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.59 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.56 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.52 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.49 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.49 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.47 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.46 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.46 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.45 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.44 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.44 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.43 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Drifter : 0.43 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.42 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0.4 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0.4 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 0.39 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0.39 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.37 sec
[14:17:33.837] I [ timer  ] Timer: WireCell::Gen::Retagger : 0.36 sec
[14:17:33.837] I [ timer  ] Timer: wcls::FrameSaver : 0.32 sec
[14:17:33.837] I [ timer  ] Timer: wcls::SimDepoSource : 0.15 sec
[14:17:33.837] I [ timer  ] Timer: Total node execution : 215.3200007379055 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 8146 subRun: 0 event: 86070 at 27-Sep-2025 14:17:46 BST
SimDepoSource got 143217 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 143217 depos spanning: [-2245.24, 2245.34]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 18.81 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 18.33 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 18.08 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 17.37 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 14.93 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 14.38 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 14.3 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 13.86 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 11.79 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 11.68 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 10.4 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 10.2 sec
[14:21:34.239] I [ timer  ] Timer: wcls::SimChannelSink : 2.18 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 1.06 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 1.05 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 1 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.99 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.96 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.92 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.91 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.91 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.9 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.9 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.88 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.85 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.73 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.68 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.64 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.63 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.62 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.62 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.6 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.59 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.58 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.57 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.57 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.54 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.54 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.54 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.52 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 0.52 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.5 sec
[14:21:34.239] I [ timer  ] Timer: wcls::FrameSaver : 0.49 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.49 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.48 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.44 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.44 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.44 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Retagger : 0.43 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Drifter : 0.43 sec
[14:21:34.239] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.43 sec
[14:21:34.240] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.42 sec
[14:21:34.240] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0.41 sec
[14:21:34.240] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0.36 sec
[14:21:34.240] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0.35 sec
[14:21:34.240] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.35 sec
[14:21:34.240] I [ timer  ] Timer: wcls::SimDepoSource : 0.1 sec
[14:21:34.240] I [ timer  ] Timer: Total node execution : 203.69000012427568 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
27-Sep-2025 14:21:48 BST  Closed output file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T123019Z_gen_008607_supernova_g4_detsim.root"
27-Sep-2025 14:21:48 BST  Closed input file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T123019Z_gen_008607_supernova_g4.root"
================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      240.214       247.216       254.992       246.602       3.90602        10     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000395438   0.00343821    0.00448419    0.00391906    0.00111656       10     
simulate:tpcrawdecoder:WireCellToolkit          230.737       237.669       245.506       237.088       3.95391        10     
simulate:opdigi:OpDetDigitizerDUNE              2.36202       2.43086       2.46698       2.42743      0.0311394       10     
simulate:rns:RandomNumberSaver                3.2752e-05    5.28299e-05   0.000192095   3.6989e-05    4.65344e-05      10     
[art]:TriggerResults:TriggerResultInserter     9.977e-06    1.30445e-05   3.1578e-05    1.0676e-05    6.26334e-06      10     
end_path:out1:RootOutput                       4.436e-06    5.9843e-06    1.5827e-05     4.918e-06    3.29038e-06      10     
end_path:out1:RootOutput(write)                 7.00365       7.11259       7.55989       7.05411      0.156988        10     
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 5179.4 MB
  Peak resident set size usage (VmHWM): 3516.26 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T123019Z_gen_008607.root 21969231
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T123019Z_gen_008607_supernova_g4.root 181355015
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T123019Z_gen_008607_supernova_g4_detsim.root 2355187538
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T123019Z_gen_008607_supernova_g4_detsim.root.ext.json 1561
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T123019Z_gen_008607_supernova_g4_detsim.root.json 1827
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T123019Z_gen_008607_supernova_g4_detsim.root.temp.json 1827
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T123019Z_gen_008607_supernova_g4_detsim_hist.root 519