justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID205317.85@justin-prod-sched02.dune.hep.ac.uk
Workflow ID7012
Stage ID1
User nameimawby@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit43200 (12 hours)
Submitted time2025-05-16 22:39:08
SiteCA_SFU
EntryDUNE_CA_SFU_lcg-ce3
Last heartbeat2025-05-17 00:19:46
From worker nodeHostnamecdr929.int.cedar.computecanada.ca
cpuinfoIntel(R) Xeon(R) CPU E5-2683 v4 @ 2.10GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit84598 (23 hours)
GPU
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2025-05-16 22:50:08
Input filesfardet-hd:nue_dune10kt_1x2x6_1426_84_20230827T193400Z_gen_g4_detsim_hitreco__20240221T073659Z_reco2.root
JobscriptExit code0
Real time1h (5318s)
CPU time8m (521s = 9%)
Max RSS bytes1266319360 (1207 MiB)
Outputting started2025-05-17 00:18:47
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/hierarchyRecoVal_nue_0/07012/1/001/HierarchyRecoPerformance_nue_dune10kt_1x2x6_1426_84_20230827T193400Z_gen_g4_detsim_hitreco__20240221T073659Z_reco2.root
Finished2025-05-17 00:19:46
Saved logsjustin-logs:205317.85-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

Justin processors: 1
Setting up larsoft UPS area... /cvmfs/larsoft.opensciencegrid.org
Setting up DUNE UPS area... /cvmfs/dune.opensciencegrid.org/products/dune/

MRB_PROJECT=larsoft
MRB_PROJECT_VERSION=v10_04_07
MRB_QUALS=e26:prof
MRB_TOP=/cvmfs/fifeuser1.opensciencegrid.org/sw/dune/1f6ae27e2949dac32aa3f38aa8a77bd460cb592c
MRB_SOURCE=/cvmfs/fifeuser1.opensciencegrid.org/sw/dune/1f6ae27e2949dac32aa3f38aa8a77bd460cb592c/srcs
MRB_BUILDDIR=/cvmfs/fifeuser1.opensciencegrid.org/sw/dune/1f6ae27e2949dac32aa3f38aa8a77bd460cb592c/build_slf7.x86_64
MRB_INSTALL=/cvmfs/fifeuser1.opensciencegrid.org/sw/dune/1f6ae27e2949dac32aa3f38aa8a77bd460cb592c/localProducts_larsoft_v10_04_07_e26_prof

PRODUCTS=/cvmfs/fifeuser1.opensciencegrid.org/sw/dune/1f6ae27e2949dac32aa3f38aa8a77bd460cb592c/localProducts_larsoft_v10_04_07_e26_prof:/cvmfs/dune.opensciencegrid.org/products/dune:/cvmfs/larsoft.opensciencegrid.org/products:/cvmfs/larsoft.opensciencegrid.org/packages:/cvmfs/fermilab.opensciencegrid.org/products/common/db/
CETPKG_INSTALL=/cvmfs/fifeuser1.opensciencegrid.org/sw/dune/1f6ae27e2949dac32aa3f38aa8a77bd460cb592c/localProducts_larsoft_v10_04_07_e26_prof

