justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 238212.112@dunegpschedd01.fnal.gov

Jobsub ID238212.112@dunegpschedd01.fnal.gov
Workflow ID9313
Stage ID1
User nameimawby@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes1048576000 (1000 MiB)
Wall seconds limit7200 (2 hours)
Submitted time2025-10-24 15:45:10
SiteCERN
EntryCMSHTPC_T2_CH_CERN_ce507
Last heartbeat2025-10-24 15:58:24
From worker nodeHostnameb9p21p5630.cern.ch
cpuinfoAMD EPYC 7302 16-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 15:45:50
Input filesfardet-hd:nu_dune10kt_1x2x6_1412_870_20230826T153540Z_gen_g4_detsim_hitreco__20240229T185035Z_reco2.root
JobscriptExit code0
Real time12m (728s)
CPU time6m (383s = 52%)
Max RSS bytes1444933632 (1377 MiB)
Outputting started2025-10-24 15:57:59
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09313/1/002/ClusterValidation_WithAlg_nu_dune10kt_1x2x6_1412_870_20230826T153540Z_gen_g4_detsim_hitreco__20240229T185035Z_reco2.root
https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09313/1/002/ClusterValidation_WithoutAlg_nu_dune10kt_1x2x6_1412_870_20230826T153540Z_gen_g4_detsim_hitreco__20240229T185035Z_reco2.root
Finished2025-10-24 15:58:24
Saved logsjustin-logs:238212.112-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

6_prof
----------- this block should be empty ------------------
---------------------------------------------------------
Input PFN = root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/b9/88/nu_dune10kt_1x2x6_1412_870_20230826T153540Z_gen_g4_detsim_hitreco__20240229T185035Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
    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 29th record. run: 1412 subRun: 1 event: 87029 at 24-Oct-2025 17:53:31 CEST
