justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 272996.132@dunegpschedd01.fnal.gov

Jobsub ID272996.132@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_uct2_gk02_condce_mcore
Last heartbeat2026-01-09 15:24:10
From worker nodeHostnameiut2-c296.iu.edu
cpuinfoIntel(R) Xeon(R) Gold 6148 CPU @ 2.40GHz
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:37
Input fileshd-protodune-det-reco:np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup.root
JobscriptExit code0
Real time12m (735s)
CPU time11m (717s = 97%)
Max RSS bytes957333504 (912 MiB)
Outputting started2026-01-09 15:23:52
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/ykermaid/fnal/11641/1/001/np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup_20260109T151152Z_singlehit.root
Finished2026-01-09 15:24:10
Saved logsjustin-logs:272996.132-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/8b/6f/np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup.root
did: hd-protodune-det-reco:np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup.root
output_file: np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup_20260109T151152Z_singlehit.root
Running reco stage1
%MSG-i MF_INIT_OK:  Early 09-Jan-2026 10:12:03 EST 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 10:12:08 EST 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 10:12:08 EST JobSetup
Sorting volumes...
%MSG
%MSG-i GeometryCore:  Early 09-Jan-2026 10:12:08 EST 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 10:12:08 EST 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 10:12:08 EST 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 10:12:08 EST JobSetup
Asked to ignore 1 keys: 'InheritNumberTimeSamples'
%MSG
IFDH constructor, got keys:
service_type, 
IFDH: didn't find a base uri...

09-Jan-2026 10:12:09 EST  Initiating request to open input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/8b/6f/np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup.root"
09-Jan-2026 10:12:11 EST  Opened input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/8b/6f/np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup.root"
Begin processing the 1st record. run: 28086 subRun: 1 event: 347391 at 09-Jan-2026 10:12:12 EST
Begin processing the 2nd record. run: 28086 subRun: 1 event: 347399 at 09-Jan-2026 10:12:18 EST
Begin processing the 3rd record. run: 28086 subRun: 1 event: 347407 at 09-Jan-2026 10:12:31 EST
Begin processing the 4th record. run: 28086 subRun: 1 event: 347471 at 09-Jan-2026 10:12:45 EST
Begin processing the 5th record. run: 28086 subRun: 1 event: 347479 at 09-Jan-2026 10:12:58 EST
Begin processing the 6th record. run: 28086 subRun: 1 event: 347487 at 09-Jan-2026 10:13:33 EST
Begin processing the 7th record. run: 28086 subRun: 1 event: 347495 at 09-Jan-2026 10:13:55 EST
Begin processing the 8th record. run: 28086 subRun: 1 event: 347503 at 09-Jan-2026 10:14:28 EST
Begin processing the 9th record. run: 28086 subRun: 1 event: 347511 at 09-Jan-2026 10:14:48 EST
Begin processing the 10th record. run: 28086 subRun: 1 event: 347519 at 09-Jan-2026 10:15:25 EST
Begin processing the 11th record. run: 28086 subRun: 1 event: 347527 at 09-Jan-2026 10:15:35 EST
Begin processing the 12th record. run: 28086 subRun: 1 event: 347535 at 09-Jan-2026 10:15:59 EST
Begin processing the 13th record. run: 28086 subRun: 1 event: 347543 at 09-Jan-2026 10:16:31 EST
Begin processing the 14th record. run: 28086 subRun: 1 event: 347551 at 09-Jan-2026 10:16:45 EST
Begin processing the 15th record. run: 28086 subRun: 1 event: 347559 at 09-Jan-2026 10:17:19 EST
Begin processing the 16th record. run: 28086 subRun: 1 event: 347567 at 09-Jan-2026 10:17:56 EST
Begin processing the 17th record. run: 28086 subRun: 1 event: 347575 at 09-Jan-2026 10:18:39 EST
Begin processing the 18th record. run: 28086 subRun: 1 event: 347583 at 09-Jan-2026 10:18:50 EST
Begin processing the 19th record. run: 28086 subRun: 1 event: 347591 at 09-Jan-2026 10:19:32 EST
Begin processing the 20th record. run: 28086 subRun: 1 event: 347599 at 09-Jan-2026 10:19:53 EST
Begin processing the 21st record. run: 28086 subRun: 1 event: 347607 at 09-Jan-2026 10:20:28 EST
Begin processing the 22nd record. run: 28086 subRun: 1 event: 347615 at 09-Jan-2026 10:20:43 EST
Begin processing the 23rd record. run: 28086 subRun: 1 event: 347623 at 09-Jan-2026 10:21:01 EST
Begin processing the 24th record. run: 28086 subRun: 1 event: 347631 at 09-Jan-2026 10:21:15 EST
Begin processing the 25th record. run: 28086 subRun: 1 event: 347639 at 09-Jan-2026 10:21:52 EST
Begin processing the 26th record. run: 28086 subRun: 1 event: 347647 at 09-Jan-2026 10:21:55 EST
Begin processing the 27th record. run: 28086 subRun: 1 event: 347695 at 09-Jan-2026 10:22:22 EST
Begin processing the 28th record. run: 28086 subRun: 1 event: 347703 at 09-Jan-2026 10:22:35 EST
Begin processing the 29th record. run: 28086 subRun: 1 event: 347711 at 09-Jan-2026 10:22:51 EST
Begin processing the 30th record. run: 28086 subRun: 1 event: 347719 at 09-Jan-2026 10:23:03 EST
Begin processing the 31st record. run: 28086 subRun: 1 event: 347727 at 09-Jan-2026 10:23:24 EST
09-Jan-2026 10:23:48 EST  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/8b/6f/np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup.root"

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          2.50911       22.4367       42.9574       20.684        11.089         31     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.000388904   0.00570804     0.0316171    0.00079311    0.00917285       31     
end_path:ana:SingleHit              2.49394       22.4306       42.956        20.6827       11.0922        31     
====================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 1941.58 MB
  Peak resident set size usage (VmHWM): 957.334 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 = 682.078962 Real = 695.689507

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 1941.58 VmHWM = 957.334

Art has completed and will exit with status 0.
Output files:
\tHists: np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup_20260109T151152Z_singlehit.root
formed
{
  "name": "np04hd_raw_run028086_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup_20260109T151152Z_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": 1767972228.0,
    "core.end_time": 1767972228.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_1401_dataflow7_datawriter_0_20240721T214536_reco_stage1_reco_stage2_20240811T000522_keepup.root"
    }
  ]
}
justIN time: 2026-02-04 11:25:21 UTC       justIN version: 01.06.00