justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 232735.126@dunegpschedd02.fnal.gov

Jobsub ID232735.126@dunegpschedd02.fnal.gov
Workflow ID9327
Stage ID1
User nameimawby@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes1048576000 (1000 MiB)
Wall seconds limit7200 (2 hours)
Submitted time2025-10-24 20:59:30
SiteCERN
EntryCMSHTPC_T2_CH_CERN_ce507
Last heartbeat2025-10-24 21:22:29
From worker nodeHostnameb9p12p8135.cern.ch
cpuinfoAMD EPYC 7543 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes1048576000 (1000 MiB)
Wall seconds limit343800 (95 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-10-24 21:02:01
Input filesfardet-hd:nu_dune10kt_1x2x6_1413_668_20230826T183345Z_gen_g4_detsim_hitreco__20240229T184341Z_reco2.root
JobscriptExit code0
Real time11m (701s)
CPU time6m (416s = 59%)
Max RSS bytes1365164032 (1301 MiB)
Outputting started2025-10-24 21:13:52
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09327/1/001/ClusterValidation_WithAlg_nu_dune10kt_1x2x6_1413_668_20230826T183345Z_gen_g4_detsim_hitreco__20240229T184341Z_reco2.root
https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09327/1/001/ClusterValidation_WithoutAlg_nu_dune10kt_1x2x6_1413_668_20230826T183345Z_gen_g4_detsim_hitreco__20240229T184341Z_reco2.root
Finished2025-10-24 21:22:29
Saved logsjustin-logs:232735.126-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

------
---------------------------------------------------------
Input PFN = root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/fardet-hd/ad/e2/nu_dune10kt_1x2x6_1413_668_20230826T183345Z_gen_g4_detsim_hitreco__20240229T184341Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 33rd record. run: 1413 subRun: 1 event: 66833 at 24-Oct-2025 23:08:49 CEST
PandoraContentApi::GetList(*this, m_inputHitListName, pCaloHitList) return STATUS_CODE_NOT_INITIALIZED
    in function: GetVolumeIdToHitListMap
    in file:     /exp/dune/app/users/imawby/dunesw_splitting/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_splitting/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 34th record. run: 1413 subRun: 1 event: 66834 at 24-Oct-2025 23:08:50 CEST
Begin processing the 35th record. run: 1413 subRun: 1 event: 66835 at 24-Oct-2025 23:08:52 CEST
Begin processing the 36th record. run: 1413 subRun: 1 event: 66836 at 24-Oct-2025 23:08:54 CEST
Begin processing the 37th record. run: 1413 subRun: 1 event: 66837 at 24-Oct-2025 23:08:57 CEST
Begin processing the 38th record. run: 1413 subRun: 1 event: 66838 at 24-Oct-2025 23:08:59 CEST
Begin processing the 39th record. run: 1413 subRun: 1 event: 66839 at 24-Oct-2025 23:09:08 CEST
Begin processing the 40th record. run: 1413 subRun: 1 event: 66840 at 24-Oct-2025 23:09:10 CEST
Begin processing the 41st record. run: 1413 subRun: 1 event: 66841 at 24-Oct-2025 23:09:12 CEST
Begin processing the 42nd record. run: 1413 subRun: 1 event: 66842 at 24-Oct-2025 23:09:14 CEST
Begin processing the 43rd record. run: 1413 subRun: 1 event: 66843 at 24-Oct-2025 23:09:17 CEST
Begin processing the 44th record. run: 1413 subRun: 1 event: 66844 at 24-Oct-2025 23:09:23 CEST
Begin processing the 45th record. run: 1413 subRun: 1 event: 66845 at 24-Oct-2025 23:09:25 CEST
Begin processing the 46th record. run: 1413 subRun: 1 event: 66846 at 24-Oct-2025 23:09:29 CEST
Begin processing the 47th record. run: 1413 subRun: 1 event: 66847 at 24-Oct-2025 23:09:31 CEST
Begin processing the 48th record. run: 1413 subRun: 1 event: 66848 at 24-Oct-2025 23:09:34 CEST
Begin processing the 49th record. run: 1413 subRun: 1 event: 66849 at 24-Oct-2025 23:09:37 CEST
Begin processing the 50th record. run: 1413 subRun: 1 event: 66850 at 24-Oct-2025 23:09:51 CEST
Begin processing the 51st record. run: 1413 subRun: 1 event: 66851 at 24-Oct-2025 23:09:53 CEST
Begin processing the 52nd record. run: 1413 subRun: 1 event: 66852 at 24-Oct-2025 23:09:56 CEST
Begin processing the 53rd record. run: 1413 subRun: 1 event: 66853 at 24-Oct-2025 23:09:58 CEST
Begin processing the 54th record. run: 1413 subRun: 1 event: 66854 at 24-Oct-2025 23:10:00 CEST
Begin processing the 55th record. run: 1413 subRun: 1 event: 66855 at 24-Oct-2025 23:10:03 CEST
Begin processing the 56th record. run: 1413 subRun: 1 event: 66856 at 24-Oct-2025 23:10:08 CEST
Begin processing the 57th record. run: 1413 subRun: 1 event: 66857 at 24-Oct-2025 23:10:14 CEST
Begin processing the 58th record. run: 1413 subRun: 1 event: 66858 at 24-Oct-2025 23:10:16 CEST
Begin processing the 59th record. run: 1413 subRun: 1 event: 66859 at 24-Oct-2025 23:10:22 CEST
Begin processing the 60th record. run: 1413 subRun: 1 event: 66860 at 24-Oct-2025 23:10:25 CEST
Begin processing the 61st record. run: 1413 subRun: 1 event: 66861 at 24-Oct-2025 23:10:28 CEST
Begin processing the 62nd record. run: 1413 subRun: 1 event: 66862 at 24-Oct-2025 23:10:33 CEST
Begin processing the 63rd record. run: 1413 subRun: 1 event: 66863 at 24-Oct-2025 23:10:39 CEST
Begin processing the 64th record. run: 1413 subRun: 1 event: 66864 at 24-Oct-2025 23:10:42 CEST
Begin processing the 65th record. run: 1413 subRun: 1 event: 66865 at 24-Oct-2025 23:10:44 CEST
Begin processing the 66th record. run: 1413 subRun: 1 event: 66866 at 24-Oct-2025 23:10:47 CEST
Begin processing the 67th record. run: 1413 subRun: 1 event: 66867 at 24-Oct-2025 23:11:05 CEST
Begin processing the 68th record. run: 1413 subRun: 1 event: 66868 at 24-Oct-2025 23:11:08 CEST
Begin processing the 69th record. run: 1413 subRun: 1 event: 66869 at 24-Oct-2025 23:11:11 CEST
Begin processing the 70th record. run: 1413 subRun: 1 event: 66870 at 24-Oct-2025 23:11:15 CEST
Begin processing the 71st record. run: 1413 subRun: 1 event: 66871 at 24-Oct-2025 23:11:20 CEST
Begin processing the 72nd record. run: 1413 subRun: 1 event: 66872 at 24-Oct-2025 23:11:22 CEST
Begin processing the 73rd record. run: 1413 subRun: 1 event: 66873 at 24-Oct-2025 23:11:25 CEST
Begin processing the 74th record. run: 1413 subRun: 1 event: 66874 at 24-Oct-2025 23:11:27 CEST
Begin processing the 75th record. run: 1413 subRun: 1 event: 66875 at 24-Oct-2025 23:12:15 CEST
Begin processing the 76th record. run: 1413 subRun: 1 event: 66876 at 24-Oct-2025 23:12:17 CEST
Begin processing the 77th record. run: 1413 subRun: 1 event: 66877 at 24-Oct-2025 23:12:20 CEST
Begin processing the 78th record. run: 1413 subRun: 1 event: 66878 at 24-Oct-2025 23:12:22 CEST
Begin processing the 79th record. run: 1413 subRun: 1 event: 66879 at 24-Oct-2025 23:12:26 CEST
Begin processing the 80th record. run: 1413 subRun: 1 event: 66880 at 24-Oct-2025 23:12:29 CEST
Begin processing the 81st record. run: 1413 subRun: 1 event: 66881 at 24-Oct-2025 23:12:31 CEST
Begin processing the 82nd record. run: 1413 subRun: 1 event: 66882 at 24-Oct-2025 23:12:35 CEST
Begin processing the 83rd record. run: 1413 subRun: 1 event: 66883 at 24-Oct-2025 23:12:38 CEST
Begin processing the 84th record. run: 1413 subRun: 1 event: 66884 at 24-Oct-2025 23:12:43 CEST
Begin processing the 85th record. run: 1413 subRun: 1 event: 66885 at 24-Oct-2025 23:12:49 CEST
Begin processing the 86th record. run: 1413 subRun: 1 event: 66886 at 24-Oct-2025 23:12:51 CEST
Begin processing the 87th record. run: 1413 subRun: 1 event: 66887 at 24-Oct-2025 23:12:54 CEST
Begin processing the 88th record. run: 1413 subRun: 1 event: 66888 at 24-Oct-2025 23:12:57 CEST
Begin processing the 89th record. run: 1413 subRun: 1 event: 66889 at 24-Oct-2025 23:13:00 CEST
Begin processing the 90th record. run: 1413 subRun: 1 event: 66890 at 24-Oct-2025 23:13:07 CEST
Begin processing the 91st record. run: 1413 subRun: 1 event: 66891 at 24-Oct-2025 23:13:09 CEST
Begin processing the 92nd record. run: 1413 subRun: 1 event: 66892 at 24-Oct-2025 23:13:11 CEST
Begin processing the 93rd record. run: 1413 subRun: 1 event: 66893 at 24-Oct-2025 23:13:18 CEST
Begin processing the 94th record. run: 1413 subRun: 1 event: 66894 at 24-Oct-2025 23:13:20 CEST
Begin processing the 95th record. run: 1413 subRun: 1 event: 66895 at 24-Oct-2025 23:13:23 CEST
Begin processing the 96th record. run: 1413 subRun: 1 event: 66896 at 24-Oct-2025 23:13:26 CEST
Begin processing the 97th record. run: 1413 subRun: 1 event: 66897 at 24-Oct-2025 23:13:29 CEST
Begin processing the 98th record. run: 1413 subRun: 1 event: 66898 at 24-Oct-2025 23:13:31 CEST
Begin processing the 99th record. run: 1413 subRun: 1 event: 66899 at 24-Oct-2025 23:13:34 CEST
Begin processing the 100th record. run: 1413 subRun: 1 event: 66900 at 24-Oct-2025 23:13:37 CEST
24-Oct-2025 23:13:43 CEST  Closed output file "nu_dune10kt_1x2x6_1413_668_20230826T183345Z_gen_g4_detsim_hitreco__20240229T184341Z_reco2_reco2.root"
24-Oct-2025 23:13:43 CEST  Closed input file "root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/fardet-hd/ad/e2/nu_dune10kt_1x2x6_1413_668_20230826T183345Z_gen_g4_detsim_hitreco__20240229T184341Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.148843       3.88175       46.5285       2.35701       5.18815        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0343973     0.0362947     0.163905      0.0349666     0.0128307       100    
reco:pandora:StandardPandora                   0.112587       3.83564       46.4674       2.31783       5.18294        100    
[art]:TriggerResults:TriggerResultInserter     1.099e-05    2.02211e-05   0.000158452   1.63605e-05   1.56462e-05      100    
end_path:out1:RootOutput                       3.01e-06     4.95365e-06    2.183e-05    4.9155e-06    2.26577e-06      100    
end_path:out1:RootOutput(write)               0.000836887   0.00959468     0.0380626    0.00680053    0.00802788       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2356.66 MB
  Peak resident set size usage (VmHWM): 1365.16 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
justIN time: 2025-11-05 05:01:50 UTC       justIN version: 01.05.01