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.
44
_stderr_handler = None
47
class QuietFormatter(logging.Formatter):
48
"""Formatter that supresses the details of errors.
50
This is used by default on stderr so as not to scare the user.
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.
56
def format(self, record):
57
if record.levelno >= logging.WARNING:
58
s = 'bzr: ' + record.levelname + ': '
62
s += record.getMessage()
65
##s = textwrap.fill(s)
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
72
s += (' at %s line %d, in %s()\n' % exinfo[-1][:3])
73
s += ' see ~/.bzr.log for debug information'
81
# configure convenient aliases for output routines
83
_bzr_logger = logging.getLogger('bzr')
84
_bzr_logger.setLevel(logging.DEBUG)
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
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.
100
def _rollover_trace_maybe(trace_fname):
103
size = os.stat(trace_fname)[stat.ST_SIZE]
106
old_fname = trace_fname + '.old'
108
from osutils import rename
109
rename(trace_fname, old_fname)
116
def open_tracefile(tracefilename='~/.bzr.log'):
19
__copyright__ = "Copyright (C) 2005 Canonical Ltd."
20
__author__ = "Martin Pool <mbp@canonical.com>"
23
import sys, os, time, socket, stat
26
######################################################################
27
# messages and logging
29
## TODO: If --verbose is given then write to both stderr and
30
## _tracefile; perhaps replace _tracefile with a tee thing.
32
global _tracefile, _starttime
34
# used to have % (os.environ['USER'], time.time(), os.getpid()), 'w')
37
# If false, notes also go to stdout; should replace this with --silent
42
# TODO: Somehow tie this to the --verbose option?
47
b = 'bzr: warning: ' + msg + '\n'
54
_tracefile.write('\n')
57
sys.stderr.write('- ' + msg + '\n')
61
b = '* ' + str(msg) + '\n'
75
def create_tracefile(argv):
76
# TODO: Also show contents of /etc/lsb-release, if it can be parsed.
77
# Perhaps that should eventually go into the platform library?
78
# TODO: If the file doesn't exist, add a note describing it.
117
80
# Messages are always written to here, so that we have some
118
81
# information if something goes wrong. In a future version this
119
82
# file will be removed on successful completion.
123
trace_fname = os.path.join(os.path.expanduser(tracefilename))
124
_rollover_trace_maybe(trace_fname)
126
# buffering=1 means line buffered
128
tf = codecs.open(trace_fname, 'at', 'utf8', buffering=1)
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")
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)
143
warning("failed to open trace file: %s" % (e))
146
def log_startup(argv):
149
debug('bzr %s invoked on python %s (%s)',
151
'.'.join(map(str, sys.version_info)),
154
debug(' arguments: %r', argv)
155
debug(' working dir: %s', os.getcwdu())
158
def log_exception(msg=None):
159
"""Log the last exception into the trace file.
161
The exception string representation is used as the error
162
summary, unless msg is given.
167
if msg and (msg[-1] == '\n'):
169
## msg = "(%s) %s" % (str(type(ei[1])), msg)
170
_bzr_logger.exception(msg)
174
def enable_default_logging():
175
"""Configure default logging to stderr and .bzr.log"""
176
global _stderr_handler, _file_handler
178
_stderr_handler = logging.StreamHandler()
179
_stderr_handler.setFormatter(QuietFormatter())
181
if not _file_handler:
184
if os.environ.get('BZR_DEBUG'):
185
level = logging.DEBUG
189
_stderr_handler.setLevel(logging.INFO)
190
_file_handler.setLevel(level)
192
logging.getLogger('').addHandler(_stderr_handler)
195
def disable_default_logging():
196
"""Turn off default log handlers.
198
This is intended to be used by the test framework, which doesn't
199
want leakage from the code-under-test into the main logs.
202
l = logging.getLogger('')
203
l.removeHandler(_stderr_handler)
205
l.removeHandler(_file_handler)
83
global _starttime, _tracefile
85
_starttime = os.times()[4]
87
_tracefile = file('.bzr.log', 'at')
90
if os.fstat(t.fileno())[stat.ST_SIZE] == 0:
91
t.write("\nthis is a debug log for diagnosing/reporting problems in bzr\n")
92
t.write("you can delete or truncate this file, or include sections in\n")
93
t.write("bug reports to bazaar-ng@lists.canonical.com\n\n")
95
# TODO: If we failed to create the file, perhaps give a warning
96
# but don't abort; send things to /dev/null instead?
99
t.write('-' * 60 + '\n')
100
t.write('bzr invoked at %s\n' % bzrlib.osutils.format_date(time.time()))
101
t.write(' version: %s\n' % bzrlib.__version__)
102
t.write(' by %s on %s\n' % (bzrlib.osutils.username(), socket.getfqdn()))
103
t.write(' arguments: %r\n' % argv)
105
# This causes a vfork; I don't care enough about it.
106
t.write(' platform: %s\n' % sys.platform)
107
t.write(' python: %s\n' % (sys.version_info,))
110
atexit.register(_close_trace)
115
mutter("finished, %.3fu/%.3fs cpu, %.3fu/%.3fs cum, %.3f elapsed"
116
% (times[:4] + ((times[4] - _starttime),)))