justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 242413.71@dunegpschedd01.fnal.gov

Jobsub ID242413.71@dunegpschedd01.fnal.gov
Workflow ID9555
Stage ID1
User nameimawby@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes1048576000 (1000 MiB)
Wall seconds limit7200 (2 hours)
Submitted time2025-11-03 16:39:03
SiteNL_SURFsara
EntryDUNE_SurfSARA_arc03
Last heartbeat2025-11-03 16:48:33
From worker nodeHostnamewn-la-20.gina.surf.nl
cpuinfoAMD EPYC 9754 128-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes1048576000 (1000 MiB)
Wall seconds limit129600 (36 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-11-03 16:40:14
Input filesfardet-hd:nu_dune10kt_1x2x6_1412_889_20230826T153639Z_gen_g4_detsim_hitreco__20240229T181927Z_reco2.root
JobscriptExit code0
Real time7m (463s)
CPU time6m (375s = 80%)
Max RSS bytes1403322368 (1338 MiB)
Outputting started2025-11-03 16:47:58
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/splitting_nu_0/fnal/09555/1/001/CheatingKalmanSplittingU_nu_dune10kt_1x2x6_1412_889_20230826T153639Z_gen_g4_detsim_hitreco__20240229T181927Z_reco2.root
Finished2025-11-03 16:48:33
Saved logsjustin-logs:242413.71-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

-----------------------------
Input PFN = root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/4c/73/nu_dune10kt_1x2x6_1412_889_20230826T153639Z_gen_g4_detsim_hitreco__20240229T181927Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
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 37th record. run: 1412 subRun: 1 event: 88937 at 03-Nov-2025 17:44:15 CET
Begin processing the 38th record. run: 1412 subRun: 1 event: 88938 at 03-Nov-2025 17:44:18 CET
Begin processing the 39th record. run: 1412 subRun: 1 event: 88939 at 03-Nov-2025 17:44:21 CET
Begin processing the 40th record. run: 1412 subRun: 1 event: 88940 at 03-Nov-2025 17:44:35 CET
Begin processing the 41st record. run: 1412 subRun: 1 event: 88941 at 03-Nov-2025 17:44:38 CET
Begin processing the 42nd record. run: 1412 subRun: 1 event: 88942 at 03-Nov-2025 17:44:42 CET
Begin processing the 43rd record. run: 1412 subRun: 1 event: 88943 at 03-Nov-2025 17:44:45 CET
Begin processing the 44th record. run: 1412 subRun: 1 event: 88944 at 03-Nov-2025 17:44:48 CET
Begin processing the 45th record. run: 1412 subRun: 1 event: 88945 at 03-Nov-2025 17:44:51 CET
Begin processing the 46th record. run: 1412 subRun: 1 event: 88946 at 03-Nov-2025 17:44:54 CET
Begin processing the 47th record. run: 1412 subRun: 1 event: 88947 at 03-Nov-2025 17:44:57 CET
Begin processing the 48th record. run: 1412 subRun: 1 event: 88948 at 03-Nov-2025 17:45:00 CET
Begin processing the 49th record. run: 1412 subRun: 1 event: 88949 at 03-Nov-2025 17:45:04 CET
Begin processing the 50th record. run: 1412 subRun: 1 event: 88950 at 03-Nov-2025 17:45:07 CET
Begin processing the 51st record. run: 1412 subRun: 1 event: 88951 at 03-Nov-2025 17:45:10 CET
Begin processing the 52nd record. run: 1412 subRun: 1 event: 88952 at 03-Nov-2025 17:45:13 CET
Begin processing the 53rd record. run: 1412 subRun: 1 event: 88953 at 03-Nov-2025 17:45:18 CET
Begin processing the 54th record. run: 1412 subRun: 1 event: 88954 at 03-Nov-2025 17:45:22 CET
Begin processing the 55th record. run: 1412 subRun: 1 event: 88955 at 03-Nov-2025 17:45:25 CET
Begin processing the 56th record. run: 1412 subRun: 1 event: 88956 at 03-Nov-2025 17:45:29 CET
Begin processing the 57th record. run: 1412 subRun: 1 event: 88957 at 03-Nov-2025 17:45:32 CET
Begin processing the 58th record. run: 1412 subRun: 1 event: 88958 at 03-Nov-2025 17:45:35 CET
Begin processing the 59th record. run: 1412 subRun: 1 event: 88959 at 03-Nov-2025 17:45:38 CET
Begin processing the 60th record. run: 1412 subRun: 1 event: 88960 at 03-Nov-2025 17:45:41 CET
Begin processing the 61st record. run: 1412 subRun: 1 event: 88961 at 03-Nov-2025 17:45:44 CET
Begin processing the 62nd record. run: 1412 subRun: 1 event: 88962 at 03-Nov-2025 17:45:48 CET
Begin processing the 63rd record. run: 1412 subRun: 1 event: 88963 at 03-Nov-2025 17:45:51 CET
Begin processing the 64th record. run: 1412 subRun: 1 event: 88964 at 03-Nov-2025 17:45:54 CET
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 65th record. run: 1412 subRun: 1 event: 88965 at 03-Nov-2025 17:45:54 CET
Begin processing the 66th record. run: 1412 subRun: 1 event: 88966 at 03-Nov-2025 17:45:58 CET
Begin processing the 67th record. run: 1412 subRun: 1 event: 88967 at 03-Nov-2025 17:46:01 CET
Begin processing the 68th record. run: 1412 subRun: 1 event: 88968 at 03-Nov-2025 17:46:04 CET
Begin processing the 69th record. run: 1412 subRun: 1 event: 88969 at 03-Nov-2025 17:46:07 CET
Begin processing the 70th record. run: 1412 subRun: 1 event: 88970 at 03-Nov-2025 17:46:11 CET
Begin processing the 71st record. run: 1412 subRun: 1 event: 88971 at 03-Nov-2025 17:46:14 CET
Begin processing the 72nd record. run: 1412 subRun: 1 event: 88972 at 03-Nov-2025 17:46:17 CET
Begin processing the 73rd record. run: 1412 subRun: 1 event: 88973 at 03-Nov-2025 17:46:20 CET
Begin processing the 74th record. run: 1412 subRun: 1 event: 88974 at 03-Nov-2025 17:46:23 CET
Begin processing the 75th record. run: 1412 subRun: 1 event: 88975 at 03-Nov-2025 17:46:26 CET
Begin processing the 76th record. run: 1412 subRun: 1 event: 88976 at 03-Nov-2025 17:46:29 CET
Begin processing the 77th record. run: 1412 subRun: 1 event: 88977 at 03-Nov-2025 17:46:32 CET
Begin processing the 78th record. run: 1412 subRun: 1 event: 88978 at 03-Nov-2025 17:46:35 CET
Begin processing the 79th record. run: 1412 subRun: 1 event: 88979 at 03-Nov-2025 17:46:39 CET
Begin processing the 80th record. run: 1412 subRun: 1 event: 88980 at 03-Nov-2025 17:46:43 CET
Begin processing the 81st record. run: 1412 subRun: 1 event: 88981 at 03-Nov-2025 17:46:46 CET
Begin processing the 82nd record. run: 1412 subRun: 1 event: 88982 at 03-Nov-2025 17:46:49 CET
Begin processing the 83rd record. run: 1412 subRun: 1 event: 88983 at 03-Nov-2025 17:46:52 CET
Begin processing the 84th record. run: 1412 subRun: 1 event: 88984 at 03-Nov-2025 17:47:02 CET
Begin processing the 85th record. run: 1412 subRun: 1 event: 88985 at 03-Nov-2025 17:47:05 CET
Begin processing the 86th record. run: 1412 subRun: 1 event: 88986 at 03-Nov-2025 17:47:08 CET
Begin processing the 87th record. run: 1412 subRun: 1 event: 88987 at 03-Nov-2025 17:47:11 CET
Begin processing the 88th record. run: 1412 subRun: 1 event: 88988 at 03-Nov-2025 17:47:15 CET
Begin processing the 89th record. run: 1412 subRun: 1 event: 88989 at 03-Nov-2025 17:47:18 CET
Begin processing the 90th record. run: 1412 subRun: 1 event: 88990 at 03-Nov-2025 17:47:21 CET
Begin processing the 91st record. run: 1412 subRun: 1 event: 88991 at 03-Nov-2025 17:47:25 CET
Begin processing the 92nd record. run: 1412 subRun: 1 event: 88992 at 03-Nov-2025 17:47:28 CET
Begin processing the 93rd record. run: 1412 subRun: 1 event: 88993 at 03-Nov-2025 17:47:31 CET
Begin processing the 94th record. run: 1412 subRun: 1 event: 88994 at 03-Nov-2025 17:47:34 CET
Begin processing the 95th record. run: 1412 subRun: 1 event: 88995 at 03-Nov-2025 17:47:38 CET
Begin processing the 96th record. run: 1412 subRun: 1 event: 88996 at 03-Nov-2025 17:47:41 CET
Begin processing the 97th record. run: 1412 subRun: 1 event: 88997 at 03-Nov-2025 17:47:44 CET
Begin processing the 98th record. run: 1412 subRun: 1 event: 88998 at 03-Nov-2025 17:47:47 CET
Begin processing the 99th record. run: 1412 subRun: 1 event: 88999 at 03-Nov-2025 17:47:50 CET
Begin processing the 100th record. run: 1412 subRun: 1 event: 89000 at 03-Nov-2025 17:47:54 CET
03-Nov-2025 17:47:57 CET  Closed output file "nu_dune10kt_1x2x6_1412_889_20230826T153639Z_gen_g4_detsim_hitreco__20240229T181927Z_reco2_reco2.root"
03-Nov-2025 17:47:57 CET  Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/4c/73/nu_dune10kt_1x2x6_1412_889_20230826T153639Z_gen_g4_detsim_hitreco__20240229T181927Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0894952      3.14601       13.0006       2.95792       1.32308        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0207422     0.0367032     0.0647181     0.0386065     0.0104064       100    
reco:pandora:StandardPandora                   0.067105       3.10453       12.9367       2.92356       1.31885        100    
[art]:TriggerResults:TriggerResultInserter    1.5042e-05    2.56352e-05   0.000161962   2.14115e-05   1.73301e-05      100    
end_path:out1:RootOutput                       4.256e-06    5.36682e-06    2.034e-05     5.143e-06    1.57175e-06      100    
end_path:out1:RootOutput(write)               0.00117566    0.00451162     0.0233126    0.00295692    0.00365903       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2385.05 MB
  Peak resident set size usage (VmHWM): 1403.32 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
mv: cannot stat 'CheatingKalmanSplittingV.root': No such file or directory
mv: cannot stat 'CheatingKalmanSplittingW.root': No such file or directory
justIN time: 2025-11-04 01:41:31 UTC       justIN version: 01.05.01