Jobsub ID 293869.22@justin-prod-sched01.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
AFM detsim jobscript.
Input PFN = root://xgate.hec.lancs.ac.uk:1094//cephfs/grid/dune/usertests/57/b4/000329_reco_data_2024-11-14T_092908Z_reco_data_2024-11-14T_140718Z.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 ===
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::Reframer : 37.420284 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::Reframer : 37.400223 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::Reframer : 37.230225 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::Reframer : 37.160263 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::DepoBagger : 36.54987 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::Reframer : 36.530304 sec
[23:59:30.874] I [ timer ] Timer: wcls::SimDepoSource : 20.280369 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::FrameFanin : 13.520213 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::DumpFrames : 13.280209 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::FrameFanin : 12.680195 sec
[23:59:30.874] I [ timer ] Timer: wcls::FrameSaver : 12.650194 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::FrameFanin : 12.320187 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::Retagger : 12.100182 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 11.60017 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 11.270163 sec
[23:59:30.874] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 10.890154 sec
[23:59:30.874] I [ timer ] Timer: Total node execution : 124438.49947834015 sec
wclsFrameSaver: saving 864 traces tagged "gauss"
FrameSaver: q=18059 n=9994 tag=gauss
wclsFrameSaver: saving 847 traces tagged "wiener"
FrameSaver: q=28283.3 n=10147 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
19-Nov-2024 23:59:31 GMT Closed output file "000329_reco_data_2024-11-14T_092908Z_reco_data_2024-11-14T_140718Z_reco_data_2024-11-18T_125448Z.root"
19-Nov-2024 23:59:31 GMT Closed input file "root://xgate.hec.lancs.ac.uk:1094//cephfs/grid/dune/usertests/57/b4/000329_reco_data_2024-11-14T_092908Z_reco_data_2024-11-14T_140718Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 96.4321 126.12 502.074 121.912 24.5799 1000
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000239195 0.00548697 0.871088 0.000706819 0.0366736 1000
simulate:tpcrawdecoder:WireCellToolkit 96.3945 125.951 496.268 121.77 24.3222 1000
simulate:opdigi:OpDetDigitizerDUNE 0.000238329 0.101436 4.34533 0.00110966 0.278751 1000
simulate:rns:RandomNumberSaver 2.7091e-05 3.55273e-05 0.000148577 3.4225e-05 6.46741e-06 1000
[art]:TriggerResults:TriggerResultInserter 1.1769e-05 1.50464e-05 4.0436e-05 1.46445e-05 2.41996e-06 1000
end_path:out1:RootOutput 4.096e-06 5.1148e-06 1.4906e-05 4.9255e-06 8.69846e-07 1000
end_path:out1:RootOutput(write) 0.0318492 0.0614323 1.46042 0.0380637 0.0888173 1000
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4338.68 MB
Peak resident set size usage (VmHWM): 2635.75 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 41029157
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 314159210
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 891919568
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000329_reco_data_2024-11-14T_092908Z_reco_data_2024-11-14T_140718Z_reco_data_2024-11-18T_125448Z.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": 1732060771.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": 1731934685.0
},
"parents": [
{
"did": "usertests:000329_reco_data_2024-11-14T_092908Z_reco_data_2024-11-14T_140718Z.root"
}
]
}
===================
.:
total 2531824
-rw-r--r-- 1 pltdune002 pltdune 2515978271 Nov 19 23:59 000329_reco_data_2024-11-14T_092908Z_reco_data_2024-11-14T_140718Z_reco_data_2024-11-18T_125448Z.root
-rw-r--r-- 1 pltdune002 pltdune 38601496 Nov 19 23:59 000329_reco_data_2024-11-14T_092908Z_reco_data_2024-11-14T_140718Z_reco_2024-11-18T_125448Z.log
-rw-r--r-- 1 pltdune002 pltdune 37962583 Nov 19 23:59 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 pltdune002 pltdune 6072 Nov 19 23:59 jobscript.log
-rw-r--r-- 1 pltdune002 pltdune 1115 Nov 19 23:59 000329_reco_data_2024-11-14T_092908Z_reco_data_2024-11-14T_140718Z_reco_data_2024-11-18T_125448Z.root.json
-rw-r--r-- 1 pltdune002 pltdune 930 Nov 19 23:59 000329_reco_data_2024-11-14T_092908Z_reco_data_2024-11-14T_140718Z_reco_data_2024-11-18T_125448Z.root.ext.json
-rw-r--r-- 1 pltdune002 pltdune 164 Nov 18 12:54 all-input-dids.txt
-rw-r--r-- 1 pltdune002 pltdune 140 Nov 19 23:59 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune002 pltdune 0 Nov 18 12:55 debugprod.log 