Jobsub ID 235781.0@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
ice::ctor: StandardRawDigitPrepService:
StandardRawDigitPrepService::ctor: LogLevel: 1
StandardRawDigitPrepService::ctor: SkipBad: 1
StandardRawDigitPrepService::ctor: SkipNoisy: 0
StandardRawDigitPrepService::ctor: ChannelStatusOnline: 0
StandardRawDigitPrepService::ctor: DoMitigation: 0
StandardRawDigitPrepService::ctor: DoEarlySignalFinding: 0
StandardRawDigitPrepService::ctor: DoNoiseRemoval: 0
StandardRawDigitPrepService::ctor: DoDeconvolution: 1
StandardRawDigitPrepService::ctor: DoPedestalAdjustment: 0
StandardRawDigitPrepService::ctor: DoROI: 1
StandardRawDigitPrepService::ctor: DoWires: 1
StandardRawDigitPrepService::ctor: DoDump: 0
StandardRawDigitPrepService::ctor: DoIntermediateStates: 0
StandardRawDigitPrepService::ctor: No display tools.
Warning in <TFile::Append>: Replacing existing TH1: FieldResponse_U (Potential memory leak).
Warning in <TFile::Append>: Replacing existing TH1: FieldResponse_V (Potential memory leak).
Warning in <TFile::Append>: Replacing existing TH1: FieldResponse_Y (Potential memory leak).
31-Oct-2025 10:42:54 CDT Initiating request to open input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/ae/5a/prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim.root"
31-Oct-2025 10:42:56 CDT Opened input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/ae/5a/prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim.root"
Begin processing the 1st record. run: 8106 subRun: 0 event: 29201 at 31-Oct-2025 10:42:56 CDT
31-Oct-2025 10:43:03 CDT Opened output file with pattern "prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim_20251031T154237Z_reco.root"
Begin processing the 2nd record. run: 8106 subRun: 0 event: 29202 at 31-Oct-2025 10:43:27 CDT
Begin processing the 3rd record. run: 8106 subRun: 0 event: 29203 at 31-Oct-2025 10:43:34 CDT
Begin processing the 4th record. run: 8106 subRun: 0 event: 29204 at 31-Oct-2025 10:43:41 CDT
Begin processing the 5th record. run: 8106 subRun: 0 event: 29205 at 31-Oct-2025 10:43:48 CDT
Begin processing the 6th record. run: 8106 subRun: 0 event: 29206 at 31-Oct-2025 10:43:54 CDT
Begin processing the 7th record. run: 8106 subRun: 0 event: 29207 at 31-Oct-2025 10:44:01 CDT
Begin processing the 8th record. run: 8106 subRun: 0 event: 29208 at 31-Oct-2025 10:44:08 CDT
Begin processing the 9th record. run: 8106 subRun: 0 event: 29209 at 31-Oct-2025 10:44:15 CDT
Begin processing the 10th record. run: 8106 subRun: 0 event: 29210 at 31-Oct-2025 10:44:22 CDT
Begin processing the 11th record. run: 8106 subRun: 0 event: 29211 at 31-Oct-2025 10:44:28 CDT
Begin processing the 12th record. run: 8106 subRun: 0 event: 29212 at 31-Oct-2025 10:44:35 CDT
Begin processing the 13th record. run: 8106 subRun: 0 event: 29213 at 31-Oct-2025 10:44:42 CDT
Begin processing the 14th record. run: 8106 subRun: 0 event: 29214 at 31-Oct-2025 10:44:48 CDT
Begin processing the 15th record. run: 8106 subRun: 0 event: 29215 at 31-Oct-2025 10:44:55 CDT
Begin processing the 16th record. run: 8106 subRun: 0 event: 29216 at 31-Oct-2025 10:45:01 CDT
Begin processing the 17th record. run: 8106 subRun: 0 event: 29217 at 31-Oct-2025 10:45:07 CDT
Begin processing the 18th record. run: 8106 subRun: 0 event: 29218 at 31-Oct-2025 10:45:14 CDT
Begin processing the 19th record. run: 8106 subRun: 0 event: 29219 at 31-Oct-2025 10:45:21 CDT
Begin processing the 20th record. run: 8106 subRun: 0 event: 29220 at 31-Oct-2025 10:45:28 CDT
Begin processing the 21st record. run: 8106 subRun: 0 event: 29221 at 31-Oct-2025 10:45:35 CDT
Begin processing the 22nd record. run: 8106 subRun: 0 event: 29222 at 31-Oct-2025 10:45:41 CDT
Begin processing the 23rd record. run: 8106 subRun: 0 event: 29223 at 31-Oct-2025 10:45:48 CDT
Begin processing the 24th record. run: 8106 subRun: 0 event: 29224 at 31-Oct-2025 10:45:55 CDT
Begin processing the 25th record. run: 8106 subRun: 0 event: 29225 at 31-Oct-2025 10:46:01 CDT
Begin processing the 26th record. run: 8106 subRun: 0 event: 29226 at 31-Oct-2025 10:46:08 CDT
Begin processing the 27th record. run: 8106 subRun: 0 event: 29227 at 31-Oct-2025 10:46:15 CDT
Begin processing the 28th record. run: 8106 subRun: 0 event: 29228 at 31-Oct-2025 10:46:22 CDT
Begin processing the 29th record. run: 8106 subRun: 0 event: 29229 at 31-Oct-2025 10:46:28 CDT
Begin processing the 30th record. run: 8106 subRun: 0 event: 29230 at 31-Oct-2025 10:46:35 CDT
Begin processing the 31st record. run: 8106 subRun: 0 event: 29231 at 31-Oct-2025 10:46:41 CDT
Begin processing the 32nd record. run: 8106 subRun: 0 event: 29232 at 31-Oct-2025 10:46:48 CDT
Begin processing the 33rd record. run: 8106 subRun: 0 event: 29233 at 31-Oct-2025 10:46:54 CDT
Begin processing the 34th record. run: 8106 subRun: 0 event: 29234 at 31-Oct-2025 10:47:01 CDT
Begin processing the 35th record. run: 8106 subRun: 0 event: 29235 at 31-Oct-2025 10:47:07 CDT
Begin processing the 36th record. run: 8106 subRun: 0 event: 29236 at 31-Oct-2025 10:47:14 CDT
Begin processing the 37th record. run: 8106 subRun: 0 event: 29237 at 31-Oct-2025 10:47:20 CDT
Begin processing the 38th record. run: 8106 subRun: 0 event: 29238 at 31-Oct-2025 10:47:27 CDT
Begin processing the 39th record. run: 8106 subRun: 0 event: 29239 at 31-Oct-2025 10:47:33 CDT
Begin processing the 40th record. run: 8106 subRun: 0 event: 29240 at 31-Oct-2025 10:47:40 CDT
Begin processing the 41st record. run: 8106 subRun: 0 event: 29241 at 31-Oct-2025 10:47:47 CDT
Begin processing the 42nd record. run: 8106 subRun: 0 event: 29242 at 31-Oct-2025 10:47:54 CDT
Begin processing the 43rd record. run: 8106 subRun: 0 event: 29243 at 31-Oct-2025 10:48:01 CDT
Begin processing the 44th record. run: 8106 subRun: 0 event: 29244 at 31-Oct-2025 10:48:07 CDT
Begin processing the 45th record. run: 8106 subRun: 0 event: 29245 at 31-Oct-2025 10:48:14 CDT
Begin processing the 46th record. run: 8106 subRun: 0 event: 29246 at 31-Oct-2025 10:48:21 CDT
Begin processing the 47th record. run: 8106 subRun: 0 event: 29247 at 31-Oct-2025 10:48:27 CDT
Begin processing the 48th record. run: 8106 subRun: 0 event: 29248 at 31-Oct-2025 10:48:34 CDT
Begin processing the 49th record. run: 8106 subRun: 0 event: 29249 at 31-Oct-2025 10:48:41 CDT
Begin processing the 50th record. run: 8106 subRun: 0 event: 29250 at 31-Oct-2025 10:48:47 CDT
31-Oct-2025 10:48:54 CDT Closed output file "prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim_20251031T154237Z_reco.root"
31-Oct-2025 10:48:54 CDT Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/ae/5a/prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim.root"
=========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
=========================================================================================================================================
Full event 6.16245 6.58271 7.26214 6.60703 0.201151 50
-----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000284927 0.00225628 0.0185654 0.000355955 0.00467971 50
makers:tpmakerTPCsimpleThr:TriggerPrimitiveMakerTPC 3.13192 3.52853 4.17636 3.51595 0.153077 50
makers:tpmakerTPCabsRS:TriggerPrimitiveMakerTPC 2.69182 3.04841 3.17699 3.09104 0.108308 50
[art]:TriggerResults:TriggerResultInserter 1.563e-05 2.64882e-05 0.000102162 2.34645e-05 1.22501e-05 50
end_path:out1:RootOutput 3.196e-06 7.95218e-06 2.7401e-05 8.1505e-06 4.23586e-06 50
end_path:out1:RootOutput(write) 0.00150396 0.00285528 0.00563714 0.00202488 0.00129283 50
=========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 1536.97 MB
Peak resident set size usage (VmHWM): 797.889 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Moving on to metadata extractor
mv: cannot stat 'triggerAnaTree_hist.root': No such file or directory
============OUTPUT FILE: prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim_20251031T154237Z_reco.root
Extracted metadata
checking file====== fardet-hd:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim.root
MD conversion to MetaCat OK
all-input-dids.txt
debugprod.log
jobscript.log
justin-processed-pfns.txt
mem.db
old_md.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim_20251031T154237Z_reco.root
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim_20251031T154237Z_reco.root.ext.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim_20251031T154237Z_reco.root.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T163750Z_gen_000585_supernova_g4_detsim_20251031T154237Z_reco.root.temp.json
time.db
triggersim_hist.root