Jobsub ID 242413.177@dunegpschedd01.fnal.gov
| Jobsub ID | 242413.177@dunegpschedd01.fnal.gov | 
| Workflow ID | 9555 | 
| 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-11-03 16:39:03 | 
| Site | UK_Manchester | 
| Entry | UBoone_T2_UK_Manchester_ce02 | 
| Last heartbeat | 2025-11-03 16:50:16 | 
| From worker node | Hostname | wn1208241.tier2.hep.manchester.ac.uk | 
| cpuinfo | AMD EPYC 7702P 64-Core Processor | 
| OS release | Scientific Linux release 7.9 (Nitrogen) | 
| Processors | 1 | 
| RSS bytes | 1048576000 (1000 MiB) | 
| Wall seconds limit | 257400 (71 hours) | 
| GPU |  | 
| Inner Apptainer? | True | 
| Job state | finished | 
| Started | 2025-11-03 16:40:15 | 
| Input files | fardet-hd:nu_dune10kt_1x2x6_1413_678_20230826T183344Z_gen_g4_detsim_hitreco__20240229T181138Z_reco2.root
  | 
| Jobscript | Exit code | 0 | 
| Real time | 9m (563s) | 
| CPU time | 7m (451s = 80%) | 
| Max RSS bytes | 1272692736 (1213 MiB) | 
| Outputting started | 2025-11-03 16:49:39 | 
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/splitting_nu_0/fnal/09555/1/001/CheatingKalmanSplittingU_nu_dune10kt_1x2x6_1413_678_20230826T183344Z_gen_g4_detsim_hitreco__20240229T181138Z_reco2.root
  | 
| Finished | 2025-11-03 16:50:08 | 
| Saved logs | justin-logs:242413.177-dunegpschedd01.fnal.gov.logs.tgz | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
.uk/data/dune/fardet-hd/62/79/nu_dune10kt_1x2x6_1413_678_20230826T183344Z_gen_g4_detsim_hitreco__20240229T181138Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
    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 28th record. run: 1413 subRun: 1 event: 67828 at 03-Nov-2025 16:44:42 GMT
