justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID168206.22@justin-prod-sched02.dune.hep.ac.uk
Workflow ID5840
Stage ID1
User nameamoor@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes6291456000 (6000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2025-04-01 11:18:06
SiteUK_Brunel
EntryCMSHTPC_T2_UK_London_Brunel_dc2_22
Last heartbeat2025-04-01 11:22:16
From worker nodeHostnamewn-a2-26-01.brunel.ac.uk
cpuinfoIntel(R) Xeon(R) CPU E5-2640 v3 @ 2.60GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes6291456000 (6000 MiB)
Wall seconds limit171000 (47 hours)
GPU
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2025-04-01 11:19:28
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 time1m (101s)
CPU time0m (52s = 51%)
Max RSS bytes1171070976 (1116 MiB)
Outputting started2025-04-01 11:21:10
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_111931Z.root
Finished2025-04-01 11:22:16
Saved logsjustin-logs:168206.22-justin-prod-sched02.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 ===
Begin processing the 19th record. run: 20000031 subRun: 0 event: 19 at 01-Apr-2025 12:21:06 BST
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
Begin processing the 20th record. run: 20000031 subRun: 0 event: 20 at 01-Apr-2025 12:21:07 BST
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 12:21:08 BST  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_111931Z.root"
01-Apr-2025 12:21:08 BST  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.0316488     0.0492344     0.271677      0.0325181     0.0519688       20     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                 0.0280939     0.0325399     0.0560275     0.0282549    0.00984115       20     
reco:pandora:StandardPandora                          0.000899457    0.012744      0.231493     0.00105852     0.0501866       20     
reco:pandoraTrack:LArPandoraTrackCreation             0.000119177   0.000198752   0.00120703    0.000137205   0.000232954      20     
reco:pandoraShower:LArPandoraModularShowerCreation    0.000156604   0.000247525   0.00137992    0.000177924   0.000262352      20     
reco:pandoracalo:Calorimetry                          0.00022431    0.000304281    0.0010082    0.000252555   0.000168291      20     
reco:pandorapid:Chi2ParticleID                        3.5915e-05    5.98396e-05   0.000385312   3.82545e-05   7.52379e-05      20     
reco:trkshowersplit:TrackShowerHits                   0.000193965   0.00022875    0.00036236    0.000205643   4.96072e-05      20     
reco:rns:RandomNumberSaver                            1.4031e-05    2.50431e-05   0.00015332    1.7267e-05    2.96699e-05      20     
[art]:TriggerResults:TriggerResultInserter             9.487e-06    1.25501e-05   3.5812e-05    1.03215e-05   5.88272e-06      20     
end_path:out1:RootOutput                               2.431e-06    3.5687e-06    1.2399e-05    2.8935e-06    2.12301e-06      20     
end_path:out1:RootOutput(write)                       0.00147751    0.00248849    0.00637424     0.0017197     0.0014336       20     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2246.5 MB
  Peak resident set size usage (VmHWM): 1171.07 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.w5840s1",
        "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": 1743506467.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": 1743506420.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 115480
-rw-r--r--. 1 pildune000 dunepil 118170316 Apr  1 12:21 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_111931Z.root
-rw-r--r--. 1 pildune000 dunepil     48112 Apr  1 12:21 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_111931Z.log
-rw-r--r--. 1 pildune000 dunepil      7341 Apr  1 12:21 jobscript.log
-rw-r--r--. 1 pildune000 dunepil      1168 Apr  1 12:21 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_111931Z.root.json
-rw-r--r--. 1 pildune000 dunepil      1042 Apr  1 12:21 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_111931Z.root.ext.json
-rw-r--r--. 1 pildune000 dunepil       519 Apr  1 12:21 reco2_hist.root
-rw-r--r--. 1 pildune000 dunepil       284 Apr  1 12:19 all-input-dids.txt
-rw-r--r--. 1 pildune000 dunepil       197 Apr  1 12:21 justin-processed-pfns.txt
-rw-r--r--. 1 pildune000 dunepil         0 Apr  1 12:19 debugprod.log
justIN time: 2025-04-03 08:21:38 UTC       justIN version: 01.03.00