Jobsub ID 46457.7@dunegpschedd01.fnal.gov

Jobsub ID	46457.7@dunegpschedd01.fnal.gov
Workflow ID	2595
Stage ID	1
User name	smanthey@fnal.gov
HTCondor Group	group_dune
Requested	Processors	1
	GPU	No
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-09-14 23:32:59
Site	US_FNAL-FermiGrid
Entry	FNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat	2025-09-14 23:48:08
From worker node	Hostname	dunegli-6867132-0-fnpc17125.fnal.gov
	cpuinfo	Intel(R) Xeon(R) Gold 6140 CPU @ 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-09-14 23:33:55
Input files	fardet-hd:prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250210T180106Z_gen_003776_supernova_g4_halfActiveVol_detsim_reco_20250725T012548Z_reco2.root
Jobscript	Exit code	0
	Real time	14m (841s)
	CPU time	13m (815s = 96%)
	Max RSS bytes	866627584 (826 MiB)
Outputting started	2025-09-14 23:47:56
Output files	https://fndcadoor.fnal.gov:2880/dune/scratch/users/smanthey/ana/solar_ana_marley_flash_radiological_decay0_dune10kt_1x2x6_lateralAPA/fnal/02595/1/001/fdhd_ana_2025-09-14T_233402Z_hist.root
Finished	2025-09-14 23:48:08
Saved logs	justin-logs:46457.7-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

