Jobsub ID 33814.91@dunegpschedd02.fnal.gov

Jobsub ID	33814.91@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 01:20:57
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_dissel
Last heartbeat	2025-09-05 01:24:36
From worker node	Hostname	wn-choc-026.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 01:21:46
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	2m (145s)
	CPU time	1m (65s = 44%)
	Max RSS bytes	1644085248 (1567 MiB)
Outputting started	2025-09-05 01:24:11
Output files
Finished	2025-09-05 01:24:36
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 03:23:50 CEST
Begin processing the 133rd record. run: 50258005 subRun: 1 event: 99533 at 05-Sep-2025 03:23:50 CEST
Begin processing the 134th record. run: 50258005 subRun: 1 event: 99534 at 05-Sep-2025 03:23:50 CEST
Begin processing the 135th record. run: 50258005 subRun: 1 event: 99535 at 05-Sep-2025 03:23:50 CEST
Begin processing the 136th record. run: 50258005 subRun: 1 event: 99536 at 05-Sep-2025 03:23:50 CEST
Begin processing the 137th record. run: 50258005 subRun: 1 event: 99537 at 05-Sep-2025 03:23:50 CEST
Begin processing the 138th record. run: 50258005 subRun: 1 event: 99538 at 05-Sep-2025 03:23:51 CEST
Begin processing the 139th record. run: 50258005 subRun: 1 event: 99539 at 05-Sep-2025 03:23:51 CEST
Begin processing the 140th record. run: 50258005 subRun: 1 event: 99540 at 05-Sep-2025 03:23:51 CEST
Begin processing the 141st record. run: 50258005 subRun: 1 event: 99541 at 05-Sep-2025 03:23:51 CEST
Begin processing the 142nd record. run: 50258005 subRun: 1 event: 99542 at 05-Sep-2025 03:23:51 CEST
Begin processing the 143rd record. run: 50258005 subRun: 1 event: 99543 at 05-Sep-2025 03:23:51 CEST
Begin processing the 144th record. run: 50258005 subRun: 1 event: 99544 at 05-Sep-2025 03:23:52 CEST
Begin processing the 145th record. run: 50258005 subRun: 1 event: 99545 at 05-Sep-2025 03:23:52 CEST
Begin processing the 146th record. run: 50258005 subRun: 1 event: 99546 at 05-Sep-2025 03:23:52 CEST
Begin processing the 147th record. run: 50258005 subRun: 1 event: 99547 at 05-Sep-2025 03:23:52 CEST
Begin processing the 148th record. run: 50258005 subRun: 1 event: 99548 at 05-Sep-2025 03:23:54 CEST
Begin processing the 149th record. run: 50258005 subRun: 1 event: 99549 at 05-Sep-2025 03:23:54 CEST
Begin processing the 150th record. run: 50258005 subRun: 1 event: 99550 at 05-Sep-2025 03:23:55 CEST
Begin processing the 151st record. run: 50258005 subRun: 1 event: 99551 at 05-Sep-2025 03:23:55 CEST
Begin processing the 152nd record. run: 50258005 subRun: 1 event: 99552 at 05-Sep-2025 03:23:55 CEST
Begin processing the 153rd record. run: 50258005 subRun: 1 event: 99553 at 05-Sep-2025 03:23:55 CEST
Begin processing the 154th record. run: 50258005 subRun: 1 event: 99554 at 05-Sep-2025 03:23:55 CEST
Begin processing the 155th record. run: 50258005 subRun: 1 event: 99555 at 05-Sep-2025 03:23:56 CEST
Begin processing the 156th record. run: 50258005 subRun: 1 event: 99556 at 05-Sep-2025 03:23:56 CEST
Begin processing the 157th record. run: 50258005 subRun: 1 event: 99557 at 05-Sep-2025 03:23:56 CEST
Begin processing the 158th record. run: 50258005 subRun: 1 event: 99558 at 05-Sep-2025 03:23:56 CEST
Begin processing the 159th record. run: 50258005 subRun: 1 event: 99559 at 05-Sep-2025 03:23:56 CEST
Begin processing the 160th record. run: 50258005 subRun: 1 event: 99560 at 05-Sep-2025 03:23:56 CEST
Begin processing the 161st record. run: 50258005 subRun: 1 event: 99561 at 05-Sep-2025 03:24:01 CEST
Begin processing the 162nd record. run: 50258005 subRun: 1 event: 99562 at 05-Sep-2025 03:24:01 CEST
Begin processing the 163rd record. run: 50258005 subRun: 1 event: 99563 at 05-Sep-2025 03:24:02 CEST
Begin processing the 164th record. run: 50258005 subRun: 1 event: 99564 at 05-Sep-2025 03:24:03 CEST
Begin processing the 165th record. run: 50258005 subRun: 1 event: 99565 at 05-Sep-2025 03:24:03 CEST
Begin processing the 166th record. run: 50258005 subRun: 1 event: 99566 at 05-Sep-2025 03:24:04 CEST
Begin processing the 167th record. run: 50258005 subRun: 1 event: 99567 at 05-Sep-2025 03:24:04 CEST
Begin processing the 168th record. run: 50258005 subRun: 1 event: 99568 at 05-Sep-2025 03:24:04 CEST
Begin processing the 169th record. run: 50258005 subRun: 1 event: 99569 at 05-Sep-2025 03:24:04 CEST
Begin processing the 170th record. run: 50258005 subRun: 1 event: 99570 at 05-Sep-2025 03:24:04 CEST
Begin processing the 171st record. run: 50258005 subRun: 1 event: 99571 at 05-Sep-2025 03:24:04 CEST
Begin processing the 172nd record. run: 50258005 subRun: 1 event: 99572 at 05-Sep-2025 03:24:04 CEST
Begin processing the 173rd record. run: 50258005 subRun: 1 event: 99573 at 05-Sep-2025 03:24:04 CEST
Begin processing the 174th record. run: 50258005 subRun: 1 event: 99574 at 05-Sep-2025 03:24:05 CEST
Begin processing the 175th record. run: 50258005 subRun: 1 event: 99575 at 05-Sep-2025 03:24:05 CEST
Begin processing the 176th record. run: 50258005 subRun: 1 event: 99576 at 05-Sep-2025 03:24:05 CEST
Begin processing the 177th record. run: 50258005 subRun: 1 event: 99577 at 05-Sep-2025 03:24:05 CEST
Begin processing the 178th record. run: 50258005 subRun: 1 event: 99578 at 05-Sep-2025 03:24:05 CEST
Begin processing the 179th record. run: 50258005 subRun: 1 event: 99579 at 05-Sep-2025 03:24:05 CEST
Begin processing the 180th record. run: 50258005 subRun: 1 event: 99580 at 05-Sep-2025 03:24:06 CEST
Begin processing the 181st record. run: 50258005 subRun: 1 event: 99581 at 05-Sep-2025 03:24:06 CEST
Begin processing the 182nd record. run: 50258005 subRun: 1 event: 99582 at 05-Sep-2025 03:24:06 CEST
Begin processing the 183rd record. run: 50258005 subRun: 1 event: 99583 at 05-Sep-2025 03:24:06 CEST
Begin processing the 184th record. run: 50258005 subRun: 1 event: 99584 at 05-Sep-2025 03:24:06 CEST
Begin processing the 185th record. run: 50258005 subRun: 1 event: 99585 at 05-Sep-2025 03:24:07 CEST
Begin processing the 186th record. run: 50258005 subRun: 1 event: 99586 at 05-Sep-2025 03:24:07 CEST
Begin processing the 187th record. run: 50258005 subRun: 1 event: 99587 at 05-Sep-2025 03:24:07 CEST
Begin processing the 188th record. run: 50258005 subRun: 1 event: 99588 at 05-Sep-2025 03:24:07 CEST
Begin processing the 189th record. run: 50258005 subRun: 1 event: 99589 at 05-Sep-2025 03:24:07 CEST
Begin processing the 190th record. run: 50258005 subRun: 1 event: 99590 at 05-Sep-2025 03:24:08 CEST
Begin processing the 191st record. run: 50258005 subRun: 1 event: 99591 at 05-Sep-2025 03:24:08 CEST
Begin processing the 192nd record. run: 50258005 subRun: 1 event: 99592 at 05-Sep-2025 03:24:08 CEST
Begin processing the 193rd record. run: 50258005 subRun: 1 event: 99593 at 05-Sep-2025 03:24:08 CEST
Begin processing the 194th record. run: 50258005 subRun: 1 event: 99594 at 05-Sep-2025 03:24:08 CEST
Begin processing the 195th record. run: 50258005 subRun: 1 event: 99595 at 05-Sep-2025 03:24:08 CEST
Begin processing the 196th record. run: 50258005 subRun: 1 event: 99596 at 05-Sep-2025 03:24:09 CEST
Begin processing the 197th record. run: 50258005 subRun: 1 event: 99597 at 05-Sep-2025 03:24:10 CEST
Begin processing the 198th record. run: 50258005 subRun: 1 event: 99598 at 05-Sep-2025 03:24:10 CEST
Begin processing the 199th record. run: 50258005 subRun: 1 event: 99599 at 05-Sep-2025 03:24:10 CEST
Begin processing the 200th record. run: 50258005 subRun: 1 event: 99600 at 05-Sep-2025 03:24:10 CEST
05-Sep-2025 03:24:10 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.0420951     0.332743       11.9273      0.0950666      1.07233        200    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.00050823    0.00507335     0.0314505     0.0010112    0.00571848       200    
prod:pandorapid:Chi2ParticleID                0.00100888    0.00463022     0.0624454     0.002438     0.00750263       200    
prod:energyreconue:EnergyReco                 0.00494102     0.0359151      1.24962      0.0146588     0.116403        200    
prod:energyreconumu:EnergyReco                0.00157844     0.122496       6.16178      0.014711      0.548779        200    
prod:energyreconc:EnergyReco                  0.00346082     0.0379436      1.03187      0.0221066     0.0936569       200    
[art]:TriggerResults:TriggerResultInserter    1.3185e-05    1.49554e-05   6.5328e-05    1.44585e-05   3.82651e-06      200    
end_path:ana:PIDASelectionAna                 0.00400325     0.126159       3.42038      0.0412786     0.360086        200    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4429.81 MB
  Peak resident set size usage (VmHWM): 1644.09 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 03:24 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50258005_497_20231121T154603Z_gen_g4_detsim_hitreco__20240503T053823Z_reco2_pida_2025-09-05T_012154Z.root
-rw-r--r--. 1 dune012 dune 24511 Sep  5 03:24 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50258005_497_20231121T154603Z_gen_g4_detsim_hitreco__20240503T053823Z_reco2_reco_2025-09-05T_012154Z.log
-rw-r--r--. 1 dune012 dune 12187 Sep  5 03:24 jobscript.log
-rw-r--r--. 1 dune012 dune   217 Sep  5 03:24 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   138 Sep  5 03:21 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  5 03:22 debugprod.log