justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 272996.66@dunegpschedd01.fnal.gov

Jobsub ID272996.66@dunegpschedd01.fnal.gov
Workflow ID11641
Stage ID1
User nameykermaid@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit3600 (1 hours)
Submitted time2026-01-09 14:44:24
SiteUS_UChicago
EntryEngage_US_MWT2_iut2_condce_mcore
Last heartbeat2026-01-09 15:24:22
From worker nodeHostnamemwt2-c184.campuscluster.illinois.edu
cpuinfoIntel(R) Xeon(R) Gold 6248 CPU @ 2.50GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit86400 (24 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2026-01-09 15:11:08
Input fileshd-protodune-det-reco:np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup.root
JobscriptExit code0
Real time12m (779s)
CPU time12m (763s = 97%)
Max RSS bytes987824128 (942 MiB)
Outputting started2026-01-09 15:24:08
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/ykermaid/fnal/11641/1/001/np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup_20260109T151122Z_singlehit.root
Finished2026-01-09 15:24:22
Saved logsjustin-logs:272996.66-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

.10-2.17 -z /cvmfs/larsoft.opensciencegrid.org/products -q e26:prof
OPENBLAS_INC=/cvmfs/larsoft.opensciencegrid.org/products/openblas/v0_3_23/Linux64bit+3.10-2.17-e26/include
PYTHON_INCLUDE=/cvmfs/larsoft.opensciencegrid.org/products/python/v3_9_15/Linux64bit+3.10-2.17/include/python3.9
_=/usr/bin/env
Will use justin-get-file
pfn: root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/cc/74/np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup.root
did: hd-protodune-det-reco:np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup.root
output_file: np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup_20260109T151122Z_singlehit.root
Running reco stage1
%MSG-i MF_INIT_OK:  Early 09-Jan-2026 09:11:31 CST JobSetup
Messagelogger initialization complete.
%MSG
Info in <TGeoManager::Import>: Reading geometry from file: /cvmfs/dune.opensciencegrid.org/products/dune/dunecore/v10_16_00d00/gdml/protodunehd_v6_refactored.gdml
Info in <TGeoManager::TGeoManager>: Geometry GDMLImport, Geometry imported from GDML created
Info in <TGeoManager::SetTopVolume>: Top volume is volWorld. Master volume is volWorld
Info in <TGeoNavigator::BuildCache>: --- Maximum geometry depth set to 100
Info in <TGeoManager::CheckGeometry>: Fixing runtime shapes...
Info in <TGeoManager::CheckGeometry>: ...Nothing to fix
Info in <TGeoManager::CloseGeometry>: Counting nodes...
Info in <TGeoManager::Voxelize>: Voxelizing...
Info in <TGeoManager::CloseGeometry>: Building cache...
Info in <TGeoManager::CountLevels>: max level = 5, max placements = 1148
Info in <TGeoManager::CloseGeometry>: 25610 nodes/ 5537 volume UID's in Geometry imported from GDML
Info in <TGeoManager::CloseGeometry>: ----------------modeler ready----------------
%MSG-i AuxDetGeometryCore:  Early 09-Jan-2026 09:11:34 CST JobSetup
New detector geometry loaded from
	/cvmfs/dune.opensciencegrid.org/products/dune/dunecore/v10_16_00d00/gdml/protodunehd_v6_refactored.gdml
%MSG
%MSG-i GeometryCore:  Early 09-Jan-2026 09:11:34 CST JobSetup
Sorting volumes...
%MSG
%MSG-i GeometryCore:  Early 09-Jan-2026 09:11:34 CST JobSetup
New detector geometry loaded from
	/cvmfs/dune.opensciencegrid.org/products/dune/dunecore/v10_16_00d00/gdml/protodunehd_v6_refactored.gdml
%MSG
%MSG-i DuneApaWireReadoutGeom:  Early 09-Jan-2026 09:11:34 CST JobSetup
Initializing wire readout...
%MSG
Cryostat 0:
  10240 total channels
  4 APAs
  For all identical APA:
    Number of channels per APA = 2560
    U channels per APA = 800
    V channels per APA = 800
    Z channels per APA = 960
    Pitch in U Plane = 0.4669
    Pitch in V Plane = 0.4669
    Pitch in Z Plane = 0.4792
%MSG-i SimpleChannelStatusService:  Early 09-Jan-2026 09:11:34 CST JobSetup
Loaded from configuration:
  - 0 bad channels
  - 0 noisy channels
  - largest channel ID: 10239, largest present: 10239
%MSG
%MSG-i setupProvider<DetectorPropertiesStandard>:  Early  09-Jan-2026 09:11:34 CST JobSetup
Asked to ignore 1 keys: 'InheritNumberTimeSamples'
%MSG
IFDH constructor, got keys:
service_type, 
IFDH: didn't find a base uri...

09-Jan-2026 09:11:35 CST  Initiating request to open input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/cc/74/np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup.root"
09-Jan-2026 09:11:43 CST  Opened input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/cc/74/np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup.root"
Begin processing the 1st record. run: 28086 subRun: 1 event: 395299 at 09-Jan-2026 09:11:45 CST
Begin processing the 2nd record. run: 28086 subRun: 1 event: 395307 at 09-Jan-2026 09:12:07 CST
Begin processing the 3rd record. run: 28086 subRun: 1 event: 395315 at 09-Jan-2026 09:12:29 CST
Begin processing the 4th record. run: 28086 subRun: 1 event: 395323 at 09-Jan-2026 09:12:47 CST
Begin processing the 5th record. run: 28086 subRun: 1 event: 395331 at 09-Jan-2026 09:13:00 CST
Begin processing the 6th record. run: 28086 subRun: 1 event: 395339 at 09-Jan-2026 09:13:31 CST
Begin processing the 7th record. run: 28086 subRun: 1 event: 395347 at 09-Jan-2026 09:14:00 CST
Begin processing the 8th record. run: 28086 subRun: 1 event: 395355 at 09-Jan-2026 09:15:05 CST
Begin processing the 9th record. run: 28086 subRun: 1 event: 395363 at 09-Jan-2026 09:15:39 CST
Begin processing the 10th record. run: 28086 subRun: 1 event: 395371 at 09-Jan-2026 09:15:52 CST
Begin processing the 11th record. run: 28086 subRun: 1 event: 395379 at 09-Jan-2026 09:16:09 CST
Begin processing the 12th record. run: 28086 subRun: 1 event: 395387 at 09-Jan-2026 09:16:39 CST
Begin processing the 13th record. run: 28086 subRun: 1 event: 395395 at 09-Jan-2026 09:17:10 CST
Begin processing the 14th record. run: 28086 subRun: 1 event: 395403 at 09-Jan-2026 09:17:20 CST
Begin processing the 15th record. run: 28086 subRun: 1 event: 395411 at 09-Jan-2026 09:17:26 CST
Begin processing the 16th record. run: 28086 subRun: 1 event: 395419 at 09-Jan-2026 09:17:47 CST
Begin processing the 17th record. run: 28086 subRun: 1 event: 395427 at 09-Jan-2026 09:18:06 CST
Begin processing the 18th record. run: 28086 subRun: 1 event: 395435 at 09-Jan-2026 09:18:30 CST
Begin processing the 19th record. run: 28086 subRun: 1 event: 395443 at 09-Jan-2026 09:19:18 CST
Begin processing the 20th record. run: 28086 subRun: 1 event: 395451 at 09-Jan-2026 09:19:36 CST
Begin processing the 21st record. run: 28086 subRun: 1 event: 395459 at 09-Jan-2026 09:19:54 CST
Begin processing the 22nd record. run: 28086 subRun: 1 event: 395467 at 09-Jan-2026 09:20:03 CST
Begin processing the 23rd record. run: 28086 subRun: 1 event: 395475 at 09-Jan-2026 09:20:12 CST
Begin processing the 24th record. run: 28086 subRun: 1 event: 395483 at 09-Jan-2026 09:20:54 CST
Begin processing the 25th record. run: 28086 subRun: 1 event: 395491 at 09-Jan-2026 09:21:20 CST
Begin processing the 26th record. run: 28086 subRun: 1 event: 395499 at 09-Jan-2026 09:22:24 CST
Begin processing the 27th record. run: 28086 subRun: 1 event: 395507 at 09-Jan-2026 09:22:32 CST
Begin processing the 28th record. run: 28086 subRun: 1 event: 395515 at 09-Jan-2026 09:22:40 CST
Begin processing the 29th record. run: 28086 subRun: 1 event: 395523 at 09-Jan-2026 09:22:45 CST
Begin processing the 30th record. run: 28086 subRun: 1 event: 395531 at 09-Jan-2026 09:23:16 CST
Begin processing the 31st record. run: 28086 subRun: 1 event: 395539 at 09-Jan-2026 09:23:49 CST
09-Jan-2026 09:24:03 CST  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/cc/74/np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup.root"

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          5.47349       23.8224       64.7616       21.3785       14.9391        31     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.000257923   0.00558811     0.0391002    0.000431218   0.00990064       31     
end_path:ana:SingleHit              5.47297       23.8166       64.761        21.3779       14.9391        31     
====================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 1950.52 MB
  Peak resident set size usage (VmHWM): 987.824 MB
  Details saved in: 'mem.db'
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 31 passed = 31 failed = 0

TrigReport ---------- Modules in End-path ----------
TrigReport        Run    Success      Error Name
TrigReport         31         31          0 ana

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 726.340428 Real = 738.928394

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 1950.52 VmHWM = 987.824

Art has completed and will exit with status 0.
Output files:
\tHists: np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup_20260109T151122Z_singlehit.root
formed
{
  "name": "np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup_20260109T151122Z_singlehit.root",
  "namespace": "usertests",
  "metadata": {
    "core.file_format": "root",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v10_16_00d00",
    "core.data_tier": "root-tuple-virtual",
    "dune.config_file": "runSingleHit_PDHD.fcl",
    "dune.campaign": "hd-protodune-sim-reco",
    "core.start_time": 1767972244.0,
    "core.end_time": 1767972244.0,
    "core.data_stream": "physics",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      28086
    ],
    "core.runs_subruns": [
      2808600001
    ]
  },
  "parents": [
    {
      "did": "hd-protodune-det-reco:np04hd_raw_run028086_1594_dataflow3_datawriter_0_20240721T232644_reco_stage1_reco_stage2_20240811T000738_keepup.root"
    }
  ]
}
justIN time: 2026-02-04 11:24:02 UTC       justIN version: 01.06.00