~bzr-pqm/bzr/bzr.dev

« back to all changes in this revision

Viewing changes to bzrlib/trace.py

  • Committer: mbp at sourcefrog
  • Date: 2005-03-24 00:44:18 UTC
  • Revision ID: mbp@sourcefrog.net-20050324004418-b4a050f656c07f5f
show space usage for various stores in the info command

Show diffs side-by-side

added added

removed removed

Lines of Context:
 
1
#! /usr/bin/env python
 
2
# -*- coding: UTF-8 -*-
 
3
 
1
4
# This program is free software; you can redistribute it and/or modify
2
5
# it under the terms of the GNU General Public License as published by
3
6
# the Free Software Foundation; either version 2 of the License, or
13
16
# Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA  02111-1307  USA
14
17
 
15
18
 
16
 
"""Messages and logging for bazaar-ng
17
 
 
18
 
Messages are sent out through the Python logging library.
19
 
 
20
 
They can be sent to two places: to stderr, and to ~/.bzr.log.
21
 
 
22
 
~/.bzr.log gets all messages, and tracebacks of all uncaught
23
 
exceptions.
24
 
 
25
 
Normally stderr only gets messages of level INFO and higher, and gets
26
 
only a summary of exceptions, not the traceback.
27
 
"""
28
 
 
29
 
 
30
 
# TODO: in debug mode, stderr should get full tracebacks and also
31
 
# debug messages.  (Is this really needed?)
32
 
 
33
 
# TODO: When running the test suites, we should add an additional
34
 
# logger that sends messages into the test log file.
35
 
 
36
 
 
37
 
import sys
38
 
import os
39
 
import logging
40
 
import traceback
41
 
 
42
 
 
43
 
_file_handler = None
44
 
_stderr_handler = None
45
 
 
46
 
 
47
 
class QuietFormatter(logging.Formatter):
48
 
    """Formatter that supresses the details of errors.
49
 
 
50
 
    This is used by default on stderr so as not to scare the user.
51
 
    """
52
 
    # At first I tried overriding formatException to suppress the
53
 
    # exception details, but that has global effect: no loggers
54
 
    # can get the exception details is we suppress them here.
55
 
 
56
 
    def format(self, record):
57
 
        if record.levelno >= logging.WARNING:
58
 
            s = 'bzr: ' + record.levelname + ': '
59
 
        else:
60
 
            s = ''
61
 
            
62
 
        s += record.getMessage()
63
 
 
64
 
        ##import textwrap
65
 
        ##s = textwrap.fill(s)
66
 
            
67
 
        if record.exc_info:
68
 
            # give just a summary of the exception, not the whole thing
69
 
            exinfo = traceback.extract_tb(record.exc_info[2])
70
 
            # the format of this string matches one of the REs
71
 
            s += '\n'
72
 
            s += ('  at %s line %d, in %s()\n' % exinfo[-1][:3])
73
 
            s += '  see ~/.bzr.log for debug information'
74
 
 
75
 
        return s
76
 
        
77
 
 
78
 
 
79
 
 
80
 
################
81
 
# configure convenient aliases for output routines
82
 
 
83
 
_bzr_logger = logging.getLogger('bzr')
84
 
_bzr_logger.setLevel(logging.DEBUG) 
85
 
 
86
 
info = note = _bzr_logger.info
87
 
warning =   _bzr_logger.warning
88
 
log_error = _bzr_logger.error
89
 
error =     _bzr_logger.error
90
 
mutter =    _bzr_logger.debug
91
 
debug =     _bzr_logger.debug
92
 
 
93
 
 
94
 
 
95
 
 
96
 
# we do the rollover using this code, rather than the default from python
97
 
# logging, because we only want to rollover at program startup, not on each
98
 
# message.  maybe that's not a good enough reason.
99
 
 
100
 
def _rollover_trace_maybe(trace_fname):
101
 
    import stat
102
 
    try:
103
 
        size = os.stat(trace_fname)[stat.ST_SIZE]
104
 
        if size <= 4 << 20:
105
 
            return
106
 
        old_fname = trace_fname + '.old'
