Jobsub ID 40523.83@dunegpschedd01.fnal.gov

Jobsub ID	40523.83@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_dissel
Last heartbeat	2025-09-04 23:43:43
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:29
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6453326_71_20231206T230218Z_gen_g4_detsim_hitreco__20240510T032121Z_reco2.root
Jobscript	Exit code	0
	Real time	0m (57s)
	CPU time	0m (44s = 77%)
	Max RSS bytes	1352859648 (1290 MiB)
Outputting started	2025-09-04 23:43:27
Output files
Finished	2025-09-04 23:43:43
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

01:43:00 CEST
Begin processing the 30th record. run: 6453326 subRun: 1 event: 7130 at 05-Sep-2025 01:43:00 CEST
Begin processing the 31st record. run: 6453326 subRun: 1 event: 7131 at 05-Sep-2025 01:43:00 CEST
Begin processing the 32nd record. run: 6453326 subRun: 1 event: 7132 at 05-Sep-2025 01:43:00 CEST
Begin processing the 33rd record. run: 6453326 subRun: 1 event: 7133 at 05-Sep-2025 01:43:01 CEST
Begin processing the 34th record. run: 6453326 subRun: 1 event: 7134 at 05-Sep-2025 01:43:01 CEST
Begin processing the 35th record. run: 6453326 subRun: 1 event: 7135 at 05-Sep-2025 01:43:01 CEST
Begin processing the 36th record. run: 6453326 subRun: 1 event: 7136 at 05-Sep-2025 01:43:02 CEST
Begin processing the 37th record. run: 6453326 subRun: 1 event: 7137 at 05-Sep-2025 01:43:02 CEST
Begin processing the 38th record. run: 6453326 subRun: 1 event: 7138 at 05-Sep-2025 01:43:02 CEST
Begin processing the 39th record. run: 6453326 subRun: 1 event: 7139 at 05-Sep-2025 01:43:03 CEST
Begin processing the 40th record. run: 6453326 subRun: 1 event: 7140 at 05-Sep-2025 01:43:03 CEST
Begin processing the 41st record. run: 6453326 subRun: 1 event: 7141 at 05-Sep-2025 01:43:03 CEST
Begin processing the 42nd record. run: 6453326 subRun: 1 event: 7142 at 05-Sep-2025 01:43:04 CEST
Begin processing the 43rd record. run: 6453326 subRun: 1 event: 7143 at 05-Sep-2025 01:43:04 CEST
Begin processing the 44th record. run: 6453326 subRun: 1 event: 7144 at 05-Sep-2025 01:43:04 CEST
Begin processing the 45th record. run: 6453326 subRun: 1 event: 7145 at 05-Sep-2025 01:43:04 CEST
Begin processing the 46th record. run: 6453326 subRun: 1 event: 7146 at 05-Sep-2025 01:43:05 CEST
Begin processing the 47th record. run: 6453326 subRun: 1 event: 7147 at 05-Sep-2025 01:43:05 CEST
Begin processing the 48th record. run: 6453326 subRun: 1 event: 7148 at 05-Sep-2025 01:43:05 CEST
Begin processing the 49th record. run: 6453326 subRun: 1 event: 7149 at 05-Sep-2025 01:43:05 CEST
Begin processing the 50th record. run: 6453326 subRun: 1 event: 7150 at 05-Sep-2025 01:43:05 CEST
Begin processing the 51st record. run: 6453326 subRun: 1 event: 7151 at 05-Sep-2025 01:43:06 CEST
Begin processing the 52nd record. run: 6453326 subRun: 1 event: 7152 at 05-Sep-2025 01:43:06 CEST
Begin processing the 53rd record. run: 6453326 subRun: 1 event: 7153 at 05-Sep-2025 01:43:06 CEST
Begin processing the 54th record. run: 6453326 subRun: 1 event: 7154 at 05-Sep-2025 01:43:07 CEST
Begin processing the 55th record. run: 6453326 subRun: 1 event: 7155 at 05-Sep-2025 01:43:07 CEST
Begin processing the 56th record. run: 6453326 subRun: 1 event: 7156 at 05-Sep-2025 01:43:07 CEST
Begin processing the 57th record. run: 6453326 subRun: 1 event: 7157 at 05-Sep-2025 01:43:07 CEST
Begin processing the 58th record. run: 6453326 subRun: 1 event: 7158 at 05-Sep-2025 01:43:07 CEST
Begin processing the 59th record. run: 6453326 subRun: 1 event: 7159 at 05-Sep-2025 01:43:07 CEST
Begin processing the 60th record. run: 6453326 subRun: 1 event: 7160 at 05-Sep-2025 01:43:11 CEST
Begin processing the 61st record. run: 6453326 subRun: 1 event: 7161 at 05-Sep-2025 01:43:11 CEST
Begin processing the 62nd record. run: 6453326 subRun: 1 event: 7162 at 05-Sep-2025 01:43:11 CEST
Begin processing the 63rd record. run: 6453326 subRun: 1 event: 7163 at 05-Sep-2025 01:43:12 CEST
Begin processing the 64th record. run: 6453326 subRun: 1 event: 7164 at 05-Sep-2025 01:43:12 CEST
Begin processing the 65th record. run: 6453326 subRun: 1 event: 7165 at 05-Sep-2025 01:43:12 CEST
Begin processing the 66th record. run: 6453326 subRun: 1 event: 7166 at 05-Sep-2025 01:43:12 CEST
Begin processing the 67th record. run: 6453326 subRun: 1 event: 7167 at 05-Sep-2025 01:43:12 CEST
Begin processing the 68th record. run: 6453326 subRun: 1 event: 7168 at 05-Sep-2025 01:43:12 CEST
Begin processing the 69th record. run: 6453326 subRun: 1 event: 7169 at 05-Sep-2025 01:43:12 CEST
Begin processing the 70th record. run: 6453326 subRun: 1 event: 7170 at 05-Sep-2025 01:43:13 CEST
Begin processing the 71st record. run: 6453326 subRun: 1 event: 7171 at 05-Sep-2025 01:43:13 CEST
Begin processing the 72nd record. run: 6453326 subRun: 1 event: 7172 at 05-Sep-2025 01:43:13 CEST
Begin processing the 73rd record. run: 6453326 subRun: 1 event: 7173 at 05-Sep-2025 01:43:14 CEST
Begin processing the 74th record. run: 6453326 subRun: 1 event: 7174 at 05-Sep-2025 01:43:14 CEST
Begin processing the 75th record. run: 6453326 subRun: 1 event: 7175 at 05-Sep-2025 01:43:15 CEST
Begin processing the 76th record. run: 6453326 subRun: 1 event: 7176 at 05-Sep-2025 01:43:15 CEST
Begin processing the 77th record. run: 6453326 subRun: 1 event: 7177 at 05-Sep-2025 01:43:15 CEST
Begin processing the 78th record. run: 6453326 subRun: 1 event: 7178 at 05-Sep-2025 01:43:16 CEST
Begin processing the 79th record. run: 6453326 subRun: 1 event: 7179 at 05-Sep-2025 01:43:16 CEST
Begin processing the 80th record. run: 6453326 subRun: 1 event: 7180 at 05-Sep-2025 01:43:16 CEST
Begin processing the 81st record. run: 6453326 subRun: 1 event: 7181 at 05-Sep-2025 01:43:16 CEST
Begin processing the 82nd record. run: 6453326 subRun: 1 event: 7182 at 05-Sep-2025 01:43:16 CEST
Begin processing the 83rd record. run: 6453326 subRun: 1 event: 7183 at 05-Sep-2025 01:43:16 CEST
Begin processing the 84th record. run: 6453326 subRun: 1 event: 7184 at 05-Sep-2025 01:43:17 CEST
Begin processing the 85th record. run: 6453326 subRun: 1 event: 7185 at 05-Sep-2025 01:43:17 CEST
Begin processing the 86th record. run: 6453326 subRun: 1 event: 7186 at 05-Sep-2025 01:43:17 CEST
Begin processing the 87th record. run: 6453326 subRun: 1 event: 7187 at 05-Sep-2025 01:43:17 CEST
Begin processing the 88th record. run: 6453326 subRun: 1 event: 7188 at 05-Sep-2025 01:43:17 CEST
Begin processing the 89th record. run: 6453326 subRun: 1 event: 7189 at 05-Sep-2025 01:43:17 CEST
Begin processing the 90th record. run: 6453326 subRun: 1 event: 7190 at 05-Sep-2025 01:43:18 CEST
Begin processing the 91st record. run: 6453326 subRun: 1 event: 7191 at 05-Sep-2025 01:43:18 CEST
Begin processing the 92nd record. run: 6453326 subRun: 1 event: 7192 at 05-Sep-2025 01:43:18 CEST
Begin processing the 93rd record. run: 6453326 subRun: 1 event: 7193 at 05-Sep-2025 01:43:18 CEST
Begin processing the 94th record. run: 6453326 subRun: 1 event: 7194 at 05-Sep-2025 01:43:19 CEST
Begin processing the 95th record. run: 6453326 subRun: 1 event: 7195 at 05-Sep-2025 01:43:19 CEST
Begin processing the 96th record. run: 6453326 subRun: 1 event: 7196 at 05-Sep-2025 01:43:19 CEST
Begin processing the 97th record. run: 6453326 subRun: 1 event: 7197 at 05-Sep-2025 01:43:19 CEST
Begin processing the 98th record. run: 6453326 subRun: 1 event: 7198 at 05-Sep-2025 01:43:19 CEST
Begin processing the 99th record. run: 6453326 subRun: 1 event: 7199 at 05-Sep-2025 01:43:20 CEST
Begin processing the 100th record. run: 6453326 subRun: 1 event: 7200 at 05-Sep-2025 01:43:26 CEST
05-Sep-2025 01:43:26 CEST  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/54/a4/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6453326_71_20231206T230218Z_gen_g4_detsim_hitreco__20240510T032121Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.026296      0.240012       4.67166      0.103451      0.599234        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000711807    0.012939      0.0420588     0.0135619    0.00859171       100    
prod:pandorapid:Chi2ParticleID                  0.00101      0.0257233     0.115396      0.0246341     0.0187767       100    
prod:energyreconue:EnergyReco                 0.00502666     0.0352868     0.645228      0.0133177     0.0917787       100    
prod:energyreconumu:EnergyReco                0.00162914     0.045268       1.41597      0.0111384     0.166481        100    
prod:energyreconc:EnergyReco                   0.0034946     0.0264093     0.533809      0.0123131     0.0689334       100    
[art]:TriggerResults:TriggerResultInserter    1.3043e-05    1.56992e-05   0.000100439   1.45285e-05   8.65795e-06      100    
end_path:ana:PIDASelectionAna                 0.00377182     0.0940185      1.99573      0.0272471     0.269825        100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5755.22 MB
  Peak resident set size usage (VmHWM): 1352.86 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 20141 Sep  5 01:43 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6453326_71_20231206T230218Z_gen_g4_detsim_hitreco__20240510T032121Z_reco2_pida_2025-09-04T_234233Z.root
-rw-r--r--. 1 dune012 dune 14205 Sep  5 01:43 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6453326_71_20231206T230218Z_gen_g4_detsim_hitreco__20240510T032121Z_reco2_reco_2025-09-04T_234233Z.log
-rw-r--r--. 1 dune012 dune 11953 Sep  5 01:43 jobscript.log
-rw-r--r--. 1 dune012 dune   215 Sep  5 01:43 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   136 Sep  5 01:42 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  5 01:42 debugprod.log