Jobsub ID 303186.1@dunegpschedd01.fnal.gov

Jobsub ID	303186.1@dunegpschedd01.fnal.gov
Workflow ID	12654
Stage ID	4
User name	usher@fnal.gov
Requested	Processors	1
	GPU	No
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	28800 (8 hours)
Submitted time	2026-02-02 22:56:13
Site	ES_PIC
Entry	DUNE_T1_ES_PIC_ce16-multicore
Last heartbeat	2026-02-02 23:02:38
From worker node	Hostname	hnode66.pic.es
	cpuinfo	AMD EPYC 7402P 24-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	216000 (60 hours)
	GPU
	Inner Apptainer?	True
Job state	jobscript_error
Started	2026-02-02 22:57:37
Input files	usertests:prodgenie_monte-carlo-012654-000744_gen_g4_detsim.root
Jobscript	Exit code	1
	Real time	0m (0s)
	CPU time	0m (0s = 0%)
	Max RSS bytes	0 (0 MiB)
Outputting started
Output files
Finished	2026-02-02 23:02:38
Saved logs	justin-logs:303186.1-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

0 event: 20 at 03-Feb-2026 00:02:05 CET
++++>>>> total num hits: 133005, num free: 133005

Running Ophitfinder with InputDigiType = 'recob'
Found hits: 2852!
bad particle: track id = 0 PDG = 14 StatusCode = 0
bad particle: track id = 1 PDG = 1000180400 StatusCode = 0
bad particle: track id = 2 PDG = 2212 StatusCode = 11
bad particle: track id = 3 PDG = 1000170390 StatusCode = 2
bad particle: track id = 6 PDG = 2224 StatusCode = 3
bad particle: track id = 7 PDG = 2212 StatusCode = 14
bad particle: track id = 8 PDG = 211 StatusCode = 14
bad particle: track id = 12 PDG = 2000000002 StatusCode = 15
Filling voxel information...
   [93m[WARNING][00m [0m [94m<SuperaMCParticleCluster::AnalyzeSimChannel>[00m Total IDE ctr 96636
 ... due to missing track ID 0 from 0 track IDs
 ... due to invalid particle 213
 ... due to invalid 2d index 0
 ... due to invalid 3d index 14431

    [95m[NORMAL][00m [0m [94m<SuperaMCParticleCluster::process>[00m Saved interaction count: 1
    [95m[NORMAL][00m [0m [94m<SuperaMCParticleCluster::process>[00m 0 particles have no ancestor, summed deposit energy = 0
  [5;1;33;41m[CRITICAL][00m [0m [94m<SuperaMCParticleCluster::process>[00m SuperaMCParticleCluster.cxx::L2402 Particle index 11 holds particle w/ an invalid parent ID 65535
      [95mParticle  (PdgCode,TrackID) = (22,1)[00m ... with Parent (0,1)
      Vertex   (x, y, z, t) = (231.3,116.68,618.385,0)
      Momentum (px, py, pz) = (2.44822,4.70343,-1.69639)
      Final Momentum (end_px, end_py, end_pz) = (1.79769e+308,1.79769e+308,1.79769e+308)
      Initial Energy  = 5.56721
      Deposit  Energy  = 0
      Creation Process = primary
      Instance ID = 11
      Group ID    = 11
      Interaction ID = 0

      [95mParticle  (PdgCode,TrackID) = (22,1)[00m ... with Parent (0,1)
      Vertex   (x, y, z, t) = (231.3,116.68,618.385,0)
      Momentum (px, py, pz) = (2.44822,4.70343,-1.69639)
      Final Momentum (end_px, end_py, end_pz) = (1.79769e+308,1.79769e+308,1.79769e+308)
      Initial Energy  = 5.56721
      Deposit  Energy  = 0
      Creation Process = primary
      Instance ID = 11
      Group ID    = 11
      Interaction ID = 0

    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing particle_mpv_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing neutrino_mpv_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_mcst_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_pcluster_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_sed_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_masked_true2reco_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_index_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_masked_true_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_pcluster_highE_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_pcluster_lowE_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_leftover_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_semantics_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing particle_pcluster_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_sed_at_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_chi2_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_occupancy_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_nhits_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_cryo_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_tpc_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_charge0_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_charge1_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_charge2_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_time0_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_time1_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_time2_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_key0_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_key1_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_key2_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_sed_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_semantics_ghost_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing particle_corrected_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_rescaled_tree with 19 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Closing output file
03-Feb-2026 00:02:15 CET  Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/b9/e0/prodgenie_monte-carlo-012654-000744_gen_g4_detsim.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                    0.000417705     8.48139       67.0668       3.8286        14.1317        20     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000369533    0.0063688     0.038971     0.000784999    0.013451        20     
reco:gaushit:GausHitFinder                     0.131904      0.195365      0.310777      0.190572      0.0481798       20     
reco:cluster3d:Cluster3D                      0.00752752      2.82433       38.9311      0.268954       8.37847        20     
reco:opdec:Deconvolution                       0.195831      0.328071      0.469804      0.322427      0.0758457       20     
reco:ophitspe:OpHitFinderDeco                  0.451582      0.457944      0.465656      0.457698     0.00292011       20     
reco:opflash:OpFlashFinder                    0.000648684   0.00177673     0.004169     0.00170038    0.000765261      20     
reco:opslicer:OpSlicer                         0.0354615     0.375094      0.795304      0.259196      0.251658        20     
reco:mcreco:MCReco                             0.117565      0.377322      0.945109      0.340949       0.2366         20     
[art]:TriggerResults:TriggerResultInserter     1.516e-05    3.1319e-05    9.9543e-05    2.4641e-05    1.93449e-05      20     
end_path:superaMC:LArSoftSuperaDriver          0.407405       4.1905        23.3514       1.93886       5.39246        19     
end_path:out1:RootOutput                       4.79e-06     7.40963e-06   1.5411e-05     6.031e-06    2.8437e-06       19     
end_path:out1:RootOutput(write)                0.0465854     0.310351       2.20884      0.171241      0.472056        19     
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 9593.32 MB
  Peak resident set size usage (VmHWM): 2160.9 MB
====================================================================================================
%MSG-s ArtException:  PostEndJob 03-Feb-2026 00:02:15 CET ModuleEndJob
---- EventProcessorFailure BEGIN
  EventProcessor: an exception occurred during current event processing
  ---- EventProcessorFailure BEGIN
    EndPathExecutor: an exception occurred during current event processing
    ---- ScheduleExecutionFailure BEGIN
      Path: ProcessingStopped.
      ---- StdException BEGIN
        An exception was thrown while processing module LArSoftSuperaDriver/superaMC run: 100744 subRun: 0 event: 20
        std::exception
      ---- StdException END
      Exception going through path end_path
    ---- ScheduleExecutionFailure END
  ---- EventProcessorFailure END
---- EventProcessorFailure END
---- FatalRootError BEGIN
  Fatal Root Error: TTree::SetEntries
  Tree branches have different numbers of entries, eg EventAuxiliary has 19 entries while sim::OpDetDivRecs_opdigi__detsim. has 50 entries.
  ROOT severity: 2000
---- FatalRootError END
%MSG
Art has completed and will exit with status 1.
'larcv.root' -> 'prodgenie_monte-carlo-012654-000744_gen_g4_detsim_reco_larcv.root'
ERROR: Output file prodgenie_monte-carlo-012654-000744_gen_g4_detsim_reco.root not produced!