Jobsub ID 40648.1@dunegpschedd02.fnal.gov

Jobsub ID	40648.1@dunegpschedd02.fnal.gov
Workflow ID	2626
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-16 22:18:24
Site	US_FNAL-FermiGrid
Entry	FNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat	2025-09-17 05:13:52
From worker node	Hostname	dunegli-6878158-0-fnpc17131.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-16 22:18:32
Input files	fardet-vd:prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T144235Z_gen_003846_supernova_g4stage1_g4stage2_detsim_reco_20250701T075538Z_reco2.root
Jobscript	Exit code	0
	Real time	6h (24908s)
	CPU time	6h (24780s = 99%)
	Max RSS bytes	1926684672 (1837 MiB)
Outputting started	2025-09-17 05:13:40
Output files	https://fndcadoor.fnal.gov:2880/dune/scratch/users/smanthey/ana/solar_ana_marley_flash_dunevd10kt_1x8x14_3view_30deg/fnal/02626/1/001/fdhd_ana_2025-09-16T_221840Z_hist.root
Finished	2025-09-17 05:13:52
Saved logs	justin-logs:40648.1-dunegpschedd02.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

ducial Volume in [cm]: 850.32, 1507.84, 2306.12
#########################################[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  17-Sep-2025 04:31:14 UTC run: 5056 subRun: 0 event: 38460
[91m
There are a total of 132722 Particles in the event

# of particles 10	from gen 1 marley
# of particles 31022	from gen 2 Ar39GenInLAr
# of particles 3582	from gen 3 Kr85GenInLAr
# of particles 1	from gen 4 Ar42GenInLAr
# of particles 2	from gen 5 K42From42ArGenInLAr
# of particles 28	from gen 6 Rn222ChainRn222GenInLAr
# of particles 35	from gen 7 Rn222ChainPo218GenInLAr
# of particles 63	from gen 8 Rn222ChainPb214GenInLAr
# of particles 71	from gen 9 Rn222ChainBi214GenInLAr
# of particles 28	from gen 10 Rn222ChainPb210GenInLAr
# of particles 8	from gen 11 Rn220ChainPb212GenInLAr
# of particles 225	from gen 12 K40GenInCathode
# of particles 3018	from gen 13 U238ChainGenInCathode
# of particles 3609	from gen 14 Th232ChainGenInCathode
# of particles 110	from gen 15 K40GenInAnode
# of particles 1252	from gen 16 U238ChainGenInAnode
# of particles 1571	from gen 17 Th232ChainGenInAnode
# of particles 3	from gen 18 Rn222ChainGenInPDS
# of particles 0	from gen 19 K42From42ArGenInUpperMesh *not generated!
# of particles 1	from gen 20 Rn222ChainFromPo218GenInUpperMesh1x8x14
# of particles 28	from gen 21 Rn222ChainFromPb214GenInUpperMesh1x8x14
# of particles 38	from gen 22 Rn222ChainFromBi214GenInUpperMesh1x8x14
# of particles 70	from gen 23 Rn222ChainFromPb210GenInUpperMesh1x8x14
# of particles 44	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 7	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  17-Sep-2025 04:31:14 UTC run: 5056 subRun: 0 event: 38460
[33m
Number of Signal Particles: 9
Neutrino Interaction: -1
Neutrino Energy: 28.57 MeV
Position (-156.21, 535.66, 1530.57) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	11		0.51	(-156.21, 535.66, 1530.57)	132789	132708
marley	-12		0.80	(-156.21, 535.66, 1530.57)	132788	132708
marley	1000200400	0.00	(-156.21, 535.66, 1530.57)	132787	132708
marley	22		0.03	(-156.21, 535.66, 1530.57)	132713	0
marley	22		0.77	(-156.21, 535.66, 1530.57)	132712	0
marley	22		0.84	(-156.21, 535.66, 1530.57)	132711	0
marley	22		0.65	(-156.21, 535.66, 1530.57)	132710	0
marley	22		2.09	(-156.21, 535.66, 1530.57)	132709	0
marley	1000190400	0.02	(-156.21, 535.66, 1530.57)	132708	0
marley	11		22.67	(-156.21, 535.66, 1530.57)	132707	0
Signal Track IDs: 132707; 132708; 132709; 132710; 132711; 132712; 132713; 132787; 132788; 132789; [0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  17-Sep-2025 04:33:47 UTC run: 5056 subRun: 0 event: 38460
[34mOpFlash PE 85.72 with purity 0.10 time -0.04 plane 3
 - Vertex (285.07, 220.00, 2188.38)
	*** 1st Sanity check: Ratio 0.51 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 60.29 with purity 0.21 time -0.01 plane 0
 - Vertex (-327.50, 383.74, 896.28)
	*** 1st Sanity check: Ratio 0.21 <= 1.00
	*** 2nd Sanity check: #OpHits 7 >= 7
OpFlash PE 59.07 with purity 0.67 time 0.02 plane 1
 - Vertex (162.88, 743.30, 1773.36)
	*** 1st Sanity check: Ratio 0.24 <= 1.00
	*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 4.47 with purity 0.50 time 0.01 plane 0
 - Vertex (-327.50, 464.10, 40.42)
	*** 1st Sanity check: Ratio 1.00 <= 1.00
	*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 19.49 with purity 0.73 time 0.02 plane 3
 - Vertex (285.07, 220.00, 2188.38)
	*** 1st Sanity check: Ratio 0.54 <= 1.00
	*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 1248.07 with purity 0.33 time 0.02 plane 0
 - Vertex (-327.50, 519.68, 1515.47)
	*** 1st Sanity check: Ratio 0.10 <= 1.00
	*** 2nd Sanity check: #OpHits 29 >= 29
OpFlash PE 61.64 with purity 0.30 time 0.02 plane 0
 - Vertex (-327.50, -256.82, 1285.82)
	*** 1st Sanity check: Ratio 0.21 <= 1.00
	*** 2nd Sanity check: #OpHits 8 >= 8
OpFlash PE 49.08 with purity 0.05 time 0.06 plane 0
 - Vertex (-327.50, -424.90, 674.08)
	*** 1st Sanity check: Ratio 0.26 <= 1.00
	*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 10.07 with purity 0.42 time 0.07 plane 1
 - Vertex (135.07, 743.30, 1784.74)
	*** 1st Sanity check: Ratio 0.52 <= 1.00
	*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 14.27 with purity 0.38 time 0.07 plane 0
 - Vertex (-327.50, 594.07, 1472.75)
	*** 1st Sanity check: Ratio 0.62 <= 1.00
	*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 15.85 with purity 0.10 time 0.11 plane 0
 - Vertex (-327.50, 438.24, 1527.68)
	*** 1st Sanity check: Ratio 0.41 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3

# of OpFlashes (solarflash) in full geometry: 18724
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  17-Sep-2025 04:33:53 UTC run: 5056 subRun: 0 event: 38460
[36m
# OpHits (ophit10ppm) in full geometry: 52653
# OpFlashes (solarflash) in full geometry: 18724
# Hits (gaushit) in each view: 6868, 6810, 6642, 0
# Cluster from the hits: 2844, 2866, 5650, 0
# Tracks (pmtracktc) in full geometry: 498[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  17-Sep-2025 05:13:38 UTC run: 5056 subRun: 0 event: 38460
[32m
# ClusterReco: Looping over 5643 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  17-Sep-2025 05:13:38 UTC run: 5056 subRun: 0 event: 38460
[32m*** Matched preselection cluster: 3976
 - MainTrackID 132709
 - Gen 1 -> marley TPC 87
 - Purity 1.00 Hits 7
 - Charge 2048.12 ( MaxHit 1037.76 )
 - #AdjCl 11 ( 2 signal ):
    - Cluster 3620 at distance 97.35 with time 2726.70 and charge 25.63 in TPC 83 and hits 1
    - Cluster 3721 at distance 92.91 with time 2814.49 and charge 82.45 in TPC 86 and hits 1
    - Cluster 3738 at distance 95.40 with time 2825.05 and charge 75.40 in TPC 86 and hits 1
    - Cluster 3856 at distance 85.41 with time 2922.32 and charge 65.66 in TPC 86 and hits 1
    - Cluster 4014 at distance 11.54 with time 3028.71 and charge 238.62 in TPC 87 and hits 3
    - Cluster 4051 at distance 66.88 with time 3061.97 and charge 156.10 in TPC 87 and hits 1
    - Cluster 4118 at distance 29.56 with time 3104.64 and charge 87.68 in TPC 87 and hits 1
    - Cluster 4223 at distance 87.29 with time 3181.09 and charge 28.36 in TPC 83 and hits 1
    - Cluster 4230 at distance 76.14 with time 3183.35 and charge 96.80 in TPC 87 and hits 2
    - Cluster 4312 at distance 63.51 with time 3248.68 and charge 42.26 in TPC 87 and hits 1
    - Cluster 4688 at distance 95.17 with time 3552.92 and charge 22.31 in TPC 86 and hits 1
 - RecoCol  Time,Y,Z ( 3004.85, 531.52, 1530.50 )
 - RecoInd0 Time,Y,Z ( 3004.18, 531.37, 1535.84 )
 - RecoInd1 Time,Y,Z ( 3004.74, 531.67, 1569.16 )
*** Matched flash: 
 - Purity 0.33 Plane 0 #Hits 29 PE 1248.07 MaxPE 127.37
 - Time 0.02 Fast 0.54 Residual 549.92
 - Reco Time,Y,Z ( 0.02, 519.68, 1515.47 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -156.21, 535.66, 1530.57 )
 - Main X,Y,Z ( -214.51, 557.64, 1601.75 )
 - EDep X,Y,Z ( -159.17, 536.07, 1531.19 )
 - Reco X,Y,Z ( -157.43, 531.52, 1530.50 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  17-Sep-2025 05:13:38 UTC run: 5056 subRun: 0 event: 38460
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
17-Sep-2025 05:13:38 UTC  Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/4f/d5/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T144235Z_gen_003846_supernova_g4stage1_g4stage2_detsim_reco_20250701T075538Z_reco2.root"

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                           2051         2483.53       2791.32       2544.53       253.641        10     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.000826026   0.00771492     0.0182323    0.00497133    0.00717281       10     
end_path:solarnuana:SolarNuAna       2051         2483.52       2791.32       2544.52       253.638        10     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 17-Sep-2025 05:13:38 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)  : 2543.76 MB
  Peak resident set size usage (VmHWM): 1926.68 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 = 24759.791558 Real = 24885.005230

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 2543.76 VmHWM = 1926.68

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