~bzr-pqm/bzr/bzr.dev

1185.33.86 by Martin Pool
Add additional module for lsprof.
1
# this is copied from the lsprof distro because somehow
2
# it is not installed by distutils
3
# I made one modification to profile so that it returns a pair
4
# instead of just the Stats object
5
2493.2.3 by Ian Clatworthy
changes requested in jameinel's review incorporated
6
import cPickle
7
import os
1185.33.86 by Martin Pool
Add additional module for lsprof.
8
import sys
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
9
import thread
10
import threading
1773.4.1 by Martin Pool
Add pyflakes makefile target; fix many warnings
11
from _lsprof import Profiler, profiler_entry
1185.33.86 by Martin Pool
Add additional module for lsprof.
12
2805.7.4 by Ian Clatworthy
incorporate feedback from lifeless
13
14
import bzrlib.osutils
15
16
1185.33.86 by Martin Pool
Add additional module for lsprof.
17
__all__ = ['profile', 'Stats']
18
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
19
_g_threadmap = {}
20
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
21
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
22
def _thread_profile(f, *args, **kwds):
23
    # we lose the first profile point for a new thread in order to trampoline
24
    # a new Profile object into place
25
    global _g_threadmap
26
    thr = thread.get_ident()
27
    _g_threadmap[thr] = p = Profiler()
28
    # this overrides our sys.setprofile hook:
1706.2.7 by Robey Pointer
pull over some changes from the original lsprof
29
    p.enable(subcalls=True, builtins=True)
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
30
31
1185.33.86 by Martin Pool
Add additional module for lsprof.
32
def profile(f, *args, **kwds):
33
    """XXX docstring"""
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
34
    global _g_threadmap
1185.33.86 by Martin Pool
Add additional module for lsprof.
35
    p = Profiler()
36
    p.enable(subcalls=True)
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
37
    threading.setprofile(_thread_profile)
2805.7.1 by Ian Clatworthy
Dump profiling data even when exceptions are encountered
38
    # Note: The except clause is needed below so that profiling data still
39
    # gets dumped even when exceptions are encountered. The except clause code
40
    # is taken straight from run_bzr_catch_errrors() in commands.py and ought
41
    # to be kept in sync with it.
1185.33.86 by Martin Pool
Add additional module for lsprof.
42
    try:
2805.7.4 by Ian Clatworthy
incorporate feedback from lifeless
43
        try:
44
            ret = f(*args, **kwds)
2805.7.6 by Ian Clatworthy
put back KeyboardInterrupt trapping as needed for Python 2.5
45
        except (KeyboardInterrupt, Exception), e:
2805.7.4 by Ian Clatworthy
incorporate feedback from lifeless
46
            import bzrlib.trace
47
            bzrlib.trace.report_exception(sys.exc_info(), sys.stderr)
48
            ret = 3
1185.33.86 by Martin Pool
Add additional module for lsprof.
49
    finally:
50
        p.disable()
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
51
        for pp in _g_threadmap.values():
52
            pp.disable()
53
        threading.setprofile(None)
54
    
55
    threads = {}
56
    for tid, pp in _g_threadmap.items():
57
        threads[tid] = Stats(pp.getstats(), {})
58
    _g_threadmap = {}
59
    return ret, Stats(p.getstats(), threads)
1185.33.86 by Martin Pool
Add additional module for lsprof.
60
61
62
class Stats(object):
63
    """XXX docstring"""
64
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
65
    def __init__(self, data, threads):
1185.33.86 by Martin Pool
Add additional module for lsprof.
66
        self.data = data
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
67
        self.threads = threads
1185.33.86 by Martin Pool
Add additional module for lsprof.
68
69
    def sort(self, crit="inlinetime"):
70
        """XXX docstring"""
71
        if crit not in profiler_entry.__dict__:
72
            raise ValueError, "Can't sort by %s" % crit
73
        self.data.sort(lambda b, a: cmp(getattr(a, crit),
74
                                        getattr(b, crit)))
75
        for e in self.data:
76
            if e.calls:
77
                e.calls.sort(lambda b, a: cmp(getattr(a, crit),
78
                                              getattr(b, crit)))
79
80
    def pprint(self, top=None, file=None):
81
        """XXX docstring"""
82
        if file is None:
83
            file = sys.stdout
84
        d = self.data
85
        if top is not None:
86
            d = d[:top]
87
        cols = "% 12s %12s %11.4f %11.4f   %s\n"
88
        hcols = "% 12s %12s %12s %12s %s\n"
89
        cols2 = "+%12s %12s %11.4f %11.4f +  %s\n"
90
        file.write(hcols % ("CallCount", "Recursive", "Total(ms)",
91
                            "Inline(ms)", "module:lineno(function)"))
92
        for e in d:
