blob: bf821abac16cf70fcc771cd11352f5b3bb42bcfa [file] [log] [blame]
Georg Brandl116aa622007-08-15 14:28:22 +00001:mod:`logging` --- Logging facility for Python
2==============================================
3
4.. module:: logging
Vinay Sajip1d5d6852010-12-12 22:47:13 +00005 :synopsis: Flexible event logging system for applications.
Georg Brandl116aa622007-08-15 14:28:22 +00006
7
8.. moduleauthor:: Vinay Sajip <vinay_sajip@red-dove.com>
9.. sectionauthor:: Vinay Sajip <vinay_sajip@red-dove.com>
10
11
Georg Brandl116aa622007-08-15 14:28:22 +000012.. index:: pair: Errors; logging
13
Vinay Sajipc63619b2010-12-19 12:56:57 +000014.. sidebar:: Important
15
Vinay Sajip01094e12010-12-19 13:41:26 +000016 This page contains the API reference information. For tutorial
17 information and discussion of more advanced topics, see
Vinay Sajipc63619b2010-12-19 12:56:57 +000018
19 * :ref:`Basic Tutorial <logging-basic-tutorial>`
20 * :ref:`Advanced Tutorial <logging-advanced-tutorial>`
21 * :ref:`Logging Cookbook <logging-cookbook>`
22
23
Vinay Sajip31b862d2013-09-05 23:01:07 +010024**Source code:** :source:`Lib/logging/__init__.py`
25
26--------------
27
Vinay Sajip1d5d6852010-12-12 22:47:13 +000028This module defines functions and classes which implement a flexible event
Vinay Sajip36675b62010-12-12 22:30:17 +000029logging system for applications and libraries.
Georg Brandl116aa622007-08-15 14:28:22 +000030
Vinay Sajipa18b9592010-12-12 13:20:55 +000031The key benefit of having the logging API provided by a standard library module
32is that all Python modules can participate in logging, so your application log
33can include your own messages integrated with messages from third-party
34modules.
35
Vinay Sajipc63619b2010-12-19 12:56:57 +000036The module provides a lot of functionality and flexibility. If you are
37unfamiliar with logging, the best way to get to grips with it is to see the
Vinay Sajip01094e12010-12-19 13:41:26 +000038tutorials (see the links on the right).
Vinay Sajipa18b9592010-12-12 13:20:55 +000039
Vinay Sajipc63619b2010-12-19 12:56:57 +000040The basic classes defined by the module, together with their functions, are
41listed below.
Vinay Sajip9a6b4002010-12-14 19:40:21 +000042
43* Loggers expose the interface that application code directly uses.
44* Handlers send the log records (created by loggers) to the appropriate
45 destination.
46* Filters provide a finer grained facility for determining which log records
47 to output.
48* Formatters specify the layout of log records in the final output.
Vinay Sajipa18b9592010-12-12 13:20:55 +000049
Georg Brandl116aa622007-08-15 14:28:22 +000050
Vinay Sajipc63619b2010-12-19 12:56:57 +000051.. _logger:
Vinay Sajip5286ccf2010-12-12 13:25:29 +000052
Vinay Sajipc63619b2010-12-19 12:56:57 +000053Logger Objects
Christian Heimes8b0facf2007-12-04 19:30:01 +000054--------------
55
Vinay Sajip074faff2012-04-10 19:59:50 +010056Loggers have the following attributes and methods. Note that Loggers are never
Vinay Sajipc63619b2010-12-19 12:56:57 +000057instantiated directly, but always through the module-level function
Vinay Sajip074faff2012-04-10 19:59:50 +010058``logging.getLogger(name)``. Multiple calls to :func:`getLogger` with the same
59name will always return a reference to the same Logger object.
60
61The ``name`` is potentially a period-separated hierarchical value, like
62``foo.bar.baz`` (though it could also be just plain ``foo``, for example).
63Loggers that are further down in the hierarchical list are children of loggers
64higher up in the list. For example, given a logger with a name of ``foo``,
65loggers with names of ``foo.bar``, ``foo.bar.baz``, and ``foo.bam`` are all
66descendants of ``foo``. The logger name hierarchy is analogous to the Python
67package hierarchy, and identical to it if you organise your loggers on a
68per-module basis using the recommended construction
69``logging.getLogger(__name__)``. That's because in a module, ``__name__``
70is the module's name in the Python package namespace.
71
Georg Brandl116aa622007-08-15 14:28:22 +000072
Vinay Sajipc63619b2010-12-19 12:56:57 +000073.. class:: Logger
Georg Brandl116aa622007-08-15 14:28:22 +000074
Vinay Sajipc63619b2010-12-19 12:56:57 +000075.. attribute:: Logger.propagate
Georg Brandl116aa622007-08-15 14:28:22 +000076
Vinay Sajip6c4c16c2013-01-21 19:44:28 +000077 If this evaluates to true, events logged to this logger will be passed to the
78 handlers of higher level (ancestor) loggers, in addition to any handlers
79 attached to this logger. Messages are passed directly to the ancestor
80 loggers' handlers - neither the level nor filters of the ancestor loggers in
81 question are considered.
Vinay Sajip287f2462011-11-23 08:54:22 +000082
83 If this evaluates to false, logging messages are not passed to the handlers
84 of ancestor loggers.
85
Benjamin Peterson79ed84c2011-12-30 13:47:25 -060086 The constructor sets this attribute to ``True``.
Vinay Sajipc8c8c692010-09-17 10:09:04 +000087
Vinay Sajip52b3d342013-01-21 21:57:10 +000088 .. note:: If you attach a handler to a logger *and* one or more of its
89 ancestors, it may emit the same record multiple times. In general, you
90 should not need to attach a handler to more than one logger - if you just
91 attach it to the appropriate logger which is highest in the logger
92 hierarchy, then it will see all events logged by all descendant loggers,
93 provided that their propagate setting is left set to ``True``. A common
94 scenario is to attach handlers only to the root logger, and to let
95 propagation take care of the rest.
Vinay Sajipc8c8c692010-09-17 10:09:04 +000096
Vinay Sajipc63619b2010-12-19 12:56:57 +000097.. method:: Logger.setLevel(lvl)
Vinay Sajipf234eb92010-12-12 17:37:27 +000098
Vinay Sajipc63619b2010-12-19 12:56:57 +000099 Sets the threshold for this logger to *lvl*. Logging messages which are less
100 severe than *lvl* will be ignored. When a logger is created, the level is set to
101 :const:`NOTSET` (which causes all messages to be processed when the logger is
102 the root logger, or delegation to the parent when the logger is a non-root
103 logger). Note that the root logger is created with level :const:`WARNING`.
104
105 The term 'delegation to the parent' means that if a logger has a level of
106 NOTSET, its chain of ancestor loggers is traversed until either an ancestor with
107 a level other than NOTSET is found, or the root is reached.
108
109 If an ancestor is found with a level other than NOTSET, then that ancestor's
110 level is treated as the effective level of the logger where the ancestor search
111 began, and is used to determine how a logging event is handled.
112
113 If the root is reached, and it has a level of NOTSET, then all messages will be
114 processed. Otherwise, the root's level will be used as the effective level.
115
Vinay Sajip800e11b2013-12-19 11:50:24 +0000116 See :ref:`levels` for a list of levels.
117
Gregory P. Smithc1f079f2012-01-14 12:46:17 -0800118 .. versionchanged:: 3.2
119 The *lvl* parameter now accepts a string representation of the
120 level such as 'INFO' as an alternative to the integer constants
Vinay Sajip2f1cd8a2014-09-18 18:01:12 +0100121 such as :const:`INFO`. Note, however, that levels are internally stored
122 as integers, and methods such as e.g. :meth:`getEffectiveLevel` and
123 :meth:`isEnabledFor` will return/expect to be passed integers.
Gregory P. Smithc1f079f2012-01-14 12:46:17 -0800124
Vinay Sajipc63619b2010-12-19 12:56:57 +0000125
126.. method:: Logger.isEnabledFor(lvl)
127
128 Indicates if a message of severity *lvl* would be processed by this logger.
129 This method checks first the module-level level set by
130 ``logging.disable(lvl)`` and then the logger's effective level as determined
131 by :meth:`getEffectiveLevel`.
132
133
134.. method:: Logger.getEffectiveLevel()
135
136 Indicates the effective level for this logger. If a value other than
137 :const:`NOTSET` has been set using :meth:`setLevel`, it is returned. Otherwise,
138 the hierarchy is traversed towards the root until a value other than
Vinay Sajip2f1cd8a2014-09-18 18:01:12 +0100139 :const:`NOTSET` is found, and that value is returned. The value returned is
140 an integer, typically one of :const:`logging.DEBUG`, :const:`logging.INFO`
141 etc.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000142
143
144.. method:: Logger.getChild(suffix)
145
146 Returns a logger which is a descendant to this logger, as determined by the suffix.
147 Thus, ``logging.getLogger('abc').getChild('def.ghi')`` would return the same
148 logger as would be returned by ``logging.getLogger('abc.def.ghi')``. This is a
149 convenience method, useful when the parent logger is named using e.g. ``__name__``
150 rather than a literal string.
151
152 .. versionadded:: 3.2
153
154
155.. method:: Logger.debug(msg, *args, **kwargs)
156
157 Logs a message with level :const:`DEBUG` on this logger. The *msg* is the
158 message format string, and the *args* are the arguments which are merged into
159 *msg* using the string formatting operator. (Note that this means that you can
160 use keywords in the format string, together with a single dictionary argument.)
161
Vinay Sajip02a8f9e2014-09-14 21:29:11 +0100162 There are three keyword arguments in *kwargs* which are inspected:
163 *exc_info*, *stack_info*, and *extra*.
164
165 If *exc_info* does not evaluate as false, it causes exception information to be
Vinay Sajipc63619b2010-12-19 12:56:57 +0000166 added to the logging message. If an exception tuple (in the format returned by
Vinay Sajip02a8f9e2014-09-14 21:29:11 +0100167 :func:`sys.exc_info`) or an exception instance is provided, it is used;
168 otherwise, :func:`sys.exc_info` is called to get the exception information.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000169
170 The second optional keyword argument is *stack_info*, which defaults to
Serhiy Storchakafbc1c262013-11-29 12:17:13 +0200171 ``False``. If true, stack information is added to the logging
Vinay Sajipc63619b2010-12-19 12:56:57 +0000172 message, including the actual logging call. Note that this is not the same
173 stack information as that displayed through specifying *exc_info*: The
174 former is stack frames from the bottom of the stack up to the logging call
175 in the current thread, whereas the latter is information about stack frames
176 which have been unwound, following an exception, while searching for
177 exception handlers.
178
179 You can specify *stack_info* independently of *exc_info*, e.g. to just show
180 how you got to a certain point in your code, even when no exceptions were
181 raised. The stack frames are printed following a header line which says::
182
183 Stack (most recent call last):
184
Éric Araujo661161e2011-10-22 19:29:48 +0200185 This mimics the ``Traceback (most recent call last):`` which is used when
Vinay Sajipc63619b2010-12-19 12:56:57 +0000186 displaying exception frames.
187
188 The third keyword argument is *extra* which can be used to pass a
189 dictionary which is used to populate the __dict__ of the LogRecord created for
190 the logging event with user-defined attributes. These custom attributes can then
191 be used as you like. For example, they could be incorporated into logged
192 messages. For example::
193
194 FORMAT = '%(asctime)-15s %(clientip)s %(user)-8s %(message)s'
195 logging.basicConfig(format=FORMAT)
Jason R. Coombs30b8e542012-03-07 10:26:08 -0500196 d = {'clientip': '192.168.0.1', 'user': 'fbloggs'}
Vinay Sajipc63619b2010-12-19 12:56:57 +0000197 logger = logging.getLogger('tcpserver')
198 logger.warning('Protocol problem: %s', 'connection reset', extra=d)
199
200 would print something like ::
201
202 2006-02-08 22:20:02,165 192.168.0.1 fbloggs Protocol problem: connection reset
203
204 The keys in the dictionary passed in *extra* should not clash with the keys used
205 by the logging system. (See the :class:`Formatter` documentation for more
206 information on which keys are used by the logging system.)
207
208 If you choose to use these attributes in logged messages, you need to exercise
209 some care. In the above example, for instance, the :class:`Formatter` has been
210 set up with a format string which expects 'clientip' and 'user' in the attribute
211 dictionary of the LogRecord. If these are missing, the message will not be
212 logged because a string formatting exception will occur. So in this case, you
213 always need to pass the *extra* dictionary with these keys.
214
215 While this might be annoying, this feature is intended for use in specialized
216 circumstances, such as multi-threaded servers where the same code executes in
217 many contexts, and interesting conditions which arise are dependent on this
218 context (such as remote client IP address and authenticated user name, in the
219 above example). In such circumstances, it is likely that specialized
220 :class:`Formatter`\ s would be used with particular :class:`Handler`\ s.
221
222 .. versionadded:: 3.2
223 The *stack_info* parameter was added.
224
Vinay Sajip02a8f9e2014-09-14 21:29:11 +0100225 .. versionchanged:: 3.5
226 The *exc_info* parameter can now accept exception instances.
227
Vinay Sajipc63619b2010-12-19 12:56:57 +0000228
229.. method:: Logger.info(msg, *args, **kwargs)
230
231 Logs a message with level :const:`INFO` on this logger. The arguments are
232 interpreted as for :meth:`debug`.
233
234
235.. method:: Logger.warning(msg, *args, **kwargs)
236
237 Logs a message with level :const:`WARNING` on this logger. The arguments are
238 interpreted as for :meth:`debug`.
239
Éric Araujo661161e2011-10-22 19:29:48 +0200240 .. note:: There is an obsolete method ``warn`` which is functionally
241 identical to ``warning``. As ``warn`` is deprecated, please do not use
242 it - use ``warning`` instead.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000243
244.. method:: Logger.error(msg, *args, **kwargs)
245
246 Logs a message with level :const:`ERROR` on this logger. The arguments are
247 interpreted as for :meth:`debug`.
248
249
250.. method:: Logger.critical(msg, *args, **kwargs)
251
252 Logs a message with level :const:`CRITICAL` on this logger. The arguments are
253 interpreted as for :meth:`debug`.
254
255
256.. method:: Logger.log(lvl, msg, *args, **kwargs)
257
258 Logs a message with integer level *lvl* on this logger. The other arguments are
259 interpreted as for :meth:`debug`.
260
261
Vinay Sajip65425b42014-04-15 23:13:12 +0100262.. method:: Logger.exception(msg, *args, **kwargs)
Vinay Sajipc63619b2010-12-19 12:56:57 +0000263
264 Logs a message with level :const:`ERROR` on this logger. The arguments are
265 interpreted as for :meth:`debug`. Exception info is added to the logging
266 message. This method should only be called from an exception handler.
267
268
269.. method:: Logger.addFilter(filt)
270
271 Adds the specified filter *filt* to this logger.
272
273
274.. method:: Logger.removeFilter(filt)
275
276 Removes the specified filter *filt* from this logger.
277
278
279.. method:: Logger.filter(record)
280
281 Applies this logger's filters to the record and returns a true value if the
Vinay Sajip6c4c16c2013-01-21 19:44:28 +0000282 record is to be processed. The filters are consulted in turn, until one of
283 them returns a false value. If none of them return a false value, the record
284 will be processed (passed to handlers). If one returns a false value, no
285 further processing of the record occurs.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000286
287
288.. method:: Logger.addHandler(hdlr)
289
290 Adds the specified handler *hdlr* to this logger.
291
292
293.. method:: Logger.removeHandler(hdlr)
294
295 Removes the specified handler *hdlr* from this logger.
296
297
298.. method:: Logger.findCaller(stack_info=False)
299
300 Finds the caller's source filename and line number. Returns the filename, line
301 number, function name and stack information as a 4-element tuple. The stack
302 information is returned as *None* unless *stack_info* is *True*.
303
304
305.. method:: Logger.handle(record)
306
307 Handles a record by passing it to all handlers associated with this logger and
308 its ancestors (until a false value of *propagate* is found). This method is used
309 for unpickled records received from a socket, as well as those created locally.
310 Logger-level filtering is applied using :meth:`~Logger.filter`.
311
312
313.. method:: Logger.makeRecord(name, lvl, fn, lno, msg, args, exc_info, func=None, extra=None, sinfo=None)
314
315 This is a factory method which can be overridden in subclasses to create
316 specialized :class:`LogRecord` instances.
317
318.. method:: Logger.hasHandlers()
319
320 Checks to see if this logger has any handlers configured. This is done by
321 looking for handlers in this logger and its parents in the logger hierarchy.
Serhiy Storchakafbc1c262013-11-29 12:17:13 +0200322 Returns ``True`` if a handler was found, else ``False``. The method stops searching
Vinay Sajipc63619b2010-12-19 12:56:57 +0000323 up the hierarchy whenever a logger with the 'propagate' attribute set to
324 False is found - that will be the last logger which is checked for the
325 existence of handlers.
326
327 .. versionadded:: 3.2
328
329
Vinay Sajip800e11b2013-12-19 11:50:24 +0000330.. _levels:
331
332Logging Levels
333--------------
334
335The numeric values of logging levels are given in the following table. These are
336primarily of interest if you want to define your own levels, and need them to
337have specific values relative to the predefined levels. If you define a level
338with the same numeric value, it overwrites the predefined value; the predefined
339name is lost.
340
341+--------------+---------------+
342| Level | Numeric value |
343+==============+===============+
344| ``CRITICAL`` | 50 |
345+--------------+---------------+
346| ``ERROR`` | 40 |
347+--------------+---------------+
348| ``WARNING`` | 30 |
349+--------------+---------------+
350| ``INFO`` | 20 |
351+--------------+---------------+
352| ``DEBUG`` | 10 |
353+--------------+---------------+
354| ``NOTSET`` | 0 |
355+--------------+---------------+
356
357
Vinay Sajipc63619b2010-12-19 12:56:57 +0000358.. _handler:
359
360Handler Objects
Benjamin Peterson058e31e2009-01-16 03:54:08 +0000361---------------
362
Vinay Sajipc63619b2010-12-19 12:56:57 +0000363Handlers have the following attributes and methods. Note that :class:`Handler`
364is never instantiated directly; this class acts as a base for more useful
365subclasses. However, the :meth:`__init__` method in subclasses needs to call
366:meth:`Handler.__init__`.
Georg Brandl116aa622007-08-15 14:28:22 +0000367
Georg Brandl116aa622007-08-15 14:28:22 +0000368
Vinay Sajipc63619b2010-12-19 12:56:57 +0000369.. method:: Handler.__init__(level=NOTSET)
Georg Brandl116aa622007-08-15 14:28:22 +0000370
Vinay Sajipc63619b2010-12-19 12:56:57 +0000371 Initializes the :class:`Handler` instance by setting its level, setting the list
372 of filters to the empty list and creating a lock (using :meth:`createLock`) for
373 serializing access to an I/O mechanism.
Vinay Sajip30bf1222009-01-10 19:23:34 +0000374
Georg Brandl116aa622007-08-15 14:28:22 +0000375
Vinay Sajipc63619b2010-12-19 12:56:57 +0000376.. method:: Handler.createLock()
Georg Brandl116aa622007-08-15 14:28:22 +0000377
Vinay Sajipc63619b2010-12-19 12:56:57 +0000378 Initializes a thread lock which can be used to serialize access to underlying
379 I/O functionality which may not be threadsafe.
Georg Brandl116aa622007-08-15 14:28:22 +0000380
Georg Brandl116aa622007-08-15 14:28:22 +0000381
Vinay Sajipc63619b2010-12-19 12:56:57 +0000382.. method:: Handler.acquire()
Georg Brandl116aa622007-08-15 14:28:22 +0000383
Vinay Sajipc63619b2010-12-19 12:56:57 +0000384 Acquires the thread lock created with :meth:`createLock`.
Georg Brandl116aa622007-08-15 14:28:22 +0000385
Georg Brandl116aa622007-08-15 14:28:22 +0000386
Vinay Sajipc63619b2010-12-19 12:56:57 +0000387.. method:: Handler.release()
Georg Brandl116aa622007-08-15 14:28:22 +0000388
Vinay Sajipc63619b2010-12-19 12:56:57 +0000389 Releases the thread lock acquired with :meth:`acquire`.
Georg Brandl116aa622007-08-15 14:28:22 +0000390
Georg Brandl116aa622007-08-15 14:28:22 +0000391
Vinay Sajipc63619b2010-12-19 12:56:57 +0000392.. method:: Handler.setLevel(lvl)
Vinay Sajip30bf1222009-01-10 19:23:34 +0000393
Vinay Sajipc63619b2010-12-19 12:56:57 +0000394 Sets the threshold for this handler to *lvl*. Logging messages which are less
395 severe than *lvl* will be ignored. When a handler is created, the level is set
396 to :const:`NOTSET` (which causes all messages to be processed).
397
Vinay Sajip800e11b2013-12-19 11:50:24 +0000398 See :ref:`levels` for a list of levels.
399
Gregory P. Smithc1f079f2012-01-14 12:46:17 -0800400 .. versionchanged:: 3.2
401 The *lvl* parameter now accepts a string representation of the
402 level such as 'INFO' as an alternative to the integer constants
403 such as :const:`INFO`.
404
Vinay Sajipc63619b2010-12-19 12:56:57 +0000405
406.. method:: Handler.setFormatter(form)
407
408 Sets the :class:`Formatter` for this handler to *form*.
409
410
411.. method:: Handler.addFilter(filt)
412
413 Adds the specified filter *filt* to this handler.
414
415
416.. method:: Handler.removeFilter(filt)
417
418 Removes the specified filter *filt* from this handler.
419
420
421.. method:: Handler.filter(record)
422
423 Applies this handler's filters to the record and returns a true value if the
Vinay Sajip6c4c16c2013-01-21 19:44:28 +0000424 record is to be processed. The filters are consulted in turn, until one of
425 them returns a false value. If none of them return a false value, the record
426 will be emitted. If one returns a false value, the handler will not emit the
427 record.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000428
429
430.. method:: Handler.flush()
431
432 Ensure all logging output has been flushed. This version does nothing and is
433 intended to be implemented by subclasses.
434
435
436.. method:: Handler.close()
437
438 Tidy up any resources used by the handler. This version does no output but
439 removes the handler from an internal list of handlers which is closed when
440 :func:`shutdown` is called. Subclasses should ensure that this gets called
441 from overridden :meth:`close` methods.
442
443
444.. method:: Handler.handle(record)
445
446 Conditionally emits the specified logging record, depending on filters which may
447 have been added to the handler. Wraps the actual emission of the record with
448 acquisition/release of the I/O thread lock.
449
450
451.. method:: Handler.handleError(record)
452
453 This method should be called from handlers when an exception is encountered
Vinay Sajipfee358b2012-02-20 18:35:26 +0000454 during an :meth:`emit` call. If the module-level attribute
455 ``raiseExceptions`` is ``False``, exceptions get silently ignored. This is
456 what is mostly wanted for a logging system - most users will not care about
457 errors in the logging system, they are more interested in application
458 errors. You could, however, replace this with a custom handler if you wish.
459 The specified record is the one which was being processed when the exception
460 occurred. (The default value of ``raiseExceptions`` is ``True``, as that is
461 more useful during development).
Vinay Sajipc63619b2010-12-19 12:56:57 +0000462
463
464.. method:: Handler.format(record)
465
466 Do formatting for a record - if a formatter is set, use it. Otherwise, use the
467 default formatter for the module.
468
469
470.. method:: Handler.emit(record)
471
472 Do whatever it takes to actually log the specified logging record. This version
473 is intended to be implemented by subclasses and so raises a
474 :exc:`NotImplementedError`.
475
476For a list of handlers included as standard, see :mod:`logging.handlers`.
477
478.. _formatter-objects:
479
480Formatter Objects
481-----------------
Vinay Sajip121a1c42010-09-08 10:46:15 +0000482
Vinay Sajip30bf1222009-01-10 19:23:34 +0000483.. currentmodule:: logging
484
Vinay Sajipc63619b2010-12-19 12:56:57 +0000485:class:`Formatter` objects have the following attributes and methods. They are
486responsible for converting a :class:`LogRecord` to (usually) a string which can
487be interpreted by either a human or an external system. The base
488:class:`Formatter` allows a formatting string to be specified. If none is
Vinay Sajipbbd95a92015-05-02 09:46:05 +0100489supplied, the default value of ``'%(message)s'`` is used, which just includes
490the message in the logging call. To have additional items of information in the
491formatted output (such as a timestamp), keep reading.
Georg Brandlf9734072008-12-07 15:30:06 +0000492
Vinay Sajipc63619b2010-12-19 12:56:57 +0000493A Formatter can be initialized with a format string which makes use of knowledge
494of the :class:`LogRecord` attributes - such as the default value mentioned above
495making use of the fact that the user's message and arguments are pre-formatted
496into a :class:`LogRecord`'s *message* attribute. This format string contains
497standard Python %-style mapping keys. See section :ref:`old-string-formatting`
498for more information on string formatting.
Georg Brandlf9734072008-12-07 15:30:06 +0000499
Vinay Sajipc63619b2010-12-19 12:56:57 +0000500The useful mapping keys in a :class:`LogRecord` are given in the section on
501:ref:`logrecord-attributes`.
Vinay Sajip121a1c42010-09-08 10:46:15 +0000502
Georg Brandl116aa622007-08-15 14:28:22 +0000503
Vinay Sajipc46102c2011-04-08 01:30:51 +0100504.. class:: Formatter(fmt=None, datefmt=None, style='%')
Georg Brandl116aa622007-08-15 14:28:22 +0000505
Vinay Sajipc63619b2010-12-19 12:56:57 +0000506 Returns a new instance of the :class:`Formatter` class. The instance is
507 initialized with a format string for the message as a whole, as well as a
508 format string for the date/time portion of a message. If no *fmt* is
509 specified, ``'%(message)s'`` is used. If no *datefmt* is specified, the
510 ISO8601 date format is used.
Georg Brandl116aa622007-08-15 14:28:22 +0000511
Vinay Sajipc46102c2011-04-08 01:30:51 +0100512 The *style* parameter can be one of '%', '{' or '$' and determines how
513 the format string will be merged with its data: using one of %-formatting,
Vinay Sajipcbefe3b2014-01-15 15:09:05 +0000514 :meth:`str.format` or :class:`string.Template`. See :ref:`formatting-styles`
515 for more information on using {- and $-formatting for log messages.
Vinay Sajipc46102c2011-04-08 01:30:51 +0100516
517 .. versionchanged:: 3.2
518 The *style* parameter was added.
519
520
Vinay Sajipc63619b2010-12-19 12:56:57 +0000521 .. method:: format(record)
Georg Brandl116aa622007-08-15 14:28:22 +0000522
Vinay Sajipc63619b2010-12-19 12:56:57 +0000523 The record's attribute dictionary is used as the operand to a string
524 formatting operation. Returns the resulting string. Before formatting the
525 dictionary, a couple of preparatory steps are carried out. The *message*
526 attribute of the record is computed using *msg* % *args*. If the
527 formatting string contains ``'(asctime)'``, :meth:`formatTime` is called
528 to format the event time. If there is exception information, it is
529 formatted using :meth:`formatException` and appended to the message. Note
530 that the formatted exception information is cached in attribute
531 *exc_text*. This is useful because the exception information can be
532 pickled and sent across the wire, but you should be careful if you have
533 more than one :class:`Formatter` subclass which customizes the formatting
534 of exception information. In this case, you will have to clear the cached
535 value after a formatter has done its formatting, so that the next
536 formatter to handle the event doesn't use the cached value but
537 recalculates it afresh.
538
539 If stack information is available, it's appended after the exception
540 information, using :meth:`formatStack` to transform it if necessary.
541
542
543 .. method:: formatTime(record, datefmt=None)
544
545 This method should be called from :meth:`format` by a formatter which
546 wants to make use of a formatted time. This method can be overridden in
547 formatters to provide for any specific requirement, but the basic behavior
548 is as follows: if *datefmt* (a string) is specified, it is used with
549 :func:`time.strftime` to format the creation time of the
550 record. Otherwise, the ISO8601 format is used. The resulting string is
551 returned.
552
Vinay Sajipcdc75172011-06-12 11:44:28 +0100553 This function uses a user-configurable function to convert the creation
554 time to a tuple. By default, :func:`time.localtime` is used; to change
555 this for a particular formatter instance, set the ``converter`` attribute
556 to a function with the same signature as :func:`time.localtime` or
557 :func:`time.gmtime`. To change it for all formatters, for example if you
558 want all logging times to be shown in GMT, set the ``converter``
559 attribute in the ``Formatter`` class.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000560
Vinay Sajip89c00ce2011-06-10 19:05:16 +0100561 .. versionchanged:: 3.3
Georg Brandle10b5e12011-06-14 21:09:55 +0200562 Previously, the default ISO 8601 format was hard-coded as in this
563 example: ``2010-09-06 22:38:15,292`` where the part before the comma is
564 handled by a strptime format string (``'%Y-%m-%d %H:%M:%S'``), and the
565 part after the comma is a millisecond value. Because strptime does not
566 have a format placeholder for milliseconds, the millisecond value is
567 appended using another format string, ``'%s,%03d'`` – and both of these
568 format strings have been hardcoded into this method. With the change,
569 these strings are defined as class-level attributes which can be
570 overridden at the instance level when desired. The names of the
571 attributes are ``default_time_format`` (for the strptime format string)
572 and ``default_msec_format`` (for appending the millisecond value).
Vinay Sajipc63619b2010-12-19 12:56:57 +0000573
574 .. method:: formatException(exc_info)
575
576 Formats the specified exception information (a standard exception tuple as
577 returned by :func:`sys.exc_info`) as a string. This default implementation
578 just uses :func:`traceback.print_exception`. The resulting string is
579 returned.
580
581 .. method:: formatStack(stack_info)
582
583 Formats the specified stack information (a string as returned by
584 :func:`traceback.print_stack`, but with the last newline removed) as a
585 string. This default implementation just returns the input value.
586
587.. _filter:
588
589Filter Objects
590--------------
591
592``Filters`` can be used by ``Handlers`` and ``Loggers`` for more sophisticated
593filtering than is provided by levels. The base filter class only allows events
594which are below a certain point in the logger hierarchy. For example, a filter
595initialized with 'A.B' will allow events logged by loggers 'A.B', 'A.B.C',
596'A.B.C.D', 'A.B.D' etc. but not 'A.BB', 'B.A.B' etc. If initialized with the
597empty string, all events are passed.
598
599
600.. class:: Filter(name='')
601
602 Returns an instance of the :class:`Filter` class. If *name* is specified, it
603 names a logger which, together with its children, will have its events allowed
604 through the filter. If *name* is the empty string, allows every event.
605
606
607 .. method:: filter(record)
608
609 Is the specified record to be logged? Returns zero for no, nonzero for
610 yes. If deemed appropriate, the record may be modified in-place by this
611 method.
612
Vinay Sajip6c4c16c2013-01-21 19:44:28 +0000613Note that filters attached to handlers are consulted before an event is
Vinay Sajipc63619b2010-12-19 12:56:57 +0000614emitted by the handler, whereas filters attached to loggers are consulted
Vinay Sajip6c4c16c2013-01-21 19:44:28 +0000615whenever an event is logged (using :meth:`debug`, :meth:`info`,
616etc.), before sending an event to handlers. This means that events which have
617been generated by descendant loggers will not be filtered by a logger's filter
618setting, unless the filter has also been applied to those descendant loggers.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000619
620You don't actually need to subclass ``Filter``: you can pass any instance
621which has a ``filter`` method with the same semantics.
622
623.. versionchanged:: 3.2
624 You don't need to create specialized ``Filter`` classes, or use other
625 classes with a ``filter`` method: you can use a function (or other
626 callable) as a filter. The filtering logic will check to see if the filter
627 object has a ``filter`` attribute: if it does, it's assumed to be a
628 ``Filter`` and its :meth:`~Filter.filter` method is called. Otherwise, it's
629 assumed to be a callable and called with the record as the single
630 parameter. The returned value should conform to that returned by
631 :meth:`~Filter.filter`.
632
633Although filters are used primarily to filter records based on more
634sophisticated criteria than levels, they get to see every record which is
635processed by the handler or logger they're attached to: this can be useful if
636you want to do things like counting how many records were processed by a
637particular logger or handler, or adding, changing or removing attributes in
638the LogRecord being processed. Obviously changing the LogRecord needs to be
639done with some care, but it does allow the injection of contextual information
640into logs (see :ref:`filters-contextual`).
641
642.. _log-record:
643
644LogRecord Objects
645-----------------
646
647:class:`LogRecord` instances are created automatically by the :class:`Logger`
648every time something is logged, and can be created manually via
649:func:`makeLogRecord` (for example, from a pickled event received over the
650wire).
651
652
653.. class:: LogRecord(name, level, pathname, lineno, msg, args, exc_info, func=None, sinfo=None)
654
655 Contains all the information pertinent to the event being logged.
656
657 The primary information is passed in :attr:`msg` and :attr:`args`, which
658 are combined using ``msg % args`` to create the :attr:`message` field of the
659 record.
660
661 :param name: The name of the logger used to log the event represented by
Vinay Sajip6c4c16c2013-01-21 19:44:28 +0000662 this LogRecord. Note that this name will always have this
663 value, even though it may be emitted by a handler attached to
664 a different (ancestor) logger.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000665 :param level: The numeric level of the logging event (one of DEBUG, INFO etc.)
Vinay Sajip0aaa9e12011-06-11 23:03:37 +0100666 Note that this is converted to *two* attributes of the LogRecord:
667 ``levelno`` for the numeric value and ``levelname`` for the
668 corresponding level name.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000669 :param pathname: The full pathname of the source file where the logging call
670 was made.
671 :param lineno: The line number in the source file where the logging call was
672 made.
673 :param msg: The event description message, possibly a format string with
674 placeholders for variable data.
675 :param args: Variable data to merge into the *msg* argument to obtain the
676 event description.
677 :param exc_info: An exception tuple with the current exception information,
678 or *None* if no exception information is available.
679 :param func: The name of the function or method from which the logging call
680 was invoked.
681 :param sinfo: A text string representing stack information from the base of
682 the stack in the current thread, up to the logging call.
683
684 .. method:: getMessage()
685
686 Returns the message for this :class:`LogRecord` instance after merging any
687 user-supplied arguments with the message. If the user-supplied message
688 argument to the logging call is not a string, :func:`str` is called on it to
689 convert it to a string. This allows use of user-defined classes as
690 messages, whose ``__str__`` method can return the actual format string to
691 be used.
692
693 .. versionchanged:: 3.2
694 The creation of a ``LogRecord`` has been made more configurable by
695 providing a factory which is used to create the record. The factory can be
696 set using :func:`getLogRecordFactory` and :func:`setLogRecordFactory`
697 (see this for the factory's signature).
698
699 This functionality can be used to inject your own values into a
700 LogRecord at creation time. You can use the following pattern::
701
702 old_factory = logging.getLogRecordFactory()
703
704 def record_factory(*args, **kwargs):
705 record = old_factory(*args, **kwargs)
706 record.custom_attribute = 0xdecafbad
707 return record
708
709 logging.setLogRecordFactory(record_factory)
710
711 With this pattern, multiple factories could be chained, and as long
712 as they don't overwrite each other's attributes or unintentionally
713 overwrite the standard attributes listed above, there should be no
714 surprises.
715
716
717.. _logrecord-attributes:
718
719LogRecord attributes
720--------------------
721
722The LogRecord has a number of attributes, most of which are derived from the
723parameters to the constructor. (Note that the names do not always correspond
724exactly between the LogRecord constructor parameters and the LogRecord
725attributes.) These attributes can be used to merge data from the record into
726the format string. The following table lists (in alphabetical order) the
727attribute names, their meanings and the corresponding placeholder in a %-style
728format string.
729
730If you are using {}-formatting (:func:`str.format`), you can use
731``{attrname}`` as the placeholder in the format string. If you are using
732$-formatting (:class:`string.Template`), use the form ``${attrname}``. In
733both cases, of course, replace ``attrname`` with the actual attribute name
734you want to use.
735
736In the case of {}-formatting, you can specify formatting flags by placing them
737after the attribute name, separated from it with a colon. For example: a
738placeholder of ``{msecs:03d}`` would format a millisecond value of ``4`` as
739``004``. Refer to the :meth:`str.format` documentation for full details on
740the options available to you.
741
742+----------------+-------------------------+-----------------------------------------------+
743| Attribute name | Format | Description |
744+================+=========================+===============================================+
745| args | You shouldn't need to | The tuple of arguments merged into ``msg`` to |
746| | format this yourself. | produce ``message``. |
747+----------------+-------------------------+-----------------------------------------------+
748| asctime | ``%(asctime)s`` | Human-readable time when the |
749| | | :class:`LogRecord` was created. By default |
750| | | this is of the form '2003-07-08 16:49:45,896' |
751| | | (the numbers after the comma are millisecond |
752| | | portion of the time). |
753+----------------+-------------------------+-----------------------------------------------+
754| created | ``%(created)f`` | Time when the :class:`LogRecord` was created |
755| | | (as returned by :func:`time.time`). |
756+----------------+-------------------------+-----------------------------------------------+
757| exc_info | You shouldn't need to | Exception tuple (à la ``sys.exc_info``) or, |
758| | format this yourself. | if no exception has occurred, *None*. |
759+----------------+-------------------------+-----------------------------------------------+
760| filename | ``%(filename)s`` | Filename portion of ``pathname``. |
761+----------------+-------------------------+-----------------------------------------------+
762| funcName | ``%(funcName)s`` | Name of function containing the logging call. |
763+----------------+-------------------------+-----------------------------------------------+
764| levelname | ``%(levelname)s`` | Text logging level for the message |
765| | | (``'DEBUG'``, ``'INFO'``, ``'WARNING'``, |
766| | | ``'ERROR'``, ``'CRITICAL'``). |
767+----------------+-------------------------+-----------------------------------------------+
768| levelno | ``%(levelno)s`` | Numeric logging level for the message |
769| | | (:const:`DEBUG`, :const:`INFO`, |
770| | | :const:`WARNING`, :const:`ERROR`, |
771| | | :const:`CRITICAL`). |
772+----------------+-------------------------+-----------------------------------------------+
773| lineno | ``%(lineno)d`` | Source line number where the logging call was |
774| | | issued (if available). |
775+----------------+-------------------------+-----------------------------------------------+
776| module | ``%(module)s`` | Module (name portion of ``filename``). |
777+----------------+-------------------------+-----------------------------------------------+
778| msecs | ``%(msecs)d`` | Millisecond portion of the time when the |
779| | | :class:`LogRecord` was created. |
780+----------------+-------------------------+-----------------------------------------------+
781| message | ``%(message)s`` | The logged message, computed as ``msg % |
782| | | args``. This is set when |
783| | | :meth:`Formatter.format` is invoked. |
784+----------------+-------------------------+-----------------------------------------------+
785| msg | You shouldn't need to | The format string passed in the original |
786| | format this yourself. | logging call. Merged with ``args`` to |
787| | | produce ``message``, or an arbitrary object |
788| | | (see :ref:`arbitrary-object-messages`). |
789+----------------+-------------------------+-----------------------------------------------+
790| name | ``%(name)s`` | Name of the logger used to log the call. |
791+----------------+-------------------------+-----------------------------------------------+
792| pathname | ``%(pathname)s`` | Full pathname of the source file where the |
793| | | logging call was issued (if available). |
794+----------------+-------------------------+-----------------------------------------------+
795| process | ``%(process)d`` | Process ID (if available). |
796+----------------+-------------------------+-----------------------------------------------+
797| processName | ``%(processName)s`` | Process name (if available). |
798+----------------+-------------------------+-----------------------------------------------+
799| relativeCreated| ``%(relativeCreated)d`` | Time in milliseconds when the LogRecord was |
800| | | created, relative to the time the logging |
801| | | module was loaded. |
802+----------------+-------------------------+-----------------------------------------------+
803| stack_info | You shouldn't need to | Stack frame information (where available) |
804| | format this yourself. | from the bottom of the stack in the current |
805| | | thread, up to and including the stack frame |
806| | | of the logging call which resulted in the |
807| | | creation of this record. |
808+----------------+-------------------------+-----------------------------------------------+
809| thread | ``%(thread)d`` | Thread ID (if available). |
810+----------------+-------------------------+-----------------------------------------------+
811| threadName | ``%(threadName)s`` | Thread name (if available). |
812+----------------+-------------------------+-----------------------------------------------+
813
Vinay Sajip3be7a8b2012-07-20 09:50:18 +0100814.. versionchanged:: 3.1
815 *processName* was added.
816
Vinay Sajipc63619b2010-12-19 12:56:57 +0000817
818.. _logger-adapter:
819
820LoggerAdapter Objects
821---------------------
822
823:class:`LoggerAdapter` instances are used to conveniently pass contextual
Serhiy Storchakaa4d170d2013-12-23 18:20:51 +0200824information into logging calls. For a usage example, see the section on
Vinay Sajipc63619b2010-12-19 12:56:57 +0000825:ref:`adding contextual information to your logging output <context-info>`.
826
Vinay Sajipc63619b2010-12-19 12:56:57 +0000827.. class:: LoggerAdapter(logger, extra)
828
829 Returns an instance of :class:`LoggerAdapter` initialized with an
830 underlying :class:`Logger` instance and a dict-like object.
831
832 .. method:: process(msg, kwargs)
833
834 Modifies the message and/or keyword arguments passed to a logging call in
835 order to insert contextual information. This implementation takes the object
836 passed as *extra* to the constructor and adds it to *kwargs* using key
837 'extra'. The return value is a (*msg*, *kwargs*) tuple which has the
838 (possibly modified) versions of the arguments passed in.
839
840In addition to the above, :class:`LoggerAdapter` supports the following
Vinay Sajip9b83d532013-10-31 01:10:30 +0000841methods of :class:`Logger`: :meth:`~Logger.debug`, :meth:`~Logger.info`,
842:meth:`~Logger.warning`, :meth:`~Logger.error`, :meth:`~Logger.exception`,
843:meth:`~Logger.critical`, :meth:`~Logger.log`, :meth:`~Logger.isEnabledFor`,
844:meth:`~Logger.getEffectiveLevel`, :meth:`~Logger.setLevel` and
845:meth:`~Logger.hasHandlers`. These methods have the same signatures as their
Vinay Sajipc63619b2010-12-19 12:56:57 +0000846counterparts in :class:`Logger`, so you can use the two types of instances
847interchangeably.
848
849.. versionchanged:: 3.2
Vinay Sajip9b83d532013-10-31 01:10:30 +0000850 The :meth:`~Logger.isEnabledFor`, :meth:`~Logger.getEffectiveLevel`,
851 :meth:`~Logger.setLevel` and :meth:`~Logger.hasHandlers` methods were added
852 to :class:`LoggerAdapter`. These methods delegate to the underlying logger.
Vinay Sajipc63619b2010-12-19 12:56:57 +0000853
854
855Thread Safety
856-------------
857
858The logging module is intended to be thread-safe without any special work
859needing to be done by its clients. It achieves this though using threading
860locks; there is one lock to serialize access to the module's shared data, and
861each handler also creates a lock to serialize access to its underlying I/O.
862
863If you are implementing asynchronous signal handlers using the :mod:`signal`
864module, you may not be able to use logging from within such handlers. This is
865because lock implementations in the :mod:`threading` module are not always
866re-entrant, and so cannot be invoked from such signal handlers.
867
Georg Brandl116aa622007-08-15 14:28:22 +0000868
Benjamin Peterson058e31e2009-01-16 03:54:08 +0000869Module-Level Functions
870----------------------
871
Georg Brandl116aa622007-08-15 14:28:22 +0000872In addition to the classes described above, there are a number of module- level
873functions.
874
875
Georg Brandlcd7f32b2009-06-08 09:13:45 +0000876.. function:: getLogger(name=None)
Georg Brandl116aa622007-08-15 14:28:22 +0000877
Georg Brandlcd7f32b2009-06-08 09:13:45 +0000878 Return a logger with the specified name or, if name is ``None``, return a
Georg Brandl116aa622007-08-15 14:28:22 +0000879 logger which is the root logger of the hierarchy. If specified, the name is
Vinay Sajip9a6b4002010-12-14 19:40:21 +0000880 typically a dot-separated hierarchical name like *'a'*, *'a.b'* or *'a.b.c.d'*.
Georg Brandl116aa622007-08-15 14:28:22 +0000881 Choice of these names is entirely up to the developer who is using logging.
882
883 All calls to this function with a given name return the same logger instance.
884 This means that logger instances never need to be passed between different parts
885 of an application.
886
887
888.. function:: getLoggerClass()
889
890 Return either the standard :class:`Logger` class, or the last class passed to
891 :func:`setLoggerClass`. This function may be called from within a new class
Vinay Sajip9c10d6b2013-11-15 20:58:13 +0000892 definition, to ensure that installing a customized :class:`Logger` class will
893 not undo customizations already applied by other code. For example::
Georg Brandl116aa622007-08-15 14:28:22 +0000894
895 class MyLogger(logging.getLoggerClass()):
896 # ... override behaviour here
897
898
Vinay Sajip61561522010-12-03 11:50:38 +0000899.. function:: getLogRecordFactory()
900
901 Return a callable which is used to create a :class:`LogRecord`.
902
903 .. versionadded:: 3.2
Vinay Sajip61561522010-12-03 11:50:38 +0000904 This function has been provided, along with :func:`setLogRecordFactory`,
905 to allow developers more control over how the :class:`LogRecord`
906 representing a logging event is constructed.
907
908 See :func:`setLogRecordFactory` for more information about the how the
909 factory is called.
910
Georg Brandlcd7f32b2009-06-08 09:13:45 +0000911.. function:: debug(msg, *args, **kwargs)
Georg Brandl116aa622007-08-15 14:28:22 +0000912
913 Logs a message with level :const:`DEBUG` on the root logger. The *msg* is the
914 message format string, and the *args* are the arguments which are merged into
915 *msg* using the string formatting operator. (Note that this means that you can
916 use keywords in the format string, together with a single dictionary argument.)
917
Vinay Sajip8593ae62010-11-14 21:33:04 +0000918 There are three keyword arguments in *kwargs* which are inspected: *exc_info*
Georg Brandl116aa622007-08-15 14:28:22 +0000919 which, if it does not evaluate as false, causes exception information to be
920 added to the logging message. If an exception tuple (in the format returned by
921 :func:`sys.exc_info`) is provided, it is used; otherwise, :func:`sys.exc_info`
922 is called to get the exception information.
923
Vinay Sajip8593ae62010-11-14 21:33:04 +0000924 The second optional keyword argument is *stack_info*, which defaults to
Serhiy Storchakafbc1c262013-11-29 12:17:13 +0200925 ``False``. If true, stack information is added to the logging
Vinay Sajip8593ae62010-11-14 21:33:04 +0000926 message, including the actual logging call. Note that this is not the same
927 stack information as that displayed through specifying *exc_info*: The
928 former is stack frames from the bottom of the stack up to the logging call
929 in the current thread, whereas the latter is information about stack frames
930 which have been unwound, following an exception, while searching for
931 exception handlers.
932
933 You can specify *stack_info* independently of *exc_info*, e.g. to just show
934 how you got to a certain point in your code, even when no exceptions were
935 raised. The stack frames are printed following a header line which says::
936
937 Stack (most recent call last):
938
Éric Araujo661161e2011-10-22 19:29:48 +0200939 This mimics the ``Traceback (most recent call last):`` which is used when
Vinay Sajip8593ae62010-11-14 21:33:04 +0000940 displaying exception frames.
941
942 The third optional keyword argument is *extra* which can be used to pass a
Georg Brandl116aa622007-08-15 14:28:22 +0000943 dictionary which is used to populate the __dict__ of the LogRecord created for
944 the logging event with user-defined attributes. These custom attributes can then
945 be used as you like. For example, they could be incorporated into logged
946 messages. For example::
947
Vinay Sajip9a6b4002010-12-14 19:40:21 +0000948 FORMAT = '%(asctime)-15s %(clientip)s %(user)-8s %(message)s'
Georg Brandl116aa622007-08-15 14:28:22 +0000949 logging.basicConfig(format=FORMAT)
950 d = {'clientip': '192.168.0.1', 'user': 'fbloggs'}
Vinay Sajip9a6b4002010-12-14 19:40:21 +0000951 logging.warning('Protocol problem: %s', 'connection reset', extra=d)
Georg Brandl116aa622007-08-15 14:28:22 +0000952
Vinay Sajip4039aff2010-09-11 10:25:28 +0000953 would print something like::
Georg Brandl116aa622007-08-15 14:28:22 +0000954
955 2006-02-08 22:20:02,165 192.168.0.1 fbloggs Protocol problem: connection reset
956
957 The keys in the dictionary passed in *extra* should not clash with the keys used
958 by the logging system. (See the :class:`Formatter` documentation for more
959 information on which keys are used by the logging system.)
960
961 If you choose to use these attributes in logged messages, you need to exercise
962 some care. In the above example, for instance, the :class:`Formatter` has been
963 set up with a format string which expects 'clientip' and 'user' in the attribute
964 dictionary of the LogRecord. If these are missing, the message will not be
965 logged because a string formatting exception will occur. So in this case, you
966 always need to pass the *extra* dictionary with these keys.
967
968 While this might be annoying, this feature is intended for use in specialized
969 circumstances, such as multi-threaded servers where the same code executes in
970 many contexts, and interesting conditions which arise are dependent on this
971 context (such as remote client IP address and authenticated user name, in the
972 above example). In such circumstances, it is likely that specialized
973 :class:`Formatter`\ s would be used with particular :class:`Handler`\ s.
974
Vinay Sajip8593ae62010-11-14 21:33:04 +0000975 .. versionadded:: 3.2
976 The *stack_info* parameter was added.
Georg Brandl116aa622007-08-15 14:28:22 +0000977
Georg Brandlcd7f32b2009-06-08 09:13:45 +0000978.. function:: info(msg, *args, **kwargs)
Georg Brandl116aa622007-08-15 14:28:22 +0000979
980 Logs a message with level :const:`INFO` on the root logger. The arguments are
981 interpreted as for :func:`debug`.
982
983
Georg Brandlcd7f32b2009-06-08 09:13:45 +0000984.. function:: warning(msg, *args, **kwargs)
Georg Brandl116aa622007-08-15 14:28:22 +0000985
Vinay Sajip04d5bc02011-10-21 07:33:42 +0100986 Logs a message with level :const:`WARNING` on the root logger. The arguments
987 are interpreted as for :func:`debug`.
988
Éric Araujo661161e2011-10-22 19:29:48 +0200989 .. note:: There is an obsolete function ``warn`` which is functionally
990 identical to ``warning``. As ``warn`` is deprecated, please do not use
991 it - use ``warning`` instead.
Georg Brandl116aa622007-08-15 14:28:22 +0000992
993
Georg Brandlcd7f32b2009-06-08 09:13:45 +0000994.. function:: error(msg, *args, **kwargs)
Georg Brandl116aa622007-08-15 14:28:22 +0000995
996 Logs a message with level :const:`ERROR` on the root logger. The arguments are
997 interpreted as for :func:`debug`.
998
999
Georg Brandlcd7f32b2009-06-08 09:13:45 +00001000.. function:: critical(msg, *args, **kwargs)
Georg Brandl116aa622007-08-15 14:28:22 +00001001
1002 Logs a message with level :const:`CRITICAL` on the root logger. The arguments
1003 are interpreted as for :func:`debug`.
1004
1005
Vinay Sajip65425b42014-04-15 23:13:12 +01001006.. function:: exception(msg, *args, **kwargs)
Georg Brandl116aa622007-08-15 14:28:22 +00001007
1008 Logs a message with level :const:`ERROR` on the root logger. The arguments are
1009 interpreted as for :func:`debug`. Exception info is added to the logging
1010 message. This function should only be called from an exception handler.
1011
Georg Brandlcd7f32b2009-06-08 09:13:45 +00001012.. function:: log(level, msg, *args, **kwargs)
Georg Brandl116aa622007-08-15 14:28:22 +00001013
1014 Logs a message with level *level* on the root logger. The other arguments are
1015 interpreted as for :func:`debug`.
1016
Vinay Sajip350e6232014-01-15 13:28:39 +00001017 .. note:: The above module-level convenience functions, which delegate to the
1018 root logger, call :func:`basicConfig` to ensure that at least one handler
1019 is available. Because of this, they should *not* be used in threads,
1020 in versions of Python earlier than 2.7.1 and 3.2, unless at least one
1021 handler has been added to the root logger *before* the threads are
1022 started. In earlier versions of Python, due to a thread safety shortcoming
1023 in :func:`basicConfig`, this can (under rare circumstances) lead to
1024 handlers being added multiple times to the root logger, which can in turn
1025 lead to multiple messages for the same event.
Georg Brandl116aa622007-08-15 14:28:22 +00001026
1027.. function:: disable(lvl)
1028
1029 Provides an overriding level *lvl* for all loggers which takes precedence over
1030 the logger's own level. When the need arises to temporarily throttle logging
Benjamin Peterson886af962010-03-21 23:13:07 +00001031 output down across the whole application, this function can be useful. Its
1032 effect is to disable all logging calls of severity *lvl* and below, so that
1033 if you call it with a value of INFO, then all INFO and DEBUG events would be
1034 discarded, whereas those of severity WARNING and above would be processed
Vinay Sajipa9c179b2013-11-30 22:45:29 +00001035 according to the logger's effective level. If
1036 ``logging.disable(logging.NOTSET)`` is called, it effectively removes this
1037 overriding level, so that logging output again depends on the effective
1038 levels of individual loggers.
Georg Brandl116aa622007-08-15 14:28:22 +00001039
1040
1041.. function:: addLevelName(lvl, levelName)
1042
1043 Associates level *lvl* with text *levelName* in an internal dictionary, which is
1044 used to map numeric levels to a textual representation, for example when a
1045 :class:`Formatter` formats a message. This function can also be used to define
1046 your own levels. The only constraints are that all levels used must be
1047 registered using this function, levels should be positive integers and they
1048 should increase in increasing order of severity.
1049
Vinay Sajip21b30822013-01-08 11:25:42 +00001050 .. note:: If you are thinking of defining your own levels, please see the
1051 section on :ref:`custom-levels`.
Georg Brandl116aa622007-08-15 14:28:22 +00001052
1053.. function:: getLevelName(lvl)
1054
1055 Returns the textual representation of logging level *lvl*. If the level is one
1056 of the predefined levels :const:`CRITICAL`, :const:`ERROR`, :const:`WARNING`,
1057 :const:`INFO` or :const:`DEBUG` then you get the corresponding string. If you
1058 have associated levels with names using :func:`addLevelName` then the name you
1059 have associated with *lvl* is returned. If a numeric value corresponding to one
1060 of the defined levels is passed in, the corresponding string representation is
Vinay Sajip9a6b4002010-12-14 19:40:21 +00001061 returned. Otherwise, the string 'Level %s' % lvl is returned.
Georg Brandl116aa622007-08-15 14:28:22 +00001062
Vinay Sajip2f1cd8a2014-09-18 18:01:12 +01001063 .. note:: Levels are internally integers (as they need to be compared in the
1064 logging logic). This function is used to convert between an integer level
1065 and the level name displayed in the formatted log output by means of the
1066 ``%(levelname)s`` format specifier (see :ref:`logrecord-attributes`).
1067
Vinay Sajipe0d324d2014-06-14 09:26:26 +01001068 .. versionchanged:: 3.4
1069 In Python versions earlier than 3.4, this function could also be passed a
1070 text level, and would return the corresponding numeric value of the level.
Vinay Sajipd1d4fbf2014-09-11 23:06:09 +01001071 This undocumented behaviour was considered a mistake, and was removed in
1072 Python 3.4, but reinstated in 3.4.2 due to retain backward compatibility.
Georg Brandl116aa622007-08-15 14:28:22 +00001073
1074.. function:: makeLogRecord(attrdict)
1075
1076 Creates and returns a new :class:`LogRecord` instance whose attributes are
1077 defined by *attrdict*. This function is useful for taking a pickled
1078 :class:`LogRecord` attribute dictionary, sent over a socket, and reconstituting
1079 it as a :class:`LogRecord` instance at the receiving end.
1080
1081
Georg Brandlcd7f32b2009-06-08 09:13:45 +00001082.. function:: basicConfig(**kwargs)
Georg Brandl116aa622007-08-15 14:28:22 +00001083
1084 Does basic configuration for the logging system by creating a
1085 :class:`StreamHandler` with a default :class:`Formatter` and adding it to the
Vinay Sajipcbabd7e2009-10-10 20:32:36 +00001086 root logger. The functions :func:`debug`, :func:`info`, :func:`warning`,
Georg Brandl116aa622007-08-15 14:28:22 +00001087 :func:`error` and :func:`critical` will call :func:`basicConfig` automatically
1088 if no handlers are defined for the root logger.
1089
Vinay Sajipcbabd7e2009-10-10 20:32:36 +00001090 This function does nothing if the root logger already has handlers
1091 configured for it.
1092
Vinay Sajipe50f4d22013-01-07 14:16:52 +00001093 .. note:: This function should be called from the main thread
1094 before other threads are started. In versions of Python prior to
1095 2.7.1 and 3.2, if this function is called from multiple threads,
1096 it is possible (in rare circumstances) that a handler will be added
1097 to the root logger more than once, leading to unexpected results
1098 such as messages being duplicated in the log.
Vinay Sajipc8c8c692010-09-17 10:09:04 +00001099
Georg Brandl116aa622007-08-15 14:28:22 +00001100 The following keyword arguments are supported.
1101
Georg Brandl44ea77b2013-03-28 13:28:44 +01001102 .. tabularcolumns:: |l|L|
1103
Georg Brandl116aa622007-08-15 14:28:22 +00001104 +--------------+---------------------------------------------+
1105 | Format | Description |
1106 +==============+=============================================+
1107 | ``filename`` | Specifies that a FileHandler be created, |
1108 | | using the specified filename, rather than a |
1109 | | StreamHandler. |
1110 +--------------+---------------------------------------------+
1111 | ``filemode`` | Specifies the mode to open the file, if |
1112 | | filename is specified (if filemode is |
1113 | | unspecified, it defaults to 'a'). |
1114 +--------------+---------------------------------------------+
1115 | ``format`` | Use the specified format string for the |
1116 | | handler. |
1117 +--------------+---------------------------------------------+
1118 | ``datefmt`` | Use the specified date/time format. |
1119 +--------------+---------------------------------------------+
Vinay Sajipc5b27302010-10-31 14:59:16 +00001120 | ``style`` | If ``format`` is specified, use this style |
1121 | | for the format string. One of '%', '{' or |
1122 | | '$' for %-formatting, :meth:`str.format` or |
1123 | | :class:`string.Template` respectively, and |
1124 | | defaulting to '%' if not specified. |
1125 +--------------+---------------------------------------------+
Georg Brandl116aa622007-08-15 14:28:22 +00001126 | ``level`` | Set the root logger level to the specified |
1127 | | level. |
1128 +--------------+---------------------------------------------+
1129 | ``stream`` | Use the specified stream to initialize the |
1130 | | StreamHandler. Note that this argument is |
1131 | | incompatible with 'filename' - if both are |
Vinay Sajip4a0a31d2011-04-11 08:42:07 +01001132 | | present, a ``ValueError`` is raised. |
1133 +--------------+---------------------------------------------+
1134 | ``handlers`` | If specified, this should be an iterable of |
1135 | | already created handlers to add to the root |
1136 | | logger. Any handlers which don't already |
1137 | | have a formatter set will be assigned the |
1138 | | default formatter created in this function. |
1139 | | Note that this argument is incompatible |
1140 | | with 'filename' or 'stream' - if both are |
1141 | | present, a ``ValueError`` is raised. |
Georg Brandl116aa622007-08-15 14:28:22 +00001142 +--------------+---------------------------------------------+
1143
Vinay Sajipc5b27302010-10-31 14:59:16 +00001144 .. versionchanged:: 3.2
1145 The ``style`` argument was added.
1146
Vinay Sajip4a0a31d2011-04-11 08:42:07 +01001147 .. versionchanged:: 3.3
1148 The ``handlers`` argument was added. Additional checks were added to
1149 catch situations where incompatible arguments are specified (e.g.
1150 ``handlers`` together with ``stream`` or ``filename``, or ``stream``
1151 together with ``filename``).
1152
Vinay Sajipc5b27302010-10-31 14:59:16 +00001153
Georg Brandl116aa622007-08-15 14:28:22 +00001154.. function:: shutdown()
1155
1156 Informs the logging system to perform an orderly shutdown by flushing and
Christian Heimesb186d002008-03-18 15:15:01 +00001157 closing all handlers. This should be called at application exit and no
1158 further use of the logging system should be made after this call.
Georg Brandl116aa622007-08-15 14:28:22 +00001159
1160
1161.. function:: setLoggerClass(klass)
1162
1163 Tells the logging system to use the class *klass* when instantiating a logger.
1164 The class should define :meth:`__init__` such that only a name argument is
1165 required, and the :meth:`__init__` should call :meth:`Logger.__init__`. This
1166 function is typically called before any loggers are instantiated by applications
1167 which need to use custom logger behavior.
1168
Georg Brandl1eb40bc2010-12-03 15:30:09 +00001169
Vinay Sajip61561522010-12-03 11:50:38 +00001170.. function:: setLogRecordFactory(factory)
1171
1172 Set a callable which is used to create a :class:`LogRecord`.
1173
1174 :param factory: The factory callable to be used to instantiate a log record.
1175
1176 .. versionadded:: 3.2
Georg Brandl1eb40bc2010-12-03 15:30:09 +00001177 This function has been provided, along with :func:`getLogRecordFactory`, to
1178 allow developers more control over how the :class:`LogRecord` representing
1179 a logging event is constructed.
Vinay Sajip61561522010-12-03 11:50:38 +00001180
Georg Brandl1eb40bc2010-12-03 15:30:09 +00001181 The factory has the following signature:
Vinay Sajip61561522010-12-03 11:50:38 +00001182
Vinay Sajip9a6b4002010-12-14 19:40:21 +00001183 ``factory(name, level, fn, lno, msg, args, exc_info, func=None, sinfo=None, **kwargs)``
Vinay Sajip61561522010-12-03 11:50:38 +00001184
1185 :name: The logger name.
1186 :level: The logging level (numeric).
1187 :fn: The full pathname of the file where the logging call was made.
1188 :lno: The line number in the file where the logging call was made.
1189 :msg: The logging message.
1190 :args: The arguments for the logging message.
1191 :exc_info: An exception tuple, or None.
1192 :func: The name of the function or method which invoked the logging
1193 call.
1194 :sinfo: A stack traceback such as is provided by
1195 :func:`traceback.print_stack`, showing the call hierarchy.
1196 :kwargs: Additional keyword arguments.
Georg Brandl116aa622007-08-15 14:28:22 +00001197
Georg Brandl1eb40bc2010-12-03 15:30:09 +00001198
Vinay Sajipe50f4d22013-01-07 14:16:52 +00001199Module-Level Attributes
1200-----------------------
1201
1202.. attribute:: lastResort
1203
1204 A "handler of last resort" is available through this attribute. This
1205 is a :class:`StreamHandler` writing to ``sys.stderr`` with a level of
1206 ``WARNING``, and is used to handle logging events in the absence of any
1207 logging configuration. The end result is to just print the message to
1208 ``sys.stderr``. This replaces the earlier error message saying that
1209 "no handlers could be found for logger XYZ". If you need the earlier
1210 behaviour for some reason, ``lastResort`` can be set to ``None``.
1211
1212 .. versionadded:: 3.2
1213
Benjamin Peterson9451a1c2010-03-13 22:30:34 +00001214Integration with the warnings module
1215------------------------------------
1216
1217The :func:`captureWarnings` function can be used to integrate :mod:`logging`
1218with the :mod:`warnings` module.
1219
1220.. function:: captureWarnings(capture)
1221
1222 This function is used to turn the capture of warnings by logging on and
1223 off.
1224
Senthil Kumaran46a48be2010-10-15 13:10:10 +00001225 If *capture* is ``True``, warnings issued by the :mod:`warnings` module will
1226 be redirected to the logging system. Specifically, a warning will be
Benjamin Peterson9451a1c2010-03-13 22:30:34 +00001227 formatted using :func:`warnings.formatwarning` and the resulting string
Éric Araujoa6091992012-02-26 02:13:30 +01001228 logged to a logger named ``'py.warnings'`` with a severity of :const:`WARNING`.
Benjamin Peterson9451a1c2010-03-13 22:30:34 +00001229
Senthil Kumaran46a48be2010-10-15 13:10:10 +00001230 If *capture* is ``False``, the redirection of warnings to the logging system
Benjamin Peterson9451a1c2010-03-13 22:30:34 +00001231 will stop, and warnings will be redirected to their original destinations
Éric Araujo661161e2011-10-22 19:29:48 +02001232 (i.e. those in effect before ``captureWarnings(True)`` was called).
Benjamin Peterson9451a1c2010-03-13 22:30:34 +00001233
1234
Vinay Sajipc63619b2010-12-19 12:56:57 +00001235.. seealso::
Vinay Sajip75043022010-12-19 06:02:31 +00001236
Vinay Sajipc63619b2010-12-19 12:56:57 +00001237 Module :mod:`logging.config`
1238 Configuration API for the logging module.
Georg Brandl116aa622007-08-15 14:28:22 +00001239
Vinay Sajipc63619b2010-12-19 12:56:57 +00001240 Module :mod:`logging.handlers`
1241 Useful handlers included with the logging module.
Georg Brandl116aa622007-08-15 14:28:22 +00001242
Vinay Sajipc63619b2010-12-19 12:56:57 +00001243 :pep:`282` - A Logging System
1244 The proposal which described this feature for inclusion in the Python standard
1245 library.
Georg Brandl116aa622007-08-15 14:28:22 +00001246
Vinay Sajipc63619b2010-12-19 12:56:57 +00001247 `Original Python logging package <http://www.red-dove.com/python_logging.html>`_
1248 This is the original source for the :mod:`logging` package. The version of the
1249 package available from this site is suitable for use with Python 1.5.2, 2.1.x
1250 and 2.2.x, which do not include the :mod:`logging` package in the standard
1251 library.
Christian Heimes8b0facf2007-12-04 19:30:01 +00001252