Jobsub ID 40523.81@dunegpschedd01.fnal.gov

Jobsub ID	40523.81@dunegpschedd01.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-04 23:40:48
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_klomp
Last heartbeat	2025-09-04 23:43:52
From worker node	Hostname	wn-choc-005.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-04 23:42:47
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_74517585_744_20231204T072833Z_gen_g4_detsim_hitreco__20240509T211024Z_reco2.root
Jobscript	Exit code	0
	Real time	0m (49s)
	CPU time	0m (44s = 89%)
	Max RSS bytes	1310253056 (1249 MiB)
Outputting started	2025-09-04 23:43:36
Output files
Finished	2025-09-04 23:43:52
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

run: 74517585 subRun: 1 event: 74431 at 05-Sep-2025 01:43:19 CEST
Begin processing the 32nd record. run: 74517585 subRun: 1 event: 74432 at 05-Sep-2025 01:43:19 CEST
Begin processing the 33rd record. run: 74517585 subRun: 1 event: 74433 at 05-Sep-2025 01:43:19 CEST
Begin processing the 34th record. run: 74517585 subRun: 1 event: 74434 at 05-Sep-2025 01:43:19 CEST
Begin processing the 35th record. run: 74517585 subRun: 1 event: 74435 at 05-Sep-2025 01:43:19 CEST
Begin processing the 36th record. run: 74517585 subRun: 1 event: 74436 at 05-Sep-2025 01:43:19 CEST
Begin processing the 37th record. run: 74517585 subRun: 1 event: 74437 at 05-Sep-2025 01:43:20 CEST
Begin processing the 38th record. run: 74517585 subRun: 1 event: 74438 at 05-Sep-2025 01:43:20 CEST
Begin processing the 39th record. run: 74517585 subRun: 1 event: 74439 at 05-Sep-2025 01:43:20 CEST
Begin processing the 40th record. run: 74517585 subRun: 1 event: 74440 at 05-Sep-2025 01:43:20 CEST
Begin processing the 41st record. run: 74517585 subRun: 1 event: 74441 at 05-Sep-2025 01:43:20 CEST
Begin processing the 42nd record. run: 74517585 subRun: 1 event: 74442 at 05-Sep-2025 01:43:20 CEST
Begin processing the 43rd record. run: 74517585 subRun: 1 event: 74443 at 05-Sep-2025 01:43:20 CEST
Begin processing the 44th record. run: 74517585 subRun: 1 event: 74444 at 05-Sep-2025 01:43:20 CEST
Begin processing the 45th record. run: 74517585 subRun: 1 event: 74445 at 05-Sep-2025 01:43:21 CEST
Begin processing the 46th record. run: 74517585 subRun: 1 event: 74446 at 05-Sep-2025 01:43:21 CEST
Begin processing the 47th record. run: 74517585 subRun: 1 event: 74447 at 05-Sep-2025 01:43:21 CEST
Begin processing the 48th record. run: 74517585 subRun: 1 event: 74448 at 05-Sep-2025 01:43:23 CEST
Begin processing the 49th record. run: 74517585 subRun: 1 event: 74449 at 05-Sep-2025 01:43:23 CEST
Begin processing the 50th record. run: 74517585 subRun: 1 event: 74450 at 05-Sep-2025 01:43:23 CEST
Begin processing the 51st record. run: 74517585 subRun: 1 event: 74451 at 05-Sep-2025 01:43:23 CEST
Begin processing the 52nd record. run: 74517585 subRun: 1 event: 74452 at 05-Sep-2025 01:43:23 CEST
Begin processing the 53rd record. run: 74517585 subRun: 1 event: 74453 at 05-Sep-2025 01:43:27 CEST
Begin processing the 54th record. run: 74517585 subRun: 1 event: 74454 at 05-Sep-2025 01:43:27 CEST
Begin processing the 55th record. run: 74517585 subRun: 1 event: 74455 at 05-Sep-2025 01:43:27 CEST
Begin processing the 56th record. run: 74517585 subRun: 1 event: 74456 at 05-Sep-2025 01:43:27 CEST
Begin processing the 57th record. run: 74517585 subRun: 1 event: 74457 at 05-Sep-2025 01:43:27 CEST
Begin processing the 58th record. run: 74517585 subRun: 1 event: 74458 at 05-Sep-2025 01:43:27 CEST
Begin processing the 59th record. run: 74517585 subRun: 1 event: 74459 at 05-Sep-2025 01:43:28 CEST
Begin processing the 60th record. run: 74517585 subRun: 1 event: 74460 at 05-Sep-2025 01:43:28 CEST
Begin processing the 61st record. run: 74517585 subRun: 1 event: 74461 at 05-Sep-2025 01:43:28 CEST
Begin processing the 62nd record. run: 74517585 subRun: 1 event: 74462 at 05-Sep-2025 01:43:28 CEST
Begin processing the 63rd record. run: 74517585 subRun: 1 event: 74463 at 05-Sep-2025 01:43:28 CEST
Begin processing the 64th record. run: 74517585 subRun: 1 event: 74464 at 05-Sep-2025 01:43:28 CEST
Begin processing the 65th record. run: 74517585 subRun: 1 event: 74465 at 05-Sep-2025 01:43:28 CEST
Begin processing the 66th record. run: 74517585 subRun: 1 event: 74466 at 05-Sep-2025 01:43:29 CEST
Begin processing the 67th record. run: 74517585 subRun: 1 event: 74467 at 05-Sep-2025 01:43:29 CEST
Begin processing the 68th record. run: 74517585 subRun: 1 event: 74468 at 05-Sep-2025 01:43:29 CEST
Begin processing the 69th record. run: 74517585 subRun: 1 event: 74469 at 05-Sep-2025 01:43:29 CEST
Begin processing the 70th record. run: 74517585 subRun: 1 event: 74470 at 05-Sep-2025 01:43:29 CEST
Begin processing the 71st record. run: 74517585 subRun: 1 event: 74471 at 05-Sep-2025 01:43:29 CEST
Begin processing the 72nd record. run: 74517585 subRun: 1 event: 74472 at 05-Sep-2025 01:43:29 CEST
Begin processing the 73rd record. run: 74517585 subRun: 1 event: 74473 at 05-Sep-2025 01:43:29 CEST
Begin processing the 74th record. run: 74517585 subRun: 1 event: 74474 at 05-Sep-2025 01:43:29 CEST
Begin processing the 75th record. run: 74517585 subRun: 1 event: 74475 at 05-Sep-2025 01:43:29 CEST
Begin processing the 76th record. run: 74517585 subRun: 1 event: 74476 at 05-Sep-2025 01:43:30 CEST
Begin processing the 77th record. run: 74517585 subRun: 1 event: 74477 at 05-Sep-2025 01:43:30 CEST
Begin processing the 78th record. run: 74517585 subRun: 1 event: 74478 at 05-Sep-2025 01:43:30 CEST
Begin processing the 79th record. run: 74517585 subRun: 1 event: 74479 at 05-Sep-2025 01:43:30 CEST
Begin processing the 80th record. run: 74517585 subRun: 1 event: 74480 at 05-Sep-2025 01:43:30 CEST
Begin processing the 81st record. run: 74517585 subRun: 1 event: 74481 at 05-Sep-2025 01:43:30 CEST
Begin processing the 82nd record. run: 74517585 subRun: 1 event: 74482 at 05-Sep-2025 01:43:30 CEST
Begin processing the 83rd record. run: 74517585 subRun: 1 event: 74483 at 05-Sep-2025 01:43:33 CEST
Begin processing the 84th record. run: 74517585 subRun: 1 event: 74484 at 05-Sep-2025 01:43:33 CEST
Begin processing the 85th record. run: 74517585 subRun: 1 event: 74485 at 05-Sep-2025 01:43:33 CEST
Begin processing the 86th record. run: 74517585 subRun: 1 event: 74486 at 05-Sep-2025 01:43:33 CEST
Begin processing the 87th record. run: 74517585 subRun: 1 event: 74487 at 05-Sep-2025 01:43:33 CEST
Begin processing the 88th record. run: 74517585 subRun: 1 event: 74488 at 05-Sep-2025 01:43:33 CEST
Begin processing the 89th record. run: 74517585 subRun: 1 event: 74489 at 05-Sep-2025 01:43:34 CEST
Begin processing the 90th record. run: 74517585 subRun: 1 event: 74490 at 05-Sep-2025 01:43:34 CEST
Begin processing the 91st record. run: 74517585 subRun: 1 event: 74491 at 05-Sep-2025 01:43:35 CEST
Begin processing the 92nd record. run: 74517585 subRun: 1 event: 74492 at 05-Sep-2025 01:43:35 CEST
Begin processing the 93rd record. run: 74517585 subRun: 1 event: 74493 at 05-Sep-2025 01:43:35 CEST
Begin processing the 94th record. run: 74517585 subRun: 1 event: 74494 at 05-Sep-2025 01:43:35 CEST
Begin processing the 95th record. run: 74517585 subRun: 1 event: 74495 at 05-Sep-2025 01:43:35 CEST
Begin processing the 96th record. run: 74517585 subRun: 1 event: 74496 at 05-Sep-2025 01:43:35 CEST
Begin processing the 97th record. run: 74517585 subRun: 1 event: 74497 at 05-Sep-2025 01:43:35 CEST
Begin processing the 98th record. run: 74517585 subRun: 1 event: 74498 at 05-Sep-2025 01:43:35 CEST
Begin processing the 99th record. run: 74517585 subRun: 1 event: 74499 at 05-Sep-2025 01:43:36 CEST
Begin processing the 100th record. run: 74517585 subRun: 1 event: 74500 at 05-Sep-2025 01:43:36 CEST
05-Sep-2025 01:43:36 CEST  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/cf/1f/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_74517585_744_20231204T072833Z_gen_g4_detsim_hitreco__20240509T211024Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0255293     0.187838       2.93374      0.0580226     0.412875        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.00048776    0.00205411     0.0197583    0.000821414   0.00436108       100    
prod:pandorapid:Chi2ParticleID                0.000983026   0.00552272     0.0566349    0.00236198    0.00822479       100    
prod:energyreconue:EnergyReco                 0.00488532     0.0251872     0.244609      0.0108405     0.0425562       100    
prod:energyreconumu:EnergyReco                0.00155196     0.0548103      1.25531     0.00946349     0.159059        100    
prod:energyreconc:EnergyReco                  0.00342648     0.021531      0.192779      0.0122366     0.0317915       100    
[art]:TriggerResults:TriggerResultInserter    1.3033e-05    1.53746e-05   7.0088e-05    1.43995e-05   6.05911e-06      100    
end_path:ana:PIDASelectionAna                 0.00373408     0.0783959      1.34931      0.0171507     0.192515        100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5704.22 MB
  Peak resident set size usage (VmHWM): 1310.25 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
.:
total 56
-rw-r--r--. 1 dune012 dune 20178 Sep  5 01:43 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_74517585_744_20231204T072833Z_gen_g4_detsim_hitreco__20240509T211024Z_reco2_pida_2025-09-04T_234251Z.root
-rw-r--r--. 1 dune012 dune 14411 Sep  5 01:43 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_74517585_744_20231204T072833Z_gen_g4_detsim_hitreco__20240509T211024Z_reco2_reco_2025-09-04T_234251Z.log
-rw-r--r--. 1 dune012 dune 12111 Sep  5 01:43 jobscript.log
-rw-r--r--. 1 dune012 dune   217 Sep  5 01:43 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   138 Sep  5 01:42 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  5 01:42 debugprod.log