13
13
# Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA 02111-1307 USA
17
# TODO: Could probably replace this with something based on Python logging
23
__copyright__ = "Copyright (C) 2005 Canonical Ltd."
24
__author__ = "Martin Pool <mbp@canonical.com>"
16
27
"""Messages and logging for bazaar-ng
18
Messages are sent out through the Python logging library.
20
They can be sent to two places: to stderr, and to ~/.bzr.log.
22
~/.bzr.log gets all messages, and tracebacks of all uncaught
25
Normally stderr only gets messages of level INFO and higher, and gets
26
only a summary of exceptions, not the traceback.
29
Nothing is actually logged unless you call bzrlib.open_tracefile().
30
# TODO: in debug mode, stderr should get full tracebacks and also
31
# debug messages. (Is this really needed?)
33
# TODO: When running the test suites, we should add an additional
34
# logger that sends messages into the test log file.
46
class QuietFormatter(logging.Formatter):
47
"""Formatter that supresses the details of errors.
49
This is used by default on stderr so as not to scare the user.
51
# At first I tried overriding formatException to suppress the
52
# exception details, but that has global effect: no loggers
53
# can get the exception details is we suppress them here.
55
def format(self, record):
57
if record.levelno >= logging.WARNING:
58
s += record.levelname + ': '
60
s += record.getMessage()
63
# give just a summary of the exception, not the whole thing
64
exinfo = traceback.extract_tb(record.exc_info[2])
65
# the format of this string matches one of the REs
67
s += (' at %s line %d, in %s()\n' % exinfo[-1][:3])
68
s += ' see ~/.bzr.log for debug information'
73
# configure default handler to stderr
75
_stderr_handler = logging.StreamHandler()
76
_stderr_handler.setFormatter(QuietFormatter())
78
if os.environ.get('BZR_DEBUG'):
79
_stderr_handler.setLevel(logging.DEBUG)
81
_stderr_handler.setLevel(logging.INFO)
83
logging.getLogger('').addHandler(_stderr_handler)
88
# configure convenient aliases for output routines
90
_bzr_logger = logging.getLogger('bzr')
91
_bzr_logger.setLevel(logging.DEBUG)
93
note = _bzr_logger.info
94
warning = _bzr_logger.warning
95
log_error = _bzr_logger.error
96
error = _bzr_logger.error
97
mutter = _bzr_logger.debug
98
debug = _bzr_logger.debug
103
# we do the rollover using this code, rather than the default from python
104
# logging, because we only want to rollover at program startup, not on each
105
# message. maybe that's not a good enough reason.
35
######################################################################
36
# messages and logging
38
global _tracefile, _starttime
41
# used to have % (os.environ['USER'], time.time(), os.getpid()), 'w')
44
# If false, notes also go to stdout; should replace this with --silent
49
# fix this if we ever fork within python
51
_logprefix = '[%d] ' % _mypid
54
def _write_trace(msg):
57
_tracefile.write(_logprefix + msg + '\n')
61
sys.stderr.write('bzr: warning: ' + msg + '\n')
62
_write_trace('warning: ' + msg)
69
b = '* ' + str(msg) + '\n'
72
_write_trace('note: ' + msg)
76
sys.stderr.write(msg + '\n')
107
80
def _rollover_trace_maybe(trace_fname):
132
105
# Messages are always written to here, so that we have some
133
106
# information if something goes wrong. In a future version this
134
107
# file will be removed on successful completion.
108
global _starttime, _tracefile
136
109
import stat, codecs
111
_starttime = os.times()[4]
138
113
trace_fname = os.path.join(os.path.expanduser(tracefilename))
139
114
_rollover_trace_maybe(trace_fname)
141
116
# buffering=1 means line buffered
143
tf = codecs.open(trace_fname, 'at', 'utf8', buffering=1)
118
_tracefile = codecs.open(trace_fname, 'at', 'utf8', buffering=1)
145
if os.fstat(tf.fileno())[stat.ST_SIZE] == 0:
146
tf.write("\nthis is a debug log for diagnosing/reporting problems in bzr\n")
147
tf.write("you can delete or truncate this file, or include sections in\n")
148
tf.write("bug reports to bazaar-ng@lists.canonical.com\n\n")
150
_file_handler = logging.StreamHandler(tf)
151
fmt = r'[%(process)5d] %(asctime)s.%(msecs)03d %(levelname)s: %(message)s'
152
datefmt = r'%a %H:%M:%S'
153
_file_handler.setFormatter(logging.Formatter(fmt, datefmt))
154
_file_handler.setLevel(logging.DEBUG)
155
logging.getLogger('').addHandler(_file_handler)
121
if os.fstat(t.fileno())[stat.ST_SIZE] == 0:
122
t.write("\nthis is a debug log for diagnosing/reporting problems in bzr\n")
123
t.write("you can delete or truncate this file, or include sections in\n")
124
t.write("bug reports to bazaar-ng@lists.canonical.com\n\n")
159
debug('bzr %s invoked on python %s (%s)'
160
% (bzrlib.__version__,
161
'.'.join(map(str, sys.version_info)),
127
_write_trace('bzr %s invoked on python %s (%s)'
128
% (bzrlib.__version__,
129
'.'.join(map(str, sys.version_info)),
164
debug(' arguments: %r' % argv)
165
debug(' working dir: ' + os.getcwdu())
132
_write_trace(' arguments: %r' % argv)
133
_write_trace(' working dir: ' + os.getcwdu())
166
134
except IOError, e:
167
135
warning("failed to open trace file: %s" % (e))
171
def log_exception(msg=None):
172
"""Log the last exception into the trace file.
174
The exception string representation is used as the error
175
summary, unless msg is given.
139
mutter("finished, %.3fu/%.3fs cpu, %.3fu/%.3fs cum, %.3f elapsed"
140
% (times[:4] + ((times[4] - _starttime),)))
145
"""Log the last exception into the trace file."""
147
s = cgitb.text(sys.exc_info())
148
for l in s.split('\n'):
184
_bzr_logger.exception(msg)
added
removed
bzrlib/trace.py
