Jobsub ID 279275.81@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
ocalProducts_larsoft_v10_13_00_e26_prof
----------- this block should be empty ------------------
---------------------------------------------------------
Input PFN = root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/44/0e/nu_dune10kt_1x2x6_1408_143_20230826T093314Z_gen_g4_detsim_hitreco__20240227T211803Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 29th record. run: 1408 subRun: 1 event: 14329 at 15-Jan-2026 20:40:57 CET
Begin processing the 30th record. run: 1408 subRun: 1 event: 14330 at 15-Jan-2026 20:41:00 CET
Begin processing the 31st record. run: 1408 subRun: 1 event: 14331 at 15-Jan-2026 20:41:03 CET
Begin processing the 32nd record. run: 1408 subRun: 1 event: 14332 at 15-Jan-2026 20:41:06 CET
Begin processing the 33rd record. run: 1408 subRun: 1 event: 14333 at 15-Jan-2026 20:41:09 CET
Begin processing the 34th record. run: 1408 subRun: 1 event: 14334 at 15-Jan-2026 20:41:15 CET
Begin processing the 35th record. run: 1408 subRun: 1 event: 14335 at 15-Jan-2026 20:41:17 CET
Begin processing the 36th record. run: 1408 subRun: 1 event: 14336 at 15-Jan-2026 20:41:30 CET
Begin processing the 37th record. run: 1408 subRun: 1 event: 14337 at 15-Jan-2026 20:41:34 CET
Begin processing the 38th record. run: 1408 subRun: 1 event: 14338 at 15-Jan-2026 20:41:37 CET
Begin processing the 39th record. run: 1408 subRun: 1 event: 14339 at 15-Jan-2026 20:41:40 CET
Begin processing the 40th record. run: 1408 subRun: 1 event: 14340 at 15-Jan-2026 20:41:43 CET
Begin processing the 41st record. run: 1408 subRun: 1 event: 14341 at 15-Jan-2026 20:41:46 CET
Begin processing the 42nd record. run: 1408 subRun: 1 event: 14342 at 15-Jan-2026 20:41:50 CET
Begin processing the 43rd record. run: 1408 subRun: 1 event: 14343 at 15-Jan-2026 20:41:54 CET
Begin processing the 44th record. run: 1408 subRun: 1 event: 14344 at 15-Jan-2026 20:41:58 CET
Begin processing the 45th record. run: 1408 subRun: 1 event: 14345 at 15-Jan-2026 20:42:01 CET
Begin processing the 46th record. run: 1408 subRun: 1 event: 14346 at 15-Jan-2026 20:42:04 CET
Begin processing the 47th record. run: 1408 subRun: 1 event: 14347 at 15-Jan-2026 20:42:07 CET
Begin processing the 48th record. run: 1408 subRun: 1 event: 14348 at 15-Jan-2026 20:42:11 CET
Begin processing the 49th record. run: 1408 subRun: 1 event: 14349 at 15-Jan-2026 20:42:14 CET
Begin processing the 50th record. run: 1408 subRun: 1 event: 14350 at 15-Jan-2026 20:42:16 CET
Begin processing the 51st record. run: 1408 subRun: 1 event: 14351 at 15-Jan-2026 20:42:19 CET
Begin processing the 52nd record. run: 1408 subRun: 1 event: 14352 at 15-Jan-2026 20:42:23 CET
Begin processing the 53rd record. run: 1408 subRun: 1 event: 14353 at 15-Jan-2026 20:42:26 CET
Begin processing the 54th record. run: 1408 subRun: 1 event: 14354 at 15-Jan-2026 20:42:29 CET
Begin processing the 55th record. run: 1408 subRun: 1 event: 14355 at 15-Jan-2026 20:42:35 CET
Begin processing the 56th record. run: 1408 subRun: 1 event: 14356 at 15-Jan-2026 20:42:38 CET
Begin processing the 57th record. run: 1408 subRun: 1 event: 14357 at 15-Jan-2026 20:42:41 CET
Begin processing the 58th record. run: 1408 subRun: 1 event: 14358 at 15-Jan-2026 20:42:44 CET
Begin processing the 59th record. run: 1408 subRun: 1 event: 14359 at 15-Jan-2026 20:42:48 CET
Begin processing the 60th record. run: 1408 subRun: 1 event: 14360 at 15-Jan-2026 20:42:52 CET
Begin processing the 61st record. run: 1408 subRun: 1 event: 14361 at 15-Jan-2026 20:42:56 CET
Begin processing the 62nd record. run: 1408 subRun: 1 event: 14362 at 15-Jan-2026 20:42:59 CET
Begin processing the 63rd record. run: 1408 subRun: 1 event: 14363 at 15-Jan-2026 20:43:05 CET
Begin processing the 64th record. run: 1408 subRun: 1 event: 14364 at 15-Jan-2026 20:43:08 CET
Begin processing the 65th record. run: 1408 subRun: 1 event: 14365 at 15-Jan-2026 20:43:12 CET
Begin processing the 66th record. run: 1408 subRun: 1 event: 14366 at 15-Jan-2026 20:43:15 CET
Begin processing the 67th record. run: 1408 subRun: 1 event: 14367 at 15-Jan-2026 20:43:18 CET
Begin processing the 68th record. run: 1408 subRun: 1 event: 14368 at 15-Jan-2026 20:43:21 CET
Begin processing the 69th record. run: 1408 subRun: 1 event: 14369 at 15-Jan-2026 20:43:25 CET
Begin processing the 70th record. run: 1408 subRun: 1 event: 14370 at 15-Jan-2026 20:43:28 CET
Begin processing the 71st record. run: 1408 subRun: 1 event: 14371 at 15-Jan-2026 20:43:30 CET
Begin processing the 72nd record. run: 1408 subRun: 1 event: 14372 at 15-Jan-2026 20:43:33 CET
Begin processing the 73rd record. run: 1408 subRun: 1 event: 14373 at 15-Jan-2026 20:43:50 CET
Begin processing the 74th record. run: 1408 subRun: 1 event: 14374 at 15-Jan-2026 20:43:53 CET
Begin processing the 75th record. run: 1408 subRun: 1 event: 14375 at 15-Jan-2026 20:43:56 CET
Begin processing the 76th record. run: 1408 subRun: 1 event: 14376 at 15-Jan-2026 20:44:00 CET
Begin processing the 77th record. run: 1408 subRun: 1 event: 14377 at 15-Jan-2026 20:44:03 CET
Begin processing the 78th record. run: 1408 subRun: 1 event: 14378 at 15-Jan-2026 20:44:06 CET
Begin processing the 79th record. run: 1408 subRun: 1 event: 14379 at 15-Jan-2026 20:44:09 CET
Begin processing the 80th record. run: 1408 subRun: 1 event: 14380 at 15-Jan-2026 20:44:13 CET
Begin processing the 81st record. run: 1408 subRun: 1 event: 14381 at 15-Jan-2026 20:44:15 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 82nd record. run: 1408 subRun: 1 event: 14382 at 15-Jan-2026 20:44:18 CET
Begin processing the 83rd record. run: 1408 subRun: 1 event: 14383 at 15-Jan-2026 20:44:21 CET
Begin processing the 84th record. run: 1408 subRun: 1 event: 14384 at 15-Jan-2026 20:44:24 CET
Begin processing the 85th record. run: 1408 subRun: 1 event: 14385 at 15-Jan-2026 20:44:27 CET
Begin processing the 86th record. run: 1408 subRun: 1 event: 14386 at 15-Jan-2026 20:44:30 CET
Begin processing the 87th record. run: 1408 subRun: 1 event: 14387 at 15-Jan-2026 20:44:34 CET
Begin processing the 88th record. run: 1408 subRun: 1 event: 14388 at 15-Jan-2026 20:44:37 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 89th record. run: 1408 subRun: 1 event: 14389 at 15-Jan-2026 20:44:39 CET
Begin processing the 90th record. run: 1408 subRun: 1 event: 14390 at 15-Jan-2026 20:44:43 CET
Begin processing the 91st record. run: 1408 subRun: 1 event: 14391 at 15-Jan-2026 20:44:46 CET
Begin processing the 92nd record. run: 1408 subRun: 1 event: 14392 at 15-Jan-2026 20:44:50 CET
Begin processing the 93rd record. run: 1408 subRun: 1 event: 14393 at 15-Jan-2026 20:44:53 CET
Begin processing the 94th record. run: 1408 subRun: 1 event: 14394 at 15-Jan-2026 20:44:57 CET
Begin processing the 95th record. run: 1408 subRun: 1 event: 14395 at 15-Jan-2026 20:45:00 CET
Begin processing the 96th record. run: 1408 subRun: 1 event: 14396 at 15-Jan-2026 20:45:03 CET
Begin processing the 97th record. run: 1408 subRun: 1 event: 14397 at 15-Jan-2026 20:45:08 CET
Begin processing the 98th record. run: 1408 subRun: 1 event: 14398 at 15-Jan-2026 20:45:11 CET
Begin processing the 99th record. run: 1408 subRun: 1 event: 14399 at 15-Jan-2026 20:45:15 CET
Begin processing the 100th record. run: 1408 subRun: 1 event: 14400 at 15-Jan-2026 20:45:19 CET
15-Jan-2026 20:45:22 CET Closed output file "nu_dune10kt_1x2x6_1408_143_20230826T093314Z_gen_g4_detsim_hitreco__20240227T211803Z_reco2_reco2.root"
15-Jan-2026 20:45:22 CET Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/44/0e/nu_dune10kt_1x2x6_1408_143_20230826T093314Z_gen_g4_detsim_hitreco__20240227T211803Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 2.23451 3.37483 18.4735 2.80267 2.28912 100
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.0333903 0.0595006 0.124761 0.0582077 0.0136692 100
reco:pandora:StandardPandora 2.19069 3.30121 18.3666 2.71729 2.2805 100
[art]:TriggerResults:TriggerResultInserter 1.7082e-05 4.41576e-05 0.000300351 3.0572e-05 3.7444e-05 100
end_path:out1:RootOutput 3.626e-06 4.9153e-06 2.9265e-05 4.4085e-06 3.17245e-06 100
end_path:out1:RootOutput(write) 0.00142966 0.0138312 0.062535 0.0114937 0.0114102 100
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 2195.52 MB
Peak resident set size usage (VmHWM): 1196.09 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===