Jobsub ID 229258.1@dunegpschedd01.fnal.gov

Jobsub ID	229258.1@dunegpschedd01.fnal.gov
Workflow ID	8503
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 16:53:26
Site	BR_CBPF
Entry	DUNE_BR_CBPF_ce02
Last heartbeat	2025-10-03 17:19:37
From worker node	Hostname	wn31
	cpuinfo	Intel(R) Xeon(R) CPU E5-2660 0 @ 2.20GHz
	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 16:56:36
Input files	monte-carlo-008503-001910
Jobscript	Exit code	0
	Real time	19m (1193s)
	CPU time	19m (1142s = 95%)
	Max RSS bytes	3044900864 (2903 MiB)
Outputting started	2025-10-03 17:16:30
Output files	fardet-hd:prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910_g4_detsim.root
Finished	2025-10-03 17:19:37
Saved logs	justin-logs:229258.1-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

WireCell::Gen::DepoTransform : 0.27 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.27 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.26 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.26 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.23 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.22 sec
[14:15:24.468] I [ timer  ] Timer: wcls::SimChannelSink : 0.19 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.19 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.18 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.18 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.17 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.11 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.1 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.08 sec
[14:15:24.468] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.08 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.07 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.06 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 0.05 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.05 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.05 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.05 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.04 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0.03 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Retagger : 0.03 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[14:15:24.469] I [ timer  ] Timer: wcls::FrameSaver : 0.02 sec
[14:15:24.469] I [ timer  ] Timer: wcls::SimDepoSource : 0.02 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::Drifter : 0.02 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0.01 sec
[14:15:24.469] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0.01 sec
[14:15:24.469] I [ timer  ] Timer: Total node execution : 24.820000018924475 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 10th record. run: 8503 subRun: 0 event: 19100 at 03-Oct-2025 14:15:44 -03
SimDepoSource got 4803 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
SimDepoSource: ready with 4803 depos spanning: [1.00006, 1.00628]us
Retagger: tagging trace set: daq with 30720 traces, 0 summary
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 2.44 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 1.25 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 1.16 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 1.05 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 1.05 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 1.02 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.95 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.93 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.92 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.83 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.78 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.69 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::Digitizer : 0.68 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.53 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.52 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.51 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.5 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.45 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.44 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.43 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.43 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.43 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::IncoherentAddNoise : 0.41 sec
[14:16:10.013] I [ timer  ] Timer: wcls::SimChannelSink : 0.33 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.27 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.27 sec
[14:16:10.013] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.25 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.25 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.24 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.23 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.22 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.21 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.18 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.18 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoTransform : 0.18 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.11 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.09 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.09 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoBagger : 0.08 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DumpFrames : 0.07 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.07 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.06 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.06 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.06 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.06 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.05 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.05 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Drifter : 0.04 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::FrameFanin : 0.04 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.03 sec
[14:16:10.014] I [ timer  ] Timer: wcls::SimDepoSource : 0.02 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::DepoSetFanout : 0.02 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Reframer : 0.02 sec
[14:16:10.014] I [ timer  ] Timer: WireCell::Gen::Retagger : 0.01 sec
[14:16:10.014] I [ timer  ] Timer: wcls::FrameSaver : 0.01 sec
[14:16:10.014] I [ timer  ] Timer: Total node execution : 23.289999833330512 sec
wclsFrameSaver: saving raw::RawDigits tagged "daq"
03-Oct-2025 14:16:26 -03  Closed output file "prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910_g4_detsim.root"
03-Oct-2025 14:16:26 -03  Closed input file "prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910_g4.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      39.2992       44.7035       52.5503       44.2229       3.32038        10     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.00080011    0.00101396    0.00122816    0.000997377   0.00013191       10     
simulate:tpcrawdecoder:WireCellToolkit          27.0905       29.7252       35.0911       29.5118       2.1442         10     
simulate:opdigi:OpDetDigitizerDUNE             0.115954      0.220373      0.338936      0.201913      0.0634673       10     
simulate:rns:RandomNumberSaver                3.9969e-05     8.967e-05    0.000416526   5.3467e-05    0.00010949       10     
[art]:TriggerResults:TriggerResultInserter    1.9818e-05    3.42349e-05   7.9883e-05    2.9468e-05    1.61889e-05      10     
end_path:out1:RootOutput                       4.092e-06    9.3031e-06    2.8935e-05     6.466e-06    7.03263e-06      10     
end_path:out1:RootOutput(write)                 11.1371       14.7563       17.2584       15.752        2.13062        10     
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4698.2 MB
  Peak resident set size usage (VmHWM): 3044.9 MB
====================================================================================================
Art has completed and will exit with status 0.
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910.root 99210
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910_g4.root 4750597
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910_g4_detsim.root 1803483774
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910_g4_detsim.root.ext.json 1469
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910_g4_detsim.root.json 1771
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910_g4_detsim.root.temp.json 1771
written output file: prod_gamma_1-500MeV_dune10kt_1x2x6_20251003T165640Z_gen_001910_g4_detsim_hist.root 519