Jobsub ID 31542.40@dunegpschedd02.fnal.gov

Jobsub ID	31542.40@dunegpschedd02.fnal.gov
Workflow ID	1978
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-01 13:59:31
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_juk
Last heartbeat	2025-09-01 14:08:19
From worker node	Hostname	wn-pep-004.farm.nikhef.nl
	cpuinfo	Intel(R) Xeon(R) Gold 6148 CPU @ 2.40GHz
	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-01 14:00:48
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6402377_204_20231202T101051Z_gen_g4_detsim_hitreco__20240507T210651Z_reco2.root
Jobscript	Exit code	0
	Real time	0m (44s)
	CPU time	0m (27s = 61%)
	Max RSS bytes	911953920 (869 MiB)
Outputting started	2025-09-01 14:01:33
Output files
Finished	2025-09-01 14:08:19
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

ent: 20430 at 01-Sep-2025 16:01:24 CEST
Begin processing the 31st record. run: 6402377 subRun: 1 event: 20431 at 01-Sep-2025 16:01:24 CEST
Begin processing the 32nd record. run: 6402377 subRun: 1 event: 20432 at 01-Sep-2025 16:01:25 CEST
Begin processing the 33rd record. run: 6402377 subRun: 1 event: 20433 at 01-Sep-2025 16:01:25 CEST
Begin processing the 34th record. run: 6402377 subRun: 1 event: 20434 at 01-Sep-2025 16:01:25 CEST
Begin processing the 35th record. run: 6402377 subRun: 1 event: 20435 at 01-Sep-2025 16:01:25 CEST
Begin processing the 36th record. run: 6402377 subRun: 1 event: 20436 at 01-Sep-2025 16:01:25 CEST
Begin processing the 37th record. run: 6402377 subRun: 1 event: 20437 at 01-Sep-2025 16:01:25 CEST
Begin processing the 38th record. run: 6402377 subRun: 1 event: 20438 at 01-Sep-2025 16:01:25 CEST
Begin processing the 39th record. run: 6402377 subRun: 1 event: 20439 at 01-Sep-2025 16:01:25 CEST
Begin processing the 40th record. run: 6402377 subRun: 1 event: 20440 at 01-Sep-2025 16:01:25 CEST
Begin processing the 41st record. run: 6402377 subRun: 1 event: 20441 at 01-Sep-2025 16:01:25 CEST
Begin processing the 42nd record. run: 6402377 subRun: 1 event: 20442 at 01-Sep-2025 16:01:25 CEST
Begin processing the 43rd record. run: 6402377 subRun: 1 event: 20443 at 01-Sep-2025 16:01:26 CEST
Begin processing the 44th record. run: 6402377 subRun: 1 event: 20444 at 01-Sep-2025 16:01:26 CEST
Begin processing the 45th record. run: 6402377 subRun: 1 event: 20445 at 01-Sep-2025 16:01:26 CEST
Begin processing the 46th record. run: 6402377 subRun: 1 event: 20446 at 01-Sep-2025 16:01:26 CEST
Begin processing the 47th record. run: 6402377 subRun: 1 event: 20447 at 01-Sep-2025 16:01:26 CEST
Begin processing the 48th record. run: 6402377 subRun: 1 event: 20448 at 01-Sep-2025 16:01:26 CEST
Begin processing the 49th record. run: 6402377 subRun: 1 event: 20449 at 01-Sep-2025 16:01:26 CEST
Begin processing the 50th record. run: 6402377 subRun: 1 event: 20450 at 01-Sep-2025 16:01:26 CEST
Begin processing the 51st record. run: 6402377 subRun: 1 event: 20451 at 01-Sep-2025 16:01:26 CEST
Begin processing the 52nd record. run: 6402377 subRun: 1 event: 20452 at 01-Sep-2025 16:01:26 CEST
Begin processing the 53rd record. run: 6402377 subRun: 1 event: 20453 at 01-Sep-2025 16:01:26 CEST
Begin processing the 54th record. run: 6402377 subRun: 1 event: 20454 at 01-Sep-2025 16:01:26 CEST
Begin processing the 55th record. run: 6402377 subRun: 1 event: 20455 at 01-Sep-2025 16:01:26 CEST
Begin processing the 56th record. run: 6402377 subRun: 1 event: 20456 at 01-Sep-2025 16:01:26 CEST
Begin processing the 57th record. run: 6402377 subRun: 1 event: 20457 at 01-Sep-2025 16:01:27 CEST
Begin processing the 58th record. run: 6402377 subRun: 1 event: 20458 at 01-Sep-2025 16:01:27 CEST
Begin processing the 59th record. run: 6402377 subRun: 1 event: 20459 at 01-Sep-2025 16:01:27 CEST
Begin processing the 60th record. run: 6402377 subRun: 1 event: 20460 at 01-Sep-2025 16:01:27 CEST
Begin processing the 61st record. run: 6402377 subRun: 1 event: 20461 at 01-Sep-2025 16:01:27 CEST
Begin processing the 62nd record. run: 6402377 subRun: 1 event: 20462 at 01-Sep-2025 16:01:27 CEST
Begin processing the 63rd record. run: 6402377 subRun: 1 event: 20463 at 01-Sep-2025 16:01:27 CEST
Begin processing the 64th record. run: 6402377 subRun: 1 event: 20464 at 01-Sep-2025 16:01:27 CEST
Begin processing the 65th record. run: 6402377 subRun: 1 event: 20465 at 01-Sep-2025 16:01:27 CEST
Begin processing the 66th record. run: 6402377 subRun: 1 event: 20466 at 01-Sep-2025 16:01:27 CEST
Begin processing the 67th record. run: 6402377 subRun: 1 event: 20467 at 01-Sep-2025 16:01:27 CEST
Begin processing the 68th record. run: 6402377 subRun: 1 event: 20468 at 01-Sep-2025 16:01:27 CEST
Begin processing the 69th record. run: 6402377 subRun: 1 event: 20469 at 01-Sep-2025 16:01:27 CEST
Begin processing the 70th record. run: 6402377 subRun: 1 event: 20470 at 01-Sep-2025 16:01:27 CEST
Begin processing the 71st record. run: 6402377 subRun: 1 event: 20471 at 01-Sep-2025 16:01:27 CEST
Begin processing the 72nd record. run: 6402377 subRun: 1 event: 20472 at 01-Sep-2025 16:01:27 CEST
Begin processing the 73rd record. run: 6402377 subRun: 1 event: 20473 at 01-Sep-2025 16:01:28 CEST
Begin processing the 74th record. run: 6402377 subRun: 1 event: 20474 at 01-Sep-2025 16:01:28 CEST
Begin processing the 75th record. run: 6402377 subRun: 1 event: 20475 at 01-Sep-2025 16:01:28 CEST
Begin processing the 76th record. run: 6402377 subRun: 1 event: 20476 at 01-Sep-2025 16:01:28 CEST
Begin processing the 77th record. run: 6402377 subRun: 1 event: 20477 at 01-Sep-2025 16:01:28 CEST
Begin processing the 78th record. run: 6402377 subRun: 1 event: 20478 at 01-Sep-2025 16:01:28 CEST
Begin processing the 79th record. run: 6402377 subRun: 1 event: 20479 at 01-Sep-2025 16:01:28 CEST
Begin processing the 80th record. run: 6402377 subRun: 1 event: 20480 at 01-Sep-2025 16:01:28 CEST
Begin processing the 81st record. run: 6402377 subRun: 1 event: 20481 at 01-Sep-2025 16:01:29 CEST
Begin processing the 82nd record. run: 6402377 subRun: 1 event: 20482 at 01-Sep-2025 16:01:29 CEST
Begin processing the 83rd record. run: 6402377 subRun: 1 event: 20483 at 01-Sep-2025 16:01:29 CEST
Begin processing the 84th record. run: 6402377 subRun: 1 event: 20484 at 01-Sep-2025 16:01:29 CEST
Begin processing the 85th record. run: 6402377 subRun: 1 event: 20485 at 01-Sep-2025 16:01:29 CEST
Begin processing the 86th record. run: 6402377 subRun: 1 event: 20486 at 01-Sep-2025 16:01:29 CEST
Begin processing the 87th record. run: 6402377 subRun: 1 event: 20487 at 01-Sep-2025 16:01:29 CEST
Begin processing the 88th record. run: 6402377 subRun: 1 event: 20488 at 01-Sep-2025 16:01:29 CEST
Begin processing the 89th record. run: 6402377 subRun: 1 event: 20489 at 01-Sep-2025 16:01:29 CEST
Begin processing the 90th record. run: 6402377 subRun: 1 event: 20490 at 01-Sep-2025 16:01:29 CEST
Begin processing the 91st record. run: 6402377 subRun: 1 event: 20491 at 01-Sep-2025 16:01:30 CEST
Begin processing the 92nd record. run: 6402377 subRun: 1 event: 20492 at 01-Sep-2025 16:01:30 CEST
Begin processing the 93rd record. run: 6402377 subRun: 1 event: 20493 at 01-Sep-2025 16:01:30 CEST
Begin processing the 94th record. run: 6402377 subRun: 1 event: 20494 at 01-Sep-2025 16:01:30 CEST
Begin processing the 95th record. run: 6402377 subRun: 1 event: 20495 at 01-Sep-2025 16:01:30 CEST
Begin processing the 96th record. run: 6402377 subRun: 1 event: 20496 at 01-Sep-2025 16:01:31 CEST
Begin processing the 97th record. run: 6402377 subRun: 1 event: 20497 at 01-Sep-2025 16:01:31 CEST
Begin processing the 98th record. run: 6402377 subRun: 1 event: 20498 at 01-Sep-2025 16:01:31 CEST
Begin processing the 99th record. run: 6402377 subRun: 1 event: 20499 at 01-Sep-2025 16:01:32 CEST
Begin processing the 100th record. run: 6402377 subRun: 1 event: 20500 at 01-Sep-2025 16:01:32 CEST
01-Sep-2025 16:01:32 CEST  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/e3/19/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6402377_204_20231202T101051Z_gen_g4_detsim_hitreco__20240507T210651Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0185204     0.0886546      1.41106      0.0324023     0.178774        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000422235   0.000644266   0.00106421    0.000631333   0.000162676      100    
prod:pandorapid:Chi2ParticleID                0.000821434   0.00230142     0.0121019    0.00164868    0.00185424       100    
prod:energyreconue:EnergyReco                 0.00357294     0.0081946     0.0711225    0.00505659    0.00911101       100    
prod:energyreconumu:EnergyReco                0.00148856     0.0357125     0.901346     0.00821238     0.116785        100    
prod:energyreconc:EnergyReco                  0.00255525    0.00983624     0.0684986    0.00867262    0.00990603       100    
[art]:TriggerResults:TriggerResultInserter     8.69e-06     1.06062e-05   4.2922e-05     1.015e-05    3.37183e-06      100    
end_path:ana:PIDASelectionAna                 0.00320823     0.0317274      0.35701      0.0125502     0.053804        100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 7451.06 MB
  Peak resident set size usage (VmHWM): 907.039 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 19986 Sep  1 16:01 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6402377_204_20231202T101051Z_gen_g4_detsim_hitreco__20240507T210651Z_reco2_pida_2025-09-01T_140054Z.root
-rw-r--r--. 1 dune012 dune 14308 Sep  1 16:01 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6402377_204_20231202T101051Z_gen_g4_detsim_hitreco__20240507T210651Z_reco2_reco_2025-09-01T_140054Z.log
-rw-r--r--. 1 dune012 dune 12032 Sep  1 16:01 jobscript.log
-rw-r--r--. 1 dune012 dune   216 Sep  1 16:01 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   137 Sep  1 16:00 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  1 16:01 debugprod.log