Jobsub ID 241547.13@dunegpschedd02.fnal.gov

Jobsub ID	241547.13@dunegpschedd02.fnal.gov
Workflow ID	9937
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-11 21:35:27
Site	US_FNAL-FermiGrid
Entry	FNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat	2025-11-11 23:00:29
From worker node	Hostname	dunegli-7570608-0-fnpc22015.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	2025-11-11 22:18:01
Input files	fardet-hd:prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250206T104551Z_gen_001528_supernova_g4_detsim_reco_20250724T113926Z_reco2.root
Jobscript	Exit code	0
	Real time	5m (317s)
	CPU time	5m (304s = 95%)
	Max RSS bytes	916332544 (873 MiB)
Outputting started	2025-11-11 22:23:19
Output files	https://fndcadoor.fnal.gov:2880/dune/scratch/users/smanthey/ana/solar_ana_marley_flash_radiological_decay0_dune10kt_1x2x6_centralAPA/fnal/09937/1/001/fdhd_ana_2025-11-11T_221806Z_hist.root
Finished	2025-11-11 23:00:29
Saved logs	justin-logs:241547.13-dunegpschedd02.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

Vertex (-0.05, -31.14, 1245.87)
	*** 1st Sanity check: Ratio 1.00 <= 1.00
	*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 5.71 with purity 0.61 time 0.00 plane 0
 - Vertex (-0.05, -157.42, 636.24)
	*** 1st Sanity check: Ratio 0.39 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 10.38 with purity 0.09 time 0.00 plane 0
 - Vertex (0.05, 539.20, 926.29)
	*** 1st Sanity check: Ratio 0.47 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 630.50 with purity 0.97 time 0.00 plane 0
 - Vertex (-0.05, -303.55, 1261.25)
	*** 1st Sanity check: Ratio 0.09 <= 1.00
	*** 2nd Sanity check: #OpHits 56 >= 56
OpFlash PE 7.82 with purity 1.00 time 0.01 plane 0
 - Vertex (0.03, 155.04, 755.16)
	*** 1st Sanity check: Ratio 0.26 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 3.98 with purity 0.47 time 0.01 plane 0
 - Vertex (0.05, 412.80, 574.92)
	*** 1st Sanity check: Ratio 0.53 <= 1.00
	*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 119.94 with purity 1.00 time 0.03 plane 0
 - Vertex (-0.05, -446.59, 1299.68)
	*** 1st Sanity check: Ratio 0.12 <= 1.00
	*** 2nd Sanity check: #OpHits 31 >= 31
OpFlash PE 34.15 with purity 0.96 time 0.07 plane 0
 - Vertex (-0.05, -312.27, 1252.05)
	*** 1st Sanity check: Ratio 0.17 <= 1.00
	*** 2nd Sanity check: #OpHits 11 >= 11
OpFlash PE 11.13 with purity 0.92 time 0.09 plane 0
 - Vertex (-0.05, -373.38, 1335.83)
	*** 1st Sanity check: Ratio 0.44 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 5.40 with purity 0.34 time 0.10 plane 0
 - Vertex (-0.05, -218.87, 1051.05)
	*** 1st Sanity check: Ratio 0.34 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 5.92 with purity 0.85 time 0.12 plane 0
 - Vertex (-0.05, -302.90, 1283.63)
	*** 1st Sanity check: Ratio 0.36 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 7.13 with purity 0.32 time 0.15 plane 0
 - Vertex (-0.05, -359.49, 1234.60)
	*** 1st Sanity check: Ratio 0.39 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 129.16 with purity 0.64 time 0.28 plane 0
 - Vertex (-0.05, -342.49, 1197.07)
	*** 1st Sanity check: Ratio 0.96 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3