local product directory is /cvmfs/fifeuser1.opensciencegrid.org/sw/dune/1f6ae27e2949dac32aa3f38aa8a77bd460cb592c/localProducts_larsoft_v10_04_07_e26_prof
----------- this block should be empty ------------------
---------------------------------------------------------
Input PFN = root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/0e/40/nue_dune10kt_1x2x6_1426_84_20230827T193400Z_gen_g4_detsim_hitreco__20240221T073659Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 68th record. run: 1426 subRun: 1 event: 8468 at 16-May-2025 17:13:32 PDT
Begin processing the 69th record. run: 1426 subRun: 1 event: 8469 at 16-May-2025 17:13:43 PDT
Begin processing the 70th record. run: 1426 subRun: 1 event: 8470 at 16-May-2025 17:13:49 PDT
Begin processing the 71st record. run: 1426 subRun: 1 event: 8471 at 16-May-2025 17:13:57 PDT
Begin processing the 72nd record. run: 1426 subRun: 1 event: 8472 at 16-May-2025 17:14:03 PDT
YES RECO: 2212 GEN: 3
YES RECO: 2212 GEN: 3
YES RECO: -11 GEN: 3
Begin processing the 73rd record. run: 1426 subRun: 1 event: 8473 at 16-May-2025 17:14:21 PDT
YES RECO: 211 GEN: 3
Begin processing the 74th record. run: 1426 subRun: 1 event: 8474 at 16-May-2025 17:14:41 PDT
Begin processing the 75th record. run: 1426 subRun: 1 event: 8475 at 16-May-2025 17:15:00 PDT
YES RECO: -211 GEN: 3
YES RECO: -211 GEN: 4
YES RECO: -211 GEN: 5
YES RECO: 2212 GEN: 5
YES RECO: 2212 GEN: 4
YES RECO: 2212 GEN: 5
YES RECO: 2212 GEN: 4
YES RECO: 2212 GEN: 3
YES RECO: -11 GEN: 3
Begin processing the 76th record. run: 1426 subRun: 1 event: 8476 at 16-May-2025 17:15:18 PDT
Begin processing the 77th record. run: 1426 subRun: 1 event: 8477 at 16-May-2025 17:15:31 PDT
PandoraContentApi::GetList(*this, m_pfoListName, pPfoList) return STATUS_CODE_NOT_INITIALIZED
    in function: Run
    in file:     /exp/dune/app/users/imawby/dunesw_pandoraBugFix/srcs/larpandoracontent/larpandoracontent/LArMonitoring/SecondaryValidationAlgorithm.cc line#: 58
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 Alg0003, LArSecondaryValidation, STATUS_CODE_NOT_INITIALIZED
Begin processing the 78th record. run: 1426 subRun: 1 event: 8478 at 16-May-2025 17:15:38 PDT
Begin processing the 79th record. run: 1426 subRun: 1 event: 8479 at 16-May-2025 17:15:44 PDT
SUCCESS!
Begin processing the 80th record. run: 1426 subRun: 1 event: 8480 at 16-May-2025 17:15:51 PDT
Begin processing the 81st record. run: 1426 subRun: 1 event: 8481 at 16-May-2025 17:15:56 PDT
Begin processing the 82nd record. run: 1426 subRun: 1 event: 8482 at 16-May-2025 17:16:04 PDT
SUCCESS!
Begin processing the 83rd record. run: 1426 subRun: 1 event: 8483 at 16-May-2025 17:16:13 PDT
Begin processing the 84th record. run: 1426 subRun: 1 event: 8484 at 16-May-2025 17:16:19 PDT
Begin processing the 85th record. run: 1426 subRun: 1 event: 8485 at 16-May-2025 17:16:25 PDT
Begin processing the 86th record. run: 1426 subRun: 1 event: 8486 at 16-May-2025 17:16:38 PDT
Begin processing the 87th record. run: 1426 subRun: 1 event: 8487 at 16-May-2025 17:16:47 PDT
YES RECO: 2212 GEN: 3
Begin processing the 88th record. run: 1426 subRun: 1 event: 8488 at 16-May-2025 17:17:04 PDT
Begin processing the 89th record. run: 1426 subRun: 1 event: 8489 at 16-May-2025 17:17:12 PDT
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
PandoraContentApi::GetList(*this, m_caloHitListName, pCaloHitList) return STATUS_CODE_NOT_INITIALIZED
    in function: Run
    in file:     /exp/dune/app/users/imawby/dunesw_pandoraBugFix/srcs/larpandoracontent/larpandoracontent/LArMonitoring/SecondaryValidationAlgorithm.cc line#: 54
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 Alg0003, LArSecondaryValidation, STATUS_CODE_NOT_INITIALIZED
Begin processing the 90th record. run: 1426 subRun: 1 event: 8490 at 16-May-2025 17:17:15 PDT
Begin processing the 91st record. run: 1426 subRun: 1 event: 8491 at 16-May-2025 17:17:32 PDT
SUCCESS!
YES RECO: -11 GEN: 3
YES RECO: 2212 GEN: 3
Begin processing the 92nd record. run: 1426 subRun: 1 event: 8492 at 16-May-2025 17:17:43 PDT
YES RECO: 211 GEN: 3
YES RECO: 2212 GEN: 4
Begin processing the 93rd record. run: 1426 subRun: 1 event: 8493 at 16-May-2025 17:17:51 PDT
Begin processing the 94th record. run: 1426 subRun: 1 event: 8494 at 16-May-2025 17:17:56 PDT
Begin processing the 95th record. run: 1426 subRun: 1 event: 8495 at 16-May-2025 17:18:02 PDT
Begin processing the 96th record. run: 1426 subRun: 1 event: 8496 at 16-May-2025 17:18:11 PDT
Begin processing the 97th record. run: 1426 subRun: 1 event: 8497 at 16-May-2025 17:18:16 PDT
Begin processing the 98th record. run: 1426 subRun: 1 event: 8498 at 16-May-2025 17:18:22 PDT
Begin processing the 99th record. run: 1426 subRun: 1 event: 8499 at 16-May-2025 17:18:33 PDT
Begin processing the 100th record. run: 1426 subRun: 1 event: 8500 at 16-May-2025 17:18:40 PDT
16-May-2025 17:18:46 PDT  Closed output file "nue_dune10kt_1x2x6_1426_84_20230827T193400Z_gen_g4_detsim_hitreco__20240221T073659Z_reco2_reco2.root"
16-May-2025 17:18:46 PDT  Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/0e/40/nue_dune10kt_1x2x6_1426_84_20230827T193400Z_gen_g4_detsim_hitreco__20240221T073659Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.536162       5.02711       24.4237       4.30485       2.51023        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.113904      0.156477      0.704915      0.143502      0.0649486       100    
reco:pandora:StandardPandora                    0.39679       4.85833       24.2257       4.12224       2.50526        100    
[art]:TriggerResults:TriggerResultInserter    1.8461e-05    3.69385e-05   0.000120823   3.0366e-05    1.97667e-05      100    
end_path:out1:RootOutput                       2.946e-06    4.38271e-06   1.8733e-05    3.7295e-06    2.03691e-06      100    
end_path:out1:RootOutput(write)               0.00144916     0.0120602     0.0537042     0.0102312    0.00891098       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2246.11 MB
  Peak resident set size usage (VmHWM): 1266.32 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
justIN time: 2025-05-27 17:30:26 UTC       justIN version: 01.03.01