Jobsub ID 273497.104@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
0a301f448969f3ed8/localProducts_larsoft_v10_13_00_e26_prof
----------- this block should be empty ------------------
---------------------------------------------------------
Input PFN = root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/ff/32/nu_dune10kt_1x2x6_1408_348_20230826T093326Z_gen_g4_detsim_hitreco__20240229T171130Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 26th record. run: 1408 subRun: 1 event: 34826 at 15-Jan-2026 21:23:59 CET
Begin processing the 27th record. run: 1408 subRun: 1 event: 34827 at 15-Jan-2026 21:24:02 CET
Begin processing the 28th record. run: 1408 subRun: 1 event: 34828 at 15-Jan-2026 21:24:04 CET
Begin processing the 29th record. run: 1408 subRun: 1 event: 34829 at 15-Jan-2026 21:24:07 CET
Begin processing the 30th record. run: 1408 subRun: 1 event: 34830 at 15-Jan-2026 21:24:11 CET
Begin processing the 31st record. run: 1408 subRun: 1 event: 34831 at 15-Jan-2026 21:24:13 CET
Begin processing the 32nd record. run: 1408 subRun: 1 event: 34832 at 15-Jan-2026 21:24:16 CET
Begin processing the 33rd record. run: 1408 subRun: 1 event: 34833 at 15-Jan-2026 21:24:19 CET
Begin processing the 34th record. run: 1408 subRun: 1 event: 34834 at 15-Jan-2026 21:25:30 CET
Begin processing the 35th record. run: 1408 subRun: 1 event: 34835 at 15-Jan-2026 21:25:32 CET
Begin processing the 36th record. run: 1408 subRun: 1 event: 34836 at 15-Jan-2026 21:25:35 CET
Begin processing the 37th record. run: 1408 subRun: 1 event: 34837 at 15-Jan-2026 21:25:38 CET
Begin processing the 38th record. run: 1408 subRun: 1 event: 34838 at 15-Jan-2026 21:25:40 CET
Begin processing the 39th record. run: 1408 subRun: 1 event: 34839 at 15-Jan-2026 21:25:43 CET
Begin processing the 40th record. run: 1408 subRun: 1 event: 34840 at 15-Jan-2026 21:25:46 CET
Begin processing the 41st record. run: 1408 subRun: 1 event: 34841 at 15-Jan-2026 21:25:50 CET
Begin processing the 42nd record. run: 1408 subRun: 1 event: 34842 at 15-Jan-2026 21:25:53 CET
Begin processing the 43rd record. run: 1408 subRun: 1 event: 34843 at 15-Jan-2026 21:25:56 CET
Begin processing the 44th record. run: 1408 subRun: 1 event: 34844 at 15-Jan-2026 21:25:58 CET
Begin processing the 45th record. run: 1408 subRun: 1 event: 34845 at 15-Jan-2026 21:26:01 CET
Begin processing the 46th record. run: 1408 subRun: 1 event: 34846 at 15-Jan-2026 21:26:05 CET
Begin processing the 47th record. run: 1408 subRun: 1 event: 34847 at 15-Jan-2026 21:26:08 CET
Begin processing the 48th record. run: 1408 subRun: 1 event: 34848 at 15-Jan-2026 21:26:10 CET
Begin processing the 49th record. run: 1408 subRun: 1 event: 34849 at 15-Jan-2026 21:26:13 CET
Begin processing the 50th record. run: 1408 subRun: 1 event: 34850 at 15-Jan-2026 21:26:15 CET
Begin processing the 51st record. run: 1408 subRun: 1 event: 34851 at 15-Jan-2026 21:26:18 CET
Begin processing the 52nd record. run: 1408 subRun: 1 event: 34852 at 15-Jan-2026 21:26:20 CET
Begin processing the 53rd record. run: 1408 subRun: 1 event: 34853 at 15-Jan-2026 21:26:23 CET
Begin processing the 54th record. run: 1408 subRun: 1 event: 34854 at 15-Jan-2026 21:26:26 CET
Begin processing the 55th record. run: 1408 subRun: 1 event: 34855 at 15-Jan-2026 21:26:29 CET
Begin processing the 56th record. run: 1408 subRun: 1 event: 34856 at 15-Jan-2026 21:26:31 CET
Begin processing the 57th record. run: 1408 subRun: 1 event: 34857 at 15-Jan-2026 21:26:34 CET
Begin processing the 58th record. run: 1408 subRun: 1 event: 34858 at 15-Jan-2026 21:26:36 CET
Begin processing the 59th record. run: 1408 subRun: 1 event: 34859 at 15-Jan-2026 21:26:40 CET
Begin processing the 60th record. run: 1408 subRun: 1 event: 34860 at 15-Jan-2026 21:26:44 CET
Begin processing the 61st record. run: 1408 subRun: 1 event: 34861 at 15-Jan-2026 21:26:47 CET
Begin processing the 62nd record. run: 1408 subRun: 1 event: 34862 at 15-Jan-2026 21:26:50 CET
Begin processing the 63rd record. run: 1408 subRun: 1 event: 34863 at 15-Jan-2026 21:26:52 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 64th record. run: 1408 subRun: 1 event: 34864 at 15-Jan-2026 21:26:55 CET
Begin processing the 65th record. run: 1408 subRun: 1 event: 34865 at 15-Jan-2026 21:26:58 CET
Begin processing the 66th record. run: 1408 subRun: 1 event: 34866 at 15-Jan-2026 21:27:02 CET
Begin processing the 67th record. run: 1408 subRun: 1 event: 34867 at 15-Jan-2026 21:27:04 CET
Begin processing the 68th record. run: 1408 subRun: 1 event: 34868 at 15-Jan-2026 21:27:07 CET
Begin processing the 69th record. run: 1408 subRun: 1 event: 34869 at 15-Jan-2026 21:27:09 CET
Begin processing the 70th record. run: 1408 subRun: 1 event: 34870 at 15-Jan-2026 21:27:12 CET
Begin processing the 71st record. run: 1408 subRun: 1 event: 34871 at 15-Jan-2026 21:27:15 CET
Begin processing the 72nd record. run: 1408 subRun: 1 event: 34872 at 15-Jan-2026 21:27:18 CET
Begin processing the 73rd record. run: 1408 subRun: 1 event: 34873 at 15-Jan-2026 21:27:21 CET
Begin processing the 74th record. run: 1408 subRun: 1 event: 34874 at 15-Jan-2026 21:27:25 CET
Begin processing the 75th record. run: 1408 subRun: 1 event: 34875 at 15-Jan-2026 21:27:27 CET
Begin processing the 76th record. run: 1408 subRun: 1 event: 34876 at 15-Jan-2026 21:27:30 CET
Begin processing the 77th record. run: 1408 subRun: 1 event: 34877 at 15-Jan-2026 21:27:33 CET
Begin processing the 78th record. run: 1408 subRun: 1 event: 34878 at 15-Jan-2026 21:27:36 CET
Begin processing the 79th record. run: 1408 subRun: 1 event: 34879 at 15-Jan-2026 21:27:39 CET
Begin processing the 80th record. run: 1408 subRun: 1 event: 34880 at 15-Jan-2026 21:27:41 CET
Begin processing the 81st record. run: 1408 subRun: 1 event: 34881 at 15-Jan-2026 21:27:44 CET
Begin processing the 82nd record. run: 1408 subRun: 1 event: 34882 at 15-Jan-2026 21:27:46 CET
Begin processing the 83rd record. run: 1408 subRun: 1 event: 34883 at 15-Jan-2026 21:27:49 CET
Begin processing the 84th record. run: 1408 subRun: 1 event: 34884 at 15-Jan-2026 21:27:56 CET
Begin processing the 85th record. run: 1408 subRun: 1 event: 34885 at 15-Jan-2026 21:28:04 CET
Begin processing the 86th record. run: 1408 subRun: 1 event: 34886 at 15-Jan-2026 21:28:08 CET
Begin processing the 87th record. run: 1408 subRun: 1 event: 34887 at 15-Jan-2026 21:28:10 CET
Begin processing the 88th record. run: 1408 subRun: 1 event: 34888 at 15-Jan-2026 21:28:13 CET
Begin processing the 89th record. run: 1408 subRun: 1 event: 34889 at 15-Jan-2026 21:28:15 CET
Begin processing the 90th record. run: 1408 subRun: 1 event: 34890 at 15-Jan-2026 21:28:18 CET
Begin processing the 91st record. run: 1408 subRun: 1 event: 34891 at 15-Jan-2026 21:28:21 CET
Begin processing the 92nd record. run: 1408 subRun: 1 event: 34892 at 15-Jan-2026 21:28:24 CET
Begin processing the 93rd record. run: 1408 subRun: 1 event: 34893 at 15-Jan-2026 21:28:27 CET
Begin processing the 94th record. run: 1408 subRun: 1 event: 34894 at 15-Jan-2026 21:28:30 CET
Begin processing the 95th record. run: 1408 subRun: 1 event: 34895 at 15-Jan-2026 21:28:33 CET
Begin processing the 96th record. run: 1408 subRun: 1 event: 34896 at 15-Jan-2026 21:28:36 CET
Begin processing the 97th record. run: 1408 subRun: 1 event: 34897 at 15-Jan-2026 21:28:41 CET
Begin processing the 98th record. run: 1408 subRun: 1 event: 34898 at 15-Jan-2026 21:28:47 CET
Begin processing the 99th record. run: 1408 subRun: 1 event: 34899 at 15-Jan-2026 21:28:50 CET
Begin processing the 100th record. run: 1408 subRun: 1 event: 34900 at 15-Jan-2026 21:28:53 CET
15-Jan-2026 21:28:56 CET Closed output file "nu_dune10kt_1x2x6_1408_348_20230826T093326Z_gen_g4_detsim_hitreco__20240229T171130Z_reco2_reco2.root"
15-Jan-2026 21:28:56 CET Closed input file "root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/ff/32/nu_dune10kt_1x2x6_1408_348_20230826T093326Z_gen_g4_detsim_hitreco__20240229T171130Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.191486 3.60757 70.339 2.31248 7.40573 100
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.0384589 0.056925 0.120935 0.0555304 0.0148281 100
reco:pandora:StandardPandora 0.119614 3.54005 70.2403 2.24872 7.40067 100
[art]:TriggerResults:TriggerResultInserter 1.2859e-05 2.49507e-05 6.4988e-05 2.2494e-05 1.01047e-05 100
end_path:out1:RootOutput 2.955e-06 5.4764e-06 1.9059e-05 5.6835e-06 2.2173e-06 100
end_path:out1:RootOutput(write) 0.000898215 0.0103398 0.0599284 0.00724213 0.0102581 100
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 2244.68 MB
Peak resident set size usage (VmHWM): 1250.67 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===