Jobsub ID 273497.106@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
user2.opensciencegrid.org/sw/dune/ad554f6b0d8af5cd51272760a301f448969f3ed8/localProducts_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/57/50/nu_dune10kt_1x2x6_1111_86_20230827T033400Z_gen_g4_detsim_hitreco__20240229T182445Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 29th record. run: 1111 subRun: 1 event: 8629 at 15-Jan-2026 21:24:26 CET
Begin processing the 30th record. run: 1111 subRun: 1 event: 8630 at 15-Jan-2026 21:24:34 CET
Begin processing the 31st record. run: 1111 subRun: 1 event: 8631 at 15-Jan-2026 21:24:38 CET
Begin processing the 32nd record. run: 1111 subRun: 1 event: 8632 at 15-Jan-2026 21:24:40 CET
Begin processing the 33rd record. run: 1111 subRun: 1 event: 8633 at 15-Jan-2026 21:24:43 CET
Begin processing the 34th record. run: 1111 subRun: 1 event: 8634 at 15-Jan-2026 21:24:47 CET
Begin processing the 35th record. run: 1111 subRun: 1 event: 8635 at 15-Jan-2026 21:24:50 CET
Begin processing the 36th record. run: 1111 subRun: 1 event: 8636 at 15-Jan-2026 21:24:53 CET
Begin processing the 37th record. run: 1111 subRun: 1 event: 8637 at 15-Jan-2026 21:24:56 CET
Begin processing the 38th record. run: 1111 subRun: 1 event: 8638 at 15-Jan-2026 21:24:59 CET
Begin processing the 39th record. run: 1111 subRun: 1 event: 8639 at 15-Jan-2026 21:25:05 CET
Begin processing the 40th record. run: 1111 subRun: 1 event: 8640 at 15-Jan-2026 21:25:07 CET
Begin processing the 41st record. run: 1111 subRun: 1 event: 8641 at 15-Jan-2026 21:25:10 CET
Begin processing the 42nd record. run: 1111 subRun: 1 event: 8642 at 15-Jan-2026 21:25:14 CET
Begin processing the 43rd record. run: 1111 subRun: 1 event: 8643 at 15-Jan-2026 21:25:17 CET
Begin processing the 44th record. run: 1111 subRun: 1 event: 8644 at 15-Jan-2026 21:25:20 CET
Begin processing the 45th record. run: 1111 subRun: 1 event: 8645 at 15-Jan-2026 21:25:23 CET
Begin processing the 46th record. run: 1111 subRun: 1 event: 8646 at 15-Jan-2026 21:25:26 CET
Begin processing the 47th record. run: 1111 subRun: 1 event: 8647 at 15-Jan-2026 21:25:29 CET
Begin processing the 48th record. run: 1111 subRun: 1 event: 8648 at 15-Jan-2026 21:25:34 CET
Begin processing the 49th record. run: 1111 subRun: 1 event: 8649 at 15-Jan-2026 21:25:37 CET
Begin processing the 50th record. run: 1111 subRun: 1 event: 8650 at 15-Jan-2026 21:25:40 CET
Begin processing the 51st record. run: 1111 subRun: 1 event: 8651 at 15-Jan-2026 21:25:43 CET
Begin processing the 52nd record. run: 1111 subRun: 1 event: 8652 at 15-Jan-2026 21:25:47 CET
Begin processing the 53rd record. run: 1111 subRun: 1 event: 8653 at 15-Jan-2026 21:25:54 CET
Begin processing the 54th record. run: 1111 subRun: 1 event: 8654 at 15-Jan-2026 21:25:57 CET
Begin processing the 55th record. run: 1111 subRun: 1 event: 8655 at 15-Jan-2026 21:26:01 CET
Begin processing the 56th record. run: 1111 subRun: 1 event: 8656 at 15-Jan-2026 21:26:14 CET
Begin processing the 57th record. run: 1111 subRun: 1 event: 8657 at 15-Jan-2026 21:26:17 CET
Begin processing the 58th record. run: 1111 subRun: 1 event: 8658 at 15-Jan-2026 21:26:20 CET
Begin processing the 59th record. run: 1111 subRun: 1 event: 8659 at 15-Jan-2026 21:26:25 CET
Begin processing the 60th record. run: 1111 subRun: 1 event: 8660 at 15-Jan-2026 21:26:34 CET
Begin processing the 61st record. run: 1111 subRun: 1 event: 8661 at 15-Jan-2026 21:26:37 CET
Begin processing the 62nd record. run: 1111 subRun: 1 event: 8662 at 15-Jan-2026 21:26:41 CET
Begin processing the 63rd record. run: 1111 subRun: 1 event: 8663 at 15-Jan-2026 21:26:44 CET
Begin processing the 64th record. run: 1111 subRun: 1 event: 8664 at 15-Jan-2026 21:26:46 CET
Begin processing the 65th record. run: 1111 subRun: 1 event: 8665 at 15-Jan-2026 21:26:49 CET
Begin processing the 66th record. run: 1111 subRun: 1 event: 8666 at 15-Jan-2026 21:26:52 CET
Begin processing the 67th record. run: 1111 subRun: 1 event: 8667 at 15-Jan-2026 21:26:55 CET
Begin processing the 68th record. run: 1111 subRun: 1 event: 8668 at 15-Jan-2026 21:26:58 CET
Begin processing the 69th record. run: 1111 subRun: 1 event: 8669 at 15-Jan-2026 21:27:54 CET
Begin processing the 70th record. run: 1111 subRun: 1 event: 8670 at 15-Jan-2026 21:27:57 CET
Begin processing the 71st record. run: 1111 subRun: 1 event: 8671 at 15-Jan-2026 21:28:00 CET
Begin processing the 72nd record. run: 1111 subRun: 1 event: 8672 at 15-Jan-2026 21:28:02 CET
Begin processing the 73rd record. run: 1111 subRun: 1 event: 8673 at 15-Jan-2026 21:28:09 CET
Begin processing the 74th record. run: 1111 subRun: 1 event: 8674 at 15-Jan-2026 21:28:12 CET
Begin processing the 75th record. run: 1111 subRun: 1 event: 8675 at 15-Jan-2026 21:28: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 76th record. run: 1111 subRun: 1 event: 8676 at 15-Jan-2026 21:28:17 CET
Begin processing the 77th record. run: 1111 subRun: 1 event: 8677 at 15-Jan-2026 21:28:21 CET
Begin processing the 78th record. run: 1111 subRun: 1 event: 8678 at 15-Jan-2026 21:28:24 CET
Begin processing the 79th record. run: 1111 subRun: 1 event: 8679 at 15-Jan-2026 21:28:41 CET
Begin processing the 80th record. run: 1111 subRun: 1 event: 8680 at 15-Jan-2026 21:29:10 CET
Begin processing the 81st record. run: 1111 subRun: 1 event: 8681 at 15-Jan-2026 21:29:13 CET
Begin processing the 82nd record. run: 1111 subRun: 1 event: 8682 at 15-Jan-2026 21:29:16 CET
Begin processing the 83rd record. run: 1111 subRun: 1 event: 8683 at 15-Jan-2026 21:29:19 CET
Begin processing the 84th record. run: 1111 subRun: 1 event: 8684 at 15-Jan-2026 21:29:23 CET
Begin processing the 85th record. run: 1111 subRun: 1 event: 8685 at 15-Jan-2026 21:29:26 CET
Begin processing the 86th record. run: 1111 subRun: 1 event: 8686 at 15-Jan-2026 21:29:29 CET
Begin processing the 87th record. run: 1111 subRun: 1 event: 8687 at 15-Jan-2026 21:29:32 CET
Begin processing the 88th record. run: 1111 subRun: 1 event: 8688 at 15-Jan-2026 21:29:49 CET
Begin processing the 89th record. run: 1111 subRun: 1 event: 8689 at 15-Jan-2026 21:29:51 CET
Begin processing the 90th record. run: 1111 subRun: 1 event: 8690 at 15-Jan-2026 21:29:55 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 91st record. run: 1111 subRun: 1 event: 8691 at 15-Jan-2026 21:29:57 CET
Begin processing the 92nd record. run: 1111 subRun: 1 event: 8692 at 15-Jan-2026 21:30:00 CET
Begin processing the 93rd record. run: 1111 subRun: 1 event: 8693 at 15-Jan-2026 21:30:02 CET
Begin processing the 94th record. run: 1111 subRun: 1 event: 8694 at 15-Jan-2026 21:30:05 CET
Begin processing the 95th record. run: 1111 subRun: 1 event: 8695 at 15-Jan-2026 21:30:08 CET
Begin processing the 96th record. run: 1111 subRun: 1 event: 8696 at 15-Jan-2026 21:30:11 CET
Begin processing the 97th record. run: 1111 subRun: 1 event: 8697 at 15-Jan-2026 21:30:13 CET
Begin processing the 98th record. run: 1111 subRun: 1 event: 8698 at 15-Jan-2026 21:30:16 CET
Begin processing the 99th record. run: 1111 subRun: 1 event: 8699 at 15-Jan-2026 21:30:19 CET
Begin processing the 100th record. run: 1111 subRun: 1 event: 8700 at 15-Jan-2026 21:30:22 CET
15-Jan-2026 21:30:26 CET Closed output file "nu_dune10kt_1x2x6_1111_86_20230827T033400Z_gen_g4_detsim_hitreco__20240229T182445Z_reco2_reco2.root"
15-Jan-2026 21:30:26 CET Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/57/50/nu_dune10kt_1x2x6_1111_86_20230827T033400Z_gen_g4_detsim_hitreco__20240229T182445Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 2.18681 4.24595 53.8104 2.70498 6.05328 100
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.0429142 0.0567809 0.0897633 0.0580845 0.00878836 100
reco:pandora:StandardPandora 2.14023 4.17611 53.6571 2.64789 6.03904 100
[art]:TriggerResults:TriggerResultInserter 1.4802e-05 3.72313e-05 0.000239653 3.02705e-05 3.09121e-05 100
end_path:out1:RootOutput 3.175e-06 4.94255e-06 4.1663e-05 3.901e-06 3.92088e-06 100
end_path:out1:RootOutput(write) 0.00122572 0.0127578 0.0867548 0.00778192 0.0154164 100
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 2337.1 MB
Peak resident set size usage (VmHWM): 1344.17 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===