Jobsub ID 262043.12@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
0da6/localProducts_larsoft_v10_08_00_e26_prof
----------- this block should be empty ------------------
---------------------------------------------------------
Input PFN = root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/ae/7a/nu_dune10kt_1x2x6_1427_948_20230827T213419Z_gen_g4_detsim_hitreco__20240222T222635Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 41st record. run: 1427 subRun: 1 event: 94841 at 02-Dec-2025 04:58:13 EST
Begin processing the 42nd record. run: 1427 subRun: 1 event: 94842 at 02-Dec-2025 04:58:15 EST
Begin processing the 43rd record. run: 1427 subRun: 1 event: 94843 at 02-Dec-2025 04:58:18 EST
Begin processing the 44th record. run: 1427 subRun: 1 event: 94844 at 02-Dec-2025 04:58:23 EST
Begin processing the 45th record. run: 1427 subRun: 1 event: 94845 at 02-Dec-2025 04:58:30 EST
Begin processing the 46th record. run: 1427 subRun: 1 event: 94846 at 02-Dec-2025 04:58:33 EST
Begin processing the 47th record. run: 1427 subRun: 1 event: 94847 at 02-Dec-2025 04:58:36 EST
Begin processing the 48th record. run: 1427 subRun: 1 event: 94848 at 02-Dec-2025 04:58:42 EST
Begin processing the 49th record. run: 1427 subRun: 1 event: 94849 at 02-Dec-2025 04:58:46 EST
Begin processing the 50th record. run: 1427 subRun: 1 event: 94850 at 02-Dec-2025 04:58:52 EST
Begin processing the 51st record. run: 1427 subRun: 1 event: 94851 at 02-Dec-2025 04:58:55 EST
Begin processing the 52nd record. run: 1427 subRun: 1 event: 94852 at 02-Dec-2025 04:58:58 EST
Begin processing the 53rd record. run: 1427 subRun: 1 event: 94853 at 02-Dec-2025 04:59:01 EST
Begin processing the 54th record. run: 1427 subRun: 1 event: 94854 at 02-Dec-2025 04:59:03 EST
Begin processing the 55th record. run: 1427 subRun: 1 event: 94855 at 02-Dec-2025 04:59:06 EST
Begin processing the 56th record. run: 1427 subRun: 1 event: 94856 at 02-Dec-2025 04:59:10 EST
Begin processing the 57th record. run: 1427 subRun: 1 event: 94857 at 02-Dec-2025 04:59:15 EST
Begin processing the 58th record. run: 1427 subRun: 1 event: 94858 at 02-Dec-2025 04:59:18 EST
Begin processing the 59th record. run: 1427 subRun: 1 event: 94859 at 02-Dec-2025 04:59:20 EST
Begin processing the 60th record. run: 1427 subRun: 1 event: 94860 at 02-Dec-2025 04:59:25 EST
Begin processing the 61st record. run: 1427 subRun: 1 event: 94861 at 02-Dec-2025 04:59:29 EST
Begin processing the 62nd record. run: 1427 subRun: 1 event: 94862 at 02-Dec-2025 04:59:34 EST
Begin processing the 63rd record. run: 1427 subRun: 1 event: 94863 at 02-Dec-2025 04:59:38 EST
Begin processing the 64th record. run: 1427 subRun: 1 event: 94864 at 02-Dec-2025 04:59:58 EST
Begin processing the 65th record. run: 1427 subRun: 1 event: 94865 at 02-Dec-2025 05:00:02 EST
Begin processing the 66th record. run: 1427 subRun: 1 event: 94866 at 02-Dec-2025 05:00:05 EST
Begin processing the 67th record. run: 1427 subRun: 1 event: 94867 at 02-Dec-2025 05:00:08 EST
Begin processing the 68th record. run: 1427 subRun: 1 event: 94868 at 02-Dec-2025 05:00:13 EST
Begin processing the 69th record. run: 1427 subRun: 1 event: 94869 at 02-Dec-2025 05:00:16 EST
Begin processing the 70th record. run: 1427 subRun: 1 event: 94870 at 02-Dec-2025 05:00:19 EST
Begin processing the 71st record. run: 1427 subRun: 1 event: 94871 at 02-Dec-2025 05:00:22 EST
Begin processing the 72nd record. run: 1427 subRun: 1 event: 94872 at 02-Dec-2025 05:00:28 EST
Begin processing the 73rd record. run: 1427 subRun: 1 event: 94873 at 02-Dec-2025 05:00:32 EST
Begin processing the 74th record. run: 1427 subRun: 1 event: 94874 at 02-Dec-2025 05:00:35 EST
Begin processing the 75th record. run: 1427 subRun: 1 event: 94875 at 02-Dec-2025 05:00:39 EST
Begin processing the 76th record. run: 1427 subRun: 1 event: 94876 at 02-Dec-2025 05:00:42 EST
PandoraContentApi::GetList(*this, listname, pCaloHitList) return STATUS_CODE_NOT_INITIALIZED
in function: Infer
in file: /exp/dune/app/users/imawby/dunesw_splitting/srcs/larpandoracontent/larpandoradlcontent/LArVertex/DlVertexingAlgorithm.cc line#: 192
iter->second->Run() throw STATUS_CODE_NOT_INITIALIZED
in function: RunAlgorithm
in file: /scratch/workspace/build-larbase/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/SLF7/build/pandora/v03_16_00l/src/pandora-v03-16-00/PandoraSDK-v03-04-01/src/Api/PandoraContentApiImpl.cc line#: 235
Failure in algorithm Alg0002, LArDLVertexing, STATUS_CODE_NOT_INITIALIZED
DLVertexing: Input vertex list is empty! Can't perform pass 2
PandoraContentApi::GetList(*this, listname, pCaloHitList) return STATUS_CODE_NOT_INITIALIZED
in function: Infer
in file: /exp/dune/app/users/imawby/dunesw_splitting/srcs/larpandoracontent/larpandoradlcontent/LArVertex/DlSecondaryVertexingAlgorithm.cc line#: 186
iter->second->Run() throw STATUS_CODE_NOT_INITIALIZED
in function: RunAlgorithm
in file: /scratch/workspace/build-larbase/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/SLF7/build/pandora/v03_16_00l/src/pandora-v03-16-00/PandoraSDK-v03-04-01/src/Api/PandoraContentApiImpl.cc line#: 235
Failure in algorithm Alg0004, LArDLSecondaryVertexing, STATUS_CODE_NOT_INITIALIZED
PandoraContentApi::GetList(*this, m_caloHitListNameU, m_pCaloHitListU) return STATUS_CODE_NOT_INITIALIZED
in function: GetLists
in file: /exp/dune/app/users/imawby/dunesw_splitting/srcs/larpandoracontent/larpandoradlcontent/LArTwoDReco/DLThreeDClusterSplittingAlgorithm.cc line#: 201
Begin processing the 77th record. run: 1427 subRun: 1 event: 94877 at 02-Dec-2025 05:00:43 EST
Begin processing the 78th record. run: 1427 subRun: 1 event: 94878 at 02-Dec-2025 05:02:33 EST
Begin processing the 79th record. run: 1427 subRun: 1 event: 94879 at 02-Dec-2025 05:02:37 EST
Begin processing the 80th record. run: 1427 subRun: 1 event: 94880 at 02-Dec-2025 05:02:40 EST
Begin processing the 81st record. run: 1427 subRun: 1 event: 94881 at 02-Dec-2025 05:02:44 EST
Begin processing the 82nd record. run: 1427 subRun: 1 event: 94882 at 02-Dec-2025 05:02:48 EST
Begin processing the 83rd record. run: 1427 subRun: 1 event: 94883 at 02-Dec-2025 05:02:51 EST
Begin processing the 84th record. run: 1427 subRun: 1 event: 94884 at 02-Dec-2025 05:02:58 EST
Begin processing the 85th record. run: 1427 subRun: 1 event: 94885 at 02-Dec-2025 05:03:01 EST
Begin processing the 86th record. run: 1427 subRun: 1 event: 94886 at 02-Dec-2025 05:03:04 EST
Begin processing the 87th record. run: 1427 subRun: 1 event: 94887 at 02-Dec-2025 05:03:08 EST
Begin processing the 88th record. run: 1427 subRun: 1 event: 94888 at 02-Dec-2025 05:03:11 EST
Begin processing the 89th record. run: 1427 subRun: 1 event: 94889 at 02-Dec-2025 05:03:14 EST
Begin processing the 90th record. run: 1427 subRun: 1 event: 94890 at 02-Dec-2025 05:03:17 EST
Begin processing the 91st record. run: 1427 subRun: 1 event: 94891 at 02-Dec-2025 05:03:45 EST
Begin processing the 92nd record. run: 1427 subRun: 1 event: 94892 at 02-Dec-2025 05:03:49 EST
Begin processing the 93rd record. run: 1427 subRun: 1 event: 94893 at 02-Dec-2025 05:03:52 EST
Begin processing the 94th record. run: 1427 subRun: 1 event: 94894 at 02-Dec-2025 05:03:58 EST
Begin processing the 95th record. run: 1427 subRun: 1 event: 94895 at 02-Dec-2025 05:04:01 EST
Begin processing the 96th record. run: 1427 subRun: 1 event: 94896 at 02-Dec-2025 05:04:05 EST
Begin processing the 97th record. run: 1427 subRun: 1 event: 94897 at 02-Dec-2025 05:04:09 EST
Begin processing the 98th record. run: 1427 subRun: 1 event: 94898 at 02-Dec-2025 05:04:12 EST
Begin processing the 99th record. run: 1427 subRun: 1 event: 94899 at 02-Dec-2025 05:04:14 EST
Begin processing the 100th record. run: 1427 subRun: 1 event: 94900 at 02-Dec-2025 05:04:17 EST
02-Dec-2025 05:04:22 EST Closed output file "nu_dune10kt_1x2x6_1427_948_20230827T213419Z_gen_g4_detsim_hitreco__20240222T222635Z_reco2_reco2.root"
02-Dec-2025 05:04:22 EST Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/ae/7a/nu_dune10kt_1x2x6_1427_948_20230827T213419Z_gen_g4_detsim_hitreco__20240222T222635Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.161765 6.9702 156.777 3.24283 18.7896 100
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.0166557 0.0355915 0.0838862 0.033813 0.0106114 100
reco:pandora:StandardPandora 0.124145 6.91467 156.497 3.19102 18.7629 100
[art]:TriggerResults:TriggerResultInserter 1.4597e-05 3.36136e-05 0.000182633 2.78275e-05 2.37141e-05 100
end_path:out1:RootOutput 3.357e-06 5.7241e-06 2.619e-05 5.24e-06 3.01268e-06 100
end_path:out1:RootOutput(write) 0.0023298 0.0195363 0.1956 0.0121916 0.0252144 100
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 2553.89 MB
Peak resident set size usage (VmHWM): 1554.12 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===