Jobsub ID 213636.3@dunegpschedd01.fnal.gov
| Jobsub ID | 213636.3@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 10:56:43 | 
| Site | UK_Lancaster | 
| Entry | UBoone_UK_Lancaster_HEC_grendel_ce02 | 
| Last heartbeat | 2025-09-27 14:15:56 | 
| From worker node | Hostname | comp03-01 | 
| cpuinfo | Intel(R) Xeon(R) CPU E5-2620 v4 @ 2.10GHz | 
| 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:04:53 | 
| Input files | monte-carlo-008146-007722
  | 
| Jobscript | Exit code | 0 | 
| Real time | 1h (3904s) | 
| CPU time | 1h (3876s = 99%) | 
| Max RSS bytes | 3517349888 (3354 MiB) | 
| Outputting started | 2025-09-27 13:09:57 | 
| Output files |  | 
| Finished | 2025-09-27 14:15:56 | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
ll::Gen::IncoherentAddNoise : 0.61 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.61 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.6 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.59 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.57 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.55 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.48 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.45 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.41 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.41 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.37 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.37 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.36 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.33 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.31 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Retagger : 0.29 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.29 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.29 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 0.28 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.28 sec
[14:05:22.112] I [ timer  ] Timer: wcls::FrameSaver : 0.26 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0.26 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0.25 sec
[14:05:22.112] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0.25 sec
[14:05:22.112] I [ timer  ] Timer: wcls::SimDepoSource : 0.11 sec
[14:05:22.112] I [ timer  ] Timer: Total node execution : 249.04999889433384 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 8146 subRun: 0 event: 77220 at 27-Sep-2025 14:05:36 BST
SimDepoSource got 140523 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 140523 depos spanning: [-2245.55, 2245.34]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 20.86 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 19.92 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 19.74 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 17.44 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 17.21 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 16.65 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 16.05 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 15.86 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 15.4 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 14.53 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 14.36 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 11.91 sec
[14:09:39.225] I [ timer  ] Timer: wcls::SimChannelSink : 2.48 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.88 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.81 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.8 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.8 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.78 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.77 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.75 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.75 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.73 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.73 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.73 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.72 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.68 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.63 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.6 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.59 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.58 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.57 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.57 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.57 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.56 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Drifter : 0.53 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.53 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.53 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.49 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0.4 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.39 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 0.39 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.39 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.37 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.35 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.35 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.34 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.33 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.31 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.3 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Retagger : 0.29 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0.29 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.29 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.28 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0.25 sec
[14:09:39.225] I [ timer  ] Timer: wcls::FrameSaver : 0.24 sec
[14:09:39.225] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.21 sec
[14:09:39.225] I [ timer  ] Timer: wcls::SimDepoSource : 0.16 sec
[14:09:39.225] I [ timer  ] Timer: Total node execution : 225.01999735832214 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
27-Sep-2025 14:09:54 BST  Closed output file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T120456Z_gen_007722_supernova_g4_detsim.root"
27-Sep-2025 14:09:54 BST  Closed input file "prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T120456Z_gen_007722_supernova_g4.root"
================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      255.961       303.909       336.67        305.578       21.4633        10     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000556832   0.00390564    0.00469271    0.00436452    0.00116426       10     
simulate:tpcrawdecoder:WireCellToolkit          245.275       291.58        324.06        292.465       20.8877        10     
simulate:opdigi:OpDetDigitizerDUNE              2.60824       2.97884       3.18933       3.03877      0.174649        10     
simulate:rns:RandomNumberSaver                3.2082e-05    5.91316e-05   0.000239847   3.8615e-05    6.03978e-05      10     
[art]:TriggerResults:TriggerResultInserter    1.1527e-05    1.62043e-05   4.1572e-05    1.3366e-05    8.5236e-06       10     
end_path:out1:RootOutput                       3.731e-06    5.6183e-06    1.6664e-05    4.5175e-06    3.69355e-06      10     
end_path:out1:RootOutput(write)                 8.07254       9.34563       10.4846       9.46603      0.618031        10     
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 5178.09 MB
  Peak resident set size usage (VmHWM): 3517.35 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T120456Z_gen_007722.root 21940738
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T120456Z_gen_007722_supernova_g4.root 180337898
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T120456Z_gen_007722_supernova_g4_detsim.root 2351971150
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T120456Z_gen_007722_supernova_g4_detsim.root.ext.json 1561
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T120456Z_gen_007722_supernova_g4_detsim.root.json 1827
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T120456Z_gen_007722_supernova_g4_detsim.root.temp.json 1827
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_centralAPA_20250927T120456Z_gen_007722_supernova_g4_detsim_hist.root 519