justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 303291.0@dunegpschedd01.fnal.gov

Jobsub ID303291.0@dunegpschedd01.fnal.gov
Workflow ID12663
Stage ID2
User nameykermaid@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2026-02-03 09:12:40
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce04_mcore_op_duneonly
Last heartbeat2026-02-03 09:29:40
From worker nodeHostnamedunegli-8528044-0-fnpc23045.fnal.gov
cpuinfoAMD EPYC 7543 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit172800 (48 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2026-02-03 09:21:02
Input filesusertests:np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline.root
JobscriptExit code0
Real time7m (476s)
CPU time7m (466s = 97%)
Max RSS bytes1515790336 (1445 MiB)
Outputting started2026-02-03 09:28:59
Output filesusertests:np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline_reco_stage1_20260203T092853_offline.root
usertests:np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline_reco_stage1_20260203T092853_offline_larcv.root
Finished2026-02-03 09:29:40
Saved logsjustin-logs:303291.0-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

:L593 Updating event id for product sparse3d by reco_hit_key0
     [DEBUG]  <IOManager::set_id> IOManager.cxx::L593 Updating event id for product sparse3d by reco_hit_key1
     [DEBUG]  <IOManager::set_id> IOManager.cxx::L593 Updating event id for product sparse3d by reco_hit_key2
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_tree entry 17
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_chi2_tree entry 17
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_cryo_tree entry 17
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_tpc_tree entry 17
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_hit_charge0_tree entry 17
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_hit_charge1_tree entry 17
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_hit_charge2_tree entry 17
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_hit_key0_tree entry 17
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_hit_key1_tree entry 17
     [DEBUG]  <IOManager::save_entry> IOManager.cxx::L416 Saving sparse3d_reco_hit_key2_tree entry 17
     [DEBUG]  <IOManager::clear_entry> IOManager.cxx::L460 Set _last_event_id to externally set values: run = 39273 subrun = 1 event = 356
03-Feb-2026 09:28:53 UTC  Closed output file "np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline_reco_stage1_20260203T092853_offline.root"
03-Feb-2026 09:28:53 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/59/50/np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline.root"
     [DEBUG]  <ProcessDriver::finalize> ProcessDriver.cxx::L424 called
      [INFO]  <ProcessDriver::finalize::L427> Finalizing: SuperaBBoxInteraction
      [INFO]  <ProcessDriver::finalize::L427> Finalizing: SuperaSpacePoint
      [INFO]  <ProcessDriver::finalize::L434> Compiling time profile...
      [INFO]  <ProcessDriver::finalize::L457> Finalizing IO...
     [DEBUG]  <IOManager::finalize> IOManager.cxx::L611 start
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_chi2_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_cryo_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_tpc_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_hit_charge0_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_hit_charge1_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_hit_charge2_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_hit_key0_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_hit_key1_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Writing sparse3d_reco_hit_key2_tree with 18 entries
    [NORMAL]  <IOManager::finalize> Closing output file
      [INFO]  <IOManager::finalize::L639> Deleting data pointers
     [DEBUG]  <IOManager::reset> IOManager.cxx::L647 start
      [INFO]  <ProcessDriver::finalize::L459> Resetting...
     [DEBUG]  <ProcessDriver::reset> ProcessDriver.cxx::L25 Called
     [DEBUG]  <IOManager::reset> IOManager.cxx::L647 start

===========================================================================================================================================
TimeTracker printout (sec)                                   Min           Avg           Max         Median          RMS         nEvts   
===========================================================================================================================================
Full event                                                 10.4817       25.0706       51.1845       23.4859       9.30162        18     
-------------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                   0.000443132   0.00156156     0.0147496    0.000666771    0.0032177       18     
produce:opflash:OpFlashFinderVerticalDrift               0.00934337     0.0154683     0.0433311     0.0123388    0.00988778       18     
produce:pandora:StandardPandora                            8.86705       20.8046       44.793        19.2573       8.14308        18     
produce:pandoraWriter:StandardPandora                     0.0500433     0.0781981     0.0979587     0.0798945     0.0142273       18     
produce:pandoraTrack:LArPandoraTrackCreation              0.536904       1.79529       3.4259        1.95827      0.678875        18     
produce:pandoraShower:LArPandoraModularShowerCreation     0.143359      0.269363      0.385518       0.28368      0.0613982       18     
produce:pandoraGnocalo:GnocchiCalorimetry                 0.0139963     0.0273846     0.039356      0.029767     0.00631449       18     
produce:pandorapid:Chi2ParticleID                        0.00126895    0.00223939    0.00351643    0.00229351    0.000541608      18     
[art]:TriggerResults:TriggerResultInserter               1.0761e-05    1.57173e-05   4.7301e-05    1.50235e-05   7.88906e-06      18     
end_path:out1:RootOutput                                  4.017e-06    6.46011e-06   2.5128e-05     4.854e-06    4.71139e-06      18     
end_path:supera:LArSoftSuperaDriver                       0.379788       1.86121       3.79056       1.80389      0.762289        18     
end_path:out1:RootOutput(write)                           0.112687      0.201028      0.289461      0.217307      0.0438871       18     
===========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2627.84 MB
  Peak resident set size usage (VmHWM): 1515.79 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline_reco_stage1_20260203T092853_offline.root
Forming reco metadata
Successfully opened file np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline_reco_stage1_20260203T092853_offline.root
Ran successfully
{
  "name": "np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline_reco_stage1_20260203T092853_offline.root",
  "namespace": "usertests",
  "metadata": {
    "core.file_format": "artroot",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v10_17_00d00",
    "core.data_tier": "full-reconstructed",
    "dune.config_file": "standard_reco_stage1_protodunevd_beam.fcl",
    "dune.campaign": "vd-protodune-det-reco-test",
    "core.start_time": 1770110468.0,
    "core.end_time": 1770110933.0,
    "core.events": [
      16,
      36,
      56,
      76,
      96,
      116,
      136,
      156,
      176,
      196,
      216,
      236,
      256,
      276,
      296,
      316,
      336,
      356
    ],
    "core.event_count": 18,
    "core.first_event_number": 16,
    "core.last_event_number": 356,
    "core.data_stream": "physics",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      39273
    ],
    "core.runs_subruns": [
      3927300001
    ]
  },
  "parents": [
    {
      "did": "usertests:np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline.root"
    }
  ]
}\tLArCV: np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline_reco_stage1_20260203T092853_offline_larcv.root
Forming larcv metadata
formed
{
  "name": "np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline_reco_stage1_20260203T092853_offline_larcv.root",
  "namespace": "usertests",
  "metadata": {
    "core.file_format": "root",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v10_17_00d00",
    "core.data_tier": "root-tuple-virtual",
    "dune.config_file": "standard_reco_stage1_protodunevd_beam.fcl",
    "dune.campaign": "vd-protodune-det-reco-test",
    "core.start_time": 1770110468.0,
    "core.end_time": 1770110933.0,
    "core.data_stream": "physics",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      39273
    ],
    "core.runs_subruns": [
      3927300001
    ]
  },
  "parents": [
    {
      "did": "usertests:np02vd_raw_run039273_0000_df-s05-d2_dw_0_20250831T094635_reco_stage0_20260203T084832_offline.root"
    }
  ]
}
justIN time: 2026-02-04 12:01:57 UTC       justIN version: 01.06.00