st 0.87 Residual 251257.94
 - Reco Time,Y,Z ( -13.70, 155.68, 35.12 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( 344.40, 363.45, 101.65 )
 - Main X,Y,Z ( 340.52, 362.48, 93.74 )
 - EDep X,Y,Z ( 337.31, 350.95, 100.53 )
 - Reco X,Y,Z ( 336.51, 241.25, 100.51 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  14-Sep-2025 23:47:39 UTC run: 5117 subRun: 0 event: 188799
[32m*** Matched preselection cluster: 115
 - MainTrackID 32797
 - Gen 1 -> marley TPC 3
 - Purity 1.00 Hits 19
 - Charge 3792.91 ( MaxHit 345.52 )
 - #AdjCl 3 ( 2 signal ):
    - Cluster 100 at distance 33.52 with time 1982.68 and charge 65.23 in TPC 3 and hits 1
    - Cluster 107 at distance 17.13 with time 2041.90 and charge 183.86 in TPC 3 and hits 2
    - Cluster 110 at distance 7.76 with time 2066.56 and charge 223.54 in TPC 3 and hits 2
 - RecoCol  Time,Y,Z ( 2106.80, 360.59, 97.16 )
 - RecoInd0 Time,Y,Z ( 2109.92, 360.55, 115.32 )
 - RecoInd1 Time,Y,Z ( 2104.75, 360.63, 115.32 )
*** Matched flash: 
 - Purity 0.97 Plane 1 #Hits 69 PE 213.31 MaxPE 9.98
 - Time 0.01 Fast 0.74 Residual 59.47
 - Reco Time,Y,Z ( 0.01, 323.10, 153.62 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( 344.40, 363.45, 101.65 )
 - Main X,Y,Z ( 338.37, 358.58, 93.29 )
 - EDep X,Y,Z ( 344.38, 363.44, 101.62 )
 - Reco X,Y,Z ( 338.27, 360.59, 97.16 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  14-Sep-2025 23:47:39 UTC run: 5117 subRun: 0 event: 188799
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
Begin processing the 50th record. run: 5117 subRun: 0 event: 188800 at 14-Sep-2025 23:47:39 UTC
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  14-Sep-2025 23:47:39 UTC run: 5117 subRun: 0 event: 188800
[35m
#########################################
Event: 188800 Flag: 248381281
Geometry: dune10kt_v6_1x2x6 (HD)
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: 25 TPCs found
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  14-Sep-2025 23:47:39 UTC run: 5117 subRun: 0 event: 188800
[91m
There are a total of 33009 Particles in the event

# of particles 8	from gen 1 marley
# of particles 10901	from gen 2 Ar39GenInLAr
# of particles 1205	from gen 3 Kr85GenInLAr
# of particles 1	from gen 4 Ar42GenInLAr
# of particles 1	from gen 5 K42From42ArGenInLAr
# of particles 14	from gen 6 Rn222ChainRn222GenInLAr
# of particles 10	from gen 7 Rn222ChainPo218GenInLAr
# of particles 19	from gen 8 Rn222ChainPb214GenInLAr
# of particles 16	from gen 9 Rn222ChainBi214GenInLAr
# of particles 0	from gen 10 Rn222ChainPb210GenInLAr
# of particles 14	from gen 11 Rn220ChainPb212GenInLAr
# of particles 16	from gen 12 K40GenInCPA
# of particles 263	from gen 13 U238ChainGenInCPA
# of particles 270	from gen 14 Th232ChainGenInCPA
# of particles 1	from gen 15 K42From42ArGenInCPA
# of particles 0	from gen 16 Rn222ChainPo218GenInCPA
# of particles 8	from gen 17 Rn222ChainPb214GenInCPA
# of particles 59	from gen 18 Rn222ChainBi214GenInCPA
# of particles 40	from gen 19 Rn222ChainPb210GenInCPA
# of particles 18	from gen 20 Rn222ChainFromBi210GenInCPA
# of particles 38	from gen 21 Rn220ChainFromPb212GenInCPA
# of particles 3	from gen 22 Co60GenInAPA
# of particles 0	from gen 23 U238ChainGenInAPA
# of particles 9	from gen 24 Th232ChainGenInAPA
# of particles 52	from gen 25 U238Th232K40GenInLArAPAboards1x2x6
# of particles 0	from gen 26 Rn222ChainGenInPDS
# of particles 19242	from gen 27 CavernwallGammasAtLAr1x2x6
# of particles 801	from gen 28 foamGammasAtLAr1x2x6
# of particles 0	from gen 29 CavernwallNeutronsAtLAr1x2x6
# of particles 0	from gen 30 CryostatNGammasAtLAr1x2x6
# of particles 0	from gen 31 CavernNGammasAtLAr1x2x6[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  14-Sep-2025 23:47:39 UTC run: 5117 subRun: 0 event: 188800
[33m
Number of Signal Particles: 7
Neutrino Interaction: -1
Neutrino Energy: 38.81 MeV
Position (40.75, -503.89, 1281.73) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		0.42	(40.75, -503.89, 1281.73)	33043	33003
marley	-12		0.90	(40.75, -503.89, 1281.73)	33042	33003
marley	1000200400	0.00	(40.75, -503.89, 1281.73)	33041	33003
marley	22		0.03	(40.75, -503.89, 1281.73)	33006	0
marley	22		1.61	(40.75, -503.89, 1281.73)	33005	0
marley	22		0.65	(40.75, -503.89, 1281.73)	33004	0
marley	1000190400	0.05	(40.75, -503.89, 1281.73)	33003	0
marley	11		34.97	(40.75, -503.89, 1281.73)	33002	0
Signal Track IDs: 33002; 33003; 33004; 33005; 33006; 33041; 33042; 33043; [0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  14-Sep-2025 23:47:43 UTC run: 5117 subRun: 0 event: 188800
[34mOpFlash PE 24.40 with purity 0.17 time -0.05 plane 0
 - Vertex (-0.05, -204.83, 541.00)
	*** 1st Sanity check: Ratio 0.21 <= 1.00
	*** 2nd Sanity check: #OpHits 11 >= 11
OpFlash PE 8.40 with purity 0.22 time -0.02 plane 1
 - Vertex (0.05, 332.70, 1061.05)
	*** 1st Sanity check: Ratio 0.35 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 1762.34 with purity 0.92 time 0.01 plane 0
 - Vertex (-0.05, -512.21, 1280.71)
	*** 1st Sanity check: Ratio 0.15 <= 1.00
	*** 2nd Sanity check: #OpHits 111 >= 111
OpFlash PE 33.27 with purity 0.64 time 0.15 plane 0
 - Vertex (-0.05, -510.25, 1292.69)
	*** 1st Sanity check: Ratio 0.28 <= 1.00
	*** 2nd Sanity check: #OpHits 11 >= 11

# of OpFlashes (solarflash) in full geometry: 1112
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  14-Sep-2025 23:47:43 UTC run: 5117 subRun: 0 event: 188800
[36m
# OpHits (ophitspe) in full geometry: 40792
# OpFlashes (solarflash) in full geometry: 1112
# Hits (hitfd) in each view: 147, 155, 278, 0
# Cluster from the hits: 83, 88, 243, 0
# Tracks (pmtracktc) in full geometry: 2[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  14-Sep-2025 23:47:55 UTC run: 5117 subRun: 0 event: 188800
[32m
# ClusterReco: Looping over 133 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  14-Sep-2025 23:47:55 UTC run: 5117 subRun: 0 event: 188800
[32m*** Matched preselection cluster: 14
 - MainTrackID 33002
 - Gen 1 -> marley TPC 21
 - Purity 1.00 Hits 13
 - Charge 3739.54 ( MaxHit 892.89 )
 - #AdjCl 4 ( 2 signal ):
    - Cluster 23 at distance 13.55 with time 317.38 and charge 56.83 in TPC 21 and hits 1
    - Cluster 28 at distance 73.26 with time 429.41 and charge 55.23 in TPC 21 and hits 1
    - Cluster 29 at distance 33.98 with time 430.20 and charge 777.93 in TPC 21 and hits 3
    - Cluster 37 at distance 92.93 with time 546.15 and charge 45.92 in TPC 23 and hits 1
 - RecoCol  Time,Y,Z ( 268.00, -505.79, 1280.45 )
 - RecoInd0 Time,Y,Z ( 269.65, -505.65, 1302.60 )
 - RecoInd1 Time,Y,Z ( 269.53, -505.92, 1255.18 )
*** Matched flash: 
 - Purity 0.92 Plane 0 #Hits 111 PE 1762.34 MaxPE 265.46
 - Time 0.01 Fast 0.86 Residual 3108.55
 - Reco Time,Y,Z ( 0.01, -512.21, 1280.71 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( 40.75, -503.89, 1281.73 )
 - Main X,Y,Z ( 49.66, -507.79, 1279.35 )
 - EDep X,Y,Z ( 49.39, -507.04, 1278.84 )
 - Reco X,Y,Z ( -43.03, -505.79, 1280.45 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  14-Sep-2025 23:47:55 UTC run: 5117 subRun: 0 event: 188800
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
14-Sep-2025 23:47:55 UTC  Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/56/02/prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_lateralAPA_20250210T180106Z_gen_003776_supernova_g4_halfActiveVol_detsim_reco_20250725T012548Z_reco2.root"

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          13.0321       15.7983       23.6858       15.7698       1.64266        50     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.00121012    0.00813902     0.130149      0.0017698     0.0197718       50     
end_path:solarnuana:SolarNuAna      13.0301        15.79        23.6723       15.7681       1.64387        50     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 14-Sep-2025 23:47:55 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)  : 1495.42 MB
  Peak resident set size usage (VmHWM): 849.138 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 = 793.883317 Real = 815.702452

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 1495.42 VmHWM = 849.138

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