Jobsub ID 273497.0@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/78/f5/nu_dune10kt_1x2x6_1410_263_20230826T123330Z_gen_g4_detsim_hitreco__20240229T171845Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 26th record. run: 1410 subRun: 1 event: 26326 at 15-Jan-2026 21:20:35 CET
Begin processing the 27th record. run: 1410 subRun: 1 event: 26327 at 15-Jan-2026 21:20:37 CET
Begin processing the 28th record. run: 1410 subRun: 1 event: 26328 at 15-Jan-2026 21:20:40 CET
Begin processing the 29th record. run: 1410 subRun: 1 event: 26329 at 15-Jan-2026 21:20:46 CET
Begin processing the 30th record. run: 1410 subRun: 1 event: 26330 at 15-Jan-2026 21:20:48 CET
Begin processing the 31st record. run: 1410 subRun: 1 event: 26331 at 15-Jan-2026 21:20:51 CET
Begin processing the 32nd record. run: 1410 subRun: 1 event: 26332 at 15-Jan-2026 21:20:58 CET
Begin processing the 33rd record. run: 1410 subRun: 1 event: 26333 at 15-Jan-2026 21:21:00 CET
Begin processing the 34th record. run: 1410 subRun: 1 event: 26334 at 15-Jan-2026 21:21:02 CET
Begin processing the 35th record. run: 1410 subRun: 1 event: 26335 at 15-Jan-2026 21:21:04 CET
Begin processing the 36th record. run: 1410 subRun: 1 event: 26336 at 15-Jan-2026 21:21:06 CET
Begin processing the 37th record. run: 1410 subRun: 1 event: 26337 at 15-Jan-2026 21:21:08 CET
Begin processing the 38th record. run: 1410 subRun: 1 event: 26338 at 15-Jan-2026 21:21:11 CET
Begin processing the 39th record. run: 1410 subRun: 1 event: 26339 at 15-Jan-2026 21:21:14 CET
Begin processing the 40th record. run: 1410 subRun: 1 event: 26340 at 15-Jan-2026 21:21:17 CET
Begin processing the 41st record. run: 1410 subRun: 1 event: 26341 at 15-Jan-2026 21:21:19 CET
Begin processing the 42nd record. run: 1410 subRun: 1 event: 26342 at 15-Jan-2026 21:21:22 CET
Begin processing the 43rd record. run: 1410 subRun: 1 event: 26343 at 15-Jan-2026 21:21:24 CET
Begin processing the 44th record. run: 1410 subRun: 1 event: 26344 at 15-Jan-2026 21:21:28 CET
Begin processing the 45th record. run: 1410 subRun: 1 event: 26345 at 15-Jan-2026 21:21:30 CET
Begin processing the 46th record. run: 1410 subRun: 1 event: 26346 at 15-Jan-2026 21:21:32 CET
Begin processing the 47th record. run: 1410 subRun: 1 event: 26347 at 15-Jan-2026 21:21:34 CET
Begin processing the 48th record. run: 1410 subRun: 1 event: 26348 at 15-Jan-2026 21:21:36 CET
Begin processing the 49th record. run: 1410 subRun: 1 event: 26349 at 15-Jan-2026 21:21:39 CET
Begin processing the 50th record. run: 1410 subRun: 1 event: 26350 at 15-Jan-2026 21:21:41 CET
Begin processing the 51st record. run: 1410 subRun: 1 event: 26351 at 15-Jan-2026 21:21:44 CET
Begin processing the 52nd record. run: 1410 subRun: 1 event: 26352 at 15-Jan-2026 21:21:46 CET
Begin processing the 53rd record. run: 1410 subRun: 1 event: 26353 at 15-Jan-2026 21:21:48 CET
Begin processing the 54th record. run: 1410 subRun: 1 event: 26354 at 15-Jan-2026 21:21:50 CET
Begin processing the 55th record. run: 1410 subRun: 1 event: 26355 at 15-Jan-2026 21:21:52 CET
Begin processing the 56th record. run: 1410 subRun: 1 event: 26356 at 15-Jan-2026 21:21:56 CET
Begin processing the 57th record. run: 1410 subRun: 1 event: 26357 at 15-Jan-2026 21:21:58 CET
Begin processing the 58th record. run: 1410 subRun: 1 event: 26358 at 15-Jan-2026 21:22:01 CET
Begin processing the 59th record. run: 1410 subRun: 1 event: 26359 at 15-Jan-2026 21:22:03 CET
Begin processing the 60th record. run: 1410 subRun: 1 event: 26360 at 15-Jan-2026 21:22:05 CET
Begin processing the 61st record. run: 1410 subRun: 1 event: 26361 at 15-Jan-2026 21:22:08 CET
Begin processing the 62nd record. run: 1410 subRun: 1 event: 26362 at 15-Jan-2026 21:22:11 CET
Begin processing the 63rd record. run: 1410 subRun: 1 event: 26363 at 15-Jan-2026 21:22:12 CET
Begin processing the 64th record. run: 1410 subRun: 1 event: 26364 at 15-Jan-2026 21:22:15 CET
Begin processing the 65th record. run: 1410 subRun: 1 event: 26365 at 15-Jan-2026 21:22:18 CET
Begin processing the 66th record. run: 1410 subRun: 1 event: 26366 at 15-Jan-2026 21:22:20 CET
Begin processing the 67th record. run: 1410 subRun: 1 event: 26367 at 15-Jan-2026 21:22:22 CET
Begin processing the 68th record. run: 1410 subRun: 1 event: 26368 at 15-Jan-2026 21:22:25 CET
Begin processing the 69th record. run: 1410 subRun: 1 event: 26369 at 15-Jan-2026 21:22:27 CET
Begin processing the 70th record. run: 1410 subRun: 1 event: 26370 at 15-Jan-2026 21:22:29 CET
Begin processing the 71st record. run: 1410 subRun: 1 event: 26371 at 15-Jan-2026 21:22:32 CET
Begin processing the 72nd record. run: 1410 subRun: 1 event: 26372 at 15-Jan-2026 21:22:34 CET
Begin processing the 73rd record. run: 1410 subRun: 1 event: 26373 at 15-Jan-2026 21:22:40 CET
Begin processing the 74th record. run: 1410 subRun: 1 event: 26374 at 15-Jan-2026 21:22:49 CET
Begin processing the 75th record. run: 1410 subRun: 1 event: 26375 at 15-Jan-2026 21:22:51 CET
Begin processing the 76th record. run: 1410 subRun: 1 event: 26376 at 15-Jan-2026 21:22:55 CET
Begin processing the 77th record. run: 1410 subRun: 1 event: 26377 at 15-Jan-2026 21:22:56 CET
Begin processing the 78th record. run: 1410 subRun: 1 event: 26378 at 15-Jan-2026 21:22:59 CET
Begin processing the 79th record. run: 1410 subRun: 1 event: 26379 at 15-Jan-2026 21:23:02 CET
Begin processing the 80th record. run: 1410 subRun: 1 event: 26380 at 15-Jan-2026 21:23:05 CET
Begin processing the 81st record. run: 1410 subRun: 1 event: 26381 at 15-Jan-2026 21:23:07 CET
Begin processing the 82nd record. run: 1410 subRun: 1 event: 26382 at 15-Jan-2026 21:23:10 CET
Begin processing the 83rd record. run: 1410 subRun: 1 event: 26383 at 15-Jan-2026 21:23:13 CET
Begin processing the 84th record. run: 1410 subRun: 1 event: 26384 at 15-Jan-2026 21:23:16 CET
Begin processing the 85th record. run: 1410 subRun: 1 event: 26385 at 15-Jan-2026 21:23:18 CET
Begin processing the 86th record. run: 1410 subRun: 1 event: 26386 at 15-Jan-2026 21:23:22 CET
Begin processing the 87th record. run: 1410 subRun: 1 event: 26387 at 15-Jan-2026 21:23:24 CET
Begin processing the 88th record. run: 1410 subRun: 1 event: 26388 at 15-Jan-2026 21:23:28 CET
Begin processing the 89th record. run: 1410 subRun: 1 event: 26389 at 15-Jan-2026 21:23:30 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 90th record. run: 1410 subRun: 1 event: 26390 at 15-Jan-2026 21:23:32 CET
Begin processing the 91st record. run: 1410 subRun: 1 event: 26391 at 15-Jan-2026 21:23:34 CET
Begin processing the 92nd record. run: 1410 subRun: 1 event: 26392 at 15-Jan-2026 21:23:36 CET
Begin processing the 93rd record. run: 1410 subRun: 1 event: 26393 at 15-Jan-2026 21:23:38 CET
Begin processing the 94th record. run: 1410 subRun: 1 event: 26394 at 15-Jan-2026 21:23:42 CET
Begin processing the 95th record. run: 1410 subRun: 1 event: 26395 at 15-Jan-2026 21:23:44 CET
Begin processing the 96th record. run: 1410 subRun: 1 event: 26396 at 15-Jan-2026 21:23:46 CET
Begin processing the 97th record. run: 1410 subRun: 1 event: 26397 at 15-Jan-2026 21:23:48 CET
Begin processing the 98th record. run: 1410 subRun: 1 event: 26398 at 15-Jan-2026 21:23:50 CET
Begin processing the 99th record. run: 1410 subRun: 1 event: 26399 at 15-Jan-2026 21:23:52 CET
Begin processing the 100th record. run: 1410 subRun: 1 event: 26400 at 15-Jan-2026 21:23:56 CET
15-Jan-2026 21:23:59 CET Closed output file "nu_dune10kt_1x2x6_1410_263_20230826T123330Z_gen_g4_detsim_hitreco__20240229T171845Z_reco2_reco2.root"
15-Jan-2026 21:23:59 CET Closed input file "root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/fardet-hd/78/f5/nu_dune10kt_1x2x6_1410_263_20230826T123330Z_gen_g4_detsim_hitreco__20240229T171845Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.0144499 2.52797 8.75987 2.16902 1.16235 100
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00191466 0.010917 0.0298921 0.0112908 0.00717757 100
reco:pandora:StandardPandora 0.0108526 2.5062 8.7177 2.15255 1.15471 100
[art]:TriggerResults:TriggerResultInserter 9.127e-06 2.18599e-05 0.00016792 1.71725e-05 2.20884e-05 100
end_path:out1:RootOutput 2.965e-06 3.99108e-06 1.7643e-05 3.702e-06 1.91214e-06 100
end_path:out1:RootOutput(write) 0.000738816 0.0106601 0.0373216 0.00776181 0.00872709 100
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 2163.75 MB
Peak resident set size usage (VmHWM): 1185.44 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===