Begin processing the 29th record. run: 1413 subRun: 1 event: 67829 at 03-Nov-2025 16:44:46 GMT
Begin processing the 30th record. run: 1413 subRun: 1 event: 67830 at 03-Nov-2025 16:44:49 GMT
Begin processing the 31st record. run: 1413 subRun: 1 event: 67831 at 03-Nov-2025 16:44:53 GMT
Begin processing the 32nd record. run: 1413 subRun: 1 event: 67832 at 03-Nov-2025 16:44:57 GMT
Begin processing the 33rd record. run: 1413 subRun: 1 event: 67833 at 03-Nov-2025 16:45:02 GMT
Begin processing the 34th record. run: 1413 subRun: 1 event: 67834 at 03-Nov-2025 16:45:05 GMT
Begin processing the 35th record. run: 1413 subRun: 1 event: 67835 at 03-Nov-2025 16:45:10 GMT
Begin processing the 36th record. run: 1413 subRun: 1 event: 67836 at 03-Nov-2025 16:45:13 GMT
Begin processing the 37th record. run: 1413 subRun: 1 event: 67837 at 03-Nov-2025 16:45:17 GMT
Begin processing the 38th record. run: 1413 subRun: 1 event: 67838 at 03-Nov-2025 16:45:20 GMT
Begin processing the 39th record. run: 1413 subRun: 1 event: 67839 at 03-Nov-2025 16:45:24 GMT
Begin processing the 40th record. run: 1413 subRun: 1 event: 67840 at 03-Nov-2025 16:45:28 GMT
Begin processing the 41st record. run: 1413 subRun: 1 event: 67841 at 03-Nov-2025 16:45:32 GMT
Begin processing the 42nd record. run: 1413 subRun: 1 event: 67842 at 03-Nov-2025 16:45:35 GMT
Begin processing the 43rd record. run: 1413 subRun: 1 event: 67843 at 03-Nov-2025 16:45:40 GMT
Begin processing the 44th record. run: 1413 subRun: 1 event: 67844 at 03-Nov-2025 16:45:44 GMT
Begin processing the 45th record. run: 1413 subRun: 1 event: 67845 at 03-Nov-2025 16:45:48 GMT
Begin processing the 46th record. run: 1413 subRun: 1 event: 67846 at 03-Nov-2025 16:45:51 GMT
Begin processing the 47th record. run: 1413 subRun: 1 event: 67847 at 03-Nov-2025 16:45:55 GMT
Begin processing the 48th record. run: 1413 subRun: 1 event: 67848 at 03-Nov-2025 16:45:59 GMT
Begin processing the 49th record. run: 1413 subRun: 1 event: 67849 at 03-Nov-2025 16:46:04 GMT
Begin processing the 50th record. run: 1413 subRun: 1 event: 67850 at 03-Nov-2025 16:46:08 GMT
Begin processing the 51st record. run: 1413 subRun: 1 event: 67851 at 03-Nov-2025 16:46:13 GMT
Begin processing the 52nd record. run: 1413 subRun: 1 event: 67852 at 03-Nov-2025 16:46:17 GMT
Begin processing the 53rd record. run: 1413 subRun: 1 event: 67853 at 03-Nov-2025 16:46:21 GMT
Begin processing the 54th record. run: 1413 subRun: 1 event: 67854 at 03-Nov-2025 16:46:25 GMT
Begin processing the 55th record. run: 1413 subRun: 1 event: 67855 at 03-Nov-2025 16:46:29 GMT
Begin processing the 56th record. run: 1413 subRun: 1 event: 67856 at 03-Nov-2025 16:46:33 GMT
Begin processing the 57th record. run: 1413 subRun: 1 event: 67857 at 03-Nov-2025 16:46:37 GMT
Begin processing the 58th record. run: 1413 subRun: 1 event: 67858 at 03-Nov-2025 16:46:41 GMT
Begin processing the 59th record. run: 1413 subRun: 1 event: 67859 at 03-Nov-2025 16:46:45 GMT
Begin processing the 60th record. run: 1413 subRun: 1 event: 67860 at 03-Nov-2025 16:46:48 GMT
Begin processing the 61st record. run: 1413 subRun: 1 event: 67861 at 03-Nov-2025 16:46:52 GMT
Begin processing the 62nd record. run: 1413 subRun: 1 event: 67862 at 03-Nov-2025 16:46:55 GMT
Begin processing the 63rd record. run: 1413 subRun: 1 event: 67863 at 03-Nov-2025 16:46:59 GMT
Begin processing the 64th record. run: 1413 subRun: 1 event: 67864 at 03-Nov-2025 16:47:03 GMT
Begin processing the 65th record. run: 1413 subRun: 1 event: 67865 at 03-Nov-2025 16:47:07 GMT
Begin processing the 66th record. run: 1413 subRun: 1 event: 67866 at 03-Nov-2025 16:47:11 GMT
Begin processing the 67th record. run: 1413 subRun: 1 event: 67867 at 03-Nov-2025 16:47:15 GMT
Begin processing the 68th record. run: 1413 subRun: 1 event: 67868 at 03-Nov-2025 16:47:19 GMT
Begin processing the 69th record. run: 1413 subRun: 1 event: 67869 at 03-Nov-2025 16:47:25 GMT
Begin processing the 70th record. run: 1413 subRun: 1 event: 67870 at 03-Nov-2025 16:47:29 GMT
Begin processing the 71st record. run: 1413 subRun: 1 event: 67871 at 03-Nov-2025 16:47:33 GMT
Begin processing the 72nd record. run: 1413 subRun: 1 event: 67872 at 03-Nov-2025 16:47:37 GMT
Begin processing the 73rd record. run: 1413 subRun: 1 event: 67873 at 03-Nov-2025 16:47:41 GMT
Begin processing the 74th record. run: 1413 subRun: 1 event: 67874 at 03-Nov-2025 16:47:45 GMT
Begin processing the 75th record. run: 1413 subRun: 1 event: 67875 at 03-Nov-2025 16:47:49 GMT
Begin processing the 76th record. run: 1413 subRun: 1 event: 67876 at 03-Nov-2025 16:47:53 GMT
Begin processing the 77th record. run: 1413 subRun: 1 event: 67877 at 03-Nov-2025 16:47:56 GMT
Begin processing the 78th record. run: 1413 subRun: 1 event: 67878 at 03-Nov-2025 16:48:00 GMT
Begin processing the 79th record. run: 1413 subRun: 1 event: 67879 at 03-Nov-2025 16:48:05 GMT
Begin processing the 80th record. run: 1413 subRun: 1 event: 67880 at 03-Nov-2025 16:48:09 GMT
Begin processing the 81st record. run: 1413 subRun: 1 event: 67881 at 03-Nov-2025 16:48:13 GMT
Begin processing the 82nd record. run: 1413 subRun: 1 event: 67882 at 03-Nov-2025 16:48:17 GMT
Begin processing the 83rd record. run: 1413 subRun: 1 event: 67883 at 03-Nov-2025 16:48:21 GMT
Begin processing the 84th record. run: 1413 subRun: 1 event: 67884 at 03-Nov-2025 16:48:27 GMT
Begin processing the 85th record. run: 1413 subRun: 1 event: 67885 at 03-Nov-2025 16:48:31 GMT
Begin processing the 86th record. run: 1413 subRun: 1 event: 67886 at 03-Nov-2025 16:48:35 GMT
Begin processing the 87th record. run: 1413 subRun: 1 event: 67887 at 03-Nov-2025 16:48:39 GMT
Begin processing the 88th record. run: 1413 subRun: 1 event: 67888 at 03-Nov-2025 16:48:43 GMT
Begin processing the 89th record. run: 1413 subRun: 1 event: 67889 at 03-Nov-2025 16:48:47 GMT
Begin processing the 90th record. run: 1413 subRun: 1 event: 67890 at 03-Nov-2025 16:48:50 GMT
Begin processing the 91st record. run: 1413 subRun: 1 event: 67891 at 03-Nov-2025 16:48:54 GMT
Begin processing the 92nd record. run: 1413 subRun: 1 event: 67892 at 03-Nov-2025 16:48:58 GMT
Begin processing the 93rd record. run: 1413 subRun: 1 event: 67893 at 03-Nov-2025 16:49:02 GMT
Begin processing the 94th record. run: 1413 subRun: 1 event: 67894 at 03-Nov-2025 16:49:07 GMT
Begin processing the 95th record. run: 1413 subRun: 1 event: 67895 at 03-Nov-2025 16:49:12 GMT
Begin processing the 96th record. run: 1413 subRun: 1 event: 67896 at 03-Nov-2025 16:49:16 GMT
Begin processing the 97th record. run: 1413 subRun: 1 event: 67897 at 03-Nov-2025 16:49:20 GMT
Begin processing the 98th record. run: 1413 subRun: 1 event: 67898 at 03-Nov-2025 16:49:24 GMT
Begin processing the 99th record. run: 1413 subRun: 1 event: 67899 at 03-Nov-2025 16:49:29 GMT
Begin processing the 100th record. run: 1413 subRun: 1 event: 67900 at 03-Nov-2025 16:49:33 GMT
03-Nov-2025 16:49:37 GMT  Closed output file "nu_dune10kt_1x2x6_1413_678_20230826T183344Z_gen_g4_detsim_hitreco__20240229T181138Z_reco2_reco2.root"
03-Nov-2025 16:49:37 GMT  Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/62/79/nu_dune10kt_1x2x6_1413_678_20230826T183344Z_gen_g4_detsim_hitreco__20240229T181138Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.126525       3.86152       10.704        3.67137       1.09145        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.0205958     0.040717      0.117922      0.0380639     0.0141266       100    
reco:pandora:StandardPandora                   0.0802603      3.81348       10.6399       3.62419       1.08945        100    
[art]:TriggerResults:TriggerResultInserter     1.613e-05    2.97636e-05   0.000247376   2.63195e-05    2.409e-05       100    
end_path:out1:RootOutput                       3.627e-06    4.76799e-06    2.657e-05    4.3835e-06    2.49602e-06      100    
end_path:out1:RootOutput(write)               0.00159506    0.00687738     0.0233857    0.00569077    0.00419924       100    
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 2278.08 MB
  Peak resident set size usage (VmHWM): 1272.69 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
mv: cannot stat 'CheatingKalmanSplittingV.root': No such file or directory
mv: cannot stat 'CheatingKalmanSplittingW.root': No such file or directory