Jobsub ID 288544.46@dunegpschedd02.fnal.gov

Jobsub ID	288544.46@dunegpschedd02.fnal.gov
Workflow ID	12007
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-20 14:48:38
Site	US_FNAL-T1
Entry	CMSHTPC_T1_US_FNAL_condce_opp1_whole
Last heartbeat	2026-01-20 22:08:36
From worker node	Hostname	dunegli-50386-0-cmswn2355.fnal.gov
	cpuinfo	Intel(R) Xeon(R) CPU E5-2670 v3 @ 2.30GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	171000 (47 hours)
	GPU
	Inner Apptainer?	True
Job state	outputting_failed
Started	2026-01-20 14:57:37
Input files	fardet-vd:prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250127T000641Z_gen_003505_supernova_g4stage1_g4stage2_detsim_reco_20250703T060244Z_reco2.root
Jobscript	Exit code	0
	Real time	7h (25840s)
	CPU time	7h (25646s = 99%)
	Max RSS bytes	2560102400 (2441 MiB)
Outputting started	2026-01-20 22:08:17
Output files
Finished	2026-01-20 22:08:36
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

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  20-Jan-2026 20:40:12 UTC run: 4924 subRun: 0 event: 35050
[91m
There are a total of 132937 Particles in the event

# of particles 11	from gen 1 marley
# of particles 31147	from gen 2 Ar39GenInLAr
# of particles 3530	from gen 3 Kr85GenInLAr
# of particles 2	from gen 4 Ar42GenInLAr
# of particles 0	from gen 5 K42From42ArGenInLAr
# of particles 36	from gen 6 Rn222ChainRn222GenInLAr
# of particles 23	from gen 7 Rn222ChainPo218GenInLAr
# of particles 54	from gen 8 Rn222ChainPb214GenInLAr
# of particles 25	from gen 9 Rn222ChainBi214GenInLAr
# of particles 16	from gen 10 Rn222ChainPb210GenInLAr
# of particles 35	from gen 11 Rn220ChainPb212GenInLAr
# of particles 211	from gen 12 K40GenInCathode
# of particles 2920	from gen 13 U238ChainGenInCathode
# of particles 3605	from gen 14 Th232ChainGenInCathode
# of particles 121	from gen 15 K40GenInAnode
# of particles 1378	from gen 16 U238ChainGenInAnode
# of particles 1716	from gen 17 Th232ChainGenInAnode
# of particles 0	from gen 18 Rn222ChainGenInPDS
# of particles 2	from gen 19 K42From42ArGenInUpperMesh1x8x14
# of particles 0	from gen 20 Rn222ChainFromPo218GenInUpperMesh1x8x14
# of particles 17	from gen 21 Rn222ChainFromPb214GenInUpperMesh1x8x14
# of particles 63	from gen 22 Rn222ChainFromBi214GenInUpperMesh1x8x14
# of particles 43	from gen 23 Rn222ChainFromPb210GenInUpperMesh1x8x14
# of particles 39	from gen 24 Rn222ChainFromBi210GenInUpperMesh1x8x14
# of particles 46	from gen 25 Rn220ChainFromPb212GenInUpperMesh1x8x14
# of particles 84313	from gen 26 CavernwallGammasAtLAr1x8x14
# of particles 3534	from gen 27 foamGammasAtLAr1x8x14
# of particles 49	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  20-Jan-2026 20:40:12 UTC run: 4924 subRun: 0 event: 35050
[33m
Number of Signal Particles: 8
Neutrino Interaction: -1
Neutrino Energy: 14.94 MeV
Position (-138.82, 36.76, 1937.56) cm
Gen.	PdgCode		Energy		EndPosition		TrackID	MotherID
--------------------------------------------------------------------------------
marley	22		1.46	(-138.82, 36.76, 1937.56)	132955	132880
marley	1000180400	0.00	(-138.82, 36.76, 1937.56)	132954	132880
marley	12		0.04	(-138.82, 36.76, 1937.56)	132953	132880
marley	11		0.00	(-138.82, 36.76, 1937.56)	132951	132880
marley	11		0.00	(-138.82, 36.76, 1937.56)	132950	132880
marley	22		0.03	(-138.82, 36.76, 1937.56)	132884	0
marley	22		0.77	(-138.82, 36.76, 1937.56)	132883	0
marley	22		1.25	(-138.82, 36.76, 1937.56)	132882	0
marley	22		4.74	(-138.82, 36.76, 1937.56)	132881	0
marley	1000190400	0.00	(-138.82, 36.76, 1937.56)	132880	0
marley	11		6.65	(-138.82, 36.76, 1937.56)	132879	0
Signal Track IDs: 132879; 132880; 132881; 132882; 132883; 132884; 132950; 132951; 132953; 132954; 132955; [0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 20:40:12 UTC run: 4924 subRun: 0 event: 35050
[33m
Kinetic energy of signal particle is below threshold of 30.00 MeV. Selecting event.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 20:43:23 UTC run: 4924 subRun: 0 event: 35050
[34mOpFlash PE 1643.63 with purity 0.66 time -5.94 plane 2
 - Vertex (60.07, -743.30, 1641.62)
	*** 1st Sanity check: Ratio 0.34 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 36.02 with purity 0.62 time 0.26 plane 2
 - Vertex (79.39, -743.30, 1641.62)
	*** 1st Sanity check: Ratio 0.62 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 557.50 with purity 0.37 time 0.21 plane 0
 - Vertex (-327.50, 39.83, 1902.97)
	*** 1st Sanity check: Ratio 0.10 <= 1.00
	*** 2nd Sanity check: #OpHits 29 >= 29
OpFlash PE 38.36 with purity 0.28 time 0.92 plane 3
 - Vertex (173.41, 43.71, 2188.38)
	*** 1st Sanity check: Ratio 0.27 <= 1.00
	*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 99.23 with purity 0.03 time 1.07 plane 0
 - Vertex (-327.50, -468.10, 853.10)
	*** 1st Sanity check: Ratio 0.42 <= 1.00
	*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 15.55 with purity 0.30 time 2.63 plane 0
 - Vertex (-327.50, 424.21, 712.24)
	*** 1st Sanity check: Ratio 0.39 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 12.50 with purity 0.50 time 3.05 plane 1
 - Vertex (285.07, 743.30, 1343.78)
	*** 1st Sanity check: Ratio 1.00 <= 1.00
	*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 65.34 with purity 0.14 time 3.61 plane 0
 - Vertex (-327.50, -215.45, 1662.01)
	*** 1st Sanity check: Ratio 0.14 <= 1.00
	*** 2nd Sanity check: #OpHits 8 >= 8

# of OpHits (ophit10ppm): 52217 for times between -4254.31 us and 295147919198126080.00 us.
# of OpFlashes (solarflash): 18084 for times between -4254.31 us and 295147919198126080.00 us.
[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 20:43:26 UTC run: 4924 subRun: 0 event: 35050
[36m
# OpHits (ophit10ppm) in full geometry: 52217
# OpFlashes (solarflash) in full geometry: 18084
# Hits (gaushit) in each view: 6798, 6795, 6758, 0
# Cluster from the hits: 2821, 2889, 5733, 0
# Tracks (pmtracktc) in full geometry: 468[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 22:08:14 UTC run: 4924 subRun: 0 event: 35050
[32m
# ClusterReco: Looping over 5726 matched clusters[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 22:08:14 UTC run: 4924 subRun: 0 event: 35050
[32m*** Matched preselection cluster: 3860 from 5726
 - MainTrackID 132879
 - Gen 1 -> marley TPC 100
 - Purity 1.00 Hits 3
 - Charge 673.00 ( MaxHit 269.39 )
 - #AdjCl 10 ( 1 signal ):
    - Cluster 3310 at distance 78.49 with time 2473.23 and charge 43.81 in TPC 108 and hits 1
    - Cluster 3490 at distance 50.60 with time 2613.20 and charge 27.22 in TPC 104 and hits 1
    - Cluster 3676 at distance 74.42 with time 2748.33 and charge 24.83 in TPC 106 and hits 1
    - Cluster 3811 at distance 54.90 with time 2853.69 and charge 124.69 in TPC 100 and hits 2
    - Cluster 3855 at distance 84.73 with time 2877.84 and charge 41.20 in TPC 100 and hits 1
    - Cluster 3867 at distance 38.88 with time 2887.08 and charge 192.22 in TPC 100 and hits 2
    - Cluster 4081 at distance 89.21 with time 3047.06 and charge 25.56 in TPC 106 and hits 1
    - Cluster 4160 at distance 97.25 with time 3105.71 and charge 37.34 in TPC 108 and hits 1
    - Cluster 4403 at distance 87.55 with time 3271.30 and charge 67.53 in TPC 108 and hits 2
    - Cluster 4449 at distance 79.29 with time 3306.72 and charge 42.43 in TPC 108 and hits 1
 - RecoCol  Time,Y,Z ( 2881.91, 37.08, 1938.06 )
 - RecoInd0 Time,Y,Z ( 2881.36, 36.41, 1868.00 )
 - RecoInd1 Time,Y,Z ( 2883.50, 37.75, 1907.95 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( -138.82, 36.76, 1937.56 )
 - Main X,Y,Z ( -137.29, 36.06, 1938.42 )
 - EDep X,Y,Z ( -137.32, 36.02, 1938.36 )
 - Reco X,Y,Z ( -1000000.00, 37.08, 1938.06 )[0m
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  20-Jan-2026 22:08:14 UTC run: 4924 subRun: 0 event: 35050
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
20-Jan-2026 22:08:16 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/0d/a9/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250127T000641Z_gen_003505_supernova_g4stage1_g4stage2_detsim_reco_20250703T060244Z_reco2.root"
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@EndJob 20-Jan-2026 22:08:16 UTC  ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          2.38858       2573.02       5337.89       2342.16       2575.94        10     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.00121022     0.0151802     0.0530093     0.0101499     0.0154339       10     
end_path:solarnuana:SolarNuAna      2.38465        2573         5337.87       2342.14       2575.95        10     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 20-Jan-2026 22:08:16 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)  : 3185.37 MB
  Peak resident set size usage (VmHWM): 2560.1 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 = 25614.461229 Real = 25807.016075

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 3185.37 VmHWM = 2560.1

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