Jobsub ID 243527.5@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
ctor: ROI building service: @0x1b17030
StandardRawDigitPrepService::ctor: Fetching wire building service.
StandardRawDigitPrepService::ctor: Wire building service: @0x1b170a0
StandardRawDigitPrepService::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).
05-Nov-2025 14:25:20 CET Initiating request to open input file "root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/48/73/prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim.root"
05-Nov-2025 14:25:22 CET Opened input file "root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/48/73/prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim.root"
Begin processing the 1st record. run: 1845 subRun: 0 event: 6051 at 05-Nov-2025 14:25:23 CET
05-Nov-2025 14:25:32 CET Opened output file with pattern "prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim_20251105T132501Z_reco.root"
Begin processing the 2nd record. run: 1845 subRun: 0 event: 6052 at 05-Nov-2025 14:25:51 CET
Begin processing the 3rd record. run: 1845 subRun: 0 event: 6053 at 05-Nov-2025 14:26:00 CET
Begin processing the 4th record. run: 1845 subRun: 0 event: 6054 at 05-Nov-2025 14:26:08 CET
Begin processing the 5th record. run: 1845 subRun: 0 event: 6055 at 05-Nov-2025 14:26:17 CET
Begin processing the 6th record. run: 1845 subRun: 0 event: 6056 at 05-Nov-2025 14:26:26 CET
Begin processing the 7th record. run: 1845 subRun: 0 event: 6057 at 05-Nov-2025 14:26:35 CET
Begin processing the 8th record. run: 1845 subRun: 0 event: 6058 at 05-Nov-2025 14:26:43 CET
Begin processing the 9th record. run: 1845 subRun: 0 event: 6059 at 05-Nov-2025 14:26:52 CET
Begin processing the 10th record. run: 1845 subRun: 0 event: 6060 at 05-Nov-2025 14:27:00 CET
Begin processing the 11th record. run: 1845 subRun: 0 event: 6061 at 05-Nov-2025 14:27:09 CET
Begin processing the 12th record. run: 1845 subRun: 0 event: 6062 at 05-Nov-2025 14:27:18 CET
Begin processing the 13th record. run: 1845 subRun: 0 event: 6063 at 05-Nov-2025 14:27:26 CET
Begin processing the 14th record. run: 1845 subRun: 0 event: 6064 at 05-Nov-2025 14:27:35 CET
Begin processing the 15th record. run: 1845 subRun: 0 event: 6065 at 05-Nov-2025 14:27:43 CET
Begin processing the 16th record. run: 1845 subRun: 0 event: 6066 at 05-Nov-2025 14:27:52 CET
Begin processing the 17th record. run: 1845 subRun: 0 event: 6067 at 05-Nov-2025 14:28:01 CET
Begin processing the 18th record. run: 1845 subRun: 0 event: 6068 at 05-Nov-2025 14:28:09 CET
Begin processing the 19th record. run: 1845 subRun: 0 event: 6069 at 05-Nov-2025 14:28:18 CET
Begin processing the 20th record. run: 1845 subRun: 0 event: 6070 at 05-Nov-2025 14:28:26 CET
Begin processing the 21st record. run: 1845 subRun: 0 event: 6071 at 05-Nov-2025 14:28:35 CET
Begin processing the 22nd record. run: 1845 subRun: 0 event: 6072 at 05-Nov-2025 14:28:44 CET
Begin processing the 23rd record. run: 1845 subRun: 0 event: 6073 at 05-Nov-2025 14:28:52 CET
Begin processing the 24th record. run: 1845 subRun: 0 event: 6074 at 05-Nov-2025 14:29:01 CET
Begin processing the 25th record. run: 1845 subRun: 0 event: 6075 at 05-Nov-2025 14:29:10 CET
Begin processing the 26th record. run: 1845 subRun: 0 event: 6076 at 05-Nov-2025 14:29:18 CET
Begin processing the 27th record. run: 1845 subRun: 0 event: 6077 at 05-Nov-2025 14:29:27 CET
Begin processing the 28th record. run: 1845 subRun: 0 event: 6078 at 05-Nov-2025 14:29:35 CET
Begin processing the 29th record. run: 1845 subRun: 0 event: 6079 at 05-Nov-2025 14:29:44 CET
Begin processing the 30th record. run: 1845 subRun: 0 event: 6080 at 05-Nov-2025 14:29:53 CET
Begin processing the 31st record. run: 1845 subRun: 0 event: 6081 at 05-Nov-2025 14:30:01 CET
Begin processing the 32nd record. run: 1845 subRun: 0 event: 6082 at 05-Nov-2025 14:30:10 CET
Begin processing the 33rd record. run: 1845 subRun: 0 event: 6083 at 05-Nov-2025 14:30:19 CET
Begin processing the 34th record. run: 1845 subRun: 0 event: 6084 at 05-Nov-2025 14:30:27 CET
Begin processing the 35th record. run: 1845 subRun: 0 event: 6085 at 05-Nov-2025 14:30:36 CET
Begin processing the 36th record. run: 1845 subRun: 0 event: 6086 at 05-Nov-2025 14:30:44 CET
Begin processing the 37th record. run: 1845 subRun: 0 event: 6087 at 05-Nov-2025 14:30:53 CET
Begin processing the 38th record. run: 1845 subRun: 0 event: 6088 at 05-Nov-2025 14:31:02 CET
Begin processing the 39th record. run: 1845 subRun: 0 event: 6089 at 05-Nov-2025 14:31:10 CET
Begin processing the 40th record. run: 1845 subRun: 0 event: 6090 at 05-Nov-2025 14:31:19 CET
Begin processing the 41st record. run: 1845 subRun: 0 event: 6091 at 05-Nov-2025 14:31:27 CET
Begin processing the 42nd record. run: 1845 subRun: 0 event: 6092 at 05-Nov-2025 14:31:36 CET
Begin processing the 43rd record. run: 1845 subRun: 0 event: 6093 at 05-Nov-2025 14:31:45 CET
Begin processing the 44th record. run: 1845 subRun: 0 event: 6094 at 05-Nov-2025 14:31:53 CET
Begin processing the 45th record. run: 1845 subRun: 0 event: 6095 at 05-Nov-2025 14:32:02 CET
Begin processing the 46th record. run: 1845 subRun: 0 event: 6096 at 05-Nov-2025 14:32:11 CET
Begin processing the 47th record. run: 1845 subRun: 0 event: 6097 at 05-Nov-2025 14:32:19 CET
Begin processing the 48th record. run: 1845 subRun: 0 event: 6098 at 05-Nov-2025 14:32:28 CET
Begin processing the 49th record. run: 1845 subRun: 0 event: 6099 at 05-Nov-2025 14:32:36 CET
Begin processing the 50th record. run: 1845 subRun: 0 event: 6100 at 05-Nov-2025 14:32:45 CET
05-Nov-2025 14:32:55 CET Closed output file "prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim_20251105T132501Z_reco.root"
05-Nov-2025 14:32:55 CET Closed input file "root://se1.farm.particle.cz:1094//dune/RSE/fardet-hd/48/73/prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim.root"
=========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
=========================================================================================================================================
Full event 8.33599 8.41586 8.66848 8.40602 0.0475967 50
-----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000259919 0.00192463 0.0161252 0.000313228 0.00460013 50
makers:tpmakerTPCsimpleThr:TriggerPrimitiveMakerTPC 4.44899 4.52223 4.60391 4.51981 0.024862 50
makers:tpmakerTPCabsRS:TriggerPrimitiveMakerTPC 3.87538 3.88901 4.10348 3.88213 0.0325949 50
[art]:TriggerResults:TriggerResultInserter 1.7006e-05 2.24472e-05 0.000101932 1.97595e-05 1.24153e-05 50
end_path:out1:RootOutput 4.287e-06 5.14768e-06 2.2214e-05 4.7165e-06 2.49391e-06 50
end_path:out1:RootOutput(write) 0.0018957 0.00208937 0.00294055 0.00206905 0.000159984 50
=========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 1535.15 MB
Peak resident set size usage (VmHWM): 802.361 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Moving on to metadata extractor
============OUTPUT FILE: prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim_20251105T132501Z_reco.root
Extracted metadata
checking file====== fardet-hd:prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim.root
MD conversion to MetaCat OK
all-input-dids.txt
debugprod.log
did.list
file.list
jobscript.log
mem.db
old_md.json
prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim_20251105T132501Z_reco.root
prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim_20251105T132501Z_reco.root.ext.json
prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim_20251105T132501Z_reco.root.json
prodmarley_nue_flat_cc_dune10kt_1x2x2_20250826T091438Z_gen_000122_supernova_g4_detsim_20251105T132501Z_reco.root.temp.json
temp_pfns.txt
time.db
triggersim_hist.root