Jobsub ID 33793.29@dunegpschedd02.fnal.gov

Jobsub ID	33793.29@dunegpschedd02.fnal.gov
Workflow ID	1980
Stage ID	1
User name	hsouza@fnal.gov
HTCondor Group	group_dune
Requested	Processors	1
	GPU	No
	RSS bytes	3145728000 (3000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-09-05 00:02:50
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_klomp
Last heartbeat	2025-09-05 00:05:49
From worker node	Hostname	wn-choc-019.farm.nikhef.nl
	cpuinfo	Intel(R) Xeon(R) CPU E5-2650 v4 @ 2.20GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	3145728000 (3000 MiB)
	Wall seconds limit	129600 (36 hours)
	GPU
	Inner Apptainer?	True
Job state	outputting_failed
Started	2025-09-05 00:04:10
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50258005_497_20231121T154603Z_gen_g4_detsim_hitreco__20240503T053823Z_reco2.root
Jobscript	Exit code	0
	Real time	1m (82s)
	CPU time	1m (71s = 86%)
	Max RSS bytes	1642643456 (1566 MiB)
Outputting started	2025-09-05 00:05:33
Output files
Finished	2025-09-05 00:05:49
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

egin processing the 132nd record. run: 50258005 subRun: 1 event: 99532 at 05-Sep-2025 02:05:21 CEST
Begin processing the 133rd record. run: 50258005 subRun: 1 event: 99533 at 05-Sep-2025 02:05:21 CEST
Begin processing the 134th record. run: 50258005 subRun: 1 event: 99534 at 05-Sep-2025 02:05:22 CEST
Begin processing the 135th record. run: 50258005 subRun: 1 event: 99535 at 05-Sep-2025 02:05:22 CEST
Begin processing the 136th record. run: 50258005 subRun: 1 event: 99536 at 05-Sep-2025 02:05:22 CEST
Begin processing the 137th record. run: 50258005 subRun: 1 event: 99537 at 05-Sep-2025 02:05:22 CEST
Begin processing the 138th record. run: 50258005 subRun: 1 event: 99538 at 05-Sep-2025 02:05:22 CEST
Begin processing the 139th record. run: 50258005 subRun: 1 event: 99539 at 05-Sep-2025 02:05:22 CEST
Begin processing the 140th record. run: 50258005 subRun: 1 event: 99540 at 05-Sep-2025 02:05:22 CEST
Begin processing the 141st record. run: 50258005 subRun: 1 event: 99541 at 05-Sep-2025 02:05:22 CEST
Begin processing the 142nd record. run: 50258005 subRun: 1 event: 99542 at 05-Sep-2025 02:05:22 CEST
Begin processing the 143rd record. run: 50258005 subRun: 1 event: 99543 at 05-Sep-2025 02:05:22 CEST
Begin processing the 144th record. run: 50258005 subRun: 1 event: 99544 at 05-Sep-2025 02:05:22 CEST
Begin processing the 145th record. run: 50258005 subRun: 1 event: 99545 at 05-Sep-2025 02:05:22 CEST
Begin processing the 146th record. run: 50258005 subRun: 1 event: 99546 at 05-Sep-2025 02:05:23 CEST
Begin processing the 147th record. run: 50258005 subRun: 1 event: 99547 at 05-Sep-2025 02:05:23 CEST
Begin processing the 148th record. run: 50258005 subRun: 1 event: 99548 at 05-Sep-2025 02:05:23 CEST
Begin processing the 149th record. run: 50258005 subRun: 1 event: 99549 at 05-Sep-2025 02:05:23 CEST
Begin processing the 150th record. run: 50258005 subRun: 1 event: 99550 at 05-Sep-2025 02:05:24 CEST
Begin processing the 151st record. run: 50258005 subRun: 1 event: 99551 at 05-Sep-2025 02:05:24 CEST
Begin processing the 152nd record. run: 50258005 subRun: 1 event: 99552 at 05-Sep-2025 02:05:24 CEST
Begin processing the 153rd record. run: 50258005 subRun: 1 event: 99553 at 05-Sep-2025 02:05:24 CEST
Begin processing the 154th record. run: 50258005 subRun: 1 event: 99554 at 05-Sep-2025 02:05:24 CEST
Begin processing the 155th record. run: 50258005 subRun: 1 event: 99555 at 05-Sep-2025 02:05:24 CEST
Begin processing the 156th record. run: 50258005 subRun: 1 event: 99556 at 05-Sep-2025 02:05:24 CEST
Begin processing the 157th record. run: 50258005 subRun: 1 event: 99557 at 05-Sep-2025 02:05:24 CEST
Begin processing the 158th record. run: 50258005 subRun: 1 event: 99558 at 05-Sep-2025 02:05:25 CEST
Begin processing the 159th record. run: 50258005 subRun: 1 event: 99559 at 05-Sep-2025 02:05:25 CEST
Begin processing the 160th record. run: 50258005 subRun: 1 event: 99560 at 05-Sep-2025 02:05:25 CEST
Begin processing the 161st record. run: 50258005 subRun: 1 event: 99561 at 05-Sep-2025 02:05:27 CEST
Begin processing the 162nd record. run: 50258005 subRun: 1 event: 99562 at 05-Sep-2025 02:05:28 CEST
Begin processing the 163rd record. run: 50258005 subRun: 1 event: 99563 at 05-Sep-2025 02:05:28 CEST
Begin processing the 164th record. run: 50258005 subRun: 1 event: 99564 at 05-Sep-2025 02:05:28 CEST
Begin processing the 165th record. run: 50258005 subRun: 1 event: 99565 at 05-Sep-2025 02:05:28 CEST
Begin processing the 166th record. run: 50258005 subRun: 1 event: 99566 at 05-Sep-2025 02:05:29 CEST
Begin processing the 167th record. run: 50258005 subRun: 1 event: 99567 at 05-Sep-2025 02:05:29 CEST
Begin processing the 168th record. run: 50258005 subRun: 1 event: 99568 at 05-Sep-2025 02:05:29 CEST
Begin processing the 169th record. run: 50258005 subRun: 1 event: 99569 at 05-Sep-2025 02:05:29 CEST
Begin processing the 170th record. run: 50258005 subRun: 1 event: 99570 at 05-Sep-2025 02:05:29 CEST
Begin processing the 171st record. run: 50258005 subRun: 1 event: 99571 at 05-Sep-2025 02:05:29 CEST
Begin processing the 172nd record. run: 50258005 subRun: 1 event: 99572 at 05-Sep-2025 02:05:29 CEST
Begin processing the 173rd record. run: 50258005 subRun: 1 event: 99573 at 05-Sep-2025 02:05:29 CEST
Begin processing the 174th record. run: 50258005 subRun: 1 event: 99574 at 05-Sep-2025 02:05:29 CEST
Begin processing the 175th record. run: 50258005 subRun: 1 event: 99575 at 05-Sep-2025 02:05:29 CEST
Begin processing the 176th record. run: 50258005 subRun: 1 event: 99576 at 05-Sep-2025 02:05:29 CEST
Begin processing the 177th record. run: 50258005 subRun: 1 event: 99577 at 05-Sep-2025 02:05:29 CEST
Begin processing the 178th record. run: 50258005 subRun: 1 event: 99578 at 05-Sep-2025 02:05:30 CEST
Begin processing the 179th record. run: 50258005 subRun: 1 event: 99579 at 05-Sep-2025 02:05:30 CEST
Begin processing the 180th record. run: 50258005 subRun: 1 event: 99580 at 05-Sep-2025 02:05:30 CEST
Begin processing the 181st record. run: 50258005 subRun: 1 event: 99581 at 05-Sep-2025 02:05:30 CEST
Begin processing the 182nd record. run: 50258005 subRun: 1 event: 99582 at 05-Sep-2025 02:05:30 CEST
Begin processing the 183rd record. run: 50258005 subRun: 1 event: 99583 at 05-Sep-2025 02:05:30 CEST
Begin processing the 184th record. run: 50258005 subRun: 1 event: 99584 at 05-Sep-2025 02:05:30 CEST
Begin processing the 185th record. run: 50258005 subRun: 1 event: 99585 at 05-Sep-2025 02:05:30 CEST
Begin processing the 186th record. run: 50258005 subRun: 1 event: 99586 at 05-Sep-2025 02:05:31 CEST
Begin processing the 187th record. run: 50258005 subRun: 1 event: 99587 at 05-Sep-2025 02:05:31 CEST
Begin processing the 188th record. run: 50258005 subRun: 1 event: 99588 at 05-Sep-2025 02:05:31 CEST
Begin processing the 189th record. run: 50258005 subRun: 1 event: 99589 at 05-Sep-2025 02:05:31 CEST
Begin processing the 190th record. run: 50258005 subRun: 1 event: 99590 at 05-Sep-2025 02:05:31 CEST
Begin processing the 191st record. run: 50258005 subRun: 1 event: 99591 at 05-Sep-2025 02:05:31 CEST
Begin processing the 192nd record. run: 50258005 subRun: 1 event: 99592 at 05-Sep-2025 02:05:31 CEST
Begin processing the 193rd record. run: 50258005 subRun: 1 event: 99593 at 05-Sep-2025 02:05:31 CEST
Begin processing the 194th record. run: 50258005 subRun: 1 event: 99594 at 05-Sep-2025 02:05:31 CEST
Begin processing the 195th record. run: 50258005 subRun: 1 event: 99595 at 05-Sep-2025 02:05:31 CEST
Begin processing the 196th record. run: 50258005 subRun: 1 event: 99596 at 05-Sep-2025 02:05:32 CEST
Begin processing the 197th record. run: 50258005 subRun: 1 event: 99597 at 05-Sep-2025 02:05:32 CEST
Begin processing the 198th record. run: 50258005 subRun: 1 event: 99598 at 05-Sep-2025 02:05:32 CEST
Begin processing the 199th record. run: 50258005 subRun: 1 event: 99599 at 05-Sep-2025 02:05:32 CEST
Begin processing the 200th record. run: 50258005 subRun: 1 event: 99600 at 05-Sep-2025 02:05:32 CEST
05-Sep-2025 02:05:32 CEST  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/a9/fc/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50258005_497_20231121T154603Z_gen_g4_detsim_hitreco__20240503T053823Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0249936     0.166552       5.93704      0.0478015     0.528634        200    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000507074   0.000868788   0.00245831    0.000830399   0.00025068       200    
prod:pandorapid:Chi2ParticleID                0.00096202    0.00316514     0.0402668    0.00213679    0.00428125       200    
prod:energyreconue:EnergyReco                 0.00463954     0.0208615     0.617308      0.0090952     0.0586967       200    
prod:energyreconumu:EnergyReco                0.00155233     0.0599056      3.00458      0.0110789     0.262519        200    
prod:energyreconc:EnergyReco                  0.00347263     0.0193342     0.506075      0.0124977     0.0462526       200    
[art]:TriggerResults:TriggerResultInserter    1.2538e-05    1.45489e-05    6.625e-05    1.4149e-05    3.82334e-06      200    
end_path:ana:PIDASelectionAna                 0.00375461     0.0620868      1.76757      0.0181572     0.185153        200    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 6040.41 MB
  Peak resident set size usage (VmHWM): 1642.64 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
.:
total 80
-rw-r--r--. 1 dune012 dune 28836 Sep  5 02:05 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50258005_497_20231121T154603Z_gen_g4_detsim_hitreco__20240503T053823Z_reco2_pida_2025-09-05T_000415Z.root
-rw-r--r--. 1 dune012 dune 24511 Sep  5 02:05 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50258005_497_20231121T154603Z_gen_g4_detsim_hitreco__20240503T053823Z_reco2_reco_2025-09-05T_000415Z.log
-rw-r--r--. 1 dune012 dune 12187 Sep  5 02:05 jobscript.log
-rw-r--r--. 1 dune012 dune   217 Sep  5 02:05 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   138 Sep  5 02:04 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  5 02:04 debugprod.log