Jobsub ID 300382.42@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
G-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 25-Jan-2026 17:16:11 UTC run: 4963 subRun: 0 event: 25500
[34mOpFlash PE 225.94 with purity 0.28 time -0.93 plane 2
- Vertex (110.65, -743.30, 776.14)
*** 1st Sanity check: Ratio 0.23 <= 1.00
*** 2nd Sanity check: #OpHits 13 >= 13
OpFlash PE 418.73 with purity 0.49 time 0.72 plane 0
- Vertex (-327.50, -395.56, 1239.94)
*** 1st Sanity check: Ratio 0.11 <= 1.00
*** 2nd Sanity check: #OpHits 32 >= 32
OpFlash PE 61.65 with purity 0.52 time 2.29 plane 0
- Vertex (-327.50, -432.02, 1488.91)
*** 1st Sanity check: Ratio 0.19 <= 1.00
*** 2nd Sanity check: #OpHits 8 >= 8
OpFlash PE 29.49 with purity 0.50 time 3.77 plane 2
- Vertex (285.07, -743.30, 1641.62)
*** 1st Sanity check: Ratio 0.65 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 37.70 with purity 0.54 time 3.33 plane 2
- Vertex (73.98, -743.30, 1045.94)
*** 1st Sanity check: Ratio 0.41 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 16.60 with purity 0.23 time 4.92 plane 0
- Vertex (-327.50, -208.57, 1713.91)
*** 1st Sanity check: Ratio 0.54 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 171.89 with purity 0.16 time 200.96 plane 0
- Vertex (-327.50, -42.00, 1004.94)
*** 1st Sanity check: Ratio 0.42 <= 1.00
*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 81.77 with purity 0.33 time 203.79 plane 4
- Vertex (210.07, -220.00, -96.50)
*** 1st Sanity check: Ratio 0.41 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 107.77 with purity 0.08 time 203.92 plane 2
- Vertex (146.70, -743.30, 576.08)
*** 1st Sanity check: Ratio 0.40 <= 1.00
*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 44.26 with purity 0.08 time 204.76 plane 0
- Vertex (-327.50, -447.25, 385.84)
*** 1st Sanity check: Ratio 0.24 <= 1.00
*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 7.43 with purity 0.33 time 204.86 plane 0
- Vertex (-327.50, -377.40, 1600.62)
*** 1st Sanity check: Ratio 1.00 <= 1.00
*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 14.47 with purity 0.14 time 206.30 plane 2
- Vertex (106.48, -743.30, 358.11)
*** 1st Sanity check: Ratio 0.69 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
# of OpHits (ophit10ppm): 53178 for times between -4254.71 us and 295147919198126080.00 us.
# of OpFlashes (solarflash): 18387 for times between -4254.71 us and 295147919198126080.00 us.
[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 25-Jan-2026 17:16:15 UTC run: 4963 subRun: 0 event: 25500
[36m
# OpHits (ophit10ppm) in full geometry: 53178
# OpFlashes (solarflash) in full geometry: 18387
# Hits (gaushit) in each view: 6655, 6635, 6690, 0
# Cluster from the hits: 2761, 2807, 5675, 0
# Tracks (pmtracktc) in full geometry: 499[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 25-Jan-2026 19:09:37 UTC run: 4963 subRun: 0 event: 25500
[32m
# ClusterReco: Looping over 5659 matched clusters[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 25-Jan-2026 19:09:37 UTC run: 4963 subRun: 0 event: 25500
[32m*** Matched preselection cluster: 1907 from 5659
- MainTrackID 133256
- Gen 1 -> marley TPC 25
- Purity 1.00 Hits 3
- Charge 981.99 ( MaxHit 801.07 )
- #AdjCl 7 ( 0 signal ):
- Cluster 1571 at distance 52.09 with time 1191.84 and charge 220.06 in TPC 25 and hits 2
- Cluster 1666 at distance 71.94 with time 1260.98 and charge 39.49 in TPC 25 and hits 2
- Cluster 1844 at distance 22.62 with time 1408.72 and charge 53.90 in TPC 25 and hits 1
- Cluster 1911 at distance 78.04 with time 1450.60 and charge 23.46 in TPC 27 and hits 1
- Cluster 1929 at distance 75.85 with time 1463.33 and charge 131.70 in TPC 19 and hits 1
- Cluster 1970 at distance 16.62 with time 1506.97 and charge 41.54 in TPC 27 and hits 1
- Cluster 2023 at distance 74.01 with time 1553.34 and charge 51.19 in TPC 31 and hits 2
- RecoCol Time,Y,Z ( 1448.01, -484.04, 459.20 )
- RecoInd0 Time,Y,Z ( 1448.17, -483.98, 471.65 )
- RecoInd1 Time,Y,Z ( 1448.11, -484.11, 522.72 )
*** Matched flash: 7248 from 18387
- Purity 0.00 % Plane 0 #Hits 20
- MainOpHitPE 79.49 (PE); TotalPE 491.56 vs expected 172.36 (PE)
- Time -893.29 (us) Fast 51.80 % Residual 1888.48
- Reco Time,Y,Z ( -893.29, -571.50, 432.31 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( 66.39, -408.04, 1304.77 )
- Main X,Y,Z ( 119.21, -490.25, 458.64 )
- EDep X,Y,Z ( 125.17, -483.87, 459.21 )
- Reco X,Y,Z ( -50.89, -484.04, 459.20 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 25-Jan-2026 19:09:37 UTC run: 4963 subRun: 0 event: 25500
[32m*** Matched preselection cluster: 1919 from 5659
- MainTrackID 133256
- Gen 1 -> marley TPC 25
- Purity 1.00 Hits 1
- Charge 62.61 ( MaxHit 62.61 )
- #AdjCl 6 ( 0 signal ):
- Cluster 1429 at distance 81.94 with time 1100.29 and charge 27.56 in TPC 29 and hits 1
- Cluster 1603 at distance 93.37 with time 1214.61 and charge 24.43 in TPC 17 and hits 1
- Cluster 1858 at distance 80.17 with time 1420.47 and charge 36.72 in TPC 17 and hits 1
- Cluster 1885 at distance 79.70 with time 1436.81 and charge 35.73 in TPC 29 and hits 1
- Cluster 2126 at distance 88.24 with time 1622.67 and charge 34.41 in TPC 31 and hits 1
- Cluster 2250 at distance 85.45 with time 1721.81 and charge 52.47 in TPC 27 and hits 1
- RecoCol Time,Y,Z ( 1454.75, -214.14, 462.29 )
- RecoInd0 Time,Y,Z ( 1451.65, 413.81, 81.94 )
- RecoInd1 Time,Y,Z ( 1452.81, -842.08, 1120.78 )
*** Matched flash: 6267 from 18387
- Purity 0.00 % Plane 0 #Hits 15
- MainOpHitPE 163.52 (PE); TotalPE 615.97 vs expected 62.17 (PE)
- Time -1354.88 (us) Fast 62.39 % Residual 3858.50
- Reco Time,Y,Z ( -1354.88, -311.45, 471.09 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( 66.39, -408.04, 1304.77 )
- Main X,Y,Z ( 119.21, -490.25, 458.64 )
- EDep X,Y,Z ( 125.17, -483.87, 459.21 )
- Reco X,Y,Z ( -126.09, -214.14, 462.29 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 25-Jan-2026 19:09:37 UTC run: 4963 subRun: 0 event: 25500
[32m*** Matched preselection cluster: 2151 from 5659
- MainTrackID 133130
- Gen 1 -> marley TPC 65
- Purity 1.00 Hits 2
- Charge 155.99 ( MaxHit 135.61 )
- #AdjCl 4 ( 0 signal ):
- Cluster 1787 at distance 52.71 with time 1357.75 and charge 56.51 in TPC 65 and hits 2
- Cluster 1961 at distance 98.63 with time 1498.49 and charge 32.39 in TPC 73 and hits 1
- Cluster 2219 at distance 77.36 with time 1697.06 and charge 135.34 in TPC 65 and hits 2
- Cluster 2538 at distance 91.88 with time 1926.32 and charge 106.96 in TPC 65 and hits 1
- RecoCol Time,Y,Z ( 1646.93, -408.52, 1302.13 )
- RecoInd0 Time,Y,Z ( 1646.99, -408.56, 1270.32 )
- RecoInd1 Time,Y,Z ( 1646.82, -408.49, 1270.32 )
*** Matched flash: 9179 from 18387
- Purity 48.70 % Plane 0 #Hits 32
- MainOpHitPE 45.24 (PE); TotalPE 418.73 vs expected 23.28 (PE)
- Time 0.72 (us) Fast 18.84 % Residual 3019.99
- Reco Time,Y,Z ( 0.72, -395.56, 1239.94 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( 66.39, -408.04, 1304.77 )
- Main X,Y,Z ( 60.67, -408.60, 1302.25 )
- EDep X,Y,Z ( 60.63, -408.55, 1302.15 )
- Reco X,Y,Z ( 60.72, -408.52, 1302.13 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 25-Jan-2026 19:09:37 UTC run: 4963 subRun: 0 event: 25500
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
25-Jan-2026 19:09:38 UTC Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/89/bc/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250128T082548Z_gen_002550_supernova_g4stage1_g4stage2_detsim_reco_20250625T100240Z_reco2.root"
%MSG-i ProducerUtils: SolarNuAna:solarnuana@EndJob 25-Jan-2026 19:09:38 UTC ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG
====================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
====================================================================================================================
Full event 2.35063 4314.05 6963.35 5804.19 2852.08 10
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00135152 18.3607 62.1923 0.00965354 28.0378 10
end_path:solarnuana:SolarNuAna 2.34466 4295.69 6963.34 5774.11 2840.75 10
====================================================================================================================
%MSG-i NuRandomService: SolarNuAna:solarnuana@EndJob 25-Jan-2026 19:09: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) : 3195.96 MB
Peak resident set size usage (VmHWM): 2585.31 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 = 42946.725692 Real = 43420.001524
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 3195.96 VmHWM = 2585.31
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===