Jobsub ID 293869.18@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/88/0e/000805_reco_data_2024-11-14T_093438Z_reco_data_2024-11-14T_144206Z.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 ===
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::Reframer : 78.77872 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::Reframer : 78.45882 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::Reframer : 78.17875 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::Reframer : 77.688736 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::Reframer : 77.54878 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::Reframer : 77.30869 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::Reframer : 77.2687 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::DumpFrames : 50.85747 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::FrameFanin : 43.34874 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::FrameFanin : 41.798992 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::FrameFanin : 41.649025 sec
[14:32:11.044] I [ timer ] Timer: wcls::FrameSaver : 39.78933 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 39.569366 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::Retagger : 38.579533 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 38.11961 sec
[14:32:11.044] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 37.69968 sec
[14:32:11.044] I [ timer ] Timer: Total node execution : 171188.32053756714 sec
wclsFrameSaver: saving 862 traces tagged "gauss"
FrameSaver: q=17561.2 n=9842 tag=gauss
wclsFrameSaver: saving 846 traces tagged "wiener"
FrameSaver: q=27740.9 n=9997 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
20-Nov-2024 14:32:12 GMT Closed output file "000805_reco_data_2024-11-14T_093438Z_reco_data_2024-11-14T_144206Z_reco_data_2024-11-18T_125534Z.root"
20-Nov-2024 14:32:12 GMT Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/88/0e/000805_reco_data_2024-11-14T_093438Z_reco_data_2024-11-14T_144206Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 110.656 178.442 2273.24 168.01 89.3843 1000
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000270349 0.00314944 0.0605373 0.000961232 0.00765868 1000
simulate:tpcrawdecoder:WireCellToolkit 110.613 178.066 2248.8 167.904 88.4208 1000
simulate:opdigi:OpDetDigitizerDUNE 0.000278751 0.262099 22.1934 0.00387802 0.969413 1000
simulate:rns:RandomNumberSaver 2.9634e-05 7.38523e-05 0.00206498 6.6649e-05 9.64884e-05 1000
[art]:TriggerResults:TriggerResultInserter 1.4978e-05 2.85678e-05 0.000144455 2.8479e-05 1.05663e-05 1000
end_path:out1:RootOutput 5.005e-06 9.79983e-06 4.4558e-05 9.6485e-06 3.45281e-06 1000
end_path:out1:RootOutput(write) 0.0408023 0.110365 2.24509 0.0891266 0.145476 1000
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4723.44 MB
Peak resident set size usage (VmHWM): 3000.3 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 495432774
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 238048339
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 357566494
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000805_reco_data_2024-11-14T_093438Z_reco_data_2024-11-14T_144206Z_reco_data_2024-11-18T_125534Z.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": 1732113131.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": 1731934761.0
},
"parents": [
{
"did": "usertests:000805_reco_data_2024-11-14T_093438Z_reco_data_2024-11-14T_144206Z.root"
}
]
}
===================
.:
total 2750264
-rw-r--r-- 1 pltdune01 pltdune 2739661281 Nov 20 14:32 000805_reco_data_2024-11-14T_093438Z_reco_data_2024-11-14T_144206Z_reco_data_2024-11-18T_125534Z.root
-rw-r--r-- 1 pltdune01 pltdune 38603832 Nov 20 14:32 000805_reco_data_2024-11-14T_093438Z_reco_data_2024-11-14T_144206Z_reco_2024-11-18T_125534Z.log
-rw-r--r-- 1 pltdune01 pltdune 37964542 Nov 20 14:32 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 pltdune01 pltdune 6075 Nov 20 14:32 jobscript.log
-rw-r--r-- 1 pltdune01 pltdune 1115 Nov 20 14:32 000805_reco_data_2024-11-14T_093438Z_reco_data_2024-11-14T_144206Z_reco_data_2024-11-18T_125534Z.root.json
-rw-r--r-- 1 pltdune01 pltdune 930 Nov 20 14:32 000805_reco_data_2024-11-14T_093438Z_reco_data_2024-11-14T_144206Z_reco_data_2024-11-18T_125534Z.root.ext.json
-rw-r--r-- 1 pltdune01 pltdune 164 Nov 18 12:55 all-input-dids.txt
-rw-r--r-- 1 pltdune01 pltdune 145 Nov 20 14:32 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune01 pltdune 0 Nov 18 12:56 debugprod.log 