Begin processing the 30th record. run: 1412 subRun: 1 event: 87030 at 24-Oct-2025 17:53:35 CEST
Begin processing the 31st record. run: 1412 subRun: 1 event: 87031 at 24-Oct-2025 17:53:38 CEST
Begin processing the 32nd record. run: 1412 subRun: 1 event: 87032 at 24-Oct-2025 17:53:42 CEST
Begin processing the 33rd record. run: 1412 subRun: 1 event: 87033 at 24-Oct-2025 17:53:45 CEST
Begin processing the 34th record. run: 1412 subRun: 1 event: 87034 at 24-Oct-2025 17:53:47 CEST
Begin processing the 35th record. run: 1412 subRun: 1 event: 87035 at 24-Oct-2025 17:53:51 CEST
Begin processing the 36th record. run: 1412 subRun: 1 event: 87036 at 24-Oct-2025 17:53:54 CEST
Begin processing the 37th record. run: 1412 subRun: 1 event: 87037 at 24-Oct-2025 17:54:00 CEST
Begin processing the 38th record. run: 1412 subRun: 1 event: 87038 at 24-Oct-2025 17:54:03 CEST
Begin processing the 39th record. run: 1412 subRun: 1 event: 87039 at 24-Oct-2025 17:54:16 CEST
Begin processing the 40th record. run: 1412 subRun: 1 event: 87040 at 24-Oct-2025 17:54:20 CEST
Begin processing the 41st record. run: 1412 subRun: 1 event: 87041 at 24-Oct-2025 17:54:24 CEST
Begin processing the 42nd record. run: 1412 subRun: 1 event: 87042 at 24-Oct-2025 17:54:27 CEST
Begin processing the 43rd record. run: 1412 subRun: 1 event: 87043 at 24-Oct-2025 17:54:31 CEST
Begin processing the 44th record. run: 1412 subRun: 1 event: 87044 at 24-Oct-2025 17:54:34 CEST
Begin processing the 45th record. run: 1412 subRun: 1 event: 87045 at 24-Oct-2025 17:54:38 CEST
Begin processing the 46th record. run: 1412 subRun: 1 event: 87046 at 24-Oct-2025 17:54:41 CEST
Begin processing the 47th record. run: 1412 subRun: 1 event: 87047 at 24-Oct-2025 17:54:47 CEST
Begin processing the 48th record. run: 1412 subRun: 1 event: 87048 at 24-Oct-2025 17:54:51 CEST
Begin processing the 49th record. run: 1412 subRun: 1 event: 87049 at 24-Oct-2025 17:54:55 CEST
Begin processing the 50th record. run: 1412 subRun: 1 event: 87050 at 24-Oct-2025 17:54:58 CEST
Begin processing the 51st record. run: 1412 subRun: 1 event: 87051 at 24-Oct-2025 17:55:01 CEST
Begin processing the 52nd record. run: 1412 subRun: 1 event: 87052 at 24-Oct-2025 17:55:05 CEST
Begin processing the 53rd record. run: 1412 subRun: 1 event: 87053 at 24-Oct-2025 17:55:08 CEST
Begin processing the 54th record. run: 1412 subRun: 1 event: 87054 at 24-Oct-2025 17:55:12 CEST
Begin processing the 55th record. run: 1412 subRun: 1 event: 87055 at 24-Oct-2025 17:55:15 CEST
Begin processing the 56th record. run: 1412 subRun: 1 event: 87056 at 24-Oct-2025 17:55:18 CEST
Begin processing the 57th record. run: 1412 subRun: 1 event: 87057 at 24-Oct-2025 17:55:21 CEST
Begin processing the 58th record. run: 1412 subRun: 1 event: 87058 at 24-Oct-2025 17:55:24 CEST
Begin processing the 59th record. run: 1412 subRun: 1 event: 87059 at 24-Oct-2025 17:55:28 CEST
Begin processing the 60th record. run: 1412 subRun: 1 event: 87060 at 24-Oct-2025 17:55:31 CEST
Begin processing the 61st record. run: 1412 subRun: 1 event: 87061 at 24-Oct-2025 17:55:37 CEST
Begin processing the 62nd record. run: 1412 subRun: 1 event: 87062 at 24-Oct-2025 17:55:39 CEST
Begin processing the 63rd record. run: 1412 subRun: 1 event: 87063 at 24-Oct-2025 17:55:43 CEST
Begin processing the 64th record. run: 1412 subRun: 1 event: 87064 at 24-Oct-2025 17:55:46 CEST
Begin processing the 65th record. run: 1412 subRun: 1 event: 87065 at 24-Oct-2025 17:55:49 CEST
Begin processing the 66th record. run: 1412 subRun: 1 event: 87066 at 24-Oct-2025 17:55:52 CEST
Begin processing the 67th record. run: 1412 subRun: 1 event: 87067 at 24-Oct-2025 17:55:54 CEST
Begin processing the 68th record. run: 1412 subRun: 1 event: 87068 at 24-Oct-2025 17:55:57 CEST
Begin processing the 69th record. run: 1412 subRun: 1 event: 87069 at 24-Oct-2025 17:56:01 CEST
Begin processing the 70th record. run: 1412 subRun: 1 event: 87070 at 24-Oct-2025 17:56:04 CEST
Begin processing the 71st record. run: 1412 subRun: 1 event: 87071 at 24-Oct-2025 17:56:07 CEST
Begin processing the 72nd record. run: 1412 subRun: 1 event: 87072 at 24-Oct-2025 17:56:11 CEST
Begin processing the 73rd record. run: 1412 subRun: 1 event: 87073 at 24-Oct-2025 17:56:14 CEST
Begin processing the 74th record. run: 1412 subRun: 1 event: 87074 at 24-Oct-2025 17:56:17 CEST
Begin processing the 75th record. run: 1412 subRun: 1 event: 87075 at 24-Oct-2025 17:56:20 CEST
Begin processing the 76th record. run: 1412 subRun: 1 event: 87076 at 24-Oct-2025 17:56:23 CEST
Begin processing the 77th record. run: 1412 subRun: 1 event: 87077 at 24-Oct-2025 17:56:26 CEST
Begin processing the 78th record. run: 1412 subRun: 1 event: 87078 at 24-Oct-2025 17:56:29 CEST
Begin processing the 79th record. run: 1412 subRun: 1 event: 87079 at 24-Oct-2025 17:56:33 CEST
Begin processing the 80th record. run: 1412 subRun: 1 event: 87080 at 24-Oct-2025 17:56:37 CEST
Begin processing the 81st record. run: 1412 subRun: 1 event: 87081 at 24-Oct-2025 17:56:40 CEST
Begin processing the 82nd record. run: 1412 subRun: 1 event: 87082 at 24-Oct-2025 17:56:45 CEST
Begin processing the 83rd record. run: 1412 subRun: 1 event: 87083 at 24-Oct-2025 17:56:48 CEST
Begin processing the 84th record. run: 1412 subRun: 1 event: 87084 at 24-Oct-2025 17:56:51 CEST
Begin processing the 85th record. run: 1412 subRun: 1 event: 87085 at 24-Oct-2025 17:56:55 CEST
Begin processing the 86th record. run: 1412 subRun: 1 event: 87086 at 24-Oct-2025 17:57:00 CEST
Begin processing the 87th record. run: 1412 subRun: 1 event: 87087 at 24-Oct-2025 17:57:07 CEST
Begin processing the 88th record. run: 1412 subRun: 1 event: 87088 at 24-Oct-2025 17:57:10 CEST
Begin processing the 89th record. run: 1412 subRun: 1 event: 87089 at 24-Oct-2025 17:57:13 CEST
Begin processing the 90th record. run: 1412 subRun: 1 event: 87090 at 24-Oct-2025 17:57:16 CEST
Begin processing the 91st record. run: 1412 subRun: 1 event: 87091 at 24-Oct-2025 17:57:19 CEST
Begin processing the 92nd record. run: 1412 subRun: 1 event: 87092 at 24-Oct-2025 17:57:24 CEST
Begin processing the 93rd record. run: 1412 subRun: 1 event: 87093 at 24-Oct-2025 17:57:27 CEST
Begin processing the 94th record. run: 1412 subRun: 1 event: 87094 at 24-Oct-2025 17:57:31 CEST
Begin processing the 95th record. run: 1412 subRun: 1 event: 87095 at 24-Oct-2025 17:57:36 CEST
Begin processing the 96th record. run: 1412 subRun: 1 event: 87096 at 24-Oct-2025 17:57:40 CEST
Begin processing the 97th record. run: 1412 subRun: 1 event: 87097 at 24-Oct-2025 17:57:43 CEST
Begin processing the 98th record. run: 1412 subRun: 1 event: 87098 at 24-Oct-2025 17:57:46 CEST
Begin processing the 99th record. run: 1412 subRun: 1 event: 87099 at 24-Oct-2025 17:57:50 CEST
Begin processing the 100th record. run: 1412 subRun: 1 event: 87100 at 24-Oct-2025 17:57:54 CEST
24-Oct-2025 17:57:58 CEST  Closed output file "nu_dune10kt_1x2x6_1412_870_20230826T153540Z_gen_g4_detsim_hitreco__20240229T185035Z_reco2_reco2.root"
24-Oct-2025 17:57:58 CEST  Closed input file "root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/b9/88/nu_dune10kt_1x2x6_1412_870_20230826T153540Z_gen_g4_detsim_hitreco__20240229T185035Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.143465       3.68182       34.7429       2.84266       3.95053        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0179224     0.0459633     0.088446      0.0434441     0.0126326       100    
reco:pandora:StandardPandora                   0.104569       3.63085       34.7052       2.80193       3.94983        100    
[art]:TriggerResults:TriggerResultInserter     1.178e-05    2.2737e-05    0.000173883    1.896e-05    1.83558e-05      100    
end_path:out1:RootOutput                       3.01e-06     6.40741e-06    2.827e-05     6.52e-06     2.50174e-06      100    
end_path:out1:RootOutput(write)               0.00106968    0.00472667     0.0366186    0.00353655    0.00430781       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2442.65 MB
  Peak resident set size usage (VmHWM): 1444.93 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:09 UTC       justIN version: 01.05.01