Jobsub ID 288544.45@dunegpschedd02.fnal.gov

Jobsub ID	288544.45@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 19:14:56
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:41
Input files	fardet-vd:prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250128T012956Z_gen_000196_supernova_g4stage1_g4stage2_detsim_reco_20250628T012726Z_reco2.root
Jobscript	Exit code	0
	Real time	4h (15416s)
	CPU time	4h (15313s = 99%)
	Max RSS bytes	2569318400 (2450 MiB)
Outputting started	2026-01-20 19:14:37
Output files
Finished	2026-01-20 19:14:56
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

h record. run: 4961 subRun: 0 event: 1960 at 20-Jan-2026 17:56:42 UTC
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 17:56:47 UTC run: 4961 subRun: 0 event: 1960
[35m
###################################################
Event:			1960
Flag:			2135980370
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 17:56:49 UTC run: 4961 subRun: 0 event: 1960
[91m
There are a total of 133187 Particles in the event

# of particles 10	from gen 1 marley
# of particles 31452	from gen 2 Ar39GenInLAr
# of particles 3483	from gen 3 Kr85GenInLAr
# of particles 4	from gen 4 Ar42GenInLAr
# of particles 0	from gen 5 K42From42ArGenInLAr
# of particles 23	from gen 6 Rn222ChainRn222GenInLAr
# of particles 28	from gen 7 Rn222ChainPo218GenInLAr
# of particles 57	from gen 8 Rn222ChainPb214GenInLAr
# of particles 39	from gen 9 Rn222ChainBi214GenInLAr
# of particles 25	from gen 10 Rn222ChainPb210GenInLAr
# of particles 24	from gen 11 Rn220ChainPb212GenInLAr
# of particles 230	from gen 12 K40GenInCathode
# of particles 3077	from gen 13 U238ChainGenInCathode
# of particles 3627	from gen 14 Th232ChainGenInCathode
# of particles 95	from gen 15 K40GenInAnode
# of particles 1332	from gen 16 U238ChainGenInAnode
# of particles 1589	from gen 17 Th232ChainGenInAnode
# of particles 0	from gen 18 Rn222ChainGenInPDS
# of particles 7	from gen 19 K42From42ArGenInUpperMesh1x8x14
# of particles 3	from gen 20 Rn222ChainFromPo218GenInUpperMesh1x8x14
# of particles 24	from gen 21 Rn222ChainFromPb214GenInUpperMesh1x8x14
# of particles 64	from gen 22 Rn222ChainFromBi214GenInUpperMesh1x8x14
# of particles 48	from gen 23 Rn222ChainFromPb210GenInUpperMesh1x8x14
# of particles 37	from gen 24 Rn222ChainFromBi210GenInUpperMesh1x8x14
# of particles 51	from gen 25 Rn220ChainFromPb212GenInUpperMesh1x8x14
# of particles 84313	from gen 26 CavernwallGammasAtLAr1x8x14
# of particles 3534	from gen 27 foamGammasAtLAr1x8x14
# of particles 10	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 17:56:50 UTC run: 4961 subRun: 0 event: 1960
[33m
Number of Signal Particles: 9
Neutrino Interaction: -1
Neutrino Energy: 23.47 MeV
Position (-45.09, -276.30, 1559.35) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		0.47	(-45.09, -276.30, 1559.35)	133235	133170
marley	-12		0.84	(-45.09, -276.30, 1559.35)	133234	133170
marley	1000200400	0.00	(-45.09, -276.30, 1559.35)	133233	133170
marley	22		0.03	(-45.09, -276.30, 1559.35)	133175	0
marley	22		0.77	(-45.09, -276.30, 1559.35)	133174	0
marley	22		0.84	(-45.09, -276.30, 1559.35)	133173	0
marley	22		0.65	(-45.09, -276.30, 1559.35)	133172	0
marley	22		2.09	(-45.09, -276.30, 1559.35)	133171	0
marley	1000190400	0.01	(-45.09, -276.30, 1559.35)	133170	0
marley	11		17.58	(-45.09, -276.30, 1559.35)	133169	0
Signal Track IDs: 133169; 133170; 133171; 133172; 133173; 133174; 133175; 133233; 133234; 133235; [0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 17:56:50 UTC run: 4961 subRun: 0 event: 1960
[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 18:00:42 UTC run: 4961 subRun: 0 event: 1960
[34mOpFlash PE 554.99 with purity 0.11 time -5.46 plane 3
 - Vertex (135.07, -220.00, 2188.38)
	*** 1st Sanity check: Ratio 0.19 <= 1.00
	*** 2nd Sanity check: #OpHits 11 >= 11
OpFlash PE 35.44 with purity 0.04 time -1.30 plane 2
 - Vertex (215.25, -743.30, 207.82)
	*** 1st Sanity check: Ratio 0.26 <= 1.00
	*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 49.25 with purity 0.19 time -0.83 plane 3
 - Vertex (191.04, -220.00, 2188.38)
	*** 1st Sanity check: Ratio 0.32 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 796.17 with purity 0.33 time 0.30 plane 0
 - Vertex (-327.50, -256.13, 1552.33)
	*** 1st Sanity check: Ratio 0.06 <= 1.00
	*** 2nd Sanity check: #OpHits 41 >= 41
OpFlash PE 184.29 with purity 0.19 time 0.50 plane 2
 - Vertex (174.24, -743.30, 1343.78)
	*** 1st Sanity check: Ratio 0.26 <= 1.00
	*** 2nd Sanity check: #OpHits 14 >= 14
OpFlash PE 105.93 with purity 0.26 time 1.61 plane 3
 - Vertex (103.50, -90.10, 2188.38)
	*** 1st Sanity check: Ratio 0.33 <= 1.00
	*** 2nd Sanity check: #OpHits 7 >= 7
OpFlash PE 39.89 with purity 0.10 time 1.39 plane 0
 - Vertex (-327.50, -565.28, 827.30)
	*** 1st Sanity check: Ratio 0.21 <= 1.00
	*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 71.95 with purity 0.15 time 2.45 plane 0
 - Vertex (-327.50, -389.04, 1603.23)
	*** 1st Sanity check: Ratio 0.24 <= 1.00
	*** 2nd Sanity check: #OpHits 7 >= 7
OpFlash PE 30.87 with purity 0.16 time 2.89 plane 2
 - Vertex (138.21, -743.30, 1478.31)
	*** 1st Sanity check: Ratio 0.28 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4

# of OpHits (ophit10ppm): 52704 for times between -4251.74 us and 295147919198126080.00 us.
# of OpFlashes (solarflash): 18232 for times between -4251.74 us and 295147919198126080.00 us.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 18:00:47 UTC run: 4961 subRun: 0 event: 1960
[36m
# OpHits (ophit10ppm) in full geometry: 52704
# OpFlashes (solarflash) in full geometry: 18232
# Hits (gaushit) in each view: 6609, 6549, 6642, 0
# Cluster from the hits: 2771, 2801, 5584, 0
# Tracks (pmtracktc) in full geometry: 437[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 19:14:35 UTC run: 4961 subRun: 0 event: 1960
[32m
# ClusterReco: Looping over 5570 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 19:14:35 UTC run: 4961 subRun: 0 event: 1960
[32m*** Matched preselection cluster: 2969 from 5570
 - MainTrackID 133169
 - Gen 1 -> marley TPC 82
 - Purity 1.00 Hits 15
 - Charge 2135.26 ( MaxHit 411.00 )
 - #AdjCl 5 ( 0 signal ):
    - Cluster 2503 at distance 67.10 with time 1963.78 and charge 247.14 in TPC 82 and hits 2
    - Cluster 2588 at distance 79.18 with time 2015.26 and charge 36.36 in TPC 82 and hits 1
    - Cluster 3144 at distance 80.04 with time 2437.62 and charge 49.47 in TPC 86 and hits 2
    - Cluster 3272 at distance 70.96 with time 2524.06 and charge 70.02 in TPC 82 and hits 1
    - Cluster 3728 at distance 91.62 with time 2862.42 and charge 59.36 in TPC 82 and hits 1
 - RecoCol  Time,Y,Z ( 2303.73, -276.72, 1561.74 )
 - RecoInd0 Time,Y,Z ( 2303.79, -276.77, 1569.16 )
 - RecoInd1 Time,Y,Z ( 2304.04, -276.67, 1569.16 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -45.09, -276.30, 1559.35 )
 - Main X,Y,Z ( -44.07, -275.75, 1563.29 )
 - EDep X,Y,Z ( -45.04, -276.98, 1561.36 )
 - Reco X,Y,Z ( -1000000.00, -276.72, 1561.74 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 19:14:35 UTC run: 4961 subRun: 0 event: 1960
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
20-Jan-2026 19:14:36 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/27/c7/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250128T012956Z_gen_000196_supernova_g4stage1_g4stage2_detsim_reco_20250628T012726Z_reco2.root"
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@EndJob 20-Jan-2026 19:14:36 UTC  ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          1.90289       1532.27       5881.71       3.36844       2355.99        10     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.00154179     0.0100072     0.0234526    0.00638165    0.00855116       10     
end_path:solarnuana:SolarNuAna      1.89827       1532.26       5881.7        3.34907        2356          10     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 20-Jan-2026 19:14:36 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)  : 3195.92 MB
  Peak resident set size usage (VmHWM): 2569.32 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 = 15275.767930 Real = 15377.239687

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 3195.92 VmHWM = 2569.32

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