93
            file.write(cols % (e.callcount, e.reccallcount, e.totaltime,
94
                               e.inlinetime, label(e.code)))
95
            if e.calls:
96
                for se in e.calls:
97
                    file.write(cols % ("+%s" % se.callcount, se.reccallcount,
98
                                       se.totaltime, se.inlinetime,
99
                                       "+%s" % label(se.code)))
100
101
    def freeze(self):
102
        """Replace all references to code objects with string
103
        descriptions; this makes it possible to pickle the instance."""
104
105
        # this code is probably rather ickier than it needs to be!
106
        for i in range(len(self.data)):
107
            e = self.data[i]
108
            if not isinstance(e.code, str):
109
                self.data[i] = type(e)((label(e.code),) + e[1:])
1706.2.7 by Robey Pointer
pull over some changes from the original lsprof
110
            if e.calls:
111
                for j in range(len(e.calls)):
112
                    se = e.calls[j]
113
                    if not isinstance(se.code, str):
114
                        e.calls[j] = type(se)((label(se.code),) + se[1:])
1553.7.2 by Robey Pointer
add threading support -- each thread created during an lsprof session gets its own profile object, and the Stats objects are attached to a 'threads' member of the final Stats object
115
        for s in self.threads.values():
116
            s.freeze()
117
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
118
    def calltree(self, file):
119
        """Output profiling data in calltree format (for KCacheGrind)."""
120
        _CallTreeFilter(self.data).output(file)
121
2493.2.3 by Ian Clatworthy
changes requested in jameinel's review incorporated
122
    def save(self, filename, format=None):
123
        """Save profiling data to a file.
124
125
        :param filename: the name of the output file
126
        :param format: 'txt' for a text representation;
127
            'callgrind' for calltree format;
128
            otherwise a pickled Python object. A format of None indicates
2654.2.2 by Ian Clatworthy
Put all format detection stuff in one spot as requested by John Arbash Meinel
129
            that the format to use is to be found from the filename. If
130
            the name starts with callgrind.out, callgrind format is used
131
            otherwise the format is given by the filename extension.
2493.2.3 by Ian Clatworthy
changes requested in jameinel's review incorporated
132
        """
133
        if format is None:
2805.7.4 by Ian Clatworthy
incorporate feedback from lifeless
134
            basename = bzrlib.osutils.basename(filename)
2805.7.2 by Ian Clatworthy
use basename, not full path, when checking for callgrind.out file prefix
135
            if basename.startswith('callgrind.out'):
2654.2.2 by Ian Clatworthy
Put all format detection stuff in one spot as requested by John Arbash Meinel
136
                format = "callgrind"
137
            else:
2805.7.4 by Ian Clatworthy
incorporate feedback from lifeless
138
                ext = bzrlib.osutils.splitext(filename)[1]
2654.2.2 by Ian Clatworthy
Put all format detection stuff in one spot as requested by John Arbash Meinel
139
                if len(ext) > 1:
140
                    format = ext[1:]
2493.2.3 by Ian Clatworthy
changes requested in jameinel's review incorporated
141
        outfile = open(filename, 'wb')
142
        try:
143
            if format == "callgrind":
144
                self.calltree(outfile)
145
            elif format == "txt":
146
                self.pprint(file=outfile)
147
            else:
148
                self.freeze()
149
                cPickle.dump(self, outfile, 2)
150
        finally:
151
            outfile.close()
152
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
153
154
class _CallTreeFilter(object):
2493.2.2 by Ian Clatworthy
Incorporate feedback from Robert Collins
155
    """Converter of a Stats object to input suitable for KCacheGrind.
156
157
    This code is taken from http://ddaa.net/blog/python/lsprof-calltree
158
    with the changes made by J.P. Calderone and Itamar applied. Note that
159
    isinstance(code, str) needs to be used at times to determine if the code 
160
    object is actually an external code object (with a filename, etc.) or
161
    a Python built-in.
162
    """
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
163
164
    def __init__(self, data):
165
        self.data = data
166
        self.out_file = None
167
168
    def output(self, out_file):
169
        self.out_file = out_file        
2911.6.1 by Blake Winton
Change 'print >> f,'s to 'f.write('s.
170
        out_file.write('events: Ticks\n')
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
171
        self._print_summary()
172
        for entry in self.data:
173
            self._entry(entry)
174
175
    def _print_summary(self):
176
        max_cost = 0
177
        for entry in self.data:
178
            totaltime = int(entry.totaltime * 1000)
179
            max_cost = max(max_cost, totaltime)
2911.6.1 by Blake Winton
Change 'print >> f,'s to 'f.write('s.
180
        self.out_file.write('summary: %d\n' % (max_cost,))
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
181
182
    def _entry(self, entry):
183
        out_file = self.out_file
184
        code = entry.code
