Jobsub ID 238961.1@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).
06-Nov-2025 15:08:08 CST Initiating request to open input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/e5/50/prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T164636Z_gen_000933_supernova_g4_detsim.root"
06-Nov-2025 15:08:10 CST Opened input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/e5/50/prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T164636Z_gen_000933_supernova_g4_detsim.root"
Begin processing the 1st record. run: 8106 subRun: 0 event: 46601 at 06-Nov-2025 15:08:11 CST
06-Nov-2025 15:08:17 CST Opened output file with pattern "prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T164636Z_gen_000933_supernova_g4_detsim_20251106T210751Z_reco.root"
Begin processing the 2nd record. run: 8106 subRun: 0 event: 46602 at 06-Nov-2025 15:08:46 CST
Begin processing the 3rd record. run: 8106 subRun: 0 event: 46603 at 06-Nov-2025 15:08:52 CST
Begin processing the 4th record. run: 8106 subRun: 0 event: 46604 at 06-Nov-2025 15:08:59 CST
Begin processing the 5th record. run: 8106 subRun: 0 event: 46605 at 06-Nov-2025 15:09:05 CST
Begin processing the 6th record. run: 8106 subRun: 0 event: 46606 at 06-Nov-2025 15:09:11 CST
Begin processing the 7th record. run: 8106 subRun: 0 event: 46607 at 06-Nov-2025 15:09:18 CST
Begin processing the 8th record. run: 8106 subRun: 0 event: 46608 at 06-Nov-2025 15:09:24 CST
Begin processing the 9th record. run: 8106 subRun: 0 event: 46609 at 06-Nov-2025 15:09:30 CST
Begin processing the 10th record. run: 8106 subRun: 0 event: 46610 at 06-Nov-2025 15:09:37 CST
Begin processing the 11th record. run: 8106 subRun: 0 event: 46611 at 06-Nov-2025 15:09:43 CST
Begin processing the 12th record. run: 8106 subRun: 0 event: 46612 at 06-Nov-2025 15:09:50 CST
Begin processing the 13th record. run: 8106 subRun: 0 event: 46613 at 06-Nov-2025 15:09:56 CST
Begin processing the 14th record. run: 8106 subRun: 0 event: 46614 at 06-Nov-2025 15:10:02 CST
Begin processing the 15th record. run: 8106 subRun: 0 event: 46615 at 06-Nov-2025 15:10:09 CST
Begin processing the 16th record. run: 8106 subRun: 0 event: 46616 at 06-Nov-2025 15:10:16 CST
Begin processing the 17th record. run: 8106 subRun: 0 event: 46617 at 06-Nov-2025 15:10:22 CST
Begin processing the 18th record. run: 8106 subRun: 0 event: 46618 at 06-Nov-2025 15:10:28 CST
Begin processing the 19th record. run: 8106 subRun: 0 event: 46619 at 06-Nov-2025 15:10:34 CST
Begin processing the 20th record. run: 8106 subRun: 0 event: 46620 at 06-Nov-2025 15:10:41 CST
Begin processing the 21st record. run: 8106 subRun: 0 event: 46621 at 06-Nov-2025 15:10:48 CST
Begin processing the 22nd record. run: 8106 subRun: 0 event: 46622 at 06-Nov-2025 15:10:54 CST
Begin processing the 23rd record. run: 8106 subRun: 0 event: 46623 at 06-Nov-2025 15:11:01 CST
Begin processing the 24th record. run: 8106 subRun: 0 event: 46624 at 06-Nov-2025 15:11:07 CST
Begin processing the 25th record. run: 8106 subRun: 0 event: 46625 at 06-Nov-2025 15:11:13 CST
Begin processing the 26th record. run: 8106 subRun: 0 event: 46626 at 06-Nov-2025 15:11:20 CST
Begin processing the 27th record. run: 8106 subRun: 0 event: 46627 at 06-Nov-2025 15:11:26 CST
Begin processing the 28th record. run: 8106 subRun: 0 event: 46628 at 06-Nov-2025 15:11:32 CST
Begin processing the 29th record. run: 8106 subRun: 0 event: 46629 at 06-Nov-2025 15:11:39 CST
Begin processing the 30th record. run: 8106 subRun: 0 event: 46630 at 06-Nov-2025 15:11:45 CST
Begin processing the 31st record. run: 8106 subRun: 0 event: 46631 at 06-Nov-2025 15:11:51 CST
Begin processing the 32nd record. run: 8106 subRun: 0 event: 46632 at 06-Nov-2025 15:11:57 CST
Begin processing the 33rd record. run: 8106 subRun: 0 event: 46633 at 06-Nov-2025 15:12:04 CST
Begin processing the 34th record. run: 8106 subRun: 0 event: 46634 at 06-Nov-2025 15:12:11 CST
Begin processing the 35th record. run: 8106 subRun: 0 event: 46635 at 06-Nov-2025 15:12:17 CST
Begin processing the 36th record. run: 8106 subRun: 0 event: 46636 at 06-Nov-2025 15:12:23 CST
Begin processing the 37th record. run: 8106 subRun: 0 event: 46637 at 06-Nov-2025 15:12:29 CST
Begin processing the 38th record. run: 8106 subRun: 0 event: 46638 at 06-Nov-2025 15:12:35 CST
Begin processing the 39th record. run: 8106 subRun: 0 event: 46639 at 06-Nov-2025 15:12:42 CST
Begin processing the 40th record. run: 8106 subRun: 0 event: 46640 at 06-Nov-2025 15:12:48 CST
Begin processing the 41st record. run: 8106 subRun: 0 event: 46641 at 06-Nov-2025 15:12:54 CST
Begin processing the 42nd record. run: 8106 subRun: 0 event: 46642 at 06-Nov-2025 15:13:01 CST
Begin processing the 43rd record. run: 8106 subRun: 0 event: 46643 at 06-Nov-2025 15:13:07 CST
Begin processing the 44th record. run: 8106 subRun: 0 event: 46644 at 06-Nov-2025 15:13:13 CST
Begin processing the 45th record. run: 8106 subRun: 0 event: 46645 at 06-Nov-2025 15:13:19 CST
Begin processing the 46th record. run: 8106 subRun: 0 event: 46646 at 06-Nov-2025 15:13:26 CST
Begin processing the 47th record. run: 8106 subRun: 0 event: 46647 at 06-Nov-2025 15:13:32 CST
Begin processing the 48th record. run: 8106 subRun: 0 event: 46648 at 06-Nov-2025 15:13:38 CST
Begin processing the 49th record. run: 8106 subRun: 0 event: 46649 at 06-Nov-2025 15:13:44 CST
Begin processing the 50th record. run: 8106 subRun: 0 event: 46650 at 06-Nov-2025 15:13:50 CST
06-Nov-2025 15:13:58 CST Closed output file "prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T164636Z_gen_000933_supernova_g4_detsim_20251106T210751Z_reco.root"
06-Nov-2025 15:13:58 CST Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/e5/50/prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T164636Z_gen_000933_supernova_g4_detsim.root"
=========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
=========================================================================================================================================
Full event 5.73229 6.29212 6.68821 6.30147 0.199302 50
-----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000225685 0.00118567 0.0224315 0.000366771 0.00321655 50
makers:tpmakerTPCsimpleThr:TriggerPrimitiveMakerTPC 3.08199 3.38891 3.6362 3.37705 0.126206 50
makers:tpmakerTPCabsRS:TriggerPrimitiveMakerTPC 2.64626 2.89883 3.13465 2.90481 0.107159 50
[art]:TriggerResults:TriggerResultInserter 1.2774e-05 2.20601e-05 9.5741e-05 2.0709e-05 1.19658e-05 50
end_path:out1:RootOutput 2.936e-06 6.65694e-06 2.0298e-05 6.071e-06 3.40836e-06 50
end_path:out1:RootOutput(write) 0.00154615 0.00258531 0.00454673 0.00200501 0.00096477 50
=========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 1485.99 MB
Peak resident set size usage (VmHWM): 745.951 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_20250926T164636Z_gen_000933_supernova_g4_detsim_20251106T210751Z_reco.root
Extracted metadata
checking file====== fardet-hd:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T164636Z_gen_000933_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_20250926T164636Z_gen_000933_supernova_g4_detsim_20251106T210751Z_reco.root
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T164636Z_gen_000933_supernova_g4_detsim_20251106T210751Z_reco.root.ext.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T164636Z_gen_000933_supernova_g4_detsim_20251106T210751Z_reco.root.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T164636Z_gen_000933_supernova_g4_detsim_20251106T210751Z_reco.root.temp.json
time.db
triggersim_hist.root