Jobsub ID 294266.86@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
70, 465.88, 1587.80) 132974 132960
marley 1000180400 0.00 (-71.38, 486.44, 1584.26) 132973 132960
marley 1000180400 0.01 (-79.73, 493.64, 1574.01) 132972 132960
marley 1000180400 0.01 (-75.43, 493.96, 1572.66) 132971 132960
marley 1000180400 0.00 (-75.32, 499.75, 1583.08) 132970 132960
marley 1000180400 0.00 (-70.95, 513.98, 1595.80) 132969 132960
marley 1000180400 0.00 (-72.38, 513.43, 1597.23) 132968 132960
marley 1000180400 0.00 (-91.70, 518.11, 1618.46) 132967 132960
marley 1000180400 0.00 (-89.70, 504.45, 1627.25) 132966 132960
marley 1000180360 0.00 (-90.47, 504.30, 1628.28) 132965 132960
marley 1000180400 0.00 (-78.06, 533.81, 1668.41) 132964 132960
marley 1000180400 0.01 (-53.99, 533.48, 1697.01) 132963 132960
marley 1000180400 0.00 (42.37, 476.62, 1637.55) 132962 132960
marley 1000180400 0.01 (55.86, 499.23, 1592.29) 132961 132960
marley 2112 0.14 (14.85, 513.46, 1594.32) 132960 0
marley 1000190390 0.02 (14.85, 513.46, 1594.32) 132959 0
marley 11 5.96 (14.85, 513.46, 1594.32) 132958 0
Signal Track IDs: 132958; 132959; 132960; 132961; 132962; 132963; 132964; 132965; 132966; 132967; 132968; 132969; 132970; 132971; 132972; 132973; 132974; 132975; 132976; 132977; 132978; 132979; 132980; 132981; 132982; 132983; 132984; 132985; 132986; 132987; 132989; 132990; 132991; 132992; 132993; 132994; 132995; 132997; 132998; 133019; 133020; 133021; 133022; 133023; 133024; 133025; 133026; 133027; 133028; 133029; 133030; 133031; [0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 20-Jan-2026 19:17:21 UTC run: 4787 subRun: 0 event: 647
[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 19:21:18 UTC run: 4787 subRun: 0 event: 647
[34mOpFlash PE 247.14 with purity 0.18 time 0.25 plane 0
- Vertex (-327.50, 538.10, 1746.62)
*** 1st Sanity check: Ratio 0.33 <= 1.00
*** 2nd Sanity check: #OpHits 13 >= 13
OpFlash PE 50.21 with purity 0.17 time 0.54 plane 1
- Vertex (115.77, 743.30, 1639.23)
*** 1st Sanity check: Ratio 0.29 <= 1.00
*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 25.95 with purity 0.10 time 1.99 plane 0
- Vertex (-327.50, -396.73, 1389.53)
*** 1st Sanity check: Ratio 0.39 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 179.90 with purity 0.10 time 620.71 plane 2
- Vertex (60.07, -743.30, 1045.94)
*** 1st Sanity check: Ratio 0.47 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 41.20 with purity 0.08 time 620.99 plane 3
- Vertex (141.26, 220.00, 2188.38)
*** 1st Sanity check: Ratio 0.46 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 102.42 with purity 0.76 time 621.92 plane 1
- Vertex (60.07, 743.30, 1641.62)
*** 1st Sanity check: Ratio 0.35 <= 1.00
*** 2nd Sanity check: #OpHits 8 >= 8
OpFlash PE 10.80 with purity 0.50 time 621.77 plane 0
- Vertex (-327.50, -468.10, 1448.78)
*** 1st Sanity check: Ratio 1.00 <= 1.00
*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 127.11 with purity 0.69 time 622.03 plane 0
- Vertex (-327.50, 419.33, 1580.86)
*** 1st Sanity check: Ratio 0.12 <= 1.00
*** 2nd Sanity check: #OpHits 15 >= 15
OpFlash PE 19.43 with purity 0.31 time 622.40 plane 3
- Vertex (185.07, 91.66, 2188.38)
*** 1st Sanity check: Ratio 0.37 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 40.41 with purity 0.41 time 623.63 plane 1
- Vertex (133.59, 743.30, 1593.30)
*** 1st Sanity check: Ratio 0.35 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 12.39 with purity 0.23 time 624.29 plane 0
- Vertex (-327.50, 538.10, 1724.11)
*** 1st Sanity check: Ratio 0.54 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 1301.77 with purity 0.59 time 626.21 plane 1
- Vertex (60.07, 743.30, 1343.78)
*** 1st Sanity check: Ratio 0.24 <= 1.00
*** 2nd Sanity check: #OpHits 11 >= 11
# of OpHits (ophit10ppm): 52642 for times between -4254.10 us and 295147919198126080.00 us.
# of OpFlashes (solarflash): 18219 for times between -4254.10 us and 295147919198126080.00 us.
[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 20-Jan-2026 19:21:22 UTC run: 4787 subRun: 0 event: 647
[36m
# OpHits (ophit10ppm) in full geometry: 52642
# OpFlashes (solarflash) in full geometry: 18219
# Hits (gaushit) in each view: 6942, 6764, 6780, 0
# Cluster from the hits: 2923, 2889, 5779, 0
# Tracks (pmtracktc) in full geometry: 458[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 20-Jan-2026 20:26:53 UTC run: 4787 subRun: 0 event: 647
[32m
# ClusterReco: Looping over 5773 matched clusters[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 20-Jan-2026 20:26:53 UTC run: 4787 subRun: 0 event: 647
[32m*** Matched preselection cluster: 2519 from 5773
- MainTrackID 132958
- Gen 1 -> marley TPC 87
- Purity 1.00 Hits 4
- Charge 688.84 ( MaxHit 200.06 )
- #AdjCl 5 ( 0 signal ):
- Cluster 2124 at distance 57.23 with time 1654.83 and charge 118.93 in TPC 85 and hits 1
- Cluster 2219 at distance 79.78 with time 1717.87 and charge 44.04 in TPC 87 and hits 1
- Cluster 2320 at distance 95.94 with time 1787.44 and charge 32.89 in TPC 81 and hits 1
- Cluster 2333 at distance 47.25 with time 1793.31 and charge 53.50 in TPC 87 and hits 2
- Cluster 2578 at distance 89.86 with time 1979.31 and charge 202.30 in TPC 95 and hits 1
- RecoCol Time,Y,Z ( 1927.73, 513.40, 1594.85 )
- RecoInd0 Time,Y,Z ( 1927.96, 513.41, 1552.46 )
- RecoInd1 Time,Y,Z ( 1927.82, 513.38, 1611.58 )
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( 14.85, 513.46, 1594.32 )
- Main X,Y,Z ( 15.89, 513.65, 1595.07 )
- EDep X,Y,Z ( 15.12, 513.32, 1594.61 )
- Reco X,Y,Z ( -1000000.00, 513.40, 1594.85 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 20-Jan-2026 20:26:53 UTC run: 4787 subRun: 0 event: 647
[32m*** Matched preselection cluster: 4344 from 5773
- MainTrackID 133022
- Gen 1 -> marley TPC 95
- Purity 1.00 Hits 3
- Charge 270.91 ( MaxHit 175.60 )
- #AdjCl 7 ( 0 signal ):
- Cluster 3910 at distance 84.56 with time 2955.82 and charge 63.95 in TPC 91 and hits 1
- Cluster 4122 at distance 77.57 with time 3090.54 and charge 87.06 in TPC 91 and hits 1
- Cluster 4304 at distance 7.15 with time 3225.97 and charge 53.88 in TPC 93 and hits 2
- Cluster 4632 at distance 51.49 with time 3443.31 and charge 34.58 in TPC 93 and hits 1
- Cluster 4680 at distance 50.26 with time 3481.70 and charge 201.83 in TPC 85 and hits 1
- Cluster 4907 at distance 68.78 with time 3632.84 and charge 49.76 in TPC 83 and hits 2
- Cluster 4968 at distance 89.35 with time 3672.37 and charge 29.15 in TPC 89 and hits 1
- RecoCol Time,Y,Z ( 3249.91, -137.95, 1658.66 )
- RecoInd0 Time,Y,Z ( 3249.86, -927.77, 821.56 )
- RecoInd1 Time,Y,Z ( 3249.96, 651.87, 1668.89 )
*** Matched flash: 10192 from 18219
- Purity 0.00 % Plane 0 #Hits 8
- MainOpHitPE 14.30 (PE); TotalPE 55.65 vs expected 87.60 (PE)
- Time 496.11 (us) Fast 27.49 % Residual 21.77
- Reco Time,Y,Z ( 496.11, -89.46, 1633.27 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( 14.85, 513.46, 1594.32 )
- Main X,Y,Z ( -115.41, 722.26, 1651.94 )
- EDep X,Y,Z ( -96.92, 651.88, 1658.65 )
- Reco X,Y,Z ( -117.12, -137.95, 1658.66 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 20-Jan-2026 20:26:53 UTC run: 4787 subRun: 0 event: 647
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
20-Jan-2026 20:26:54 UTC Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/69/52/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250122T003921Z_gen_000647_supernova_g4stage1_g4stage2_detsim_reco_20250703T085250Z_reco2.root"
%MSG-i ProducerUtils: SolarNuAna:solarnuana@EndJob 20-Jan-2026 20:26:54 UTC ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG
====================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
====================================================================================================================
Full event 4176.36 4176.36 4176.36 4176.36 0 1
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00323234 0.00323234 0.00323234 0.00323234 0 1
end_path:solarnuana:SolarNuAna 4176.35 4176.35 4176.35 4176.35 0 1
====================================================================================================================
%MSG-i NuRandomService: SolarNuAna:solarnuana@EndJob 20-Jan-2026 20:26:54 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) : 3179.79 MB
Peak resident set size usage (VmHWM): 2550.51 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 1 passed = 1 failed = 0
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 1 1 0 solarnuana
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 4158.359730 Real = 4183.157689
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 3179.79 VmHWM = 2550.51
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===