Jobsub ID 294217.1@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
na:solarnuana@BeginModule 23-Jan-2026 13:07:19 UTC run: 5031 subRun: 0 event: 46620
[36m
# OpHits (ophit10ppm) in full geometry: 53466
# OpFlashes (solarflash) in full geometry: 18378
# Hits (gaushit) in each view: 6891, 6910, 6789, 0
# Cluster from the hits: 2865, 2941, 5762, 0
# Tracks (pmtracktc) in full geometry: 476[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 23-Jan-2026 13:41:54 UTC run: 5031 subRun: 0 event: 46620
[32m
# ClusterReco: Looping over 5753 matched clusters[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 23-Jan-2026 13:41:54 UTC run: 5031 subRun: 0 event: 46620
[32m*** Matched preselection cluster: 3841 from 5753
- MainTrackID 133405
- Gen 1 -> marley TPC 19
- Purity 1.00 Hits 3
- Charge 411.20 ( MaxHit 238.42 )
- #AdjCl 13 ( 4 signal ):
- Cluster 3246 at distance 95.76 with time 2461.32 and charge 29.69 in TPC 31 and hits 1
- Cluster 3529 at distance 90.21 with time 2679.15 and charge 72.47 in TPC 19 and hits 1
- Cluster 3593 at distance 46.37 with time 2728.31 and charge 303.94 in TPC 19 and hits 3
- Cluster 3611 at distance 61.66 with time 2741.88 and charge 51.81 in TPC 19 and hits 1
- Cluster 3696 at distance 94.30 with time 2809.27 and charge 23.11 in TPC 29 and hits 1
- Cluster 3790 at distance 37.43 with time 2867.93 and charge 161.77 in TPC 27 and hits 2
- Cluster 3795 at distance 12.28 with time 2869.20 and charge 67.83 in TPC 19 and hits 2
- Cluster 3849 at distance 18.82 with time 2901.56 and charge 190.89 in TPC 19 and hits 3
- Cluster 3875 at distance 15.30 with time 2917.72 and charge 144.79 in TPC 19 and hits 2
- Cluster 4182 at distance 95.48 with time 3116.57 and charge 201.22 in TPC 19 and hits 3
- Cluster 4215 at distance 70.34 with time 3133.22 and charge 42.81 in TPC 27 and hits 1
- Cluster 4334 at distance 98.35 with time 3222.86 and charge 40.60 in TPC 23 and hits 1
- Cluster 4428 at distance 95.66 with time 3280.02 and charge 48.75 in TPC 31 and hits 2
- RecoCol Time,Y,Z ( 2896.78, -41.12, 435.76 )
- RecoInd0 Time,Y,Z ( 2896.84, -41.85, 406.15 )
- RecoInd1 Time,Y,Z ( 2898.19, -40.38, 373.80 )
*** Matched flash: 9815 from 18378
- Purity 40.78 % Plane 0 #Hits 30
- MainOpHitPE 40.24 (PE); TotalPE 430.97 vs expected 96.89 (PE)
- Time 286.45 (us) Fast 9.57 % Residual 890.43
- Reco Time,Y,Z ( 286.45, -43.19, 416.06 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -286.27, 487.20, 331.33 )
- Main X,Y,Z ( -100.31, -52.36, 414.53 )
- EDep X,Y,Z ( -94.32, -41.63, 435.93 )
- Reco X,Y,Z ( -94.09, -41.12, 435.76 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 23-Jan-2026 13:41:54 UTC run: 5031 subRun: 0 event: 46620
[32m*** Matched preselection cluster: 3912 from 5753
- MainTrackID 133406
- Gen 1 -> marley TPC 19
- Purity 1.00 Hits 2
- Charge 74.27 ( MaxHit 42.86 )
- #AdjCl 7 ( 1 signal ):
- Cluster 3833 at distance 58.81 with time 2893.01 and charge 38.69 in TPC 19 and hits 1
- Cluster 4173 at distance 84.84 with time 3111.76 and charge 25.00 in TPC 17 and hits 1
- Cluster 4285 at distance 50.21 with time 3189.50 and charge 27.07 in TPC 23 and hits 1
- Cluster 4387 at distance 57.67 with time 3250.82 and charge 64.24 in TPC 25 and hits 1
- Cluster 4435 at distance 94.99 with time 3283.90 and charge 31.45 in TPC 23 and hits 1
- Cluster 4541 at distance 94.32 with time 3361.57 and charge 26.26 in TPC 29 and hits 1
- Cluster 4559 at distance 93.11 with time 3373.37 and charge 39.50 in TPC 29 and hits 1
- RecoCol Time,Y,Z ( 2939.77, 114.88, 442.69 )
- RecoInd0 Time,Y,Z ( 2939.82, -42.65, 408.91 )
- RecoInd1 Time,Y,Z ( 2941.56, 272.40, 74.96 )
*** Matched flash: 8576 from 18378
- Purity 0.00 % Plane 0 #Hits 9
- MainOpHitPE 50.15 (PE); TotalPE 129.09 vs expected 101.18 (PE)
- Time -277.29 (us) Fast 39.62 % Residual 391.01
- Reco Time,Y,Z ( -277.29, 38.00, 484.26 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -286.27, 487.20, 331.33 )
- Main X,Y,Z ( -100.31, -52.36, 414.53 )
- EDep X,Y,Z ( -97.50, -49.27, 423.34 )
- Reco X,Y,Z ( -191.51, 114.88, 442.69 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 23-Jan-2026 13:41:54 UTC run: 5031 subRun: 0 event: 46620
[32m*** Matched preselection cluster: 3922 from 5753
- MainTrackID 133406
- Gen 1 -> marley TPC 19
- Purity 1.00 Hits 2
- Charge 92.66 ( MaxHit 75.08 )
- #AdjCl 8 ( 0 signal ):
- Cluster 3209 at distance 99.90 with time 2433.41 and charge 48.71 in TPC 17 and hits 2
- Cluster 3339 at distance 78.17 with time 2524.84 and charge 44.60 in TPC 31 and hits 1
- Cluster 3438 at distance 78.32 with time 2607.49 and charge 39.12 in TPC 27 and hits 1
- Cluster 3567 at distance 97.44 with time 2710.61 and charge 25.39 in TPC 29 and hits 1
- Cluster 3899 at distance 16.01 with time 2937.19 and charge 21.54 in TPC 31 and hits 1
- Cluster 3902 at distance 95.05 with time 2937.59 and charge 25.60 in TPC 23 and hits 1
- Cluster 4428 at distance 93.74 with time 3280.02 and charge 48.75 in TPC 31 and hits 2
- Cluster 4560 at distance 83.66 with time 3373.62 and charge 32.71 in TPC 27 and hits 1
- RecoCol Time,Y,Z ( 2947.15, -157.37, 446.89 )
- RecoInd0 Time,Y,Z ( 2947.27, -37.91, 415.12 )
- RecoInd1 Time,Y,Z ( 2948.73, -276.83, 1419.24 )
*** Matched flash: 12049 from 18378
- Purity 0.00 % Plane 0 #Hits 9
- MainOpHitPE 20.48 (PE); TotalPE 107.49 vs expected 19.80 (PE)
- Time 1334.17 (us) Fast 19.99 % Residual 45.42
- Reco Time,Y,Z ( 1334.17, -150.86, 386.09 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -286.27, 487.20, 331.33 )
- Main X,Y,Z ( -100.31, -52.36, 414.53 )
- EDep X,Y,Z ( -97.50, -49.27, 423.34 )
- Reco X,Y,Z ( 66.05, -157.37, 446.89 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 23-Jan-2026 13:41:54 UTC run: 5031 subRun: 0 event: 46620
[32m*** Matched preselection cluster: 5143 from 5753
- MainTrackID 133143
- Gen 1 -> marley TPC 22
- Purity 1.00 Hits 9
- Charge 1366.57 ( MaxHit 294.78 )
- #AdjCl 5 ( 1 signal ):
- Cluster 4977 at distance 22.01 with time 3679.20 and charge 211.55 in TPC 22 and hits 1
- Cluster 5020 at distance 89.66 with time 3712.11 and charge 61.34 in TPC 22 and hits 1
- Cluster 5109 at distance 37.17 with time 3774.14 and charge 34.03 in TPC 20 and hits 1
- Cluster 5223 at distance 29.11 with time 3865.82 and charge 200.98 in TPC 22 and hits 2
- Cluster 5231 at distance 74.55 with time 3871.26 and charge 34.93 in TPC 22 and hits 1
- RecoCol Time,Y,Z ( 3803.32, 485.05, 332.63 )
- RecoInd0 Time,Y,Z ( 3803.54, 485.04, 373.96 )
- RecoInd1 Time,Y,Z ( 3803.35, 485.06, 332.97 )
*** Matched flash: 9177 from 18378
- Purity 8.19 % Plane 0 #Hits 23
- MainOpHitPE 1056.85 (PE); TotalPE 2765.57 vs expected 849.64 (PE)
- Time -0.00 (us) Fast 42.81 % Residual 380806.34
- Reco Time,Y,Z ( -0.00, 464.10, 338.26 )
- Found valid waveform: true
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -286.27, 487.20, 331.33 )
- Main X,Y,Z ( -285.02, 483.58, 334.44 )
- EDep X,Y,Z ( -285.57, 484.81, 332.65 )
- Reco X,Y,Z ( -285.64, 485.05, 332.63 )[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 23-Jan-2026 13:41:54 UTC run: 5031 subRun: 0 event: 46620
[32m-----------------------------------------------------------------------------------------
[0m
%MSG
23-Jan-2026 13:41:54 UTC Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/1d/1e/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250203T073211Z_gen_004662_supernova_g4stage1_g4stage2_detsim_reco_20250702T003223Z_reco2.root"
%MSG-i ProducerUtils: SolarNuAna:solarnuana@EndJob 23-Jan-2026 13:41:54 UTC ModuleEndJob
[35mFinished running the SolarNuAna module[0m
%MSG
====================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
====================================================================================================================
Full event 0.613174 1236.76 2987.7 1065.2 1258.41 10
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000750889 0.00823365 0.0174702 0.00823139 0.00615115 10
end_path:solarnuana:SolarNuAna 0.599028 1236.75 2987.7 1065.19 1258.41 10
====================================================================================================================
%MSG-i NuRandomService: SolarNuAna:solarnuana@EndJob 23-Jan-2026 13:41: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) : 3193.12 MB
Peak resident set size usage (VmHWM): 2566.84 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 = 12275.598728 Real = 12399.758165
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 3193.12 VmHWM = 2566.84
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===