justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 242416.5@dunegpschedd01.fnal.gov

Jobsub ID242416.5@dunegpschedd01.fnal.gov
Workflow ID9556
Stage ID1
User nameimawby@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit43200 (12 hours)
Submitted time2025-11-03 16:45:05
SiteNL_SURFsara
EntryDUNE_SurfSARA_arc01
Last heartbeat2025-11-03 17:19:37
From worker nodeHostnamewn-lb-02.gina.surf.nl
cpuinfoAMD EPYC 9754 128-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit129600 (36 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-11-03 17:12:04
Input filesfardet-hd:nu_dune10kt_1x2x6_1098_561_20230826T013155Z_gen_g4_detsim_hitreco__20240229T165725Z_reco2.root
JobscriptExit code0
Real time6m (417s)
CPU time6m (402s = 96%)
Max RSS bytes1317343232 (1256 MiB)
Outputting started2025-11-03 17:19:02
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/splitting_nu_1/fnal/09556/1/001/CheatingKalmanSplittingU_nu_dune10kt_1x2x6_1098_561_20230826T013155Z_gen_g4_detsim_hitreco__20240229T165725Z_reco2.root
Finished2025-11-03 17:19:37
Saved logsjustin-logs:242416.5-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

------------
Input PFN = root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/55/eb/nu_dune10kt_1x2x6_1098_561_20230826T013155Z_gen_g4_detsim_hitreco__20240229T165725Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Failure in algorithm Alg0002, LArDLMaster, STATUS_CODE_NOT_INITIALIZED
Begin processing the 34th record. run: 1098 subRun: 1 event: 56134 at 03-Nov-2025 18:15:06 CET
Begin processing the 35th record. run: 1098 subRun: 1 event: 56135 at 03-Nov-2025 18:15:09 CET
Begin processing the 36th record. run: 1098 subRun: 1 event: 56136 at 03-Nov-2025 18:15:13 CET
Begin processing the 37th record. run: 1098 subRun: 1 event: 56137 at 03-Nov-2025 18:15:16 CET
Begin processing the 38th record. run: 1098 subRun: 1 event: 56138 at 03-Nov-2025 18:15:20 CET
Begin processing the 39th record. run: 1098 subRun: 1 event: 56139 at 03-Nov-2025 18:15:23 CET
Begin processing the 40th record. run: 1098 subRun: 1 event: 56140 at 03-Nov-2025 18:15:26 CET
Begin processing the 41st record. run: 1098 subRun: 1 event: 56141 at 03-Nov-2025 18:15:29 CET
Begin processing the 42nd record. run: 1098 subRun: 1 event: 56142 at 03-Nov-2025 18:15:32 CET
Begin processing the 43rd record. run: 1098 subRun: 1 event: 56143 at 03-Nov-2025 18:15:36 CET
Begin processing the 44th record. run: 1098 subRun: 1 event: 56144 at 03-Nov-2025 18:15:40 CET
Begin processing the 45th record. run: 1098 subRun: 1 event: 56145 at 03-Nov-2025 18:15:43 CET
Begin processing the 46th record. run: 1098 subRun: 1 event: 56146 at 03-Nov-2025 18:15:47 CET
Begin processing the 47th record. run: 1098 subRun: 1 event: 56147 at 03-Nov-2025 18:15:50 CET
Begin processing the 48th record. run: 1098 subRun: 1 event: 56148 at 03-Nov-2025 18:15:54 CET
Begin processing the 49th record. run: 1098 subRun: 1 event: 56149 at 03-Nov-2025 18:15:57 CET
Begin processing the 50th record. run: 1098 subRun: 1 event: 56150 at 03-Nov-2025 18:16:01 CET
Begin processing the 51st record. run: 1098 subRun: 1 event: 56151 at 03-Nov-2025 18:16:04 CET
Begin processing the 52nd record. run: 1098 subRun: 1 event: 56152 at 03-Nov-2025 18:16:08 CET
Begin processing the 53rd record. run: 1098 subRun: 1 event: 56153 at 03-Nov-2025 18:16:11 CET
Begin processing the 54th record. run: 1098 subRun: 1 event: 56154 at 03-Nov-2025 18:16:17 CET
Begin processing the 55th record. run: 1098 subRun: 1 event: 56155 at 03-Nov-2025 18:16:21 CET
Begin processing the 56th record. run: 1098 subRun: 1 event: 56156 at 03-Nov-2025 18:16:24 CET
Begin processing the 57th record. run: 1098 subRun: 1 event: 56157 at 03-Nov-2025 18:16:28 CET
Begin processing the 58th record. run: 1098 subRun: 1 event: 56158 at 03-Nov-2025 18:16:32 CET
Begin processing the 59th record. run: 1098 subRun: 1 event: 56159 at 03-Nov-2025 18:16:35 CET
Begin processing the 60th record. run: 1098 subRun: 1 event: 56160 at 03-Nov-2025 18:16:39 CET
Begin processing the 61st record. run: 1098 subRun: 1 event: 56161 at 03-Nov-2025 18:16:42 CET
Begin processing the 62nd record. run: 1098 subRun: 1 event: 56162 at 03-Nov-2025 18:16:45 CET
Begin processing the 63rd record. run: 1098 subRun: 1 event: 56163 at 03-Nov-2025 18:16:48 CET
Begin processing the 64th record. run: 1098 subRun: 1 event: 56164 at 03-Nov-2025 18:16:52 CET
Begin processing the 65th record. run: 1098 subRun: 1 event: 56165 at 03-Nov-2025 18:16:55 CET
Begin processing the 66th record. run: 1098 subRun: 1 event: 56166 at 03-Nov-2025 18:16:58 CET
Begin processing the 67th record. run: 1098 subRun: 1 event: 56167 at 03-Nov-2025 18:17:02 CET
Begin processing the 68th record. run: 1098 subRun: 1 event: 56168 at 03-Nov-2025 18:17:06 CET
Begin processing the 69th record. run: 1098 subRun: 1 event: 56169 at 03-Nov-2025 18:17:10 CET
Begin processing the 70th record. run: 1098 subRun: 1 event: 56170 at 03-Nov-2025 18:17:14 CET
Begin processing the 71st record. run: 1098 subRun: 1 event: 56171 at 03-Nov-2025 18:17:17 CET
Begin processing the 72nd record. run: 1098 subRun: 1 event: 56172 at 03-Nov-2025 18:17:20 CET
Begin processing the 73rd record. run: 1098 subRun: 1 event: 56173 at 03-Nov-2025 18:17:24 CET
Begin processing the 74th record. run: 1098 subRun: 1 event: 56174 at 03-Nov-2025 18:17:27 CET
Begin processing the 75th record. run: 1098 subRun: 1 event: 56175 at 03-Nov-2025 18:17:31 CET
Begin processing the 76th record. run: 1098 subRun: 1 event: 56176 at 03-Nov-2025 18:17:34 CET
Begin processing the 77th record. run: 1098 subRun: 1 event: 56177 at 03-Nov-2025 18:17:41 CET
Begin processing the 78th record. run: 1098 subRun: 1 event: 56178 at 03-Nov-2025 18:17:45 CET
Begin processing the 79th record. run: 1098 subRun: 1 event: 56179 at 03-Nov-2025 18:17:48 CET
Begin processing the 80th record. run: 1098 subRun: 1 event: 56180 at 03-Nov-2025 18:17:51 CET
Begin processing the 81st record. run: 1098 subRun: 1 event: 56181 at 03-Nov-2025 18:17:54 CET
Begin processing the 82nd record. run: 1098 subRun: 1 event: 56182 at 03-Nov-2025 18:17:58 CET
Begin processing the 83rd record. run: 1098 subRun: 1 event: 56183 at 03-Nov-2025 18:18:01 CET
Begin processing the 84th record. run: 1098 subRun: 1 event: 56184 at 03-Nov-2025 18:18:05 CET
Begin processing the 85th record. run: 1098 subRun: 1 event: 56185 at 03-Nov-2025 18:18:08 CET
Begin processing the 86th record. run: 1098 subRun: 1 event: 56186 at 03-Nov-2025 18:18:11 CET
Begin processing the 87th record. run: 1098 subRun: 1 event: 56187 at 03-Nov-2025 18:18:15 CET
Begin processing the 88th record. run: 1098 subRun: 1 event: 56188 at 03-Nov-2025 18:18:19 CET
Begin processing the 89th record. run: 1098 subRun: 1 event: 56189 at 03-Nov-2025 18:18:22 CET
Begin processing the 90th record. run: 1098 subRun: 1 event: 56190 at 03-Nov-2025 18:18:25 CET
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: 1098 subRun: 1 event: 56191 at 03-Nov-2025 18:18:26 CET
Begin processing the 92nd record. run: 1098 subRun: 1 event: 56192 at 03-Nov-2025 18:18:29 CET
Begin processing the 93rd record. run: 1098 subRun: 1 event: 56193 at 03-Nov-2025 18:18:32 CET
Begin processing the 94th record. run: 1098 subRun: 1 event: 56194 at 03-Nov-2025 18:18:35 CET
Begin processing the 95th record. run: 1098 subRun: 1 event: 56195 at 03-Nov-2025 18:18:39 CET
Begin processing the 96th record. run: 1098 subRun: 1 event: 56196 at 03-Nov-2025 18:18:42 CET
Begin processing the 97th record. run: 1098 subRun: 1 event: 56197 at 03-Nov-2025 18:18:46 CET
Begin processing the 98th record. run: 1098 subRun: 1 event: 56198 at 03-Nov-2025 18:18:49 CET
Begin processing the 99th record. run: 1098 subRun: 1 event: 56199 at 03-Nov-2025 18:18:53 CET
Begin processing the 100th record. run: 1098 subRun: 1 event: 56200 at 03-Nov-2025 18:18:56 CET
03-Nov-2025 18:19:01 CET  Closed output file "nu_dune10kt_1x2x6_1098_561_20230826T013155Z_gen_g4_detsim_hitreco__20240229T165725Z_reco2_reco2.root"
03-Nov-2025 18:19:01 CET  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/55/eb/nu_dune10kt_1x2x6_1098_561_20230826T013155Z_gen_g4_detsim_hitreco__20240229T165725Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0282195      3.40257       9.90972       3.26742      0.988729        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.00235785     0.0193078     0.0403265     0.0186527    0.00824322       100    
reco:pandora:StandardPandora                   0.0226025      3.37831       9.8725        3.24169      0.984696        100    
[art]:TriggerResults:TriggerResultInserter    1.5263e-05    2.18977e-05   6.3164e-05    2.07355e-05   6.59915e-06      100    
end_path:out1:RootOutput                       4.547e-06    5.88568e-06    3.313e-05    5.3675e-06    3.04474e-06      100    
end_path:out1:RootOutput(write)               0.00119715    0.00467393     0.0171387    0.00361177    0.00327776       100    
================================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 2298.64 MB
  Peak resident set size usage (VmHWM): 1317.34 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
justIN time: 2025-11-04 01:41:36 UTC       justIN version: 01.05.01