185
        inlinetime = int(entry.inlinetime * 1000)
2911.6.1 by Blake Winton
Change 'print >> f,'s to 'f.write('s.
186
        #out_file.write('ob=%s\n' % (code.co_filename,))
187
        if isinstance(code, str):
188
            out_file.write('fi=~\n')
189
        else:
190
            out_file.write('fi=%s\n' % (code.co_filename,))
191
        out_file.write('fn=%s\n' % (label(code, True),))
192
        if isinstance(code, str):
2911.6.4 by Blake Winton
Fix test failures
193
            out_file.write('0  %s\n' % (inlinetime,))
2911.6.1 by Blake Winton
Change 'print >> f,'s to 'f.write('s.
194
        else:
195
            out_file.write('%d %d\n' % (code.co_firstlineno, inlinetime))
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
196
        # recursive calls are counted in entry.calls
197
        if entry.calls:
198
            calls = entry.calls
199
        else:
200
            calls = []
2493.2.1 by Ian Clatworthy
make profiling information easier to view and better documented
201
        if isinstance(code, str):
202
            lineno = 0
203
        else:
204
            lineno = code.co_firstlineno
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
205
        for subentry in calls:
2493.2.1 by Ian Clatworthy
make profiling information easier to view and better documented
206
            self._subentry(lineno, subentry)
2911.6.1 by Blake Winton
Change 'print >> f,'s to 'f.write('s.
207
        out_file.write('\n')
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
208
209
    def _subentry(self, lineno, subentry):
210
        out_file = self.out_file
211
        code = subentry.code
212
        totaltime = int(subentry.totaltime * 1000)
2911.6.1 by Blake Winton
Change 'print >> f,'s to 'f.write('s.
213
        #out_file.write('cob=%s\n' % (code.co_filename,))
214
        out_file.write('cfn=%s\n' % (label(code, True),))
2493.2.1 by Ian Clatworthy
make profiling information easier to view and better documented
215
        if isinstance(code, str):
2911.6.1 by Blake Winton
Change 'print >> f,'s to 'f.write('s.
216
            out_file.write('cfi=~\n')
217
            out_file.write('calls=%d 0\n' % (subentry.callcount,))
2493.2.1 by Ian Clatworthy
make profiling information easier to view and better documented
218
        else:
2911.6.1 by Blake Winton
Change 'print >> f,'s to 'f.write('s.
219
            out_file.write('cfi=%s\n' % (code.co_filename,))
220
            out_file.write('calls=%d %d\n' % (
221
                subentry.callcount, code.co_firstlineno))
222
        out_file.write('%d %d\n' % (lineno, totaltime))
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
223
1185.33.86 by Martin Pool
Add additional module for lsprof.
224
_fn2mod = {}
225
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
226
def label(code, calltree=False):
1185.33.86 by Martin Pool
Add additional module for lsprof.
227
    if isinstance(code, str):
228
        return code
229
    try:
230
        mname = _fn2mod[code.co_filename]
231
    except KeyError:
1711.2.124 by John Arbash Meinel
Use sys.modules.items() to prevent running into site.py problems
232
        for k, v in sys.modules.items():
1185.33.86 by Martin Pool
Add additional module for lsprof.
233
            if v is None:
234
                continue
1963.2.6 by Robey Pointer
pychecker is on crack; go back to using 'is None'.
235
            if getattr(v, '__file__', None) is None:
1185.33.86 by Martin Pool
Add additional module for lsprof.
236
                continue
237
            if not isinstance(v.__file__, str):
238
                continue
239
            if v.__file__.startswith(code.co_filename):
240
                mname = _fn2mod[code.co_filename] = k
241
                break
242
        else:
243
            mname = _fn2mod[code.co_filename] = '<%s>'%code.co_filename
1553.7.3 by Robey Pointer
patch from ddaa to add kcachegrind output-format support to lsprof
244
    if calltree:
245
        return '%s %s:%d' % (code.co_name, mname, code.co_firstlineno)
246
    else:
247
        return '%s:%d(%s)' % (mname, code.co_firstlineno, code.co_name)
1185.33.86 by Martin Pool
Add additional module for lsprof.
248
249
250
if __name__ == '__main__':
251
    import os
252
    sys.argv = sys.argv[1:]
253
    if not sys.argv:
2911.6.1 by Blake Winton
Change 'print >> f,'s to 'f.write('s.
254
        sys.stderr.write("usage: lsprof.py <script> <arguments...>\n")
1185.33.86 by Martin Pool
Add additional module for lsprof.
255
        sys.exit(2)
256
    sys.path.insert(0, os.path.abspath(os.path.dirname(sys.argv[0])))
257
    stats = profile(execfile, sys.argv[0], globals(), locals())
258
    stats.sort()
259
    stats.pprint()