justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID148403.0@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 16:57:57
SiteUS_PuertoRico
EntryCMSHTPC_T3_US_PuertoRico_UPRM
Last heartbeat2025-02-24 19:55:05
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:54
Input filesfardet-hd:nu_dune10kt_1x2x6_1109_853_20230827T051950Z_gen_g4_detsim_hitreco__20240222T222612Z_reco2.root
JobscriptExit code0
Real time19m (1193s)
CPU time8m (484s = 40%)
Max RSS bytes1000472576 (954 MiB)
Outputting started2025-02-24 19:54:48
Output files
Finished2025-02-24 19:55:05
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/dd/bd/nu_dune10kt_1x2x6_1109_853_20230827T051950Z_gen_g4_detsim_hitreco__20240222T222612Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 33rd record. run: 1109 subRun: 1 event: 85333 at 24-Feb-2025 15:47:25 AST
Begin processing the 34th record. run: 1109 subRun: 1 event: 85334 at 24-Feb-2025 15:47:35 AST
Begin processing the 35th record. run: 1109 subRun: 1 event: 85335 at 24-Feb-2025 15:47:40 AST
Begin processing the 36th record. run: 1109 subRun: 1 event: 85336 at 24-Feb-2025 15:47:45 AST
Begin processing the 37th record. run: 1109 subRun: 1 event: 85337 at 24-Feb-2025 15:47:50 AST
Begin processing the 38th record. run: 1109 subRun: 1 event: 85338 at 24-Feb-2025 15:47:54 AST
Begin processing the 39th record. run: 1109 subRun: 1 event: 85339 at 24-Feb-2025 15:48:00 AST
Begin processing the 40th record. run: 1109 subRun: 1 event: 85340 at 24-Feb-2025 15:48:08 AST
Begin processing the 41st record. run: 1109 subRun: 1 event: 85341 at 24-Feb-2025 15:48:14 AST
Begin processing the 42nd record. run: 1109 subRun: 1 event: 85342 at 24-Feb-2025 15:48:20 AST
Begin processing the 43rd record. run: 1109 subRun: 1 event: 85343 at 24-Feb-2025 15:49:33 AST
Begin processing the 44th record. run: 1109 subRun: 1 event: 85344 at 24-Feb-2025 15:49:38 AST
Begin processing the 45th record. run: 1109 subRun: 1 event: 85345 at 24-Feb-2025 15:49:47 AST
Begin processing the 46th record. run: 1109 subRun: 1 event: 85346 at 24-Feb-2025 15:49:51 AST
Begin processing the 47th record. run: 1109 subRun: 1 event: 85347 at 24-Feb-2025 15:49:56 AST
Begin processing the 48th record. run: 1109 subRun: 1 event: 85348 at 24-Feb-2025 15:50:11 AST
Begin processing the 49th record. run: 1109 subRun: 1 event: 85349 at 24-Feb-2025 15:50:15 AST
Begin processing the 50th record. run: 1109 subRun: 1 event: 85350 at 24-Feb-2025 15:50:20 AST
Begin processing the 51st record. run: 1109 subRun: 1 event: 85351 at 24-Feb-2025 15:50:24 AST
Begin processing the 52nd record. run: 1109 subRun: 1 event: 85352 at 24-Feb-2025 15:50:29 AST
Begin processing the 53rd record. run: 1109 subRun: 1 event: 85353 at 24-Feb-2025 15:50:33 AST
Begin processing the 54th record. run: 1109 subRun: 1 event: 85354 at 24-Feb-2025 15:50:38 AST
Begin processing the 55th record. run: 1109 subRun: 1 event: 85355 at 24-Feb-2025 15:50:43 AST
Begin processing the 56th record. run: 1109 subRun: 1 event: 85356 at 24-Feb-2025 15:50:48 AST
Begin processing the 57th record. run: 1109 subRun: 1 event: 85357 at 24-Feb-2025 15:50:53 AST
Begin processing the 58th record. run: 1109 subRun: 1 event: 85358 at 24-Feb-2025 15:51:03 AST
Begin processing the 59th record. run: 1109 subRun: 1 event: 85359 at 24-Feb-2025 15:51:10 AST
Begin processing the 60th record. run: 1109 subRun: 1 event: 85360 at 24-Feb-2025 15:51:15 AST
Begin processing the 61st record. run: 1109 subRun: 1 event: 85361 at 24-Feb-2025 15:51:20 AST
Begin processing the 62nd record. run: 1109 subRun: 1 event: 85362 at 24-Feb-2025 15:51:25 AST
Begin processing the 63rd record. run: 1109 subRun: 1 event: 85363 at 24-Feb-2025 15:51:31 AST
Begin processing the 64th record. run: 1109 subRun: 1 event: 85364 at 24-Feb-2025 15:51:36 AST
Begin processing the 65th record. run: 1109 subRun: 1 event: 85365 at 24-Feb-2025 15:51:41 AST
Begin processing the 66th record. run: 1109 subRun: 1 event: 85366 at 24-Feb-2025 15:51:45 AST
Begin processing the 67th record. run: 1109 subRun: 1 event: 85367 at 24-Feb-2025 15:51:53 AST
Begin processing the 68th record. run: 1109 subRun: 1 event: 85368 at 24-Feb-2025 15:51:57 AST
Begin processing the 69th record. run: 1109 subRun: 1 event: 85369 at 24-Feb-2025 15:52:04 AST
Begin processing the 70th record. run: 1109 subRun: 1 event: 85370 at 24-Feb-2025 15:52:08 AST
Begin processing the 71st record. run: 1109 subRun: 1 event: 85371 at 24-Feb-2025 15:52:14 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 72nd record. run: 1109 subRun: 1 event: 85372 at 24-Feb-2025 15:52:16 AST
Begin processing the 73rd record. run: 1109 subRun: 1 event: 85373 at 24-Feb-2025 15:52:22 AST
Begin processing the 74th record. run: 1109 subRun: 1 event: 85374 at 24-Feb-2025 15:52:27 AST
Begin processing the 75th record. run: 1109 subRun: 1 event: 85375 at 24-Feb-2025 15:52:31 AST
Begin processing the 76th record. run: 1109 subRun: 1 event: 85376 at 24-Feb-2025 15:52:36 AST
Begin processing the 77th record. run: 1109 subRun: 1 event: 85377 at 24-Feb-2025 15:52:41 AST
Begin processing the 78th record. run: 1109 subRun: 1 event: 85378 at 24-Feb-2025 15:52:45 AST
Begin processing the 79th record. run: 1109 subRun: 1 event: 85379 at 24-Feb-2025 15:52:51 AST
Begin processing the 80th record. run: 1109 subRun: 1 event: 85380 at 24-Feb-2025 15:52:55 AST
Begin processing the 81st record. run: 1109 subRun: 1 event: 85381 at 24-Feb-2025 15:53:01 AST
Begin processing the 82nd record. run: 1109 subRun: 1 event: 85382 at 24-Feb-2025 15:53:06 AST
Begin processing the 83rd record. run: 1109 subRun: 1 event: 85383 at 24-Feb-2025 15:53:11 AST
Begin processing the 84th record. run: 1109 subRun: 1 event: 85384 at 24-Feb-2025 15:53:17 AST
Begin processing the 85th record. run: 1109 subRun: 1 event: 85385 at 24-Feb-2025 15:53:22 AST
Begin processing the 86th record. run: 1109 subRun: 1 event: 85386 at 24-Feb-2025 15:53:26 AST
Begin processing the 87th record. run: 1109 subRun: 1 event: 85387 at 24-Feb-2025 15:53:31 AST
Begin processing the 88th record. run: 1109 subRun: 1 event: 85388 at 24-Feb-2025 15:53:35 AST
Begin processing the 89th record. run: 1109 subRun: 1 event: 85389 at 24-Feb-2025 15:53:40 AST
Begin processing the 90th record. run: 1109 subRun: 1 event: 85390 at 24-Feb-2025 15:53:44 AST
Begin processing the 91st record. run: 1109 subRun: 1 event: 85391 at 24-Feb-2025 15:53:48 AST
Begin processing the 92nd record. run: 1109 subRun: 1 event: 85392 at 24-Feb-2025 15:53:54 AST
Begin processing the 93rd record. run: 1109 subRun: 1 event: 85393 at 24-Feb-2025 15:54:02 AST
Begin processing the 94th record. run: 1109 subRun: 1 event: 85394 at 24-Feb-2025 15:54:06 AST
Begin processing the 95th record. run: 1109 subRun: 1 event: 85395 at 24-Feb-2025 15:54:11 AST
Begin processing the 96th record. run: 1109 subRun: 1 event: 85396 at 24-Feb-2025 15:54:16 AST
Begin processing the 97th record. run: 1109 subRun: 1 event: 85397 at 24-Feb-2025 15:54:20 AST
Begin processing the 98th record. run: 1109 subRun: 1 event: 85398 at 24-Feb-2025 15:54:26 AST
Begin processing the 99th record. run: 1109 subRun: 1 event: 85399 at 24-Feb-2025 15:54:33 AST
Begin processing the 100th record. run: 1109 subRun: 1 event: 85400 at 24-Feb-2025 15:54:38 AST
24-Feb-2025 15:54:46 AST  Closed output file "nu_dune10kt_1x2x6_1109_853_20230827T051950Z_gen_g4_detsim_hitreco__20240222T222612Z_reco2_reco2.root"
24-Feb-2025 15:54:46 AST  Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/dd/bd/nu_dune10kt_1x2x6_1109_853_20230827T051950Z_gen_g4_detsim_hitreco__20240222T222612Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.645771       4.75279       69.9071       3.4537        6.76589        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0880263     0.177578      0.438335      0.174189      0.0309859       100    
reco:pandora:StandardPandora                   0.479271       4.5599        69.6698       3.27324       6.75939        100    
[art]:TriggerResults:TriggerResultInserter    1.4199e-05    2.63825e-05   0.000136018   2.2633e-05    1.49815e-05      100    
end_path:out1:RootOutput                       2.855e-06    3.57188e-06   1.2586e-05    3.2285e-06    1.16858e-06      100    
end_path:out1:RootOutput(write)                0.0014909     0.0150453     0.0626055    0.00870633     0.0143105       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2189.23 MB
  Peak resident set size usage (VmHWM): 1000.47 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:13:13 UTC       justIN version: 01.03.00