Jobsub ID 279275.34@dunegpschedd01.fnal.gov

Jobsub ID	279275.34@dunegpschedd01.fnal.gov
Workflow ID	11972
Stage ID	1
User name	imawby@fnal.gov
Requested	Processors	1
	GPU	No
	RSS bytes	1048576000 (1000 MiB)
	Wall seconds limit	7200 (2 hours)
Submitted time	2026-01-15 19:34:14
Site	FR_CCIN2P3
Entry	DUNE_FR_CCIN2P3_cccondorce02
Last heartbeat	2026-01-15 20:43:31
From worker node	Hostname	ccwcondor0009
	cpuinfo	AMD EPYC 9334 32-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	1048576000 (1000 MiB)
	Wall seconds limit	106200 (29 hours)
	GPU
	Inner Apptainer?	True
Job state	outputting_failed
Started	2026-01-15 19:35:40
Input files	fardet-hd:nu_dune10kt_1x2x6_1412_749_20230826T153338Z_gen_g4_detsim_hitreco__20240227T210725Z_reco2.root
Jobscript	Exit code	0
	Real time	8m (505s)
	CPU time	5m (313s = 61%)
	Max RSS bytes	1135362048 (1082 MiB)
Outputting started	2026-01-15 19:44:05
Output files
Finished	2026-01-15 20:43:31
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

ocalProducts_larsoft_v10_13_00_e26_prof
----------- this block should be empty ------------------
---------------------------------------------------------
Input PFN = root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/33/02/nu_dune10kt_1x2x6_1412_749_20230826T153338Z_gen_g4_detsim_hitreco__20240227T210725Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 29th record. run: 1412 subRun: 1 event: 74929 at 15-Jan-2026 20:40:18 CET
Begin processing the 30th record. run: 1412 subRun: 1 event: 74930 at 15-Jan-2026 20:40:20 CET
PandoraContentApi::GetList(*this, listName, pList) return STATUS_CODE_NOT_INITIALIZED
    in function: GetList
    in file:     /exp/dune/app/users/imawby/dunesw_validation/srcs/larpandoracontent/larpandoradlcontent/LArTwoDReco/DLThreeDClusterSplittingAlgorithm.cc line#: 194
