justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 267285.72@dunegpschedd02.fnal.gov

Jobsub ID267285.72@dunegpschedd02.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:50:27
SiteUS_UChicago
EntryEngage_US_MWT2_uct2_gk02_condce_mcore
Last heartbeat2026-01-09 15:24:14
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:02:39
Input fileshd-protodune-det-reco:np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup.root
JobscriptExit code0
Real time21m (1277s)
CPU time20m (1249s = 97%)
Max RSS bytes1136058368 (1083 MiB)
Outputting started2026-01-09 15:23:57
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/ykermaid/fnal/11641/1/001/np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup_20260109T150255Z_singlehit.root
Finished2026-01-09 15:24:14
Saved logsjustin-logs:267285.72-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

0-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/2d/1b/np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup.root
did: hd-protodune-det-reco:np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup.root
output_file: np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup_20260109T150255Z_singlehit.root
Running reco stage1
%MSG-i MF_INIT_OK:  Early 09-Jan-2026 10:03:06 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:03:10 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:03:11 EST JobSetup
Sorting volumes...
%MSG
%MSG-i GeometryCore:  Early 09-Jan-2026 10:03:11 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:03:11 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:03:11 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:03:11 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:03:11 EST  Initiating request to open input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/2d/1b/np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup.root"
09-Jan-2026 10:03:14 EST  Opened input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/2d/1b/np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup.root"
Begin processing the 1st record. run: 28086 subRun: 1 event: 536104 at 09-Jan-2026 10:03:15 EST
Begin processing the 2nd record. run: 28086 subRun: 1 event: 536112 at 09-Jan-2026 10:03:36 EST
Begin processing the 3rd record. run: 28086 subRun: 1 event: 536120 at 09-Jan-2026 10:04:06 EST
Begin processing the 4th record. run: 28086 subRun: 1 event: 536128 at 09-Jan-2026 10:04:13 EST
Begin processing the 5th record. run: 28086 subRun: 1 event: 536136 at 09-Jan-2026 10:04:52 EST
Begin processing the 6th record. run: 28086 subRun: 1 event: 536144 at 09-Jan-2026 10:05:04 EST
Begin processing the 7th record. run: 28086 subRun: 1 event: 536152 at 09-Jan-2026 10:05:20 EST
Begin processing the 8th record. run: 28086 subRun: 1 event: 536160 at 09-Jan-2026 10:05:24 EST
Begin processing the 9th record. run: 28086 subRun: 1 event: 536168 at 09-Jan-2026 10:05:37 EST
Begin processing the 10th record. run: 28086 subRun: 1 event: 536176 at 09-Jan-2026 10:05:45 EST
Begin processing the 11th record. run: 28086 subRun: 1 event: 536184 at 09-Jan-2026 10:06:00 EST
Begin processing the 12th record. run: 28086 subRun: 1 event: 536192 at 09-Jan-2026 10:06:37 EST
Begin processing the 13th record. run: 28086 subRun: 1 event: 536200 at 09-Jan-2026 10:06:53 EST
Begin processing the 14th record. run: 28086 subRun: 1 event: 536208 at 09-Jan-2026 10:07:26 EST
Begin processing the 15th record. run: 28086 subRun: 1 event: 536216 at 09-Jan-2026 10:07:28 EST
Begin processing the 16th record. run: 28086 subRun: 1 event: 536224 at 09-Jan-2026 10:07:46 EST
Begin processing the 17th record. run: 28086 subRun: 1 event: 536232 at 09-Jan-2026 10:08:21 EST
Begin processing the 18th record. run: 28086 subRun: 1 event: 536240 at 09-Jan-2026 10:08:43 EST
Begin processing the 19th record. run: 28086 subRun: 1 event: 536248 at 09-Jan-2026 10:09:44 EST
Begin processing the 20th record. run: 28086 subRun: 1 event: 536256 at 09-Jan-2026 10:10:00 EST
Begin processing the 21st record. run: 28086 subRun: 1 event: 536264 at 09-Jan-2026 10:10:43 EST
Begin processing the 22nd record. run: 28086 subRun: 1 event: 536272 at 09-Jan-2026 10:11:07 EST
Begin processing the 23rd record. run: 28086 subRun: 1 event: 536280 at 09-Jan-2026 10:11:25 EST
Begin processing the 24th record. run: 28086 subRun: 1 event: 536288 at 09-Jan-2026 10:12:00 EST
Begin processing the 25th record. run: 28086 subRun: 1 event: 536296 at 09-Jan-2026 10:13:08 EST
Begin processing the 26th record. run: 28086 subRun: 1 event: 536304 at 09-Jan-2026 10:13:24 EST
Begin processing the 27th record. run: 28086 subRun: 1 event: 536312 at 09-Jan-2026 10:13:51 EST
Begin processing the 28th record. run: 28086 subRun: 1 event: 536376 at 09-Jan-2026 10:14:11 EST
Begin processing the 29th record. run: 28086 subRun: 1 event: 536384 at 09-Jan-2026 10:14:18 EST
Begin processing the 30th record. run: 28086 subRun: 1 event: 536392 at 09-Jan-2026 10:14:36 EST
Begin processing the 31st record. run: 28086 subRun: 1 event: 536400 at 09-Jan-2026 10:23:36 EST
09-Jan-2026 10:23:52 EST  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune-det-reco/2d/1b/np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup.root"

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          2.28574       39.9015       539.403       18.503        92.4032        31     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.000362027   0.00616869     0.0290122    0.000733835   0.00956069       31     
end_path:ana:SingleHit              2.28479       39.895        539.403       18.4737       92.4044        31     
====================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2234.13 MB
  Peak resident set size usage (VmHWM): 1136.06 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 = 1213.901666 Real = 1237.090467

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 2234.13 VmHWM = 1136.06

Art has completed and will exit with status 0.
Output files:
\tHists: np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup_20260109T150255Z_singlehit.root
formed
{
  "name": "np04hd_raw_run028086_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup_20260109T150255Z_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": 1767972233.0,
    "core.end_time": 1767972233.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_2162_dataflow0_datawriter_0_20240722T042156_reco_stage1_reco_stage2_20240811T004002_keepup.root"
    }
  ]
}
justIN time: 2026-02-04 11:23:52 UTC       justIN version: 01.06.00