profiling.py
252 lines
| 8.0 KiB
| text/x-python
|
PythonLexer
/ mercurial / profiling.py
Gregory Szorc
|
r29781 | # profiling.py - profiling functions | ||
# | ||||
# Copyright 2016 Gregory Szorc <gregory.szorc@gmail.com> | ||||
# | ||||
# This software may be used and distributed according to the terms of the | ||||
# GNU General Public License version 2 or any later version. | ||||
from __future__ import absolute_import, print_function | ||||
Gregory Szorc
|
r29783 | import contextlib | ||
Gregory Szorc
|
r29781 | |||
from .i18n import _ | ||||
from . import ( | ||||
Pulkit Goyal
|
r30820 | encoding, | ||
Gregory Szorc
|
r29781 | error, | ||
Jun Wu
|
r32417 | extensions, | ||
Matt Harbison
|
r36701 | pycompat, | ||
Gregory Szorc
|
r29781 | util, | ||
) | ||||
Jun Wu
|
r32417 | def _loadprofiler(ui, profiler): | ||
"""load profiler extension. return profile method, or None on failure""" | ||||
extname = profiler | ||||
extensions.loadall(ui, whitelist=[extname]) | ||||
try: | ||||
mod = extensions.find(extname) | ||||
except KeyError: | ||||
return None | ||||
else: | ||||
return getattr(mod, 'profile', None) | ||||
Gregory Szorc
|
r29783 | @contextlib.contextmanager | ||
def lsprofile(ui, fp): | ||||
Jun Wu
|
r33499 | format = ui.config('profiling', 'format') | ||
field = ui.config('profiling', 'sort') | ||||
limit = ui.configint('profiling', 'limit') | ||||
climit = ui.configint('profiling', 'nested') | ||||
Gregory Szorc
|
r29781 | |||
if format not in ['text', 'kcachegrind']: | ||||
ui.warn(_("unrecognized profiling format '%s'" | ||||
" - Ignored\n") % format) | ||||
format = 'text' | ||||
try: | ||||
from . import lsprof | ||||
except ImportError: | ||||
raise error.Abort(_( | ||||
'lsprof not available - install from ' | ||||
'http://codespeak.net/svn/user/arigo/hack/misc/lsprof/')) | ||||
p = lsprof.Profiler() | ||||
p.enable(subcalls=True) | ||||
try: | ||||
Gregory Szorc
|
r29783 | yield | ||
Gregory Szorc
|
r29781 | finally: | ||
p.disable() | ||||
if format == 'kcachegrind': | ||||
from . import lsprofcalltree | ||||
calltree = lsprofcalltree.KCacheGrind(p) | ||||
calltree.output(fp) | ||||
else: | ||||
# format == 'text' | ||||
stats = lsprof.Stats(p.getstats()) | ||||
Gregory Szorc
|
r40228 | stats.sort(pycompat.sysstr(field)) | ||
Gregory Szorc
|
r29781 | stats.pprint(limit=limit, file=fp, climit=climit) | ||
Gregory Szorc
|
r29783 | @contextlib.contextmanager | ||
def flameprofile(ui, fp): | ||||
Gregory Szorc
|
r29781 | try: | ||
from flamegraph import flamegraph | ||||
except ImportError: | ||||
raise error.Abort(_( | ||||
'flamegraph not available - install from ' | ||||
'https://github.com/evanhempel/python-flamegraph')) | ||||
# developer config: profiling.freq | ||||
Jun Wu
|
r33499 | freq = ui.configint('profiling', 'freq') | ||
Gregory Szorc
|
r29781 | filter_ = None | ||
collapse_recursion = True | ||||
thread = flamegraph.ProfileThread(fp, 1.0 / freq, | ||||
filter_, collapse_recursion) | ||||
Simon Farnsworth
|
r30975 | start_time = util.timer() | ||
Gregory Szorc
|
r29781 | try: | ||
thread.start() | ||||
Gregory Szorc
|
r29783 | yield | ||
Gregory Szorc
|
r29781 | finally: | ||
thread.stop() | ||||
thread.join() | ||||
print('Collected %d stack frames (%d unique) in %2.2f seconds.' % ( | ||||
Simon Farnsworth
|
r30975 | util.timer() - start_time, thread.num_frames(), | ||
Gregory Szorc
|
r29781 | thread.num_frames(unique=True))) | ||
Gregory Szorc
|
r29783 | @contextlib.contextmanager | ||
def statprofile(ui, fp): | ||||
Gregory Szorc
|
r30316 | from . import statprof | ||
Gregory Szorc
|
r29781 | |||
Jun Wu
|
r33499 | freq = ui.configint('profiling', 'freq') | ||
Gregory Szorc
|
r29781 | if freq > 0: | ||
Gregory Szorc
|
r29785 | # Cannot reset when profiler is already active. So silently no-op. | ||
if statprof.state.profile_level == 0: | ||||
statprof.reset(freq) | ||||
Gregory Szorc
|
r29781 | else: | ||
ui.warn(_("invalid sampling frequency '%s' - ignoring\n") % freq) | ||||
Matt Harbison
|
r40469 | track = ui.config('profiling', 'time-track', | ||
pycompat.iswindows and 'cpu' or 'real') | ||||
Boris Feld
|
r38279 | statprof.start(mechanism='thread', track=track) | ||
Gregory Szorc
|
r30316 | |||
Gregory Szorc
|
r29781 | try: | ||
Gregory Szorc
|
r29783 | yield | ||
Gregory Szorc
|
r29781 | finally: | ||
Gregory Szorc
|
r30316 | data = statprof.stop() | ||
Jun Wu
|
r33499 | profformat = ui.config('profiling', 'statformat') | ||
Gregory Szorc
|
r30316 | |||
formats = { | ||||
'byline': statprof.DisplayFormats.ByLine, | ||||
'bymethod': statprof.DisplayFormats.ByMethod, | ||||
'hotpath': statprof.DisplayFormats.Hotpath, | ||||
'json': statprof.DisplayFormats.Json, | ||||
Bryan O'Sullivan
|
r30930 | 'chrome': statprof.DisplayFormats.Chrome, | ||
Gregory Szorc
|
r30316 | } | ||
if profformat in formats: | ||||
displayformat = formats[profformat] | ||||
else: | ||||
ui.warn(_('unknown profiler output format: %s\n') % profformat) | ||||
displayformat = statprof.DisplayFormats.Hotpath | ||||
Bryan O'Sullivan
|
r30930 | kwargs = {} | ||
def fraction(s): | ||||
r32978 | if isinstance(s, (float, int)): | |||
return float(s) | ||||
Bryan O'Sullivan
|
r30930 | if s.endswith('%'): | ||
v = float(s[:-1]) / 100 | ||||
else: | ||||
v = float(s) | ||||
if 0 <= v <= 1: | ||||
return v | ||||
raise ValueError(s) | ||||
if profformat == 'chrome': | ||||
showmin = ui.configwith(fraction, 'profiling', 'showmin', 0.005) | ||||
Boris Feld
|
r34411 | showmax = ui.configwith(fraction, 'profiling', 'showmax') | ||
Bryan O'Sullivan
|
r30930 | kwargs.update(minthreshold=showmin, maxthreshold=showmax) | ||
Gregory Szorc
|
r32851 | elif profformat == 'hotpath': | ||
Gregory Szorc
|
r33192 | # inconsistent config: profiling.showmin | ||
Gregory Szorc
|
r32851 | limit = ui.configwith(fraction, 'profiling', 'showmin', 0.05) | ||
Pulkit Goyal
|
r36418 | kwargs[r'limit'] = limit | ||
Bryan O'Sullivan
|
r30930 | |||
statprof.display(fp, data=data, format=displayformat, **kwargs) | ||||
Gregory Szorc
|
r29781 | |||
r32783 | class profile(object): | |||
Gregory Szorc
|
r29783 | """Start profiling. | ||
Profiling is active when the context manager is active. When the context | ||||
manager exits, profiling results will be written to the configured output. | ||||
""" | ||||
r32785 | def __init__(self, ui, enabled=True): | |||
r32783 | self._ui = ui | |||
self._output = None | ||||
self._fp = None | ||||
r32805 | self._fpdoclose = True | |||
r32783 | self._profiler = None | |||
r32785 | self._enabled = enabled | |||
r32784 | self._entered = False | |||
self._started = False | ||||
Gregory Szorc
|
r29781 | |||
r32783 | def __enter__(self): | |||
r32784 | self._entered = True | |||
r32785 | if self._enabled: | |||
self.start() | ||||
r32786 | return self | |||
r32784 | ||||
def start(self): | ||||
"""Start profiling. | ||||
The profiling will stop at the context exit. | ||||
If the profiler was already started, this has no effect.""" | ||||
if not self._entered: | ||||
raise error.ProgrammingError() | ||||
if self._started: | ||||
return | ||||
self._started = True | ||||
r32783 | profiler = encoding.environ.get('HGPROF') | |||
proffn = None | ||||
if profiler is None: | ||||
Boris Feld
|
r34413 | profiler = self._ui.config('profiling', 'type') | ||
r32783 | if profiler not in ('ls', 'stat', 'flame'): | |||
# try load profiler from extension with the same name | ||||
proffn = _loadprofiler(self._ui, profiler) | ||||
if proffn is None: | ||||
self._ui.warn(_("unrecognized profiler '%s' - ignored\n") | ||||
% profiler) | ||||
profiler = 'stat' | ||||
Gregory Szorc
|
r29781 | |||
r32783 | self._output = self._ui.config('profiling', 'output') | |||
Gregory Szorc
|
r29781 | |||
r32808 | try: | |||
r32807 | if self._output == 'blackbox': | |||
self._fp = util.stringio() | ||||
elif self._output: | ||||
path = self._ui.expandpath(self._output) | ||||
self._fp = open(path, 'wb') | ||||
Matt Harbison
|
r36701 | elif pycompat.iswindows: | ||
# parse escape sequence by win32print() | ||||
class uifp(object): | ||||
def __init__(self, ui): | ||||
self._ui = ui | ||||
def write(self, data): | ||||
self._ui.write_err(data) | ||||
def flush(self): | ||||
self._ui.flush() | ||||
self._fpdoclose = False | ||||
self._fp = uifp(self._ui) | ||||
r32807 | else: | |||
self._fpdoclose = False | ||||
self._fp = self._ui.ferr | ||||
r32783 | ||||
r32807 | if proffn is not None: | |||
pass | ||||
elif profiler == 'ls': | ||||
proffn = lsprofile | ||||
elif profiler == 'flame': | ||||
proffn = flameprofile | ||||
else: | ||||
proffn = statprofile | ||||
Gregory Szorc
|
r29783 | |||
r32807 | self._profiler = proffn(self._ui, self._fp) | |||
self._profiler.__enter__() | ||||
r32808 | except: # re-raises | |||
self._closefp() | ||||
raise | ||||
Gregory Szorc
|
r29783 | |||
r32783 | def __exit__(self, exception_type, exception_value, traceback): | |||
r32810 | propagate = None | |||
r32809 | if self._profiler is not None: | |||
r32810 | propagate = self._profiler.__exit__(exception_type, exception_value, | |||
traceback) | ||||
r32809 | if self._output == 'blackbox': | |||
val = 'Profile:\n%s' % self._fp.getvalue() | ||||
# ui.log treats the input as a format string, | ||||
# so we need to escape any % signs. | ||||
val = val.replace('%', '%%') | ||||
self._ui.log('profile', val) | ||||
r32806 | self._closefp() | |||
r32810 | return propagate | |||
r32804 | ||||
def _closefp(self): | ||||
r32805 | if self._fpdoclose and self._fp is not None: | |||
self._fp.close() | ||||