Begin processing the 31st record. run: 1412 subRun: 1 event: 74931 at 15-Jan-2026 20:40:22 CET
Begin processing the 32nd record. run: 1412 subRun: 1 event: 74932 at 15-Jan-2026 20:40:25 CET
Begin processing the 33rd record. run: 1412 subRun: 1 event: 74933 at 15-Jan-2026 20:40:28 CET
Begin processing the 34th record. run: 1412 subRun: 1 event: 74934 at 15-Jan-2026 20:40:30 CET
Begin processing the 35th record. run: 1412 subRun: 1 event: 74935 at 15-Jan-2026 20:40:34 CET
Begin processing the 36th record. run: 1412 subRun: 1 event: 74936 at 15-Jan-2026 20:40:36 CET
Begin processing the 37th record. run: 1412 subRun: 1 event: 74937 at 15-Jan-2026 20:40:39 CET
Begin processing the 38th record. run: 1412 subRun: 1 event: 74938 at 15-Jan-2026 20:40:43 CET
Begin processing the 39th record. run: 1412 subRun: 1 event: 74939 at 15-Jan-2026 20:40:45 CET
Begin processing the 40th record. run: 1412 subRun: 1 event: 74940 at 15-Jan-2026 20:40:48 CET
Begin processing the 41st record. run: 1412 subRun: 1 event: 74941 at 15-Jan-2026 20:40:52 CET
Begin processing the 42nd record. run: 1412 subRun: 1 event: 74942 at 15-Jan-2026 20:40:54 CET
Begin processing the 43rd record. run: 1412 subRun: 1 event: 74943 at 15-Jan-2026 20:40:58 CET
Begin processing the 44th record. run: 1412 subRun: 1 event: 74944 at 15-Jan-2026 20:41:01 CET
Begin processing the 45th record. run: 1412 subRun: 1 event: 74945 at 15-Jan-2026 20:41:05 CET
Begin processing the 46th record. run: 1412 subRun: 1 event: 74946 at 15-Jan-2026 20:41:08 CET
Begin processing the 47th record. run: 1412 subRun: 1 event: 74947 at 15-Jan-2026 20:41:11 CET
Begin processing the 48th record. run: 1412 subRun: 1 event: 74948 at 15-Jan-2026 20:41:14 CET
Begin processing the 49th record. run: 1412 subRun: 1 event: 74949 at 15-Jan-2026 20:41:16 CET
Begin processing the 50th record. run: 1412 subRun: 1 event: 74950 at 15-Jan-2026 20:41:20 CET
Begin processing the 51st record. run: 1412 subRun: 1 event: 74951 at 15-Jan-2026 20:41:23 CET
Begin processing the 52nd record. run: 1412 subRun: 1 event: 74952 at 15-Jan-2026 20:41:28 CET
Begin processing the 53rd record. run: 1412 subRun: 1 event: 74953 at 15-Jan-2026 20:41:31 CET
Begin processing the 54th record. run: 1412 subRun: 1 event: 74954 at 15-Jan-2026 20:41:35 CET
Begin processing the 55th record. run: 1412 subRun: 1 event: 74955 at 15-Jan-2026 20:41:37 CET
Begin processing the 56th record. run: 1412 subRun: 1 event: 74956 at 15-Jan-2026 20:41:40 CET
Begin processing the 57th record. run: 1412 subRun: 1 event: 74957 at 15-Jan-2026 20:41:43 CET
Begin processing the 58th record. run: 1412 subRun: 1 event: 74958 at 15-Jan-2026 20:41:48 CET
Begin processing the 59th record. run: 1412 subRun: 1 event: 74959 at 15-Jan-2026 20:41:51 CET
Begin processing the 60th record. run: 1412 subRun: 1 event: 74960 at 15-Jan-2026 20:41:54 CET
Begin processing the 61st record. run: 1412 subRun: 1 event: 74961 at 15-Jan-2026 20:41:57 CET
Begin processing the 62nd record. run: 1412 subRun: 1 event: 74962 at 15-Jan-2026 20:42:00 CET
Begin processing the 63rd record. run: 1412 subRun: 1 event: 74963 at 15-Jan-2026 20:42:02 CET
Begin processing the 64th record. run: 1412 subRun: 1 event: 74964 at 15-Jan-2026 20:42:05 CET
Begin processing the 65th record. run: 1412 subRun: 1 event: 74965 at 15-Jan-2026 20:42:08 CET
Begin processing the 66th record. run: 1412 subRun: 1 event: 74966 at 15-Jan-2026 20:42:10 CET
Begin processing the 67th record. run: 1412 subRun: 1 event: 74967 at 15-Jan-2026 20:42:17 CET
Begin processing the 68th record. run: 1412 subRun: 1 event: 74968 at 15-Jan-2026 20:42:19 CET
Begin processing the 69th record. run: 1412 subRun: 1 event: 74969 at 15-Jan-2026 20:42:22 CET
Begin processing the 70th record. run: 1412 subRun: 1 event: 74970 at 15-Jan-2026 20:42:25 CET
Begin processing the 71st record. run: 1412 subRun: 1 event: 74971 at 15-Jan-2026 20:42:28 CET
Begin processing the 72nd record. run: 1412 subRun: 1 event: 74972 at 15-Jan-2026 20:42:31 CET
Begin processing the 73rd record. run: 1412 subRun: 1 event: 74973 at 15-Jan-2026 20:42:34 CET
Begin processing the 74th record. run: 1412 subRun: 1 event: 74974 at 15-Jan-2026 20:42:36 CET
Begin processing the 75th record. run: 1412 subRun: 1 event: 74975 at 15-Jan-2026 20:42:39 CET
Begin processing the 76th record. run: 1412 subRun: 1 event: 74976 at 15-Jan-2026 20:42:42 CET
Begin processing the 77th record. run: 1412 subRun: 1 event: 74977 at 15-Jan-2026 20:42:44 CET
Begin processing the 78th record. run: 1412 subRun: 1 event: 74978 at 15-Jan-2026 20:42:47 CET
Begin processing the 79th record. run: 1412 subRun: 1 event: 74979 at 15-Jan-2026 20:42:50 CET
PandoraContentApi::GetList(*this, listName, pList) return STATUS_CODE_NOT_INITIALIZED
    in function: GetList
    in file:     /exp/dune/app/users/imawby/dunesw_validation/srcs/larpandoracontent/larpandoradlcontent/LArTwoDReco/DLThreeDClusterSplittingAlgorithm.cc line#: 194
