Jobsub ID 232196.7@dunegpschedd02.fnal.gov
| Jobsub ID | 232196.7@dunegpschedd02.fnal.gov | |
| Workflow ID | 9278 | |
| Stage ID | 1 | |
| User name | imawby@fnal.gov | |
| HTCondor Group | group_dune | |
| Requested | Processors | 1 | 
| GPU | No | |
| RSS bytes | 1048576000 (1000 MiB) | |
| Wall seconds limit | 7200 (2 hours) | |
| Submitted time | 2025-10-22 22:20:59 | |
| Site | US_FNAL-T1 | |
| Entry | CMSHTPC_T1_US_FNAL_condce_opp1_whole | |
| Last heartbeat | 2025-10-22 22:43:39 | |
| From worker node | Hostname | dunegli-47316-0-cmswn4025.fnal.gov | 
| cpuinfo | AMD EPYC 7543 32-Core Processor | |
| OS release | Scientific Linux release 7.9 (Nitrogen) | |
| Processors | 1 | |
| RSS bytes | 1048576000 (1000 MiB) | |
| Wall seconds limit | 171000 (47 hours) | |
| GPU | ||
| Inner Apptainer? | True | |
| Job state | finished | |
| Started | 2025-10-22 22:28:24 | |
| Input files | fardet-hd:nu_dune10kt_1x2x6_1113_768_20230827T125852Z_gen_g4_detsim_hitreco__20240223T222333Z_reco2.root | |
| Jobscript | Exit code | 0 | 
| Real time | 14m (879s) | |
| CPU time | 9m (591s = 67%) | |
| Max RSS bytes | 1452306432 (1385 MiB) | |
| Outputting started | 2025-10-22 22:43:04 | |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09278/1/002/ClusterValidation_WithAlg_nu_dune10kt_1x2x6_1113_768_20230827T125852Z_gen_g4_detsim_hitreco__20240223T222333Z_reco2.root https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09278/1/002/ClusterValidation_WithoutAlg_nu_dune10kt_1x2x6_1113_768_20230827T125852Z_gen_g4_detsim_hitreco__20240223T222333Z_reco2.root  | |
| Finished | 2025-10-22 22:43:39 | |
| Saved logs | justin-logs:232196.7-dunegpschedd02.fnal.gov.logs.tgz | |
| List job events Cached HTCondor job logs | ||
Jobscript log (last 10,000 characters)
t PFN = root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/36/cc/nu_dune10kt_1x2x6_1113_768_20230827T125852Z_gen_g4_detsim_hitreco__20240223T222333Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 34th record. run: 1113 subRun: 1 event: 76834 at 22-Oct-2025 22:36:38 UTC
Begin processing the 35th record. run: 1113 subRun: 1 event: 76835 at 22-Oct-2025 22:36:42 UTC
Begin processing the 36th record. run: 1113 subRun: 1 event: 76836 at 22-Oct-2025 22:36:46 UTC
Begin processing the 37th record. run: 1113 subRun: 1 event: 76837 at 22-Oct-2025 22:36:50 UTC
Begin processing the 38th record. run: 1113 subRun: 1 event: 76838 at 22-Oct-2025 22:36:54 UTC
Begin processing the 39th record. run: 1113 subRun: 1 event: 76839 at 22-Oct-2025 22:36:59 UTC
Begin processing the 40th record. run: 1113 subRun: 1 event: 76840 at 22-Oct-2025 22:37:03 UTC
Begin processing the 41st record. run: 1113 subRun: 1 event: 76841 at 22-Oct-2025 22:37:09 UTC
Begin processing the 42nd record. run: 1113 subRun: 1 event: 76842 at 22-Oct-2025 22:37:14 UTC
Begin processing the 43rd record. run: 1113 subRun: 1 event: 76843 at 22-Oct-2025 22:37:18 UTC
Begin processing the 44th record. run: 1113 subRun: 1 event: 76844 at 22-Oct-2025 22:37:22 UTC
Begin processing the 45th record. run: 1113 subRun: 1 event: 76845 at 22-Oct-2025 22:37:31 UTC
Begin processing the 46th record. run: 1113 subRun: 1 event: 76846 at 22-Oct-2025 22:38:24 UTC
Begin processing the 47th record. run: 1113 subRun: 1 event: 76847 at 22-Oct-2025 22:38:30 UTC
Begin processing the 48th record. run: 1113 subRun: 1 event: 76848 at 22-Oct-2025 22:38:35 UTC
Begin processing the 49th record. run: 1113 subRun: 1 event: 76849 at 22-Oct-2025 22:38:40 UTC
Begin processing the 50th record. run: 1113 subRun: 1 event: 76850 at 22-Oct-2025 22:38:45 UTC
Begin processing the 51st record. run: 1113 subRun: 1 event: 76851 at 22-Oct-2025 22:39:03 UTC
Begin processing the 52nd record. run: 1113 subRun: 1 event: 76852 at 22-Oct-2025 22:39:08 UTC
Begin processing the 53rd record. run: 1113 subRun: 1 event: 76853 at 22-Oct-2025 22:39:13 UTC
Begin processing the 54th record. run: 1113 subRun: 1 event: 76854 at 22-Oct-2025 22:39:17 UTC
Begin processing the 55th record. run: 1113 subRun: 1 event: 76855 at 22-Oct-2025 22:39:22 UTC
Begin processing the 56th record. run: 1113 subRun: 1 event: 76856 at 22-Oct-2025 22:39:27 UTC
Begin processing the 57th record. run: 1113 subRun: 1 event: 76857 at 22-Oct-2025 22:39:32 UTC
Begin processing the 58th record. run: 1113 subRun: 1 event: 76858 at 22-Oct-2025 22:39:36 UTC
Begin processing the 59th record. run: 1113 subRun: 1 event: 76859 at 22-Oct-2025 22:39:41 UTC
Begin processing the 60th record. run: 1113 subRun: 1 event: 76860 at 22-Oct-2025 22:39:46 UTC
Begin processing the 61st record. run: 1113 subRun: 1 event: 76861 at 22-Oct-2025 22:39:50 UTC
Begin processing the 62nd record. run: 1113 subRun: 1 event: 76862 at 22-Oct-2025 22:39:55 UTC
Begin processing the 63rd record. run: 1113 subRun: 1 event: 76863 at 22-Oct-2025 22:40:01 UTC
Begin processing the 64th record. run: 1113 subRun: 1 event: 76864 at 22-Oct-2025 22:40:06 UTC
Begin processing the 65th record. run: 1113 subRun: 1 event: 76865 at 22-Oct-2025 22:40:11 UTC
Begin processing the 66th record. run: 1113 subRun: 1 event: 76866 at 22-Oct-2025 22:40:16 UTC
Begin processing the 67th record. run: 1113 subRun: 1 event: 76867 at 22-Oct-2025 22:40:23 UTC
Begin processing the 68th record. run: 1113 subRun: 1 event: 76868 at 22-Oct-2025 22:40:30 UTC
Begin processing the 69th record. run: 1113 subRun: 1 event: 76869 at 22-Oct-2025 22:40:37 UTC
Begin processing the 70th record. run: 1113 subRun: 1 event: 76870 at 22-Oct-2025 22:40:41 UTC
Begin processing the 71st record. run: 1113 subRun: 1 event: 76871 at 22-Oct-2025 22:40:46 UTC
Begin processing the 72nd record. run: 1113 subRun: 1 event: 76872 at 22-Oct-2025 22:41:11 UTC
Begin processing the 73rd record. run: 1113 subRun: 1 event: 76873 at 22-Oct-2025 22:41:15 UTC
Begin processing the 74th record. run: 1113 subRun: 1 event: 76874 at 22-Oct-2025 22:41:19 UTC
Begin processing the 75th record. run: 1113 subRun: 1 event: 76875 at 22-Oct-2025 22:41:25 UTC
Begin processing the 76th record. run: 1113 subRun: 1 event: 76876 at 22-Oct-2025 22:41:29 UTC
Begin processing the 77th record. run: 1113 subRun: 1 event: 76877 at 22-Oct-2025 22:41:33 UTC
Begin processing the 78th record. run: 1113 subRun: 1 event: 76878 at 22-Oct-2025 22:41:38 UTC
StatusCodeException caught while instantiating pandora object :STATUS_CODE_INVALID_PARAMETER
factory.Create(parameters, pCluster) throw STATUS_CODE_INVALID_PARAMETER
    in function: Create
    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/Managers/ClusterManager.cc line#: 50
