Jobsub ID 229188.0@dunegpschedd01.fnal.gov

Jobsub ID	229188.0@dunegpschedd01.fnal.gov
Workflow ID	8499
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 14:28:15
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_brug
Last heartbeat	2025-10-03 15:17:09
From worker node	Hostname	wn-pijl-010.farm.nikhef.nl
	cpuinfo	AMD EPYC 9754 128-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	129600 (36 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2025-10-03 14:29:29
Input files	monte-carlo-008499-003429
Jobscript	Exit code	0
	Real time	45m (2724s)
	CPU time	44m (2640s = 96%)
	Max RSS bytes	3328724992 (3174 MiB)
Outputting started	2025-10-03 15:14:54
Output files	fardet-hd:prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429_supernova_g4_detsim.root
Finished	2025-10-03 15:17:09
Saved logs	justin-logs:229188.0-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

11:09.709] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.63 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.62 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.61 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.6 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.6 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::Drifter : 0.57 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.55 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.55 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.54 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.51 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::Retagger : 0.48 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.48 sec
[17:11:09.709] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0.48 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.46 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0.46 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.45 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.44 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.44 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.44 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.43 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.4 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.38 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.37 sec
[17:11:09.710] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0.34 sec
[17:11:09.710] I [ timer  ] Timer: wcls::FrameSaver : 0.29 sec
[17:11:09.710] I [ timer  ] Timer: wcls::SimDepoSource : 0.07 sec
[17:11:09.710] I [ timer  ] Timer: Total node execution : 142.75000048428774 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 8499 subRun: 0 event: 34290 at 03-Oct-2025 17:11:34 CEST
SimDepoSource got 82095 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 82095 depos spanning: [-2245.49, 2245.52]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 15.66 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 13.18 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 11.97 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 11.54 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 11.36 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 10.85 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 10.43 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 9.38 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 8.96 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 8.7 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 8.33 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 5.99 sec
[17:14:26.172] I [ timer  ] Timer: wcls::SimChannelSink : 1.37 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.74 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.74 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.72 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.72 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.71 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.71 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.7 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.7 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.69 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.68 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.68 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.67 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Drifter : 0.66 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.66 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.66 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.64 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.64 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.64 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.63 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.63 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.63 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.61 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.61 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.55 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.53 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.51 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.49 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.48 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.47 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.46 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 0.44 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.43 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.41 sec
[17:14:26.172] I [ timer  ] Timer: wcls::FrameSaver : 0.41 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.38 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0.38 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Retagger : 0.36 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.35 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.33 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.31 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0.3 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.3 sec
[17:14:26.172] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0.3 sec
[17:14:26.172] I [ timer  ] Timer: wcls::SimDepoSource : 0.12 sec
[17:14:26.172] I [ timer  ] Timer: Total node execution : 151.5000004991889 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
03-Oct-2025 17:14:50 CEST  Closed output file "prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429_supernova_g4_detsim.root"
03-Oct-2025 17:14:50 CEST  Closed input file "prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429_supernova_g4.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      154.837       189.178       204.162       189.963        12.72         10     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000873103   0.00442199     0.0146864    0.00361022    0.00373522       10     
simulate:tpcrawdecoder:WireCellToolkit          140.755       170.65        184.11        172.189       11.009         10     
simulate:opdigi:OpDetDigitizerDUNE              1.83309       2.07799       2.29224       2.06745      0.127844        10     
simulate:rns:RandomNumberSaver                2.1202e-05    4.95444e-05   0.000240041   3.00805e-05   6.36096e-05      10     
[art]:TriggerResults:TriggerResultInserter    1.0075e-05    1.64827e-05   4.3235e-05    1.44165e-05   9.0799e-06       10     
end_path:out1:RootOutput                       2.934e-06    5.3682e-06    1.9219e-05    3.8905e-06    4.65366e-06      10     
end_path:out1:RootOutput(write)                 11.8572       16.4452       18.687        17.1123       2.05609        10     
================================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 5004.55 MB
  Peak resident set size usage (VmHWM): 3328.72 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429.root 22070901
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429_supernova_g4.root 130219009
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429_supernova_g4_detsim.root 2140010374
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429_supernova_g4_detsim.root.ext.json 1575
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429_supernova_g4_detsim.root.json 1841
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429_supernova_g4_detsim.root.temp.json 1841
written output file: prodbackground_radiological_decay0_dune10kt_1x2x6_lateralAPA_20251003T142935Z_gen_003429_supernova_g4_detsim_hist.root 519