Jobsub ID 242636.0@dunegpschedd01.fnal.gov
| Jobsub ID | 242636.0@dunegpschedd01.fnal.gov | 
| Workflow ID | 9557 | 
| Stage ID | 1 | 
| User name | imawby@fnal.gov | 
| HTCondor Group | group_dune | 
| Requested | Processors | 1 | 
| GPU | No | 
| RSS bytes | 4194304000 (4000 MiB) | 
| Wall seconds limit | 43200 (12 hours) | 
| Submitted time | 2025-11-03 20:55:16 | 
| Site | US_UChicago | 
| Entry | Engage_US_MWT2_uct2_condce_mcore | 
| Last heartbeat | 2025-11-03 21:04:55 | 
| From worker node | Hostname | mwt2-c059.campuscluster.illinois.edu | 
| cpuinfo | AMD EPYC 7443 24-Core Processor | 
| OS release | Scientific Linux release 7.9 (Nitrogen) | 
| Processors | 1 | 
| RSS bytes | 4194304000 (4000 MiB) | 
| Wall seconds limit | 86400 (24 hours) | 
| GPU |  | 
| Inner Apptainer? | True | 
| Job state | finished | 
| Started | 2025-11-03 20:58:50 | 
| Input files | fardet-hd:nu_dune10kt_1x2x6_1434_82_20230828T093309Z_gen_g4_detsim_hitreco__20240223T001138Z_reco2.root
  | 
| Jobscript | Exit code | 0 | 
| Real time | 5m (348s) | 
| CPU time | 4m (267s = 76%) | 
| Max RSS bytes | 1247645696 (1189 MiB) | 
| Outputting started | 2025-11-03 21:04:38 | 
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/splitting_nu_2/fnal/09557/1/001/CheatingKalmanSplittingU_nu_dune10kt_1x2x6_1434_82_20230828T093309Z_gen_g4_detsim_hitreco__20240223T001138Z_reco2.root
  | 
