Jobsub ID 301936.1@dunegpschedd01.fnal.gov

Jobsub ID	301936.1@dunegpschedd01.fnal.gov
Workflow ID	12420
Stage ID	1
User name	smanthey@fnal.gov
Requested	Processors	1
	GPU	No
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2026-01-28 13:52:44
Site	US_FNAL-FermiGrid
Entry	FNAL_GPGrid_ce04_mcore_op_duneonly
Last heartbeat	2026-01-28 17:06:16
From worker node	Hostname	dunegli-8463070-0-fnpc23031.fnal.gov
	cpuinfo	AMD EPYC 7543 32-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	172800 (48 hours)
	GPU
	Inner Apptainer?	True
Job state	outputting_failed
Started	2026-01-28 13:53:57
Input files	fardet-vd:prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250204T110609Z_gen_001708_supernova_g4stage1_g4stage2_detsim_reco_20250730T045723Z_reco2.root
Jobscript	Exit code	0
	Real time	3h (11530s)
	CPU time	3h (11441s = 99%)
	Max RSS bytes	2574282752 (2455 MiB)
Outputting started	2026-01-28 17:06:08
Output files
Finished	2026-01-28 17:06:16
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

132726; 132727; 132728; 132729; 132730; 132731; 132732; 132733; 132737; 132738; 132740; 132741; 132743; 132745; 132746; 132748; 132749; 132750; 132752; 132830; 132831; [0m
%MSG
%MSG-w ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 16:34:40 UTC run: 5043 subRun: 0 event: 17079
[31m
Kinetic energy of signal particle is above threshold of 30.00 MeV. Skipping event.
[0m
%MSG
Begin processing the 10th record. run: 5043 subRun: 0 event: 17080 at 28-Jan-2026 16:34:40 UTC
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 16:34:43 UTC run: 5043 subRun: 0 event: 17080
[35m
###################################################
Event:			17080
Flag:			1766238395
Geometry:		dunevd10kt_3view_30deg_v5_refactored_1x8x14ref (VD)
Signal Label:		marley
PDS Frequency in [MHz]:	62.50
PDS Tick in [us]:	0.016
TPC Frequency in [MHz]:	2.00
TPC Tick in [us]:	0.50
TPC Map:		112 TPCs
TPC DriftLength in [cm]:650.07
TPC DriftTime in [us]:	4048.69
Fiducial Volume in [cm]:850.32, 1507.84, 2306.12
###################################################[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 16:34:43 UTC run: 5043 subRun: 0 event: 17080
[91m
There are a total of 133004 Particles in the event

# of particles 7	from gen 1 marley
# of particles 31322	from gen 2 Ar39GenInLAr
# of particles 3420	from gen 3 Kr85GenInLAr
# of particles 3	from gen 4 Ar42GenInLAr
# of particles 1	from gen 5 K42From42ArGenInLAr
# of particles 27	from gen 6 Rn222ChainRn222GenInLAr
# of particles 31	from gen 7 Rn222ChainPo218GenInLAr
# of particles 44	from gen 8 Rn222ChainPb214GenInLAr
# of particles 46	from gen 9 Rn222ChainBi214GenInLAr
# of particles 9	from gen 10 Rn222ChainPb210GenInLAr
# of particles 21	from gen 11 Rn220ChainPb212GenInLAr
# of particles 213	from gen 12 K40GenInCathode
# of particles 2953	from gen 13 U238ChainGenInCathode
# of particles 3502	from gen 14 Th232ChainGenInCathode
# of particles 109	from gen 15 K40GenInAnode
# of particles 1401	from gen 16 U238ChainGenInAnode
# of particles 1796	from gen 17 Th232ChainGenInAnode
# of particles 0	from gen 18 Rn222ChainGenInPDS
# of particles 3	from gen 19 K42From42ArGenInUpperMesh1x8x14
# of particles 1	from gen 20 Rn222ChainFromPo218GenInUpperMesh1x8x14
# of particles 17	from gen 21 Rn222ChainFromPb214GenInUpperMesh1x8x14
# of particles 55	from gen 22 Rn222ChainFromBi214GenInUpperMesh1x8x14
# of particles 73	from gen 23 Rn222ChainFromPb210GenInUpperMesh1x8x14
# of particles 37	from gen 24 Rn222ChainFromBi210GenInUpperMesh1x8x14
# of particles 49	from gen 25 Rn220ChainFromPb212GenInUpperMesh1x8x14
# of particles 84313	from gen 26 CavernwallGammasAtLAr1x8x14
# of particles 3534	from gen 27 foamGammasAtLAr1x8x14
# of particles 16	from gen 28 CavernwallNeutronsAtLAr1x8x14
# of particles 1	from gen 29 CryostatNGammasAtLAr1x8x14
# of particles 0	from gen 30 CavernNGammasAtLAr1x8x14[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 16:34:43 UTC run: 5043 subRun: 0 event: 17080
[33m
Number of Signal Particles: 7
Neutrino Interaction: -1
Neutrino Energy: 5.58 MeV
Position (-279.10, 221.22, 1333.69) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		0.75	(-279.10, 221.22, 1333.69)	133024	132984
marley	-12		0.56	(-279.10, 221.22, 1333.69)	133023	132984
marley	22		0.03	(-279.10, 221.22, 1333.69)	132987	0
marley	22		1.61	(-279.10, 221.22, 1333.69)	132986	0
marley	22		0.65	(-279.10, 221.22, 1333.69)	132985	0
marley	1000190400	0.00	(-279.10, 221.22, 1333.69)	132984	0
marley	11		1.79	(-279.10, 221.22, 1333.69)	132983	0
Signal Track IDs: 132983; 132984; 132985; 132986; 132987; 133023; 133024; [0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 16:34:43 UTC run: 5043 subRun: 0 event: 17080
[33m
Kinetic energy of signal particle is below threshold of 30.00 MeV. Selecting event.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 16:35:28 UTC run: 5043 subRun: 0 event: 17080
[34mOpFlash PE 218.97 with purity 0.09 time -0.04 plane 0
 - Vertex (-327.50, 259.42, 1288.13)
	*** 1st Sanity check: Ratio 0.29 <= 1.00
	*** 2nd Sanity check: #OpHits 13 >= 13
OpFlash PE 49.67 with purity 0.04 time 0.42 plane 0
 - Vertex (-327.50, 461.34, 661.51)
	*** 1st Sanity check: Ratio 0.19 <= 1.00
	*** 2nd Sanity check: #OpHits 8 >= 8
OpFlash PE 75.82 with purity 0.07 time 2.47 plane 0
 - Vertex (-327.50, 192.38, 1207.80)
	*** 1st Sanity check: Ratio 0.15 <= 1.00
	*** 2nd Sanity check: #OpHits 10 >= 10
OpFlash PE 19.13 with purity 0.23 time 4.97 plane 0
 - Vertex (-327.50, 107.89, 1633.62)
	*** 1st Sanity check: Ratio 0.38 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3

# of OpHits (ophit10ppm): 51999 for times between -4254.06 us and 295147919198126080.00 us.
# of OpFlashes (solarflash): 18175 for times between -4254.06 us and 295147919198126080.00 us.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 16:35:30 UTC run: 5043 subRun: 0 event: 17080
[36m
# OpHits (ophit10ppm) in full geometry: 51999
# OpFlashes (solarflash) in full geometry: 18175
# Hits (gaushit) in each view: 6629, 6695, 6675, 0
# Cluster from the hits: 2775, 2863, 5667, 0
# Tracks (pmtracktc) in full geometry: 450[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 17:06:07 UTC run: 5043 subRun: 0 event: 17080
[32m
# ClusterReco: Looping over 5666 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 17:06:07 UTC run: 5043 subRun: 0 event: 17080
[32m*** Matched preselection cluster: 5043 from 5666
 - MainTrackID 132983
 - Gen 1 -> marley TPC 69
 - Purity 1.00 Hits 2
 - Charge 157.63 ( MaxHit 106.22 )
 - #AdjCl 9 ( 1 signal ):
    - Cluster 4393 at distance 81.36 with time 3282.20 and charge 29.67 in TPC 75 and hits 1
    - Cluster 4715 at distance 84.81 with time 3526.03 and charge 75.73 in TPC 69 and hits 1
    - Cluster 4977 at distance 30.50 with time 3721.88 and charge 49.74 in TPC 69 and hits 1
    - Cluster 4990 at distance 59.91 with time 3732.44 and charge 91.29 in TPC 77 and hits 2
    - Cluster 5006 at distance 5.12 with time 3741.77 and charge 90.58 in TPC 69 and hits 2
    - Cluster 5008 at distance 80.14 with time 3742.54 and charge 137.50 in TPC 79 and hits 2
    - Cluster 5194 at distance 83.71 with time 3875.59 and charge 34.43 in TPC 69 and hits 1
    - Cluster 5241 at distance 87.97 with time 3910.49 and charge 22.68 in TPC 67 and hits 1
    - Cluster 5307 at distance 40.39 with time 3965.66 and charge 40.68 in TPC 69 and hits 1
 - RecoCol  Time,Y,Z ( 3763.39, 221.33, 1333.98 )
 - RecoInd0 Time,Y,Z ( 3763.32, 221.29, 1270.32 )
 - RecoInd1 Time,Y,Z ( 3763.22, 221.36, 1293.28 )
*** Matched flash: 9081 from 18175
 - Purity 8.90 % Plane 0 #Hits 13
 - MainOpHitPE 62.68 (PE);  TotalPE 218.97 vs expected 224.98 (PE)
 - Time -0.04 (us) Fast 29.08 % Residual 784.62
 - Reco Time,Y,Z ( -0.04, 259.42, 1288.13 )
 - Found valid waveform: true
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -279.10, 221.22, 1333.69 )
 - Main X,Y,Z ( -279.27, 221.27, 1334.04 )
 - EDep X,Y,Z ( -279.18, 221.35, 1333.94 )
 - Reco X,Y,Z ( -279.23, 221.33, 1333.98 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  28-Jan-2026 17:06:07 UTC run: 5043 subRun: 0 event: 17080
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
28-Jan-2026 17:06:07 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/c7/21/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250204T110609Z_gen_001708_supernova_g4stage1_g4stage2_detsim_reco_20250730T045723Z_reco2.root"
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@EndJob 28-Jan-2026 17:06:07 UTC  ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                         0.555174       1149.35       1981.08       1879.51       938.303        10     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.00134339     0.0105488     0.0215058    0.00959732    0.00857106       10     
end_path:solarnuana:SolarNuAna     0.552269       1149.34       1981.06       1879.51       938.303        10     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 28-Jan-2026 17:06:07 UTC  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
  algorithm version: EventTimestamp_v1

%MSG

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

  Peak virtual memory usage (VmPeak)  : 3194.21 MB
  Peak resident set size usage (VmHWM): 2574.28 MB
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 10 passed = 10 failed = 0

TrigReport ---------- Modules in End-path ----------
TrigReport        Run    Success      Error Name
TrigReport         10         10          0 solarnuana

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 11430.020854 Real = 11516.616438

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 3194.21 VmHWM = 2574.28

Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===