Jobsub ID 272059.43@justin-prod-sched01.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
AFM detsim jobscript.
Input PFN = root://golias100.farm.particle.cz:1094/dpm/farm.particle.cz/home/dune/RSE/usertests/bd/58/000569_reco_data_2024-10-07T_115757Z_reco_data_2024-10-08T_104657Z.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 ===
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Reframer : 44.23859 sec
[15:15:32.709] I [ timer ] Timer: wcls::FrameSaver : 44.06861 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Reframer : 43.99864 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 43.46871 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Reframer : 43.428734 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 43.198757 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Retagger : 43.14877 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Reframer : 43.128773 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Reframer : 43.11879 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Reframer : 43.09881 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Reframer : 43.088806 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 43.06878 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Reframer : 42.948814 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::FrameFanin : 42.52889 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::Reframer : 42.49889 sec
[15:15:32.709] I [ timer ] Timer: WireCell::Gen::FrameFanin : 42.328903 sec
[15:15:32.709] I [ timer ] Timer: Total node execution : 7450.929870605469 sec
wclsFrameSaver: saving 856 traces tagged "gauss"
FrameSaver: q=19307.1 n=10239 tag=gauss
wclsFrameSaver: saving 858 traces tagged "wiener"
FrameSaver: q=29054.1 n=10287 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
09-Oct-2024 15:15:35 CEST Closed output file "000569_reco_data_2024-10-07T_115757Z_reco_data_2024-10-08T_104657Z_reco_data_2024-10-09T_100846Z.root"
09-Oct-2024 15:15:35 CEST Closed input file "root://golias100.farm.particle.cz:1094/dpm/farm.particle.cz/home/dune/RSE/usertests/bd/58/000569_reco_data_2024-10-07T_115757Z_reco_data_2024-10-08T_104657Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 139.354 790.037 7868.82 185.758 1970.04 14
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000794241 0.0019181 0.00489171 0.00178893 0.00113501 14
simulate:tpcrawdecoder:WireCellToolkit 138.957 781.976 7772.33 185.193 1945.44 14
simulate:opdigi:OpDetDigitizerDUNE 0.00065504 6.98007 85.0445 0.379533 21.7135 14
simulate:rns:RandomNumberSaver 5.4903e-05 0.000125915 0.00041021 7.8397e-05 0.000116815 14
[art]:TriggerResults:TriggerResultInserter 1.7893e-05 3.47761e-05 0.000105539 2.85785e-05 2.16721e-05 14
end_path:out1:RootOutput 7.043e-06 1.27389e-05 4.1558e-05 9.458e-06 8.63093e-06 14
end_path:out1:RootOutput(write) 0.0555517 1.07739 11.4317 0.181771 2.88795 14
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 12802.3 MB
Peak resident set size usage (VmHWM): 10545.1 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 596472845
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 157149672
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 365569816
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000569_reco_data_2024-10-07T_115757Z_reco_data_2024-10-08T_104657Z_reco_data_2024-10-09T_100846Z.root
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
"metadata": {
"DUNE.campaign": "justIN.w3659s1",
"art.file_format_era": "ART_2011a",
"art.file_format_version": 15,
"art.first_event": 84,
"art.last_event": 918,
"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": 1728479735.0,
"core.event_count": 14,
"core.file_format": "artroot",
"core.file_type": "mc",
"core.first_event_number": 84,
"core.last_event_number": 918,
"core.run_type": "physics",
"core.runs": [
20000031
],
"core.runs_subruns": [
2000003100000
],
"core.start_time": 1728468763.0
},
"parents": [
{
"did": "usertests:000569_reco_data_2024-10-07T_115757Z_reco_data_2024-10-08T_104657Z.root"
}
]
}
===================
.:
total 2105976
-rw-r--r-- 1 fermilab users 2155242936 Oct 9 15:15 000569_reco_data_2024-10-07T_115757Z_reco_data_2024-10-08T_104657Z_reco_data_2024-10-09T_100846Z.root
-rw-r--r-- 1 fermilab users 623509 Oct 9 15:15 000569_reco_data_2024-10-07T_115757Z_reco_data_2024-10-08T_104657Z_reco_2024-10-09T_100846Z.log
-rw-r--r-- 1 fermilab users 608564 Oct 9 15:15 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 fermilab users 6109 Oct 9 15:15 jobscript.log
-rw-r--r-- 1 fermilab users 1113 Oct 9 15:15 000569_reco_data_2024-10-07T_115757Z_reco_data_2024-10-08T_104657Z_reco_data_2024-10-09T_100846Z.root.json
-rw-r--r-- 1 fermilab users 928 Oct 9 15:15 000569_reco_data_2024-10-07T_115757Z_reco_data_2024-10-08T_104657Z_reco_data_2024-10-09T_100846Z.root.ext.json
-rw-r--r-- 1 fermilab users 164 Oct 9 12:08 all-input-dids.txt
-rw-r--r-- 1 fermilab users 162 Oct 9 15:15 justin-processed-pfns.txt
-rw-r--r-- 1 fermilab users 0 Oct 9 12:09 debugprod.log 