Jobsub ID 241422.15@dunegpschedd01.fnal.gov
| Jobsub ID | 241422.15@dunegpschedd01.fnal.gov | 
| Workflow ID | 9495 | 
| 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-31 14:45:05 | 
| Site | US_PuertoRico | 
| Entry | CMS_T3_US_PuertoRico_UPRM | 
| Last heartbeat | 2025-10-31 15:21:22 | 
| From worker node | Hostname | compute-1-4.local | 
| cpuinfo | Intel(R) Xeon(R) CPU           W3550  @ 3.07GHz | 
| 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-31 14:46:07 | 
| Input files | fardet-hd:nu_dune10kt_1x2x6_1108_793_20230826T214117Z_gen_g4_detsim_hitreco__20240229T172208Z_reco2.root
  | 
| Jobscript | Exit code | 0 | 
| Real time | 34m (2093s) | 
| CPU time | 22m (1357s = 64%) | 
| Max RSS bytes | 1247293440 (1189 MiB) | 
| Outputting started | 2025-10-31 15:21:01 | 
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/imawby/kalmanAlg_nu_0/fnal/09495/1/001/ClusterValidation_WithAlg_nu_dune10kt_1x2x6_1108_793_20230826T214117Z_gen_g4_detsim_hitreco__20240229T172208Z_reco2.root
  | 
