Jobsub ID 288544.18@dunegpschedd02.fnal.gov

Jobsub ID	288544.18@dunegpschedd02.fnal.gov
Workflow ID	12007
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-20 14:48:38
Site	US_FNAL-T1
Entry	CMSHTPC_T1_US_FNAL_condce_opp1_whole
Last heartbeat	2026-01-20 20:39:16
From worker node	Hostname	dunegli-50386-0-cmswn2355.fnal.gov
	cpuinfo	Intel(R) Xeon(R) CPU E5-2670 v3 @ 2.30GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	171000 (47 hours)
	GPU
	Inner Apptainer?	True
Job state	outputting_failed
Started	2026-01-20 14:57:29
Input files	fardet-vd:prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250126T022343Z_gen_001632_supernova_g4stage1_g4stage2_detsim_reco_20250611T092505Z_reco2.root
Jobscript	Exit code	0
	Real time	5h (20488s)
	CPU time	5h (20154s = 98%)
	Max RSS bytes	2573430784 (2454 MiB)
Outputting started	2026-01-20 20:38:57
Output files
Finished	2026-01-20 20:39:16
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

)
 - EDep X,Y,Z ( -190.56, -609.51, 677.44 )
 - Reco X,Y,Z ( -1000000.00, -609.30, 678.14 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 19:09:56 UTC run: 4909 subRun: 0 event: 16319
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
Begin processing the 10th record. run: 4909 subRun: 0 event: 16320 at 20-Jan-2026 19:09:57 UTC
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 19:11:15 UTC run: 4909 subRun: 0 event: 16320
[35m
###################################################
Event:			16320
Flag:			1602528868
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  20-Jan-2026 19:11:17 UTC run: 4909 subRun: 0 event: 16320
[91m
There are a total of 132684 Particles in the event

# of particles 9	from gen 1 marley
# of particles 31026	from gen 2 Ar39GenInLAr
# of particles 3591	from gen 3 Kr85GenInLAr
# of particles 2	from gen 4 Ar42GenInLAr
# of particles 4	from gen 5 K42From42ArGenInLAr
# of particles 32	from gen 6 Rn222ChainRn222GenInLAr
# of particles 22	from gen 7 Rn222ChainPo218GenInLAr
# of particles 54	from gen 8 Rn222ChainPb214GenInLAr
# of particles 41	from gen 9 Rn222ChainBi214GenInLAr
# of particles 19	from gen 10 Rn222ChainPb210GenInLAr
# of particles 19	from gen 11 Rn220ChainPb212GenInLAr
# of particles 238	from gen 12 K40GenInCathode
# of particles 2958	from gen 13 U238ChainGenInCathode
# of particles 3615	from gen 14 Th232ChainGenInCathode
# of particles 101	from gen 15 K40GenInAnode
# of particles 1324	from gen 16 U238ChainGenInAnode
# of particles 1546	from gen 17 Th232ChainGenInAnode
# of particles 1	from gen 18 Rn222ChainGenInPDS
# of particles 3	from gen 19 K42From42ArGenInUpperMesh1x8x14
# of particles 2	from gen 20 Rn222ChainFromPo218GenInUpperMesh1x8x14
# of particles 16	from gen 21 Rn222ChainFromPb214GenInUpperMesh1x8x14
# of particles 56	from gen 22 Rn222ChainFromBi214GenInUpperMesh1x8x14
# of particles 30	from gen 23 Rn222ChainFromPb210GenInUpperMesh1x8x14
# of particles 40	from gen 24 Rn222ChainFromBi210GenInUpperMesh1x8x14
# of particles 55	from gen 25 Rn220ChainFromPb212GenInUpperMesh1x8x14
# of particles 84313	from gen 26 CavernwallGammasAtLAr1x8x14
# of particles 3534	from gen 27 foamGammasAtLAr1x8x14
# of particles 32	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  20-Jan-2026 19:11:17 UTC run: 4909 subRun: 0 event: 16320
[33m
Number of Signal Particles: 9
Neutrino Interaction: -1
Neutrino Energy: 16.06 MeV
Position (-279.35, -685.89, 1367.58) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		0.55	(-279.35, -685.89, 1367.58)	132720	132644
marley	-12		0.76	(-279.35, -685.89, 1367.58)	132719	132644
marley	22		0.03	(-279.35, -685.89, 1367.58)	132649	0
marley	22		0.77	(-279.35, -685.89, 1367.58)	132648	0
marley	22		1.30	(-279.35, -685.89, 1367.58)	132647	0
marley	22		0.19	(-279.35, -685.89, 1367.58)	132646	0
marley	22		2.09	(-279.35, -685.89, 1367.58)	132645	0
marley	1000190400	0.00	(-279.35, -685.89, 1367.58)	132644	0
marley	11		10.17	(-279.35, -685.89, 1367.58)	132643	0
Signal Track IDs: 132643; 132644; 132645; 132646; 132647; 132648; 132649; 132719; 132720; [0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 19:11:17 UTC run: 4909 subRun: 0 event: 16320
[33m
Kinetic energy of signal particle is below threshold of 30.00 MeV. Selecting event.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 19:15:23 UTC run: 4909 subRun: 0 event: 16320
[34mOpFlash PE 18.23 with purity 0.50 time -0.39 plane 1
 - Vertex (135.07, 743.30, 1641.62)
	*** 1st Sanity check: Ratio 0.53 <= 1.00
	*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 591.55 with purity 0.88 time -0.00 plane 0
 - Vertex (-327.50, -632.80, 1377.78)
	*** 1st Sanity check: Ratio 0.44 <= 1.00
	*** 2nd Sanity check: #OpHits 9 >= 9
OpFlash PE 32.27 with purity 0.21 time 1.14 plane 2
 - Vertex (176.19, -743.30, 712.93)
	*** 1st Sanity check: Ratio 0.25 <= 1.00
	*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 18.70 with purity 0.37 time 1.54 plane 2
 - Vertex (132.91, -743.30, 1751.00)
	*** 1st Sanity check: Ratio 0.37 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 18.40 with purity 0.38 time 1.99 plane 0
 - Vertex (-327.50, -343.45, 2026.97)
	*** 1st Sanity check: Ratio 0.38 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 5.11 with purity 0.50 time 2.60 plane 0
 - Vertex (-327.50, -632.80, 186.42)
	*** 1st Sanity check: Ratio 1.00 <= 1.00
	*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 7.36 with purity 1.00 time 2.92 plane 0
 - Vertex (-327.50, -377.40, 1302.78)
	*** 1st Sanity check: Ratio 1.00 <= 1.00
	*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 5.25 with purity 0.75 time 5.59 plane 0
 - Vertex (-327.50, -632.80, 1377.78)
	*** 1st Sanity check: Ratio 1.00 <= 1.00
	*** 2nd Sanity check: #OpHits 1 >= 1

# of OpHits (ophit10ppm): 52824 for times between -4254.22 us and 295147919198126080.00 us.
# of OpFlashes (solarflash): 18395 for times between -4253.93 us and 295147919198126080.00 us.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 19:15:27 UTC run: 4909 subRun: 0 event: 16320
[36m
# OpHits (ophit10ppm) in full geometry: 52824
# OpFlashes (solarflash) in full geometry: 18395
# Hits (gaushit) in each view: 6737, 6769, 6595, 0
# Cluster from the hits: 2790, 2856, 5550, 0
# Tracks (pmtracktc) in full geometry: 466[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 20:38:56 UTC run: 4909 subRun: 0 event: 16320
[32m
# ClusterReco: Looping over 5542 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 20:38:56 UTC run: 4909 subRun: 0 event: 16320
[32m*** Matched preselection cluster: 5171 from 5542
 - MainTrackID 132647
 - Gen 1 -> marley TPC 72
 - Purity 1.00 Hits 2
 - Charge 77.61 ( MaxHit 52.60 )
 - #AdjCl 1 ( 0 signal ):
    - Cluster 4794 at distance 96.70 with time 3674.64 and charge 74.62 in TPC 76 and hits 2
 - RecoCol  Time,Y,Z ( 3970.20, -659.08, 1364.07 )
 - RecoInd0 Time,Y,Z ( 3969.84, -658.82, 1366.16 )
 - RecoInd1 Time,Y,Z ( 3970.13, -659.34, 1419.24 )
*** Matched flash: 9190 from 18395
 - Purity 88.50 % Plane 0 #Hits 9
 - MainOpHitPE 263.18 (PE);  TotalPE 591.55 vs expected 256.86 (PE)
 - Time -0.00 (us) Fast 86.32 % Residual 13514.77
 - Reco Time,Y,Z ( -0.00, -632.80, 1377.78 )
 - Found valid waveform: true
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -279.35, -685.89, 1367.58 )
 - Main X,Y,Z ( -315.85, -655.93, 1357.13 )
 - EDep X,Y,Z ( -312.47, -659.03, 1364.09 )
 - Reco X,Y,Z ( -312.43, -659.08, 1364.07 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 20:38:56 UTC run: 4909 subRun: 0 event: 16320
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
20-Jan-2026 20:38:56 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/54/59/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250126T022343Z_gen_001632_supernova_g4stage1_g4stage2_detsim_reco_20250611T092505Z_reco2.root"
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@EndJob 20-Jan-2026 20:38:56 UTC  ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          2.54129       2032.35       5387.74       68.0746       2465.87        10     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.00110848      13.1432       67.1835     0.00989179      26.2794        10     
end_path:solarnuana:SolarNuAna      2.03376       2019.2        5387.72       3.88544       2476.45        10     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 20-Jan-2026 20:38:56 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)  : 3197.06 MB
  Peak resident set size usage (VmHWM): 2573.43 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 = 20125.869793 Real = 20458.284077

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 3197.06 VmHWM = 2573.43

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