justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 293880.0@dunegpschedd02.fnal.gov

Jobsub ID293880.0@dunegpschedd02.fnal.gov
Workflow ID12253
Stage ID2
User nameykermaid@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2026-01-22 23:19:33
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce04_mcore_op_duneonly
Last heartbeat2026-01-22 23:31:24
From worker nodeHostnamedunegli-8389524-0-fnpc23116.fnal.gov
cpuinfoAMD EPYC 9354 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-01-22 23:21:08
Input filesusertests:np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline.root
JobscriptExit code0
Real time8m (516s)
CPU time8m (494s = 95%)
Max RSS bytes1921519616 (1832 MiB)
Outputting started2026-01-22 23:29:45
Output filesusertests:np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline_reco_stage1_20260122T232940_offline.root
usertests:np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline_reco_stage1_20260122T232940_offline_larcv.root
Finished2026-01-22 23:31:24
Saved logsjustin-logs:293880.0-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

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 = 72349
22-Jan-2026 23:29:40 UTC  Closed output file "np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline_reco_stage1_20260122T232940_offline.root"
22-Jan-2026 23:29:40 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/fc/6f/np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_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                                                 6.20582       26.7092       55.3199       27.1894       13.351         18     
-------------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                   0.000377324   0.00251238     0.0215937    0.000629989   0.00521844       18     
produce:opflash:OpFlashFinderVerticalDrift               0.00728266     0.0221585     0.0348457     0.0232814    0.00793335       18     
produce:pandora:StandardPandora                            5.30512       22.5747       47.4291       22.9122       11.0639        18     
produce:pandoraWriter:StandardPandora                     0.0521348     0.106085      0.196197      0.102319      0.0375943       18     
produce:pandoraTrack:LArPandoraTrackCreation              0.153835      0.580792       1.44545      0.493889      0.337717        18     
produce:pandoraShower:LArPandoraModularShowerCreation     0.147535      0.287269      0.501402      0.263091      0.0943163       18     
produce:pandoraGnocalo:GnocchiCalorimetry                 0.0120979     0.0233543     0.0435633     0.0207795    0.00847771       18     
produce:pandorapid:Chi2ParticleID                        0.000574524   0.00108295    0.00199384    0.00090986    0.000434525      18     
[art]:TriggerResults:TriggerResultInserter                9.475e-06    1.43006e-05   3.6716e-05    1.1402e-05    6.96756e-06      18     
end_path:out1:RootOutput                                  3.185e-06    4.73956e-06   1.7626e-05    3.6105e-06    3.21995e-06      18     
end_path:supera:LArSoftSuperaDriver                       0.378702       2.84214       8.6744        2.66799       1.97533        18     
end_path:out1:RootOutput(write)                           0.123681      0.214625      0.378814      0.184382      0.0779921       18     
===========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3033.26 MB
  Peak resident set size usage (VmHWM): 1921.52 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline_reco_stage1_20260122T232940_offline.root
Forming reco metadata
Successfully opened file np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline_reco_stage1_20260122T232940_offline.root
Ran successfully
{
  "name": "np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline_reco_stage1_20260122T232940_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": 1769124086.0,
    "core.end_time": 1769124580.0,
    "core.events": [
      72009,
      72029,
      72049,
      72069,
      72089,
      72109,
      72129,
      72149,
      72169,
      72189,
      72209,
      72229,
      72249,
      72269,
      72289,
      72309,
      72329,
      72349
    ],
    "core.event_count": 18,
    "core.first_event_number": 72009,
    "core.last_event_number": 72349,
    "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_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline.root"
    }
  ]
}\tLArCV: np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline_reco_stage1_20260122T232940_offline_larcv.root
Forming larcv metadata
formed
{
  "name": "np02vd_raw_run039273_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline_reco_stage1_20260122T232940_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": 1769124086.0,
    "core.end_time": 1769124580.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_0200_df-s03-d3_dw_0_20250831T121553_reco_stage0_20260122T231400_offline.root"
    }
  ]
}
justIN time: 2026-02-04 08:55:42 UTC       justIN version: 01.06.00