| Finished | 2025-10-31 15:21:22 | 
| Saved logs | justin-logs:241422.15-dunegpschedd01.fnal.gov.logs.tgz | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
--------------------------
Input PFN = root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/0b/ad/nu_dune10kt_1x2x6_1108_793_20230826T214117Z_gen_g4_detsim_hitreco__20240229T172208Z_reco2.root
lar exit code 0
=== Start last 100 lines of lar log file ===
Begin processing the 23rd record. run: 1108 subRun: 1 event: 79323 at 31-Oct-2025 11:00:18 AST
Begin processing the 24th record. run: 1108 subRun: 1 event: 79324 at 31-Oct-2025 11:00:27 AST
Begin processing the 25th record. run: 1108 subRun: 1 event: 79325 at 31-Oct-2025 11:00:38 AST
Begin processing the 26th record. run: 1108 subRun: 1 event: 79326 at 31-Oct-2025 11:00:48 AST
Begin processing the 27th record. run: 1108 subRun: 1 event: 79327 at 31-Oct-2025 11:00:58 AST
Begin processing the 28th record. run: 1108 subRun: 1 event: 79328 at 31-Oct-2025 11:01:10 AST
Begin processing the 29th record. run: 1108 subRun: 1 event: 79329 at 31-Oct-2025 11:01:20 AST
Begin processing the 30th record. run: 1108 subRun: 1 event: 79330 at 31-Oct-2025 11:01:32 AST
Begin processing the 31st record. run: 1108 subRun: 1 event: 79331 at 31-Oct-2025 11:01:42 AST
Begin processing the 32nd record. run: 1108 subRun: 1 event: 79332 at 31-Oct-2025 11:01:53 AST
Begin processing the 33rd record. run: 1108 subRun: 1 event: 79333 at 31-Oct-2025 11:02:03 AST
Begin processing the 34th record. run: 1108 subRun: 1 event: 79334 at 31-Oct-2025 11:02:14 AST
Begin processing the 35th record. run: 1108 subRun: 1 event: 79335 at 31-Oct-2025 11:02:33 AST
Begin processing the 36th record. run: 1108 subRun: 1 event: 79336 at 31-Oct-2025 11:02:49 AST
Begin processing the 37th record. run: 1108 subRun: 1 event: 79337 at 31-Oct-2025 11:02:59 AST
Begin processing the 38th record. run: 1108 subRun: 1 event: 79338 at 31-Oct-2025 11:03:10 AST
Begin processing the 39th record. run: 1108 subRun: 1 event: 79339 at 31-Oct-2025 11:03:21 AST
Begin processing the 40th record. run: 1108 subRun: 1 event: 79340 at 31-Oct-2025 11:03:34 AST
Begin processing the 41st record. run: 1108 subRun: 1 event: 79341 at 31-Oct-2025 11:03:45 AST
Begin processing the 42nd record. run: 1108 subRun: 1 event: 79342 at 31-Oct-2025 11:03:56 AST
Begin processing the 43rd record. run: 1108 subRun: 1 event: 79343 at 31-Oct-2025 11:04:07 AST
Begin processing the 44th record. run: 1108 subRun: 1 event: 79344 at 31-Oct-2025 11:04:26 AST
Begin processing the 45th record. run: 1108 subRun: 1 event: 79345 at 31-Oct-2025 11:04:35 AST
Begin processing the 46th record. run: 1108 subRun: 1 event: 79346 at 31-Oct-2025 11:04:52 AST
Begin processing the 47th record. run: 1108 subRun: 1 event: 79347 at 31-Oct-2025 11:05:04 AST
Begin processing the 48th record. run: 1108 subRun: 1 event: 79348 at 31-Oct-2025 11:05:18 AST
Begin processing the 49th record. run: 1108 subRun: 1 event: 79349 at 31-Oct-2025 11:05:28 AST
Begin processing the 50th record. run: 1108 subRun: 1 event: 79350 at 31-Oct-2025 11:05:43 AST
Begin processing the 51st record. run: 1108 subRun: 1 event: 79351 at 31-Oct-2025 11:05:54 AST
Begin processing the 52nd record. run: 1108 subRun: 1 event: 79352 at 31-Oct-2025 11:06:05 AST
Begin processing the 53rd record. run: 1108 subRun: 1 event: 79353 at 31-Oct-2025 11:06:18 AST
Begin processing the 54th record. run: 1108 subRun: 1 event: 79354 at 31-Oct-2025 11:06:29 AST
Begin processing the 55th record. run: 1108 subRun: 1 event: 79355 at 31-Oct-2025 11:06:42 AST
Begin processing the 56th record. run: 1108 subRun: 1 event: 79356 at 31-Oct-2025 11:06:53 AST
Begin processing the 57th record. run: 1108 subRun: 1 event: 79357 at 31-Oct-2025 11:07:04 AST
Begin processing the 58th record. run: 1108 subRun: 1 event: 79358 at 31-Oct-2025 11:07:17 AST
Begin processing the 59th record. run: 1108 subRun: 1 event: 79359 at 31-Oct-2025 11:07:27 AST
Begin processing the 60th record. run: 1108 subRun: 1 event: 79360 at 31-Oct-2025 11:07:39 AST
Begin processing the 61st record. run: 1108 subRun: 1 event: 79361 at 31-Oct-2025 11:07:49 AST
Begin processing the 62nd record. run: 1108 subRun: 1 event: 79362 at 31-Oct-2025 11:08:02 AST
Begin processing the 63rd record. run: 1108 subRun: 1 event: 79363 at 31-Oct-2025 11:10:19 AST
Begin processing the 64th record. run: 1108 subRun: 1 event: 79364 at 31-Oct-2025 11:10:31 AST
Begin processing the 65th record. run: 1108 subRun: 1 event: 79365 at 31-Oct-2025 11:10:42 AST
Begin processing the 66th record. run: 1108 subRun: 1 event: 79366 at 31-Oct-2025 11:10:54 AST
Begin processing the 67th record. run: 1108 subRun: 1 event: 79367 at 31-Oct-2025 11:11:05 AST
Begin processing the 68th record. run: 1108 subRun: 1 event: 79368 at 31-Oct-2025 11:11:21 AST
Begin processing the 69th record. run: 1108 subRun: 1 event: 79369 at 31-Oct-2025 11:14:00 AST
Begin processing the 70th record. run: 1108 subRun: 1 event: 79370 at 31-Oct-2025 11:14:10 AST
Begin processing the 71st record. run: 1108 subRun: 1 event: 79371 at 31-Oct-2025 11:14:20 AST
Begin processing the 72nd record. run: 1108 subRun: 1 event: 79372 at 31-Oct-2025 11:14:34 AST
Begin processing the 73rd record. run: 1108 subRun: 1 event: 79373 at 31-Oct-2025 11:14:45 AST
Begin processing the 74th record. run: 1108 subRun: 1 event: 79374 at 31-Oct-2025 11:14:58 AST
Begin processing the 75th record. run: 1108 subRun: 1 event: 79375 at 31-Oct-2025 11:15:08 AST
Begin processing the 76th record. run: 1108 subRun: 1 event: 79376 at 31-Oct-2025 11:15:18 AST
Begin processing the 77th record. run: 1108 subRun: 1 event: 79377 at 31-Oct-2025 11:15:30 AST
Begin processing the 78th record. run: 1108 subRun: 1 event: 79378 at 31-Oct-2025 11:15:41 AST
Begin processing the 79th record. run: 1108 subRun: 1 event: 79379 at 31-Oct-2025 11:15:52 AST
Begin processing the 80th record. run: 1108 subRun: 1 event: 79380 at 31-Oct-2025 11:16:01 AST
Begin processing the 81st record. run: 1108 subRun: 1 event: 79381 at 31-Oct-2025 11:16:10 AST
Begin processing the 82nd record. run: 1108 subRun: 1 event: 79382 at 31-Oct-2025 11:16:38 AST
Begin processing the 83rd record. run: 1108 subRun: 1 event: 79383 at 31-Oct-2025 11:16:48 AST
Begin processing the 84th record. run: 1108 subRun: 1 event: 79384 at 31-Oct-2025 11:16:57 AST
Begin processing the 85th record. run: 1108 subRun: 1 event: 79385 at 31-Oct-2025 11:17:07 AST
Begin processing the 86th record. run: 1108 subRun: 1 event: 79386 at 31-Oct-2025 11:17:31 AST
Begin processing the 87th record. run: 1108 subRun: 1 event: 79387 at 31-Oct-2025 11:17:42 AST
Begin processing the 88th record. run: 1108 subRun: 1 event: 79388 at 31-Oct-2025 11:17:52 AST
Begin processing the 89th record. run: 1108 subRun: 1 event: 79389 at 31-Oct-2025 11:18:03 AST
Begin processing the 90th record. run: 1108 subRun: 1 event: 79390 at 31-Oct-2025 11:18:11 AST
Begin processing the 91st record. run: 1108 subRun: 1 event: 79391 at 31-Oct-2025 11:18:26 AST
Begin processing the 92nd record. run: 1108 subRun: 1 event: 79392 at 31-Oct-2025 11:18:36 AST
Begin processing the 93rd record. run: 1108 subRun: 1 event: 79393 at 31-Oct-2025 11:18:46 AST
Begin processing the 94th record. run: 1108 subRun: 1 event: 79394 at 31-Oct-2025 11:18:56 AST
Begin processing the 95th record. run: 1108 subRun: 1 event: 79395 at 31-Oct-2025 11:19:06 AST
Begin processing the 96th record. run: 1108 subRun: 1 event: 79396 at 31-Oct-2025 11:19:25 AST
Begin processing the 97th record. run: 1108 subRun: 1 event: 79397 at 31-Oct-2025 11:19:35 AST
Begin processing the 98th record. run: 1108 subRun: 1 event: 79398 at 31-Oct-2025 11:19:47 AST
Begin processing the 99th record. run: 1108 subRun: 1 event: 79399 at 31-Oct-2025 11:19:58 AST
Begin processing the 100th record. run: 1108 subRun: 1 event: 79400 at 31-Oct-2025 11:20:48 AST
31-Oct-2025 11:20:59 AST  Closed output file "nu_dune10kt_1x2x6_1108_793_20230826T214117Z_gen_g4_detsim_hitreco__20240229T172208Z_reco2_reco2.root"
31-Oct-2025 11:20:59 AST  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/0b/ad/nu_dune10kt_1x2x6_1108_793_20230826T214117Z_gen_g4_detsim_hitreco__20240229T172208Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                      6.95871       13.298        154.678       9.52376       19.1406        100    
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                         0.152982      0.189699      0.288308      0.182162      0.026917        100    
reco:pandora:StandardPandora                    6.77639       13.083        154.309       9.33148       19.1111        100    
[art]:TriggerResults:TriggerResultInserter     2.25e-05     4.60207e-05   0.00049487    3.22905e-05   5.02633e-05      100    
end_path:out1:RootOutput                       3.475e-06    4.67299e-06   5.0207e-05     3.884e-06    4.91079e-06      100    
end_path:out1:RootOutput(write)               0.00246751     0.024997      0.208371      0.0170062     0.0314793       100    
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 2435.94 MB
  Peak resident set size usage (VmHWM): 1247.29 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
mv: cannot stat 'ClusterValidation_WithoutAlg.root': No such file or directory