Failed to create cluster: STATUS_CODE_INVALID_PARAMETER
this->GetManager<Cluster>()->Create(parameters, pCluster, factory) return STATUS_CODE_INVALID_PARAMETER
    in function: Create<object_creation::ClusterParameters, pandora::Cluster>
    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#: 140
PandoraContentApi::Cluster::Create(*this, parameters, pNewCluster) return STATUS_CODE_INVALID_PARAMETER
    in function: ThisDivideCaloHits
    in file:     /exp/dune/app/users/imawby/dunesw_splitting/srcs/larpandoracontent/larpandoradlcontent/LArTwoDReco/DLClusterSplittingAlgorithm.cc line#: 194
Begin processing the 79th record. run: 1113 subRun: 1 event: 76879 at 22-Oct-2025 22:41:43 UTC
Begin processing the 80th record. run: 1113 subRun: 1 event: 76880 at 22-Oct-2025 22:41:47 UTC
Begin processing the 81st record. run: 1113 subRun: 1 event: 76881 at 22-Oct-2025 22:41:51 UTC
Begin processing the 82nd record. run: 1113 subRun: 1 event: 76882 at 22-Oct-2025 22:41:55 UTC
Begin processing the 83rd record. run: 1113 subRun: 1 event: 76883 at 22-Oct-2025 22:41:59 UTC
Begin processing the 84th record. run: 1113 subRun: 1 event: 76884 at 22-Oct-2025 22:42:04 UTC
Begin processing the 85th record. run: 1113 subRun: 1 event: 76885 at 22-Oct-2025 22:42:15 UTC
Begin processing the 86th record. run: 1113 subRun: 1 event: 76886 at 22-Oct-2025 22:42:17 UTC
Begin processing the 87th record. run: 1113 subRun: 1 event: 76887 at 22-Oct-2025 22:42:24 UTC
Begin processing the 88th record. run: 1113 subRun: 1 event: 76888 at 22-Oct-2025 22:42:27 UTC
Begin processing the 89th record. run: 1113 subRun: 1 event: 76889 at 22-Oct-2025 22:42:30 UTC
Begin processing the 90th record. run: 1113 subRun: 1 event: 76890 at 22-Oct-2025 22:42:32 UTC
Begin processing the 91st record. run: 1113 subRun: 1 event: 76891 at 22-Oct-2025 22:42:37 UTC
Begin processing the 92nd record. run: 1113 subRun: 1 event: 76892 at 22-Oct-2025 22:42:40 UTC
Begin processing the 93rd record. run: 1113 subRun: 1 event: 76893 at 22-Oct-2025 22:42:42 UTC
Begin processing the 94th record. run: 1113 subRun: 1 event: 76894 at 22-Oct-2025 22:42:44 UTC
Begin processing the 95th record. run: 1113 subRun: 1 event: 76895 at 22-Oct-2025 22:42:46 UTC
Begin processing the 96th record. run: 1113 subRun: 1 event: 76896 at 22-Oct-2025 22:42:49 UTC
Begin processing the 97th record. run: 1113 subRun: 1 event: 76897 at 22-Oct-2025 22:42:51 UTC
Begin processing the 98th record. run: 1113 subRun: 1 event: 76898 at 22-Oct-2025 22:42:53 UTC
Begin processing the 99th record. run: 1113 subRun: 1 event: 76899 at 22-Oct-2025 22:42:58 UTC
Begin processing the 100th record. run: 1113 subRun: 1 event: 76900 at 22-Oct-2025 22:43:02 UTC
22-Oct-2025 22:43:03 UTC  Closed output file "nu_dune10kt_1x2x6_1113_768_20230827T125852Z_gen_g4_detsim_hitreco__20240223T222333Z_reco2_reco2.root"
22-Oct-2025 22:43:03 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/36/cc/nu_dune10kt_1x2x6_1113_768_20230827T125852Z_gen_g4_detsim_hitreco__20240223T222333Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      1.28276       5.56633       51.9821       4.61159       5.46713        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.00255142     0.031699       0.80805      0.0202921     0.0795219       100    
reco:pandora:StandardPandora                     1.264        5.52441       51.9131       4.57767       5.45923        100    
[art]:TriggerResults:TriggerResultInserter     9.548e-06    4.45716e-05   0.000155674   4.10975e-05   2.40272e-05      100    
end_path:out1:RootOutput                       2.525e-06    8.98041e-06   6.6175e-05     8.025e-06    6.58409e-06      100    
end_path:out1:RootOutput(write)               0.000981324   0.00980589     0.121408     0.00689835     0.0136732       100    
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 2466.87 MB
  Peak resident set size usage (VmHWM): 1452.31 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===