justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 238339.23@dunegpschedd01.fnal.gov

Jobsub ID238339.23@dunegpschedd01.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 21:05:31
SiteCERN
EntryCMSHTPC_T2_CH_CERN_ce507
Last heartbeat2025-10-24 21:23:25
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:08:10
Input filesfardet-hd:nu_dune10kt_1x2x6_1410_117_20230826T123320Z_gen_g4_detsim_hitreco__20240229T191322Z_reco2.root
JobscriptExit code0
Real time14m (850s)
CPU time6m (414s = 48%)
Max RSS bytes1410727936 (1345 MiB)
Outputting started2025-10-24 21:22:22
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09327/1/001/ClusterValidation_WithAlg_nu_dune10kt_1x2x6_1410_117_20230826T123320Z_gen_g4_detsim_hitreco__20240229T191322Z_reco2.root
https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09327/1/001/ClusterValidation_WithoutAlg_nu_dune10kt_1x2x6_1410_117_20230826T123320Z_gen_g4_detsim_hitreco__20240229T191322Z_reco2.root
Finished2025-10-24 21:23:25
Saved logsjustin-logs:238339.23-dunegpschedd01.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/4b/6e/nu_dune10kt_1x2x6_1410_117_20230826T123320Z_gen_g4_detsim_hitreco__20240229T191322Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 35th record. run: 1410 subRun: 1 event: 11735 at 24-Oct-2025 23:17:28 CEST
Begin processing the 36th record. run: 1410 subRun: 1 event: 11736 at 24-Oct-2025 23:17:31 CEST
Begin processing the 37th record. run: 1410 subRun: 1 event: 11737 at 24-Oct-2025 23:17:33 CEST
Begin processing the 38th record. run: 1410 subRun: 1 event: 11738 at 24-Oct-2025 23:17:35 CEST
Begin processing the 39th record. run: 1410 subRun: 1 event: 11739 at 24-Oct-2025 23:17:37 CEST
Begin processing the 40th record. run: 1410 subRun: 1 event: 11740 at 24-Oct-2025 23:17:39 CEST
Begin processing the 41st record. run: 1410 subRun: 1 event: 11741 at 24-Oct-2025 23:17:42 CEST
Begin processing the 42nd record. run: 1410 subRun: 1 event: 11742 at 24-Oct-2025 23:17:47 CEST
Begin processing the 43rd record. run: 1410 subRun: 1 event: 11743 at 24-Oct-2025 23:17:50 CEST
Begin processing the 44th record. run: 1410 subRun: 1 event: 11744 at 24-Oct-2025 23:17:52 CEST
Begin processing the 45th record. run: 1410 subRun: 1 event: 11745 at 24-Oct-2025 23:18:21 CEST
Begin processing the 46th record. run: 1410 subRun: 1 event: 11746 at 24-Oct-2025 23:18:25 CEST
Begin processing the 47th record. run: 1410 subRun: 1 event: 11747 at 24-Oct-2025 23:18:48 CEST
Begin processing the 48th record. run: 1410 subRun: 1 event: 11748 at 24-Oct-2025 23:18:50 CEST
Begin processing the 49th record. run: 1410 subRun: 1 event: 11749 at 24-Oct-2025 23:18:51 CEST
Begin processing the 50th record. run: 1410 subRun: 1 event: 11750 at 24-Oct-2025 23:18:54 CEST
Begin processing the 51st record. run: 1410 subRun: 1 event: 11751 at 24-Oct-2025 23:19:00 CEST
Begin processing the 52nd record. run: 1410 subRun: 1 event: 11752 at 24-Oct-2025 23:19:36 CEST
Begin processing the 53rd record. run: 1410 subRun: 1 event: 11753 at 24-Oct-2025 23:19:38 CEST
Begin processing the 54th record. run: 1410 subRun: 1 event: 11754 at 24-Oct-2025 23:19:41 CEST
Begin processing the 55th record. run: 1410 subRun: 1 event: 11755 at 24-Oct-2025 23:19:43 CEST
Begin processing the 56th record. run: 1410 subRun: 1 event: 11756 at 24-Oct-2025 23:19:46 CEST
Begin processing the 57th record. run: 1410 subRun: 1 event: 11757 at 24-Oct-2025 23:19:49 CEST
Begin processing the 58th record. run: 1410 subRun: 1 event: 11758 at 24-Oct-2025 23:19:51 CEST
Begin processing the 59th record. run: 1410 subRun: 1 event: 11759 at 24-Oct-2025 23:19:56 CEST
Begin processing the 60th record. run: 1410 subRun: 1 event: 11760 at 24-Oct-2025 23:19:59 CEST
Begin processing the 61st record. run: 1410 subRun: 1 event: 11761 at 24-Oct-2025 23:20:01 CEST
Begin processing the 62nd record. run: 1410 subRun: 1 event: 11762 at 24-Oct-2025 23:20:04 CEST
Begin processing the 63rd record. run: 1410 subRun: 1 event: 11763 at 24-Oct-2025 23:20:07 CEST
Begin processing the 64th record. run: 1410 subRun: 1 event: 11764 at 24-Oct-2025 23:20:09 CEST
Begin processing the 65th record. run: 1410 subRun: 1 event: 11765 at 24-Oct-2025 23:20:12 CEST
Begin processing the 66th record. run: 1410 subRun: 1 event: 11766 at 24-Oct-2025 23:20:15 CEST
Begin processing the 67th record. run: 1410 subRun: 1 event: 11767 at 24-Oct-2025 23:20:17 CEST
Begin processing the 68th record. run: 1410 subRun: 1 event: 11768 at 24-Oct-2025 23:20:20 CEST
Begin processing the 69th record. run: 1410 subRun: 1 event: 11769 at 24-Oct-2025 23:20:22 CEST
Begin processing the 70th record. run: 1410 subRun: 1 event: 11770 at 24-Oct-2025 23:20:24 CEST
Begin processing the 71st record. run: 1410 subRun: 1 event: 11771 at 24-Oct-2025 23:20:27 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 72nd record. run: 1410 subRun: 1 event: 11772 at 24-Oct-2025 23:20:28 CEST
Begin processing the 73rd record. run: 1410 subRun: 1 event: 11773 at 24-Oct-2025 23:20:30 CEST
Begin processing the 74th record. run: 1410 subRun: 1 event: 11774 at 24-Oct-2025 23:20:49 CEST
PcaShowerParticleBuildingAlgorithm::OpeningAngle - principal eigenvalue less than or equal to 0.
PcaShowerParticleBuildingAlgorithm::OpeningAngle - principal eigenvalue less than or equal to 0.
Begin processing the 75th record. run: 1410 subRun: 1 event: 11775 at 24-Oct-2025 23:20:55 CEST
Begin processing the 76th record. run: 1410 subRun: 1 event: 11776 at 24-Oct-2025 23:20:59 CEST
Begin processing the 77th record. run: 1410 subRun: 1 event: 11777 at 24-Oct-2025 23:21:01 CEST
Begin processing the 78th record. run: 1410 subRun: 1 event: 11778 at 24-Oct-2025 23:21:03 CEST
Begin processing the 79th record. run: 1410 subRun: 1 event: 11779 at 24-Oct-2025 23:21:05 CEST
Begin processing the 80th record. run: 1410 subRun: 1 event: 11780 at 24-Oct-2025 23:21:19 CEST
Begin processing the 81st record. run: 1410 subRun: 1 event: 11781 at 24-Oct-2025 23:21:22 CEST
Begin processing the 82nd record. run: 1410 subRun: 1 event: 11782 at 24-Oct-2025 23:21:27 CEST
Begin processing the 83rd record. run: 1410 subRun: 1 event: 11783 at 24-Oct-2025 23:21:30 CEST
Begin processing the 84th record. run: 1410 subRun: 1 event: 11784 at 24-Oct-2025 23:21:32 CEST
Begin processing the 85th record. run: 1410 subRun: 1 event: 11785 at 24-Oct-2025 23:21:35 CEST
Begin processing the 86th record. run: 1410 subRun: 1 event: 11786 at 24-Oct-2025 23:21:38 CEST
Begin processing the 87th record. run: 1410 subRun: 1 event: 11787 at 24-Oct-2025 23:21:40 CEST
Begin processing the 88th record. run: 1410 subRun: 1 event: 11788 at 24-Oct-2025 23:21:43 CEST
Begin processing the 89th record. run: 1410 subRun: 1 event: 11789 at 24-Oct-2025 23:21:45 CEST
Begin processing the 90th record. run: 1410 subRun: 1 event: 11790 at 24-Oct-2025 23:21:49 CEST
Begin processing the 91st record. run: 1410 subRun: 1 event: 11791 at 24-Oct-2025 23:21:51 CEST
Begin processing the 92nd record. run: 1410 subRun: 1 event: 11792 at 24-Oct-2025 23:21:53 CEST
Begin processing the 93rd record. run: 1410 subRun: 1 event: 11793 at 24-Oct-2025 23:21:55 CEST
Begin processing the 94th record. run: 1410 subRun: 1 event: 11794 at 24-Oct-2025 23:21:57 CEST
Begin processing the 95th record. run: 1410 subRun: 1 event: 11795 at 24-Oct-2025 23:22:00 CEST
Begin processing the 96th record. run: 1410 subRun: 1 event: 11796 at 24-Oct-2025 23:22:03 CEST
Begin processing the 97th record. run: 1410 subRun: 1 event: 11797 at 24-Oct-2025 23:22:06 CEST
Begin processing the 98th record. run: 1410 subRun: 1 event: 11798 at 24-Oct-2025 23:22:11 CEST
Begin processing the 99th record. run: 1410 subRun: 1 event: 11799 at 24-Oct-2025 23:22:13 CEST
Begin processing the 100th record. run: 1410 subRun: 1 event: 11800 at 24-Oct-2025 23:22:18 CEST
24-Oct-2025 23:22:21 CEST  Closed output file "nu_dune10kt_1x2x6_1410_117_20230826T123320Z_gen_g4_detsim_hitreco__20240229T191322Z_reco2_reco2.root"
24-Oct-2025 23:22:21 CEST  Closed input file "root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/fardet-hd/4b/6e/nu_dune10kt_1x2x6_1410_117_20230826T123320Z_gen_g4_detsim_hitreco__20240229T191322Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      0.14909       3.86147       35.0114       2.22833       5.28487        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0180957     0.0384249     0.069549      0.0362138    0.00756195       100    
reco:pandora:StandardPandora                    0.11267       3.81365       34.9296       2.18179       5.27592        100    
[art]:TriggerResults:TriggerResultInserter     9.22e-06     2.31692e-05   0.000588106   1.3775e-05    6.00439e-05      100    
end_path:out1:RootOutput                       2.22e-06     3.09125e-06   2.0151e-05     2.76e-06     1.83486e-06      100    
end_path:out1:RootOutput(write)               0.00095511    0.00919359     0.0509993    0.00511064     0.0101481       100    
================================================================================================================================

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

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