Jobsub ID 303184.3@dunegpschedd01.fnal.gov

Jobsub ID	303184.3@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:52:13
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_klomp
Last heartbeat	2026-02-02 23:08:55
From worker node	Hostname	wn-pep-009.farm.nikhef.nl
	cpuinfo	Intel(R) Xeon(R) Gold 6148 CPU @ 2.40GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	129600 (36 hours)
	GPU
	Inner Apptainer?	True
Job state	jobscript_error
Started	2026-02-02 22:53:17
Input files	usertests:prodgenie_monte-carlo-012654-000451_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:08:55
Saved logs	justin-logs:303184.3-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

46th record. run: 100451 subRun: 0 event: 46 at 03-Feb-2026 00:08:36 CET
++++>>>> total num hits: 41751, num free: 41751

Running Ophitfinder with InputDigiType = 'recob'
Found hits: 2206!
bad particle: track id = 0 PDG = 14 StatusCode = 0
bad particle: track id = 1 PDG = 1000180400 StatusCode = 0
bad particle: track id = 2 PDG = 2112 StatusCode = 11
bad particle: track id = 3 PDG = 1000180390 StatusCode = 2
bad particle: track id = 6 PDG = 4122 StatusCode = 14
bad particle: track id = 7 PDG = 4122 StatusCode = 3
bad particle: track id = 8 PDG = 2000000002 StatusCode = 15
Filling voxel information...
   [93m[WARNING][00m [0m [94m<SuperaMCParticleCluster::AnalyzeSimChannel>[00m Total IDE ctr 99657
 ... due to missing track ID 0 from 0 track IDs
 ... due to invalid particle 3452
 ... due to invalid 2d index 0
 ... due to invalid 3d index 41098

    [95m[NORMAL][00m [0m [94m<SuperaMCParticleCluster::process>[00m Saved interaction count: 3
    [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 45 holds particle w/ an invalid parent ID 65535
      [95mParticle  (PdgCode,TrackID) = (22,1)[00m ... with Parent (0,1)
      Vertex   (x, y, z, t) = (-150.811,433.314,909.106,0)
      Momentum (px, py, pz) = (3.4184,1.08509,6.28367)
      Final Momentum (end_px, end_py, end_pz) = (1.79769e+308,1.79769e+308,1.79769e+308)
      Initial Energy  = 7.23515
      Deposit  Energy  = 0
      Creation Process = primary
      Instance ID = 45
      Group ID    = 45
      Interaction ID = 0

      [95mParticle  (PdgCode,TrackID) = (22,1)[00m ... with Parent (0,1)
      Vertex   (x, y, z, t) = (-150.811,433.314,909.106,0)
      Momentum (px, py, pz) = (3.4184,1.08509,6.28367)
      Final Momentum (end_px, end_py, end_pz) = (1.79769e+308,1.79769e+308,1.79769e+308)
      Initial Energy  = 7.23515
      Deposit  Energy  = 0
      Creation Process = primary
      Instance ID = 45
      Group ID    = 45
      Interaction ID = 0

    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing particle_mpv_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing neutrino_mpv_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_mcst_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_pcluster_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_sed_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_masked_true2reco_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_index_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_masked_true_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_pcluster_highE_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_pcluster_lowE_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_leftover_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_semantics_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing particle_pcluster_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing cluster3d_sed_at_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_chi2_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_occupancy_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_nhits_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_cryo_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_tpc_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_charge0_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_charge1_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_charge2_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_time0_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_time1_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_time2_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_key0_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_key1_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_hit_key2_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_sed_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_pcluster_semantics_ghost_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing particle_corrected_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Writing sparse3d_reco_rescaled_tree with 45 entries
    [95m[NORMAL][00m [0m [94m<IOManager::finalize>[00m Closing output file
03-Feb-2026 00:08:40 CET  Closed input file "root://eospublic.cern.ch:1094//eos/experiment/neutplatform/protodune/dune/usertests/82/32/prodgenie_monte-carlo-012654-000451_gen_g4_detsim.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                    0.00121146      17.9467       312.899       4.18618       48.8252        46     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.000371212   0.00556848     0.0342108    0.000960184    0.0111061       46     
reco:gaushit:GausHitFinder                     0.0638525     0.167386      0.422747      0.154959      0.0731457       46     
reco:cluster3d:Cluster3D                      0.00267288      3.5763        64.8774      0.429324       10.2679        46     
reco:opdec:Deconvolution                       0.0660702     0.283573      0.473088      0.279702      0.0897047       46     
reco:ophitspe:OpHitFinderDeco                  0.206618      0.224113      0.277465      0.224606      0.010411        46     
reco:opflash:OpFlashFinder                    0.000244608   0.00339408     0.0073983    0.00354654    0.00142118       46     
reco:opslicer:OpSlicer                        7.8645e-05     0.326904      0.640548       0.32542      0.171434        46     
reco:mcreco:MCReco                             0.0561741      0.4022        2.03931      0.221177      0.415903        46     
[art]:TriggerResults:TriggerResultInserter     1.56e-05     2.45945e-05   8.2963e-05    2.15235e-05   1.07564e-05      46     
end_path:superaMC:LArSoftSuperaDriver          0.220285       12.8173       241.782       1.90174       38.3366        45     
end_path:out1:RootOutput                       3.904e-06    6.53196e-06    1.46e-05      5.542e-06    2.38535e-06      45     
end_path:out1:RootOutput(write)               0.00275326     0.467018       2.42059      0.225962      0.525978        45     
================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 8955.28 MB
  Peak resident set size usage (VmHWM): 2663.23 MB
====================================================================================================
%MSG-s ArtException:  PostEndJob 03-Feb-2026 00:08:40 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: 100451 subRun: 0 event: 46
        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 45 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-000451_gen_g4_detsim_reco_larcv.root'
ERROR: Output file prodgenie_monte-carlo-012654-000451_gen_g4_detsim_reco.root not produced!