Updated documentation for findCaller() to indicate that a 3-tuple is now returned...
[python.git] / Doc / lib / liblogging.tex
blobb97854d4e72dfdc55fdb5e30be7efbc0b88b1665
1 \section{\module{logging} ---
2 Logging facility for Python}
4 \declaremodule{standard}{logging}
6 % These apply to all modules, and may be given more than once:
8 \moduleauthor{Vinay Sajip}{vinay_sajip@red-dove.com}
9 \sectionauthor{Vinay Sajip}{vinay_sajip@red-dove.com}
11 \modulesynopsis{Logging module for Python based on \pep{282}.}
13 \indexii{Errors}{logging}
15 \versionadded{2.3}
16 This module defines functions and classes which implement a flexible
17 error logging system for applications.
19 Logging is performed by calling methods on instances of the
20 \class{Logger} class (hereafter called \dfn{loggers}). Each instance has a
21 name, and they are conceptually arranged in a name space hierarchy
22 using dots (periods) as separators. For example, a logger named
23 "scan" is the parent of loggers "scan.text", "scan.html" and "scan.pdf".
24 Logger names can be anything you want, and indicate the area of an
25 application in which a logged message originates.
27 Logged messages also have levels of importance associated with them.
28 The default levels provided are \constant{DEBUG}, \constant{INFO},
29 \constant{WARNING}, \constant{ERROR} and \constant{CRITICAL}. As a
30 convenience, you indicate the importance of a logged message by calling
31 an appropriate method of \class{Logger}. The methods are
32 \method{debug()}, \method{info()}, \method{warning()}, \method{error()} and
33 \method{critical()}, which mirror the default levels. You are not
34 constrained to use these levels: you can specify your own and use a
35 more general \class{Logger} method, \method{log()}, which takes an
36 explicit level argument.
38 The numeric values of logging levels are given in the following table. These
39 are primarily of interest if you want to define your own levels, and need
40 them to have specific values relative to the predefined levels. If you
41 define a level with the same numeric value, it overwrites the predefined
42 value; the predefined name is lost.
44 \begin{tableii}{l|l}{code}{Level}{Numeric value}
45 \lineii{CRITICAL}{50}
46 \lineii{ERROR}{40}
47 \lineii{WARNING}{30}
48 \lineii{INFO}{20}
49 \lineii{DEBUG}{10}
50 \lineii{NOTSET}{0}
51 \end{tableii}
53 Levels can also be associated with loggers, being set either by the
54 developer or through loading a saved logging configuration. When a
55 logging method is called on a logger, the logger compares its own
56 level with the level associated with the method call. If the logger's
57 level is higher than the method call's, no logging message is actually
58 generated. This is the basic mechanism controlling the verbosity of
59 logging output.
61 Logging messages are encoded as instances of the \class{LogRecord} class.
62 When a logger decides to actually log an event, a \class{LogRecord}
63 instance is created from the logging message.
65 Logging messages are subjected to a dispatch mechanism through the
66 use of \dfn{handlers}, which are instances of subclasses of the
67 \class{Handler} class. Handlers are responsible for ensuring that a logged
68 message (in the form of a \class{LogRecord}) ends up in a particular
69 location (or set of locations) which is useful for the target audience for
70 that message (such as end users, support desk staff, system administrators,
71 developers). Handlers are passed \class{LogRecord} instances intended for
72 particular destinations. Each logger can have zero, one or more handlers
73 associated with it (via the \method{addHandler()} method of \class{Logger}).
74 In addition to any handlers directly associated with a logger,
75 \emph{all handlers associated with all ancestors of the logger} are
76 called to dispatch the message.
78 Just as for loggers, handlers can have levels associated with them.
79 A handler's level acts as a filter in the same way as a logger's level does.
80 If a handler decides to actually dispatch an event, the \method{emit()} method
81 is used to send the message to its destination. Most user-defined subclasses
82 of \class{Handler} will need to override this \method{emit()}.
84 In addition to the base \class{Handler} class, many useful subclasses
85 are provided:
87 \begin{enumerate}
89 \item \class{StreamHandler} instances send error messages to
90 streams (file-like objects).
92 \item \class{FileHandler} instances send error messages to disk
93 files.
95 \item \class{BaseRotatingHandler} is the base class for handlers that
96 rotate log files at a certain point. It is not meant to be instantiated
97 directly. Instead, use \class{RotatingFileHandler} or
98 \class{TimedRotatingFileHandler}.
100 \item \class{RotatingFileHandler} instances send error messages to disk
101 files, with support for maximum log file sizes and log file rotation.
103 \item \class{TimedRotatingFileHandler} instances send error messages to
104 disk files rotating the log file at certain timed intervals.
106 \item \class{SocketHandler} instances send error messages to
107 TCP/IP sockets.
109 \item \class{DatagramHandler} instances send error messages to UDP
110 sockets.
112 \item \class{SMTPHandler} instances send error messages to a
113 designated email address.
115 \item \class{SysLogHandler} instances send error messages to a
116 \UNIX{} syslog daemon, possibly on a remote machine.
118 \item \class{NTEventLogHandler} instances send error messages to a
119 Windows NT/2000/XP event log.
121 \item \class{MemoryHandler} instances send error messages to a
122 buffer in memory, which is flushed whenever specific criteria are
123 met.
125 \item \class{HTTPHandler} instances send error messages to an
126 HTTP server using either \samp{GET} or \samp{POST} semantics.
128 \end{enumerate}
130 The \class{StreamHandler} and \class{FileHandler} classes are defined
131 in the core logging package. The other handlers are defined in a sub-
132 module, \module{logging.handlers}. (There is also another sub-module,
133 \module{logging.config}, for configuration functionality.)
135 Logged messages are formatted for presentation through instances of the
136 \class{Formatter} class. They are initialized with a format string
137 suitable for use with the \% operator and a dictionary.
139 For formatting multiple messages in a batch, instances of
140 \class{BufferingFormatter} can be used. In addition to the format string
141 (which is applied to each message in the batch), there is provision for
142 header and trailer format strings.
144 When filtering based on logger level and/or handler level is not enough,
145 instances of \class{Filter} can be added to both \class{Logger} and
146 \class{Handler} instances (through their \method{addFilter()} method).
147 Before deciding to process a message further, both loggers and handlers
148 consult all their filters for permission. If any filter returns a false
149 value, the message is not processed further.
151 The basic \class{Filter} functionality allows filtering by specific logger
152 name. If this feature is used, messages sent to the named logger and its
153 children are allowed through the filter, and all others dropped.
155 In addition to the classes described above, there are a number of module-
156 level functions.
158 \begin{funcdesc}{getLogger}{\optional{name}}
159 Return a logger with the specified name or, if no name is specified, return
160 a logger which is the root logger of the hierarchy. If specified, the name
161 is typically a dot-separated hierarchical name like \var{"a"}, \var{"a.b"}
162 or \var{"a.b.c.d"}. Choice of these names is entirely up to the developer
163 who is using logging.
165 All calls to this function with a given name return the same logger instance.
166 This means that logger instances never need to be passed between different
167 parts of an application.
168 \end{funcdesc}
170 \begin{funcdesc}{getLoggerClass}{}
171 Return either the standard \class{Logger} class, or the last class passed to
172 \function{setLoggerClass()}. This function may be called from within a new
173 class definition, to ensure that installing a customised \class{Logger} class
174 will not undo customisations already applied by other code. For example:
176 \begin{verbatim}
177 class MyLogger(logging.getLoggerClass()):
178 # ... override behaviour here
179 \end{verbatim}
181 \end{funcdesc}
183 \begin{funcdesc}{debug}{msg\optional{, *args\optional{, **kwargs}}}
184 Logs a message with level \constant{DEBUG} on the root logger.
185 The \var{msg} is the message format string, and the \var{args} are the
186 arguments which are merged into \var{msg} using the string formatting
187 operator. (Note that this means that you can use keywords in the
188 format string, together with a single dictionary argument.)
190 There are two keyword arguments in \var{kwargs} which are inspected:
191 \var{exc_info} which, if it does not evaluate as false, causes exception
192 information to be added to the logging message. If an exception tuple (in the
193 format returned by \function{sys.exc_info()}) is provided, it is used;
194 otherwise, \function{sys.exc_info()} is called to get the exception
195 information.
197 The other optional keyword argument is \var{extra} which can be used to pass
198 a dictionary which is used to populate the __dict__ of the LogRecord created
199 for the logging event with user-defined attributes. These custom attributes
200 can then be used as you like. For example, they could be incorporated into
201 logged messages. For example:
203 \begin{verbatim}
204 FORMAT = "%(asctime)-15s %(clientip)s %(user)-8s %(message)s"
205 logging.basicConfig(format=FORMAT)
206 dict = { 'clientip' : '192.168.0.1', 'user' : 'fbloggs' }
207 logging.warning("Protocol problem: %s", "connection reset", extra=d)
208 \end{verbatim}
210 would print something like
211 \begin{verbatim}
212 2006-02-08 22:20:02,165 192.168.0.1 fbloggs Protocol problem: connection reset
213 \end{verbatim}
215 The keys in the dictionary passed in \var{extra} should not clash with the keys
216 used by the logging system. (See the \class{Formatter} documentation for more
217 information on which keys are used by the logging system.)
219 If you choose to use these attributes in logged messages, you need to exercise
220 some care. In the above example, for instance, the \class{Formatter} has been
221 set up with a format string which expects 'clientip' and 'user' in the
222 attribute dictionary of the LogRecord. If these are missing, the message will
223 not be logged because a string formatting exception will occur. So in this
224 case, you always need to pass the \var{extra} dictionary with these keys.
226 While this might be annoying, this feature is intended for use in specialized
227 circumstances, such as multi-threaded servers where the same code executes
228 in many contexts, and interesting conditions which arise are dependent on this
229 context (such as remote client IP address and authenticated user name, in the
230 above example). In such circumstances, it is likely that specialized
231 \class{Formatter}s would be used with particular \class{Handler}s.
233 \versionchanged[\var{extra} was added]{2.5}
235 \end{funcdesc}
237 \begin{funcdesc}{info}{msg\optional{, *args\optional{, **kwargs}}}
238 Logs a message with level \constant{INFO} on the root logger.
239 The arguments are interpreted as for \function{debug()}.
240 \end{funcdesc}
242 \begin{funcdesc}{warning}{msg\optional{, *args\optional{, **kwargs}}}
243 Logs a message with level \constant{WARNING} on the root logger.
244 The arguments are interpreted as for \function{debug()}.
245 \end{funcdesc}
247 \begin{funcdesc}{error}{msg\optional{, *args\optional{, **kwargs}}}
248 Logs a message with level \constant{ERROR} on the root logger.
249 The arguments are interpreted as for \function{debug()}.
250 \end{funcdesc}
252 \begin{funcdesc}{critical}{msg\optional{, *args\optional{, **kwargs}}}
253 Logs a message with level \constant{CRITICAL} on the root logger.
254 The arguments are interpreted as for \function{debug()}.
255 \end{funcdesc}
257 \begin{funcdesc}{exception}{msg\optional{, *args}}
258 Logs a message with level \constant{ERROR} on the root logger.
259 The arguments are interpreted as for \function{debug()}. Exception info
260 is added to the logging message. This function should only be called
261 from an exception handler.
262 \end{funcdesc}
264 \begin{funcdesc}{log}{level, msg\optional{, *args\optional{, **kwargs}}}
265 Logs a message with level \var{level} on the root logger.
266 The other arguments are interpreted as for \function{debug()}.
267 \end{funcdesc}
269 \begin{funcdesc}{disable}{lvl}
270 Provides an overriding level \var{lvl} for all loggers which takes
271 precedence over the logger's own level. When the need arises to
272 temporarily throttle logging output down across the whole application,
273 this function can be useful.
274 \end{funcdesc}
276 \begin{funcdesc}{addLevelName}{lvl, levelName}
277 Associates level \var{lvl} with text \var{levelName} in an internal
278 dictionary, which is used to map numeric levels to a textual
279 representation, for example when a \class{Formatter} formats a message.
280 This function can also be used to define your own levels. The only
281 constraints are that all levels used must be registered using this
282 function, levels should be positive integers and they should increase
283 in increasing order of severity.
284 \end{funcdesc}
286 \begin{funcdesc}{getLevelName}{lvl}
287 Returns the textual representation of logging level \var{lvl}. If the
288 level is one of the predefined levels \constant{CRITICAL},
289 \constant{ERROR}, \constant{WARNING}, \constant{INFO} or \constant{DEBUG}
290 then you get the corresponding string. If you have associated levels
291 with names using \function{addLevelName()} then the name you have associated
292 with \var{lvl} is returned. If a numeric value corresponding to one of the
293 defined levels is passed in, the corresponding string representation is
294 returned. Otherwise, the string "Level \%s" \% lvl is returned.
295 \end{funcdesc}
297 \begin{funcdesc}{makeLogRecord}{attrdict}
298 Creates and returns a new \class{LogRecord} instance whose attributes are
299 defined by \var{attrdict}. This function is useful for taking a pickled
300 \class{LogRecord} attribute dictionary, sent over a socket, and reconstituting
301 it as a \class{LogRecord} instance at the receiving end.
302 \end{funcdesc}
304 \begin{funcdesc}{basicConfig}{\optional{**kwargs}}
305 Does basic configuration for the logging system by creating a
306 \class{StreamHandler} with a default \class{Formatter} and adding it to
307 the root logger. The functions \function{debug()}, \function{info()},
308 \function{warning()}, \function{error()} and \function{critical()} will call
309 \function{basicConfig()} automatically if no handlers are defined for the
310 root logger.
312 \versionchanged[Formerly, \function{basicConfig} did not take any keyword
313 arguments]{2.4}
315 The following keyword arguments are supported.
317 \begin{tableii}{l|l}{code}{Format}{Description}
318 \lineii{filename}{Specifies that a FileHandler be created, using the
319 specified filename, rather than a StreamHandler.}
320 \lineii{filemode}{Specifies the mode to open the file, if filename is
321 specified (if filemode is unspecified, it defaults to 'a').}
322 \lineii{format}{Use the specified format string for the handler.}
323 \lineii{datefmt}{Use the specified date/time format.}
324 \lineii{level}{Set the root logger level to the specified level.}
325 \lineii{stream}{Use the specified stream to initialize the StreamHandler.
326 Note that this argument is incompatible with 'filename' - if both
327 are present, 'stream' is ignored.}
328 \end{tableii}
330 \end{funcdesc}
332 \begin{funcdesc}{shutdown}{}
333 Informs the logging system to perform an orderly shutdown by flushing and
334 closing all handlers.
335 \end{funcdesc}
337 \begin{funcdesc}{setLoggerClass}{klass}
338 Tells the logging system to use the class \var{klass} when instantiating a
339 logger. The class should define \method{__init__()} such that only a name
340 argument is required, and the \method{__init__()} should call
341 \method{Logger.__init__()}. This function is typically called before any
342 loggers are instantiated by applications which need to use custom logger
343 behavior.
344 \end{funcdesc}
347 \begin{seealso}
348 \seepep{282}{A Logging System}
349 {The proposal which described this feature for inclusion in
350 the Python standard library.}
351 \seelink{http://www.red-dove.com/python_logging.html}
352 {Original Python \module{logging} package}
353 {This is the original source for the \module{logging}
354 package. The version of the package available from this
355 site is suitable for use with Python 1.5.2, 2.1.x and 2.2.x,
356 which do not include the \module{logging} package in the standard
357 library.}
358 \end{seealso}
361 \subsection{Logger Objects}
363 Loggers have the following attributes and methods. Note that Loggers are
364 never instantiated directly, but always through the module-level function
365 \function{logging.getLogger(name)}.
367 \begin{datadesc}{propagate}
368 If this evaluates to false, logging messages are not passed by this
369 logger or by child loggers to higher level (ancestor) loggers. The
370 constructor sets this attribute to 1.
371 \end{datadesc}
373 \begin{methoddesc}{setLevel}{lvl}
374 Sets the threshold for this logger to \var{lvl}. Logging messages
375 which are less severe than \var{lvl} will be ignored. When a logger is
376 created, the level is set to \constant{NOTSET} (which causes all messages
377 to be processed when the logger is the root logger, or delegation to the
378 parent when the logger is a non-root logger). Note that the root logger
379 is created with level \constant{WARNING}.
381 The term "delegation to the parent" means that if a logger has a level
382 of NOTSET, its chain of ancestor loggers is traversed until either an
383 ancestor with a level other than NOTSET is found, or the root is
384 reached.
386 If an ancestor is found with a level other than NOTSET, then that
387 ancestor's level is treated as the effective level of the logger where
388 the ancestor search began, and is used to determine how a logging
389 event is handled.
391 If the root is reached, and it has a level of NOTSET, then all
392 messages will be processed. Otherwise, the root's level will be used
393 as the effective level.
394 \end{methoddesc}
396 \begin{methoddesc}{isEnabledFor}{lvl}
397 Indicates if a message of severity \var{lvl} would be processed by
398 this logger. This method checks first the module-level level set by
399 \function{logging.disable(lvl)} and then the logger's effective level as
400 determined by \method{getEffectiveLevel()}.
401 \end{methoddesc}
403 \begin{methoddesc}{getEffectiveLevel}{}
404 Indicates the effective level for this logger. If a value other than
405 \constant{NOTSET} has been set using \method{setLevel()}, it is returned.
406 Otherwise, the hierarchy is traversed towards the root until a value
407 other than \constant{NOTSET} is found, and that value is returned.
408 \end{methoddesc}
410 \begin{methoddesc}{debug}{msg\optional{, *args\optional{, **kwargs}}}
411 Logs a message with level \constant{DEBUG} on this logger.
412 The \var{msg} is the message format string, and the \var{args} are the
413 arguments which are merged into \var{msg} using the string formatting
414 operator. (Note that this means that you can use keywords in the
415 format string, together with a single dictionary argument.)
417 There are two keyword arguments in \var{kwargs} which are inspected:
418 \var{exc_info} which, if it does not evaluate as false, causes exception
419 information to be added to the logging message. If an exception tuple (in the
420 format returned by \function{sys.exc_info()}) is provided, it is used;
421 otherwise, \function{sys.exc_info()} is called to get the exception
422 information.
424 The other optional keyword argument is \var{extra} which can be used to pass
425 a dictionary which is used to populate the __dict__ of the LogRecord created
426 for the logging event with user-defined attributes. These custom attributes
427 can then be used as you like. For example, they could be incorporated into
428 logged messages. For example:
430 \begin{verbatim}
431 FORMAT = "%(asctime)-15s %(clientip)s %(user)-8s %(message)s"
432 logging.basicConfig(format=FORMAT)
433 dict = { 'clientip' : '192.168.0.1', 'user' : 'fbloggs' }
434 logger = logging.getLogger("tcpserver")
435 logger.warning("Protocol problem: %s", "connection reset", extra=d)
436 \end{verbatim}
438 would print something like
439 \begin{verbatim}
440 2006-02-08 22:20:02,165 192.168.0.1 fbloggs Protocol problem: connection reset
441 \end{verbatim}
443 The keys in the dictionary passed in \var{extra} should not clash with the keys
444 used by the logging system. (See the \class{Formatter} documentation for more
445 information on which keys are used by the logging system.)
447 If you choose to use these attributes in logged messages, you need to exercise
448 some care. In the above example, for instance, the \class{Formatter} has been
449 set up with a format string which expects 'clientip' and 'user' in the
450 attribute dictionary of the LogRecord. If these are missing, the message will
451 not be logged because a string formatting exception will occur. So in this
452 case, you always need to pass the \var{extra} dictionary with these keys.
454 While this might be annoying, this feature is intended for use in specialized
455 circumstances, such as multi-threaded servers where the same code executes
456 in many contexts, and interesting conditions which arise are dependent on this
457 context (such as remote client IP address and authenticated user name, in the
458 above example). In such circumstances, it is likely that specialized
459 \class{Formatter}s would be used with particular \class{Handler}s.
461 \versionchanged[\var{extra} was added]{2.5}
463 \end{methoddesc}
465 \begin{methoddesc}{info}{msg\optional{, *args\optional{, **kwargs}}}
466 Logs a message with level \constant{INFO} on this logger.
467 The arguments are interpreted as for \method{debug()}.
468 \end{methoddesc}
470 \begin{methoddesc}{warning}{msg\optional{, *args\optional{, **kwargs}}}
471 Logs a message with level \constant{WARNING} on this logger.
472 The arguments are interpreted as for \method{debug()}.
473 \end{methoddesc}
475 \begin{methoddesc}{error}{msg\optional{, *args\optional{, **kwargs}}}
476 Logs a message with level \constant{ERROR} on this logger.
477 The arguments are interpreted as for \method{debug()}.
478 \end{methoddesc}
480 \begin{methoddesc}{critical}{msg\optional{, *args\optional{, **kwargs}}}
481 Logs a message with level \constant{CRITICAL} on this logger.
482 The arguments are interpreted as for \method{debug()}.
483 \end{methoddesc}
485 \begin{methoddesc}{log}{lvl, msg\optional{, *args\optional{, **kwargs}}}
486 Logs a message with integer level \var{lvl} on this logger.
487 The other arguments are interpreted as for \method{debug()}.
488 \end{methoddesc}
490 \begin{methoddesc}{exception}{msg\optional{, *args}}
491 Logs a message with level \constant{ERROR} on this logger.
492 The arguments are interpreted as for \method{debug()}. Exception info
493 is added to the logging message. This method should only be called
494 from an exception handler.
495 \end{methoddesc}
497 \begin{methoddesc}{addFilter}{filt}
498 Adds the specified filter \var{filt} to this logger.
499 \end{methoddesc}
501 \begin{methoddesc}{removeFilter}{filt}
502 Removes the specified filter \var{filt} from this logger.
503 \end{methoddesc}
505 \begin{methoddesc}{filter}{record}
506 Applies this logger's filters to the record and returns a true value if
507 the record is to be processed.
508 \end{methoddesc}
510 \begin{methoddesc}{addHandler}{hdlr}
511 Adds the specified handler \var{hdlr} to this logger.
512 \end{methoddesc}
514 \begin{methoddesc}{removeHandler}{hdlr}
515 Removes the specified handler \var{hdlr} from this logger.
516 \end{methoddesc}
518 \begin{methoddesc}{findCaller}{}
519 Finds the caller's source filename and line number. Returns the filename,
520 line number and function name as a 3-element tuple.
521 \versionchanged[The function name was added. In earlier versions, the
522 filename and line number were returned as a 2-element tuple.]{2.5}
523 \end{methoddesc}
525 \begin{methoddesc}{handle}{record}
526 Handles a record by passing it to all handlers associated with this logger
527 and its ancestors (until a false value of \var{propagate} is found).
528 This method is used for unpickled records received from a socket, as well
529 as those created locally. Logger-level filtering is applied using
530 \method{filter()}.
531 \end{methoddesc}
533 \begin{methoddesc}{makeRecord}{name, lvl, fn, lno, msg, args, exc_info
534 \optional{, func, extra}}
535 This is a factory method which can be overridden in subclasses to create
536 specialized \class{LogRecord} instances.
537 \versionchanged[\var{func} and \var{extra} were added]{2.5}
538 \end{methoddesc}
540 \subsection{Basic example \label{minimal-example}}
542 \versionchanged[formerly \function{basicConfig} did not take any keyword
543 arguments]{2.4}
545 The \module{logging} package provides a lot of flexibility, and its
546 configuration can appear daunting. This section demonstrates that simple
547 use of the logging package is possible.
549 The simplest example shows logging to the console:
551 \begin{verbatim}
552 import logging
554 logging.debug('A debug message')
555 logging.info('Some information')
556 logging.warning('A shot across the bows')
557 \end{verbatim}
559 If you run the above script, you'll see this:
560 \begin{verbatim}
561 WARNING:root:A shot across the bows
562 \end{verbatim}
564 Because no particular logger was specified, the system used the root logger.
565 The debug and info messages didn't appear because by default, the root
566 logger is configured to only handle messages with a severity of WARNING
567 or above. The message format is also a configuration default, as is the output
568 destination of the messages - \code{sys.stderr}. The severity level,
569 the message format and destination can be easily changed, as shown in
570 the example below:
572 \begin{verbatim}
573 import logging
575 logging.basicConfig(level=logging.DEBUG,
576 format='%(asctime)s %(levelname)s %(message)s',
577 filename='/tmp/myapp.log',
578 filemode='w')
579 logging.debug('A debug message')
580 logging.info('Some information')
581 logging.warning('A shot across the bows')
582 \end{verbatim}
584 The \method{basicConfig()} method is used to change the configuration
585 defaults, which results in output (written to \code{/tmp/myapp.log})
586 which should look something like the following:
588 \begin{verbatim}
589 2004-07-02 13:00:08,743 DEBUG A debug message
590 2004-07-02 13:00:08,743 INFO Some information
591 2004-07-02 13:00:08,743 WARNING A shot across the bows
592 \end{verbatim}
594 This time, all messages with a severity of DEBUG or above were handled,
595 and the format of the messages was also changed, and output went to the
596 specified file rather than the console.
598 Formatting uses standard Python string formatting - see section
599 \ref{typesseq-strings}. The format string takes the following
600 common specifiers. For a complete list of specifiers, consult the
601 \class{Formatter} documentation.
603 \begin{tableii}{l|l}{code}{Format}{Description}
604 \lineii{\%(name)s} {Name of the logger (logging channel).}
605 \lineii{\%(levelname)s}{Text logging level for the message
606 (\code{'DEBUG'}, \code{'INFO'},
607 \code{'WARNING'}, \code{'ERROR'},
608 \code{'CRITICAL'}).}
609 \lineii{\%(asctime)s} {Human-readable time when the \class{LogRecord}
610 was created. By default this is of the form
611 ``2003-07-08 16:49:45,896'' (the numbers after the
612 comma are millisecond portion of the time).}
613 \lineii{\%(message)s} {The logged message.}
614 \end{tableii}
616 To change the date/time format, you can pass an additional keyword parameter,
617 \var{datefmt}, as in the following:
619 \begin{verbatim}
620 import logging
622 logging.basicConfig(level=logging.DEBUG,
623 format='%(asctime)s %(levelname)-8s %(message)s',
624 datefmt='%a, %d %b %Y %H:%M:%S',
625 filename='/temp/myapp.log',
626 filemode='w')
627 logging.debug('A debug message')
628 logging.info('Some information')
629 logging.warning('A shot across the bows')
630 \end{verbatim}
632 which would result in output like
634 \begin{verbatim}
635 Fri, 02 Jul 2004 13:06:18 DEBUG A debug message
636 Fri, 02 Jul 2004 13:06:18 INFO Some information
637 Fri, 02 Jul 2004 13:06:18 WARNING A shot across the bows
638 \end{verbatim}
640 The date format string follows the requirements of \function{strftime()} -
641 see the documentation for the \refmodule{time} module.
643 If, instead of sending logging output to the console or a file, you'd rather
644 use a file-like object which you have created separately, you can pass it
645 to \function{basicConfig()} using the \var{stream} keyword argument. Note
646 that if both \var{stream} and \var{filename} keyword arguments are passed,
647 the \var{stream} argument is ignored.
649 Of course, you can put variable information in your output. To do this,
650 simply have the message be a format string and pass in additional arguments
651 containing the variable information, as in the following example:
653 \begin{verbatim}
654 import logging
656 logging.basicConfig(level=logging.DEBUG,
657 format='%(asctime)s %(levelname)-8s %(message)s',
658 datefmt='%a, %d %b %Y %H:%M:%S',
659 filename='/temp/myapp.log',
660 filemode='w')
661 logging.error('Pack my box with %d dozen %s', 5, 'liquor jugs')
662 \end{verbatim}
664 which would result in
666 \begin{verbatim}
667 Wed, 21 Jul 2004 15:35:16 ERROR Pack my box with 5 dozen liquor jugs
668 \end{verbatim}
670 \subsection{Logging to multiple destinations \label{multiple-destinations}}
672 Let's say you want to log to console and file with different message formats
673 and in differing circumstances. Say you want to log messages with levels
674 of DEBUG and higher to file, and those messages at level INFO and higher to
675 the console. Let's also assume that the file should contain timestamps, but
676 the console messages should not. Here's how you can achieve this:
678 \begin{verbatim}
679 import logging
681 # set up logging to file - see previous section for more details
682 logging.basicConfig(level=logging.DEBUG,
683 format='%(asctime)s %(name)-12s %(levelname)-8s %(message)s',
684 datefmt='%m-%d %H:%M',
685 filename='/temp/myapp.log',
686 filemode='w')
687 # define a Handler which writes INFO messages or higher to the sys.stderr
688 console = logging.StreamHandler()
689 console.setLevel(logging.INFO)
690 # set a format which is simpler for console use
691 formatter = logging.Formatter('%(name)-12s: %(levelname)-8s %(message)s')
692 # tell the handler to use this format
693 console.setFormatter(formatter)
694 # add the handler to the root logger
695 logging.getLogger('').addHandler(console)
697 # Now, we can log to the root logger, or any other logger. First the root...
698 logging.info('Jackdaws love my big sphinx of quartz.')
700 # Now, define a couple of other loggers which might represent areas in your
701 # application:
703 logger1 = logging.getLogger('myapp.area1')
704 logger2 = logging.getLogger('myapp.area2')
706 logger1.debug('Quick zephyrs blow, vexing daft Jim.')
707 logger1.info('How quickly daft jumping zebras vex.')
708 logger2.warning('Jail zesty vixen who grabbed pay from quack.')
709 logger2.error('The five boxing wizards jump quickly.')
710 \end{verbatim}
712 When you run this, on the console you will see
714 \begin{verbatim}
715 root : INFO Jackdaws love my big sphinx of quartz.
716 myapp.area1 : INFO How quickly daft jumping zebras vex.
717 myapp.area2 : WARNING Jail zesty vixen who grabbed pay from quack.
718 myapp.area2 : ERROR The five boxing wizards jump quickly.
719 \end{verbatim}
721 and in the file you will see something like
723 \begin{verbatim}
724 10-22 22:19 root INFO Jackdaws love my big sphinx of quartz.
725 10-22 22:19 myapp.area1 DEBUG Quick zephyrs blow, vexing daft Jim.
726 10-22 22:19 myapp.area1 INFO How quickly daft jumping zebras vex.
727 10-22 22:19 myapp.area2 WARNING Jail zesty vixen who grabbed pay from quack.
728 10-22 22:19 myapp.area2 ERROR The five boxing wizards jump quickly.
729 \end{verbatim}
731 As you can see, the DEBUG message only shows up in the file. The other
732 messages are sent to both destinations.
734 This example uses console and file handlers, but you can use any number and
735 combination of handlers you choose.
737 \subsection{Sending and receiving logging events across a network
738 \label{network-logging}}
740 Let's say you want to send logging events across a network, and handle them
741 at the receiving end. A simple way of doing this is attaching a
742 \class{SocketHandler} instance to the root logger at the sending end:
744 \begin{verbatim}
745 import logging, logging.handlers
747 rootLogger = logging.getLogger('')
748 rootLogger.setLevel(logging.DEBUG)
749 socketHandler = logging.handlers.SocketHandler('localhost',
750 logging.handlers.DEFAULT_TCP_LOGGING_PORT)
751 # don't bother with a formatter, since a socket handler sends the event as
752 # an unformatted pickle
753 rootLogger.addHandler(socketHandler)
755 # Now, we can log to the root logger, or any other logger. First the root...
756 logging.info('Jackdaws love my big sphinx of quartz.')
758 # Now, define a couple of other loggers which might represent areas in your
759 # application:
761 logger1 = logging.getLogger('myapp.area1')
762 logger2 = logging.getLogger('myapp.area2')
764 logger1.debug('Quick zephyrs blow, vexing daft Jim.')
765 logger1.info('How quickly daft jumping zebras vex.')
766 logger2.warning('Jail zesty vixen who grabbed pay from quack.')
767 logger2.error('The five boxing wizards jump quickly.')
768 \end{verbatim}
770 At the receiving end, you can set up a receiver using the
771 \module{SocketServer} module. Here is a basic working example:
773 \begin{verbatim}
774 import cPickle
775 import logging
776 import logging.handlers
777 import SocketServer
778 import struct
781 class LogRecordStreamHandler(SocketServer.StreamRequestHandler):
782 """Handler for a streaming logging request.
784 This basically logs the record using whatever logging policy is
785 configured locally.
788 def handle(self):
790 Handle multiple requests - each expected to be a 4-byte length,
791 followed by the LogRecord in pickle format. Logs the record
792 according to whatever policy is configured locally.
794 while 1:
795 chunk = self.connection.recv(4)
796 if len(chunk) < 4:
797 break
798 slen = struct.unpack(">L", chunk)[0]
799 chunk = self.connection.recv(slen)
800 while len(chunk) < slen:
801 chunk = chunk + self.connection.recv(slen - len(chunk))
802 obj = self.unPickle(chunk)
803 record = logging.makeLogRecord(obj)
804 self.handleLogRecord(record)
806 def unPickle(self, data):
807 return cPickle.loads(data)
809 def handleLogRecord(self, record):
810 # if a name is specified, we use the named logger rather than the one
811 # implied by the record.
812 if self.server.logname is not None:
813 name = self.server.logname
814 else:
815 name = record.name
816 logger = logging.getLogger(name)
817 # N.B. EVERY record gets logged. This is because Logger.handle
818 # is normally called AFTER logger-level filtering. If you want
819 # to do filtering, do it at the client end to save wasting
820 # cycles and network bandwidth!
821 logger.handle(record)
823 class LogRecordSocketReceiver(SocketServer.ThreadingTCPServer):
824 """simple TCP socket-based logging receiver suitable for testing.
827 allow_reuse_address = 1
829 def __init__(self, host='localhost',
830 port=logging.handlers.DEFAULT_TCP_LOGGING_PORT,
831 handler=LogRecordStreamHandler):
832 SocketServer.ThreadingTCPServer.__init__(self, (host, port), handler)
833 self.abort = 0
834 self.timeout = 1
835 self.logname = None
837 def serve_until_stopped(self):
838 import select
839 abort = 0
840 while not abort:
841 rd, wr, ex = select.select([self.socket.fileno()],
842 [], [],
843 self.timeout)
844 if rd:
845 self.handle_request()
846 abort = self.abort
848 def main():
849 logging.basicConfig(
850 format="%(relativeCreated)5d %(name)-15s %(levelname)-8s %(message)s")
851 tcpserver = LogRecordSocketReceiver()
852 print "About to start TCP server..."
853 tcpserver.serve_until_stopped()
855 if __name__ == "__main__":
856 main()
857 \end{verbatim}
859 First run the server, and then the client. On the client side, nothing is
860 printed on the console; on the server side, you should see something like:
862 \begin{verbatim}
863 About to start TCP server...
864 59 root INFO Jackdaws love my big sphinx of quartz.
865 59 myapp.area1 DEBUG Quick zephyrs blow, vexing daft Jim.
866 69 myapp.area1 INFO How quickly daft jumping zebras vex.
867 69 myapp.area2 WARNING Jail zesty vixen who grabbed pay from quack.
868 69 myapp.area2 ERROR The five boxing wizards jump quickly.
869 \end{verbatim}
871 \subsection{Handler Objects}
873 Handlers have the following attributes and methods. Note that
874 \class{Handler} is never instantiated directly; this class acts as a
875 base for more useful subclasses. However, the \method{__init__()}
876 method in subclasses needs to call \method{Handler.__init__()}.
878 \begin{methoddesc}{__init__}{level=\constant{NOTSET}}
879 Initializes the \class{Handler} instance by setting its level, setting
880 the list of filters to the empty list and creating a lock (using
881 \method{createLock()}) for serializing access to an I/O mechanism.
882 \end{methoddesc}
884 \begin{methoddesc}{createLock}{}
885 Initializes a thread lock which can be used to serialize access to
886 underlying I/O functionality which may not be threadsafe.
887 \end{methoddesc}
889 \begin{methoddesc}{acquire}{}
890 Acquires the thread lock created with \method{createLock()}.
891 \end{methoddesc}
893 \begin{methoddesc}{release}{}
894 Releases the thread lock acquired with \method{acquire()}.
895 \end{methoddesc}
897 \begin{methoddesc}{setLevel}{lvl}
898 Sets the threshold for this handler to \var{lvl}. Logging messages which are
899 less severe than \var{lvl} will be ignored. When a handler is created, the
900 level is set to \constant{NOTSET} (which causes all messages to be processed).
901 \end{methoddesc}
903 \begin{methoddesc}{setFormatter}{form}
904 Sets the \class{Formatter} for this handler to \var{form}.
905 \end{methoddesc}
907 \begin{methoddesc}{addFilter}{filt}
908 Adds the specified filter \var{filt} to this handler.
909 \end{methoddesc}
911 \begin{methoddesc}{removeFilter}{filt}
912 Removes the specified filter \var{filt} from this handler.
913 \end{methoddesc}
915 \begin{methoddesc}{filter}{record}
916 Applies this handler's filters to the record and returns a true value if
917 the record is to be processed.
918 \end{methoddesc}
920 \begin{methoddesc}{flush}{}
921 Ensure all logging output has been flushed. This version does
922 nothing and is intended to be implemented by subclasses.
923 \end{methoddesc}
925 \begin{methoddesc}{close}{}
926 Tidy up any resources used by the handler. This version does
927 nothing and is intended to be implemented by subclasses.
928 \end{methoddesc}
930 \begin{methoddesc}{handle}{record}
931 Conditionally emits the specified logging record, depending on
932 filters which may have been added to the handler. Wraps the actual
933 emission of the record with acquisition/release of the I/O thread
934 lock.
935 \end{methoddesc}
937 \begin{methoddesc}{handleError}{record}
938 This method should be called from handlers when an exception is
939 encountered during an \method{emit()} call. By default it does nothing,
940 which means that exceptions get silently ignored. This is what is
941 mostly wanted for a logging system - most users will not care
942 about errors in the logging system, they are more interested in
943 application errors. You could, however, replace this with a custom
944 handler if you wish. The specified record is the one which was being
945 processed when the exception occurred.
946 \end{methoddesc}
948 \begin{methoddesc}{format}{record}
949 Do formatting for a record - if a formatter is set, use it.
950 Otherwise, use the default formatter for the module.
951 \end{methoddesc}
953 \begin{methoddesc}{emit}{record}
954 Do whatever it takes to actually log the specified logging record.
955 This version is intended to be implemented by subclasses and so
956 raises a \exception{NotImplementedError}.
957 \end{methoddesc}
959 \subsubsection{StreamHandler}
961 The \class{StreamHandler} class, located in the core \module{logging}
962 package, sends logging output to streams such as \var{sys.stdout},
963 \var{sys.stderr} or any file-like object (or, more precisely, any
964 object which supports \method{write()} and \method{flush()} methods).
966 \begin{classdesc}{StreamHandler}{\optional{strm}}
967 Returns a new instance of the \class{StreamHandler} class. If \var{strm} is
968 specified, the instance will use it for logging output; otherwise,
969 \var{sys.stderr} will be used.
970 \end{classdesc}
972 \begin{methoddesc}{emit}{record}
973 If a formatter is specified, it is used to format the record.
974 The record is then written to the stream with a trailing newline.
975 If exception information is present, it is formatted using
976 \function{traceback.print_exception()} and appended to the stream.
977 \end{methoddesc}
979 \begin{methoddesc}{flush}{}
980 Flushes the stream by calling its \method{flush()} method. Note that
981 the \method{close()} method is inherited from \class{Handler} and
982 so does nothing, so an explicit \method{flush()} call may be needed
983 at times.
984 \end{methoddesc}
986 \subsubsection{FileHandler}
988 The \class{FileHandler} class, located in the core \module{logging}
989 package, sends logging output to a disk file. It inherits the output
990 functionality from \class{StreamHandler}.
992 \begin{classdesc}{FileHandler}{filename\optional{, mode}}
993 Returns a new instance of the \class{FileHandler} class. The specified
994 file is opened and used as the stream for logging. If \var{mode} is
995 not specified, \constant{'a'} is used. By default, the file grows
996 indefinitely.
997 \end{classdesc}
999 \begin{methoddesc}{close}{}
1000 Closes the file.
1001 \end{methoddesc}
1003 \begin{methoddesc}{emit}{record}
1004 Outputs the record to the file.
1005 \end{methoddesc}
1007 \subsubsection{RotatingFileHandler}
1009 The \class{RotatingFileHandler} class, located in the \module{logging.handlers}
1010 module, supports rotation of disk log files.
1012 \begin{classdesc}{RotatingFileHandler}{filename\optional{, mode\optional{,
1013 maxBytes\optional{, backupCount}}}}
1014 Returns a new instance of the \class{RotatingFileHandler} class. The
1015 specified file is opened and used as the stream for logging. If
1016 \var{mode} is not specified, \code{'a'} is used. By default, the
1017 file grows indefinitely.
1019 You can use the \var{maxBytes} and
1020 \var{backupCount} values to allow the file to \dfn{rollover} at a
1021 predetermined size. When the size is about to be exceeded, the file is
1022 closed and a new file is silently opened for output. Rollover occurs
1023 whenever the current log file is nearly \var{maxBytes} in length; if
1024 \var{maxBytes} is zero, rollover never occurs. If \var{backupCount}
1025 is non-zero, the system will save old log files by appending the
1026 extensions ".1", ".2" etc., to the filename. For example, with
1027 a \var{backupCount} of 5 and a base file name of
1028 \file{app.log}, you would get \file{app.log},
1029 \file{app.log.1}, \file{app.log.2}, up to \file{app.log.5}. The file being
1030 written to is always \file{app.log}. When this file is filled, it is
1031 closed and renamed to \file{app.log.1}, and if files \file{app.log.1},
1032 \file{app.log.2}, etc. exist, then they are renamed to \file{app.log.2},
1033 \file{app.log.3} etc. respectively.
1034 \end{classdesc}
1036 \begin{methoddesc}{doRollover}{}
1037 Does a rollover, as described above.
1038 \end{methoddesc}
1040 \begin{methoddesc}{emit}{record}
1041 Outputs the record to the file, catering for rollover as described previously.
1042 \end{methoddesc}
1044 \subsubsection{TimedRotatingFileHandler}
1046 The \class{TimedRotatingFileHandler} class, located in the
1047 \module{logging.handlers} module, supports rotation of disk log files
1048 at certain timed intervals.
1050 \begin{classdesc}{TimedRotatingFileHandler}{filename
1051 \optional{,when
1052 \optional{,interval
1053 \optional{,backupCount}}}}
1055 Returns a new instance of the \class{TimedRotatingFileHandler} class. The
1056 specified file is opened and used as the stream for logging. On rotating
1057 it also sets the filename suffix. Rotating happens based on the product
1058 of \var{when} and \var{interval}.
1060 You can use the \var{when} to specify the type of \var{interval}. The
1061 list of possible values is, note that they are not case sensitive:
1063 \begin{tableii}{l|l}{}{Value}{Type of interval}
1064 \lineii{S}{Seconds}
1065 \lineii{M}{Minutes}
1066 \lineii{H}{Hours}
1067 \lineii{D}{Days}
1068 \lineii{W}{Week day (0=Monday)}
1069 \lineii{midnight}{Roll over at midnight}
1070 \end{tableii}
1072 If \var{backupCount} is non-zero, the system will save old log files by
1073 appending extensions to the filename. The extensions are date-and-time
1074 based, using the strftime format \code{\%Y-\%m-\%d_\%H-\%M-\%S} or a leading
1075 portion thereof, depending on the rollover interval. At most \var{backupCount}
1076 files will be kept, and if more would be created when rollover occurs, the
1077 oldest one is deleted.
1078 \end{classdesc}
1080 \begin{methoddesc}{doRollover}{}
1081 Does a rollover, as described above.
1082 \end{methoddesc}
1084 \begin{methoddesc}{emit}{record}
1085 Outputs the record to the file, catering for rollover as described
1086 above.
1087 \end{methoddesc}
1089 \subsubsection{SocketHandler}
1091 The \class{SocketHandler} class, located in the
1092 \module{logging.handlers} module, sends logging output to a network
1093 socket. The base class uses a TCP socket.
1095 \begin{classdesc}{SocketHandler}{host, port}
1096 Returns a new instance of the \class{SocketHandler} class intended to
1097 communicate with a remote machine whose address is given by \var{host}
1098 and \var{port}.
1099 \end{classdesc}
1101 \begin{methoddesc}{close}{}
1102 Closes the socket.
1103 \end{methoddesc}
1105 \begin{methoddesc}{handleError}{}
1106 \end{methoddesc}
1108 \begin{methoddesc}{emit}{}
1109 Pickles the record's attribute dictionary and writes it to the socket in
1110 binary format. If there is an error with the socket, silently drops the
1111 packet. If the connection was previously lost, re-establishes the connection.
1112 To unpickle the record at the receiving end into a \class{LogRecord}, use the
1113 \function{makeLogRecord()} function.
1114 \end{methoddesc}
1116 \begin{methoddesc}{handleError}{}
1117 Handles an error which has occurred during \method{emit()}. The
1118 most likely cause is a lost connection. Closes the socket so that
1119 we can retry on the next event.
1120 \end{methoddesc}
1122 \begin{methoddesc}{makeSocket}{}
1123 This is a factory method which allows subclasses to define the precise
1124 type of socket they want. The default implementation creates a TCP
1125 socket (\constant{socket.SOCK_STREAM}).
1126 \end{methoddesc}
1128 \begin{methoddesc}{makePickle}{record}
1129 Pickles the record's attribute dictionary in binary format with a length
1130 prefix, and returns it ready for transmission across the socket.
1131 \end{methoddesc}
1133 \begin{methoddesc}{send}{packet}
1134 Send a pickled string \var{packet} to the socket. This function allows
1135 for partial sends which can happen when the network is busy.
1136 \end{methoddesc}
1138 \subsubsection{DatagramHandler}
1140 The \class{DatagramHandler} class, located in the
1141 \module{logging.handlers} module, inherits from \class{SocketHandler}
1142 to support sending logging messages over UDP sockets.
1144 \begin{classdesc}{DatagramHandler}{host, port}
1145 Returns a new instance of the \class{DatagramHandler} class intended to
1146 communicate with a remote machine whose address is given by \var{host}
1147 and \var{port}.
1148 \end{classdesc}
1150 \begin{methoddesc}{emit}{}
1151 Pickles the record's attribute dictionary and writes it to the socket in
1152 binary format. If there is an error with the socket, silently drops the
1153 packet.
1154 To unpickle the record at the receiving end into a \class{LogRecord}, use the
1155 \function{makeLogRecord()} function.
1156 \end{methoddesc}
1158 \begin{methoddesc}{makeSocket}{}
1159 The factory method of \class{SocketHandler} is here overridden to create
1160 a UDP socket (\constant{socket.SOCK_DGRAM}).
1161 \end{methoddesc}
1163 \begin{methoddesc}{send}{s}
1164 Send a pickled string to a socket.
1165 \end{methoddesc}
1167 \subsubsection{SysLogHandler}
1169 The \class{SysLogHandler} class, located in the
1170 \module{logging.handlers} module, supports sending logging messages to
1171 a remote or local \UNIX{} syslog.
1173 \begin{classdesc}{SysLogHandler}{\optional{address\optional{, facility}}}
1174 Returns a new instance of the \class{SysLogHandler} class intended to
1175 communicate with a remote \UNIX{} machine whose address is given by
1176 \var{address} in the form of a \code{(\var{host}, \var{port})}
1177 tuple. If \var{address} is not specified, \code{('localhost', 514)} is
1178 used. The address is used to open a UDP socket. If \var{facility} is
1179 not specified, \constant{LOG_USER} is used.
1180 \end{classdesc}
1182 \begin{methoddesc}{close}{}
1183 Closes the socket to the remote host.
1184 \end{methoddesc}
1186 \begin{methoddesc}{emit}{record}
1187 The record is formatted, and then sent to the syslog server. If
1188 exception information is present, it is \emph{not} sent to the server.
1189 \end{methoddesc}
1191 \begin{methoddesc}{encodePriority}{facility, priority}
1192 Encodes the facility and priority into an integer. You can pass in strings
1193 or integers - if strings are passed, internal mapping dictionaries are used
1194 to convert them to integers.
1195 \end{methoddesc}
1197 \subsubsection{NTEventLogHandler}
1199 The \class{NTEventLogHandler} class, located in the
1200 \module{logging.handlers} module, supports sending logging messages to
1201 a local Windows NT, Windows 2000 or Windows XP event log. Before you
1202 can use it, you need Mark Hammond's Win32 extensions for Python
1203 installed.
1205 \begin{classdesc}{NTEventLogHandler}{appname\optional{,
1206 dllname\optional{, logtype}}}
1207 Returns a new instance of the \class{NTEventLogHandler} class. The
1208 \var{appname} is used to define the application name as it appears in the
1209 event log. An appropriate registry entry is created using this name.
1210 The \var{dllname} should give the fully qualified pathname of a .dll or .exe
1211 which contains message definitions to hold in the log (if not specified,
1212 \code{'win32service.pyd'} is used - this is installed with the Win32
1213 extensions and contains some basic placeholder message definitions.
1214 Note that use of these placeholders will make your event logs big, as the
1215 entire message source is held in the log. If you want slimmer logs, you have
1216 to pass in the name of your own .dll or .exe which contains the message
1217 definitions you want to use in the event log). The \var{logtype} is one of
1218 \code{'Application'}, \code{'System'} or \code{'Security'}, and
1219 defaults to \code{'Application'}.
1220 \end{classdesc}
1222 \begin{methoddesc}{close}{}
1223 At this point, you can remove the application name from the registry as a
1224 source of event log entries. However, if you do this, you will not be able
1225 to see the events as you intended in the Event Log Viewer - it needs to be
1226 able to access the registry to get the .dll name. The current version does
1227 not do this (in fact it doesn't do anything).
1228 \end{methoddesc}
1230 \begin{methoddesc}{emit}{record}
1231 Determines the message ID, event category and event type, and then logs the
1232 message in the NT event log.
1233 \end{methoddesc}
1235 \begin{methoddesc}{getEventCategory}{record}
1236 Returns the event category for the record. Override this if you
1237 want to specify your own categories. This version returns 0.
1238 \end{methoddesc}
1240 \begin{methoddesc}{getEventType}{record}
1241 Returns the event type for the record. Override this if you want
1242 to specify your own types. This version does a mapping using the
1243 handler's typemap attribute, which is set up in \method{__init__()}
1244 to a dictionary which contains mappings for \constant{DEBUG},
1245 \constant{INFO}, \constant{WARNING}, \constant{ERROR} and
1246 \constant{CRITICAL}. If you are using your own levels, you will either need
1247 to override this method or place a suitable dictionary in the
1248 handler's \var{typemap} attribute.
1249 \end{methoddesc}
1251 \begin{methoddesc}{getMessageID}{record}
1252 Returns the message ID for the record. If you are using your
1253 own messages, you could do this by having the \var{msg} passed to the
1254 logger being an ID rather than a format string. Then, in here,
1255 you could use a dictionary lookup to get the message ID. This
1256 version returns 1, which is the base message ID in
1257 \file{win32service.pyd}.
1258 \end{methoddesc}
1260 \subsubsection{SMTPHandler}
1262 The \class{SMTPHandler} class, located in the
1263 \module{logging.handlers} module, supports sending logging messages to
1264 an email address via SMTP.
1266 \begin{classdesc}{SMTPHandler}{mailhost, fromaddr, toaddrs, subject}
1267 Returns a new instance of the \class{SMTPHandler} class. The
1268 instance is initialized with the from and to addresses and subject
1269 line of the email. The \var{toaddrs} should be a list of strings. To specify a
1270 non-standard SMTP port, use the (host, port) tuple format for the
1271 \var{mailhost} argument. If you use a string, the standard SMTP port
1272 is used.
1273 \end{classdesc}
1275 \begin{methoddesc}{emit}{record}
1276 Formats the record and sends it to the specified addressees.
1277 \end{methoddesc}
1279 \begin{methoddesc}{getSubject}{record}
1280 If you want to specify a subject line which is record-dependent,
1281 override this method.
1282 \end{methoddesc}
1284 \subsubsection{MemoryHandler}
1286 The \class{MemoryHandler} class, located in the
1287 \module{logging.handlers} module, supports buffering of logging
1288 records in memory, periodically flushing them to a \dfn{target}
1289 handler. Flushing occurs whenever the buffer is full, or when an event
1290 of a certain severity or greater is seen.
1292 \class{MemoryHandler} is a subclass of the more general
1293 \class{BufferingHandler}, which is an abstract class. This buffers logging
1294 records in memory. Whenever each record is added to the buffer, a
1295 check is made by calling \method{shouldFlush()} to see if the buffer
1296 should be flushed. If it should, then \method{flush()} is expected to
1297 do the needful.
1299 \begin{classdesc}{BufferingHandler}{capacity}
1300 Initializes the handler with a buffer of the specified capacity.
1301 \end{classdesc}
1303 \begin{methoddesc}{emit}{record}
1304 Appends the record to the buffer. If \method{shouldFlush()} returns true,
1305 calls \method{flush()} to process the buffer.
1306 \end{methoddesc}
1308 \begin{methoddesc}{flush}{}
1309 You can override this to implement custom flushing behavior. This version
1310 just zaps the buffer to empty.
1311 \end{methoddesc}
1313 \begin{methoddesc}{shouldFlush}{record}
1314 Returns true if the buffer is up to capacity. This method can be
1315 overridden to implement custom flushing strategies.
1316 \end{methoddesc}
1318 \begin{classdesc}{MemoryHandler}{capacity\optional{, flushLevel
1319 \optional{, target}}}
1320 Returns a new instance of the \class{MemoryHandler} class. The
1321 instance is initialized with a buffer size of \var{capacity}. If
1322 \var{flushLevel} is not specified, \constant{ERROR} is used. If no
1323 \var{target} is specified, the target will need to be set using
1324 \method{setTarget()} before this handler does anything useful.
1325 \end{classdesc}
1327 \begin{methoddesc}{close}{}
1328 Calls \method{flush()}, sets the target to \constant{None} and
1329 clears the buffer.
1330 \end{methoddesc}
1332 \begin{methoddesc}{flush}{}
1333 For a \class{MemoryHandler}, flushing means just sending the buffered
1334 records to the target, if there is one. Override if you want
1335 different behavior.
1336 \end{methoddesc}
1338 \begin{methoddesc}{setTarget}{target}
1339 Sets the target handler for this handler.
1340 \end{methoddesc}
1342 \begin{methoddesc}{shouldFlush}{record}
1343 Checks for buffer full or a record at the \var{flushLevel} or higher.
1344 \end{methoddesc}
1346 \subsubsection{HTTPHandler}
1348 The \class{HTTPHandler} class, located in the
1349 \module{logging.handlers} module, supports sending logging messages to
1350 a Web server, using either \samp{GET} or \samp{POST} semantics.
1352 \begin{classdesc}{HTTPHandler}{host, url\optional{, method}}
1353 Returns a new instance of the \class{HTTPHandler} class. The
1354 instance is initialized with a host address, url and HTTP method.
1355 The \var{host} can be of the form \code{host:port}, should you need to
1356 use a specific port number. If no \var{method} is specified, \samp{GET}
1357 is used.
1358 \end{classdesc}
1360 \begin{methoddesc}{emit}{record}
1361 Sends the record to the Web server as an URL-encoded dictionary.
1362 \end{methoddesc}
1364 \subsection{Formatter Objects}
1366 \class{Formatter}s have the following attributes and methods. They are
1367 responsible for converting a \class{LogRecord} to (usually) a string
1368 which can be interpreted by either a human or an external system. The
1369 base
1370 \class{Formatter} allows a formatting string to be specified. If none is
1371 supplied, the default value of \code{'\%(message)s'} is used.
1373 A Formatter can be initialized with a format string which makes use of
1374 knowledge of the \class{LogRecord} attributes - such as the default value
1375 mentioned above making use of the fact that the user's message and
1376 arguments are pre-formatted into a \class{LogRecord}'s \var{message}
1377 attribute. This format string contains standard python \%-style
1378 mapping keys. See section \ref{typesseq-strings}, ``String Formatting
1379 Operations,'' for more information on string formatting.
1381 Currently, the useful mapping keys in a \class{LogRecord} are:
1383 \begin{tableii}{l|l}{code}{Format}{Description}
1384 \lineii{\%(name)s} {Name of the logger (logging channel).}
1385 \lineii{\%(levelno)s} {Numeric logging level for the message
1386 (\constant{DEBUG}, \constant{INFO},
1387 \constant{WARNING}, \constant{ERROR},
1388 \constant{CRITICAL}).}
1389 \lineii{\%(levelname)s}{Text logging level for the message
1390 (\code{'DEBUG'}, \code{'INFO'},
1391 \code{'WARNING'}, \code{'ERROR'},
1392 \code{'CRITICAL'}).}
1393 \lineii{\%(pathname)s} {Full pathname of the source file where the logging
1394 call was issued (if available).}
1395 \lineii{\%(filename)s} {Filename portion of pathname.}
1396 \lineii{\%(module)s} {Module (name portion of filename).}
1397 \lineii{\%(funcName)s} {Name of function containing the logging call.}
1398 \lineii{\%(lineno)d} {Source line number where the logging call was issued
1399 (if available).}
1400 \lineii{\%(created)f} {Time when the \class{LogRecord} was created (as
1401 returned by \function{time.time()}).}
1402 \lineii{\%(relativeCreated)d} {Time in milliseconds when the LogRecord was
1403 created, relative to the time the logging module was
1404 loaded.}
1405 \lineii{\%(asctime)s} {Human-readable time when the \class{LogRecord}
1406 was created. By default this is of the form
1407 ``2003-07-08 16:49:45,896'' (the numbers after the
1408 comma are millisecond portion of the time).}
1409 \lineii{\%(msecs)d} {Millisecond portion of the time when the
1410 \class{LogRecord} was created.}
1411 \lineii{\%(thread)d} {Thread ID (if available).}
1412 \lineii{\%(threadName)s} {Thread name (if available).}
1413 \lineii{\%(process)d} {Process ID (if available).}
1414 \lineii{\%(message)s} {The logged message, computed as \code{msg \% args}.}
1415 \end{tableii}
1417 \versionchanged[\var{funcName} was added]{2.5}
1419 \begin{classdesc}{Formatter}{\optional{fmt\optional{, datefmt}}}
1420 Returns a new instance of the \class{Formatter} class. The
1421 instance is initialized with a format string for the message as a whole,
1422 as well as a format string for the date/time portion of a message. If
1423 no \var{fmt} is specified, \code{'\%(message)s'} is used. If no \var{datefmt}
1424 is specified, the ISO8601 date format is used.
1425 \end{classdesc}
1427 \begin{methoddesc}{format}{record}
1428 The record's attribute dictionary is used as the operand to a
1429 string formatting operation. Returns the resulting string.
1430 Before formatting the dictionary, a couple of preparatory steps
1431 are carried out. The \var{message} attribute of the record is computed
1432 using \var{msg} \% \var{args}. If the formatting string contains
1433 \code{'(asctime)'}, \method{formatTime()} is called to format the
1434 event time. If there is exception information, it is formatted using
1435 \method{formatException()} and appended to the message.
1436 \end{methoddesc}
1438 \begin{methoddesc}{formatTime}{record\optional{, datefmt}}
1439 This method should be called from \method{format()} by a formatter which
1440 wants to make use of a formatted time. This method can be overridden
1441 in formatters to provide for any specific requirement, but the
1442 basic behavior is as follows: if \var{datefmt} (a string) is specified,
1443 it is used with \function{time.strftime()} to format the creation time of the
1444 record. Otherwise, the ISO8601 format is used. The resulting
1445 string is returned.
1446 \end{methoddesc}
1448 \begin{methoddesc}{formatException}{exc_info}
1449 Formats the specified exception information (a standard exception tuple
1450 as returned by \function{sys.exc_info()}) as a string. This default
1451 implementation just uses \function{traceback.print_exception()}.
1452 The resulting string is returned.
1453 \end{methoddesc}
1455 \subsection{Filter Objects}
1457 \class{Filter}s can be used by \class{Handler}s and \class{Logger}s for
1458 more sophisticated filtering than is provided by levels. The base filter
1459 class only allows events which are below a certain point in the logger
1460 hierarchy. For example, a filter initialized with "A.B" will allow events
1461 logged by loggers "A.B", "A.B.C", "A.B.C.D", "A.B.D" etc. but not "A.BB",
1462 "B.A.B" etc. If initialized with the empty string, all events are passed.
1464 \begin{classdesc}{Filter}{\optional{name}}
1465 Returns an instance of the \class{Filter} class. If \var{name} is specified,
1466 it names a logger which, together with its children, will have its events
1467 allowed through the filter. If no name is specified, allows every event.
1468 \end{classdesc}
1470 \begin{methoddesc}{filter}{record}
1471 Is the specified record to be logged? Returns zero for no, nonzero for
1472 yes. If deemed appropriate, the record may be modified in-place by this
1473 method.
1474 \end{methoddesc}
1476 \subsection{LogRecord Objects}
1478 \class{LogRecord} instances are created every time something is logged. They
1479 contain all the information pertinent to the event being logged. The
1480 main information passed in is in msg and args, which are combined
1481 using msg \% args to create the message field of the record. The record
1482 also includes information such as when the record was created, the
1483 source line where the logging call was made, and any exception
1484 information to be logged.
1486 \begin{classdesc}{LogRecord}{name, lvl, pathname, lineno, msg, args,
1487 exc_info \optional{, func}}
1488 Returns an instance of \class{LogRecord} initialized with interesting
1489 information. The \var{name} is the logger name; \var{lvl} is the
1490 numeric level; \var{pathname} is the absolute pathname of the source
1491 file in which the logging call was made; \var{lineno} is the line
1492 number in that file where the logging call is found; \var{msg} is the
1493 user-supplied message (a format string); \var{args} is the tuple
1494 which, together with \var{msg}, makes up the user message; and
1495 \var{exc_info} is the exception tuple obtained by calling
1496 \function{sys.exc_info() }(or \constant{None}, if no exception information
1497 is available). The \var{func} is the name of the function from which the
1498 logging call was made. If not specified, it defaults to \var{None}.
1499 \versionchanged[\var{func} was added]{2.5}
1500 \end{classdesc}
1502 \begin{methoddesc}{getMessage}{}
1503 Returns the message for this \class{LogRecord} instance after merging any
1504 user-supplied arguments with the message.
1505 \end{methoddesc}
1507 \subsection{Thread Safety}
1509 The logging module is intended to be thread-safe without any special work
1510 needing to be done by its clients. It achieves this though using threading
1511 locks; there is one lock to serialize access to the module's shared data,
1512 and each handler also creates a lock to serialize access to its underlying
1513 I/O.
1515 \subsection{Configuration}
1518 \subsubsection{Configuration functions%
1519 \label{logging-config-api}}
1521 The following functions configure the logging module. They are located in the
1522 \module{logging.config} module. Their use is optional --- you can configure
1523 the logging module using these functions or by making calls to the
1524 main API (defined in \module{logging} itself) and defining handlers
1525 which are declared either in \module{logging} or
1526 \module{logging.handlers}.
1528 \begin{funcdesc}{fileConfig}{fname\optional{, defaults}}
1529 Reads the logging configuration from a ConfigParser-format file named
1530 \var{fname}. This function can be called several times from an application,
1531 allowing an end user the ability to select from various pre-canned
1532 configurations (if the developer provides a mechanism to present the
1533 choices and load the chosen configuration). Defaults to be passed to
1534 ConfigParser can be specified in the \var{defaults} argument.
1535 \end{funcdesc}
1537 \begin{funcdesc}{listen}{\optional{port}}
1538 Starts up a socket server on the specified port, and listens for new
1539 configurations. If no port is specified, the module's default
1540 \constant{DEFAULT_LOGGING_CONFIG_PORT} is used. Logging configurations
1541 will be sent as a file suitable for processing by \function{fileConfig()}.
1542 Returns a \class{Thread} instance on which you can call \method{start()}
1543 to start the server, and which you can \method{join()} when appropriate.
1544 To stop the server, call \function{stopListening()}. To send a configuration
1545 to the socket, read in the configuration file and send it to the socket
1546 as a string of bytes preceded by a four-byte length packed in binary using
1547 struct.\code{pack('>L', n)}.
1548 \end{funcdesc}
1550 \begin{funcdesc}{stopListening}{}
1551 Stops the listening server which was created with a call to
1552 \function{listen()}. This is typically called before calling \method{join()}
1553 on the return value from \function{listen()}.
1554 \end{funcdesc}
1556 \subsubsection{Configuration file format%
1557 \label{logging-config-fileformat}}
1559 The configuration file format understood by \function{fileConfig()} is
1560 based on ConfigParser functionality. The file must contain sections
1561 called \code{[loggers]}, \code{[handlers]} and \code{[formatters]}
1562 which identify by name the entities of each type which are defined in
1563 the file. For each such entity, there is a separate section which
1564 identified how that entity is configured. Thus, for a logger named
1565 \code{log01} in the \code{[loggers]} section, the relevant
1566 configuration details are held in a section
1567 \code{[logger_log01]}. Similarly, a handler called \code{hand01} in
1568 the \code{[handlers]} section will have its configuration held in a
1569 section called \code{[handler_hand01]}, while a formatter called
1570 \code{form01} in the \code{[formatters]} section will have its
1571 configuration specified in a section called
1572 \code{[formatter_form01]}. The root logger configuration must be
1573 specified in a section called \code{[logger_root]}.
1575 Examples of these sections in the file are given below.
1577 \begin{verbatim}
1578 [loggers]
1579 keys=root,log02,log03,log04,log05,log06,log07
1581 [handlers]
1582 keys=hand01,hand02,hand03,hand04,hand05,hand06,hand07,hand08,hand09
1584 [formatters]
1585 keys=form01,form02,form03,form04,form05,form06,form07,form08,form09
1586 \end{verbatim}
1588 The root logger must specify a level and a list of handlers. An
1589 example of a root logger section is given below.
1591 \begin{verbatim}
1592 [logger_root]
1593 level=NOTSET
1594 handlers=hand01
1595 \end{verbatim}
1597 The \code{level} entry can be one of \code{DEBUG, INFO, WARNING,
1598 ERROR, CRITICAL} or \code{NOTSET}. For the root logger only,
1599 \code{NOTSET} means that all messages will be logged. Level values are
1600 \function{eval()}uated in the context of the \code{logging} package's
1601 namespace.
1603 The \code{handlers} entry is a comma-separated list of handler names,
1604 which must appear in the \code{[handlers]} section. These names must
1605 appear in the \code{[handlers]} section and have corresponding
1606 sections in the configuration file.
1608 For loggers other than the root logger, some additional information is
1609 required. This is illustrated by the following example.
1611 \begin{verbatim}
1612 [logger_parser]
1613 level=DEBUG
1614 handlers=hand01
1615 propagate=1
1616 qualname=compiler.parser
1617 \end{verbatim}
1619 The \code{level} and \code{handlers} entries are interpreted as for
1620 the root logger, except that if a non-root logger's level is specified
1621 as \code{NOTSET}, the system consults loggers higher up the hierarchy
1622 to determine the effective level of the logger. The \code{propagate}
1623 entry is set to 1 to indicate that messages must propagate to handlers
1624 higher up the logger hierarchy from this logger, or 0 to indicate that
1625 messages are \strong{not} propagated to handlers up the hierarchy. The
1626 \code{qualname} entry is the hierarchical channel name of the logger,
1627 that is to say the name used by the application to get the logger.
1629 Sections which specify handler configuration are exemplified by the
1630 following.
1632 \begin{verbatim}
1633 [handler_hand01]
1634 class=StreamHandler
1635 level=NOTSET
1636 formatter=form01
1637 args=(sys.stdout,)
1638 \end{verbatim}
1640 The \code{class} entry indicates the handler's class (as determined by
1641 \function{eval()} in the \code{logging} package's namespace). The
1642 \code{level} is interpreted as for loggers, and \code{NOTSET} is taken
1643 to mean "log everything".
1645 The \code{formatter} entry indicates the key name of the formatter for
1646 this handler. If blank, a default formatter
1647 (\code{logging._defaultFormatter}) is used. If a name is specified, it
1648 must appear in the \code{[formatters]} section and have a
1649 corresponding section in the configuration file.
1651 The \code{args} entry, when \function{eval()}uated in the context of
1652 the \code{logging} package's namespace, is the list of arguments to
1653 the constructor for the handler class. Refer to the constructors for
1654 the relevant handlers, or to the examples below, to see how typical
1655 entries are constructed.
1657 \begin{verbatim}
1658 [handler_hand02]
1659 class=FileHandler
1660 level=DEBUG
1661 formatter=form02
1662 args=('python.log', 'w')
1664 [handler_hand03]
1665 class=handlers.SocketHandler
1666 level=INFO
1667 formatter=form03
1668 args=('localhost', handlers.DEFAULT_TCP_LOGGING_PORT)
1670 [handler_hand04]
1671 class=handlers.DatagramHandler
1672 level=WARN
1673 formatter=form04
1674 args=('localhost', handlers.DEFAULT_UDP_LOGGING_PORT)
1676 [handler_hand05]
1677 class=handlers.SysLogHandler
1678 level=ERROR
1679 formatter=form05
1680 args=(('localhost', handlers.SYSLOG_UDP_PORT), handlers.SysLogHandler.LOG_USER)
1682 [handler_hand06]
1683 class=handlers.NTEventLogHandler
1684 level=CRITICAL
1685 formatter=form06
1686 args=('Python Application', '', 'Application')
1688 [handler_hand07]
1689 class=handlers.SMTPHandler
1690 level=WARN
1691 formatter=form07
1692 args=('localhost', 'from@abc', ['user1@abc', 'user2@xyz'], 'Logger Subject')
1694 [handler_hand08]
1695 class=handlers.MemoryHandler
1696 level=NOTSET
1697 formatter=form08
1698 target=
1699 args=(10, ERROR)
1701 [handler_hand09]
1702 class=handlers.HTTPHandler
1703 level=NOTSET
1704 formatter=form09
1705 args=('localhost:9022', '/log', 'GET')
1706 \end{verbatim}
1708 Sections which specify formatter configuration are typified by the following.
1710 \begin{verbatim}
1711 [formatter_form01]
1712 format=F1 %(asctime)s %(levelname)s %(message)s
1713 datefmt=
1714 class=logging.Formatter
1715 \end{verbatim}
1717 The \code{format} entry is the overall format string, and the
1718 \code{datefmt} entry is the \function{strftime()}-compatible date/time format
1719 string. If empty, the package substitutes ISO8601 format date/times, which
1720 is almost equivalent to specifying the date format string "%Y-%m-%d %H:%M:%S".
1721 The ISO8601 format also specifies milliseconds, which are appended to the
1722 result of using the above format string, with a comma separator. An example
1723 time in ISO8601 format is \code{2003-01-23 00:29:50,411}.
1725 The \code{class} entry is optional. It indicates the name of the
1726 formatter's class (as a dotted module and class name.) This option is
1727 useful for instantiating a \class{Formatter} subclass. Subclasses of
1728 \class{Formatter} can present exception tracebacks in an expanded or
1729 condensed format.