Begin processing the 80th record. run: 1412 subRun: 1 event: 74980 at 15-Jan-2026 20:42:53 CET
Begin processing the 81st record. run: 1412 subRun: 1 event: 74981 at 15-Jan-2026 20:42:55 CET
Begin processing the 82nd record. run: 1412 subRun: 1 event: 74982 at 15-Jan-2026 20:42:58 CET
Begin processing the 83rd record. run: 1412 subRun: 1 event: 74983 at 15-Jan-2026 20:43:01 CET
Begin processing the 84th record. run: 1412 subRun: 1 event: 74984 at 15-Jan-2026 20:43:06 CET
Begin processing the 85th record. run: 1412 subRun: 1 event: 74985 at 15-Jan-2026 20:43:09 CET
Begin processing the 86th record. run: 1412 subRun: 1 event: 74986 at 15-Jan-2026 20:43:11 CET
Begin processing the 87th record. run: 1412 subRun: 1 event: 74987 at 15-Jan-2026 20:43:14 CET
Begin processing the 88th record. run: 1412 subRun: 1 event: 74988 at 15-Jan-2026 20:43:17 CET
Begin processing the 89th record. run: 1412 subRun: 1 event: 74989 at 15-Jan-2026 20:43:20 CET
Begin processing the 90th record. run: 1412 subRun: 1 event: 74990 at 15-Jan-2026 20:43:26 CET
Begin processing the 91st record. run: 1412 subRun: 1 event: 74991 at 15-Jan-2026 20:43:29 CET
Begin processing the 92nd record. run: 1412 subRun: 1 event: 74992 at 15-Jan-2026 20:43:32 CET
Begin processing the 93rd record. run: 1412 subRun: 1 event: 74993 at 15-Jan-2026 20:43:36 CET
Begin processing the 94th record. run: 1412 subRun: 1 event: 74994 at 15-Jan-2026 20:43:38 CET
Begin processing the 95th record. run: 1412 subRun: 1 event: 74995 at 15-Jan-2026 20:43:42 CET
Begin processing the 96th record. run: 1412 subRun: 1 event: 74996 at 15-Jan-2026 20:43:45 CET
Begin processing the 97th record. run: 1412 subRun: 1 event: 74997 at 15-Jan-2026 20:43:48 CET
Begin processing the 98th record. run: 1412 subRun: 1 event: 74998 at 15-Jan-2026 20:43:56 CET
Begin processing the 99th record. run: 1412 subRun: 1 event: 74999 at 15-Jan-2026 20:43:58 CET
Begin processing the 100th record. run: 1412 subRun: 1 event: 75000 at 15-Jan-2026 20:44:01 CET
15-Jan-2026 20:44:04 CET  Closed output file "nu_dune10kt_1x2x6_1412_749_20230826T153338Z_gen_g4_detsim_hitreco__20240227T210725Z_reco2_reco2.root"
15-Jan-2026 20:44:04 CET  Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/33/02/nu_dune10kt_1x2x6_1412_749_20230826T153338Z_gen_g4_detsim_hitreco__20240227T210725Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      2.0478        2.89155       17.878        2.46476       1.79885        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0411096     0.0579179     0.100854      0.0584958     0.0105368       100    
reco:pandora:StandardPandora                    1.99908       2.82334       17.7887       2.39574       1.79237        100    
[art]:TriggerResults:TriggerResultInserter     9.725e-06    2.32133e-05   6.5219e-05    2.11375e-05   1.02625e-05      100    
end_path:out1:RootOutput                       3.135e-06    5.80438e-06   2.3215e-05     6.009e-06    2.39551e-06      100    
end_path:out1:RootOutput(write)               0.00133172     0.0100063     0.0385892    0.00809078    0.00839952       100    
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2145.88 MB
  Peak resident set size usage (VmHWM): 1135.36 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===