Jobsub ID 15593.11@dunegpschedd02.fnal.gov
| Jobsub ID | 15593.11@dunegpschedd02.fnal.gov |
| Workflow ID | 684 |
| Stage ID | 1 |
| User name | ichong@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-08-08 13:04:58 |
| Site | US_FNAL-T1 |
| Entry | CMSHTPC_T1_US_FNAL_condce_opp1_whole |
| Last heartbeat | 2025-08-08 15:38:29 |
| From worker node | Hostname | dunegli-44744-0-cmswn5016.fnal.gov |
| 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 | 171000 (47 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-08-08 13:05:21 |
| Input files | fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2.root
|
| Jobscript | Exit code | 0 |
| Real time | 2h (9169s) |
| CPU time | 6m (377s = 4%) |
| Max RSS bytes | 1992855552 (1900 MiB) |
| Outputting started | 2025-08-08 15:38:11 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/ichong/fnal/00684/1/001/caf_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2_truthvtx_2025-08-08T_153726Z_caf.root
|
| Finished | 2025-08-08 15:38:29 |
| Saved logs | justin-logs:15593.11-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
s:/cvmfs/fermilab.opensciencegrid.org/products/common/db/
CETPKG_INSTALL=/cvmfs/fifeuser3.opensciencegrid.org/sw/dune/1f8f8aaded68cc7c3e873196b083ca84b933f518/truth_vtx_larsoft/localProducts_larsoft_v10_04_06d00_e26_prof
local product directory is /cvmfs/fifeuser3.opensciencegrid.org/sw/dune/1f8f8aaded68cc7c3e873196b083ca84b933f518/truth_vtx_larsoft/localProducts_larsoft_v10_04_06d00_e26_prof
----------- this block should be empty ------------------
---------------------------------------------------------
Running LArSoft with FCL: /cvmfs/fifeuser3.opensciencegrid.org/sw/dune/aaa05dc551a4535ad0eeaa35b47a4bc39c7f55ae/atm-reco_truth_vtx.fcl
Running CAF step with FCL_SECONDARY: cafmaker_atmos_dune10kt_1x2x6_runreco-nuenergy-nuangular_geov5.fcl using reco output: atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2_truthvtx_2025-08-08T_130525Z.root
Renamed caf.root -> caf_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2_truthvtx_2025-08-08T_153726Z_caf.root
=== Start last 100 lines of lar log file ===
MCPDG 13, Energy 1.16464, Dist. 55.6623, nMCHits 292 (112, 71, 109)
--Primary 1, MCPDG 2212, Energy 0.987418, Dist. 2.26636, nMCHits 15 (7, 5, 3)
MCPDG 2212, Energy 0.987418, Dist. 2.26636, nMCHits 15 (7, 5, 3)
------------------------------------------------------------------------------------------------
DlVertexingAlgorithm::Run() called. m_trainingMode = 0
DlVertexingAlgorithm::Run() calling Infer()
DlVertexingAlgorithm::Infer() called
DlVertexingAlgorithm: Outputting the truth vertex.
Truth vertex position: 235.021, -427.762, 50.8491
DlVertexingAlgorithm::Run() called. m_trainingMode = 0
DlVertexingAlgorithm::Run() calling Infer()
DlVertexingAlgorithm::Infer() called
DlVertexingAlgorithm: Outputting the truth vertex.
Truth vertex position: 235.021, -427.762, 50.8491
%MSG-e ShowerProducedPtrsHolder: LArPandoraModularShowerCreation:pandoraShower@BeginModule 08-Aug-2025 15:37:13 UTC run: 6400837 subRun: 1 event: 91399
Trying to add data product: InitialTrack. This element does not exist in the element holder
%MSG
Boundary wire vector sizes: 91, 131, 123
minwire 0: 234
minwire 1: 2357
minwire 2: 0
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 499
Used alternate method to get min and max wires due to vertex determination failure: 2379, 2878
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 499
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 499
Classifier summary:
Output 0: 0.00947018,
Output 1: 0.00558681, 0.00070599, 0.00826118, 0.985446,
Output 2: 0.458466, 0.183674, 0.0032825, 0.354577,
Output 3: 0.951135, 0.0429974, 0.00294613, 0.00292159,
Output 4: 0.00641997, 0.992072, 0.00150708, 1.21658e-06,
Output 5: 0.998812, 0.00118304, 3.01861e-06, 1.72258e-06,
Output 6: 0.815389, 0.177913, 0.00563335, 0.00106395,
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 75!
Begin processing the 100th record. run: 6400837 subRun: 1 event: 91400 at 08-Aug-2025 15:37:17 UTC
---MC-PARTICLE-MONITORING-----------------------------------------------------------------------
BeamNeutrinos:
--Primary 0, MCPDG 2212, Energy 0.975575, Dist. 1.39176, nMCHits 27 (13, 9, 5)
MCPDG 2212, Energy 0.975575, Dist. 1.39176, nMCHits 27 (13, 9, 5)
------------------------------------------------------------------------------------------------
DlVertexingAlgorithm::Run() called. m_trainingMode = 0
DlVertexingAlgorithm::Run() calling Infer()
DlVertexingAlgorithm::Infer() called
DlVertexingAlgorithm: Outputting the truth vertex.
Truth vertex position: 358.395, 245.993, 1343.03
DlVertexingAlgorithm::Run() called. m_trainingMode = 0
DlVertexingAlgorithm::Run() calling Infer()
DlVertexingAlgorithm::Infer() called
DlVertexingAlgorithm: Outputting the truth vertex.
Truth vertex position: 358.395, 245.993, 1343.03
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 12!
08-Aug-2025 15:37:24 UTC Closed output file "atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2_truthvtx_2025-08-08T_130525Z.root"
08-Aug-2025 15:37:24 UTC Closed input file "root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/fardet-hd/6f/25/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 3.22825 6.84047 27.2937 6.20582 3.9833 100
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.148371 0.222144 0.300705 0.151549 0.0740047 100
reco:gaushit:GausHitFinder 0.761953 1.26606 6.10907 0.92565 0.9462 100
reco:spsolve:SpacePointSolver 0.000173318 0.0808654 4.93804 0.00413433 0.494472 100
reco:hitfd:DisambigFromSpacePoints 0.000277174 0.00819585 0.107856 0.00121611 0.02077 100
reco:rns:RandomNumberSaver 2.8424e-05 5.89878e-05 0.000589294 4.47145e-05 5.95679e-05 100
reco:pandora:StandardPandora 0.452058 0.977233 16.665 0.501743 1.91325 100
reco:pandoraTrack:LArPandoraTrackCreation 0.000187274 0.00452025 0.0624333 0.00168453 0.00853932 100
reco:pandoraShower:LArPandoraModularShowerCreation 0.00024367 0.0133077 0.279485 0.00271142 0.0362547 100
reco:pandoracalo:Calorimetry 0.000146257 0.0106882 0.231858 0.00102903 0.0317423 100
reco:pandorapid:Chi2ParticleID 5.5595e-05 0.000214441 0.00172117 0.000162141 0.000199978 100
reco:cvnmap:CVNMapper 3.0918e-05 0.0552594 0.252456 0.0681804 0.0438917 100
reco:cvneva:CVNEvaluator 2.3875e-05 0.711629 5.45577 0.898254 0.64889 100
reco:energyrecnumu:EnergyReco 0.000397381 0.0456532 1.03628 0.00757696 0.166684 100
reco:energyrecnue:EnergyReco 0.00012156 0.00210931 0.0372689 0.00058744 0.00476561 100
reco:energyrecnc:EnergyReco 0.00119943 0.0034225 0.0248454 0.00214027 0.00375443 100
reco:energyrecnumurange:EnergyReco 0.000141989 0.0366561 1.01766 0.0014734 0.156306 100
reco:energyrecnumumcs:EnergyReco 0.000788029 0.0388701 1.02725 0.00233463 0.162833 100
reco:opdec:Deconvolution 0.450693 1.69204 3.33076 1.6499 0.641938 100
reco:ophitspe:OpHitFinderDeco 1.33176 1.33859 1.35322 1.33824 0.00436981 100
reco:opflash:OpFlashFinder 0.000278356 0.000739202 0.00461173 0.000599573 0.000504234 100
reco:opslicer:OpSlicer 4.0056e-05 0.00976619 0.0854729 0.00618955 0.0129281 100
[art]:TriggerResults:TriggerResultInserter 1.5108e-05 3.10908e-05 8.459e-05 2.44665e-05 1.7369e-05 100
end_path:out1:RootOutput 5.891e-06 1.12874e-05 3.7741e-05 9.8135e-06 5.09678e-06 100
end_path:out1:RootOutput(write) 0.00413147 0.320452 0.621305 0.408879 0.193171 100
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 20758.9 MB
Peak resident set size usage (VmHWM): 1992.86 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
=== Generated output files ===
15593.11_dunegpschedd02.fnal.gov.logs.tgz
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2_truthvtx_2025-08-08T_130525Z.log
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2_truthvtx_2025-08-08T_130525Z.root
caf_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2_truthvtx_2025-08-08T_153726Z.log
caf_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2_truthvtx_2025-08-08T_153726Z.root
caf_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6400837_913_20231202T085434Z_gen_g4_detsim_hitreco__20240507T205756Z_reco2_truthvtx_2025-08-08T_153726Z_caf.root
debugprod.log
flatcaf.root
jobscript.log
justin-processed-pfns.txt
reco_hist.root
