Jobsub ID 235779.3@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
vice::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 09:59:09 CDT Initiating request to open input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/83/6f/prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim.root"
31-Oct-2025 09:59:13 CDT Opened input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/83/6f/prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim.root"
Begin processing the 1st record. run: 8106 subRun: 0 event: 61651 at 31-Oct-2025 09:59:14 CDT
31-Oct-2025 09:59:21 CDT Opened output file with pattern "prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T145853Z_reco.root"
Begin processing the 2nd record. run: 8106 subRun: 0 event: 61652 at 31-Oct-2025 09:59:49 CDT
Begin processing the 3rd record. run: 8106 subRun: 0 event: 61653 at 31-Oct-2025 09:59:56 CDT
Begin processing the 4th record. run: 8106 subRun: 0 event: 61654 at 31-Oct-2025 10:00:02 CDT
Begin processing the 5th record. run: 8106 subRun: 0 event: 61655 at 31-Oct-2025 10:00:09 CDT
Begin processing the 6th record. run: 8106 subRun: 0 event: 61656 at 31-Oct-2025 10:00:15 CDT
Begin processing the 7th record. run: 8106 subRun: 0 event: 61657 at 31-Oct-2025 10:00:22 CDT
Begin processing the 8th record. run: 8106 subRun: 0 event: 61658 at 31-Oct-2025 10:00:28 CDT
Begin processing the 9th record. run: 8106 subRun: 0 event: 61659 at 31-Oct-2025 10:00:35 CDT
Begin processing the 10th record. run: 8106 subRun: 0 event: 61660 at 31-Oct-2025 10:00:41 CDT
Begin processing the 11th record. run: 8106 subRun: 0 event: 61661 at 31-Oct-2025 10:00:48 CDT
Begin processing the 12th record. run: 8106 subRun: 0 event: 61662 at 31-Oct-2025 10:00:55 CDT
Begin processing the 13th record. run: 8106 subRun: 0 event: 61663 at 31-Oct-2025 10:01:01 CDT
Begin processing the 14th record. run: 8106 subRun: 0 event: 61664 at 31-Oct-2025 10:01:08 CDT
Begin processing the 15th record. run: 8106 subRun: 0 event: 61665 at 31-Oct-2025 10:01:14 CDT
Begin processing the 16th record. run: 8106 subRun: 0 event: 61666 at 31-Oct-2025 10:01:20 CDT
Begin processing the 17th record. run: 8106 subRun: 0 event: 61667 at 31-Oct-2025 10:01:27 CDT
Begin processing the 18th record. run: 8106 subRun: 0 event: 61668 at 31-Oct-2025 10:01:33 CDT
Begin processing the 19th record. run: 8106 subRun: 0 event: 61669 at 31-Oct-2025 10:01:40 CDT
Begin processing the 20th record. run: 8106 subRun: 0 event: 61670 at 31-Oct-2025 10:01:46 CDT
Begin processing the 21st record. run: 8106 subRun: 0 event: 61671 at 31-Oct-2025 10:01:53 CDT
Begin processing the 22nd record. run: 8106 subRun: 0 event: 61672 at 31-Oct-2025 10:01:59 CDT
Begin processing the 23rd record. run: 8106 subRun: 0 event: 61673 at 31-Oct-2025 10:02:05 CDT
Begin processing the 24th record. run: 8106 subRun: 0 event: 61674 at 31-Oct-2025 10:02:12 CDT
Begin processing the 25th record. run: 8106 subRun: 0 event: 61675 at 31-Oct-2025 10:02:18 CDT
Begin processing the 26th record. run: 8106 subRun: 0 event: 61676 at 31-Oct-2025 10:02:25 CDT
Begin processing the 27th record. run: 8106 subRun: 0 event: 61677 at 31-Oct-2025 10:02:31 CDT
Begin processing the 28th record. run: 8106 subRun: 0 event: 61678 at 31-Oct-2025 10:02:38 CDT
Begin processing the 29th record. run: 8106 subRun: 0 event: 61679 at 31-Oct-2025 10:02:45 CDT
Begin processing the 30th record. run: 8106 subRun: 0 event: 61680 at 31-Oct-2025 10:02:51 CDT
Begin processing the 31st record. run: 8106 subRun: 0 event: 61681 at 31-Oct-2025 10:02:57 CDT
Begin processing the 32nd record. run: 8106 subRun: 0 event: 61682 at 31-Oct-2025 10:03:03 CDT
Begin processing the 33rd record. run: 8106 subRun: 0 event: 61683 at 31-Oct-2025 10:03:10 CDT
Begin processing the 34th record. run: 8106 subRun: 0 event: 61684 at 31-Oct-2025 10:03:16 CDT
Begin processing the 35th record. run: 8106 subRun: 0 event: 61685 at 31-Oct-2025 10:03:23 CDT
Begin processing the 36th record. run: 8106 subRun: 0 event: 61686 at 31-Oct-2025 10:03:29 CDT
Begin processing the 37th record. run: 8106 subRun: 0 event: 61687 at 31-Oct-2025 10:03:35 CDT
Begin processing the 38th record. run: 8106 subRun: 0 event: 61688 at 31-Oct-2025 10:03:42 CDT
Begin processing the 39th record. run: 8106 subRun: 0 event: 61689 at 31-Oct-2025 10:03:48 CDT
Begin processing the 40th record. run: 8106 subRun: 0 event: 61690 at 31-Oct-2025 10:03:55 CDT
Begin processing the 41st record. run: 8106 subRun: 0 event: 61691 at 31-Oct-2025 10:04:01 CDT
Begin processing the 42nd record. run: 8106 subRun: 0 event: 61692 at 31-Oct-2025 10:04:08 CDT
Begin processing the 43rd record. run: 8106 subRun: 0 event: 61693 at 31-Oct-2025 10:04:14 CDT
Begin processing the 44th record. run: 8106 subRun: 0 event: 61694 at 31-Oct-2025 10:04:21 CDT
Begin processing the 45th record. run: 8106 subRun: 0 event: 61695 at 31-Oct-2025 10:04:27 CDT
Begin processing the 46th record. run: 8106 subRun: 0 event: 61696 at 31-Oct-2025 10:04:34 CDT
Begin processing the 47th record. run: 8106 subRun: 0 event: 61697 at 31-Oct-2025 10:04:41 CDT
Begin processing the 48th record. run: 8106 subRun: 0 event: 61698 at 31-Oct-2025 10:04:47 CDT
Begin processing the 49th record. run: 8106 subRun: 0 event: 61699 at 31-Oct-2025 10:04:53 CDT
Begin processing the 50th record. run: 8106 subRun: 0 event: 61700 at 31-Oct-2025 10:05:00 CDT
31-Oct-2025 10:05:07 CDT Closed output file "prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T145853Z_reco.root"
31-Oct-2025 10:05:07 CDT Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-hd/83/6f/prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim.root"
=========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
=========================================================================================================================================
Full event 6.05737 6.42155 7.09659 6.42995 0.16896 50
-----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000287718 0.00115443 0.018341 0.000418609 0.00271258 50
makers:tpmakerTPCsimpleThr:TriggerPrimitiveMakerTPC 3.16799 3.3703 3.87313 3.37347 0.117841 50
makers:tpmakerTPCabsRS:TriggerPrimitiveMakerTPC 2.88334 3.04644 3.19998 3.05124 0.0770967 50
[art]:TriggerResults:TriggerResultInserter 1.7543e-05 3.79074e-05 0.000154519 3.58975e-05 1.89074e-05 50
end_path:out1:RootOutput 3.226e-06 6.95662e-06 3.0247e-05 6.512e-06 3.65331e-06 50
end_path:out1:RootOutput(write) 0.00164583 0.00289168 0.00871958 0.0020509 0.00172142 50
=========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 1537.17 MB
Peak resident set size usage (VmHWM): 786.67 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_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T145853Z_reco.root
Extracted metadata
checking file====== fardet-hd:prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_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_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T145853Z_reco.root
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T145853Z_reco.root.ext.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T145853Z_reco.root.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T145853Z_reco.root.temp.json
time.db
triggersim_hist.root