justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 47035.13@dunegpschedd01.fnal.gov

Jobsub ID47035.13@dunegpschedd01.fnal.gov
Workflow ID2661
Stage ID1
User nameimawby@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit43200 (12 hours)
Submitted time2025-09-16 16:21:10
SiteES_PIC
EntryDUNE_T1_ES_PIC_ce15-multicore
Last heartbeat2025-09-16 16:37:08
From worker nodeHostnamehnode56.pic.es
cpuinfoAMD EPYC 7402P 24-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit216000 (60 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-09-16 16:22:27
Input filesfardet-hd:nu_dune10kt_1x2x6_1412_364_20230826T153315Z_gen_g4_detsim_hitreco__20240227T211545Z_reco2.root
JobscriptExit code0
Real time13m (823s)
CPU time5m (330s = 40%)
Max RSS bytes1386340352 (1322 MiB)
Outputting started2025-09-16 16:36:11
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/splitting_nu_3/fnal/02661/1/001/CheatingKalmanSplittingU_nu_dune10kt_1x2x6_1412_364_20230826T153315Z_gen_g4_detsim_hitreco__20240227T211545Z_reco2.root
https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/splitting_nu_3/fnal/02661/1/001/CheatingKalmanSplittingV_nu_dune10kt_1x2x6_1412_364_20230826T153315Z_gen_g4_detsim_hitreco__20240227T211545Z_reco2.root
https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/splitting_nu_3/fnal/02661/1/001/CheatingKalmanSplittingW_nu_dune10kt_1x2x6_1412_364_20230826T153315Z_gen_g4_detsim_hitreco__20240227T211545Z_reco2.root
Finished2025-09-16 16:37:08
Saved logsjustin-logs:47035.13-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

this block should be empty ------------------
---------------------------------------------------------
Input PFN = root://xrootd.echo.stfc.ac.uk:1094/dune:/protodune/RSE/fardet-hd/7c/e8/nu_dune10kt_1x2x6_1412_364_20230826T153315Z_gen_g4_detsim_hitreco__20240227T211545Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 33rd record. run: 1412 subRun: 1 event: 36433 at 16-Sep-2025 18:30:27 CEST
Begin processing the 34th record. run: 1412 subRun: 1 event: 36434 at 16-Sep-2025 18:30:40 CEST
Begin processing the 35th record. run: 1412 subRun: 1 event: 36435 at 16-Sep-2025 18:30:45 CEST
Begin processing the 36th record. run: 1412 subRun: 1 event: 36436 at 16-Sep-2025 18:30:50 CEST
Begin processing the 37th record. run: 1412 subRun: 1 event: 36437 at 16-Sep-2025 18:30:54 CEST
Begin processing the 38th record. run: 1412 subRun: 1 event: 36438 at 16-Sep-2025 18:30:59 CEST
Begin processing the 39th record. run: 1412 subRun: 1 event: 36439 at 16-Sep-2025 18:31:04 CEST
Begin processing the 40th record. run: 1412 subRun: 1 event: 36440 at 16-Sep-2025 18:31:08 CEST
Begin processing the 41st record. run: 1412 subRun: 1 event: 36441 at 16-Sep-2025 18:31:13 CEST
Begin processing the 42nd record. run: 1412 subRun: 1 event: 36442 at 16-Sep-2025 18:31:17 CEST
Begin processing the 43rd record. run: 1412 subRun: 1 event: 36443 at 16-Sep-2025 18:31:24 CEST
Begin processing the 44th record. run: 1412 subRun: 1 event: 36444 at 16-Sep-2025 18:31:28 CEST
Begin processing the 45th record. run: 1412 subRun: 1 event: 36445 at 16-Sep-2025 18:31:33 CEST
Begin processing the 46th record. run: 1412 subRun: 1 event: 36446 at 16-Sep-2025 18:31:38 CEST
Begin processing the 47th record. run: 1412 subRun: 1 event: 36447 at 16-Sep-2025 18:31:42 CEST
Begin processing the 48th record. run: 1412 subRun: 1 event: 36448 at 16-Sep-2025 18:31:47 CEST
Begin processing the 49th record. run: 1412 subRun: 1 event: 36449 at 16-Sep-2025 18:31:52 CEST
Begin processing the 50th record. run: 1412 subRun: 1 event: 36450 at 16-Sep-2025 18:32:03 CEST
Begin processing the 51st record. run: 1412 subRun: 1 event: 36451 at 16-Sep-2025 18:32:10 CEST
Begin processing the 52nd record. run: 1412 subRun: 1 event: 36452 at 16-Sep-2025 18:32:15 CEST
Begin processing the 53rd record. run: 1412 subRun: 1 event: 36453 at 16-Sep-2025 18:32:19 CEST
Begin processing the 54th record. run: 1412 subRun: 1 event: 36454 at 16-Sep-2025 18:32:24 CEST
Begin processing the 55th record. run: 1412 subRun: 1 event: 36455 at 16-Sep-2025 18:32:28 CEST
Begin processing the 56th record. run: 1412 subRun: 1 event: 36456 at 16-Sep-2025 18:32:33 CEST
Begin processing the 57th record. run: 1412 subRun: 1 event: 36457 at 16-Sep-2025 18:32:39 CEST
Begin processing the 58th record. run: 1412 subRun: 1 event: 36458 at 16-Sep-2025 18:32:43 CEST
Begin processing the 59th record. run: 1412 subRun: 1 event: 36459 at 16-Sep-2025 18:32:48 CEST
Begin processing the 60th record. run: 1412 subRun: 1 event: 36460 at 16-Sep-2025 18:32:53 CEST
Begin processing the 61st record. run: 1412 subRun: 1 event: 36461 at 16-Sep-2025 18:32:57 CEST
Begin processing the 62nd record. run: 1412 subRun: 1 event: 36462 at 16-Sep-2025 18:33:01 CEST
Begin processing the 63rd record. run: 1412 subRun: 1 event: 36463 at 16-Sep-2025 18:33:06 CEST
Begin processing the 64th record. run: 1412 subRun: 1 event: 36464 at 16-Sep-2025 18:33:11 CEST
Begin processing the 65th record. run: 1412 subRun: 1 event: 36465 at 16-Sep-2025 18:33:15 CEST
Begin processing the 66th record. run: 1412 subRun: 1 event: 36466 at 16-Sep-2025 18:33:20 CEST
Begin processing the 67th record. run: 1412 subRun: 1 event: 36467 at 16-Sep-2025 18:33:25 CEST
Begin processing the 68th record. run: 1412 subRun: 1 event: 36468 at 16-Sep-2025 18:33:36 CEST
Begin processing the 69th record. run: 1412 subRun: 1 event: 36469 at 16-Sep-2025 18:33:41 CEST
Begin processing the 70th record. run: 1412 subRun: 1 event: 36470 at 16-Sep-2025 18:33:46 CEST
Begin processing the 71st record. run: 1412 subRun: 1 event: 36471 at 16-Sep-2025 18:33:50 CEST
Begin processing the 72nd record. run: 1412 subRun: 1 event: 36472 at 16-Sep-2025 18:33:55 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 73rd record. run: 1412 subRun: 1 event: 36473 at 16-Sep-2025 18:33:57 CEST
Begin processing the 74th record. run: 1412 subRun: 1 event: 36474 at 16-Sep-2025 18:34:02 CEST
Begin processing the 75th record. run: 1412 subRun: 1 event: 36475 at 16-Sep-2025 18:34:07 CEST
Begin processing the 76th record. run: 1412 subRun: 1 event: 36476 at 16-Sep-2025 18:34:11 CEST
Begin processing the 77th record. run: 1412 subRun: 1 event: 36477 at 16-Sep-2025 18:34:16 CEST
Begin processing the 78th record. run: 1412 subRun: 1 event: 36478 at 16-Sep-2025 18:34:22 CEST
Begin processing the 79th record. run: 1412 subRun: 1 event: 36479 at 16-Sep-2025 18:34:28 CEST
Begin processing the 80th record. run: 1412 subRun: 1 event: 36480 at 16-Sep-2025 18:34:31 CEST
Begin processing the 81st record. run: 1412 subRun: 1 event: 36481 at 16-Sep-2025 18:34:36 CEST
Begin processing the 82nd record. run: 1412 subRun: 1 event: 36482 at 16-Sep-2025 18:34:41 CEST
Begin processing the 83rd record. run: 1412 subRun: 1 event: 36483 at 16-Sep-2025 18:34:46 CEST
Begin processing the 84th record. run: 1412 subRun: 1 event: 36484 at 16-Sep-2025 18:34:51 CEST
Begin processing the 85th record. run: 1412 subRun: 1 event: 36485 at 16-Sep-2025 18:34:56 CEST
Begin processing the 86th record. run: 1412 subRun: 1 event: 36486 at 16-Sep-2025 18:35:01 CEST
Begin processing the 87th record. run: 1412 subRun: 1 event: 36487 at 16-Sep-2025 18:35:06 CEST
Begin processing the 88th record. run: 1412 subRun: 1 event: 36488 at 16-Sep-2025 18:35:11 CEST
Begin processing the 89th record. run: 1412 subRun: 1 event: 36489 at 16-Sep-2025 18:35:15 CEST
Begin processing the 90th record. run: 1412 subRun: 1 event: 36490 at 16-Sep-2025 18:35:21 CEST
Begin processing the 91st record. run: 1412 subRun: 1 event: 36491 at 16-Sep-2025 18:35:25 CEST
Begin processing the 92nd record. run: 1412 subRun: 1 event: 36492 at 16-Sep-2025 18:35:29 CEST
Begin processing the 93rd record. run: 1412 subRun: 1 event: 36493 at 16-Sep-2025 18:35:34 CEST
Begin processing the 94th record. run: 1412 subRun: 1 event: 36494 at 16-Sep-2025 18:35:39 CEST
Begin processing the 95th record. run: 1412 subRun: 1 event: 36495 at 16-Sep-2025 18:35:43 CEST
Begin processing the 96th record. run: 1412 subRun: 1 event: 36496 at 16-Sep-2025 18:35:48 CEST
Begin processing the 97th record. run: 1412 subRun: 1 event: 36497 at 16-Sep-2025 18:35:53 CEST
Begin processing the 98th record. run: 1412 subRun: 1 event: 36498 at 16-Sep-2025 18:35:57 CEST
Begin processing the 99th record. run: 1412 subRun: 1 event: 36499 at 16-Sep-2025 18:36:01 CEST
Begin processing the 100th record. run: 1412 subRun: 1 event: 36500 at 16-Sep-2025 18:36:06 CEST
16-Sep-2025 18:36:10 CEST  Closed output file "nu_dune10kt_1x2x6_1412_364_20230826T153315Z_gen_g4_detsim_hitreco__20240227T211545Z_reco2_reco2.root"
16-Sep-2025 18:36:10 CEST  Closed input file "root://xrootd.echo.stfc.ac.uk:1094/dune:/protodune/RSE/fardet-hd/7c/e8/nu_dune10kt_1x2x6_1412_364_20230826T153315Z_gen_g4_detsim_hitreco__20240227T211545Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      0.67813       3.58983       10.0924       3.3575        1.19884        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0788181     0.236946      0.428167      0.237766      0.051401        100    
reco:pandora:StandardPandora                   0.456293       3.34782       9.75501       3.11059       1.18467        100    
[art]:TriggerResults:TriggerResultInserter     1.034e-05    1.81928e-05   6.0201e-05    1.55855e-05   8.26182e-06      100    
end_path:out1:RootOutput                       2.55e-06     3.26427e-06    1.45e-05     3.1005e-06    1.17761e-06      100    
end_path:out1:RootOutput(write)               0.00108969    0.00485647     0.0498712    0.00315348    0.00587105       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2369.46 MB
  Peak resident set size usage (VmHWM): 1386.34 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
justIN time: 2025-09-18 23:24:40 UTC       justIN version: 01.05.00