13
13
# Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA 02111-1307 USA
16
__copyright__ = "Copyright (C) 2005 Canonical Ltd."
17
__author__ = "Martin Pool <mbp@canonical.com>"
20
16
"""Messages and logging for bazaar-ng
22
Nothing is actually logged unless you call bzrlib.open_tracefile().
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.
28
######################################################################
29
# messages and logging
31
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
# fix this if we ever fork within python
44
_logprefix = '[%d] ' % _mypid
47
def _write_trace(msg):
49
_tracefile.write(_logprefix + msg + '\n')
53
sys.stderr.write('bzr: warning: ' + msg + '\n')
54
_write_trace('warning: ' + msg)
61
b = '* ' + str(msg) + '\n'
64
_write_trace('note: ' + msg)
68
sys.stderr.write(msg + '\n')
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):
58
if record.levelno >= logging.WARNING:
59
s += record.levelname + ': '
61
s += record.getMessage()
64
# give just a summary of the exception, not the whole thing
65
exinfo = traceback.extract_tb(record.exc_info[2])
66
# the format of this string matches one of the REs
68
s += (' at %s line %d, in %s()\n' % exinfo[-1][:3])
69
s += ' see ~/.bzr.log for debug information'
77
# configure convenient aliases for output routines
79
_bzr_logger = logging.getLogger('bzr')
80
_bzr_logger.setLevel(logging.DEBUG)
82
info = note = _bzr_logger.info
83
warning = _bzr_logger.warning
84
log_error = _bzr_logger.error
85
error = _bzr_logger.error
86
mutter = _bzr_logger.debug
87
debug = _bzr_logger.debug
92
# we do the rollover using this code, rather than the default from python
93
# logging, because we only want to rollover at program startup, not on each
94
# message. maybe that's not a good enough reason.
72
96
def _rollover_trace_maybe(trace_fname):
78
102
old_fname = trace_fname + '.old'
81
# must remove before rename on windows
104
from osutils import rename
105
rename(trace_fname, old_fname)
87
# might fail if in use on windows
88
os.rename(trace_fname, old_fname)
96
def open_tracefile(argv=[], tracefilename='~/.bzr.log'):
112
def open_tracefile(tracefilename='~/.bzr.log'):
97
113
# Messages are always written to here, so that we have some
98
114
# information if something goes wrong. In a future version this
99
115
# file will be removed on successful completion.
100
global _starttime, _tracefile
101
117
import stat, codecs
103
_starttime = os.times()[4]
105
119
trace_fname = os.path.join(os.path.expanduser(tracefilename))
106
120
_rollover_trace_maybe(trace_fname)
108
122
# buffering=1 means line buffered
110
_tracefile = codecs.open(trace_fname, 'at', 'utf8', buffering=1)
113
if os.fstat(t.fileno())[stat.ST_SIZE] == 0:
114
t.write("\nthis is a debug log for diagnosing/reporting problems in bzr\n")
115
t.write("you can delete or truncate this file, or include sections in\n")
116
t.write("bug reports to bazaar-ng@lists.canonical.com\n\n")
119
_write_trace('bzr %s invoked on python %s (%s)'
120
% (bzrlib.__version__,
121
'.'.join(map(str, sys.version_info)),
124
_write_trace(' arguments: %r' % argv)
125
_write_trace(' working dir: ' + os.getcwdu())
124
tf = codecs.open(trace_fname, 'at', 'utf8', buffering=1)
126
if os.fstat(tf.fileno())[stat.ST_SIZE] == 0:
127
tf.write("\nthis is a debug log for diagnosing/reporting problems in bzr\n")
128
tf.write("you can delete or truncate this file, or include sections in\n")
129
tf.write("bug reports to bazaar-ng@lists.canonical.com\n\n")
131
_file_handler = logging.StreamHandler(tf)
132
fmt = r'[%(process)5d] %(asctime)s.%(msecs)03d %(levelname)s: %(message)s'
133
datefmt = r'%a %H:%M:%S'
134
_file_handler.setFormatter(logging.Formatter(fmt, datefmt))
135
_file_handler.setLevel(logging.DEBUG)
136
logging.getLogger('').addHandler(_file_handler)
126
138
except IOError, e:
127
139
warning("failed to open trace file: %s" % (e))
131
mutter("finished, %.3fu/%.3fs cpu, %.3fu/%.3fs cum, %.3f elapsed"
132
% (times[:4] + ((times[4] - _starttime),)))
137
"""Log the last exception into the trace file."""
139
s = cgitb.text(sys.exc_info())
140
for l in s.split('\n'):
142
def log_startup(argv):
145
debug('bzr %s invoked on python %s (%s)',
147
'.'.join(map(str, sys.version_info)),
150
debug(' arguments: %r', argv)
151
debug(' working dir: %s', os.getcwdu())
154
def log_exception(msg=None):
155
"""Log the last exception into the trace file.
157
The exception string representation is used as the error
158
summary, unless msg is given.
164
if msg and (msg[-1] == '\n'):
167
_bzr_logger.exception(msg)
171
def enable_default_logging():
172
"""Configure default logging to stderr and .bzr.log"""
173
global _stderr_handler, _file_handler
175
_stderr_handler = logging.StreamHandler()
176
_stderr_handler.setFormatter(QuietFormatter())
178
if not _file_handler:
181
if os.environ.get('BZR_DEBUG'):
182
level = logging.DEBUG
186
_stderr_handler.setLevel(logging.INFO)
187
_file_handler.setLevel(level)
189
logging.getLogger('').addHandler(_stderr_handler)
192
def disable_default_logging():
193
"""Turn off default log handlers.
195
This is intended to be used by the test framework, which doesn't
196
want leakage from the code-under-test into the main logs.
199
l = logging.getLogger('')
200
l.removeHandler(_stderr_handler)
202
l.removeHandler(_file_handler)