Jobsub ID 273497.3@dunegpschedd02.fnal.gov

Jobsub ID	273497.3@dunegpschedd02.fnal.gov
Workflow ID	11974
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 20:18:16
Site	UK_Bristol
Entry	CMSHTPC_T2_UK_SGrid_Bristol_lcgce02
Last heartbeat	2026-01-15 21:30:56
From worker node	Hostname	hd75.dice.priv
	cpuinfo	AMD EPYC 7551P 32-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	1048576000 (1000 MiB)
	Wall seconds limit	259200 (72 hours)
	GPU
	Inner Apptainer?	True
Job state	outputting_failed
Started	2026-01-15 20:19:36
Input files	fardet-hd:nu_dune10kt_1x2x6_1102_390_20230826T065208Z_gen_g4_detsim_hitreco__20240229T190210Z_reco2.root
Jobscript	Exit code	0
	Real time	11m (717s)
	CPU time	10m (639s = 89%)
	Max RSS bytes	1347465216 (1285 MiB)
Outputting started	2026-01-15 20:31:34
Output files
Finished	2026-01-15 21:30:56
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

cts_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/85/30/nu_dune10kt_1x2x6_1102_390_20230826T065208Z_gen_g4_detsim_hitreco__20240229T190210Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 26th record. run: 1102 subRun: 1 event: 39026 at 15-Jan-2026 20:23:19 UTC
Begin processing the 27th record. run: 1102 subRun: 1 event: 39027 at 15-Jan-2026 20:23:23 UTC
Begin processing the 28th record. run: 1102 subRun: 1 event: 39028 at 15-Jan-2026 20:23:33 UTC
Begin processing the 29th record. run: 1102 subRun: 1 event: 39029 at 15-Jan-2026 20:23:38 UTC
Begin processing the 30th record. run: 1102 subRun: 1 event: 39030 at 15-Jan-2026 20:23:43 UTC
Begin processing the 31st record. run: 1102 subRun: 1 event: 39031 at 15-Jan-2026 20:23:47 UTC
Begin processing the 32nd record. run: 1102 subRun: 1 event: 39032 at 15-Jan-2026 20:23:53 UTC
Begin processing the 33rd record. run: 1102 subRun: 1 event: 39033 at 15-Jan-2026 20:23:57 UTC
Begin processing the 34th record. run: 1102 subRun: 1 event: 39034 at 15-Jan-2026 20:24:00 UTC
Begin processing the 35th record. run: 1102 subRun: 1 event: 39035 at 15-Jan-2026 20:24:05 UTC
Begin processing the 36th record. run: 1102 subRun: 1 event: 39036 at 15-Jan-2026 20:24:17 UTC
Begin processing the 37th record. run: 1102 subRun: 1 event: 39037 at 15-Jan-2026 20:24:21 UTC
Begin processing the 38th record. run: 1102 subRun: 1 event: 39038 at 15-Jan-2026 20:24:25 UTC
Begin processing the 39th record. run: 1102 subRun: 1 event: 39039 at 15-Jan-2026 20:24:29 UTC
Begin processing the 40th record. run: 1102 subRun: 1 event: 39040 at 15-Jan-2026 20:24:33 UTC
Begin processing the 41st record. run: 1102 subRun: 1 event: 39041 at 15-Jan-2026 20:24:38 UTC
Begin processing the 42nd record. run: 1102 subRun: 1 event: 39042 at 15-Jan-2026 20:24:42 UTC
Begin processing the 43rd record. run: 1102 subRun: 1 event: 39043 at 15-Jan-2026 20:24:59 UTC
Begin processing the 44th record. run: 1102 subRun: 1 event: 39044 at 15-Jan-2026 20:25:02 UTC
Begin processing the 45th record. run: 1102 subRun: 1 event: 39045 at 15-Jan-2026 20:25:08 UTC
Begin processing the 46th record. run: 1102 subRun: 1 event: 39046 at 15-Jan-2026 20:25:12 UTC
Begin processing the 47th record. run: 1102 subRun: 1 event: 39047 at 15-Jan-2026 20:25:16 UTC
Begin processing the 48th record. run: 1102 subRun: 1 event: 39048 at 15-Jan-2026 20:25:20 UTC
Begin processing the 49th record. run: 1102 subRun: 1 event: 39049 at 15-Jan-2026 20:25:24 UTC
Begin processing the 50th record. run: 1102 subRun: 1 event: 39050 at 15-Jan-2026 20:25:29 UTC
Begin processing the 51st record. run: 1102 subRun: 1 event: 39051 at 15-Jan-2026 20:25:35 UTC
Begin processing the 52nd record. run: 1102 subRun: 1 event: 39052 at 15-Jan-2026 20:25:39 UTC
Begin processing the 53rd record. run: 1102 subRun: 1 event: 39053 at 15-Jan-2026 20:25:45 UTC
Begin processing the 54th record. run: 1102 subRun: 1 event: 39054 at 15-Jan-2026 20:25:49 UTC
Begin processing the 55th record. run: 1102 subRun: 1 event: 39055 at 15-Jan-2026 20:25:54 UTC
Begin processing the 56th record. run: 1102 subRun: 1 event: 39056 at 15-Jan-2026 20:25:58 UTC
Begin processing the 57th record. run: 1102 subRun: 1 event: 39057 at 15-Jan-2026 20:26:07 UTC
Begin processing the 58th record. run: 1102 subRun: 1 event: 39058 at 15-Jan-2026 20:26:11 UTC
Begin processing the 59th record. run: 1102 subRun: 1 event: 39059 at 15-Jan-2026 20:26:14 UTC
Begin processing the 60th record. run: 1102 subRun: 1 event: 39060 at 15-Jan-2026 20:26:21 UTC
Begin processing the 61st record. run: 1102 subRun: 1 event: 39061 at 15-Jan-2026 20:26:25 UTC
Begin processing the 62nd record. run: 1102 subRun: 1 event: 39062 at 15-Jan-2026 20:26:29 UTC
Begin processing the 63rd record. run: 1102 subRun: 1 event: 39063 at 15-Jan-2026 20:26:40 UTC
Begin processing the 64th record. run: 1102 subRun: 1 event: 39064 at 15-Jan-2026 20:26:44 UTC
Begin processing the 65th record. run: 1102 subRun: 1 event: 39065 at 15-Jan-2026 20:26:49 UTC
Begin processing the 66th record. run: 1102 subRun: 1 event: 39066 at 15-Jan-2026 20:26:53 UTC
Begin processing the 67th record. run: 1102 subRun: 1 event: 39067 at 15-Jan-2026 20:26:56 UTC
Begin processing the 68th record. run: 1102 subRun: 1 event: 39068 at 15-Jan-2026 20:28:18 UTC
Begin processing the 69th record. run: 1102 subRun: 1 event: 39069 at 15-Jan-2026 20:28:23 UTC
Begin processing the 70th record. run: 1102 subRun: 1 event: 39070 at 15-Jan-2026 20:28:30 UTC
Begin processing the 71st record. run: 1102 subRun: 1 event: 39071 at 15-Jan-2026 20:28:46 UTC
Begin processing the 72nd record. run: 1102 subRun: 1 event: 39072 at 15-Jan-2026 20:28:50 UTC
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 73rd record. run: 1102 subRun: 1 event: 39073 at 15-Jan-2026 20:28:54 UTC
Begin processing the 74th record. run: 1102 subRun: 1 event: 39074 at 15-Jan-2026 20:28:58 UTC
Begin processing the 75th record. run: 1102 subRun: 1 event: 39075 at 15-Jan-2026 20:29:07 UTC
Begin processing the 76th record. run: 1102 subRun: 1 event: 39076 at 15-Jan-2026 20:29:11 UTC
Begin processing the 77th record. run: 1102 subRun: 1 event: 39077 at 15-Jan-2026 20:29:14 UTC
Begin processing the 78th record. run: 1102 subRun: 1 event: 39078 at 15-Jan-2026 20:29:19 UTC
Begin processing the 79th record. run: 1102 subRun: 1 event: 39079 at 15-Jan-2026 20:29:23 UTC
Begin processing the 80th record. run: 1102 subRun: 1 event: 39080 at 15-Jan-2026 20:29:27 UTC
Begin processing the 81st record. run: 1102 subRun: 1 event: 39081 at 15-Jan-2026 20:29:37 UTC
Begin processing the 82nd record. run: 1102 subRun: 1 event: 39082 at 15-Jan-2026 20:29:44 UTC
Begin processing the 83rd record. run: 1102 subRun: 1 event: 39083 at 15-Jan-2026 20:29:48 UTC
Begin processing the 84th record. run: 1102 subRun: 1 event: 39084 at 15-Jan-2026 20:29:52 UTC
Begin processing the 85th record. run: 1102 subRun: 1 event: 39085 at 15-Jan-2026 20:29:56 UTC
Begin processing the 86th record. run: 1102 subRun: 1 event: 39086 at 15-Jan-2026 20:30:00 UTC
Begin processing the 87th record. run: 1102 subRun: 1 event: 39087 at 15-Jan-2026 20:30:04 UTC
Begin processing the 88th record. run: 1102 subRun: 1 event: 39088 at 15-Jan-2026 20:30:07 UTC
Begin processing the 89th record. run: 1102 subRun: 1 event: 39089 at 15-Jan-2026 20:30:13 UTC
Begin processing the 90th record. run: 1102 subRun: 1 event: 39090 at 15-Jan-2026 20:30:17 UTC
Begin processing the 91st record. run: 1102 subRun: 1 event: 39091 at 15-Jan-2026 20:30:22 UTC
Begin processing the 92nd record. run: 1102 subRun: 1 event: 39092 at 15-Jan-2026 20:30:26 UTC
Begin processing the 93rd record. run: 1102 subRun: 1 event: 39093 at 15-Jan-2026 20:30:30 UTC
Begin processing the 94th record. run: 1102 subRun: 1 event: 39094 at 15-Jan-2026 20:30:34 UTC
Begin processing the 95th record. run: 1102 subRun: 1 event: 39095 at 15-Jan-2026 20:30:38 UTC
Begin processing the 96th record. run: 1102 subRun: 1 event: 39096 at 15-Jan-2026 20:30:54 UTC
Begin processing the 97th record. run: 1102 subRun: 1 event: 39097 at 15-Jan-2026 20:30:58 UTC
Begin processing the 98th record. run: 1102 subRun: 1 event: 39098 at 15-Jan-2026 20:31:12 UTC
Begin processing the 99th record. run: 1102 subRun: 1 event: 39099 at 15-Jan-2026 20:31:18 UTC
Begin processing the 100th record. run: 1102 subRun: 1 event: 39100 at 15-Jan-2026 20:31:22 UTC
15-Jan-2026 20:31:32 UTC  Closed output file "nu_dune10kt_1x2x6_1102_390_20230826T065208Z_gen_g4_detsim_hitreco__20240229T190210Z_reco2_reco2.root"
15-Jan-2026 20:31:33 UTC  Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/85/30/nu_dune10kt_1x2x6_1102_390_20230826T065208Z_gen_g4_detsim_hitreco__20240229T190210Z_reco2.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      3.36126       5.89815       79.6084       3.95831       7.93446        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0145296     0.0325483     0.0703339     0.0331919    0.00989783       100    
reco:pandora:StandardPandora                    3.34455       5.84584       79.4334       3.91189       7.91738        100    
[art]:TriggerResults:TriggerResultInserter    1.4206e-05    2.74035e-05   0.000149011   2.3364e-05    1.85849e-05      100    
end_path:out1:RootOutput                       3.076e-06    4.18958e-06   2.5498e-05     3.507e-06     2.424e-06       100    
end_path:out1:RootOutput(write)               0.00141529     0.0195085     0.138291      0.0124144     0.0214686       100    
================================================================================================================================

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

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