Jobsub ID 40523.61@dunegpschedd01.fnal.gov

Jobsub ID	40523.61@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_juk
Last heartbeat	2025-09-04 23:43:34
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:24
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_74517585_862_20231204T073316Z_gen_g4_detsim_hitreco__20240509T211941Z_reco2.root
Jobscript	Exit code	0
	Real time	0m (52s)
	CPU time	0m (40s = 76%)
	Max RSS bytes	1209307136 (1153 MiB)
Outputting started	2025-09-04 23:43:17
Output files
Finished	2025-09-04 23:43:34
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

. run: 74517585 subRun: 1 event: 86231 at 05-Sep-2025 01:42:56 CEST
Begin processing the 32nd record. run: 74517585 subRun: 1 event: 86232 at 05-Sep-2025 01:42:56 CEST
Begin processing the 33rd record. run: 74517585 subRun: 1 event: 86233 at 05-Sep-2025 01:42:56 CEST
Begin processing the 34th record. run: 74517585 subRun: 1 event: 86234 at 05-Sep-2025 01:42:57 CEST
Begin processing the 35th record. run: 74517585 subRun: 1 event: 86235 at 05-Sep-2025 01:42:57 CEST
Begin processing the 36th record. run: 74517585 subRun: 1 event: 86236 at 05-Sep-2025 01:42:58 CEST
Begin processing the 37th record. run: 74517585 subRun: 1 event: 86237 at 05-Sep-2025 01:42:58 CEST
Begin processing the 38th record. run: 74517585 subRun: 1 event: 86238 at 05-Sep-2025 01:42:58 CEST
Begin processing the 39th record. run: 74517585 subRun: 1 event: 86239 at 05-Sep-2025 01:42:58 CEST
Begin processing the 40th record. run: 74517585 subRun: 1 event: 86240 at 05-Sep-2025 01:42:58 CEST
Begin processing the 41st record. run: 74517585 subRun: 1 event: 86241 at 05-Sep-2025 01:42:58 CEST
Begin processing the 42nd record. run: 74517585 subRun: 1 event: 86242 at 05-Sep-2025 01:42:58 CEST
Begin processing the 43rd record. run: 74517585 subRun: 1 event: 86243 at 05-Sep-2025 01:42:58 CEST
Begin processing the 44th record. run: 74517585 subRun: 1 event: 86244 at 05-Sep-2025 01:42:59 CEST
Begin processing the 45th record. run: 74517585 subRun: 1 event: 86245 at 05-Sep-2025 01:42:59 CEST
Begin processing the 46th record. run: 74517585 subRun: 1 event: 86246 at 05-Sep-2025 01:42:59 CEST
Begin processing the 47th record. run: 74517585 subRun: 1 event: 86247 at 05-Sep-2025 01:43:01 CEST
Begin processing the 48th record. run: 74517585 subRun: 1 event: 86248 at 05-Sep-2025 01:43:01 CEST
Begin processing the 49th record. run: 74517585 subRun: 1 event: 86249 at 05-Sep-2025 01:43:01 CEST
Begin processing the 50th record. run: 74517585 subRun: 1 event: 86250 at 05-Sep-2025 01:43:01 CEST
Begin processing the 51st record. run: 74517585 subRun: 1 event: 86251 at 05-Sep-2025 01:43:01 CEST
Begin processing the 52nd record. run: 74517585 subRun: 1 event: 86252 at 05-Sep-2025 01:43:02 CEST
Begin processing the 53rd record. run: 74517585 subRun: 1 event: 86253 at 05-Sep-2025 01:43:05 CEST
Begin processing the 54th record. run: 74517585 subRun: 1 event: 86254 at 05-Sep-2025 01:43:05 CEST
Begin processing the 55th record. run: 74517585 subRun: 1 event: 86255 at 05-Sep-2025 01:43:05 CEST
Begin processing the 56th record. run: 74517585 subRun: 1 event: 86256 at 05-Sep-2025 01:43:05 CEST
Begin processing the 57th record. run: 74517585 subRun: 1 event: 86257 at 05-Sep-2025 01:43:06 CEST
Begin processing the 58th record. run: 74517585 subRun: 1 event: 86258 at 05-Sep-2025 01:43:06 CEST
Begin processing the 59th record. run: 74517585 subRun: 1 event: 86259 at 05-Sep-2025 01:43:10 CEST
Begin processing the 60th record. run: 74517585 subRun: 1 event: 86260 at 05-Sep-2025 01:43:10 CEST
Begin processing the 61st record. run: 74517585 subRun: 1 event: 86261 at 05-Sep-2025 01:43:10 CEST
Begin processing the 62nd record. run: 74517585 subRun: 1 event: 86262 at 05-Sep-2025 01:43:10 CEST
Begin processing the 63rd record. run: 74517585 subRun: 1 event: 86263 at 05-Sep-2025 01:43:10 CEST
Begin processing the 64th record. run: 74517585 subRun: 1 event: 86264 at 05-Sep-2025 01:43:10 CEST
Begin processing the 65th record. run: 74517585 subRun: 1 event: 86265 at 05-Sep-2025 01:43:10 CEST
Begin processing the 66th record. run: 74517585 subRun: 1 event: 86266 at 05-Sep-2025 01:43:10 CEST
Begin processing the 67th record. run: 74517585 subRun: 1 event: 86267 at 05-Sep-2025 01:43:10 CEST
Begin processing the 68th record. run: 74517585 subRun: 1 event: 86268 at 05-Sep-2025 01:43:11 CEST
Begin processing the 69th record. run: 74517585 subRun: 1 event: 86269 at 05-Sep-2025 01:43:11 CEST
Begin processing the 70th record. run: 74517585 subRun: 1 event: 86270 at 05-Sep-2025 01:43:11 CEST
Begin processing the 71st record. run: 74517585 subRun: 1 event: 86271 at 05-Sep-2025 01:43:11 CEST
Begin processing the 72nd record. run: 74517585 subRun: 1 event: 86272 at 05-Sep-2025 01:43:11 CEST
Begin processing the 73rd record. run: 74517585 subRun: 1 event: 86273 at 05-Sep-2025 01:43:11 CEST
Begin processing the 74th record. run: 74517585 subRun: 1 event: 86274 at 05-Sep-2025 01:43:11 CEST
Begin processing the 75th record. run: 74517585 subRun: 1 event: 86275 at 05-Sep-2025 01:43:11 CEST
Begin processing the 76th record. run: 74517585 subRun: 1 event: 86276 at 05-Sep-2025 01:43:12 CEST
Begin processing the 77th record. run: 74517585 subRun: 1 event: 86277 at 05-Sep-2025 01:43:12 CEST
Begin processing the 78th record. run: 74517585 subRun: 1 event: 86278 at 05-Sep-2025 01:43:12 CEST
Begin processing the 79th record. run: 74517585 subRun: 1 event: 86279 at 05-Sep-2025 01:43:12 CEST
Begin processing the 80th record. run: 74517585 subRun: 1 event: 86280 at 05-Sep-2025 01:43:12 CEST
Begin processing the 81st record. run: 74517585 subRun: 1 event: 86281 at 05-Sep-2025 01:43:12 CEST
Begin processing the 82nd record. run: 74517585 subRun: 1 event: 86282 at 05-Sep-2025 01:43:13 CEST
Begin processing the 83rd record. run: 74517585 subRun: 1 event: 86283 at 05-Sep-2025 01:43:13 CEST
Begin processing the 84th record. run: 74517585 subRun: 1 event: 86284 at 05-Sep-2025 01:43:13 CEST
Begin processing the 85th record. run: 74517585 subRun: 1 event: 86285 at 05-Sep-2025 01:43:14 CEST
Begin processing the 86th record. run: 74517585 subRun: 1 event: 86286 at 05-Sep-2025 01:43:14 CEST
Begin processing the 87th record. run: 74517585 subRun: 1 event: 86287 at 05-Sep-2025 01:43:14 CEST
Begin processing the 88th record. run: 74517585 subRun: 1 event: 86288 at 05-Sep-2025 01:43:14 CEST
Begin processing the 89th record. run: 74517585 subRun: 1 event: 86289 at 05-Sep-2025 01:43:14 CEST
Begin processing the 90th record. run: 74517585 subRun: 1 event: 86290 at 05-Sep-2025 01:43:14 CEST
Begin processing the 91st record. run: 74517585 subRun: 1 event: 86291 at 05-Sep-2025 01:43:15 CEST
Begin processing the 92nd record. run: 74517585 subRun: 1 event: 86292 at 05-Sep-2025 01:43:15 CEST
Begin processing the 93rd record. run: 74517585 subRun: 1 event: 86293 at 05-Sep-2025 01:43:15 CEST
Begin processing the 94th record. run: 74517585 subRun: 1 event: 86294 at 05-Sep-2025 01:43:15 CEST
Begin processing the 95th record. run: 74517585 subRun: 1 event: 86295 at 05-Sep-2025 01:43:15 CEST
Begin processing the 96th record. run: 74517585 subRun: 1 event: 86296 at 05-Sep-2025 01:43:16 CEST
Begin processing the 97th record. run: 74517585 subRun: 1 event: 86297 at 05-Sep-2025 01:43:16 CEST
Begin processing the 98th record. run: 74517585 subRun: 1 event: 86298 at 05-Sep-2025 01:43:16 CEST
Begin processing the 99th record. run: 74517585 subRun: 1 event: 86299 at 05-Sep-2025 01:43:16 CEST
Begin processing the 100th record. run: 74517585 subRun: 1 event: 86300 at 05-Sep-2025 01:43:17 CEST
05-Sep-2025 01:43:17 CEST  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/37/91/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_74517585_862_20231204T073316Z_gen_g4_detsim_hitreco__20240509T211941Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0268906     0.198971       2.16929       0.10304      0.319965        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000619131    0.0113034     0.0315387     0.0137217    0.00784107       100    
prod:pandorapid:Chi2ParticleID                0.00102687     0.0209036     0.0549377     0.0204465     0.0153155       100    
prod:energyreconue:EnergyReco                 0.00520084     0.0297923     0.347423      0.0130847     0.0489591       100    
prod:energyreconumu:EnergyReco                0.00164211     0.0386212     0.454623      0.0112199     0.0847731       100    
prod:energyreconc:EnergyReco                   0.0035558     0.0248421     0.262509      0.0142919     0.038056        100    
[art]:TriggerResults:TriggerResultInserter     1.324e-05    1.57658e-05    7.698e-05    1.48995e-05   6.43318e-06      100    
end_path:ana:PIDASelectionAna                 0.00423297     0.0731373      1.16939      0.0273617     0.160272        100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5596.8 MB
  Peak resident set size usage (VmHWM): 1209.31 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 20099 Sep  5 01:43 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_74517585_862_20231204T073316Z_gen_g4_detsim_hitreco__20240509T211941Z_reco2_pida_2025-09-04T_234228Z.root
-rw-r--r--. 1 dune012 dune 14410 Sep  5 01:43 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_74517585_862_20231204T073316Z_gen_g4_detsim_hitreco__20240509T211941Z_reco2_reco_2025-09-04T_234228Z.log
-rw-r--r--. 1 dune012 dune 12110 Sep  5 01:43 jobscript.log
-rw-r--r--. 1 dune012 dune   217 Sep  5 01:43 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune   138 Sep  5 01:42 all-input-dids.txt
-rw-r--r--. 1 dune012 dune     0 Sep  5 01:42 debugprod.log