Jobsub ID 241408.19@dunegpschedd01.fnal.gov
| Jobsub ID | 241408.19@dunegpschedd01.fnal.gov | 
| Workflow ID | 9495 | 
| Stage ID | 1 | 
| User name | imawby@fnal.gov | 
| HTCondor Group | group_dune | 
| Requested | Processors | 1 | 
| GPU | No | 
| RSS bytes | 1048576000 (1000 MiB) | 
| Wall seconds limit | 7200 (2 hours) | 
| Submitted time | 2025-10-31 13:49:03 | 
| Site | US_PuertoRico | 
| Entry | CMS_T3_US_PuertoRico_UPRM | 
| Last heartbeat | 2025-10-31 14:21:10 | 
| From worker node | Hostname | sandy-0-2.local | 
| cpuinfo | Intel(R) Xeon(R) CPU E5-1620 0 @ 3.60GHz | 
| OS release | Scientific Linux release 7.9 (Nitrogen) | 
| Processors | 1 | 
| RSS bytes | 1048576000 (1000 MiB) | 
| Wall seconds limit | 171000 (47 hours) | 
| GPU |  | 
| Inner Apptainer? | True | 
| Job state | finished | 
| Started | 2025-10-31 13:55:01 | 
| Input files | fardet-hd:nu_dune10kt_1x2x6_1109_980_20230827T004354Z_gen_g4_detsim_hitreco__20240222T233439Z_reco2.root
  | 
| Jobscript | Exit code | 0 | 
| Real time | 25m (1544s) | 
| CPU time | 13m (802s = 51%) | 
| Max RSS bytes | 1077747712 (1027 MiB) | 
| Outputting started | 2025-10-31 14:20:45 | 
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09495/1/001/ClusterValidation_WithAlg_nu_dune10kt_1x2x6_1109_980_20230827T004354Z_gen_g4_detsim_hitreco__20240222T233439Z_reco2.root
  | 
| Finished | 2025-10-31 14:21:10 | 
| Saved logs | justin-logs:241408.19-dunegpschedd01.fnal.gov.logs.tgz | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
-
---------------------------------------------------------
Input PFN = root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/ff/4c/nu_dune10kt_1x2x6_1109_980_20230827T004354Z_gen_g4_detsim_hitreco__20240222T233439Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 33rd record. run: 1109 subRun: 1 event: 98033 at 31-Oct-2025 10:10:05 AST
Begin processing the 34th record. run: 1109 subRun: 1 event: 98034 at 31-Oct-2025 10:10:27 AST
Begin processing the 35th record. run: 1109 subRun: 1 event: 98035 at 31-Oct-2025 10:10:55 AST
Begin processing the 36th record. run: 1109 subRun: 1 event: 98036 at 31-Oct-2025 10:11:03 AST
Begin processing the 37th record. run: 1109 subRun: 1 event: 98037 at 31-Oct-2025 10:11:40 AST
Begin processing the 38th record. run: 1109 subRun: 1 event: 98038 at 31-Oct-2025 10:11:47 AST
Begin processing the 39th record. run: 1109 subRun: 1 event: 98039 at 31-Oct-2025 10:11:54 AST
PandoraContentApi::GetList(*this, m_inputHitListName, pCaloHitList) return STATUS_CODE_NOT_INITIALIZED
    in function: GetVolumeIdToHitListMap
    in file:     /exp/dune/app/users/imawby/dunesw_splitting/srcs/larpandoracontent/larpandoracontent/LArControlFlow/MasterAlgorithm.cc line#: 271
