justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 148407.9@justin-prod-sched02.dune.hep.ac.uk

Jobsub ID148407.9@justin-prod-sched02.dune.hep.ac.uk
Workflow ID5272
Stage ID1
User nameimawby@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit43200 (12 hours)
Submitted time2025-02-24 17:02:22
SiteUS_PuertoRico
EntryCMSHTPC_T3_US_PuertoRico_UPRM
Last heartbeat2025-02-24 19:52:53
From worker nodeHostnamecompute-0-2.local
cpuinfoIntel(R) Xeon(R) CPU W3550 @ 3.07GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit171000 (47 hours)
GPU
Inner Apptainer?True
Job stateoutputting_failed
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2025-02-24 19:34:25
Input filesfardet-hd:nu_dune10kt_1x2x6_1098_322_20230826T012214Z_gen_g4_detsim_hitreco__20240223T002152Z_reco2.root
JobscriptExit code0
Real time18m (1089s)
CPU time6m (415s = 38%)
Max RSS bytes1025794048 (978 MiB)
Outputting started2025-02-24 19:52:35
Output files
Finished2025-02-24 19:52:53
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

-
---------------------------------------------------------
Input PFN = root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/1e/1d/nu_dune10kt_1x2x6_1098_322_20230826T012214Z_gen_g4_detsim_hitreco__20240223T002152Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 33rd record. run: 1098 subRun: 1 event: 32233 at 24-Feb-2025 15:46:17 AST
Begin processing the 34th record. run: 1098 subRun: 1 event: 32234 at 24-Feb-2025 15:46:22 AST
Begin processing the 35th record. run: 1098 subRun: 1 event: 32235 at 24-Feb-2025 15:46:27 AST
Begin processing the 36th record. run: 1098 subRun: 1 event: 32236 at 24-Feb-2025 15:46:33 AST
Begin processing the 37th record. run: 1098 subRun: 1 event: 32237 at 24-Feb-2025 15:46:41 AST
Begin processing the 38th record. run: 1098 subRun: 1 event: 32238 at 24-Feb-2025 15:46:46 AST
Begin processing the 39th record. run: 1098 subRun: 1 event: 32239 at 24-Feb-2025 15:46:53 AST
Begin processing the 40th record. run: 1098 subRun: 1 event: 32240 at 24-Feb-2025 15:46:58 AST
Begin processing the 41st record. run: 1098 subRun: 1 event: 32241 at 24-Feb-2025 15:47:04 AST
Begin processing the 42nd record. run: 1098 subRun: 1 event: 32242 at 24-Feb-2025 15:47:11 AST
Begin processing the 43rd record. run: 1098 subRun: 1 event: 32243 at 24-Feb-2025 15:47:15 AST
Begin processing the 44th record. run: 1098 subRun: 1 event: 32244 at 24-Feb-2025 15:47:21 AST
Begin processing the 45th record. run: 1098 subRun: 1 event: 32245 at 24-Feb-2025 15:47:28 AST
Begin processing the 46th record. run: 1098 subRun: 1 event: 32246 at 24-Feb-2025 15:47:32 AST
Begin processing the 47th record. run: 1098 subRun: 1 event: 32247 at 24-Feb-2025 15:47:37 AST
Begin processing the 48th record. run: 1098 subRun: 1 event: 32248 at 24-Feb-2025 15:47:42 AST
Begin processing the 49th record. run: 1098 subRun: 1 event: 32249 at 24-Feb-2025 15:47:47 AST
Begin processing the 50th record. run: 1098 subRun: 1 event: 32250 at 24-Feb-2025 15:47:52 AST
Begin processing the 51st record. run: 1098 subRun: 1 event: 32251 at 24-Feb-2025 15:47:58 AST
Begin processing the 52nd record. run: 1098 subRun: 1 event: 32252 at 24-Feb-2025 15:48:03 AST
Begin processing the 53rd record. run: 1098 subRun: 1 event: 32253 at 24-Feb-2025 15:48:27 AST
Begin processing the 54th record. run: 1098 subRun: 1 event: 32254 at 24-Feb-2025 15:48:32 AST
Begin processing the 55th record. run: 1098 subRun: 1 event: 32255 at 24-Feb-2025 15:48:37 AST
Begin processing the 56th record. run: 1098 subRun: 1 event: 32256 at 24-Feb-2025 15:48:42 AST
Begin processing the 57th record. run: 1098 subRun: 1 event: 32257 at 24-Feb-2025 15:48:47 AST
Begin processing the 58th record. run: 1098 subRun: 1 event: 32258 at 24-Feb-2025 15:48:52 AST
Begin processing the 59th record. run: 1098 subRun: 1 event: 32259 at 24-Feb-2025 15:48:56 AST
Begin processing the 60th record. run: 1098 subRun: 1 event: 32260 at 24-Feb-2025 15:49:02 AST
Begin processing the 61st record. run: 1098 subRun: 1 event: 32261 at 24-Feb-2025 15:49:06 AST
Begin processing the 62nd record. run: 1098 subRun: 1 event: 32262 at 24-Feb-2025 15:49:11 AST
Begin processing the 63rd record. run: 1098 subRun: 1 event: 32263 at 24-Feb-2025 15:49:17 AST
Begin processing the 64th record. run: 1098 subRun: 1 event: 32264 at 24-Feb-2025 15:49:22 AST
Begin processing the 65th record. run: 1098 subRun: 1 event: 32265 at 24-Feb-2025 15:49:27 AST
Begin processing the 66th record. run: 1098 subRun: 1 event: 32266 at 24-Feb-2025 15:49:32 AST
Begin processing the 67th record. run: 1098 subRun: 1 event: 32267 at 24-Feb-2025 15:49:38 AST
PandoraContentApi::GetList(*this, m_inputHitListName, pCaloHitList) return STATUS_CODE_NOT_INITIALIZED
    in function: GetVolumeIdToHitListMap
    in file:     /exp/dune/app/users/imawby/dunesw_pandoraBugFix/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_pandoraBugFix/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 68th record. run: 1098 subRun: 1 event: 32268 at 24-Feb-2025 15:49:40 AST
