Jobsub ID 292862.3@dunegpschedd02.fnal.gov
| Jobsub ID | 292862.3@dunegpschedd02.fnal.gov |
| Workflow ID | 12170 |
| Stage ID | 1 |
| User name | lwhite86@fnal.gov |
| Requested | Processors | 1 |
| GPU | No |
| RSS bytes | 4194304000 (4000 MiB) |
| Wall seconds limit | 3600 (1 hours) |
| Submitted time | 2026-01-21 15:06:52 |
| Site | US_UChicago |
| Entry | Engage_US_MWT2_uiuc_condce_mcore |
| Last heartbeat | 2026-01-21 15:14:39 |
| From worker node | Hostname | mwt2-c203.campuscluster.illinois.edu |
| cpuinfo | AMD EPYC 7402 24-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 4194304000 (4000 MiB) |
| Wall seconds limit | 86400 (24 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2026-01-21 15:07:46 |
| Input files | fardet-hd:nu_dune10kt_1x2x6_1408_835_20230826T094701Z_gen_g4_detsim_hitreco__20240229T175819Z_reco2.root
|
| Jobscript | Exit code | 0 |
| Real time | 6m (397s) |
| CPU time | 5m (352s = 88%) |
| Max RSS bytes | 1590730752 (1517 MiB) |
| Outputting started | 2026-01-21 15:14:23 |
| Output files | |
| Finished | 2026-01-21 15:14:39 |
| Saved logs | justin-logs:292862.3-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
0.0048556, 0.000868111, 0.00010478
Begin processing the 70th record. run: 1408 subRun: 1 event: 83570 at 21-Jan-2026 09:13:04 CST
TrackPID: 13, 0.273336, 0.578027, 0.145648, 0.00298845
TrackPID: 13, 0.419484, 0.453077, 0.120246, 0.00719306
TrackPID: 13, 0.99987, 0.000107242, 1.48986e-05, 7.58749e-06
TrackPID: 2212, 0.0123712, 0.186607, 0.797853, 0.00316857
Begin processing the 71st record. run: 1408 subRun: 1 event: 83571 at 21-Jan-2026 09:13:07 CST
TrackPID: 2212, 0.000167432, 0.00789808, 0.991227, 0.00070727
TrackPID: 2212, 0.0066367, 0.317118, 0.670939, 0.00530598
TrackPID: 2212, 0.000216014, 0.00227649, 0.996533, 0.000974324
TrackPID: -211, 0.137931, 0.679843, 0.175632, 0.00659417
TrackPID: 211, 0.668261, 0.222394, 0.104807, 0.00453861
TrackPID: -211, 0.0543638, 0.856689, 0.0732169, 0.01573
TrackPID: 321, 6.19038e-05, 0.031151, 0.959366, 0.00942085
TrackPID: 321, 0.0152974, 0.874323, 0.0877963, 0.0225835
TrackPID: 2212, 0.000307533, 0.038709, 0.951381, 0.00960271
Begin processing the 72nd record. run: 1408 subRun: 1 event: 83572 at 21-Jan-2026 09:13:11 CST
TrackPID: 211, 0.107016, 0.532371, 0.353232, 0.00738057
Begin processing the 73rd record. run: 1408 subRun: 1 event: 83573 at 21-Jan-2026 09:13:13 CST
TrackPID: 13, 0.998607, 0.000760339, 0.000589871, 4.25792e-05
Begin processing the 74th record. run: 1408 subRun: 1 event: 83574 at 21-Jan-2026 09:13:15 CST
TrackPID: 2212, 0.000226543, 0.00225816, 0.996576, 0.000939476
Begin processing the 75th record. run: 1408 subRun: 1 event: 83575 at 21-Jan-2026 09:13:20 CST
TrackPID: 22, 0.164455, 0.660996, 0.168932, 0.00561663
Begin processing the 76th record. run: 1408 subRun: 1 event: 83576 at 21-Jan-2026 09:13:22 CST
TrackPID: 13, 0.994766, 0.00437647, 0.000765522, 9.16764e-05
TrackPID: 2212, 0.000155451, 0.0055102, 0.992667, 0.00166753
Begin processing the 77th record. run: 1408 subRun: 1 event: 83577 at 21-Jan-2026 09:13:24 CST
TrackPID: -211, 0.286193, 0.644389, 0.0574566, 0.0119611
TrackPID: -211, 0.416937, 0.441267, 0.13402, 0.00777561
TrackPID: 2212, 0.000286541, 0.00310412, 0.995523, 0.0010859
TrackPID: 22, 0.106496, 0.865702, 0.024867, 0.00293541
TrackPID: 13, 0.455366, 0.318939, 0.214413, 0.011282
TrackPID: 2212, 0.0433953, 0.110228, 0.837628, 0.00874868
TrackPID: -211, 0.131638, 0.403624, 0.454468, 0.0102701
Begin processing the 78th record. run: 1408 subRun: 1 event: 83578 at 21-Jan-2026 09:13:32 CST
Begin processing the 79th record. run: 1408 subRun: 1 event: 83579 at 21-Jan-2026 09:13:34 CST
TrackPID: 211, 0.00169046, 0.110787, 0.878181, 0.00934139
TrackPID: 2212, 0.00018662, 0.00331684, 0.995899, 0.000597731
TrackPID: 13, 0.402549, 0.395254, 0.193851, 0.00834605
TrackPID: 2212, 0.000398881, 0.00300906, 0.995402, 0.00119045
Begin processing the 80th record. run: 1408 subRun: 1 event: 83580 at 21-Jan-2026 09:13:37 CST
TrackPID: 2212, 0.000388527, 0.0055297, 0.993051, 0.00103056
Begin processing the 81st record. run: 1408 subRun: 1 event: 83581 at 21-Jan-2026 09:13:39 CST
TrackPID: 2212, 0.147465, 0.578797, 0.265645, 0.00809297
TrackPID: 2212, 0.00134601, 0.0211345, 0.974374, 0.00314519
TrackPID: 2212, 0.0545758, 0.612697, 0.326198, 0.00652906
TrackPID: -211, 0.380334, 0.474998, 0.130439, 0.0142298
Begin processing the 82nd record. run: 1408 subRun: 1 event: 83582 at 21-Jan-2026 09:13:41 CST
TrackPID: 211, 0.298491, 0.439883, 0.250753, 0.0108733
TrackPID: 13, 0.839374, 0.107277, 0.050309, 0.00303999
Begin processing the 83rd record. run: 1408 subRun: 1 event: 83583 at 21-Jan-2026 09:13:44 CST
Begin processing the 84th record. run: 1408 subRun: 1 event: 83584 at 21-Jan-2026 09:13:46 CST
TrackPID: 2212, 0.0626511, 0.727657, 0.204696, 0.00499636
TrackPID: 13, 0.0698807, 0.851211, 0.0723546, 0.00655326
TrackPID: 2212, 0.000376291, 0.010032, 0.988369, 0.00122271
TrackPID: 2212, 9.84209e-05, 0.00258193, 0.996589, 0.000731114
Begin processing the 85th record. run: 1408 subRun: 1 event: 83585 at 21-Jan-2026 09:13:48 CST
TrackPID: 2212, 0.000246699, 0.00844756, 0.990574, 0.000731261
Begin processing the 86th record. run: 1408 subRun: 1 event: 83586 at 21-Jan-2026 09:13:49 CST
TrackPID: 211, 0.190826, 0.688442, 0.10288, 0.0178524
TrackPID: 13, 0.0545353, 0.243313, 0.692206, 0.00994587
Begin processing the 87th record. run: 1408 subRun: 1 event: 83587 at 21-Jan-2026 09:13:51 CST
TrackPID: 22, 0.0261798, 0.395338, 0.572162, 0.00632065
TrackPID: 22, 0.0159495, 0.408051, 0.560199, 0.0157999
TrackPID: -13, 0.916111, 0.0433198, 0.0390432, 0.00152628
Begin processing the 88th record. run: 1408 subRun: 1 event: 83588 at 21-Jan-2026 09:13:53 CST
Begin processing the 89th record. run: 1408 subRun: 1 event: 83589 at 21-Jan-2026 09:13:55 CST
Begin processing the 90th record. run: 1408 subRun: 1 event: 83590 at 21-Jan-2026 09:13:56 CST
TrackPID: 13, 0.999896, 8.16517e-05, 1.66014e-05, 5.77024e-06
Begin processing the 91st record. run: 1408 subRun: 1 event: 83591 at 21-Jan-2026 09:13:58 CST
PfoList empty... moving on.
iter->second->Run() throw STATUS_CODE_FAILURE
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 Alg0097, LArDLTrackCharacterisation, STATUS_CODE_FAILURE
Begin processing the 92nd record. run: 1408 subRun: 1 event: 83592 at 21-Jan-2026 09:14:00 CST
TrackPID: 2212, 0.00346647, 0.0792576, 0.914687, 0.00258931
TrackPID: -211, 0.677062, 0.204185, 0.112338, 0.00641498
Begin processing the 93rd record. run: 1408 subRun: 1 event: 83593 at 21-Jan-2026 09:14:04 CST
TrackPID: 13, 0.591729, 0.325088, 0.077547, 0.00563619
TrackPID: 2212, 0.00066483, 0.0209413, 0.97725, 0.00114377
Begin processing the 94th record. run: 1408 subRun: 1 event: 83594 at 21-Jan-2026 09:14:06 CST
TrackPID: 2212, 0.000305063, 0.0130296, 0.9857, 0.000965388
TrackPID: 211, 0.011679, 0.350044, 0.626278, 0.0119989
Begin processing the 95th record. run: 1408 subRun: 1 event: 83595 at 21-Jan-2026 09:14:08 CST
TrackPID: 2212, 0.000191936, 0.00247894, 0.996452, 0.000877055
TrackPID: 13, 0.049025, 0.419269, 0.525003, 0.00670353
Begin processing the 96th record. run: 1408 subRun: 1 event: 83596 at 21-Jan-2026 09:14:10 CST
TrackPID: 2212, 7.20296e-05, 0.00137822, 0.998176, 0.000374269
TrackPID: 2212, 0.000275952, 0.00428176, 0.994437, 0.00100547
TrackPID: -211, 0.0410272, 0.546526, 0.398483, 0.0139638
Begin processing the 97th record. run: 1408 subRun: 1 event: 83597 at 21-Jan-2026 09:14:12 CST
TrackPID: 13, 0.989267, 0.00701446, 0.00354618, 0.000171975
Begin processing the 98th record. run: 1408 subRun: 1 event: 83598 at 21-Jan-2026 09:14:14 CST
TrackPID: 211, 0.086551, 0.671544, 0.235214, 0.00669137
TrackPID: 211, 0.0146595, 0.833429, 0.133834, 0.0180769
Begin processing the 99th record. run: 1408 subRun: 1 event: 83599 at 21-Jan-2026 09:14:16 CST
TrackPID: 211, 0.166794, 0.799335, 0.0307755, 0.0030955
TrackPID: 13, 0.174571, 0.657848, 0.161885, 0.00569599
Begin processing the 100th record. run: 1408 subRun: 1 event: 83600 at 21-Jan-2026 09:14:18 CST
TrackPID: 2212, 0.000192321, 0.00574584, 0.993455, 0.000606626
TrackPID: 211, 0.0244102, 0.336905, 0.632565, 0.00611969
TrackPID: 13, 0.159132, 0.629203, 0.204971, 0.00669457
21-Jan-2026 09:14:20 CST Closed output file "nu_dune10kt_1x2x6_1408_835_20230826T094701Z_gen_g4_detsim_hitreco__20240229T175819Z_reco2_reco2.root"
21-Jan-2026 09:14:20 CST Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/3b/28/nu_dune10kt_1x2x6_1408_835_20230826T094701Z_gen_g4_detsim_hitreco__20240229T175819Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.0791146 3.02702 43.4547 1.91343 4.75858 100
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.0102334 0.0209322 0.0449133 0.021441 0.00716957 100
reco:pandora2:StandardPandora 0.0574657 3.00504 43.4322 1.89043 4.75843 100
[art]:TriggerResults:TriggerResultInserter 1.1742e-05 3.33719e-05 0.000113795 3.0337e-05 1.77365e-05 100
end_path:out1:RootOutput 3.115e-06 5.42052e-06 3.0748e-05 4.634e-06 3.27592e-06 100
end_path:out1:RootOutput(write) 0.000255761 0.000762208 0.0034402 0.000508088 0.00065488 100
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 2588.34 MB
Peak resident set size usage (VmHWM): 1590.73 MB
====================================================================================================
Art has completed and will exit with status 0.
lar exit code 0
total 436
-rw-r--r-- 1 dune osgvo 210 Jan 21 09:07 all-input-dids.txt
-rw-r--r-- 1 dune osgvo 0 Jan 21 09:08 debugprod.log
-rw-r--r-- 1 dune osgvo 58097 Jan 21 09:14 jobscript.log
-rw-r--r-- 1 dune osgvo 184 Jan 21 09:14 justin-processed-pfns.txt
drwxr-xr-x 4 dune osgvo 4096 Jan 21 09:07 larpandoracontent
-rw-r--r-- 1 dune osgvo 359156 Jan 21 09:14 nu_dune10kt_1x2x6_1408_835_20230826T094701Z_gen_g4_detsim_hitreco__20240229T175819Z_reco2_reco2.root
-rw-r--r-- 1 dune osgvo 519 Jan 21 09:14 reco2_hist.root 