Jobsub ID 241862.4@dunegpschedd02.fnal.gov

Jobsub ID	241862.4@dunegpschedd02.fnal.gov
Workflow ID	9964
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	2025-11-12 03:26:54
Site	US_FNAL-FermiGrid
Entry	FNAL_GPGrid_ce04_mcore_op_duneonly
Last heartbeat	2025-11-13 07:32:13
From worker node	Hostname	dunegli-7728680-0-fnpc23038.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	2025-11-13 03:25:25
Input files	fardet-vd:prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250124T175937Z_gen_000607_supernova_g4stage1_g4stage2_detsim_reco_20250701T235005Z_reco2.root
Jobscript	Exit code	0
	Real time	4h (14796s)
	CPU time	4h (14682s = 99%)
	Max RSS bytes	1913458688 (1824 MiB)
Outputting started	2025-11-13 07:32:01
Output files
Finished	2025-11-13 07:32:13
List job events (HTCondor job logs unavailable)
Jobscript log (last 10,000 characters)

True X,Y,Z ( 179.56, -688.96, 1702.42 )
 - Main X,Y,Z ( 76.84, -641.06, 1738.69 )
 - EDep X,Y,Z ( 65.94, -654.77, 1735.46 )
 - Reco X,Y,Z ( -1000000.00, 862.71, 1735.52 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  13-Nov-2025 06:52:29 UTC run: 4874 subRun: 0 event: 6069
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
Begin processing the 10th record. run: 4874 subRun: 0 event: 6070 at 13-Nov-2025 06:52:29 UTC
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  13-Nov-2025 06:52:32 UTC run: 4874 subRun: 0 event: 6070
[35m
###################################################
Event:			6070
Flag:			1014160714
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  13-Nov-2025 06:52:32 UTC run: 4874 subRun: 0 event: 6070
[91m
There are a total of 132407 Particles in the event

# of particles 9	from gen 1 marley
# of particles 30805	from gen 2 Ar39GenInLAr
# of particles 3493	from gen 3 Kr85GenInLAr
# of particles 1	from gen 4 Ar42GenInLAr
# of particles 1	from gen 5 K42From42ArGenInLAr
# of particles 34	from gen 6 Rn222ChainRn222GenInLAr
# of particles 22	from gen 7 Rn222ChainPo218GenInLAr
# of particles 47	from gen 8 Rn222ChainPb214GenInLAr
# of particles 39	from gen 9 Rn222ChainBi214GenInLAr
# of particles 21	from gen 10 Rn222ChainPb210GenInLAr
# of particles 30	from gen 11 Rn220ChainPb212GenInLAr
# of particles 233	from gen 12 K40GenInCathode
# of particles 3097	from gen 13 U238ChainGenInCathode
# of particles 3479	from gen 14 Th232ChainGenInCathode
# of particles 88	from gen 15 K40GenInAnode
# of particles 1347	from gen 16 U238ChainGenInAnode
# of particles 1614	from gen 17 Th232ChainGenInAnode
# of particles 0	from gen 18 Rn222ChainGenInPDS
# of particles 0	from gen 19 K42From42ArGenInUpperMesh1x8x14
# of particles 3	from gen 20 Rn222ChainFromPo218GenInUpperMesh1x8x14
# of particles 14	from gen 21 Rn222ChainFromPb214GenInUpperMesh1x8x14
# of particles 40	from gen 22 Rn222ChainFromBi214GenInUpperMesh1x8x14
# of particles 49	from gen 23 Rn222ChainFromPb210GenInUpperMesh1x8x14
# of particles 42	from gen 24 Rn222ChainFromBi210GenInUpperMesh1x8x14
# of particles 35	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  13-Nov-2025 06:52:32 UTC run: 4874 subRun: 0 event: 6070
[33m
Number of Signal Particles: 8
Neutrino Interaction: -1
Neutrino Energy: 14.86 MeV
Position (84.28, 598.27, 985.08) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		1.17	(84.28, 598.27, 985.08)	132455	132381
marley	-12		0.14	(84.28, 598.27, 985.08)	132454	132381
marley	1000200400	0.00	(84.28, 598.27, 985.08)	132453	132381
marley	22		0.03	(84.28, 598.27, 985.08)	132385	0
marley	22		0.77	(84.28, 598.27, 985.08)	132384	0
marley	22		0.84	(84.28, 598.27, 985.08)	132383	0
marley	22		1.09	(84.28, 598.27, 985.08)	132382	0
marley	1000190400	0.00	(84.28, 598.27, 985.08)	132381	0
marley	11		10.63	(84.28, 598.27, 985.08)	132380	0
Signal Track IDs: 132380; 132381; 132382; 132383; 132384; 132385; 132453; 132454; 132455; [0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  13-Nov-2025 06:52:32 UTC run: 4874 subRun: 0 event: 6070
[33m
Kinetic energy of signal particle is below threshold of 30.00 MeV. Selecting event.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  13-Nov-2025 06:52:58 UTC run: 4874 subRun: 0 event: 6070
[34mOpFlash PE 105.64 with purity 0.04 time 0.00 plane 2
 - Vertex (60.07, -743.30, 748.10)
	*** 1st Sanity check: Ratio 0.28 <= 1.00
	*** 2nd Sanity check: #OpHits 9 >= 9
OpFlash PE 13.10 with purity 0.30 time 0.00 plane 0
 - Vertex (-327.50, 448.45, 218.77)
	*** 1st Sanity check: Ratio 0.54 <= 1.00
	*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 520.54 with purity 0.45 time 0.01 plane 1
 - Vertex (108.79, 743.30, 980.95)
	*** 1st Sanity check: Ratio 0.15 <= 1.00
	*** 2nd Sanity check: #OpHits 20 >= 20
OpFlash PE 87.42 with purity 0.11 time 0.02 plane 0
 - Vertex (-327.50, 398.92, 1067.86)
	*** 1st Sanity check: Ratio 0.17 <= 1.00
	*** 2nd Sanity check: #OpHits 10 >= 10
OpFlash PE 468.77 with purity 0.23 time 0.08 plane 1
 - Vertex (60.07, 743.30, 1401.95)
	*** 1st Sanity check: Ratio 0.30 <= 1.00
	*** 2nd Sanity check: #OpHits 13 >= 13
OpFlash PE 55.04 with purity 0.11 time 0.18 plane 1
 - Vertex (122.54, 743.30, 926.51)
	*** 1st Sanity check: Ratio 0.21 <= 1.00
	*** 2nd Sanity check: #OpHits 7 >= 7

# of OpFlashes (solarflash) in full geometry: 10653
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  13-Nov-2025 06:53:00 UTC run: 4874 subRun: 0 event: 6070
[36m
# OpHits (ophit10ppm) in full geometry: 52014
# OpFlashes (solarflash) in full geometry: 10653
# Hits (gaushit) in each view: 6493, 6500, 6542, 0
# Cluster from the hits: 2714, 2758, 5522, 0
# Tracks (pmtracktc) in full geometry: 456[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  13-Nov-2025 07:32:00 UTC run: 4874 subRun: 0 event: 6070
[32m
# ClusterReco: Looping over 5509 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  13-Nov-2025 07:32:00 UTC run: 4874 subRun: 0 event: 6070
[32m*** Matched preselection cluster: 1815
 - MainTrackID 132380
 - Gen 1 -> marley TPC 55
 - Purity 1.00 Hits 8
 - Charge 1334.45 ( MaxHit 333.08 )
 - #AdjCl 7 ( 0 signal ):
    - Cluster 1173 at distance 89.07 with time 982.82 and charge 25.65 in TPC 55 and hits 1
    - Cluster 1630 at distance 71.87 with time 1341.14 and charge 40.54 in TPC 53 and hits 1
    - Cluster 1656 at distance 63.42 with time 1364.33 and charge 49.42 in TPC 55 and hits 1
    - Cluster 1657 at distance 84.83 with time 1366.41 and charge 30.08 in TPC 49 and hits 1
    - Cluster 1734 at distance 30.52 with time 1438.81 and charge 137.97 in TPC 55 and hits 1
    - Cluster 2117 at distance 93.84 with time 1728.52 and charge 134.73 in TPC 63 and hits 2
    - Cluster 2199 at distance 72.65 with time 1793.18 and charge 57.53 in TPC 55 and hits 1
 - RecoCol  Time,Y,Z ( 1500.84, 596.52, 985.87 )
 - RecoInd0 Time,Y,Z ( 1500.78, 596.52, 971.48 )
 - RecoInd1 Time,Y,Z ( 1500.60, 596.52, 971.48 )
*** Matched flash: 
 - Purity 0.00 Plane 0 #Hits 7 PE 56.81 MaxPE 12.20
 - Time 46.53 Fast 0.65 Residual 37.26
 - Reco Time,Y,Z ( 46.53, 567.21, 1021.49 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( 84.28, 598.27, 985.08 )
 - Main X,Y,Z ( 83.21, 595.00, 986.99 )
 - EDep X,Y,Z ( 84.36, 597.03, 985.50 )
 - Reco X,Y,Z ( 91.53, 596.52, 985.87 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  13-Nov-2025 07:32:00 UTC run: 4874 subRun: 0 event: 6070
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
13-Nov-2025 07:32:00 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/5f/a6/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250124T175937Z_gen_000607_supernova_g4stage1_g4stage2_detsim_reco_20250701T235005Z_reco2.root"
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@EndJob 13-Nov-2025 07:32:00 UTC  ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                         0.698533       1475.11       3571.49       1185.55       1504.54        10     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.000805583    0.0087125     0.0275813    0.00574353    0.00889984       10     
end_path:solarnuana:SolarNuAna     0.697465       1475.1        3571.47       1185.55       1504.55        10     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 13-Nov-2025 07:32:00 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)  : 2533.4 MB
  Peak resident set size usage (VmHWM): 1913.46 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 = 14670.548471 Real = 14781.954257

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 2533.4 VmHWM = 1913.46

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