Jobsub ID 33793.24@dunegpschedd02.fnal.gov

Jobsub ID	33793.24@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_dissel
Last heartbeat	2025-09-05 00:05:54
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:38
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400858_334_20231202T080228Z_gen_g4_detsim_hitreco__20240507T210024Z_reco2.root
Jobscript	Exit code	0
	Real time	0m (59s)
	CPU time	0m (56s = 94%)
	Max RSS bytes	1194823680 (1139 MiB)
Outputting started	2025-09-05 00:05:38
Output files
Finished	2025-09-05 00:05:54
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

ent: 33430 at 05-Sep-2025 02:05:05 CEST
Begin processing the 31st record. run: 6400858 subRun: 1 event: 33431 at 05-Sep-2025 02:05:12 CEST
Begin processing the 32nd record. run: 6400858 subRun: 1 event: 33432 at 05-Sep-2025 02:05:12 CEST
Begin processing the 33rd record. run: 6400858 subRun: 1 event: 33433 at 05-Sep-2025 02:05:12 CEST
Begin processing the 34th record. run: 6400858 subRun: 1 event: 33434 at 05-Sep-2025 02:05:14 CEST
Begin processing the 35th record. run: 6400858 subRun: 1 event: 33435 at 05-Sep-2025 02:05:14 CEST
Begin processing the 36th record. run: 6400858 subRun: 1 event: 33436 at 05-Sep-2025 02:05:14 CEST
Begin processing the 37th record. run: 6400858 subRun: 1 event: 33437 at 05-Sep-2025 02:05:15 CEST
Begin processing the 38th record. run: 6400858 subRun: 1 event: 33438 at 05-Sep-2025 02:05:15 CEST
Begin processing the 39th record. run: 6400858 subRun: 1 event: 33439 at 05-Sep-2025 02:05:15 CEST
Begin processing the 40th record. run: 6400858 subRun: 1 event: 33440 at 05-Sep-2025 02:05:15 CEST
Begin processing the 41st record. run: 6400858 subRun: 1 event: 33441 at 05-Sep-2025 02:05:15 CEST
Begin processing the 42nd record. run: 6400858 subRun: 1 event: 33442 at 05-Sep-2025 02:05:15 CEST
Begin processing the 43rd record. run: 6400858 subRun: 1 event: 33443 at 05-Sep-2025 02:05:15 CEST
Begin processing the 44th record. run: 6400858 subRun: 1 event: 33444 at 05-Sep-2025 02:05:15 CEST
Begin processing the 45th record. run: 6400858 subRun: 1 event: 33445 at 05-Sep-2025 02:05:16 CEST
Begin processing the 46th record. run: 6400858 subRun: 1 event: 33446 at 05-Sep-2025 02:05:17 CEST
Begin processing the 47th record. run: 6400858 subRun: 1 event: 33447 at 05-Sep-2025 02:05:17 CEST
Begin processing the 48th record. run: 6400858 subRun: 1 event: 33448 at 05-Sep-2025 02:05:17 CEST
Begin processing the 49th record. run: 6400858 subRun: 1 event: 33449 at 05-Sep-2025 02:05:19 CEST
Begin processing the 50th record. run: 6400858 subRun: 1 event: 33450 at 05-Sep-2025 02:05:19 CEST
Begin processing the 51st record. run: 6400858 subRun: 1 event: 33451 at 05-Sep-2025 02:05:20 CEST
Begin processing the 52nd record. run: 6400858 subRun: 1 event: 33452 at 05-Sep-2025 02:05:20 CEST
Begin processing the 53rd record. run: 6400858 subRun: 1 event: 33453 at 05-Sep-2025 02:05:20 CEST
Begin processing the 54th record. run: 6400858 subRun: 1 event: 33454 at 05-Sep-2025 02:05:20 CEST
Begin processing the 55th record. run: 6400858 subRun: 1 event: 33455 at 05-Sep-2025 02:05:20 CEST
Begin processing the 56th record. run: 6400858 subRun: 1 event: 33456 at 05-Sep-2025 02:05:20 CEST
Begin processing the 57th record. run: 6400858 subRun: 1 event: 33457 at 05-Sep-2025 02:05:20 CEST
Begin processing the 58th record. run: 6400858 subRun: 1 event: 33458 at 05-Sep-2025 02:05:20 CEST
Begin processing the 59th record. run: 6400858 subRun: 1 event: 33459 at 05-Sep-2025 02:05:20 CEST
Begin processing the 60th record. run: 6400858 subRun: 1 event: 33460 at 05-Sep-2025 02:05:20 CEST
Begin processing the 61st record. run: 6400858 subRun: 1 event: 33461 at 05-Sep-2025 02:05:20 CEST
Begin processing the 62nd record. run: 6400858 subRun: 1 event: 33462 at 05-Sep-2025 02:05:20 CEST
Begin processing the 63rd record. run: 6400858 subRun: 1 event: 33463 at 05-Sep-2025 02:05:20 CEST
Begin processing the 64th record. run: 6400858 subRun: 1 event: 33464 at 05-Sep-2025 02:05:21 CEST
Begin processing the 65th record. run: 6400858 subRun: 1 event: 33465 at 05-Sep-2025 02:05:21 CEST
Begin processing the 66th record. run: 6400858 subRun: 1 event: 33466 at 05-Sep-2025 02:05:21 CEST
Begin processing the 67th record. run: 6400858 subRun: 1 event: 33467 at 05-Sep-2025 02:05:21 CEST
Begin processing the 68th record. run: 6400858 subRun: 1 event: 33468 at 05-Sep-2025 02:05:21 CEST
Begin processing the 69th record. run: 6400858 subRun: 1 event: 33469 at 05-Sep-2025 02:05:21 CEST
Begin processing the 70th record. run: 6400858 subRun: 1 event: 33470 at 05-Sep-2025 02:05:22 CEST
Begin processing the 71st record. run: 6400858 subRun: 1 event: 33471 at 05-Sep-2025 02:05:22 CEST
Begin processing the 72nd record. run: 6400858 subRun: 1 event: 33472 at 05-Sep-2025 02:05:22 CEST
Begin processing the 73rd record. run: 6400858 subRun: 1 event: 33473 at 05-Sep-2025 02:05:26 CEST
Begin processing the 74th record. run: 6400858 subRun: 1 event: 33474 at 05-Sep-2025 02:05:26 CEST
Begin processing the 75th record. run: 6400858 subRun: 1 event: 33475 at 05-Sep-2025 02:05:26 CEST
Begin processing the 76th record. run: 6400858 subRun: 1 event: 33476 at 05-Sep-2025 02:05:26 CEST
Begin processing the 77th record. run: 6400858 subRun: 1 event: 33477 at 05-Sep-2025 02:05:26 CEST
Begin processing the 78th record. run: 6400858 subRun: 1 event: 33478 at 05-Sep-2025 02:05:27 CEST
Begin processing the 79th record. run: 6400858 subRun: 1 event: 33479 at 05-Sep-2025 02:05:27 CEST
Begin processing the 80th record. run: 6400858 subRun: 1 event: 33480 at 05-Sep-2025 02:05:27 CEST
Begin processing the 81st record. run: 6400858 subRun: 1 event: 33481 at 05-Sep-2025 02:05:27 CEST
Begin processing the 82nd record. run: 6400858 subRun: 1 event: 33482 at 05-Sep-2025 02:05:27 CEST
Begin processing the 83rd record. run: 6400858 subRun: 1 event: 33483 at 05-Sep-2025 02:05:27 CEST
Begin processing the 84th record. run: 6400858 subRun: 1 event: 33484 at 05-Sep-2025 02:05:27 CEST
Begin processing the 85th record. run: 6400858 subRun: 1 event: 33485 at 05-Sep-2025 02:05:27 CEST
Begin processing the 86th record. run: 6400858 subRun: 1 event: 33486 at 05-Sep-2025 02:05:27 CEST
Begin processing the 87th record. run: 6400858 subRun: 1 event: 33487 at 05-Sep-2025 02:05:27 CEST
Begin processing the 88th record. run: 6400858 subRun: 1 event: 33488 at 05-Sep-2025 02:05:27 CEST
Begin processing the 89th record. run: 6400858 subRun: 1 event: 33489 at 05-Sep-2025 02:05:27 CEST
Begin processing the 90th record. run: 6400858 subRun: 1 event: 33490 at 05-Sep-2025 02:05:28 CEST
Begin processing the 91st record. run: 6400858 subRun: 1 event: 33491 at 05-Sep-2025 02:05:28 CEST
Begin processing the 92nd record. run: 6400858 subRun: 1 event: 33492 at 05-Sep-2025 02:05:28 CEST
Begin processing the 93rd record. run: 6400858 subRun: 1 event: 33493 at 05-Sep-2025 02:05:28 CEST
Begin processing the 94th record. run: 6400858 subRun: 1 event: 33494 at 05-Sep-2025 02:05:28 CEST
Begin processing the 95th record. run: 6400858 subRun: 1 event: 33495 at 05-Sep-2025 02:05:28 CEST
Begin processing the 96th record. run: 6400858 subRun: 1 event: 33496 at 05-Sep-2025 02:05:28 CEST
Begin processing the 97th record. run: 6400858 subRun: 1 event: 33497 at 05-Sep-2025 02:05:28 CEST
Begin processing the 98th record. run: 6400858 subRun: 1 event: 33498 at 05-Sep-2025 02:05:28 CEST
Begin processing the 99th record. run: 6400858 subRun: 1 event: 33499 at 05-Sep-2025 02:05:28 CEST
Begin processing the 100th record. run: 6400858 subRun: 1 event: 33500 at 05-Sep-2025 02:05:37 CEST
05-Sep-2025 02:05:37 CEST  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/65/c2/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400858_334_20231202T080228Z_gen_g4_detsim_hitreco__20240507T210024Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0267573     0.280671       8.22156      0.0476243      1.04317        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000533049   0.000894773   0.00218021    0.000876893   0.000261356      100    
prod:pandorapid:Chi2ParticleID                0.000981289   0.00381889     0.0283159    0.00217941    0.00492609       100    
prod:energyreconue:EnergyReco                 0.00482874     0.0252419     0.451519     0.00969881     0.0611741       100    
prod:energyreconumu:EnergyReco                0.00168186     0.151319       7.54232     0.00679069     0.836902        100    
prod:energyreconc:EnergyReco                  0.00354155     0.0232569     0.387659      0.0124499     0.0513961       100    
[art]:TriggerResults:TriggerResultInserter    1.3722e-05    1.64088e-05   6.3537e-05    1.56705e-05   5.00454e-06      100    
end_path:ana:PIDASelectionAna                  0.0042685     0.075774       1.32128      0.017016      0.206625        100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5588.72 MB
  Peak resident set size usage (VmHWM): 1194.82 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 19913 Sep  5 02:05 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400858_334_20231202T080228Z_gen_g4_detsim_hitreco__20240507T210024Z_reco2_pida_2025-09-05T_000442Z.root
-rw-r--r--. 1 dune012 dune 14308 Sep  5 02:05 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400858_334_20231202T080228Z_gen_g4_detsim_hitreco__20240507T210024Z_reco2_reco_2025-09-05T_000442Z.log
-rw-r--r--. 1 dune012 dune 12032 Sep  5 02:05 jobscript.log
-rw-r--r--. 1 dune012 dune   216 Sep  5 02:05 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   137 Sep  5 02:04 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  5 02:04 debugprod.log