justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 40579.0@dunegpschedd02.fnal.gov

Jobsub ID40579.0@dunegpschedd02.fnal.gov
Workflow ID2620
Stage ID1
User namesmanthey@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2025-09-16 19:26:15
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat2025-09-16 20:00:10
From worker nodeHostnamedunegli-6878107-0-fnpc17130.fnal.gov
cpuinfoIntel(R) Xeon(R) Gold 6140 CPU @ 2.30GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit172800 (48 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-09-16 19:27:13
Input filesfardet-hd:prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250207T085844Z_gen_001376_supernova_g4_detsim_reco_20250724T061958Z_reco2.root
JobscriptExit code0
Real time32m (1961s)
CPU time32m (1927s = 98%)
Max RSS bytes912969728 (870 MiB)
Outputting started2025-09-16 19:59:54
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/smanthey/ana/solar_ana_marley_flash_radiological_decay0_dune10kt_1x2x6_centralAPA/fnal/02620/1/001/fdhd_ana_2025-09-16T_192729Z_hist.root
Finished2025-09-16 20:00:10
Saved logsjustin-logs:40579.0-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

y	1000180400	0.03	(290.60, -51.05, 628.04)	32882	32841
marley	1000180400	0.02	(279.81, -19.86, 610.19)	32881	32841
marley	1000180360	0.03	(292.98, -13.76, 623.25)	32880	32841
marley	22		6.34	(292.09, -12.47, 611.42)	32842	0
marley	2112		0.34	(292.09, -12.47, 611.42)	32841	0
marley	1000190390	0.02	(292.09, -12.47, 611.42)	32840	0
marley	11		33.98	(292.09, -12.47, 611.42)	32839	0
Signal Track IDs: 32839; 32840; 32841; 32842; 32880; 32881; 32882; 32883; 32884; 32885; 32886; 32887; 32888; 32889; 32890; 32891; 32892; 32893; 32894; 32895; 32896; 32897; 32898; 32899; 32900; 32902; 32903; 32904; 32905; 32906; 32907; 32908; 32909; 32910; 32911; 32912; 32913; 32915; 32916; 32918; 32920; 32923; 32925; 32932; 32982; 32983; 32984; 32985; 32987; 32988; 32989; 32990; 
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  16-Sep-2025 19:59:26 UTC run: 5089 subRun: 0 event: 68800
OpFlash PE 65.29 with purity 0.19 time -0.09 plane 0
 - Vertex (-0.05, -93.41, 1197.07)
	*** 1st Sanity check: Ratio 0.95 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 263.33 with purity 0.98 time 0.01 plane 0
 - Vertex (-0.05, -116.81, 568.13)
	*** 1st Sanity check: Ratio 0.05 <= 1.00
	*** 2nd Sanity check: #OpHits 65 >= 65
OpFlash PE 133.77 with purity 0.82 time 0.00 plane 1
 - Vertex (0.05, 31.14, 1076.28)
	*** 1st Sanity check: Ratio 0.27 <= 1.00
	*** 2nd Sanity check: #OpHits 32 >= 32
OpFlash PE 25.98 with purity 0.67 time 0.01 plane 0
 - Vertex (-0.05, -188.78, 1248.61)
	*** 1st Sanity check: Ratio 0.53 <= 1.00
	*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 48.75 with purity 0.93 time 0.02 plane 1
 - Vertex (0.05, 129.48, 605.32)
	*** 1st Sanity check: Ratio 0.14 <= 1.00
	*** 2nd Sanity check: #OpHits 16 >= 16
OpFlash PE 66.09 with purity 0.71 time 0.02 plane 0
 - Vertex (-0.05, -591.57, 499.90)
	*** 1st Sanity check: Ratio 0.57 <= 1.00
	*** 2nd Sanity check: #OpHits 12 >= 12
OpFlash PE 52.61 with purity 0.97 time 0.03 plane 0
 - Vertex (-0.05, -156.66, 749.49)
	*** 1st Sanity check: Ratio 0.16 <= 1.00
	*** 2nd Sanity check: #OpHits 20 >= 20
OpFlash PE 28.93 with purity 0.86 time 0.04 plane 1
 - Vertex (0.05, 159.70, 566.17)
	*** 1st Sanity check: Ratio 0.21 <= 1.00
	*** 2nd Sanity check: #OpHits 11 >= 11
OpFlash PE 22.19 with purity 0.61 time 0.07 plane 0
 - Vertex (-0.05, -209.14, 562.83)
	*** 1st Sanity check: Ratio 0.25 <= 1.00
	*** 2nd Sanity check: #OpHits 9 >= 9
OpFlash PE 9.09 with purity 0.46 time 0.06 plane 1
 - Vertex (0.05, 225.48, 960.03)
	*** 1st Sanity check: Ratio 0.35 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 10.39 with purity 0.36 time 0.06 plane 1
 - Vertex (0.05, 160.11, 161.64)
	*** 1st Sanity check: Ratio 0.46 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 47.31 with purity 0.46 time 0.10 plane 1
 - Vertex (0.05, 217.95, 548.70)
	*** 1st Sanity check: Ratio 0.92 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 43.63 with purity 0.42 time 0.11 plane 0
 - Vertex (-0.05, -187.86, 708.03)
	*** 1st Sanity check: Ratio 0.24 <= 1.00
	*** 2nd Sanity check: #OpHits 12 >= 12
OpFlash PE 32.26 with purity 0.45 time 0.12 plane 0
 - Vertex (-0.05, -217.95, 732.29)
	*** 1st Sanity check: Ratio 0.45 <= 1.00
	*** 2nd Sanity check: #OpHits 9 >= 9
OpFlash PE 39.83 with purity 0.43 time 0.15 plane 0
 - Vertex (-0.05, -93.41, 964.68)
	*** 1st Sanity check: Ratio 0.85 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 24.41 with purity 0.87 time 6.38 plane 1
 - Vertex (0.05, 310.93, 828.97)
	*** 1st Sanity check: Ratio 0.11 <= 1.00
	*** 2nd Sanity check: #OpHits 12 >= 12
OpFlash PE 5.80 with purity 1.00 time 6.38 plane 0
 - Vertex (-0.05, -207.10, 410.41)
	*** 1st Sanity check: Ratio 0.36 <= 1.00
	*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 8.60 with purity 0.75 time 6.44 plane 1
 - Vertex (0.05, 243.80, 873.84)
	*** 1st Sanity check: Ratio 0.35 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 77.33 with purity 0.06 time 6.46 plane 1
 - Vertex (0.05, 44.14, 1056.42)
	*** 1st Sanity check: Ratio 0.21 <= 1.00
	*** 2nd Sanity check: #OpHits 19 >= 19
OpFlash PE 39.23 with purity 0.24 time 6.47 plane 1
 - Vertex (0.05, 93.41, 775.68)
	*** 1st Sanity check: Ratio 0.36 <= 1.00
	*** 2nd Sanity check: #OpHits 9 >= 9
OpFlash PE 122.79 with purity 0.07 time 6.47 plane 0
 - Vertex (-0.05, -176.96, 1157.32)
	*** 1st Sanity check: Ratio 0.24 <= 1.00
	*** 2nd Sanity check: #OpHits 30 >= 30
OpFlash PE 15.56 with purity 0.27 time 6.53 plane 1
 - Vertex (0.05, 93.41, 1076.28)
	*** 1st Sanity check: Ratio 0.54 <= 1.00
	*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 46.65 with purity 0.22 time 6.55 plane 1
 - Vertex (0.05, 529.30, 1308.67)
	*** 1st Sanity check: Ratio 0.88 <= 1.00
	*** 2nd Sanity check: #OpHits 4 >= 4

# of OpFlashes (solarflash) in full geometry: 2305

%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  16-Sep-2025 19:59:26 UTC run: 5089 subRun: 0 event: 68800

# OpHits (ophitspe) in full geometry: 72754
# OpFlashes (solarflash) in full geometry: 2305
# Hits (hitfd) in each view: 247, 240, 559, 0
# Cluster from the hits: 149, 141, 485, 0
# Tracks (pmtracktc) in full geometry: 2
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  16-Sep-2025 19:59:53 UTC run: 5089 subRun: 0 event: 68800

# ClusterReco: Looping over 310 matched clusters
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  16-Sep-2025 19:59:53 UTC run: 5089 subRun: 0 event: 68800
*** Matched preselection cluster: 202
 - MainTrackID 32839
 - Gen 1 -> marley TPC 9
 - Purity 1.00 Hits 19
 - Charge 2816.64 ( MaxHit 302.84 )
 - #AdjCl 5 ( 5 signal ):
    - Cluster 186 at distance 83.43 with time 1612.70 and charge 182.00 in TPC 9 and hits 1
    - Cluster 194 at distance 45.88 with time 1694.42 and charge 128.76 in TPC 9 and hits 1
    - Cluster 196 at distance 36.42 with time 1713.17 and charge 94.62 in TPC 9 and hits 1
    - Cluster 198 at distance 21.77 with time 1745.28 and charge 74.81 in TPC 9 and hits 1
    - Cluster 219 at distance 33.36 with time 1923.61 and charge 554.87 in TPC 11 and hits 2
 - RecoCol  Time,Y,Z ( 1793.78, -14.81, 616.06 )
 - RecoInd0 Time,Y,Z ( 1793.74, -14.71, 545.35 )
 - RecoInd1 Time,Y,Z ( 1793.84, -14.91, 650.70 )
*** Matched flash: 
 - Purity 0.00 Plane 0 #Hits 31 PE 421.15 MaxPE 177.63
 - Time -29.77 Fast 0.90 Residual 18487.80
 - Reco Time,Y,Z ( -29.77, -31.14, 519.24 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( 292.09, -12.47, 611.42 )
 - Main X,Y,Z ( 290.98, -16.35, 619.53 )
 - EDep X,Y,Z ( 290.22, -16.18, 619.02 )
 - Reco X,Y,Z ( 292.79, -14.81, 616.06 )
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  16-Sep-2025 19:59:53 UTC run: 5089 subRun: 0 event: 68800
*** Matched preselection cluster: 273
 - MainTrackID 32982
 - Gen 1 -> marley TPC 15
 - Purity 1.00 Hits 2
 - Charge 245.23 ( MaxHit 162.05 )
 - #AdjCl 2 ( 2 signal ):
    - Cluster 259 at distance 36.67 with time 2303.30 and charge 149.36 in TPC 15 and hits 1
    - Cluster 265 at distance 25.56 with time 2329.43 and charge 178.32 in TPC 15 and hits 2
 - RecoCol  Time,Y,Z ( 2451.04, 200.56, 793.41 )
 - RecoInd0 Time,Y,Z ( 2450.87, 200.46, 812.49 )
 - RecoInd1 Time,Y,Z ( 2450.98, 200.66, 812.49 )
*** Reconstructed Interaction Vertex: 
 - True X,Y,Z ( 292.09, -12.47, 611.42 )
 - Main X,Y,Z ( 313.68, 208.29, 807.39 )
 - EDep X,Y,Z ( 332.69, 200.49, 793.35 )
 - Reco X,Y,Z ( -1000000.00, 200.56, 793.41 )
%MSG
%MSG-i ProducerUtils:  SolarNuAna:solarnuana@BeginModule  16-Sep-2025 19:59:53 UTC run: 5089 subRun: 0 event: 68800
-----------------------------------------------------------------------------------------

%MSG
16-Sep-2025 19:59:53 UTC  Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/5f/04/prodmarley_nue_cc_flat_radiological_decay0_dune10kt_1x2x6_centralAPA_20250207T085844Z_gen_001376_supernova_g4_detsim_reco_20250724T061958Z_reco2.root"

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
Full event                          30.121        37.3164       49.4552       36.2133       4.83648        50     
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read)            0.00162842    0.00482357     0.056684     0.00222733    0.00891738       50     
end_path:solarnuana:SolarNuAna      30.1192       37.3113       49.453        36.2108       4.83698        50     
====================================================================================================================
%MSG-i NuRandomService:  SolarNuAna:solarnuana@EndJob 16-Sep-2025 19:59:53 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)  : 1553.5 MB
  Peak resident set size usage (VmHWM): 909.758 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 = 1890.047156 Real = 1914.288960

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 1553.5 VmHWM = 909.758

Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
lar exit code 0
justIN time: 2025-09-19 07:53:47 UTC       justIN version: 01.05.00