pungi/pungi/profiler.py
Lubomír Sedlář c7121f9378 profiler: Flush stdout before printing
Apparently redirecting stderr to the same pipe as stdout does not
guarantee that the data will not be mangled together.

Flushing stdout before the profiler data is printed should ensure that
it does not end up in the middle of some RPM path.

Fixes: https://pagure.io/pungi/issue/1627
Signed-off-by: Lubomír Sedlář <lsedlar@redhat.com>
2022-08-29 05:57:14 +00:00

82 lines
2.1 KiB
Python

# -*- coding: utf-8 -*-
# This program is free software; you can redistribute it and/or modify
# it under the terms of the GNU General Public License as published by
# the Free Software Foundation; version 2 of the License.
#
# This program is distributed in the hope that it will be useful,
# but WITHOUT ANY WARRANTY; without even the implied warranty of
# MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
# GNU Library General Public License for more details.
#
# You should have received a copy of the GNU General Public License
# along with this program; if not, see <https://gnu.org/licenses/>.
"""
Simple profiler that collects time spent in functions
or code blocks and also call counts.
Usage
=====
@Profiler("label1")
def func():
...
or
with Profiler("label2"):
...
To print profiling data, run:
Profiler.print_results()
"""
from __future__ import print_function
import functools
import sys
import time
class Profiler(object):
_data = {}
def __init__(self, name):
self.name = name
self._data.setdefault(name, {"time": 0, "calls": 0})
def __enter__(self):
self.start = time.time()
def __exit__(self, ty, val, tb):
delta = time.time() - self.start
self._data[self.name]["time"] += delta
self._data[self.name]["calls"] += 1
def __call__(self, func):
@functools.wraps(func)
def decorated(*args, **kwargs):
with self:
return func(*args, **kwargs)
return decorated
@classmethod
def print_results(cls, stream=sys.stdout):
# Ensure all data that was printed to stdout was already flushed. If
# the caller is redirecting stderr to stdout, and there's buffered
# data, we may end up in a situation where the stderr output printed
# below ends up mixed with the stdout lines.
sys.stdout.flush()
print("Profiling results:", file=stream)
results = cls._data.items()
results = sorted(results, key=lambda x: x[1]["time"], reverse=True)
for name, data in results:
print(" %6.2f %5d %s" % (data["time"], data["calls"], name), file=stream)