Jobsub ID 273498.135@dunegpschedd02.fnal.gov

Jobsub ID	273498.135@dunegpschedd02.fnal.gov
Workflow ID	11974
Stage ID	1
User name	imawby@fnal.gov
Requested	Processors	1
	GPU	No
	RSS bytes	1048576000 (1000 MiB)
	Wall seconds limit	7200 (2 hours)
Submitted time	2026-01-15 20:20:16
Site	UK_Bristol
Entry	CMSHTPC_T2_UK_SGrid_Bristol_lcgce02
Last heartbeat	2026-01-15 21:32:06
From worker node	Hostname	hd81.dice.priv
	cpuinfo	AMD EPYC 7551P 32-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	1048576000 (1000 MiB)
	Wall seconds limit	259200 (72 hours)
	GPU
	Inner Apptainer?	True
Job state	outputting_failed
Started	2026-01-15 20:21:53
Input files	fardet-hd:nu_dune10kt_1x2x6_1413_472_20230826T183335Z_gen_g4_detsim_hitreco__20240229T171735Z_reco2.root
Jobscript	Exit code	0
	Real time	10m (650s)
	CPU time	8m (533s = 81%)
	Max RSS bytes	1261408256 (1202 MiB)
Outputting started	2026-01-15 20:32:44
Output files
Finished	2026-01-15 21:32:06
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

