Jobsub ID 267580.6@dunegpschedd02.fnal.gov

Jobsub ID	267580.6@dunegpschedd02.fnal.gov
Workflow ID	11647
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-09 23:38:57
Site	US_FNAL-FermiGrid
Entry	FNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat	2026-01-09 23:49:59
From worker node	Hostname	dunegli-8132011-0-fnpc23029.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	finished
Started	2026-01-09 23:39:59
Input files	fardet-hd:prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250207T113316Z_gen_003480_supernova_g4_detsim_reco_20250724T112419Z_reco2.root
Jobscript	Exit code	0
	Real time	9m (586s)
	CPU time	9m (579s = 98%)
	Max RSS bytes	904335360 (862 MiB)
Outputting started	2026-01-09 23:49:45
Output files	https://fndcadoor.fnal.gov:2880/dune/scratch/users/smanthey/ana/solar_ana_marley_flash_radiological_decay0_dune10kt_1x2x6_centralAPA/fnal/11647/1/001/fdhd_ana_2026-01-09T_234006Z_hist.root
Finished	2026-01-09 23:49:54
Saved logs	justin-logs:267580.6-dunegpschedd02.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

0
 - Vertex (0.05, 62.27, 1096.90)
	*** 1st Sanity check: Ratio 0.30 <= 1.00
	*** 2nd Sanity check: #OpHits 11 >= 11
OpFlash PE 36.84 with purity 1.00 time -15.48 plane 0
 - Vertex (-0.00, -37.29, 1141.60)
	*** 1st Sanity check: Ratio 0.26 <= 1.00
	*** 2nd Sanity check: #OpHits 10 >= 10
OpFlash PE 23.93 with purity 0.84 time -15.10 plane 0
 - Vertex (0.03, 58.79, 1070.72)
	*** 1st Sanity check: Ratio 0.19 <= 1.00
	*** 2nd Sanity check: #OpHits 9 >= 9
OpFlash PE 18.72 with purity 1.00 time -14.73 plane 0
 - Vertex (0.05, 93.41, 1125.08)
	*** 1st Sanity check: Ratio 0.46 <= 1.00
	*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 11.82 with purity 0.85 time -14.19 plane 0
 - Vertex (0.01, 34.56, 1140.66)
	*** 1st Sanity check: Ratio 0.27 <= 1.00
	*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 16.62 with purity 0.84 time -13.65 plane 0
 - Vertex (0.05, 31.14, 910.25)
	*** 1st Sanity check: Ratio 0.53 <= 1.00
	*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 8.08 with purity 0.55 time -13.38 plane 0
 - Vertex (0.05, 163.43, 1006.59)
	*** 1st Sanity check: Ratio 0.36 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 24.25 with purity 0.58 time -12.68 plane 0
 - Vertex (0.05, 217.95, 1125.08)
	*** 1st Sanity check: Ratio 0.70 <= 1.00
	*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 12.17 with purity 0.65 time -12.31 plane 0
 - Vertex (0.05, 186.72, 1215.58)
	*** 1st Sanity check: Ratio 0.65 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 7.43 with purity 0.61 time -11.17 plane 0
 - Vertex (0.05, 280.22, 964.68)
	*** 1st Sanity check: Ratio 0.78 <= 1.00
	*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 11.81 with purity 0.71 time -10.71 plane 0
 - Vertex (0.05, 217.95, 964.68)
	*** 1st Sanity check: Ratio 0.86 <= 1.00
	*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 6.65 with purity 1.00 time -9.66 plane 0
 - Vertex (0.05, 31.14, 1245.87)
	*** 1st Sanity check: Ratio 1.00 <= 1.00
	*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 29.12 with purity 0.69 time -8.26 plane 0
 - Vertex (-0.05, -31.14, 1013.48)
	*** 1st Sanity check: Ratio 0.93 <= 1.00
	*** 2nd Sanity check: #OpHits 2 >= 2

