Jobsub ID 39948.68@dunegpschedd01.fnal.gov

Jobsub ID	39948.68@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 03:47:44
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_juk
Last heartbeat	2025-09-04 03:53:16
From worker node	Hostname	wn-pep-005.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-04 03:50:26
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50568178_885_20231202T172818Z_gen_g4_detsim_hitreco__20240507T210415Z_reco2.root
Jobscript	Exit code	0
	Real time	2m (135s)
	CPU time	0m (35s = 25%)
	Max RSS bytes	1592430592 (1518 MiB)
Outputting started	2025-09-04 03:52:42
Output files
Finished	2025-09-04 03:53:16
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

in processing the 31st record. run: 50568178 subRun: 1 event: 88531 at 04-Sep-2025 05:51:16 CEST
Begin processing the 32nd record. run: 50568178 subRun: 1 event: 88532 at 04-Sep-2025 05:51:17 CEST
Begin processing the 33rd record. run: 50568178 subRun: 1 event: 88533 at 04-Sep-2025 05:51:20 CEST
Begin processing the 34th record. run: 50568178 subRun: 1 event: 88534 at 04-Sep-2025 05:51:20 CEST
Begin processing the 35th record. run: 50568178 subRun: 1 event: 88535 at 04-Sep-2025 05:51:21 CEST
Begin processing the 36th record. run: 50568178 subRun: 1 event: 88536 at 04-Sep-2025 05:51:22 CEST
Begin processing the 37th record. run: 50568178 subRun: 1 event: 88537 at 04-Sep-2025 05:51:23 CEST
Begin processing the 38th record. run: 50568178 subRun: 1 event: 88538 at 04-Sep-2025 05:51:24 CEST
Begin processing the 39th record. run: 50568178 subRun: 1 event: 88539 at 04-Sep-2025 05:51:26 CEST
Begin processing the 40th record. run: 50568178 subRun: 1 event: 88540 at 04-Sep-2025 05:51:27 CEST
Begin processing the 41st record. run: 50568178 subRun: 1 event: 88541 at 04-Sep-2025 05:51:28 CEST
Begin processing the 42nd record. run: 50568178 subRun: 1 event: 88542 at 04-Sep-2025 05:51:29 CEST
Begin processing the 43rd record. run: 50568178 subRun: 1 event: 88543 at 04-Sep-2025 05:51:30 CEST
Begin processing the 44th record. run: 50568178 subRun: 1 event: 88544 at 04-Sep-2025 05:51:31 CEST
Begin processing the 45th record. run: 50568178 subRun: 1 event: 88545 at 04-Sep-2025 05:51:32 CEST
Begin processing the 46th record. run: 50568178 subRun: 1 event: 88546 at 04-Sep-2025 05:51:40 CEST
Begin processing the 47th record. run: 50568178 subRun: 1 event: 88547 at 04-Sep-2025 05:51:41 CEST
Begin processing the 48th record. run: 50568178 subRun: 1 event: 88548 at 04-Sep-2025 05:51:43 CEST
Begin processing the 49th record. run: 50568178 subRun: 1 event: 88549 at 04-Sep-2025 05:51:44 CEST
Begin processing the 50th record. run: 50568178 subRun: 1 event: 88550 at 04-Sep-2025 05:51:45 CEST
Begin processing the 51st record. run: 50568178 subRun: 1 event: 88551 at 04-Sep-2025 05:51:47 CEST
Begin processing the 52nd record. run: 50568178 subRun: 1 event: 88552 at 04-Sep-2025 05:51:48 CEST
Begin processing the 53rd record. run: 50568178 subRun: 1 event: 88553 at 04-Sep-2025 05:51:49 CEST
Begin processing the 54th record. run: 50568178 subRun: 1 event: 88554 at 04-Sep-2025 05:51:50 CEST
Begin processing the 55th record. run: 50568178 subRun: 1 event: 88555 at 04-Sep-2025 05:51:52 CEST
Begin processing the 56th record. run: 50568178 subRun: 1 event: 88556 at 04-Sep-2025 05:51:53 CEST
Begin processing the 57th record. run: 50568178 subRun: 1 event: 88557 at 04-Sep-2025 05:51:53 CEST
Begin processing the 58th record. run: 50568178 subRun: 1 event: 88558 at 04-Sep-2025 05:51:54 CEST
Begin processing the 59th record. run: 50568178 subRun: 1 event: 88559 at 04-Sep-2025 05:51:55 CEST
Begin processing the 60th record. run: 50568178 subRun: 1 event: 88560 at 04-Sep-2025 05:51:56 CEST
Begin processing the 61st record. run: 50568178 subRun: 1 event: 88561 at 04-Sep-2025 05:51:57 CEST
Begin processing the 62nd record. run: 50568178 subRun: 1 event: 88562 at 04-Sep-2025 05:51:58 CEST
Begin processing the 63rd record. run: 50568178 subRun: 1 event: 88563 at 04-Sep-2025 05:51:59 CEST
Begin processing the 64th record. run: 50568178 subRun: 1 event: 88564 at 04-Sep-2025 05:52:00 CEST
Begin processing the 65th record. run: 50568178 subRun: 1 event: 88565 at 04-Sep-2025 05:52:01 CEST
Begin processing the 66th record. run: 50568178 subRun: 1 event: 88566 at 04-Sep-2025 05:52:02 CEST
Begin processing the 67th record. run: 50568178 subRun: 1 event: 88567 at 04-Sep-2025 05:52:04 CEST
Begin processing the 68th record. run: 50568178 subRun: 1 event: 88568 at 04-Sep-2025 05:52:04 CEST
Begin processing the 69th record. run: 50568178 subRun: 1 event: 88569 at 04-Sep-2025 05:52:06 CEST
Begin processing the 70th record. run: 50568178 subRun: 1 event: 88570 at 04-Sep-2025 05:52:07 CEST
Begin processing the 71st record. run: 50568178 subRun: 1 event: 88571 at 04-Sep-2025 05:52:08 CEST
Begin processing the 72nd record. run: 50568178 subRun: 1 event: 88572 at 04-Sep-2025 05:52:09 CEST
Begin processing the 73rd record. run: 50568178 subRun: 1 event: 88573 at 04-Sep-2025 05:52:10 CEST
Begin processing the 74th record. run: 50568178 subRun: 1 event: 88574 at 04-Sep-2025 05:52:10 CEST
Begin processing the 75th record. run: 50568178 subRun: 1 event: 88575 at 04-Sep-2025 05:52:11 CEST
Begin processing the 76th record. run: 50568178 subRun: 1 event: 88576 at 04-Sep-2025 05:52:13 CEST
Begin processing the 77th record. run: 50568178 subRun: 1 event: 88577 at 04-Sep-2025 05:52:15 CEST
Begin processing the 78th record. run: 50568178 subRun: 1 event: 88578 at 04-Sep-2025 05:52:16 CEST
Begin processing the 79th record. run: 50568178 subRun: 1 event: 88579 at 04-Sep-2025 05:52:17 CEST
Begin processing the 80th record. run: 50568178 subRun: 1 event: 88580 at 04-Sep-2025 05:52:19 CEST
Begin processing the 81st record. run: 50568178 subRun: 1 event: 88581 at 04-Sep-2025 05:52:20 CEST
Begin processing the 82nd record. run: 50568178 subRun: 1 event: 88582 at 04-Sep-2025 05:52:21 CEST
Begin processing the 83rd record. run: 50568178 subRun: 1 event: 88583 at 04-Sep-2025 05:52:22 CEST
Begin processing the 84th record. run: 50568178 subRun: 1 event: 88584 at 04-Sep-2025 05:52:23 CEST
Begin processing the 85th record. run: 50568178 subRun: 1 event: 88585 at 04-Sep-2025 05:52:24 CEST
Begin processing the 86th record. run: 50568178 subRun: 1 event: 88586 at 04-Sep-2025 05:52:26 CEST
Begin processing the 87th record. run: 50568178 subRun: 1 event: 88587 at 04-Sep-2025 05:52:27 CEST
Begin processing the 88th record. run: 50568178 subRun: 1 event: 88588 at 04-Sep-2025 05:52:28 CEST
Begin processing the 89th record. run: 50568178 subRun: 1 event: 88589 at 04-Sep-2025 05:52:29 CEST
Begin processing the 90th record. run: 50568178 subRun: 1 event: 88590 at 04-Sep-2025 05:52:30 CEST
Begin processing the 91st record. run: 50568178 subRun: 1 event: 88591 at 04-Sep-2025 05:52:30 CEST
Begin processing the 92nd record. run: 50568178 subRun: 1 event: 88592 at 04-Sep-2025 05:52:31 CEST
Begin processing the 93rd record. run: 50568178 subRun: 1 event: 88593 at 04-Sep-2025 05:52:32 CEST
Begin processing the 94th record. run: 50568178 subRun: 1 event: 88594 at 04-Sep-2025 05:52:33 CEST
Begin processing the 95th record. run: 50568178 subRun: 1 event: 88595 at 04-Sep-2025 05:52:34 CEST
Begin processing the 96th record. run: 50568178 subRun: 1 event: 88596 at 04-Sep-2025 05:52:36 CEST
Begin processing the 97th record. run: 50568178 subRun: 1 event: 88597 at 04-Sep-2025 05:52:37 CEST
Begin processing the 98th record. run: 50568178 subRun: 1 event: 88598 at 04-Sep-2025 05:52:38 CEST
Begin processing the 99th record. run: 50568178 subRun: 1 event: 88599 at 04-Sep-2025 05:52:39 CEST
Begin processing the 100th record. run: 50568178 subRun: 1 event: 88600 at 04-Sep-2025 05:52:40 CEST
04-Sep-2025 05:52:41 CEST  Closed input file "root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/1e/f3/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50568178_885_20231202T172818Z_gen_g4_detsim_hitreco__20240507T210415Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.273598      0.947044       5.49098      0.905994      0.548202        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0144362     0.0269674     0.202177      0.0287032     0.0205228       100    
prod:pandorapid:Chi2ParticleID                 0.0843713     0.123026      0.166717      0.127698      0.020318        100    
prod:energyreconue:EnergyReco                  0.150153      0.317559      0.735274      0.303502      0.0886049       100    
prod:energyreconumu:EnergyReco                 0.001298      0.0811769      2.23205      0.0481059     0.224492        100    
prod:energyreconc:EnergyReco                  0.00276389     0.0283884     0.398594      0.0238379     0.0441115       100    
[art]:TriggerResults:TriggerResultInserter    1.0244e-05    1.23936e-05   6.2231e-05    1.1389e-05    5.65528e-06      100    
end_path:ana:PIDASelectionAna                  0.0170898     0.369596       1.92924      0.342851      0.228919        100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 8140.08 MB
  Peak resident set size usage (VmHWM): 1592.43 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 19770 Sep  4 05:52 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50568178_885_20231202T172818Z_gen_g4_detsim_hitreco__20240507T210415Z_reco2_pida_2025-09-04T_035030Z.root
-rw-r--r--. 1 dune012 dune 14321 Sep  4 05:52 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50568178_885_20231202T172818Z_gen_g4_detsim_hitreco__20240507T210415Z_reco2_reco_2025-09-04T_035030Z.log
-rw-r--r--. 1 dune012 dune 12051 Sep  4 05:52 jobscript.log
-rw-r--r--. 1 dune012 dune   187 Sep  4 05:52 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   138 Sep  4 05:50 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  4 05:50 debugprod.log