justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 296359.4@dunegpschedd02.fnal.gov

Jobsub ID296359.4@dunegpschedd02.fnal.gov
Workflow ID12487
Stage ID1
User nameykermaid@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2026-01-28 15:38:49
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce04_mcore_op_duneonly
Last heartbeat2026-01-28 16:00:42
From worker nodeHostnamedunegli-8464114-0-fnpc22004.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-01-28 15:52:13
Input filesusertests:np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline.root
JobscriptExit code0
Real time7m (450s)
CPU time7m (439s = 97%)
Max RSS bytes1471148032 (1402 MiB)
Outputting started2026-01-28 15:59:43
Output filesusertests:np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline_reco_stage1_20260128T155938_offline.root
usertests:np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline_reco_stage1_20260128T155938_offline_larcv.root
Finished2026-01-28 16:00:42
Saved logsjustin-logs:296359.4-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

G]  <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 = 570597
28-Jan-2026 15:59:38 UTC  Closed output file "np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline_reco_stage1_20260128T155938_offline.root"
28-Jan-2026 15:59:38 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/58/75/np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_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                                                 11.6127       23.5023       67.2313       21.4138        12.05         18     
-------------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                   0.000964392   0.00304917     0.0159952    0.00252899    0.00330494       18     
produce:opflash:OpFlashFinderVerticalDrift               0.00927178     0.0145287     0.0307526     0.0126851    0.00506169       18     
produce:pandora:StandardPandora                            9.36302       20.2563       59.428        18.284        10.8473        18     
produce:pandoraWriter:StandardPandora                     0.065199      0.103744      0.153026      0.101728      0.0191245       18     
produce:pandoraTrack:LArPandoraTrackCreation              0.806098       1.59677       3.34614       1.59303      0.527684        18     
produce:pandoraShower:LArPandoraModularShowerCreation     0.184676      0.266747      0.346802      0.274656      0.0422438       18     
produce:pandoraGnocalo:GnocchiCalorimetry                 0.0197091     0.0291961     0.0438339     0.0299442    0.00565432       18     
produce:pandorapid:Chi2ParticleID                         0.0015567    0.00239521    0.00522138    0.00222026    0.000786566      18     
[art]:TriggerResults:TriggerResultInserter               1.2103e-05    3.94499e-05   0.000212343   2.25925e-05   4.63824e-05      18     
end_path:out1:RootOutput                                  4.559e-06    1.21031e-05   6.9241e-05     7.184e-06    1.46046e-05      18     
end_path:supera:LArSoftSuperaDriver                       0.384323      0.956004       3.43292       0.87483      0.640181        18     
end_path:out1:RootOutput(write)                           0.125481      0.183566      0.266825      0.186433      0.0324709       18     
===========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 2571.05 MB
  Peak resident set size usage (VmHWM): 1471.15 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline_reco_stage1_20260128T155938_offline.root
Forming reco metadata
Successfully opened file np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline_reco_stage1_20260128T155938_offline.root
Ran successfully
{
  "name": "np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline_reco_stage1_20260128T155938_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_neutrino.fcl",
    "dune.campaign": "vd-protodune-det-reco-test",
    "core.start_time": 1769615540.0,
    "core.end_time": 1769615978.0,
    "core.events": [
      570257,
      570277,
      570297,
      570317,
      570337,
      570357,
      570377,
      570397,
      570417,
      570437,
      570457,
      570477,
      570497,
      570517,
      570537,
      570557,
      570577,
      570597
    ],
    "core.event_count": 18,
    "core.first_event_number": 570257,
    "core.last_event_number": 570597,
    "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_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline.root"
    }
  ]
}\tLArCV: np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline_reco_stage1_20260128T155938_offline_larcv.root
Forming larcv metadata
formed
{
  "name": "np02vd_raw_run039273_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline_reco_stage1_20260128T155938_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_neutrino.fcl",
    "dune.campaign": "vd-protodune-det-reco-test",
    "core.start_time": 1769615540.0,
    "core.end_time": 1769615978.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_1584_df-s05-d3_dw_0_20250901T081851_reco_stage0_20260122T162338_offline.root"
    }
  ]
}
justIN time: 2026-02-04 12:02:14 UTC       justIN version: 01.06.00