Jobsub ID 258551.1@dunegpschedd02.fnal.gov

Jobsub ID	258551.1@dunegpschedd02.fnal.gov
Workflow ID	10955
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-12-06 15:56:09
Site	US_FNAL-FermiGrid
Entry	FNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat	2025-12-06 22:51:37
From worker node	Hostname	dunegli-7832544-0-fnpc7304.fnal.gov
	cpuinfo	Intel(R) Xeon(R) CPU E5-2650 v3 @ 2.30GHz
	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	finished
Started	2025-12-06 15:58:14
Input files	fardet-vd:prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T155756Z_gen_003264_supernova_g4stage1_g4stage2_detsim_reco_20250701T154818Z_reco2.root
Jobscript	Exit code	0
	Real time	6h (24792s)
	CPU time	6h (24536s = 98%)
	Max RSS bytes	2559033344 (2440 MiB)
Outputting started	2025-12-06 22:51:26
Output files	https://fndcadoor.fnal.gov:2880/dune/scratch/users/smanthey/ana/solar_ana_marley_flash_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_nominal/fnal/10955/1/001/fdhd_ana_2025-12-06T_155830Z_hist.root
Finished	2025-12-06 22:51:37
Saved logs	justin-logs:258551.1-dunegpschedd02.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

---------------
[0m
%MSG
Begin processing the 10th record. run: 5055 subRun: 0 event: 32640 at 06-Dec-2025 22:03:40 UTC
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  06-Dec-2025 22:03:44 UTC run: 5055 subRun: 0 event: 32640
[35m
###################################################
Event:			32640
Flag:			1203206677
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  06-Dec-2025 22:03:45 UTC run: 5055 subRun: 0 event: 32640
[91m
There are a total of 133059 Particles in the event

# of particles 8	from gen 1 marley
# of particles 31323	from gen 2 Ar39GenInLAr
# of particles 3502	from gen 3 Kr85GenInLAr
# of particles 1	from gen 4 Ar42GenInLAr
# of particles 0	from gen 5 K42From42ArGenInLAr
# of particles 23	from gen 6 Rn222ChainRn222GenInLAr
# of particles 29	from gen 7 Rn222ChainPo218GenInLAr
# of particles 59	from gen 8 Rn222ChainPb214GenInLAr
# of particles 35	from gen 9 Rn222ChainBi214GenInLAr
# of particles 42	from gen 10 Rn222ChainPb210GenInLAr
# of particles 33	from gen 11 Rn220ChainPb212GenInLAr
# of particles 211	from gen 12 K40GenInCathode
# of particles 3147	from gen 13 U238ChainGenInCathode
# of particles 3599	from gen 14 Th232ChainGenInCathode
# of particles 111	from gen 15 K40GenInAnode
# of particles 1419	from gen 16 U238ChainGenInAnode
# of particles 1451	from gen 17 Th232ChainGenInAnode
# of particles 0	from gen 18 Rn222ChainGenInPDS
# of particles 5	from gen 19 K42From42ArGenInUpperMesh1x8x14
# of particles 0	from gen 20 Rn222ChainFromPo218GenInUpperMesh1x8x14
# of particles 20	from gen 21 Rn222ChainFromPb214GenInUpperMesh1x8x14
# of particles 39	from gen 22 Rn222ChainFromBi214GenInUpperMesh1x8x14
# of particles 62	from gen 23 Rn222ChainFromPb210GenInUpperMesh1x8x14
# of particles 36	from gen 24 Rn222ChainFromBi210GenInUpperMesh1x8x14
# of particles 44	from gen 25 Rn220ChainFromPb212GenInUpperMesh1x8x14
# of particles 84313	from gen 26 CavernwallGammasAtLAr1x8x14
# of particles 3534	from gen 27 foamGammasAtLAr1x8x14
# of particles 12	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  06-Dec-2025 22:03:45 UTC run: 5055 subRun: 0 event: 32640
[33m
Number of Signal Particles: 7
Neutrino Interaction: -1
Neutrino Energy: 7.24 MeV
Position (-55.11, 133.38, 1632.28) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		0.47	(-55.11, 133.38, 1632.28)	133081	133039
marley	-12		0.84	(-55.11, 133.38, 1632.28)	133080	133039
marley	1000200400	0.00	(-55.11, 133.38, 1632.28)	133079	133039
marley	22		0.03	(-55.11, 133.38, 1632.28)	133042	0
marley	22		2.07	(-55.11, 133.38, 1632.28)	133041	0
marley	22		2.66	(-55.11, 133.38, 1632.28)	133040	0
marley	1000190400	0.00	(-55.11, 133.38, 1632.28)	133039	0
marley	11		0.97	(-55.11, 133.38, 1632.28)	133038	0
Signal Track IDs: 133038; 133039; 133040; 133041; 133042; 133079; 133080; 133081; [0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  06-Dec-2025 22:03:45 UTC run: 5055 subRun: 0 event: 32640
[33m
Kinetic energy of signal particle is below threshold of 30.00 MeV. Selecting event.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  06-Dec-2025 22:05:09 UTC run: 5055 subRun: 0 event: 32640
[34mOpFlash PE 78.81 with purity 0.27 time -0.24 plane 0
 - Vertex (-327.50, 307.59, 1815.53)
	*** 1st Sanity check: Ratio 0.11 <= 1.00
	*** 2nd Sanity check: #OpHits 12 >= 12
OpFlash PE 32.07 with purity 0.23 time 1.03 plane 1
 - Vertex (229.87, 743.30, 1114.44)
	*** 1st Sanity check: Ratio 0.27 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 120.81 with purity 0.28 time 0.89 plane 0
 - Vertex (-327.50, 183.21, 1758.53)
	*** 1st Sanity check: Ratio 0.14 <= 1.00
	*** 2nd Sanity check: #OpHits 17 >= 17
OpFlash PE 71.76 with purity 0.21 time 2.57 plane 0
 - Vertex (-327.50, -391.17, 1238.15)
	*** 1st Sanity check: Ratio 0.21 <= 1.00
	*** 2nd Sanity check: #OpHits 9 >= 9
OpFlash PE 57.55 with purity 0.17 time 2.47 plane 1
 - Vertex (144.58, 743.30, 1724.18)
	*** 1st Sanity check: Ratio 0.18 <= 1.00
	*** 2nd Sanity check: #OpHits 8 >= 8
OpFlash PE 54.83 with purity 0.35 time 4.18 plane 0
 - Vertex (-327.50, -16.81, 1720.24)
	*** 1st Sanity check: Ratio 0.22 <= 1.00
	*** 2nd Sanity check: #OpHits 8 >= 8

# of OpHits (ophit10ppm): 52682 for times between -4253.85 us and 295147919198126080.00 us.
# of OpFlashes (solarflash): 12267 for times between -4253.22 us and 295147919198126080.00 us.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  06-Dec-2025 22:05:12 UTC run: 5055 subRun: 0 event: 32640
[36m
# OpHits (ophit10ppm) in full geometry: 52682
# OpFlashes (solarflash) in full geometry: 12267
# Hits (gaushit) in each view: 6743, 6717, 6697, 0
# Cluster from the hits: 2808, 2890, 5642, 0
# Tracks (pmtracktc) in full geometry: 479[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  06-Dec-2025 22:51:25 UTC run: 5055 subRun: 0 event: 32640
[32m
# ClusterReco: Looping over 5636 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  06-Dec-2025 22:51:25 UTC run: 5055 subRun: 0 event: 32640
[32m*** Matched preselection cluster: 3135 from 5636
 - MainTrackID 133041
 - Gen 1 -> marley TPC 92
 - Purity 1.00 Hits 2
 - Charge 178.51 ( MaxHit 124.07 )
 - #AdjCl 9 ( 2 signal ):
    - Cluster 2514 at distance 89.55 with time 1968.88 and charge 39.62 in TPC 94 and hits 1
    - Cluster 2584 at distance 69.69 with time 2017.63 and charge 32.26 in TPC 88 and hits 1
    - Cluster 2613 at distance 77.27 with time 2042.52 and charge 45.34 in TPC 90 and hits 1
    - Cluster 2651 at distance 87.11 with time 2063.54 and charge 112.31 in TPC 92 and hits 2
    - Cluster 2762 at distance 98.41 with time 2152.43 and charge 23.65 in TPC 88 and hits 1
    - Cluster 2942 at distance 56.61 with time 2283.65 and charge 158.25 in TPC 92 and hits 1
    - Cluster 3070 at distance 21.40 with time 2368.48 and charge 109.61 in TPC 84 and hits 2
    - Cluster 3083 at distance 41.91 with time 2375.28 and charge 102.35 in TPC 84 and hits 2
    - Cluster 3147 at distance 90.84 with time 2428.33 and charge 24.97 in TPC 88 and hits 1
 - RecoCol  Time,Y,Z ( 2418.57, 130.16, 1651.88 )
 - RecoInd0 Time,Y,Z ( 2418.77, 130.20, 1718.08 )
 - RecoInd1 Time,Y,Z ( 2418.60, 130.13, 1680.78 )
*** Matched flash: 8680 from 12267
 - Purity 0.00 % Plane 0 #Hits 6 PE 733.46 MainOpHitPE 422.83
 - Time 1789.56 (us) Fast 95.89 % Residual 25184.62
 - Reco Time,Y,Z ( 1789.56, 38.00, 1675.62 )
 - Found valid waveform: true
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -55.11, 133.38, 1632.28 )
 - Main X,Y,Z ( -66.60, 136.47, 1657.50 )
 - EDep X,Y,Z ( -63.30, 130.04, 1651.89 )
 - Reco X,Y,Z ( 224.04, 130.16, 1651.88 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  06-Dec-2025 22:51:25 UTC run: 5055 subRun: 0 event: 32640
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
06-Dec-2025 22:51:25 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/de/a5/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T155756Z_gen_003264_supernova_g4stage1_g4stage2_detsim_reco_20250701T154818Z_reco2.root"
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@EndJob 06-Dec-2025 22:51:25 UTC  ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          1.24608       2466.96       5925.85       2614.01       1891.59        10     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.00164275     0.0266819     0.138343     0.00769319     0.0413223       10     
end_path:solarnuana:SolarNuAna      1.2436        2466.93       5925.85       2614.01       1891.6         10     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 06-Dec-2025 22:51:25 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)  : 3176.94 MB
  Peak resident set size usage (VmHWM): 2559.03 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 = 24483.582866 Real = 24730.604706

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 3176.94 VmHWM = 2559.03

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