Jobsub ID 272873.1@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
80400 0.00 (-212.38, 250.46, 453.51) 33029 33018
marley 1000180400 0.00 (-215.25, 248.10, 454.43) 33028 33018
marley 1000180400 0.01 (-218.57, 247.89, 453.79) 33027 33018
marley 1000180400 0.00 (-217.14, 248.90, 451.99) 33026 33018
marley 1000180400 0.01 (-223.43, 266.27, 446.41) 33025 33018
marley 1000180400 0.01 (-225.20, 264.63, 448.42) 33024 33018
marley 1000180400 0.01 (-221.96, 270.20, 457.55) 33023 33018
marley 1000180360 0.00 (-218.62, 261.05, 442.09) 33022 33018
marley 1000180400 0.00 (-219.72, 282.85, 398.76) 33021 33018
marley 1000180400 0.00 (-102.24, 331.64, 300.34) 33020 33018
marley 1000180400 0.01 (0.10, 334.65, 215.84) 33019 33018
marley 2112 0.14 (-42.38, 345.31, 178.09) 33018 0
marley 1000190390 0.03 (-42.38, 345.31, 178.09) 33017 0
marley 11 18.56 (-42.38, 345.31, 178.09) 33016 0
Signal Track IDs: 33016; 33017; 33018; 33019; 33020; 33021; 33022; 33023; 33024; 33025; 33026; 33027; 33028; 33029; 33030; 33031; 33032; 33033; 33034; 33035; 33036; 33037; 33038; 33039; 33109; 33110; [0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 08-Jan-2026 20:08:18 UTC run: 5089 subRun: 0 event: 110250
[33m
Kinetic energy of signal particle is below threshold of 30.00 MeV. Selecting event.
[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 08-Jan-2026 20:08:23 UTC run: 5089 subRun: 0 event: 110250
[34mOpFlash PE 47.15 with purity 0.44 time -32.03 plane 0
- Vertex (0.05, 258.81, 350.98)
*** 1st Sanity check: Ratio 0.55 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 3.60 with purity 0.24 time -18.73 plane 0
- Vertex (-0.05, -31.14, 204.43)
*** 1st Sanity check: Ratio 0.52 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 841.01 with purity 0.89 time -18.07 plane 0
- Vertex (0.05, 342.49, 173.05)
*** 1st Sanity check: Ratio 0.30 <= 1.00
*** 2nd Sanity check: #OpHits 47 >= 47
OpFlash PE 40.26 with purity 1.00 time -17.55 plane 0
- Vertex (0.05, 323.08, 169.89)
*** 1st Sanity check: Ratio 0.28 <= 1.00
*** 2nd Sanity check: #OpHits 8 >= 8
OpFlash PE 76.95 with purity 0.74 time -16.90 plane 0
- Vertex (0.05, 303.35, 332.20)
*** 1st Sanity check: Ratio 0.21 <= 1.00
*** 2nd Sanity check: #OpHits 15 >= 15
OpFlash PE 67.92 with purity 0.44 time -16.52 plane 0
- Vertex (0.05, 529.30, 660.30)
*** 1st Sanity check: Ratio 0.64 <= 1.00
*** 2nd Sanity check: #OpHits 10 >= 10
OpFlash PE 19.99 with purity 0.49 time -16.07 plane 0
- Vertex (0.05, 390.88, 404.41)
*** 1st Sanity check: Ratio 0.27 <= 1.00
*** 2nd Sanity check: #OpHits 7 >= 7
OpFlash PE 3.92 with purity 0.49 time -15.74 plane 0
- Vertex (-0.00, -95.31, 605.07)
*** 1st Sanity check: Ratio 0.51 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 23.32 with purity 1.00 time -15.48 plane 0
- Vertex (0.05, 377.69, 122.81)
*** 1st Sanity check: Ratio 0.31 <= 1.00
*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 14.02 with purity 1.00 time -15.09 plane 0
- Vertex (0.05, 327.46, 250.57)
*** 1st Sanity check: Ratio 0.40 <= 1.00
*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 17.79 with purity 0.21 time -14.51 plane 0
- Vertex (0.05, 529.30, 660.30)
*** 1st Sanity check: Ratio 0.71 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 6.92 with purity 0.64 time -13.89 plane 0
- Vertex (0.05, 329.06, 298.91)
*** 1st Sanity check: Ratio 0.46 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 20.23 with purity 0.83 time -13.27 plane 0
- Vertex (0.05, 342.49, 146.72)
*** 1st Sanity check: Ratio 0.58 <= 1.00
*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 95.93 with purity 0.74 time -12.47 plane 0
- Vertex (0.05, 342.49, 83.92)
*** 1st Sanity check: Ratio 0.97 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 5.98 with purity 0.50 time -12.12 plane 0
- Vertex (0.05, 226.07, 301.46)
*** 1st Sanity check: Ratio 0.70 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 9.54 with purity 0.91 time -11.23 plane 0
- Vertex (0.05, 342.49, 195.52)
*** 1st Sanity check: Ratio 0.82 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 75.25 with purity 0.33 time -10.40 plane 0
- Vertex (0.05, 280.22, 267.51)
*** 1st Sanity check: Ratio 0.98 <= 1.00
*** 2nd Sanity check: #OpHits 2 >= 2
OpFlash PE 1.64 with purity 0.33 time -9.76 plane 0
- Vertex (0.05, 342.49, 195.52)
*** 1st Sanity check: Ratio 1.00 <= 1.00
*** 2nd Sanity check: #OpHits 1 >= 1
OpFlash PE 35.42 with purity 0.84 time -7.77 plane 0
- Vertex (0.05, 280.22, 83.92)
*** 1st Sanity check: Ratio 0.84 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
# of OpHits (ophitspe): 70910 for times between -2262.43 us and 2225.36 us.
# of OpFlashes (solarflash): 9684 for times between -2262.43 us and 2225.28 us.
[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 08-Jan-2026 20:08:23 UTC run: 5089 subRun: 0 event: 110250
[36m
# OpHits (ophitspe) in full geometry: 70910
# OpFlashes (solarflash) in full geometry: 9684
# Hits (hitfd) in each view: 204, 204, 469, 0
# Cluster from the hits: 125, 126, 435, 0
# Tracks (pmtracktc) in full geometry: 2[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 08-Jan-2026 20:08:38 UTC run: 5089 subRun: 0 event: 110250
[32m
# ClusterReco: Looping over 269 matched clusters[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 08-Jan-2026 20:08:38 UTC run: 5089 subRun: 0 event: 110250
[32m*** Matched preselection cluster: 5 from 269
- MainTrackID 33016
- Gen 1 -> marley TPC 3
- Purity 1.00 Hits 1
- Charge 43.53 ( MaxHit 43.53 )
- #AdjCl 0 ( 0 signal ):
- RecoCol Time,Y,Z ( 15.15, -599.02, 150.05 )
- RecoInd0 Time,Y,Z ( 8.37, 885.35, 1189.87 )
- RecoInd1 Time,Y,Z ( 8.48, -2083.39, 1304.31 )
*** Matched flash: 227 from 9684
- Purity 0.00 % Plane 0 #Hits 3
- MainOpHitPE 6.41 (PE); TotalPE 10.18 vs expected 15.73 (PE)
- Time -2168.67 (us) Fast 72.79 % Residual 12.01
- Reco Time,Y,Z ( -2168.67, -577.10, 109.85 )
- Found valid waveform: false
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -42.38, 345.31, 178.09 )
- Main X,Y,Z ( -38.04, 343.66, 177.03 )
- EDep X,Y,Z ( -40.36, 343.88, 177.73 )
- Reco X,Y,Z ( 350.64, -599.02, 150.05 )[0m
%MSG
Selecting flash with PE 841.013 closer to predicted PE 1120.44 than reference flash PE 14.21 predicted PE 111.704
The differences are 0.332247 and 6.86095
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 08-Jan-2026 20:08:38 UTC run: 5089 subRun: 0 event: 110250
[32m*** Matched preselection cluster: 26 from 269
- MainTrackID 33016
- Gen 1 -> marley TPC 2
- Purity 1.00 Hits 5
- Charge 2327.18 ( MaxHit 668.88 )
- #AdjCl 1 ( 1 signal ):
- Cluster 11 at distance 29.93 with time 102.69 and charge 83.68 in TPC 2 and hits 1
- RecoCol Time,Y,Z ( 228.94, 343.95, 177.44 )
- RecoInd0 Time,Y,Z ( 229.97, 344.03, 115.32 )
- RecoInd1 Time,Y,Z ( 227.96, 343.87, 115.32 )
*** Matched flash: 4754 from 9684
- Purity 88.74 % Plane 0 #Hits 47
- MainOpHitPE 249.31 (PE); TotalPE 841.01 vs expected 1120.44 (PE)
- Time -18.07 (us) Fast 73.93 % Residual 360.81
- Reco Time,Y,Z ( -18.07, 342.49, 173.05 )
- Found valid waveform: false
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -42.38, 345.31, 178.09 )
- Main X,Y,Z ( -38.04, 343.66, 177.03 )
- EDep X,Y,Z ( -40.36, 343.88, 177.73 )
- Reco X,Y,Z ( -39.66, 343.95, 177.44 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 08-Jan-2026 20:08:38 UTC run: 5089 subRun: 0 event: 110250
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
08-Jan-2026 20:08:38 UTC Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/31/5c/prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250207T130847Z_gen_002205_supernova_g4_detsim_reco_20250724T031123Z_reco2.root"
%MSG-i ProducerUtils: SolarNuAna:solarnuana@EndJob 08-Jan-2026 20:08:38 UTC ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG
====================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
====================================================================================================================
Full event 0.220903 9.26201 23.9909 0.340293 10.1749 50
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000912226 0.00562039 0.205419 0.00155356 0.028544 50
end_path:solarnuana:SolarNuAna 0.218791 9.25626 23.9888 0.338955 10.1702 50
====================================================================================================================
%MSG-i NuRandomService: SolarNuAna:solarnuana@EndJob 08-Jan-2026 20:08: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) : 1551.33 MB
Peak resident set size usage (VmHWM): 907.125 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 50 passed = 50 failed = 0
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 50 50 0 solarnuana
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 486.435503 Real = 497.859920
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 1551.33 VmHWM = 907.125
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===