is block should be empty ------------------
---------------------------------------------------------
Input PFN = root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/fardet-hd/0c/95/nu_dune10kt_1x2x6_1413_472_20230826T183335Z_gen_g4_detsim_hitreco__20240229T171735Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 23rd record. run: 1413 subRun: 1 event: 47223 at 15-Jan-2026 20:26:04 UTC
Begin processing the 24th record. run: 1413 subRun: 1 event: 47224 at 15-Jan-2026 20:26:08 UTC
Begin processing the 25th record. run: 1413 subRun: 1 event: 47225 at 15-Jan-2026 20:26:12 UTC
Begin processing the 26th record. run: 1413 subRun: 1 event: 47226 at 15-Jan-2026 20:26:17 UTC
Begin processing the 27th record. run: 1413 subRun: 1 event: 47227 at 15-Jan-2026 20:26:22 UTC
Begin processing the 28th record. run: 1413 subRun: 1 event: 47228 at 15-Jan-2026 20:26:26 UTC
Begin processing the 29th record. run: 1413 subRun: 1 event: 47229 at 15-Jan-2026 20:26:31 UTC
Begin processing the 30th record. run: 1413 subRun: 1 event: 47230 at 15-Jan-2026 20:26:36 UTC
Begin processing the 31st record. run: 1413 subRun: 1 event: 47231 at 15-Jan-2026 20:26:40 UTC
Begin processing the 32nd record. run: 1413 subRun: 1 event: 47232 at 15-Jan-2026 20:26:51 UTC
Begin processing the 33rd record. run: 1413 subRun: 1 event: 47233 at 15-Jan-2026 20:26:55 UTC
Begin processing the 34th record. run: 1413 subRun: 1 event: 47234 at 15-Jan-2026 20:26:59 UTC
Begin processing the 35th record. run: 1413 subRun: 1 event: 47235 at 15-Jan-2026 20:27:03 UTC
Begin processing the 36th record. run: 1413 subRun: 1 event: 47236 at 15-Jan-2026 20:27:07 UTC
Begin processing the 37th record. run: 1413 subRun: 1 event: 47237 at 15-Jan-2026 20:27:21 UTC
Begin processing the 38th record. run: 1413 subRun: 1 event: 47238 at 15-Jan-2026 20:27:25 UTC
Begin processing the 39th record. run: 1413 subRun: 1 event: 47239 at 15-Jan-2026 20:27:29 UTC
Begin processing the 40th record. run: 1413 subRun: 1 event: 47240 at 15-Jan-2026 20:27:33 UTC
Begin processing the 41st record. run: 1413 subRun: 1 event: 47241 at 15-Jan-2026 20:27:38 UTC
Begin processing the 42nd record. run: 1413 subRun: 1 event: 47242 at 15-Jan-2026 20:27:42 UTC
Begin processing the 43rd record. run: 1413 subRun: 1 event: 47243 at 15-Jan-2026 20:27:46 UTC
Begin processing the 44th record. run: 1413 subRun: 1 event: 47244 at 15-Jan-2026 20:27:52 UTC
Begin processing the 45th record. run: 1413 subRun: 1 event: 47245 at 15-Jan-2026 20:27:55 UTC
Begin processing the 46th record. run: 1413 subRun: 1 event: 47246 at 15-Jan-2026 20:27:59 UTC
Begin processing the 47th record. run: 1413 subRun: 1 event: 47247 at 15-Jan-2026 20:28:04 UTC
Begin processing the 48th record. run: 1413 subRun: 1 event: 47248 at 15-Jan-2026 20:28:08 UTC
Begin processing the 49th record. run: 1413 subRun: 1 event: 47249 at 15-Jan-2026 20:28:14 UTC
Begin processing the 50th record. run: 1413 subRun: 1 event: 47250 at 15-Jan-2026 20:28:19 UTC
Begin processing the 51st record. run: 1413 subRun: 1 event: 47251 at 15-Jan-2026 20:28:35 UTC
Begin processing the 52nd record. run: 1413 subRun: 1 event: 47252 at 15-Jan-2026 20:28:39 UTC
Begin processing the 53rd record. run: 1413 subRun: 1 event: 47253 at 15-Jan-2026 20:28:46 UTC
Begin processing the 54th record. run: 1413 subRun: 1 event: 47254 at 15-Jan-2026 20:28:50 UTC
Begin processing the 55th record. run: 1413 subRun: 1 event: 47255 at 15-Jan-2026 20:28:55 UTC
Begin processing the 56th record. run: 1413 subRun: 1 event: 47256 at 15-Jan-2026 20:28:59 UTC
Begin processing the 57th record. run: 1413 subRun: 1 event: 47257 at 15-Jan-2026 20:29:04 UTC
Begin processing the 58th record. run: 1413 subRun: 1 event: 47258 at 15-Jan-2026 20:29:08 UTC
Begin processing the 59th record. run: 1413 subRun: 1 event: 47259 at 15-Jan-2026 20:29:12 UTC
Begin processing the 60th record. run: 1413 subRun: 1 event: 47260 at 15-Jan-2026 20:29:32 UTC
Begin processing the 61st record. run: 1413 subRun: 1 event: 47261 at 15-Jan-2026 20:29:37 UTC
Begin processing the 62nd record. run: 1413 subRun: 1 event: 47262 at 15-Jan-2026 20:29:40 UTC
Begin processing the 63rd record. run: 1413 subRun: 1 event: 47263 at 15-Jan-2026 20:29:44 UTC
Begin processing the 64th record. run: 1413 subRun: 1 event: 47264 at 15-Jan-2026 20:29:48 UTC
Begin processing the 65th record. run: 1413 subRun: 1 event: 47265 at 15-Jan-2026 20:29:52 UTC
Begin processing the 66th record. run: 1413 subRun: 1 event: 47266 at 15-Jan-2026 20:29:56 UTC
Begin processing the 67th record. run: 1413 subRun: 1 event: 47267 at 15-Jan-2026 20:30:00 UTC
Begin processing the 68th record. run: 1413 subRun: 1 event: 47268 at 15-Jan-2026 20:30:04 UTC
Begin processing the 69th record. run: 1413 subRun: 1 event: 47269 at 15-Jan-2026 20:30:11 UTC
Begin processing the 70th record. run: 1413 subRun: 1 event: 47270 at 15-Jan-2026 20:30:15 UTC
Begin processing the 71st record. run: 1413 subRun: 1 event: 47271 at 15-Jan-2026 20:30:24 UTC
Begin processing the 72nd record. run: 1413 subRun: 1 event: 47272 at 15-Jan-2026 20:30:28 UTC
Begin processing the 73rd record. run: 1413 subRun: 1 event: 47273 at 15-Jan-2026 20:30:32 UTC
Begin processing the 74th record. run: 1413 subRun: 1 event: 47274 at 15-Jan-2026 20:30:36 UTC
Begin processing the 75th record. run: 1413 subRun: 1 event: 47275 at 15-Jan-2026 20:30:40 UTC
Begin processing the 76th record. run: 1413 subRun: 1 event: 47276 at 15-Jan-2026 20:30:44 UTC
Begin processing the 77th record. run: 1413 subRun: 1 event: 47277 at 15-Jan-2026 20:30:49 UTC
Begin processing the 78th record. run: 1413 subRun: 1 event: 47278 at 15-Jan-2026 20:30:53 UTC
Begin processing the 79th record. run: 1413 subRun: 1 event: 47279 at 15-Jan-2026 20:30:58 UTC
Begin processing the 80th record. run: 1413 subRun: 1 event: 47280 at 15-Jan-2026 20:31:01 UTC
Begin processing the 81st record. run: 1413 subRun: 1 event: 47281 at 15-Jan-2026 20:31:05 UTC
Begin processing the 82nd record. run: 1413 subRun: 1 event: 47282 at 15-Jan-2026 20:31:10 UTC
Begin processing the 83rd record. run: 1413 subRun: 1 event: 47283 at 15-Jan-2026 20:31:14 UTC
Begin processing the 84th record. run: 1413 subRun: 1 event: 47284 at 15-Jan-2026 20:31:18 UTC
Begin processing the 85th record. run: 1413 subRun: 1 event: 47285 at 15-Jan-2026 20:31:23 UTC
Begin processing the 86th record. run: 1413 subRun: 1 event: 47286 at 15-Jan-2026 20:31:27 UTC
Begin processing the 87th record. run: 1413 subRun: 1 event: 47287 at 15-Jan-2026 20:31:31 UTC
Begin processing the 88th record. run: 1413 subRun: 1 event: 47288 at 15-Jan-2026 20:31:37 UTC
Begin processing the 89th record. run: 1413 subRun: 1 event: 47289 at 15-Jan-2026 20:31:41 UTC
Begin processing the 90th record. run: 1413 subRun: 1 event: 47290 at 15-Jan-2026 20:31:45 UTC
Begin processing the 91st record. run: 1413 subRun: 1 event: 47291 at 15-Jan-2026 20:31:50 UTC
Begin processing the 92nd record. run: 1413 subRun: 1 event: 47292 at 15-Jan-2026 20:31:53 UTC
Begin processing the 93rd record. run: 1413 subRun: 1 event: 47293 at 15-Jan-2026 20:32:00 UTC
Begin processing the 94th record. run: 1413 subRun: 1 event: 47294 at 15-Jan-2026 20:32:04 UTC
Begin processing the 95th record. run: 1413 subRun: 1 event: 47295 at 15-Jan-2026 20:32:11 UTC
Begin processing the 96th record. run: 1413 subRun: 1 event: 47296 at 15-Jan-2026 20:32:15 UTC
Begin processing the 97th record. run: 1413 subRun: 1 event: 47297 at 15-Jan-2026 20:32:20 UTC
Begin processing the 98th record. run: 1413 subRun: 1 event: 47298 at 15-Jan-2026 20:32:26 UTC
Begin processing the 99th record. run: 1413 subRun: 1 event: 47299 at 15-Jan-2026 20:32:30 UTC
Begin processing the 100th record. run: 1413 subRun: 1 event: 47300 at 15-Jan-2026 20:32:38 UTC
15-Jan-2026 20:32:43 UTC  Closed output file "nu_dune10kt_1x2x6_1413_472_20230826T183335Z_gen_g4_detsim_hitreco__20240229T171735Z_reco2_reco2.root"
15-Jan-2026 20:32:43 UTC  Closed input file "root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/fardet-hd/0c/95/nu_dune10kt_1x2x6_1413_472_20230826T183335Z_gen_g4_detsim_hitreco__20240229T171735Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      3.43527       4.8426        19.0351       4.14486       2.33292        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0223394     0.0581846     0.664371      0.0389476     0.0866417       100    
reco:pandora:StandardPandora                    3.39553       4.7668        18.9102       4.06824       2.32107        100    
[art]:TriggerResults:TriggerResultInserter    1.4517e-05    3.15484e-05   0.000115238   2.73315e-05   1.65333e-05      100    
end_path:out1:RootOutput                       3.015e-06    5.2548e-06     2.115e-05     4.063e-06    2.63381e-06      100    
end_path:out1:RootOutput(write)               0.00164713     0.0173186     0.0952663     0.0126543     0.0165584       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2242.67 MB
  Peak resident set size usage (VmHWM): 1261.41 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===