Jobsub ID 300763.1@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
.38 with purity 0.50 time -1.03 plane 3
- Vertex (171.39, -220.00, 2188.38)
*** 1st Sanity check: Ratio 0.52 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 13.80 with purity 0.28 time -0.50 plane 2
- Vertex (103.45, -743.30, 1939.46)
*** 1st Sanity check: Ratio 0.58 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 40.56 with purity 0.66 time -0.05 plane 2
- Vertex (219.06, -743.30, 804.13)
*** 1st Sanity check: Ratio 0.36 <= 1.00
*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 2229.31 with purity 0.23 time 0.02 plane 0
- Vertex (-327.50, -23.30, 1654.77)
*** 1st Sanity check: Ratio 0.12 <= 1.00
*** 2nd Sanity check: #OpHits 53 >= 53
OpFlash PE 36.66 with purity 0.37 time 0.52 plane 1
- Vertex (274.01, 743.30, 1343.78)
*** 1st Sanity check: Ratio 0.35 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 33.15 with purity 0.42 time 0.38 plane 3
- Vertex (222.37, -220.00, 2188.38)
*** 1st Sanity check: Ratio 0.28 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 804.10 with purity 0.04 time 1.30 plane 0
- Vertex (-327.50, -542.10, 1231.78)
*** 1st Sanity check: Ratio 0.39 <= 1.00
*** 2nd Sanity check: #OpHits 21 >= 21
OpFlash PE 25.85 with purity 0.05 time 1.94 plane 2
- Vertex (248.61, -743.30, 1014.57)
*** 1st Sanity check: Ratio 0.32 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 8.29 with purity 0.33 time 2.57 plane 3
- Vertex (285.07, -220.00, 2188.38)
*** 1st Sanity check: Ratio 1.00 <= 1.00
*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 91.40 with purity 0.20 time 2.78 plane 0
- Vertex (-327.50, -149.66, 1579.76)
*** 1st Sanity check: Ratio 0.13 <= 1.00
*** 2nd Sanity check: #OpHits 10 >= 10
OpFlash PE 90.13 with purity 0.12 time 2.87 plane 0
- Vertex (-327.50, -197.94, 1230.40)
*** 1st Sanity check: Ratio 0.14 <= 1.00
*** 2nd Sanity check: #OpHits 11 >= 11
OpFlash PE 108.65 with purity 0.28 time 2.86 plane 0
- Vertex (-327.50, 19.16, 1292.60)
*** 1st Sanity check: Ratio 0.14 <= 1.00
*** 2nd Sanity check: #OpHits 13 >= 13
OpFlash PE 14.37 with purity 0.20 time 4.50 plane 2
- Vertex (60.07, -743.30, 1939.46)
*** 1st Sanity check: Ratio 1.00 <= 1.00
*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 18.13 with purity 0.14 time 4.71 plane 2
- Vertex (210.07, -743.30, 1045.94)
*** 1st Sanity check: Ratio 1.00 <= 1.00
*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 14.54 with purity 0.21 time 5.64 plane 0
- Vertex (-327.50, 262.85, 1637.36)
*** 1st Sanity check: Ratio 0.41 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
# of OpHits (ophit10ppm): 52479 for times between -4254.49 us and 295147919198126080.00 us.
# of OpFlashes (solarflash): 18314 for times between -4254.49 us and 295147919198126080.00 us.
[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 26-Jan-2026 02:13:18 UTC run: 4963 subRun: 0 event: 12260
[36m
# OpHits (ophit10ppm) in full geometry: 52479
# OpFlashes (solarflash) in full geometry: 18314
# Hits (gaushit) in each view: 7104, 7011, 6905, 0
# Cluster from the hits: 2967, 2954, 5857, 0
# Tracks (pmtracktc) in full geometry: 513[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 26-Jan-2026 03:39:37 UTC run: 4963 subRun: 0 event: 12260
[32m
# ClusterReco: Looping over 5845 matched clusters[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 26-Jan-2026 03:39:37 UTC run: 4963 subRun: 0 event: 12260
[32m*** Matched preselection cluster: 4272 from 5845
- MainTrackID 132828
- Gen 1 -> marley TPC 84
- Purity 1.00 Hits 2
- Charge 163.40 ( MaxHit 129.98 )
- #AdjCl 3 ( 0 signal ):
- Cluster 3576 at distance 91.52 with time 2587.58 and charge 49.88 in TPC 82 and hits 1
- Cluster 3746 at distance 64.17 with time 2708.88 and charge 48.51 in TPC 82 and hits 1
- Cluster 3900 at distance 84.58 with time 2822.21 and charge 41.89 in TPC 86 and hits 1
- RecoCol Time,Y,Z ( 3090.02, -207.57, 1610.83 )
- RecoInd0 Time,Y,Z ( 3090.01, -419.44, 223.88 )
- RecoInd1 Time,Y,Z ( 3090.06, 4.31, 1623.87 )
*** Matched flash: 9173 from 18314
- Purity 20.30 % Plane 0 #Hits 10
- MainOpHitPE 12.32 (PE); TotalPE 91.40 vs expected 103.15 (PE)
- Time 2.78 (us) Fast 14.58 % Residual 46.32
- Reco Time,Y,Z ( 2.78, -149.66, 1579.76 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -221.41, -12.93, 1661.54 )
- Main X,Y,Z ( -212.51, -19.78, 1585.54 )
- EDep X,Y,Z ( -171.06, 4.25, 1610.79 )
- Reco X,Y,Z ( -170.66, -207.57, 1610.83 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 26-Jan-2026 03:39:37 UTC run: 4963 subRun: 0 event: 12260
[32m*** Matched preselection cluster: 4595 from 5845
- MainTrackID 132826
- Gen 1 -> marley TPC 91
- Purity 1.00 Hits 1
- Charge 35.72 ( MaxHit 35.72 )
- #AdjCl 0 ( 0 signal ):
- RecoCol Time,Y,Z ( 3318.59, -691.23, 1653.05 )
- RecoInd0 Time,Y,Z ( 3319.14, -1372.90, 74.77 )
- RecoInd1 Time,Y,Z ( 3318.78, -9.56, 1656.24 )
*** Matched flash: 11708 from 18314
- Purity 0.00 % Plane 2 #Hits 6
- MainOpHitPE 98.68 (PE); TotalPE 297.24 vs expected 29.02 (PE)
- Time 1177.94 (us) Fast 33.54 % Residual 148.88
- Reco Time,Y,Z ( 1177.94, -743.30, 1641.62 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -221.41, -12.93, 1661.54 )
- Main X,Y,Z ( -217.30, -9.98, 1655.36 )
- EDep X,Y,Z ( -220.85, -11.48, 1659.07 )
- Reco X,Y,Z ( -18.67, -691.23, 1653.05 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 26-Jan-2026 03:39:37 UTC run: 4963 subRun: 0 event: 12260
[32m*** Matched preselection cluster: 4698 from 5845
- MainTrackID 132830
- Gen 1 -> marley TPC 91
- Purity 1.00 Hits 14
- Charge 2203.31 ( MaxHit 306.92 )
- #AdjCl 10 ( 1 signal ):
- Cluster 4322 at distance 90.99 with time 3127.76 and charge 51.19 in TPC 83 and hits 1
- Cluster 4346 at distance 69.45 with time 3142.80 and charge 52.13 in TPC 91 and hits 1
- Cluster 4553 at distance 41.52 with time 3290.35 and charge 51.52 in TPC 91 and hits 1
- Cluster 4629 at distance 10.83 with time 3338.49 and charge 206.55 in TPC 91 and hits 2
- Cluster 4675 at distance 44.26 with time 3375.80 and charge 35.66 in TPC 93 and hits 1
- Cluster 4713 at distance 97.78 with time 3404.35 and charge 202.11 in TPC 91 and hits 3
- Cluster 4715 at distance 42.82 with time 3405.31 and charge 122.55 in TPC 91 and hits 2
- Cluster 4743 at distance 23.56 with time 3417.60 and charge 70.62 in TPC 91 and hits 1
- Cluster 4806 at distance 72.69 with time 3457.45 and charge 59.50 in TPC 89 and hits 2
- Cluster 4852 at distance 33.10 with time 3491.56 and charge 167.48 in TPC 91 and hits 1
- RecoCol Time,Y,Z ( 3393.51, -10.99, 1657.95 )
- RecoInd0 Time,Y,Z ( 3400.53, -10.89, 1718.08 )
- RecoInd1 Time,Y,Z ( 3393.36, -11.10, 1660.02 )
*** Matched flash: 9163 from 18314
- Purity 23.18 % Plane 0 #Hits 53
- MainOpHitPE 265.65 (PE); TotalPE 2229.31 vs expected 962.48 (PE)
- Time 0.02 (us) Fast 11.96 % Residual 5890.81
- Reco Time,Y,Z ( 0.02, -23.30, 1654.77 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -221.41, -12.93, 1661.54 )
- Main X,Y,Z ( -220.84, -7.63, 1666.09 )
- EDep X,Y,Z ( -221.32, -12.75, 1661.14 )
- Reco X,Y,Z ( -219.83, -10.99, 1657.95 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 26-Jan-2026 03:39:37 UTC run: 4963 subRun: 0 event: 12260
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
26-Jan-2026 03:39:38 UTC Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/fe/e1/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250128T070721Z_gen_001226_supernova_g4stage1_g4stage2_detsim_reco_20250626T160845Z_reco2.root"
%MSG-i ProducerUtils: SolarNuAna:solarnuana@EndJob 26-Jan-2026 03:39:38 UTC ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG
====================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
====================================================================================================================
Full event 1.71343 3828.9 8591.59 5258.87 3265.7 10
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00238256 0.010366 0.0302721 0.00760248 0.00876013 10
end_path:solarnuana:SolarNuAna 1.70985 3828.89 8591.58 5258.86 3265.7 10
====================================================================================================================
%MSG-i NuRandomService: SolarNuAna:solarnuana@EndJob 26-Jan-2026 03:39: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) : 3196.57 MB
Peak resident set size usage (VmHWM): 2581.64 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 = 37885.383600 Real = 38352.101542
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 3196.57 VmHWM = 2581.64
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===