# of OpHits (ophitspe): 72656 for times between -2261.18 us and 2227.12 us.
# of OpFlashes (solarflash): 9725 for times between -2261.12 us and 2227.11 us.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  09-Jan-2026 23:49:27 UTC run: 5089 subRun: 0 event: 173999
[36m
# OpHits (ophitspe) in full geometry: 72656
# OpFlashes (solarflash) in full geometry: 9725
# Hits (hitfd) in each view: 208, 200, 475, 0
# Cluster from the hits: 132, 117, 432, 0
# Tracks (pmtracktc) in full geometry: 1[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  09-Jan-2026 23:49:44 UTC run: 5089 subRun: 0 event: 173999
[32m
# ClusterReco: Looping over 285 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  09-Jan-2026 23:49:44 UTC run: 5089 subRun: 0 event: 173999
[32m*** Matched preselection cluster: 53 from 285
 - MainTrackID 33052
 - Gen 1 -> marley TPC 18
 - Purity 1.00 Hits 14
 - Charge 3366.63 ( MaxHit 573.10 )
 - #AdjCl 0 ( 0 signal ):
 - RecoCol  Time,Y,Z ( 543.66, 38.37, 1094.80 )
 - RecoInd0 Time,Y,Z ( 542.70, 38.06, 1025.50 )
 - RecoInd1 Time,Y,Z ( 542.70, 38.69, 1113.90 )
*** Matched flash: 1330 from 9725
 - Purity 0.00 % Plane 0 #Hits 3
 - MainOpHitPE 22.47 (PE);  TotalPE 26.66 vs expected 77.66 (PE)
 - Time -1642.08 (us) Fast 88.03 % Residual 45.08
 - Reco Time,Y,Z ( -1642.08, 31.14, 1013.48 )
 - Found valid waveform: false
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -92.22, 38.00, 1097.53 )
 - Main X,Y,Z ( -90.59, 39.59, 1092.19 )
 - EDep X,Y,Z ( -89.76, 38.14, 1094.84 )
 - Reco X,Y,Z ( -350.95, 38.37, 1094.80 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  09-Jan-2026 23:49:44 UTC run: 5089 subRun: 0 event: 173999
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
Begin processing the 50th record. run: 5089 subRun: 0 event: 174000 at 09-Jan-2026 23:49:44 UTC
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  09-Jan-2026 23:49:44 UTC run: 5089 subRun: 0 event: 174000
[35m
###################################################
Event:			174000
Flag:			1267779786
Geometry:		dune10kt_v6_1x2x6 (HD)
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:		24 TPCs
TPC DriftLength in [cm]:360.37
TPC DriftTime in [us]:	2244.44
Fiducial Volume in [cm]:759.89, 1357.70, 1746.48
###################################################[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  09-Jan-2026 23:49:45 UTC run: 5089 subRun: 0 event: 174000
[91m
There are a total of 32870 Particles in the event

# of particles 8	from gen 1 marley
# of particles 10871	from gen 2 Ar39GenInLAr
# of particles 1230	from gen 3 Kr85GenInLAr
# of particles 0	from gen 4 Ar42GenInLAr
# of particles 0	from gen 5 K42From42ArGenInLAr
# of particles 5	from gen 6 Rn222ChainRn222GenInLAr
# of particles 7	from gen 7 Rn222ChainPo218GenInLAr
# of particles 22	from gen 8 Rn222ChainPb214GenInLAr
# of particles 10	from gen 9 Rn222ChainBi214GenInLAr
# of particles 10	from gen 10 Rn222ChainPb210GenInLAr
# of particles 12	from gen 11 Rn220ChainPb212GenInLAr
# of particles 15	from gen 12 K40GenInCPA
# of particles 231	from gen 13 U238ChainGenInCPA
# of particles 325	from gen 14 Th232ChainGenInCPA
# of particles 0	from gen 15 K42From42ArGenInCPA
# of particles 1	from gen 16 Rn222ChainPo218GenInCPA
# of particles 16	from gen 17 Rn222ChainPb214GenInCPA
# of particles 34	from gen 18 Rn222ChainBi214GenInCPA
# of particles 45	from gen 19 Rn222ChainPb210GenInCPA
# of particles 22	from gen 20 Rn222ChainFromBi210GenInCPA
# of particles 39	from gen 21 Rn220ChainFromPb212GenInCPA
# of particles 0	from gen 22 Co60GenInAPA
# of particles 2	from gen 23 U238ChainGenInAPA
# of particles 0	from gen 24 Th232ChainGenInAPA
# of particles 42	from gen 25 U238Th232K40GenInLArAPAboards1x2x6
# of particles 0	from gen 26 Rn222ChainGenInPDS
# of particles 19159	from gen 27 CavernwallGammasAtLAr1x2x6lowBgAPA
# of particles 764	from gen 28 foamGammasAtLAr1x2x6lowBgAPA
# of particles 0	from gen 29 CavernwallNeutronsAtLAr1x2x6lowBgAPA
# of particles 0	from gen 30 CryostatNGammasAtLAr1x2x6lowBgAPA
# of particles 0	from gen 31 CavernNGammasAtLAr1x2x6lowBgAPA[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  09-Jan-2026 23:49:45 UTC run: 5089 subRun: 0 event: 174000
[33m
Number of Signal Particles: 8
Neutrino Interaction: -1
Neutrino Energy: 44.98 MeV
Position (-329.20, -400.41, 429.43) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		0.43	(-329.20, -400.41, 429.43)	32925	32864
marley	-12		0.13	(-329.20, -400.41, 429.43)	32924	32864
marley	22		1.27	(-329.20, -400.41, 429.43)	32868	0
marley	22		0.25	(-329.20, -400.41, 429.43)	32867	0
marley	22		3.30	(-329.20, -400.41, 429.43)	32866	0
marley	2212		2.13	(-329.20, -400.41, 429.43)	32865	0
marley	1000180390	0.01	(-329.20, -400.41, 429.43)	32864	0
marley	11		28.93	(-329.20, -400.41, 429.43)	32863	0
Signal Track IDs: 32863; 32864; 32865; 32866; 32867; 32868; 32924; 32925; [0m
%MSG
%MSG-w ProducerUtils:  SolarNuAna:solarnuana@BeginModule  09-Jan-2026 23:49:45 UTC run: 5089 subRun: 0 event: 174000
[31m
Kinetic energy of signal particle is above threshold of 30.00 MeV. Skipping event.
[0m
%MSG
09-Jan-2026 23:49:45 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/96/28/prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250207T113316Z_gen_003480_supernova_g4_detsim_reco_20250724T112419Z_reco2.root"
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@EndJob 09-Jan-2026 23:49:45 UTC  ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                         0.237288       10.5923       24.4943      0.694528       10.7549        50     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.00138754    0.00179447    0.00223429    0.00179922    0.000201019      50     
end_path:solarnuana:SolarNuAna     0.235239       10.5903       24.4923      0.692477       10.7549        50     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 09-Jan-2026 23:49:45 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)  : 1552.81 MB
  Peak resident set size usage (VmHWM): 906.67 MB
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 50 passed = 50 failed = 0

TrigReport ---------- Modules in End-path ----------
TrigReport        Run    Success      Error Name
TrigReport         50         50          0 solarnuana

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 555.972107 Real = 562.306131

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 1552.81 VmHWM = 906.67

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