107
 
 
108
 
        from osutils import rename
109
 
        rename(trace_fname, old_fname)
110
 
 
111
 
    except OSError:
112
 
        return
113
 
 
114
 
 
115
 
 
116
 
def open_tracefile(tracefilename='~/.bzr.log'):
 
19
__copyright__ = "Copyright (C) 2005 Canonical Ltd."
 
20
__author__ = "Martin Pool <mbp@canonical.com>"
 
21
 
 
22
 
 
23
import sys, os, time, socket, stat
 
24
import bzrlib
 
25
 
 
26
######################################################################
 
27
# messages and logging
 
28
 
 
29
## TODO: If --verbose is given then write to both stderr and
 
30
## _tracefile; perhaps replace _tracefile with a tee thing.
 
31
 
 
32
global _tracefile, _starttime
 
33
 
 
34
# used to have % (os.environ['USER'], time.time(), os.getpid()), 'w')
 
35
 
 
36
 
 
37
# If false, notes also go to stdout; should replace this with --silent
 
38
# at some point.
 
39
silent = False
 
40
 
 
41
verbose = False
 
42
 
 
43
 
 
44
def warning(msg):
 
45
    b = 'bzr: warning: ' + msg + '\n'
 
46
    sys.stderr.write(b)
 
47
    _tracefile.write(b)
 
48
    _tracefile.flush()
 
49
 
 
50
def mutter(msg):
 
51
    _tracefile.write(msg)
 
52
    _tracefile.write('\n')
 
53
    _tracefile.flush()
 
54
    if verbose:
 
55
        sys.stderr.write('- ' + msg + '\n')
 
56
 
 
57
 
 
58
def note(msg):
 
59
    b = '* ' + str(msg) + '\n'
 
60
    if not silent:
 
61
        sys.stderr.write(b)
 
62
    _tracefile.write(b)
 
63
    _tracefile.flush()
 
64
 
 
65
 
 
66
def log_error(msg):
 
67
    sys.stderr.write(msg)
 
68
    _tracefile.write(msg)
 
69
    _tracefile.flush()
 
70
 
 
71
 
 
72
 
 
73
def create_tracefile(argv):
 
74
    # TODO: Also show contents of /etc/lsb-release, if it can be parsed.
 
75
    #       Perhaps that should eventually go into the platform library?
 
76
    # TODO: If the file doesn't exist, add a note describing it.
 
77
 
117
78
    # Messages are always written to here, so that we have some
118
79
    # information if something goes wrong.  In a future version this
119
80
    # file will be removed on successful completion.
120
 
    global _file_handler
121
 
    import stat, codecs
122
 
 
123
 
    trace_fname = os.path.join(os.path.expanduser(tracefilename))
124
 
    _rollover_trace_maybe(trace_fname)
125
 
 
126
 
    # buffering=1 means line buffered
127
 
    try:
128
 
        tf = codecs.open(trace_fname, 'at', 'utf8', buffering=1)
129
 
 
130
 
        if os.fstat(tf.fileno())[stat.ST_SIZE] == 0:
131
 
            tf.write("\nthis is a debug log for diagnosing/reporting problems in bzr\n")
132
 
            tf.write("you can delete or truncate this file, or include sections in\n")
133
 
            tf.write("bug reports to bazaar-ng@lists.canonical.com\n\n")
134
 
        
135
 
        _file_handler = logging.StreamHandler(tf)
136
 
        fmt = r'[%(process)5d] %(asctime)s.%(msecs)03d %(levelname)s: %(message)s'
137
 
        datefmt = r'%a %H:%M:%S'
138
 
        _file_handler.setFormatter(logging.Formatter(fmt, datefmt))
139
 
        _file_handler.setLevel(logging.DEBUG)
140
 
        logging.getLogger('').addHandler(_file_handler)
141
 
 
142
 
    except IOError, e:
143
 
        warning("failed to open trace file: %s" % (e))
144
 
 
145
 
 
146
 
def log_startup(argv):
147
 
    import bzrlib