Begin processing the 69th record. run: 1098 subRun: 1 event: 32269 at 24-Feb-2025 15:49:46 AST
Begin processing the 70th record. run: 1098 subRun: 1 event: 32270 at 24-Feb-2025 15:49:50 AST
Begin processing the 71st record. run: 1098 subRun: 1 event: 32271 at 24-Feb-2025 15:49:57 AST
Begin processing the 72nd record. run: 1098 subRun: 1 event: 32272 at 24-Feb-2025 15:50:02 AST
Begin processing the 73rd record. run: 1098 subRun: 1 event: 32273 at 24-Feb-2025 15:50:07 AST
Begin processing the 74th record. run: 1098 subRun: 1 event: 32274 at 24-Feb-2025 15:50:12 AST
Begin processing the 75th record. run: 1098 subRun: 1 event: 32275 at 24-Feb-2025 15:50:17 AST
Begin processing the 76th record. run: 1098 subRun: 1 event: 32276 at 24-Feb-2025 15:50:22 AST
Begin processing the 77th record. run: 1098 subRun: 1 event: 32277 at 24-Feb-2025 15:50:26 AST
Begin processing the 78th record. run: 1098 subRun: 1 event: 32278 at 24-Feb-2025 15:50:32 AST
Begin processing the 79th record. run: 1098 subRun: 1 event: 32279 at 24-Feb-2025 15:50:36 AST
Begin processing the 80th record. run: 1098 subRun: 1 event: 32280 at 24-Feb-2025 15:50:41 AST
Begin processing the 81st record. run: 1098 subRun: 1 event: 32281 at 24-Feb-2025 15:50:46 AST
Begin processing the 82nd record. run: 1098 subRun: 1 event: 32282 at 24-Feb-2025 15:50:52 AST
Begin processing the 83rd record. run: 1098 subRun: 1 event: 32283 at 24-Feb-2025 15:50:56 AST
Begin processing the 84th record. run: 1098 subRun: 1 event: 32284 at 24-Feb-2025 15:51:01 AST
Begin processing the 85th record. run: 1098 subRun: 1 event: 32285 at 24-Feb-2025 15:51:13 AST
Begin processing the 86th record. run: 1098 subRun: 1 event: 32286 at 24-Feb-2025 15:51:19 AST
Begin processing the 87th record. run: 1098 subRun: 1 event: 32287 at 24-Feb-2025 15:51:23 AST
Begin processing the 88th record. run: 1098 subRun: 1 event: 32288 at 24-Feb-2025 15:51:28 AST
Begin processing the 89th record. run: 1098 subRun: 1 event: 32289 at 24-Feb-2025 15:51:33 AST
Begin processing the 90th record. run: 1098 subRun: 1 event: 32290 at 24-Feb-2025 15:51:39 AST
Begin processing the 91st record. run: 1098 subRun: 1 event: 32291 at 24-Feb-2025 15:51:45 AST
Begin processing the 92nd record. run: 1098 subRun: 1 event: 32292 at 24-Feb-2025 15:51:49 AST
Begin processing the 93rd record. run: 1098 subRun: 1 event: 32293 at 24-Feb-2025 15:51:54 AST
Begin processing the 94th record. run: 1098 subRun: 1 event: 32294 at 24-Feb-2025 15:51:59 AST
Begin processing the 95th record. run: 1098 subRun: 1 event: 32295 at 24-Feb-2025 15:52:05 AST
Begin processing the 96th record. run: 1098 subRun: 1 event: 32296 at 24-Feb-2025 15:52:10 AST
Begin processing the 97th record. run: 1098 subRun: 1 event: 32297 at 24-Feb-2025 15:52:15 AST
Begin processing the 98th record. run: 1098 subRun: 1 event: 32298 at 24-Feb-2025 15:52:20 AST
Begin processing the 99th record. run: 1098 subRun: 1 event: 32299 at 24-Feb-2025 15:52:24 AST
Begin processing the 100th record. run: 1098 subRun: 1 event: 32300 at 24-Feb-2025 15:52:29 AST
24-Feb-2025 15:52:34 AST  Closed output file "nu_dune10kt_1x2x6_1098_322_20230826T012214Z_gen_g4_detsim_hitreco__20240223T002152Z_reco2_reco2.root"
24-Feb-2025 15:52:34 AST  Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/1e/1d/nu_dune10kt_1x2x6_1098_322_20230826T012214Z_gen_g4_detsim_hitreco__20240223T002152Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.628161       4.02615       21.7427       3.53018       2.22661        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0884044     0.170167      0.300678      0.167027      0.0205056       100    
reco:pandora:StandardPandora                    0.4723        3.84065       21.463        3.33558       2.21431        100    
[art]:TriggerResults:TriggerResultInserter    1.5014e-05    3.01688e-05   0.000362934   2.2862e-05    3.57083e-05      100    
end_path:out1:RootOutput                       2.934e-06    3.52672e-06   1.6009e-05     3.261e-06    1.34419e-06      100    
end_path:out1:RootOutput(write)                0.001525      0.015119      0.116113      0.0111248     0.0153101       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2213.39 MB
  Peak resident set size usage (VmHWM): 1025.79 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
mv: cannot stat 'MLPHierarchyValidationFile.root': No such file or directory
justIN time: 2025-04-03 08:15:29 UTC       justIN version: 01.03.00