Jobsub ID 12985.0@dunegpschedd02.fnal.gov
Jobsub ID | 12985.0@dunegpschedd02.fnal.gov |
Workflow ID | 159 |
Stage ID | 1 |
User name | smanthey@fnal.gov |
HTCondor Group | group_dune |
Requested | Processors | 1 |
GPU | No |
RSS bytes | 4194304000 (4000 MiB) |
Wall seconds limit | 80000 (22 hours) |
Submitted time | 2025-07-30 19:32:56 |
Site | CERN |
Entry | CMSHTPC_T2_CH_CERN_ce513 |
Last heartbeat | 2025-07-30 21:50:38 |
From worker node | Hostname | b9p10p7069.cern.ch |
cpuinfo | AMD EPYC 7543 32-Core Processor |
OS release | Scientific Linux release 7.9 (Nitrogen) |
Processors | 1 |
RSS bytes | 4194304000 (4000 MiB) |
Wall seconds limit | 343800 (95 hours) |
GPU | |
Inner Apptainer? | True |
Job state | finished |
Started | 2025-07-30 19:35:09 |
Input files | usertests:fdvd_lowBg_reco2_2025-05-12T_080706Z.root
|
Jobscript | Exit code | 0 |
Real time | 2h (8106s) |
CPU time | 2h (7940s = 97%) |
Max RSS bytes | 1362042880 (1298 MiB) |
Outputting started | 2025-07-30 21:50:15 |
Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/smanthey/ana/solar_ana_marley_flash_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_optimistic/fnal/00159/1/001/fdhd_ana_2025-07-30T_193520Z_hist.root
|
Finished | 2025-07-30 21:50:38 |
Saved logs | justin-logs:12985.0-dunegpschedd02.fnal.gov.logs.tgz |
List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
teraction Vertex:
- True X,Y,Z ( -189.02, -260.16, 1414.64 )
- Reco X,Y,Z ( -191.84, -266.69, 1418.25 )[0m
%MSG
Begin processing the 10th record. run: 20000047 subRun: 0 event: 10 at 30-Jul-2025 23:35:01 CEST
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 30-Jul-2025 23:35:02 CEST run: 20000047 subRun: 0 event: 10
[35m
#########################################
Event: 10 Flag: 728805995
TPC Map: 113 TPCs found
TPC Frequency in [MHz]: 2.00
TPC Tick in [us]: 0.50
TPC DriftLength in [cm]: 650.07
TPC DriftTime in [us]: 4048.69
#########################################[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 30-Jul-2025 23:35:03 CEST run: 20000047 subRun: 0 event: 10
[91m
There are a total of 76513 Particles in the event
# of particles 7 from gen 1 marley
# of particles 30754 from gen 2 Ar39GenInLAr
# of particles 3621 from gen 3 Kr85GenInLAr
# of particles 2 from gen 4 Ar42GenInLAr
# of particles 2 from gen 5 K42From42ArGenInLAr
# of particles 34 from gen 6 Rn222ChainRn222GenInLAr
# of particles 29 from gen 7 Rn222ChainPo218GenInLAr
# of particles 67 from gen 8 Rn222ChainPb214GenInLAr
# of particles 45 from gen 9 Rn222ChainBi214GenInLAr
# of particles 42 from gen 10 Rn222ChainPb210GenInLAr
# of particles 31 from gen 11 Rn220ChainPb212GenInLAr
# of particles 218 from gen 12 K40GenInCathode
# of particles 3176 from gen 13 U238ChainGenInCathode
# of particles 3568 from gen 14 Th232ChainGenInCathode
# of particles 107 from gen 15 K40GenInAnode
# of particles 1350 from gen 16 U238ChainGenInAnode
# of particles 1712 from gen 17 Th232ChainGenInAnode
# of particles 0 from gen 18 Rn222ChainGenInPDS
# of particles 1 from gen 19 K42From42ArGenInUpperMesh
# of particles 2 from gen 20 Rn222ChainFromPo218GenInUpperMesh
# of particles 17 from gen 21 Rn222ChainFromPb214GenInUpperMesh
# of particles 46 from gen 22 Rn222ChainFromBi214GenInUpperMesh
# of particles 43 from gen 23 Rn222ChainFromPb210GenInUpperMesh
# of particles 47 from gen 24 Rn222ChainFromBi210GenInUpperMesh
# of particles 38 from gen 25 Rn220ChainFromPb212GenInUpperMesh
# of particles 28057 from gen 26 CavernwallGammasAtLAr
# of particles 3497 from gen 27 foamGammasAtLAr
# of particles 0 from gen 28 CavernwallNeutronsAtLAr
# of particles 0 from gen 29 CryostatNGammasAtLAr
# of particles 0 from gen 30 CavernNGammasAtLAr[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 30-Jul-2025 23:35:03 CEST run: 20000047 subRun: 0 event: 10
[33m
Number of Signal Particles: 6
Neutrino Interaction: -1
Neutrino Energy: 61.85 MeV
Position (-104.47, -238.29, 507.24) cm
Gen. PdgCode Energy EndPosition Mother
------------------------------------------------------------------------
marley 11 1.28 (-104.49, -238.21, 507.35) 76505
marley -12 0.54 (1222.89, -5033.92, 1294.97) 76505
marley 1000200400 37214.71 (-104.47, -238.29, 507.24) 76505
marley 22 2.04 (-91.81, -232.34, 502.40) 0
marley 22 2.46 (-101.79, -234.00, 529.72) 0
marley 1000190400 37216.67 (-104.47, -238.29, 507.24) 0
marley 11 56.22 (-91.68, -227.66, 505.75) 0
Signal Track IDs: 76504; 76505; 76506; 76507; 76549; 76550; 76551; [0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 30-Jul-2025 23:35:06 CEST run: 20000047 subRun: 0 event: 10
[34mOpFlash PE 34.82 with purity 0.00 time -3.00 plane 4
- Vertex (238.24, 220.00, -96.50)
*** 1st Sanity check: Ratio 0.31 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 36.71 with purity 0.09 time 0.81 plane 0
- Vertex (-327.50, 221.24, 972.97)
*** 1st Sanity check: Ratio 0.34 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
OpFlash PE 79.14 with purity 0.31 time 1.12 plane 0
- Vertex (-327.50, 466.39, 394.21)
*** 1st Sanity check: Ratio 0.21 <= 1.00
*** 2nd Sanity check: #OpHits 7 >= 7
OpFlash PE 1764.01 with purity 0.21 time 1.36 plane 0
- Vertex (-327.50, -206.82, 473.12)
*** 1st Sanity check: Ratio 0.10 <= 1.00
*** 2nd Sanity check: #OpHits 25 >= 25
OpFlash PE 322.80 with purity 0.13 time 1.21 plane 0
- Vertex (-327.50, -88.16, 594.72)
*** 1st Sanity check: Ratio 0.42 <= 1.00
*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 127.56 with purity 0.05 time 1.20 plane 0
- Vertex (-327.50, 71.51, 435.89)
*** 1st Sanity check: Ratio 0.51 <= 1.00
*** 2nd Sanity check: #OpHits 5 >= 5
OpFlash PE 43.49 with purity 0.00 time 1.32 plane 0
- Vertex (-327.50, 182.88, 659.46)
*** 1st Sanity check: Ratio 0.59 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 68.49 with purity 0.29 time 1.23 plane 0
- Vertex (-327.50, -632.80, 608.22)
*** 1st Sanity check: Ratio 0.58 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 151.40 with purity 0.18 time 1.20 plane 0
- Vertex (-327.50, -355.61, 871.82)
*** 1st Sanity check: Ratio 0.29 <= 1.00
*** 2nd Sanity check: #OpHits 6 >= 6
OpFlash PE 50.44 with purity 0.30 time 1.50 plane 2
- Vertex (60.07, -743.30, 488.13)
*** 1st Sanity check: Ratio 0.53 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 45.66 with purity 0.33 time 2.05 plane 0
- Vertex (-327.50, 131.41, 653.45)
*** 1st Sanity check: Ratio 0.50 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 57.36 with purity 0.00 time 1.81 plane 2
- Vertex (210.07, -743.30, 1939.46)
*** 1st Sanity check: Ratio 0.72 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 125.15 with purity 0.60 time 1.67 plane 0
- Vertex (-327.50, -206.70, 338.26)
*** 1st Sanity check: Ratio 0.81 <= 1.00
*** 2nd Sanity check: #OpHits 3 >= 3
OpFlash PE 58.21 with purity 0.00 time 2.91 plane 0
- Vertex (-327.50, -465.16, 884.94)
*** 1st Sanity check: Ratio 0.53 <= 1.00
*** 2nd Sanity check: #OpHits 4 >= 4
[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 30-Jul-2025 23:35:07 CEST run: 20000047 subRun: 0 event: 10
[36m
# OpHits (ophit10ppm) in full geometry: 25342
# OpFlashes (solarflash) in full geometry: 1483
# Hits (gaushit) in each view: 3346, 3282, 4166, 0
# Cluster from the hits: 1484, 1519, 3542, 0
# Tracks (pmtracktc) in full geometry: 205[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 30-Jul-2025 23:50:14 CEST run: 20000047 subRun: 0 event: 10
[32m
# ClusterReco: Looping over 3523 matched clusters[0m
%MSG
%MSG-i ProducerUtils: SolarNuAna:solarnuana@BeginModule 30-Jul-2025 23:50:14 CEST run: 20000047 subRun: 0 event: 10
[32m*** Matched preselection cluster: 2262
- MainTrackID 76504
- Gen 1 -> marley TPC 26
- Purity 1.00 Hits 26
- #AdjCl 8 ( 1 signal ):
- Cluster 1811 at distance 85.13 with time 2136.10 and charge 31.49 in TPC 30 and hits 1
- Cluster 1933 at distance 91.67 with time 2287.79 and charge 27.48 in TPC 31 and hits 1
- Cluster 1947 at distance 61.71 with time 2308.31 and charge 427.14 in TPC 26 and hits 3
- Cluster 2184 at distance 77.04 with time 2549.65 and charge 133.85 in TPC 26 and hits 2
- Cluster 2224 at distance 62.00 with time 2587.69 and charge 25.73 in TPC 30 and hits 1
- Cluster 2319 at distance 49.63 with time 2706.92 and charge 34.28 in TPC 26 and hits 1
- Cluster 2380 at distance 66.53 with time 2789.57 and charge 36.40 in TPC 26 and hits 1
- Cluster 2447 at distance 77.47 with time 2877.22 and charge 35.09 in TPC 24 and hits 1
- RecoCol Time,Y,Z ( 2632.24, -231.10, 508.53 )
- RecoInd0 Time,Y,Z ( -1000000.00, -1000000.00, -1000000.00 )
- RecoInd1 Time,Y,Z ( 2631.67, -231.10, 522.72 )
*** Matched flash:
- Purity 0.21 Plane 0 #Hits 25 PE 1764.01 MaxPE 176.01
- Time 0.68 Fast 0.66 Residual 388.28
- Reco Time,Y,Z ( 0.68, -206.82, 473.12 )
*** Reconstructed Interaction Vertex:
- True X,Y,Z ( -104.47, -238.29, 507.24 )
- Reco X,Y,Z ( -97.50, -231.10, 508.53 )[0m
%MSG
30-Jul-2025 23:50:14 CEST Closed input file "root://eospublic.cern.ch:1094//eos/experiment/neutplatform/protodune/dune/usertests/b7/ce/fdvd_lowBg_reco2_2025-05-12T_080706Z.root"
====================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
====================================================================================================================
Full event 450.477 806.236 952.43 872.046 160.478 10
--------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000672855 0.00723835 0.0189875 0.00577973 0.00670937 10
end_path:solarnuana:SolarNuAna 450.476 806.229 952.429 872.039 160.478 10
====================================================================================================================
%MSG-i NuRandomService: SolarNuAna:solarnuana@EndJob 30-Jul-2025 23:50:14 CEST 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) : 2015.8 MB
Peak resident set size usage (VmHWM): 1362.04 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 = 7923.708922 Real = 8084.039111
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 2015.8 VmHWM = 1362.04
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
Output file: fdhd_ana_2025-07-30T_193520Z.root
Output hist file: fdhd_ana_2025-07-30T_193520Z_hist.root
lar exit code 0