148
 
 
149
 
    debug('bzr %s invoked on python %s (%s)',
150
 
          bzrlib.__version__,
151
 
          '.'.join(map(str, sys.version_info)),
152
 
          sys.platform)
153
 
 
154
 
    debug('  arguments: %r', argv)
155
 
    debug('  working dir: %s', os.getcwdu())
156
 
 
157
 
 
158
 
def log_exception(msg=None):
159
 
    """Log the last exception into the trace file.
160
 
 
161
 
    The exception string representation is used as the error
162
 
    summary, unless msg is given.
163
 
    """
164
 
    cmd_repr = ' '.join(repr(arg) for arg in sys.argv)
165
 
    cmd_info = '\n  command: %s\n  pwd: %s' \
166
 
        % (cmd_repr, os.getcwd())
167
 
    if msg == None:
168
 
        ei = sys.exc_info()
169
 
        msg = str(ei[1])
170
 
    if msg and (msg[-1] == '\n'):
171
 
        msg = msg[:-1]
172
 
    ## msg = "(%s) %s" % (str(type(ei[1])), msg)
173
 
    _bzr_logger.exception(msg + cmd_info)
174
 
 
175
 
 
176
 
 
177
 
def enable_default_logging():
178
 
    """Configure default logging to stderr and .bzr.log"""
179
 
    global _stderr_handler, _file_handler
180
 
 
181
 
    _stderr_handler = logging.StreamHandler()
182
 
    _stderr_handler.setFormatter(QuietFormatter())
183
 
 
184
 
    if not _file_handler:
185
 
        open_tracefile()
186
 
 
187
 
    if os.environ.get('BZR_DEBUG'):
188
 
        level = logging.DEBUG
189
 
    else:
190
 
        level = logging.INFO
191
 
 
192
 
    _stderr_handler.setLevel(logging.INFO)
193
 
    _file_handler.setLevel(level)
194
 
 
195
 
    logging.getLogger('').addHandler(_stderr_handler)
196
 
 
197
 
 
198
 
def disable_default_logging():
199
 
    """Turn off default log handlers.
200
 
 
201
 
    This is intended to be used by the test framework, which doesn't
202
 
    want leakage from the code-under-test into the main logs.
203
 
    """
204
 
 
205
 
    l = logging.getLogger('')
206
 
    l.removeHandler(_stderr_handler)
207
 
    if _file_handler:
208
 
        l.removeHandler(_file_handler)
 
81
    global _starttime, _tracefile
 
82
 
 
83
    _starttime = os.times()[4]
 
84
 
 
85
    _tracefile = file('.bzr.log', 'at')
 
86
    t = _tracefile
 
87
 
 
88
    if os.fstat(t.fileno())[stat.ST_SIZE] == 0:
 
89
        t.write("\nthis is a debug log for diagnosing/reporting problems in bzr\n")
 
90
        t.write("you can delete or truncate this file, or include sections in\n")
 
91
        t.write("bug reports to bazaar-ng@lists.canonical.com\n\n")
 
92
 
 
93
    # TODO: If we failed to create the file, perhaps give a warning
 
94
    # but don't abort; send things to /dev/null instead?
 
95
 
 
96
    
 
97
    t.write('-' * 60 + '\n')
 
98
    t.write('bzr invoked at %s\n' % bzrlib.osutils.format_date(time.time()))
 
99
    t.write('  by %s on %s\n' % (bzrlib.osutils.username(), socket.getfqdn()))
 
100
    t.write('  arguments: %r\n' % argv)
 
101
 
 
102
    import platform
 
103
    t.write('  platform: %s\n' % platform.platform())
 
104
    t.write('  python: %s\n' % platform.python_version())
 
105
 
 
106
    import atexit
 
107
    atexit.register(_close_trace)
 
108
 
 
109
 
 
110
def _close_trace():
 
111
    times = os.times()
 
112
    mutter("finished, %.3fu/%.3fs cpu, %.3fu/%.3fs cum, %.3f elapsed"
 
113
           % (times[:4] + ((times[4] - _starttime),)))
 
114
 
 
115
 
 
116