Jobsub ID 288544.24@dunegpschedd02.fnal.gov

Jobsub ID	288544.24@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 23:17:40
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:56:57
Input files	fardet-vd:prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250202T031346Z_gen_004296_supernova_g4stage1_g4stage2_detsim_reco_20250702T112500Z_reco2.root
Jobscript	Exit code	0
	Real time	8h (30023s)
	CPU time	8h (29496s = 98%)
	Max RSS bytes	2566635520 (2447 MiB)
Outputting started	2026-01-20 23:17:21
Output files
Finished	2026-01-20 23:17:40
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

Looping over 5570 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 21:55:17 UTC run: 5017 subRun: 0 event: 42959
[32m*** Matched preselection cluster: 4721 from 5570
 - MainTrackID 132914
 - Gen 1 -> marley TPC 48
 - Purity 1.00 Hits 10
 - Charge 1052.04 ( MaxHit 224.56 )
 - #AdjCl 5 ( 1 signal ):
    - Cluster 4553 at distance 91.05 with time 3473.49 and charge 79.66 in TPC 40 and hits 2
    - Cluster 4779 at distance 7.38 with time 3659.21 and charge 166.22 in TPC 48 and hits 3
    - Cluster 4844 at distance 47.97 with time 3702.69 and charge 225.41 in TPC 48 and hits 2
    - Cluster 4955 at distance 77.15 with time 3783.23 and charge 115.72 in TPC 54 and hits 2
    - Cluster 5253 at distance 71.05 with time 4019.63 and charge 53.98 in TPC 48 and hits 1
 - RecoCol  Time,Y,Z ( 3615.61, -624.05, 935.52 )
 - RecoInd0 Time,Y,Z ( 3615.15, -624.05, 958.12 )
 - RecoInd1 Time,Y,Z ( 3615.55, -624.05, 971.48 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -256.37, -626.18, 937.89 )
 - Main X,Y,Z ( -256.11, -625.60, 937.44 )
 - EDep X,Y,Z ( -255.27, -623.91, 935.33 )
 - Reco X,Y,Z ( -1000000.00, -624.05, 935.52 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 21:55:17 UTC run: 5017 subRun: 0 event: 42959
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
Begin processing the 10th record. run: 5017 subRun: 0 event: 42960 at 20-Jan-2026 21:55:18 UTC
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 21:56:30 UTC run: 5017 subRun: 0 event: 42960
[35m
###################################################
Event:			42960
Flag:			481071762
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 21:56:32 UTC run: 5017 subRun: 0 event: 42960
[91m
There are a total of 132611 Particles in the event

# of particles 9	from gen 1 marley
# of particles 31088	from gen 2 Ar39GenInLAr
# of particles 3543	from gen 3 Kr85GenInLAr
# of particles 2	from gen 4 Ar42GenInLAr
# of particles 2	from gen 5 K42From42ArGenInLAr
# of particles 24	from gen 6 Rn222ChainRn222GenInLAr
# of particles 30	from gen 7 Rn222ChainPo218GenInLAr
# of particles 50	from gen 8 Rn222ChainPb214GenInLAr
# of particles 56	from gen 9 Rn222ChainBi214GenInLAr
# of particles 16	from gen 10 Rn222ChainPb210GenInLAr
# of particles 5	from gen 11 Rn220ChainPb212GenInLAr
# of particles 226	from gen 12 K40GenInCathode
# of particles 3001	from gen 13 U238ChainGenInCathode
# of particles 3458	from gen 14 Th232ChainGenInCathode
# of particles 106	from gen 15 K40GenInAnode
# of particles 1253	from gen 16 U238ChainGenInAnode
# of particles 1595	from gen 17 Th232ChainGenInAnode
# of particles 1	from gen 18 Rn222ChainGenInPDS
# of particles 3	from gen 19 K42From42ArGenInUpperMesh1x8x14
# of particles 3	from gen 20 Rn222ChainFromPo218GenInUpperMesh1x8x14
# of particles 21	from gen 21 Rn222ChainFromPb214GenInUpperMesh1x8x14
# of particles 59	from gen 22 Rn222ChainFromBi214GenInUpperMesh1x8x14
# of particles 81	from gen 23 Rn222ChainFromPb210GenInUpperMesh1x8x14
# of particles 40	from gen 24 Rn222ChainFromBi210GenInUpperMesh1x8x14
# of particles 67	from gen 25 Rn220ChainFromPb212GenInUpperMesh1x8x14
# of particles 84313	from gen 26 CavernwallGammasAtLAr1x8x14
# of particles 3534	from gen 27 foamGammasAtLAr1x8x14
# of particles 24	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 21:56:32 UTC run: 5017 subRun: 0 event: 42960
[33m
Number of Signal Particles: 8
Neutrino Interaction: -1
Neutrino Energy: 15.34 MeV
Position (-308.04, -74.30, 348.93) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		0.82	(-308.04, -74.30, 348.93)	132634	132580
marley	-12		0.49	(-308.04, -74.30, 348.93)	132633	132580
marley	1000200400	0.00	(-308.04, -74.30, 348.93)	132632	132580
marley	22		0.03	(-308.04, -74.30, 348.93)	132584	0
marley	22		0.77	(-308.04, -74.30, 348.93)	132583	0
marley	22		0.84	(-308.04, -74.30, 348.93)	132582	0
marley	22		0.65	(-308.04, -74.30, 348.93)	132581	0
marley	1000190400	0.01	(-308.04, -74.30, 348.93)	132580	0
marley	11		11.54	(-308.04, -74.30, 348.93)	132579	0
Signal Track IDs: 132579; 132580; 132581; 132582; 132583; 132584; 132632; 132633; 132634; [0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 21:56:32 UTC run: 5017 subRun: 0 event: 42960
[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 22:00:00 UTC run: 5017 subRun: 0 event: 42960
[34mOpFlash PE 795.05 with purity 0.29 time 0.23 plane 0
 - Vertex (-327.50, -42.00, 409.26)
	*** 1st Sanity check: Ratio 0.27 <= 1.00
	*** 2nd Sanity check: #OpHits 26 >= 26

# of OpHits (ophit10ppm): 53078 for times between -4254.55 us and 295147919198126080.00 us.
# of OpFlashes (solarflash): 18247 for times between -4254.55 us and 295147919198126080.00 us.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 22:00:03 UTC run: 5017 subRun: 0 event: 42960
[36m
# OpHits (ophit10ppm) in full geometry: 53078
# OpFlashes (solarflash) in full geometry: 18247
# Hits (gaushit) in each view: 6868, 6854, 6851, 0
# Cluster from the hits: 2841, 2902, 5775, 0
# Tracks (pmtracktc) in full geometry: 486[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 23:17:19 UTC run: 5017 subRun: 0 event: 42960
[32m
# ClusterReco: Looping over 5761 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 23:17:19 UTC run: 5017 subRun: 0 event: 42960
[32m*** Matched preselection cluster: 5350 from 5761
 - MainTrackID 132579
 - Gen 1 -> marley TPC 19
 - Purity 1.00 Hits 5
 - Charge 1067.20 ( MaxHit 371.50 )
 - #AdjCl 5 ( 0 signal ):
    - Cluster 5284 at distance 97.58 with time 3902.14 and charge 70.64 in TPC 19 and hits 1
    - Cluster 5368 at distance 91.97 with time 3957.96 and charge 169.39 in TPC 19 and hits 2
    - Cluster 5470 at distance 15.89 with time 4036.94 and charge 155.75 in TPC 19 and hits 1
    - Cluster 5510 at distance 90.77 with time 4062.95 and charge 124.03 in TPC 19 and hits 1
    - Cluster 5577 at distance 87.50 with time 4119.85 and charge 37.72 in TPC 23 and hits 1
 - RecoCol  Time,Y,Z ( 3944.25, -74.47, 350.00 )
 - RecoInd0 Time,Y,Z ( 3944.26, -74.49, 373.80 )
 - RecoInd1 Time,Y,Z ( 3944.25, -74.45, 373.80 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -308.04, -74.30, 348.93 )
 - Main X,Y,Z ( -308.46, -75.29, 350.88 )
 - EDep X,Y,Z ( -308.28, -74.49, 350.12 )
 - Reco X,Y,Z ( -1000000.00, -74.47, 350.00 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 23:17:19 UTC run: 5017 subRun: 0 event: 42960
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
20-Jan-2026 23:17:20 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/c6/9d/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250202T031346Z_gen_004296_supernova_g4stage1_g4stage2_detsim_reco_20250702T112500Z_reco2.root"
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@EndJob 20-Jan-2026 23:17:20 UTC  ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          1.38313       2987.05       5895.87       4531.8         2426          10     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.000633817     25.9749       73.1822     0.00933814      31.9615        10     
end_path:solarnuana:SolarNuAna      1.36942       2961.08       5833.68       4531.8        2442.45        10     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 20-Jan-2026 23:17:20 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.61 MB
  Peak resident set size usage (VmHWM): 2566.64 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 = 29479.831546 Real = 29994.934853

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 3197.61 VmHWM = 2566.64

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