| Finished | 2025-11-03 21:04:55 | 
| Saved logs | justin-logs:242636.0-dunegpschedd01.fnal.gov.logs.tgz | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
------- this block should be empty ------------------
---------------------------------------------------------
Input PFN = root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/dd/2c/nu_dune10kt_1x2x6_1434_82_20230828T093309Z_gen_g4_detsim_hitreco__20240223T001138Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 48th record. run: 1434 subRun: 1 event: 8248 at 03-Nov-2025 15:02:37 CST
Begin processing the 49th record. run: 1434 subRun: 1 event: 8249 at 03-Nov-2025 15:02:39 CST
Begin processing the 50th record. run: 1434 subRun: 1 event: 8250 at 03-Nov-2025 15:02:42 CST
Begin processing the 51st record. run: 1434 subRun: 1 event: 8251 at 03-Nov-2025 15:02:45 CST
Begin processing the 52nd record. run: 1434 subRun: 1 event: 8252 at 03-Nov-2025 15:02:47 CST
Begin processing the 53rd record. run: 1434 subRun: 1 event: 8253 at 03-Nov-2025 15:02:49 CST
Begin processing the 54th record. run: 1434 subRun: 1 event: 8254 at 03-Nov-2025 15:02:52 CST
Begin processing the 55th record. run: 1434 subRun: 1 event: 8255 at 03-Nov-2025 15:02:54 CST
Begin processing the 56th record. run: 1434 subRun: 1 event: 8256 at 03-Nov-2025 15:02:56 CST
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
Begin processing the 57th record. run: 1434 subRun: 1 event: 8257 at 03-Nov-2025 15:02:56 CST
Begin processing the 58th record. run: 1434 subRun: 1 event: 8258 at 03-Nov-2025 15:02:58 CST
Begin processing the 59th record. run: 1434 subRun: 1 event: 8259 at 03-Nov-2025 15:03:00 CST
Begin processing the 60th record. run: 1434 subRun: 1 event: 8260 at 03-Nov-2025 15:03:03 CST
Begin processing the 61st record. run: 1434 subRun: 1 event: 8261 at 03-Nov-2025 15:03:05 CST
Begin processing the 62nd record. run: 1434 subRun: 1 event: 8262 at 03-Nov-2025 15:03:07 CST
Begin processing the 63rd record. run: 1434 subRun: 1 event: 8263 at 03-Nov-2025 15:03:10 CST
Begin processing the 64th record. run: 1434 subRun: 1 event: 8264 at 03-Nov-2025 15:03:12 CST
Begin processing the 65th record. run: 1434 subRun: 1 event: 8265 at 03-Nov-2025 15:03:15 CST
Begin processing the 66th record. run: 1434 subRun: 1 event: 8266 at 03-Nov-2025 15:03:17 CST
Begin processing the 67th record. run: 1434 subRun: 1 event: 8267 at 03-Nov-2025 15:03:19 CST
Begin processing the 68th record. run: 1434 subRun: 1 event: 8268 at 03-Nov-2025 15:03:21 CST
Begin processing the 69th record. run: 1434 subRun: 1 event: 8269 at 03-Nov-2025 15:03:24 CST
Begin processing the 70th record. run: 1434 subRun: 1 event: 8270 at 03-Nov-2025 15:03:27 CST
Begin processing the 71st record. run: 1434 subRun: 1 event: 8271 at 03-Nov-2025 15:03:31 CST
Begin processing the 72nd record. run: 1434 subRun: 1 event: 8272 at 03-Nov-2025 15:03:33 CST
Begin processing the 73rd record. run: 1434 subRun: 1 event: 8273 at 03-Nov-2025 15:03:35 CST
Begin processing the 74th record. run: 1434 subRun: 1 event: 8274 at 03-Nov-2025 15:03:37 CST
Begin processing the 75th record. run: 1434 subRun: 1 event: 8275 at 03-Nov-2025 15:03:39 CST
Begin processing the 76th record. run: 1434 subRun: 1 event: 8276 at 03-Nov-2025 15:03:42 CST
Begin processing the 77th record. run: 1434 subRun: 1 event: 8277 at 03-Nov-2025 15:03:44 CST
Begin processing the 78th record. run: 1434 subRun: 1 event: 8278 at 03-Nov-2025 15:03:46 CST
Begin processing the 79th record. run: 1434 subRun: 1 event: 8279 at 03-Nov-2025 15:03:49 CST
Begin processing the 80th record. run: 1434 subRun: 1 event: 8280 at 03-Nov-2025 15:03:51 CST
Begin processing the 81st record. run: 1434 subRun: 1 event: 8281 at 03-Nov-2025 15:03:53 CST
Begin processing the 82nd record. run: 1434 subRun: 1 event: 8282 at 03-Nov-2025 15:03:56 CST
Begin processing the 83rd record. run: 1434 subRun: 1 event: 8283 at 03-Nov-2025 15:03:58 CST
Begin processing the 84th record. run: 1434 subRun: 1 event: 8284 at 03-Nov-2025 15:04:00 CST
Begin processing the 85th record. run: 1434 subRun: 1 event: 8285 at 03-Nov-2025 15:04:03 CST
Begin processing the 86th record. run: 1434 subRun: 1 event: 8286 at 03-Nov-2025 15:04:05 CST
Begin processing the 87th record. run: 1434 subRun: 1 event: 8287 at 03-Nov-2025 15:04:07 CST
Begin processing the 88th record. run: 1434 subRun: 1 event: 8288 at 03-Nov-2025 15:04:09 CST
Begin processing the 89th record. run: 1434 subRun: 1 event: 8289 at 03-Nov-2025 15:04:11 CST
Begin processing the 90th record. run: 1434 subRun: 1 event: 8290 at 03-Nov-2025 15:04:14 CST
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 91st record. run: 1434 subRun: 1 event: 8291 at 03-Nov-2025 15:04:15 CST
Begin processing the 92nd record. run: 1434 subRun: 1 event: 8292 at 03-Nov-2025 15:04:17 CST
Begin processing the 93rd record. run: 1434 subRun: 1 event: 8293 at 03-Nov-2025 15:04:18 CST
Begin processing the 94th record. run: 1434 subRun: 1 event: 8294 at 03-Nov-2025 15:04:21 CST
Begin processing the 95th record. run: 1434 subRun: 1 event: 8295 at 03-Nov-2025 15:04:23 CST
Begin processing the 96th record. run: 1434 subRun: 1 event: 8296 at 03-Nov-2025 15:04:25 CST
Begin processing the 97th record. run: 1434 subRun: 1 event: 8297 at 03-Nov-2025 15:04:28 CST
Begin processing the 98th record. run: 1434 subRun: 1 event: 8298 at 03-Nov-2025 15:04:30 CST
Begin processing the 99th record. run: 1434 subRun: 1 event: 8299 at 03-Nov-2025 15:04:32 CST
Begin processing the 100th record. run: 1434 subRun: 1 event: 8300 at 03-Nov-2025 15:04:34 CST
03-Nov-2025 15:04:37 CST  Closed output file "nu_dune10kt_1x2x6_1434_82_20230828T093309Z_gen_g4_detsim_hitreco__20240223T001138Z_reco2_reco2.root"
03-Nov-2025 15:04:37 CST  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/dd/2c/nu_dune10kt_1x2x6_1434_82_20230828T093309Z_gen_g4_detsim_hitreco__20240223T001138Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0879297      2.16605       6.00514       2.06872      0.634015        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0158791     0.0406353     0.0781309     0.0393677     0.0114996       100    
reco:pandora:StandardPandora                   0.0576383      2.12104       5.97794       2.01882      0.633793        100    
[art]:TriggerResults:TriggerResultInserter    1.2223e-05    2.21642e-05   6.1124e-05    1.97925e-05   9.07579e-06      100    
end_path:out1:RootOutput                       2.785e-06    6.61401e-06    2.13e-05     6.6425e-06    2.70521e-06      100    
end_path:out1:RootOutput(write)               0.00101022    0.00412823     0.0133156    0.00303623    0.00267769       100    
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 2251.21 MB
  Peak resident set size usage (VmHWM): 1245.46 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
mv: cannot stat 'CheatingKalmanSplittingV.root': No such file or directory
mv: cannot stat 'CheatingKalmanSplittingW.root': No such file or directory