justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 242416.26@dunegpschedd01.fnal.gov

Jobsub ID242416.26@dunegpschedd01.fnal.gov
Workflow ID9556
Stage ID1
User nameimawby@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit43200 (12 hours)
Submitted time2025-11-03 16:45:05
SiteNL_SURFsara
EntryDUNE_SurfSARA_arc03
Last heartbeat2025-11-03 17:19:46
From worker nodeHostnamewn-lb-15.gina.surf.nl
cpuinfoAMD EPYC 9754 128-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit129600 (36 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-11-03 17:11:49
Input filesfardet-hd:nu_dune10kt_1x2x6_1413_524_20230826T183337Z_gen_g4_detsim_hitreco__20240229T181346Z_reco2.root
JobscriptExit code0
Real time7m (437s)
CPU time6m (414s = 94%)
Max RSS bytes1353474048 (1290 MiB)
Outputting started2025-11-03 17:19:07
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/splitting_nu_1/fnal/09556/1/001/CheatingKalmanSplittingU_nu_dune10kt_1x2x6_1413_524_20230826T183337Z_gen_g4_detsim_hitreco__20240229T181346Z_reco2.root
Finished2025-11-03 17:19:46
Saved logsjustin-logs:242416.26-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/ae/cd/nu_dune10kt_1x2x6_1413_524_20230826T183337Z_gen_g4_detsim_hitreco__20240229T181346Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 33rd record. run: 1413 subRun: 1 event: 52433 at 03-Nov-2025 18:14:53 CET
Begin processing the 34th record. run: 1413 subRun: 1 event: 52434 at 03-Nov-2025 18:14:57 CET
Begin processing the 35th record. run: 1413 subRun: 1 event: 52435 at 03-Nov-2025 18:15:00 CET
Begin processing the 36th record. run: 1413 subRun: 1 event: 52436 at 03-Nov-2025 18:15:04 CET
Begin processing the 37th record. run: 1413 subRun: 1 event: 52437 at 03-Nov-2025 18:15:08 CET
Begin processing the 38th record. run: 1413 subRun: 1 event: 52438 at 03-Nov-2025 18:15:11 CET
Begin processing the 39th record. run: 1413 subRun: 1 event: 52439 at 03-Nov-2025 18:15:14 CET
Begin processing the 40th record. run: 1413 subRun: 1 event: 52440 at 03-Nov-2025 18:15:17 CET
Begin processing the 41st record. run: 1413 subRun: 1 event: 52441 at 03-Nov-2025 18:15:20 CET
Begin processing the 42nd record. run: 1413 subRun: 1 event: 52442 at 03-Nov-2025 18:15:24 CET
Begin processing the 43rd record. run: 1413 subRun: 1 event: 52443 at 03-Nov-2025 18:15:27 CET
Begin processing the 44th record. run: 1413 subRun: 1 event: 52444 at 03-Nov-2025 18:15:30 CET
Begin processing the 45th record. run: 1413 subRun: 1 event: 52445 at 03-Nov-2025 18:15:34 CET
Begin processing the 46th record. run: 1413 subRun: 1 event: 52446 at 03-Nov-2025 18:15:37 CET
Begin processing the 47th record. run: 1413 subRun: 1 event: 52447 at 03-Nov-2025 18:15:40 CET
Begin processing the 48th record. run: 1413 subRun: 1 event: 52448 at 03-Nov-2025 18:15:43 CET
Begin processing the 49th record. run: 1413 subRun: 1 event: 52449 at 03-Nov-2025 18:15:46 CET
Begin processing the 50th record. run: 1413 subRun: 1 event: 52450 at 03-Nov-2025 18:15:50 CET
Begin processing the 51st record. run: 1413 subRun: 1 event: 52451 at 03-Nov-2025 18:15:53 CET
Begin processing the 52nd record. run: 1413 subRun: 1 event: 52452 at 03-Nov-2025 18:15:56 CET
Begin processing the 53rd record. run: 1413 subRun: 1 event: 52453 at 03-Nov-2025 18:16:00 CET
Begin processing the 54th record. run: 1413 subRun: 1 event: 52454 at 03-Nov-2025 18:16:03 CET
Begin processing the 55th record. run: 1413 subRun: 1 event: 52455 at 03-Nov-2025 18:16:06 CET
Begin processing the 56th record. run: 1413 subRun: 1 event: 52456 at 03-Nov-2025 18:16:09 CET
Begin processing the 57th record. run: 1413 subRun: 1 event: 52457 at 03-Nov-2025 18:16:12 CET
Begin processing the 58th record. run: 1413 subRun: 1 event: 52458 at 03-Nov-2025 18:16:16 CET
Begin processing the 59th record. run: 1413 subRun: 1 event: 52459 at 03-Nov-2025 18:16:20 CET
Begin processing the 60th record. run: 1413 subRun: 1 event: 52460 at 03-Nov-2025 18:16:24 CET
Begin processing the 61st record. run: 1413 subRun: 1 event: 52461 at 03-Nov-2025 18:16:27 CET
Begin processing the 62nd record. run: 1413 subRun: 1 event: 52462 at 03-Nov-2025 18:16:30 CET
Begin processing the 63rd record. run: 1413 subRun: 1 event: 52463 at 03-Nov-2025 18:16:33 CET
Begin processing the 64th record. run: 1413 subRun: 1 event: 52464 at 03-Nov-2025 18:16:37 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: 1413 subRun: 1 event: 52465 at 03-Nov-2025 18:16:37 CET
Begin processing the 66th record. run: 1413 subRun: 1 event: 52466 at 03-Nov-2025 18:16:40 CET
Begin processing the 67th record. run: 1413 subRun: 1 event: 52467 at 03-Nov-2025 18:16:44 CET
Begin processing the 68th record. run: 1413 subRun: 1 event: 52468 at 03-Nov-2025 18:16:47 CET
Begin processing the 69th record. run: 1413 subRun: 1 event: 52469 at 03-Nov-2025 18:16:50 CET
Begin processing the 70th record. run: 1413 subRun: 1 event: 52470 at 03-Nov-2025 18:16:53 CET
Begin processing the 71st record. run: 1413 subRun: 1 event: 52471 at 03-Nov-2025 18:16:56 CET
Begin processing the 72nd record. run: 1413 subRun: 1 event: 52472 at 03-Nov-2025 18:16:59 CET
Begin processing the 73rd record. run: 1413 subRun: 1 event: 52473 at 03-Nov-2025 18:17:05 CET
Begin processing the 74th record. run: 1413 subRun: 1 event: 52474 at 03-Nov-2025 18:17:10 CET
Begin processing the 75th record. run: 1413 subRun: 1 event: 52475 at 03-Nov-2025 18:17:14 CET
Begin processing the 76th record. run: 1413 subRun: 1 event: 52476 at 03-Nov-2025 18:17:19 CET
Begin processing the 77th record. run: 1413 subRun: 1 event: 52477 at 03-Nov-2025 18:17:23 CET
Begin processing the 78th record. run: 1413 subRun: 1 event: 52478 at 03-Nov-2025 18:17:26 CET
Begin processing the 79th record. run: 1413 subRun: 1 event: 52479 at 03-Nov-2025 18:17:35 CET
Begin processing the 80th record. run: 1413 subRun: 1 event: 52480 at 03-Nov-2025 18:17:39 CET
Begin processing the 81st record. run: 1413 subRun: 1 event: 52481 at 03-Nov-2025 18:17:43 CET
Begin processing the 82nd record. run: 1413 subRun: 1 event: 52482 at 03-Nov-2025 18:17:46 CET
Begin processing the 83rd record. run: 1413 subRun: 1 event: 52483 at 03-Nov-2025 18:17:51 CET
Begin processing the 84th record. run: 1413 subRun: 1 event: 52484 at 03-Nov-2025 18:17:54 CET
Begin processing the 85th record. run: 1413 subRun: 1 event: 52485 at 03-Nov-2025 18:17:58 CET
Begin processing the 86th record. run: 1413 subRun: 1 event: 52486 at 03-Nov-2025 18:18:02 CET
Begin processing the 87th record. run: 1413 subRun: 1 event: 52487 at 03-Nov-2025 18:18:06 CET
Begin processing the 88th record. run: 1413 subRun: 1 event: 52488 at 03-Nov-2025 18:18:09 CET
Begin processing the 89th record. run: 1413 subRun: 1 event: 52489 at 03-Nov-2025 18:18:12 CET
Begin processing the 90th record. run: 1413 subRun: 1 event: 52490 at 03-Nov-2025 18:18:16 CET
Begin processing the 91st record. run: 1413 subRun: 1 event: 52491 at 03-Nov-2025 18:18:21 CET
Begin processing the 92nd record. run: 1413 subRun: 1 event: 52492 at 03-Nov-2025 18:18:24 CET
Begin processing the 93rd record. run: 1413 subRun: 1 event: 52493 at 03-Nov-2025 18:18:36 CET
Begin processing the 94th record. run: 1413 subRun: 1 event: 52494 at 03-Nov-2025 18:18:40 CET
Begin processing the 95th record. run: 1413 subRun: 1 event: 52495 at 03-Nov-2025 18:18:44 CET
Begin processing the 96th record. run: 1413 subRun: 1 event: 52496 at 03-Nov-2025 18:18:48 CET
Begin processing the 97th record. run: 1413 subRun: 1 event: 52497 at 03-Nov-2025 18:18:51 CET
Begin processing the 98th record. run: 1413 subRun: 1 event: 52498 at 03-Nov-2025 18:18:54 CET
Begin processing the 99th record. run: 1413 subRun: 1 event: 52499 at 03-Nov-2025 18:18:57 CET
Begin processing the 100th record. run: 1413 subRun: 1 event: 52500 at 03-Nov-2025 18:19:00 CET
03-Nov-2025 18:19:05 CET  Closed output file "nu_dune10kt_1x2x6_1413_524_20230826T183337Z_gen_g4_detsim_hitreco__20240229T181346Z_reco2_reco2.root"
03-Nov-2025 18:19:05 CET  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/ae/cd/nu_dune10kt_1x2x6_1413_524_20230826T183337Z_gen_g4_detsim_hitreco__20240229T181346Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0411399      3.52103       10.959        3.29345       1.07078        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0044325     0.0641485      2.27078      0.0223946     0.275063        100    
reco:pandora:StandardPandora                   0.0260585      3.45053       10.9233       3.2356        1.01586        100    
[art]:TriggerResults:TriggerResultInserter    1.5424e-05    2.7786e-05    0.000175804   2.4937e-05    1.73431e-05      100    
end_path:out1:RootOutput                       4.958e-06    6.84995e-06   2.3405e-05     5.923e-06    2.97772e-06      100    
end_path:out1:RootOutput(write)               0.00122488    0.00602345     0.0271666    0.00486205    0.00464602       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2333.59 MB
  Peak resident set size usage (VmHWM): 1353.47 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:40:11 UTC       justIN version: 01.05.01