this->GetVolumeIdToHitListMap(volumeIdToHitListMap) return STATUS_CODE_NOT_INITIALIZED
    in function: Run
    in file:     /exp/dune/app/users/imawby/dunesw_splitting/srcs/larpandoracontent/larpandoracontent/LArControlFlow/MasterAlgorithm.cc line#: 165
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, LArDLMaster, STATUS_CODE_NOT_INITIALIZED
Begin processing the 40th record. run: 1109 subRun: 1 event: 98040 at 31-Oct-2025 10:11:57 AST
Begin processing the 41st record. run: 1109 subRun: 1 event: 98041 at 31-Oct-2025 10:12:05 AST
Begin processing the 42nd record. run: 1109 subRun: 1 event: 98042 at 31-Oct-2025 10:12:12 AST
Begin processing the 43rd record. run: 1109 subRun: 1 event: 98043 at 31-Oct-2025 10:12:19 AST
Begin processing the 44th record. run: 1109 subRun: 1 event: 98044 at 31-Oct-2025 10:12:28 AST
Begin processing the 45th record. run: 1109 subRun: 1 event: 98045 at 31-Oct-2025 10:12:36 AST
Begin processing the 46th record. run: 1109 subRun: 1 event: 98046 at 31-Oct-2025 10:12:45 AST
Begin processing the 47th record. run: 1109 subRun: 1 event: 98047 at 31-Oct-2025 10:12:52 AST
Begin processing the 48th record. run: 1109 subRun: 1 event: 98048 at 31-Oct-2025 10:13:02 AST
Begin processing the 49th record. run: 1109 subRun: 1 event: 98049 at 31-Oct-2025 10:13:09 AST
Begin processing the 50th record. run: 1109 subRun: 1 event: 98050 at 31-Oct-2025 10:13:16 AST
Begin processing the 51st record. run: 1109 subRun: 1 event: 98051 at 31-Oct-2025 10:13:23 AST
Begin processing the 52nd record. run: 1109 subRun: 1 event: 98052 at 31-Oct-2025 10:13:31 AST
Begin processing the 53rd record. run: 1109 subRun: 1 event: 98053 at 31-Oct-2025 10:13:40 AST
Begin processing the 54th record. run: 1109 subRun: 1 event: 98054 at 31-Oct-2025 10:13:49 AST
Begin processing the 55th record. run: 1109 subRun: 1 event: 98055 at 31-Oct-2025 10:13:56 AST
Begin processing the 56th record. run: 1109 subRun: 1 event: 98056 at 31-Oct-2025 10:14:07 AST
Begin processing the 57th record. run: 1109 subRun: 1 event: 98057 at 31-Oct-2025 10:14:13 AST
Begin processing the 58th record. run: 1109 subRun: 1 event: 98058 at 31-Oct-2025 10:14:25 AST
Begin processing the 59th record. run: 1109 subRun: 1 event: 98059 at 31-Oct-2025 10:14:31 AST
Begin processing the 60th record. run: 1109 subRun: 1 event: 98060 at 31-Oct-2025 10:14:39 AST
Begin processing the 61st record. run: 1109 subRun: 1 event: 98061 at 31-Oct-2025 10:14:46 AST
Begin processing the 62nd record. run: 1109 subRun: 1 event: 98062 at 31-Oct-2025 10:14:53 AST
Begin processing the 63rd record. run: 1109 subRun: 1 event: 98063 at 31-Oct-2025 10:15:00 AST
Begin processing the 64th record. run: 1109 subRun: 1 event: 98064 at 31-Oct-2025 10:15:09 AST
Begin processing the 65th record. run: 1109 subRun: 1 event: 98065 at 31-Oct-2025 10:15:15 AST
Begin processing the 66th record. run: 1109 subRun: 1 event: 98066 at 31-Oct-2025 10:15:23 AST
Begin processing the 67th record. run: 1109 subRun: 1 event: 98067 at 31-Oct-2025 10:15:34 AST
Begin processing the 68th record. run: 1109 subRun: 1 event: 98068 at 31-Oct-2025 10:15:59 AST
Begin processing the 69th record. run: 1109 subRun: 1 event: 98069 at 31-Oct-2025 10:16:06 AST
Begin processing the 70th record. run: 1109 subRun: 1 event: 98070 at 31-Oct-2025 10:16:16 AST
Begin processing the 71st record. run: 1109 subRun: 1 event: 98071 at 31-Oct-2025 10:16:23 AST
Begin processing the 72nd record. run: 1109 subRun: 1 event: 98072 at 31-Oct-2025 10:16:31 AST
Begin processing the 73rd record. run: 1109 subRun: 1 event: 98073 at 31-Oct-2025 10:16:38 AST
Begin processing the 74th record. run: 1109 subRun: 1 event: 98074 at 31-Oct-2025 10:16:49 AST
Begin processing the 75th record. run: 1109 subRun: 1 event: 98075 at 31-Oct-2025 10:16:57 AST
Begin processing the 76th record. run: 1109 subRun: 1 event: 98076 at 31-Oct-2025 10:17:08 AST
Begin processing the 77th record. run: 1109 subRun: 1 event: 98077 at 31-Oct-2025 10:17:15 AST
Begin processing the 78th record. run: 1109 subRun: 1 event: 98078 at 31-Oct-2025 10:17:23 AST
Begin processing the 79th record. run: 1109 subRun: 1 event: 98079 at 31-Oct-2025 10:17:31 AST
Begin processing the 80th record. run: 1109 subRun: 1 event: 98080 at 31-Oct-2025 10:17:42 AST
Begin processing the 81st record. run: 1109 subRun: 1 event: 98081 at 31-Oct-2025 10:17:50 AST
Begin processing the 82nd record. run: 1109 subRun: 1 event: 98082 at 31-Oct-2025 10:17:57 AST
Begin processing the 83rd record. run: 1109 subRun: 1 event: 98083 at 31-Oct-2025 10:18:04 AST
Begin processing the 84th record. run: 1109 subRun: 1 event: 98084 at 31-Oct-2025 10:18:16 AST
Begin processing the 85th record. run: 1109 subRun: 1 event: 98085 at 31-Oct-2025 10:18:24 AST
Begin processing the 86th record. run: 1109 subRun: 1 event: 98086 at 31-Oct-2025 10:18:31 AST
Begin processing the 87th record. run: 1109 subRun: 1 event: 98087 at 31-Oct-2025 10:18:40 AST
Begin processing the 88th record. run: 1109 subRun: 1 event: 98088 at 31-Oct-2025 10:18:48 AST
Begin processing the 89th record. run: 1109 subRun: 1 event: 98089 at 31-Oct-2025 10:18:56 AST
Begin processing the 90th record. run: 1109 subRun: 1 event: 98090 at 31-Oct-2025 10:19:05 AST
Begin processing the 91st record. run: 1109 subRun: 1 event: 98091 at 31-Oct-2025 10:19:13 AST
Begin processing the 92nd record. run: 1109 subRun: 1 event: 98092 at 31-Oct-2025 10:19:20 AST
Begin processing the 93rd record. run: 1109 subRun: 1 event: 98093 at 31-Oct-2025 10:19:28 AST
Begin processing the 94th record. run: 1109 subRun: 1 event: 98094 at 31-Oct-2025 10:19:37 AST
Begin processing the 95th record. run: 1109 subRun: 1 event: 98095 at 31-Oct-2025 10:19:47 AST
Begin processing the 96th record. run: 1109 subRun: 1 event: 98096 at 31-Oct-2025 10:19:55 AST
Begin processing the 97th record. run: 1109 subRun: 1 event: 98097 at 31-Oct-2025 10:20:02 AST
Begin processing the 98th record. run: 1109 subRun: 1 event: 98098 at 31-Oct-2025 10:20:09 AST
Begin processing the 99th record. run: 1109 subRun: 1 event: 98099 at 31-Oct-2025 10:20:18 AST
Begin processing the 100th record. run: 1109 subRun: 1 event: 98100 at 31-Oct-2025 10:20:26 AST
31-Oct-2025 10:20:41 AST  Closed output file "nu_dune10kt_1x2x6_1109_980_20230827T004354Z_gen_g4_detsim_hitreco__20240222T233439Z_reco2_reco2.root"
31-Oct-2025 10:20:41 AST  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/ff/4c/nu_dune10kt_1x2x6_1109_980_20230827T004354Z_gen_g4_detsim_hitreco__20240222T233439Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.728561       7.94719       41.6204       6.19066       5.83612        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0893065     0.173908      0.249874      0.171622      0.0165437       100    
reco:pandora:StandardPandora                   0.558286       7.75557       41.2763       6.00456       5.81421        100    
[art]:TriggerResults:TriggerResultInserter    2.1755e-05    7.26914e-05   0.00114071    2.7587e-05    0.000158282      100    
end_path:out1:RootOutput                       3.025e-06    3.92336e-06   3.7304e-05    3.4005e-06    3.74146e-06      100    
end_path:out1:RootOutput(write)               0.00190259     0.0174143     0.254101     0.00894699     0.0284649       100    
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 2333.34 MB
  Peak resident set size usage (VmHWM): 1077.75 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
mv: cannot stat 'ClusterValidation_WithoutAlg.root': No such file or directory