13
16
# Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA 02111-1307 USA
16
"""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.
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.
36
# FIXME: Unfortunately it turns out that python's logging module
37
# is quite expensive, even when the message is not printed by any handlers.
38
# We should perhaps change back to just simply doing it here.
48
_stderr_handler = None
51
class QuietFormatter(logging.Formatter):
52
"""Formatter that supresses the details of errors.
54
This is used by default on stderr so as not to scare the user.
56
# At first I tried overriding formatException to suppress the
57
# exception details, but that has global effect: no loggers
58
# can get the exception details is we suppress them here.
60
def format(self, record):
61
if record.levelno >= logging.WARNING:
62
s = 'bzr: ' + record.levelname + ': '
66
s += record.getMessage()
69
##s = textwrap.fill(s)
72
# give just a summary of the exception, not the whole thing
73
exinfo = traceback.extract_tb(record.exc_info[2])
74
# the format of this string matches one of the REs
76
s += (' at %s line %d, in %s()\n' % exinfo[-1][:3])
77
s += ' see ~/.bzr.log for debug information'
85
# configure convenient aliases for output routines
87
_bzr_logger = logging.getLogger('bzr')
88
_bzr_logger.setLevel(logging.DEBUG)
90
info = note = _bzr_logger.info
91
warning = _bzr_logger.warning
92
log_error = _bzr_logger.error
93
error = _bzr_logger.error
94
mutter = _bzr_logger.debug
95
debug = _bzr_logger.debug
100
# we do the rollover using this code, rather than the default from python
101
# logging, because we only want to rollover at program startup, not on each
102
# message. maybe that's not a good enough reason.
19
__copyright__ = "Copyright (C) 2005 Canonical Ltd."
20
__author__ = "Martin Pool <mbp@canonical.com>"
23
import sys, os, time, socket, stat, codecs
26
######################################################################
27
# messages and logging
29
global _tracefile, _starttime
32
# used to have % (os.environ['USER'], time.time(), os.getpid()), 'w')
35
# If false, notes also go to stdout; should replace this with --silent
40
# fix this if we ever fork within python
42
_logprefix = '[%d] ' % _mypid
45
def _write_trace(msg):
46
_tracefile.write(_logprefix + msg + '\n')
50
sys.stderr.write('bzr: warning: ' + msg + '\n')
51
_write_trace('warning: ' + msg)
58
b = '* ' + str(msg) + '\n'
61
_write_trace('note: ' + msg)
65
sys.stderr.write(msg + '\n')
104
69
def _rollover_trace_maybe(trace_fname):
107
71
size = os.stat(trace_fname)[stat.ST_SIZE]
108
72
if size <= 4 << 20:
110
74
old_fname = trace_fname + '.old'
112
from osutils import rename
113
rename(trace_fname, old_fname)
77
# must remove before rename on windows
83
# might fail if in use on windows
84
os.rename(trace_fname, old_fname)
120
def open_tracefile(tracefilename='~/.bzr.log'):
92
def create_tracefile(argv):
121
93
# Messages are always written to here, so that we have some
122
94
# information if something goes wrong. In a future version this
123
95
# file will be removed on successful completion.
127
trace_fname = os.path.join(os.path.expanduser(tracefilename))
96
global _starttime, _tracefile
98
_starttime = os.times()[4]
100
trace_fname = os.path.join(os.path.expanduser('~/.bzr.log'))
128
101
_rollover_trace_maybe(trace_fname)
130
103
# buffering=1 means line buffered
132
tf = codecs.open(trace_fname, 'at', 'utf8', buffering=1)
134
if os.fstat(tf.fileno())[stat.ST_SIZE] == 0:
135
tf.write("\nthis is a debug log for diagnosing/reporting problems in bzr\n")
136
tf.write("you can delete or truncate this file, or include sections in\n")
137
tf.write("bug reports to bazaar-ng@lists.canonical.com\n\n")
104
_tracefile = codecs.open(trace_fname, 'at', 'utf8', buffering=1)
107
if os.fstat(t.fileno())[stat.ST_SIZE] == 0:
108
t.write("\nthis is a debug log for diagnosing/reporting problems in bzr\n")
109
t.write("you can delete or truncate this file, or include sections in\n")
110
t.write("bug reports to bazaar-ng@lists.canonical.com\n\n")
112
# TODO: If we failed to create the file, perhaps give a warning
113
# but don't abort; send things to /dev/null instead?
115
_write_trace('bzr %s invoked on python %s (%s)'
116
% (bzrlib.__version__,
117
'.'.join(map(str, sys.version_info)),
120
_write_trace(' arguments: %r' % argv)
121
_write_trace(' working dir: ' + os.getcwdu())
126
mutter("finished, %.3fu/%.3fs cpu, %.3fu/%.3fs cum, %.3f elapsed"
127
% (times[:4] + ((times[4] - _starttime),)))
131
def log_exception(e):
132
import traceback, cStringIO
133
s = cStringIO.StringIO()
134
traceback.print_exc(None, s)
135
for l in s.getvalue().split('\n'):
139
_file_handler = logging.StreamHandler(tf)
140
fmt = r'[%(process)5d] %(asctime)s.%(msecs)03d %(levelname)s: %(message)s'
141
datefmt = r'%a %H:%M:%S'
142
_file_handler.setFormatter(logging.Formatter(fmt, datefmt))
143
_file_handler.setLevel(logging.DEBUG)
144
logging.getLogger('').addHandler(_file_handler)
147
warning("failed to open trace file: %s" % (e))
150
def log_startup(argv):
153
debug('bzr %s invoked on python %s (%s)',
155
'.'.join(map(str, sys.version_info)),
158
debug(' arguments: %r', argv)
159
debug(' working dir: %r', os.getcwdu())
162
def log_exception(msg=None):
163
"""Log the last exception to stderr and the trace file.
165
The exception string representation is used as the error
166
summary, unless msg is given.
171
if msg and (msg[-1] == '\n'):
173
msg += '\n command: %s' % ' '.join(repr(arg) for arg in sys.argv)
174
msg += '\n pwd: %r' % os.getcwdu()
175
msg += '\n error: %s' % ei[0] # exception type
176
_bzr_logger.exception(msg)
179
def log_exception_quietly():
180
"""Log the last exception to the trace file only.
182
Used for exceptions that occur internally and that may be
183
interesting to developers but not to users. For example,
184
errors loading plugins.
186
debug(traceback.format_exc())
189
def enable_default_logging():
190
"""Configure default logging to stderr and .bzr.log"""
191
global _stderr_handler, _file_handler
193
_stderr_handler = logging.StreamHandler()
194
_stderr_handler.setFormatter(QuietFormatter())
196
if not _file_handler:
199
if os.environ.get('BZR_DEBUG'):
200
level = logging.DEBUG
204
_stderr_handler.setLevel(logging.INFO)
205
_file_handler.setLevel(level)
207
logging.getLogger('').addHandler(_stderr_handler)
210
def disable_default_logging():
211
"""Turn off default log handlers.
213
This is intended to be used by the test framework, which doesn't
214
want leakage from the code-under-test into the main logs.
217
l = logging.getLogger('')
218
l.removeHandler(_stderr_handler)
220
l.removeHandler(_file_handler)
added
removed
bzrlib/trace.py
