Jobsub ID 33258.0@dunegpschedd02.fnal.gov

Jobsub ID	33258.0@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-04 07:09:54
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_juk
Last heartbeat	2025-09-04 07:11:19
From worker node	Hostname	wn-choc-021.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 07:10:18
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50584512_976_20231204T075805Z_gen_g4_detsim_hitreco__20240509T220429Z_reco2.root
Jobscript	Exit code	0
	Real time	0m (43s)
	CPU time	0m (39s = 90%)
	Max RSS bytes	1153060864 (1099 MiB)
Outputting started	2025-09-04 07:11:02
Output files
Finished	2025-09-04 07:11:19
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

run: 50584512 subRun: 1 event: 97631 at 04-Sep-2025 09:10:42 CEST
Begin processing the 32nd record. run: 50584512 subRun: 1 event: 97632 at 04-Sep-2025 09:10:42 CEST
Begin processing the 33rd record. run: 50584512 subRun: 1 event: 97633 at 04-Sep-2025 09:10:43 CEST
Begin processing the 34th record. run: 50584512 subRun: 1 event: 97634 at 04-Sep-2025 09:10:43 CEST
Begin processing the 35th record. run: 50584512 subRun: 1 event: 97635 at 04-Sep-2025 09:10:43 CEST
Begin processing the 36th record. run: 50584512 subRun: 1 event: 97636 at 04-Sep-2025 09:10:43 CEST
Begin processing the 37th record. run: 50584512 subRun: 1 event: 97637 at 04-Sep-2025 09:10:43 CEST
Begin processing the 38th record. run: 50584512 subRun: 1 event: 97638 at 04-Sep-2025 09:10:43 CEST
Begin processing the 39th record. run: 50584512 subRun: 1 event: 97639 at 04-Sep-2025 09:10:43 CEST
Begin processing the 40th record. run: 50584512 subRun: 1 event: 97640 at 04-Sep-2025 09:10:44 CEST
Begin processing the 41st record. run: 50584512 subRun: 1 event: 97641 at 04-Sep-2025 09:10:44 CEST
Begin processing the 42nd record. run: 50584512 subRun: 1 event: 97642 at 04-Sep-2025 09:10:44 CEST
Begin processing the 43rd record. run: 50584512 subRun: 1 event: 97643 at 04-Sep-2025 09:10:45 CEST
Begin processing the 44th record. run: 50584512 subRun: 1 event: 97644 at 04-Sep-2025 09:10:45 CEST
Begin processing the 45th record. run: 50584512 subRun: 1 event: 97645 at 04-Sep-2025 09:10:45 CEST
Begin processing the 46th record. run: 50584512 subRun: 1 event: 97646 at 04-Sep-2025 09:10:45 CEST
Begin processing the 47th record. run: 50584512 subRun: 1 event: 97647 at 04-Sep-2025 09:10:45 CEST
Begin processing the 48th record. run: 50584512 subRun: 1 event: 97648 at 04-Sep-2025 09:10:45 CEST
Begin processing the 49th record. run: 50584512 subRun: 1 event: 97649 at 04-Sep-2025 09:10:45 CEST
Begin processing the 50th record. run: 50584512 subRun: 1 event: 97650 at 04-Sep-2025 09:10:45 CEST
Begin processing the 51st record. run: 50584512 subRun: 1 event: 97651 at 04-Sep-2025 09:10:46 CEST
Begin processing the 52nd record. run: 50584512 subRun: 1 event: 97652 at 04-Sep-2025 09:10:46 CEST
Begin processing the 53rd record. run: 50584512 subRun: 1 event: 97653 at 04-Sep-2025 09:10:46 CEST
Begin processing the 54th record. run: 50584512 subRun: 1 event: 97654 at 04-Sep-2025 09:10:46 CEST
Begin processing the 55th record. run: 50584512 subRun: 1 event: 97655 at 04-Sep-2025 09:10:46 CEST
Begin processing the 56th record. run: 50584512 subRun: 1 event: 97656 at 04-Sep-2025 09:10:46 CEST
Begin processing the 57th record. run: 50584512 subRun: 1 event: 97657 at 04-Sep-2025 09:10:47 CEST
Begin processing the 58th record. run: 50584512 subRun: 1 event: 97658 at 04-Sep-2025 09:10:47 CEST
Begin processing the 59th record. run: 50584512 subRun: 1 event: 97659 at 04-Sep-2025 09:10:47 CEST
Begin processing the 60th record. run: 50584512 subRun: 1 event: 97660 at 04-Sep-2025 09:10:47 CEST
Begin processing the 61st record. run: 50584512 subRun: 1 event: 97661 at 04-Sep-2025 09:10:47 CEST
Begin processing the 62nd record. run: 50584512 subRun: 1 event: 97662 at 04-Sep-2025 09:10:47 CEST
Begin processing the 63rd record. run: 50584512 subRun: 1 event: 97663 at 04-Sep-2025 09:10:47 CEST
Begin processing the 64th record. run: 50584512 subRun: 1 event: 97664 at 04-Sep-2025 09:10:47 CEST
Begin processing the 65th record. run: 50584512 subRun: 1 event: 97665 at 04-Sep-2025 09:10:47 CEST
Begin processing the 66th record. run: 50584512 subRun: 1 event: 97666 at 04-Sep-2025 09:10:48 CEST
Begin processing the 67th record. run: 50584512 subRun: 1 event: 97667 at 04-Sep-2025 09:10:48 CEST
Begin processing the 68th record. run: 50584512 subRun: 1 event: 97668 at 04-Sep-2025 09:10:48 CEST
Begin processing the 69th record. run: 50584512 subRun: 1 event: 97669 at 04-Sep-2025 09:10:48 CEST
Begin processing the 70th record. run: 50584512 subRun: 1 event: 97670 at 04-Sep-2025 09:10:48 CEST
Begin processing the 71st record. run: 50584512 subRun: 1 event: 97671 at 04-Sep-2025 09:10:48 CEST
Begin processing the 72nd record. run: 50584512 subRun: 1 event: 97672 at 04-Sep-2025 09:10:48 CEST
Begin processing the 73rd record. run: 50584512 subRun: 1 event: 97673 at 04-Sep-2025 09:10:48 CEST
Begin processing the 74th record. run: 50584512 subRun: 1 event: 97674 at 04-Sep-2025 09:10:49 CEST
Begin processing the 75th record. run: 50584512 subRun: 1 event: 97675 at 04-Sep-2025 09:10:49 CEST
Begin processing the 76th record. run: 50584512 subRun: 1 event: 97676 at 04-Sep-2025 09:10:49 CEST
Begin processing the 77th record. run: 50584512 subRun: 1 event: 97677 at 04-Sep-2025 09:10:49 CEST
Begin processing the 78th record. run: 50584512 subRun: 1 event: 97678 at 04-Sep-2025 09:10:49 CEST
Begin processing the 79th record. run: 50584512 subRun: 1 event: 97679 at 04-Sep-2025 09:10:49 CEST
Begin processing the 80th record. run: 50584512 subRun: 1 event: 97680 at 04-Sep-2025 09:10:50 CEST
Begin processing the 81st record. run: 50584512 subRun: 1 event: 97681 at 04-Sep-2025 09:10:50 CEST
Begin processing the 82nd record. run: 50584512 subRun: 1 event: 97682 at 04-Sep-2025 09:10:50 CEST
Begin processing the 83rd record. run: 50584512 subRun: 1 event: 97683 at 04-Sep-2025 09:10:50 CEST
Begin processing the 84th record. run: 50584512 subRun: 1 event: 97684 at 04-Sep-2025 09:10:50 CEST
Begin processing the 85th record. run: 50584512 subRun: 1 event: 97685 at 04-Sep-2025 09:10:50 CEST
Begin processing the 86th record. run: 50584512 subRun: 1 event: 97686 at 04-Sep-2025 09:10:52 CEST
Begin processing the 87th record. run: 50584512 subRun: 1 event: 97687 at 04-Sep-2025 09:10:52 CEST
Begin processing the 88th record. run: 50584512 subRun: 1 event: 97688 at 04-Sep-2025 09:10:55 CEST
Begin processing the 89th record. run: 50584512 subRun: 1 event: 97689 at 04-Sep-2025 09:10:55 CEST
Begin processing the 90th record. run: 50584512 subRun: 1 event: 97690 at 04-Sep-2025 09:10:55 CEST
Begin processing the 91st record. run: 50584512 subRun: 1 event: 97691 at 04-Sep-2025 09:10:55 CEST
Begin processing the 92nd record. run: 50584512 subRun: 1 event: 97692 at 04-Sep-2025 09:10:57 CEST
Begin processing the 93rd record. run: 50584512 subRun: 1 event: 97693 at 04-Sep-2025 09:10:57 CEST
Begin processing the 94th record. run: 50584512 subRun: 1 event: 97694 at 04-Sep-2025 09:10:57 CEST
Begin processing the 95th record. run: 50584512 subRun: 1 event: 97695 at 04-Sep-2025 09:10:57 CEST
Begin processing the 96th record. run: 50584512 subRun: 1 event: 97696 at 04-Sep-2025 09:10:58 CEST
Begin processing the 97th record. run: 50584512 subRun: 1 event: 97697 at 04-Sep-2025 09:11:01 CEST
Begin processing the 98th record. run: 50584512 subRun: 1 event: 97698 at 04-Sep-2025 09:11:01 CEST
Begin processing the 99th record. run: 50584512 subRun: 1 event: 97699 at 04-Sep-2025 09:11:01 CEST
Begin processing the 100th record. run: 50584512 subRun: 1 event: 97700 at 04-Sep-2025 09:11:01 CEST
04-Sep-2025 09:11:01 CEST  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/b3/f2/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50584512_976_20231204T075805Z_gen_g4_detsim_hitreco__20240509T220429Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0261289     0.145045       2.35657      0.0473531     0.336908        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000532694   0.000821462   0.00146584    0.000786669   0.000214956      100    
prod:pandorapid:Chi2ParticleID                0.00101634    0.00314281     0.0204164    0.00216883    0.00316363       100    
prod:energyreconue:EnergyReco                 0.00480591     0.0206078     0.318688     0.00888132     0.0418936       100    
prod:energyreconumu:EnergyReco                0.00163224     0.0429376      1.66989     0.00839343     0.175446        100    
prod:energyreconc:EnergyReco                  0.00349992     0.0199383     0.299757      0.0127142     0.0360486       100    
[art]:TriggerResults:TriggerResultInserter     1.369e-05    1.59487e-05   6.0692e-05    1.5129e-05    5.16593e-06      100    
end_path:ana:PIDASelectionAna                 0.00404817     0.0572622     0.935796      0.0187043     0.133146        100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5542.76 MB
  Peak resident set size usage (VmHWM): 1153.06 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 20202 Sep  4 09:11 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50584512_976_20231204T075805Z_gen_g4_detsim_hitreco__20240509T220429Z_reco2_pida_2025-09-04T_071022Z.root
-rw-r--r--. 1 dune012 dune 14411 Sep  4 09:11 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50584512_976_20231204T075805Z_gen_g4_detsim_hitreco__20240509T220429Z_reco2_reco_2025-09-04T_071022Z.log
-rw-r--r--. 1 dune012 dune 12111 Sep  4 09:11 jobscript.log
-rw-r--r--. 1 dune012 dune   217 Sep  4 09:11 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   138 Sep  4 09:10 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  4 09:10 debugprod.log