Jobsub ID 293869.30@justin-prod-sched01.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
AFM detsim jobscript.
Input PFN = root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/8d/bf/000573_reco_data_2024-11-14T_093215Z_reco_data_2024-11-14T_140735Z.root
Setting up larsoft UPS area... /cvmfs/larsoft.opensciencegrid.org
Setting up DUNE UPS area... /cvmfs/dune.opensciencegrid.org/products/dune/
/cvmfs/larsoft.opensciencegrid.org/products/xrootd/v5_4_3b/Linux64bit+3.10-2.17-e20-p3913-prof/lib/libXrdPosixPreload.so
=== Start last 50 lines of lar log file ===
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::Reframer : 73.58854 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::Reframer : 73.418465 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::Reframer : 73.33841 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::Reframer : 73.32841 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::Reframer : 73.26849 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::Reframer : 72.43838 sec
[13:48:02.418] I [ timer ] Timer: wcls::SimDepoSource : 69.8065 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::DumpFrames : 46.078274 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::FrameFanin : 40.129272 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::FrameFanin : 38.699516 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::FrameFanin : 37.889645 sec
[13:48:02.418] I [ timer ] Timer: wcls::FrameSaver : 37.51971 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 36.179935 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 35.869987 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::Retagger : 35.720013 sec
[13:48:02.418] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 34.880154 sec
[13:48:02.418] I [ timer ] Timer: Total node execution : 168813.73538970947 sec
wclsFrameSaver: saving 1011 traces tagged "gauss"
FrameSaver: q=20442.8 n=11461 tag=gauss
wclsFrameSaver: saving 995 traces tagged "wiener"
FrameSaver: q=31659.8 n=11529 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
20-Nov-2024 13:48:08 GMT Closed output file "000573_reco_data_2024-11-14T_093215Z_reco_data_2024-11-14T_140735Z_reco_data_2024-11-18T_125515Z.root"
20-Nov-2024 13:48:08 GMT Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/8d/bf/000573_reco_data_2024-11-14T_093215Z_reco_data_2024-11-14T_140735Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 108.468 175.778 994.071 164.743 58.6498 1000
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000233449 0.00275749 0.0680675 0.000910685 0.0067309 1000
simulate:tpcrawdecoder:WireCellToolkit 108.39 175.429 979.841 164.522 57.9955 1000
simulate:opdigi:OpDetDigitizerDUNE 0.000219291 0.234458 12.124 0.00369561 0.729065 1000
simulate:rns:RandomNumberSaver 2.6228e-05 7.25237e-05 0.000917995 6.87235e-05 4.55356e-05 1000
[art]:TriggerResults:TriggerResultInserter 1.1877e-05 2.32972e-05 0.000117081 2.3381e-05 8.55116e-06 1000
end_path:out1:RootOutput 3.184e-06 9.92385e-06 3.3366e-05 9.7195e-06 3.4055e-06 1000
end_path:out1:RootOutput(write) 0.041327 0.110554 2.07018 0.0892271 0.139636 1000
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4408.35 MB
Peak resident set size usage (VmHWM): 2719.58 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 325156875
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 263294170
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 698152197
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000573_reco_data_2024-11-14T_093215Z_reco_data_2024-11-14T_140735Z_reco_data_2024-11-18T_125515Z.root
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
"metadata": {
"DUNE.campaign": "justIN.w4131s1",
"art.file_format_era": "ART_2011a",
"art.file_format_version": 15,
"art.first_event": 1,
"art.last_event": 1000,
"art.process_name": "detsim",
"art.run_type": "physics",
"core.application": "art.reco",
"core.application.family": "art",
"core.application.name": "reco",
"core.application.version": "v09_75_03d00",
"core.data_stream": "out1",
"core.data_tier": "detector-simulated",
"core.end_time": 1732110488.0,
"core.event_count": 1000,
"core.file_format": "artroot",
"core.file_type": "mc",
"core.first_event_number": 1,
"core.last_event_number": 1000,
"core.run_type": "physics",
"core.runs": [
20000031
],
"core.runs_subruns": [
2000003100000
],
"core.start_time": 1731934788.0
},
"parents": [
{
"did": "usertests:000573_reco_data_2024-11-14T_093215Z_reco_data_2024-11-14T_140735Z.root"
}
]
}
===================
.:
total 2645224
-rw-r--r-- 1 pltdune01 pltdune 2632092135 Nov 20 13:48 000573_reco_data_2024-11-14T_093215Z_reco_data_2024-11-14T_140735Z_reco_data_2024-11-18T_125515Z.root
-rw-r--r-- 1 pltdune01 pltdune 38605380 Nov 20 13:48 000573_reco_data_2024-11-14T_093215Z_reco_data_2024-11-14T_140735Z_reco_2024-11-18T_125515Z.log
-rw-r--r-- 1 pltdune01 pltdune 37966317 Nov 20 13:48 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 pltdune01 pltdune 6079 Nov 20 13:48 jobscript.log
-rw-r--r-- 1 pltdune01 pltdune 1115 Nov 20 13:48 000573_reco_data_2024-11-14T_093215Z_reco_data_2024-11-14T_140735Z_reco_data_2024-11-18T_125515Z.root.json
-rw-r--r-- 1 pltdune01 pltdune 930 Nov 20 13:48 000573_reco_data_2024-11-14T_093215Z_reco_data_2024-11-14T_140735Z_reco_data_2024-11-18T_125515Z.root.ext.json
-rw-r--r-- 1 pltdune01 pltdune 164 Nov 18 12:54 all-input-dids.txt
-rw-r--r-- 1 pltdune01 pltdune 145 Nov 20 13:48 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune01 pltdune 0 Nov 18 12:55 debugprod.log 