Jobsub ID 235781.2@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:49 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 10:42:51 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 10:42:52 CDT
31-Oct-2025 10:42:59 CDT Opened output file with pattern "prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T154233Z_reco.root"
Begin processing the 2nd record. run: 8106 subRun: 0 event: 61652 at 31-Oct-2025 10:43:26 CDT
Begin processing the 3rd record. run: 8106 subRun: 0 event: 61653 at 31-Oct-2025 10:43:33 CDT
Begin processing the 4th record. run: 8106 subRun: 0 event: 61654 at 31-Oct-2025 10:43:39 CDT
Begin processing the 5th record. run: 8106 subRun: 0 event: 61655 at 31-Oct-2025 10:43:46 CDT
Begin processing the 6th record. run: 8106 subRun: 0 event: 61656 at 31-Oct-2025 10:43:52 CDT
Begin processing the 7th record. run: 8106 subRun: 0 event: 61657 at 31-Oct-2025 10:43:59 CDT
Begin processing the 8th record. run: 8106 subRun: 0 event: 61658 at 31-Oct-2025 10:44:06 CDT
Begin processing the 9th record. run: 8106 subRun: 0 event: 61659 at 31-Oct-2025 10:44:12 CDT
Begin processing the 10th record. run: 8106 subRun: 0 event: 61660 at 31-Oct-2025 10:44:19 CDT
Begin processing the 11th record. run: 8106 subRun: 0 event: 61661 at 31-Oct-2025 10:44:26 CDT
Begin processing the 12th record. run: 8106 subRun: 0 event: 61662 at 31-Oct-2025 10:44:33 CDT
Begin processing the 13th record. run: 8106 subRun: 0 event: 61663 at 31-Oct-2025 10:44:40 CDT
Begin processing the 14th record. run: 8106 subRun: 0 event: 61664 at 31-Oct-2025 10:44:46 CDT
Begin processing the 15th record. run: 8106 subRun: 0 event: 61665 at 31-Oct-2025 10:44:53 CDT
Begin processing the 16th record. run: 8106 subRun: 0 event: 61666 at 31-Oct-2025 10:45:00 CDT
Begin processing the 17th record. run: 8106 subRun: 0 event: 61667 at 31-Oct-2025 10:45:07 CDT
Begin processing the 18th record. run: 8106 subRun: 0 event: 61668 at 31-Oct-2025 10:45:13 CDT
Begin processing the 19th record. run: 8106 subRun: 0 event: 61669 at 31-Oct-2025 10:45:20 CDT
Begin processing the 20th record. run: 8106 subRun: 0 event: 61670 at 31-Oct-2025 10:45:26 CDT
Begin processing the 21st record. run: 8106 subRun: 0 event: 61671 at 31-Oct-2025 10:45:33 CDT
Begin processing the 22nd record. run: 8106 subRun: 0 event: 61672 at 31-Oct-2025 10:45:41 CDT
Begin processing the 23rd record. run: 8106 subRun: 0 event: 61673 at 31-Oct-2025 10:45:48 CDT
Begin processing the 24th record. run: 8106 subRun: 0 event: 61674 at 31-Oct-2025 10:45:55 CDT
Begin processing the 25th record. run: 8106 subRun: 0 event: 61675 at 31-Oct-2025 10:46:02 CDT
Begin processing the 26th record. run: 8106 subRun: 0 event: 61676 at 31-Oct-2025 10:46:09 CDT
Begin processing the 27th record. run: 8106 subRun: 0 event: 61677 at 31-Oct-2025 10:46:16 CDT
Begin processing the 28th record. run: 8106 subRun: 0 event: 61678 at 31-Oct-2025 10:46:23 CDT
Begin processing the 29th record. run: 8106 subRun: 0 event: 61679 at 31-Oct-2025 10:46:30 CDT
Begin processing the 30th record. run: 8106 subRun: 0 event: 61680 at 31-Oct-2025 10:46:36 CDT
Begin processing the 31st record. run: 8106 subRun: 0 event: 61681 at 31-Oct-2025 10:46:44 CDT
Begin processing the 32nd record. run: 8106 subRun: 0 event: 61682 at 31-Oct-2025 10:46:51 CDT
Begin processing the 33rd record. run: 8106 subRun: 0 event: 61683 at 31-Oct-2025 10:46:58 CDT
Begin processing the 34th record. run: 8106 subRun: 0 event: 61684 at 31-Oct-2025 10:47:05 CDT
Begin processing the 35th record. run: 8106 subRun: 0 event: 61685 at 31-Oct-2025 10:47:12 CDT
Begin processing the 36th record. run: 8106 subRun: 0 event: 61686 at 31-Oct-2025 10:47:18 CDT
Begin processing the 37th record. run: 8106 subRun: 0 event: 61687 at 31-Oct-2025 10:47:25 CDT
Begin processing the 38th record. run: 8106 subRun: 0 event: 61688 at 31-Oct-2025 10:47:33 CDT
Begin processing the 39th record. run: 8106 subRun: 0 event: 61689 at 31-Oct-2025 10:47:40 CDT
Begin processing the 40th record. run: 8106 subRun: 0 event: 61690 at 31-Oct-2025 10:47:47 CDT
Begin processing the 41st record. run: 8106 subRun: 0 event: 61691 at 31-Oct-2025 10:47:55 CDT
Begin processing the 42nd record. run: 8106 subRun: 0 event: 61692 at 31-Oct-2025 10:48:02 CDT
Begin processing the 43rd record. run: 8106 subRun: 0 event: 61693 at 31-Oct-2025 10:48:09 CDT
Begin processing the 44th record. run: 8106 subRun: 0 event: 61694 at 31-Oct-2025 10:48:16 CDT
Begin processing the 45th record. run: 8106 subRun: 0 event: 61695 at 31-Oct-2025 10:48:22 CDT
Begin processing the 46th record. run: 8106 subRun: 0 event: 61696 at 31-Oct-2025 10:48:29 CDT
Begin processing the 47th record. run: 8106 subRun: 0 event: 61697 at 31-Oct-2025 10:48:36 CDT
Begin processing the 48th record. run: 8106 subRun: 0 event: 61698 at 31-Oct-2025 10:48:43 CDT
Begin processing the 49th record. run: 8106 subRun: 0 event: 61699 at 31-Oct-2025 10:48:50 CDT
Begin processing the 50th record. run: 8106 subRun: 0 event: 61700 at 31-Oct-2025 10:48:56 CDT
31-Oct-2025 10:49:05 CDT Closed output file "prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T154233Z_reco.root"
31-Oct-2025 10:49:05 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.28062 6.80217 7.41605 6.77349 0.292391 50
-----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000349849 0.00307212 0.0479178 0.000475972 0.00968825 50
makers:tpmakerTPCsimpleThr:TriggerPrimitiveMakerTPC 3.28556 3.70068 4.25104 3.63635 0.256544 50
makers:tpmakerTPCabsRS:TriggerPrimitiveMakerTPC 2.82189 3.09428 3.37042 3.11234 0.118634 50
[art]:TriggerResults:TriggerResultInserter 2.3966e-05 4.78949e-05 0.000357544 3.8192e-05 4.81539e-05 50
end_path:out1:RootOutput 5.931e-06 9.99148e-06 4.4584e-05 8.516e-06 5.59682e-06 50
end_path:out1:RootOutput(write) 0.00182234 0.00329542 0.00888179 0.00225923 0.00161966 50
=========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 1537.16 MB
Peak resident set size usage (VmHWM): 792.969 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_20251031T154233Z_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_20251031T154233Z_reco.root
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T154233Z_reco.root.ext.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T154233Z_reco.root.json
prodmarley_nue_flat_es_dune10kt_1x2x2_20250926T165427Z_gen_001234_supernova_g4_detsim_20251031T154233Z_reco.root.temp.json
time.db
triggersim_hist.root