# of OpFlashes (solarflash) in full geometry: 8748
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  11-Nov-2025 22:23:07 UTC run: 5082 subRun: 0 event: 76399
[36m
# OpHits (ophitspe) in full geometry: 71347
# OpFlashes (solarflash) in full geometry: 8748
# Hits (hitfd) in each view: 224, 216, 504, 0
# Cluster from the hits: 134, 136, 446, 0
# Tracks (pmtracktc) in full geometry: 3[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  11-Nov-2025 22:23:18 UTC run: 5082 subRun: 0 event: 76399
[32m
# ClusterReco: Looping over 293 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  11-Nov-2025 22:23:18 UTC run: 5082 subRun: 0 event: 76399
[32m*** Matched preselection cluster: 68
 - MainTrackID 32911
 - Gen 1 -> marley TPC 20
 - Purity 1.00 Hits 12
 - Charge 2863.60 ( MaxHit 487.87 )
 - #AdjCl 3 ( 3 signal ):
    - Cluster 61 at distance 49.36 with time 668.02 and charge 44.25 in TPC 20 and hits 1
    - Cluster 63 at distance 47.76 with time 669.13 and charge 134.68 in TPC 20 and hits 2
    - Cluster 85 at distance 34.98 with time 913.92 and charge 200.04 in TPC 20 and hits 2
 - RecoCol  Time,Y,Z ( 704.73, -315.73, 1255.51 )
 - RecoInd0 Time,Y,Z ( 704.36, -315.63, 1277.27 )
 - RecoInd1 Time,Y,Z ( 703.89, -315.83, 1277.27 )
*** Matched flash: 
 - Purity 0.97 Plane 0 #Hits 56 PE 630.50 MaxPE 56.42
 - Time -18.10 Fast 0.84 Residual 154.57
 - Reco Time,Y,Z ( -18.10, -303.55, 1261.25 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -113.09, -315.35, 1258.95 )
 - Main X,Y,Z ( -117.81, -317.36, 1253.96 )
 - EDep X,Y,Z ( -117.54, -316.63, 1254.02 )
 - Reco X,Y,Z ( -116.06, -315.73, 1255.51 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  11-Nov-2025 22:23:18 UTC run: 5082 subRun: 0 event: 76399
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
Begin processing the 50th record. run: 5082 subRun: 0 event: 76400 at 11-Nov-2025 22:23:18 UTC
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  11-Nov-2025 22:23:18 UTC run: 5082 subRun: 0 event: 76400
[35m
###################################################
Event:			76400
Flag:			963062305
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  11-Nov-2025 22:23:18 UTC run: 5082 subRun: 0 event: 76400
[91m
There are a total of 32808 Particles in the event

# of particles 7	from gen 1 marley
# of particles 10901	from gen 2 Ar39GenInLAr
# of particles 1191	from gen 3 Kr85GenInLAr
# of particles 0	from gen 4 Ar42GenInLAr
# of particles 3	from gen 5 K42From42ArGenInLAr
# of particles 9	from gen 6 Rn222ChainRn222GenInLAr
# of particles 14	from gen 7 Rn222ChainPo218GenInLAr
# of particles 4	from gen 8 Rn222ChainPb214GenInLAr
# of particles 16	from gen 9 Rn222ChainBi214GenInLAr
# of particles 6	from gen 10 Rn222ChainPb210GenInLAr
# of particles 9	from gen 11 Rn220ChainPb212GenInLAr
# of particles 19	from gen 12 K40GenInCPA
# of particles 237	from gen 13 U238ChainGenInCPA
# of particles 259	from gen 14 Th232ChainGenInCPA
# of particles 1	from gen 15 K42From42ArGenInCPA
# of particles 5	from gen 16 Rn222ChainPo218GenInCPA
# of particles 7	from gen 17 Rn222ChainPb214GenInCPA
# of particles 50	from gen 18 Rn222ChainBi214GenInCPA
# of particles 36	from gen 19 Rn222ChainPb210GenInCPA
# of particles 25	from gen 20 Rn222ChainFromBi210GenInCPA
# of particles 41	from gen 21 Rn220ChainFromPb212GenInCPA
# of particles 0	from gen 22 Co60GenInAPA
# of particles 0	from gen 23 U238ChainGenInAPA
# of particles 3	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  11-Nov-2025 22:23:18 UTC run: 5082 subRun: 0 event: 76400
[33m
Number of Signal Particles: 7
Neutrino Interaction: -1
Neutrino Energy: 49.63 MeV
Position (-26.22, 538.13, 589.22) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		0.54	(-26.22, 538.13, 589.22)	32859	32803
marley	-12		0.78	(-26.22, 538.13, 589.22)	32858	32803
marley	22		0.03	(-26.22, 538.13, 589.22)	32806	0
marley	22		0.77	(-26.22, 538.13, 589.22)	32805	0
marley	22		3.71	(-26.22, 538.13, 589.22)	32804	0
marley	1000190400	0.08	(-26.22, 538.13, 589.22)	32803	0
marley	11		43.53	(-26.22, 538.13, 589.22)	32802	0
Signal Track IDs: 32802; 32803; 32804; 32805; 32806; 32858; 32859; [0m
%MSG
%MSG-w ProducerUtils:  SolarNuAna:solarnuana@BeginModule  11-Nov-2025 22:23:18 UTC run: 5082 subRun: 0 event: 76400
[31m
Kinetic energy of signal particle is above threshold of 30.00 MeV. Skipping event.
[0m
%MSG
11-Nov-2025 22:23:19 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/4b/68/prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250206T104551Z_gen_001528_supernova_g4_detsim_reco_20250724T113926Z_reco2.root"
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@EndJob 11-Nov-2025 22:23:19 UTC  ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                         0.134641       5.52163       15.0481      0.259925       6.54758        50     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.00112796    0.00776609     0.0255956    0.00277336    0.00695318       50     
end_path:solarnuana:SolarNuAna     0.132593       5.51367       15.0279      0.247236       6.54739        50     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 11-Nov-2025 22:23:19 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)  : 1549.9 MB
  Peak resident set size usage (VmHWM): 902.967 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 = 290.273232 Real = 300.985100

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 1549.9 VmHWM = 902.967

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