Jobsub ID 273485.19@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
------ this block should be empty ------------------
---------------------------------------------------------
Input PFN = root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/fardet-hd/ae/9e/nu_dune10kt_1x2x6_1412_113_20230826T153301Z_gen_g4_detsim_hitreco__20240229T181547Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 26th record. run: 1412 subRun: 1 event: 11326 at 15-Jan-2026 20:59:26 CET
Begin processing the 27th record. run: 1412 subRun: 1 event: 11327 at 15-Jan-2026 20:59:29 CET
Begin processing the 28th record. run: 1412 subRun: 1 event: 11328 at 15-Jan-2026 20:59:33 CET
Begin processing the 29th record. run: 1412 subRun: 1 event: 11329 at 15-Jan-2026 20:59:36 CET
Begin processing the 30th record. run: 1412 subRun: 1 event: 11330 at 15-Jan-2026 20:59:40 CET
Begin processing the 31st record. run: 1412 subRun: 1 event: 11331 at 15-Jan-2026 20:59:43 CET
Begin processing the 32nd record. run: 1412 subRun: 1 event: 11332 at 15-Jan-2026 20:59:46 CET
Begin processing the 33rd record. run: 1412 subRun: 1 event: 11333 at 15-Jan-2026 20:59:52 CET
Begin processing the 34th record. run: 1412 subRun: 1 event: 11334 at 15-Jan-2026 20:59:56 CET
Begin processing the 35th record. run: 1412 subRun: 1 event: 11335 at 15-Jan-2026 21:00:00 CET
Begin processing the 36th record. run: 1412 subRun: 1 event: 11336 at 15-Jan-2026 21:00:08 CET
Begin processing the 37th record. run: 1412 subRun: 1 event: 11337 at 15-Jan-2026 21:00:12 CET
Begin processing the 38th record. run: 1412 subRun: 1 event: 11338 at 15-Jan-2026 21:00:16 CET
Begin processing the 39th record. run: 1412 subRun: 1 event: 11339 at 15-Jan-2026 21:00:28 CET
Begin processing the 40th record. run: 1412 subRun: 1 event: 11340 at 15-Jan-2026 21:00:33 CET
Begin processing the 41st record. run: 1412 subRun: 1 event: 11341 at 15-Jan-2026 21:00:41 CET
Begin processing the 42nd record. run: 1412 subRun: 1 event: 11342 at 15-Jan-2026 21:00:45 CET
Begin processing the 43rd record. run: 1412 subRun: 1 event: 11343 at 15-Jan-2026 21:00:49 CET
Begin processing the 44th record. run: 1412 subRun: 1 event: 11344 at 15-Jan-2026 21:01:30 CET
Begin processing the 45th record. run: 1412 subRun: 1 event: 11345 at 15-Jan-2026 21:01:34 CET
Begin processing the 46th record. run: 1412 subRun: 1 event: 11346 at 15-Jan-2026 21:01:38 CET
Begin processing the 47th record. run: 1412 subRun: 1 event: 11347 at 15-Jan-2026 21:01:44 CET
Begin processing the 48th record. run: 1412 subRun: 1 event: 11348 at 15-Jan-2026 21:01:51 CET
Begin processing the 49th record. run: 1412 subRun: 1 event: 11349 at 15-Jan-2026 21:01:57 CET
Begin processing the 50th record. run: 1412 subRun: 1 event: 11350 at 15-Jan-2026 21:03:15 CET
Begin processing the 51st record. run: 1412 subRun: 1 event: 11351 at 15-Jan-2026 21:03:19 CET
Begin processing the 52nd record. run: 1412 subRun: 1 event: 11352 at 15-Jan-2026 21:03:22 CET
Begin processing the 53rd record. run: 1412 subRun: 1 event: 11353 at 15-Jan-2026 21:03:26 CET
Begin processing the 54th record. run: 1412 subRun: 1 event: 11354 at 15-Jan-2026 21:03:30 CET
Begin processing the 55th record. run: 1412 subRun: 1 event: 11355 at 15-Jan-2026 21:03:34 CET
Begin processing the 56th record. run: 1412 subRun: 1 event: 11356 at 15-Jan-2026 21:03:38 CET
Begin processing the 57th record. run: 1412 subRun: 1 event: 11357 at 15-Jan-2026 21:03:43 CET
Begin processing the 58th record. run: 1412 subRun: 1 event: 11358 at 15-Jan-2026 21:03:47 CET
Begin processing the 59th record. run: 1412 subRun: 1 event: 11359 at 15-Jan-2026 21:03:51 CET
Begin processing the 60th record. run: 1412 subRun: 1 event: 11360 at 15-Jan-2026 21:04:05 CET
Begin processing the 61st record. run: 1412 subRun: 1 event: 11361 at 15-Jan-2026 21:04:09 CET
Begin processing the 62nd record. run: 1412 subRun: 1 event: 11362 at 15-Jan-2026 21:04:18 CET
Begin processing the 63rd record. run: 1412 subRun: 1 event: 11363 at 15-Jan-2026 21:04:21 CET
Begin processing the 64th record. run: 1412 subRun: 1 event: 11364 at 15-Jan-2026 21:04:26 CET
Begin processing the 65th record. run: 1412 subRun: 1 event: 11365 at 15-Jan-2026 21:04:30 CET
Begin processing the 66th record. run: 1412 subRun: 1 event: 11366 at 15-Jan-2026 21:04:33 CET
Begin processing the 67th record. run: 1412 subRun: 1 event: 11367 at 15-Jan-2026 21:04:44 CET
Begin processing the 68th record. run: 1412 subRun: 1 event: 11368 at 15-Jan-2026 21:04:49 CET
PandoraContentApi::GetList(*this, listName, pList) return STATUS_CODE_NOT_INITIALIZED
in function: GetList
in file: /exp/dune/app/users/imawby/dunesw_validation/srcs/larpandoracontent/larpandoradlcontent/LArTwoDReco/DLThreeDClusterSplittingAlgorithm.cc line#: 194
Begin processing the 69th record. run: 1412 subRun: 1 event: 11369 at 15-Jan-2026 21:04:53 CET
Begin processing the 70th record. run: 1412 subRun: 1 event: 11370 at 15-Jan-2026 21:04:57 CET
Begin processing the 71st record. run: 1412 subRun: 1 event: 11371 at 15-Jan-2026 21:05:00 CET
Begin processing the 72nd record. run: 1412 subRun: 1 event: 11372 at 15-Jan-2026 21:05:04 CET
Begin processing the 73rd record. run: 1412 subRun: 1 event: 11373 at 15-Jan-2026 21:05:09 CET
Begin processing the 74th record. run: 1412 subRun: 1 event: 11374 at 15-Jan-2026 21:05:13 CET
Begin processing the 75th record. run: 1412 subRun: 1 event: 11375 at 15-Jan-2026 21:05:17 CET
Begin processing the 76th record. run: 1412 subRun: 1 event: 11376 at 15-Jan-2026 21:05:22 CET
Begin processing the 77th record. run: 1412 subRun: 1 event: 11377 at 15-Jan-2026 21:05:27 CET
Begin processing the 78th record. run: 1412 subRun: 1 event: 11378 at 15-Jan-2026 21:05:31 CET
Begin processing the 79th record. run: 1412 subRun: 1 event: 11379 at 15-Jan-2026 21:05:34 CET
Begin processing the 80th record. run: 1412 subRun: 1 event: 11380 at 15-Jan-2026 21:05:39 CET
Begin processing the 81st record. run: 1412 subRun: 1 event: 11381 at 15-Jan-2026 21:05:42 CET
Begin processing the 82nd record. run: 1412 subRun: 1 event: 11382 at 15-Jan-2026 21:05:47 CET
Begin processing the 83rd record. run: 1412 subRun: 1 event: 11383 at 15-Jan-2026 21:05:51 CET
Begin processing the 84th record. run: 1412 subRun: 1 event: 11384 at 15-Jan-2026 21:05:55 CET
Begin processing the 85th record. run: 1412 subRun: 1 event: 11385 at 15-Jan-2026 21:06:10 CET
Begin processing the 86th record. run: 1412 subRun: 1 event: 11386 at 15-Jan-2026 21:06:13 CET
Begin processing the 87th record. run: 1412 subRun: 1 event: 11387 at 15-Jan-2026 21:06:17 CET
Begin processing the 88th record. run: 1412 subRun: 1 event: 11388 at 15-Jan-2026 21:06:21 CET
Begin processing the 89th record. run: 1412 subRun: 1 event: 11389 at 15-Jan-2026 21:06:24 CET
Begin processing the 90th record. run: 1412 subRun: 1 event: 11390 at 15-Jan-2026 21:06:28 CET
Begin processing the 91st record. run: 1412 subRun: 1 event: 11391 at 15-Jan-2026 21:06:33 CET
Begin processing the 92nd record. run: 1412 subRun: 1 event: 11392 at 15-Jan-2026 21:06:37 CET
Begin processing the 93rd record. run: 1412 subRun: 1 event: 11393 at 15-Jan-2026 21:06:47 CET
Begin processing the 94th record. run: 1412 subRun: 1 event: 11394 at 15-Jan-2026 21:06:51 CET
Begin processing the 95th record. run: 1412 subRun: 1 event: 11395 at 15-Jan-2026 21:06:54 CET
Begin processing the 96th record. run: 1412 subRun: 1 event: 11396 at 15-Jan-2026 21:06:58 CET
Begin processing the 97th record. run: 1412 subRun: 1 event: 11397 at 15-Jan-2026 21:07:01 CET
Begin processing the 98th record. run: 1412 subRun: 1 event: 11398 at 15-Jan-2026 21:07:05 CET
Begin processing the 99th record. run: 1412 subRun: 1 event: 11399 at 15-Jan-2026 21:07:09 CET
Begin processing the 100th record. run: 1412 subRun: 1 event: 11400 at 15-Jan-2026 21:07:13 CET
15-Jan-2026 21:08:12 CET Closed output file "nu_dune10kt_1x2x6_1412_113_20230826T153301Z_gen_g4_detsim_hitreco__20240229T181547Z_reco2_reco2.root"
15-Jan-2026 21:08:12 CET Closed input file "root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/fardet-hd/ae/9e/nu_dune10kt_1x2x6_1412_113_20230826T153301Z_gen_g4_detsim_hitreco__20240229T181547Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 2.51605 11.2312 456.546 3.39366 47.0692 100
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.045397 0.0964709 0.489393 0.0768837 0.0775474 100
reco:pandora:StandardPandora 2.45271 11.1171 456.352 3.28314 47.0594 100
[art]:TriggerResults:TriggerResultInserter 1.2726e-05 2.53986e-05 7.5021e-05 2.1766e-05 1.2542e-05 100
end_path:out1:RootOutput 2.346e-06 3.33262e-06 1.2968e-05 2.9485e-06 1.46708e-06 100
end_path:out1:RootOutput(write) 0.00124208 0.0174517 0.110263 0.00961086 0.0205219 100
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 2398.47 MB
Peak resident set size usage (VmHWM): 1416.61 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===