justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 359717.3@justin-prod-sched01.dune.hep.ac.uk

Jobsub ID359717.3@justin-prod-sched01.dune.hep.ac.uk
Workflow ID5846
Stage ID1
User nameamoor@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes6291456000 (6000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2025-04-01 14:55:31
SiteES_PIC
EntryDUNE_T1_ES_PIC_ce15-multicore
Last heartbeat2025-04-01 15:01:10
From worker nodeHostnametd822.pic.es
cpuinfoAMD EPYC 7452 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes6291456000 (6000 MiB)
Wall seconds limit216000 (60 hours)
GPU
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2025-04-01 14:56:32
Input filesusertests:000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z.root
JobscriptExit code0
Real time2m (168s)
CPU time1m (82s = 48%)
Max RSS bytes1148383232 (1095 MiB)
Outputting started2025-04-01 14:59:20
Output filesusertests:000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z_reco_data_2025-04-01T_145639Z.root
Finished2025-04-01 15:01:10
Saved logsjustin-logs:359717.3-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

AFM reco2 jobscript.
Input PFN = root://xrootd-archive.cr.cnaf.infn.it:1096//dune/usertests/2f/4b/000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z.root
Setting up larsoft UPS area... /cvmfs/larsoft.opensciencegrid.org
Setting up DUNE UPS area... /cvmfs/dune.opensciencegrid.org/products/dune/
/cvmfs/larsoft.opensciencegrid.org/products/xrootd/v5_5_5a/Linux64bit+3.10-2.17-e26-p3915-prof/lib/libXrdPosixPreload.so
=== Start last 50 lines of lar log file ===
    in function: GetVolumeIdToHitListMap
    in file:     /scratch/workspace/build-larsoft/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/ALMA9/build/larpandoracontent/v04_14_01-buildFW/src/larpandoracontent/LArControlFlow/MasterAlgorithm.cc line#: 271
this->GetVolumeIdToHitListMap(volumeIdToHitListMap) return STATUS_CODE_NOT_INITIALIZED
    in function: Run
    in file:     /scratch/workspace/build-larsoft/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/ALMA9/build/larpandoracontent/v04_14_01-buildFW/src/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 Alg0003, LArDLMaster, STATUS_CODE_NOT_INITIALIZED
Begin processing the 20th record. run: 20000031 subRun: 0 event: 20 at 01-Apr-2025 16:59:13 CEST
PandoraContentApi::GetList(*this, m_inputHitListName, pCaloHitList) return STATUS_CODE_NOT_INITIALIZED
    in function: GetVolumeIdToHitListMap
    in file:     /scratch/workspace/build-larsoft/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/ALMA9/build/larpandoracontent/v04_14_01-buildFW/src/larpandoracontent/LArControlFlow/MasterAlgorithm.cc line#: 271
this->GetVolumeIdToHitListMap(volumeIdToHitListMap) return STATUS_CODE_NOT_INITIALIZED
    in function: Run
    in file:     /scratch/workspace/build-larsoft/BUILDTYPE/prof/QUAL/s131-e26/label1/swarm/label2/ALMA9/build/larpandoracontent/v04_14_01-buildFW/src/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 Alg0003, LArDLMaster, STATUS_CODE_NOT_INITIALIZED
01-Apr-2025 16:59:15 CEST  Closed output file "000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z_reco_data_2025-04-01T_145639Z.root"
01-Apr-2025 16:59:15 CEST  Closed input file "root://xrootd-archive.cr.cnaf.infn.it:1096//dune/usertests/2f/4b/000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                             0.452758       1.12166       3.16678      0.477222       1.04835        20     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                 0.0449038     0.0518259     0.0895605     0.0451637     0.0157965       20     
reco:linecluster:LineCluster                            0.26609      0.386597      0.686901      0.267604      0.164639        20     
reco:trajcluster:TrajCluster                            0.13339      0.346571       1.27462      0.133718       0.37378        20     
reco:pandora:StandardPandora                          0.00136352     0.138593      0.869838     0.00168932     0.243661        20     
reco:pandoraTrack:LArPandoraTrackCreation             0.000147312    0.0207451     0.106262     0.000188678    0.0374365       20     
reco:pandoraShower:LArPandoraModularShowerCreation    0.000226652    0.112976      0.557257     0.000267427     0.19205        20     
reco:pandoracalo:Calorimetry                          0.000311463    0.0186665     0.0939216    0.000388654    0.0318126       20     
reco:pandorapid:Chi2ParticleID                         4.403e-05    0.000369456   0.00297706    5.15805e-05   0.000667085      20     
reco:trkshowersplit:TrackShowerHits                   0.000313823   0.00841135     0.0435674    0.00048994     0.0137631       20     
reco:rns:RandomNumberSaver                             2.032e-05    3.82559e-05   0.000281153   2.39205e-05   5.5999e-05       20     
[art]:TriggerResults:TriggerResultInserter             1.123e-05    1.67707e-05   5.7491e-05     1.451e-05    9.55162e-06      20     
end_path:out1:RootOutput                               3.75e-06     5.38305e-06    2.257e-05     4.59e-06     3.96404e-06      20     
end_path:out1:RootOutput(write)                       0.00432372     0.0361599     0.149978     0.00568725     0.0508528       20     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2271.01 MB
  Peak resident set size usage (VmHWM): 1148.38 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
    "metadata": {
        "DUNE.campaign": "justIN.w5846s1",
        "art.file_format_era": "ART_2011a",
        "art.file_format_version": 15,
        "art.first_event": 1,
        "art.last_event": 20,
        "art.process_name": "Reco2",
        "art.run_type": "physics",
        "core.application": "art.reco",
        "core.application.family": "art",
        "core.application.name": "reco",
        "core.application.version": "v10_04_06d00",
        "core.data_stream": "out1",
        "core.data_tier": "full-reconstructed",
        "core.end_time": 1743519555.0,
        "core.event_count": 20,
        "core.file_format": "artroot",
        "core.file_type": "mc",
        "core.first_event_number": 1,
        "core.last_event_number": 20,
        "core.run_type": "physics",
        "core.runs": [
            20000031
        ],
        "core.runs_subruns": [
            2000003100000
        ],
        "core.start_time": 1743519467.0
    },
    "parents": [
        {
            "did": "usertests:000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z.root"
        }
    ]
}
===================
.:
total 119748
-rw-r--r-- 1 dune001 dune 122500984 Apr  1 16:59 000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z_reco_data_2025-04-01T_145639Z.root
-rw-r--r-- 1 dune001 dune     74836 Apr  1 16:59 000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z_reco_2025-04-01T_145639Z.log
-rw-r--r-- 1 dune001 dune      7560 Apr  1 16:59 reco2_hist.root
-rw-r--r-- 1 dune001 dune      7416 Apr  1 16:59 jobscript.log
-rw-r--r-- 1 dune001 dune      1168 Apr  1 16:59 000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z_reco_data_2025-04-01T_145639Z.root.json
-rw-r--r-- 1 dune001 dune      1042 Apr  1 16:59 000008_reco_data_2025-03-31T_142624Z_reco_data_2025-03-31T_145956Z_reco_data_2025-04-01T_083014Z_reco_data_2025-04-01T_101349Z_reco_data_2025-04-01T_145639Z.root.ext.json
-rw-r--r-- 1 dune001 dune       284 Apr  1 16:56 all-input-dids.txt
-rw-r--r-- 1 dune001 dune       197 Apr  1 16:59 justin-processed-pfns.txt
-rw-r--r-- 1 dune001 dune         0 Apr  1 16:57 debugprod.log
justIN time: 2025-04-03 08:15:39 UTC       justIN version: 01.03.00