Jobsub ID 229067.116@dunegpschedd01.fnal.gov
| Jobsub ID | 229067.116@dunegpschedd01.fnal.gov | 
| Workflow ID | 8497 | 
| 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-10-03 11:29:09 | 
| Site | UK_Lancaster | 
| Entry | UBoone_UK_Lancaster_HEC_grendel_ce02 | 
| Last heartbeat | 2025-10-03 11:49:36 | 
| From worker node | Hostname | comp07-20 | 
| 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 | finished | 
| Started | 2025-10-03 11:30:00 | 
| Input files | monte-carlo-008497-005375
  | 
| Jobscript | Exit code | 0 | 
| Real time | 7m (462s) | 
| CPU time | 7m (454s = 98%) | 
| Max RSS bytes | 3051102208 (2909 MiB) | 
| Outputting started | 2025-10-03 11:37:43 | 
| Output files | fardet-hd:prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375_g4_detsim.root
  | 
| Finished | 2025-10-03 11:49:36 | 
| Saved logs | justin-logs:229067.116-dunegpschedd01.fnal.gov.logs.tgz | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
reCell::Gen::DepoTransform : 0.12 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.05 sec
[12:37:08.481] I [ timer  ] Timer: wcls::SimChannelSink : 0.05 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.04 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.04 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.04 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.04 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.02 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.02 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.02 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.02 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0.01 sec
[12:37:08.481] I [ timer  ] Timer: wcls::FrameSaver : 0.01 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 0.01 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0.01 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Retagger : 0 sec
[12:37:08.481] I [ timer  ] Timer: wcls::SimDepoSource : 0 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::Drifter : 0 sec
[12:37:08.481] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0 sec
[12:37:08.481] I [ timer  ] Timer: Total node execution : 12.01999986357987 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 8497 subRun: 0 event: 53750 at 03-Oct-2025 12:37:17 BST
SimDepoSource got 1333 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 1333 depos spanning: [1, 1.00337]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.6 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.6 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.59 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.58 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.58 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.57 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.57 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.57 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.57 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.56 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.56 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.56 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.56 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.24 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.24 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.24 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.24 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.23 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.23 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.23 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.23 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.23 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.23 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.23 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.22 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.14 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.13 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.12 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.11 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.06 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.05 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.05 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.04 sec
[12:37:30.341] I [ timer  ] Timer: wcls::SimChannelSink : 0.04 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[12:37:30.341] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.02 sec
[12:37:30.342] I [ timer  ] Timer: WireCell::Gen::Retagger : 0.01 sec
[12:37:30.342] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0.01 sec
[12:37:30.342] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0 sec
[12:37:30.342] I [ timer  ] Timer: wcls::FrameSaver : 0 sec
[12:37:30.342] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 0 sec
[12:37:30.342] I [ timer  ] Timer: wcls::SimDepoSource : 0 sec
[12:37:30.342] I [ timer  ] Timer: WireCell::Gen::Drifter : 0 sec
[12:37:30.342] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0 sec
[12:37:30.342] I [ timer  ] Timer: Total node execution : 12.059999948367476 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
03-Oct-2025 12:37:41 BST  Closed output file "prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375_g4_detsim.root"
03-Oct-2025 12:37:41 BST  Closed input file "prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375_g4.root"
================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      20.7577       21.8596       22.6779       22.0873      0.711917        10     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000420723   0.000622084   0.000832562   0.000639509   0.000126297      10     
simulate:tpcrawdecoder:WireCellToolkit          14.5248       15.4609       16.2639       15.5407      0.634462        10     
simulate:opdigi:OpDetDigitizerDUNE             0.0789894     0.171708      0.235612      0.192488      0.0551606       10     
simulate:rns:RandomNumberSaver                1.7851e-05    4.12127e-05   0.000189933   2.2952e-05    4.99724e-05      10     
[art]:TriggerResults:TriggerResultInserter     9.802e-06    1.3569e-05    3.6219e-05    1.0784e-05    7.61166e-06      10     
end_path:out1:RootOutput                       2.334e-06    5.2776e-06    1.5558e-05     3.859e-06    4.08192e-06      10     
end_path:out1:RootOutput(write)                 6.13886       6.22614       6.63498       6.16451      0.145759        10     
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 4702.04 MB
  Peak resident set size usage (VmHWM): 3051.1 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375.root 99204
written output file: prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375_g4.root 3137969
written output file: prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375_g4_detsim.root 1801123060
written output file: prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375_g4_detsim.root.ext.json 1453
written output file: prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375_g4_detsim.root.json 1759
written output file: prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375_g4_detsim.root.temp.json 1759
written output file: prod_p_1-500MeV_dune10kt_1x2x6_20251003T113003Z_gen_005375_g4_detsim_hist.root 519