blob: ed0b1e8e8c3dc381fd993d7cd2da398e42a6c99f [file] [log] [blame]
Vinay Sajipb3d8a062007-01-16 09:50:07 +00001# Copyright 2001-2007 by Vinay Sajip. All Rights Reserved.
Guido van Rossum57102f82002-11-13 16:15:58 +00002#
3# Permission to use, copy, modify, and distribute this software and its
4# documentation for any purpose and without fee is hereby granted,
5# provided that the above copyright notice appear in all copies and that
6# both that copyright notice and this permission notice appear in
7# supporting documentation, and that the name of Vinay Sajip
8# not be used in advertising or publicity pertaining to distribution
9# of the software without specific, written prior permission.
10# VINAY SAJIP DISCLAIMS ALL WARRANTIES WITH REGARD TO THIS SOFTWARE, INCLUDING
11# ALL IMPLIED WARRANTIES OF MERCHANTABILITY AND FITNESS. IN NO EVENT SHALL
12# VINAY SAJIP BE LIABLE FOR ANY SPECIAL, INDIRECT OR CONSEQUENTIAL DAMAGES OR
13# ANY DAMAGES WHATSOEVER RESULTING FROM LOSS OF USE, DATA OR PROFITS, WHETHER
14# IN AN ACTION OF CONTRACT, NEGLIGENCE OR OTHER TORTIOUS ACTION, ARISING OUT
15# OF OR IN CONNECTION WITH THE USE OR PERFORMANCE OF THIS SOFTWARE.
Guido van Rossum57102f82002-11-13 16:15:58 +000016
17"""
Vinay Sajip3f742842004-02-28 16:07:46 +000018Additional handlers for the logging package for Python. The core package is
19based on PEP 282 and comments thereto in comp.lang.python, and influenced by
20Apache's log4j system.
Guido van Rossum57102f82002-11-13 16:15:58 +000021
22Should work under Python versions >= 1.5.2, except that source line
Vinay Sajip48cfe382004-02-20 13:17:27 +000023information is not available unless 'sys._getframe()' is.
Guido van Rossum57102f82002-11-13 16:15:58 +000024
Vinay Sajipb3d8a062007-01-16 09:50:07 +000025Copyright (C) 2001-2007 Vinay Sajip. All Rights Reserved.
Guido van Rossum57102f82002-11-13 16:15:58 +000026
27To use, simply 'import logging' and log away!
28"""
29
Vinay Sajip17c52d82004-07-03 11:48:34 +000030import sys, logging, socket, types, os, string, cPickle, struct, time, glob
Vinay Sajip73306b02007-01-14 21:49:59 +000031from stat import ST_DEV, ST_INO
Guido van Rossum57102f82002-11-13 16:15:58 +000032
Vinay Sajip4600f112005-03-13 09:56:36 +000033try:
34 import codecs
35except ImportError:
36 codecs = None
37
Guido van Rossum57102f82002-11-13 16:15:58 +000038#
39# Some constants...
40#
41
42DEFAULT_TCP_LOGGING_PORT = 9020
43DEFAULT_UDP_LOGGING_PORT = 9021
44DEFAULT_HTTP_LOGGING_PORT = 9022
45DEFAULT_SOAP_LOGGING_PORT = 9023
46SYSLOG_UDP_PORT = 514
47
Vinay Sajip4b4a63e2006-05-02 08:35:36 +000048_MIDNIGHT = 24 * 60 * 60 # number of seconds in a day
49
Vinay Sajip17c52d82004-07-03 11:48:34 +000050class BaseRotatingHandler(logging.FileHandler):
51 """
52 Base class for handlers that rotate log files at a certain point.
53 Not meant to be instantiated directly. Instead, use RotatingFileHandler
54 or TimedRotatingFileHandler.
55 """
Vinay Sajip4600f112005-03-13 09:56:36 +000056 def __init__(self, filename, mode, encoding=None):
Vinay Sajip17c52d82004-07-03 11:48:34 +000057 """
58 Use the specified filename for streamed logging
59 """
Vinay Sajip4600f112005-03-13 09:56:36 +000060 if codecs is None:
61 encoding = None
62 logging.FileHandler.__init__(self, filename, mode, encoding)
63 self.mode = mode
64 self.encoding = encoding
Guido van Rossum57102f82002-11-13 16:15:58 +000065
Vinay Sajip17c52d82004-07-03 11:48:34 +000066 def emit(self, record):
67 """
68 Emit a record.
69
70 Output the record to the file, catering for rollover as described
71 in doRollover().
72 """
Vinay Sajip3970c112004-07-08 10:24:04 +000073 try:
74 if self.shouldRollover(record):
75 self.doRollover()
76 logging.FileHandler.emit(self, record)
Vinay Sajip85c19092005-10-31 13:14:19 +000077 except (KeyboardInterrupt, SystemExit):
78 raise
Vinay Sajip3970c112004-07-08 10:24:04 +000079 except:
80 self.handleError(record)
Vinay Sajip17c52d82004-07-03 11:48:34 +000081
82class RotatingFileHandler(BaseRotatingHandler):
83 """
84 Handler for logging to a set of files, which switches from one file
85 to the next when the current file reaches a certain size.
86 """
Vinay Sajip4600f112005-03-13 09:56:36 +000087 def __init__(self, filename, mode='a', maxBytes=0, backupCount=0, encoding=None):
Guido van Rossum57102f82002-11-13 16:15:58 +000088 """
89 Open the specified file and use it as the stream for logging.
90
91 By default, the file grows indefinitely. You can specify particular
92 values of maxBytes and backupCount to allow the file to rollover at
93 a predetermined size.
94
95 Rollover occurs whenever the current log file is nearly maxBytes in
96 length. If backupCount is >= 1, the system will successively create
97 new files with the same pathname as the base file, but with extensions
98 ".1", ".2" etc. appended to it. For example, with a backupCount of 5
99 and a base file name of "app.log", you would get "app.log",
100 "app.log.1", "app.log.2", ... through to "app.log.5". The file being
101 written to is always "app.log" - when it gets filled up, it is closed
102 and renamed to "app.log.1", and if files "app.log.1", "app.log.2" etc.
103 exist, then they are renamed to "app.log.2", "app.log.3" etc.
104 respectively.
105
106 If maxBytes is zero, rollover never occurs.
107 """
Vinay Sajip17c52d82004-07-03 11:48:34 +0000108 if maxBytes > 0:
Vinay Sajip4600f112005-03-13 09:56:36 +0000109 mode = 'a' # doesn't make sense otherwise!
110 BaseRotatingHandler.__init__(self, filename, mode, encoding)
Guido van Rossum57102f82002-11-13 16:15:58 +0000111 self.maxBytes = maxBytes
112 self.backupCount = backupCount
Guido van Rossum57102f82002-11-13 16:15:58 +0000113
114 def doRollover(self):
115 """
116 Do a rollover, as described in __init__().
117 """
118
119 self.stream.close()
120 if self.backupCount > 0:
121 for i in range(self.backupCount - 1, 0, -1):
122 sfn = "%s.%d" % (self.baseFilename, i)
123 dfn = "%s.%d" % (self.baseFilename, i + 1)
124 if os.path.exists(sfn):
125 #print "%s -> %s" % (sfn, dfn)
126 if os.path.exists(dfn):
127 os.remove(dfn)
128 os.rename(sfn, dfn)
129 dfn = self.baseFilename + ".1"
130 if os.path.exists(dfn):
131 os.remove(dfn)
Vinay Sajip6dd59f12006-06-27 07:34:37 +0000132 os.rename(self.baseFilename, dfn)
Guido van Rossum57102f82002-11-13 16:15:58 +0000133 #print "%s -> %s" % (self.baseFilename, dfn)
Vinay Sajipb3d8a062007-01-16 09:50:07 +0000134 self.mode = 'w'
135 self.stream = self._open()
Guido van Rossum57102f82002-11-13 16:15:58 +0000136
Vinay Sajip17c52d82004-07-03 11:48:34 +0000137 def shouldRollover(self, record):
Guido van Rossum57102f82002-11-13 16:15:58 +0000138 """
Vinay Sajip17c52d82004-07-03 11:48:34 +0000139 Determine if rollover should occur.
Guido van Rossum57102f82002-11-13 16:15:58 +0000140
Vinay Sajip17c52d82004-07-03 11:48:34 +0000141 Basically, see if the supplied record would cause the file to exceed
142 the size limit we have.
Guido van Rossum57102f82002-11-13 16:15:58 +0000143 """
144 if self.maxBytes > 0: # are we rolling over?
145 msg = "%s\n" % self.format(record)
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000146 self.stream.seek(0, 2) #due to non-posix-compliant Windows feature
Guido van Rossum57102f82002-11-13 16:15:58 +0000147 if self.stream.tell() + len(msg) >= self.maxBytes:
Vinay Sajip17c52d82004-07-03 11:48:34 +0000148 return 1
149 return 0
Guido van Rossum57102f82002-11-13 16:15:58 +0000150
Vinay Sajip17c52d82004-07-03 11:48:34 +0000151class TimedRotatingFileHandler(BaseRotatingHandler):
152 """
153 Handler for logging to a file, rotating the log file at certain timed
154 intervals.
155
156 If backupCount is > 0, when rollover is done, no more than backupCount
157 files are kept - the oldest ones are deleted.
158 """
Vinay Sajip4600f112005-03-13 09:56:36 +0000159 def __init__(self, filename, when='h', interval=1, backupCount=0, encoding=None):
160 BaseRotatingHandler.__init__(self, filename, 'a', encoding)
Vinay Sajip17c52d82004-07-03 11:48:34 +0000161 self.when = string.upper(when)
162 self.backupCount = backupCount
163 # Calculate the real rollover interval, which is just the number of
164 # seconds between rollovers. Also set the filename suffix used when
165 # a rollover occurs. Current 'when' events supported:
166 # S - Seconds
167 # M - Minutes
168 # H - Hours
169 # D - Days
170 # midnight - roll over at midnight
171 # W{0-6} - roll over on a certain day; 0 - Monday
172 #
173 # Case of the 'when' specifier is not important; lower or upper case
174 # will work.
175 currentTime = int(time.time())
176 if self.when == 'S':
177 self.interval = 1 # one second
178 self.suffix = "%Y-%m-%d_%H-%M-%S"
179 elif self.when == 'M':
180 self.interval = 60 # one minute
181 self.suffix = "%Y-%m-%d_%H-%M"
182 elif self.when == 'H':
183 self.interval = 60 * 60 # one hour
184 self.suffix = "%Y-%m-%d_%H"
185 elif self.when == 'D' or self.when == 'MIDNIGHT':
186 self.interval = 60 * 60 * 24 # one day
187 self.suffix = "%Y-%m-%d"
188 elif self.when.startswith('W'):
189 self.interval = 60 * 60 * 24 * 7 # one week
190 if len(self.when) != 2:
191 raise ValueError("You must specify a day for weekly rollover from 0 to 6 (0 is Monday): %s" % self.when)
192 if self.when[1] < '0' or self.when[1] > '6':
193 raise ValueError("Invalid day specified for weekly rollover: %s" % self.when)
194 self.dayOfWeek = int(self.when[1])
195 self.suffix = "%Y-%m-%d"
196 else:
197 raise ValueError("Invalid rollover interval specified: %s" % self.when)
198
Vinay Sajipe7d40662004-10-03 19:12:07 +0000199 self.interval = self.interval * interval # multiply by units requested
Vinay Sajip17c52d82004-07-03 11:48:34 +0000200 self.rolloverAt = currentTime + self.interval
201
202 # If we are rolling over at midnight or weekly, then the interval is already known.
203 # What we need to figure out is WHEN the next interval is. In other words,
204 # if you are rolling over at midnight, then your base interval is 1 day,
205 # but you want to start that one day clock at midnight, not now. So, we
206 # have to fudge the rolloverAt value in order to trigger the first rollover
207 # at the right time. After that, the regular interval will take care of
208 # the rest. Note that this code doesn't care about leap seconds. :)
209 if self.when == 'MIDNIGHT' or self.when.startswith('W'):
210 # This could be done with less code, but I wanted it to be clear
211 t = time.localtime(currentTime)
212 currentHour = t[3]
213 currentMinute = t[4]
214 currentSecond = t[5]
215 # r is the number of seconds left between now and midnight
Vinay Sajip4b4a63e2006-05-02 08:35:36 +0000216 r = _MIDNIGHT - ((currentHour * 60 + currentMinute) * 60 +
217 currentSecond)
Vinay Sajip17c52d82004-07-03 11:48:34 +0000218 self.rolloverAt = currentTime + r
219 # If we are rolling over on a certain day, add in the number of days until
220 # the next rollover, but offset by 1 since we just calculated the time
221 # until the next day starts. There are three cases:
222 # Case 1) The day to rollover is today; in this case, do nothing
223 # Case 2) The day to rollover is further in the interval (i.e., today is
224 # day 2 (Wednesday) and rollover is on day 6 (Sunday). Days to
225 # next rollover is simply 6 - 2 - 1, or 3.
226 # Case 3) The day to rollover is behind us in the interval (i.e., today
227 # is day 5 (Saturday) and rollover is on day 3 (Thursday).
228 # Days to rollover is 6 - 5 + 3, or 4. In this case, it's the
229 # number of days left in the current week (1) plus the number
230 # of days in the next week until the rollover day (3).
231 if when.startswith('W'):
232 day = t[6] # 0 is Monday
233 if day > self.dayOfWeek:
234 daysToWait = (day - self.dayOfWeek) - 1
Vinay Sajipe7d40662004-10-03 19:12:07 +0000235 self.rolloverAt = self.rolloverAt + (daysToWait * (60 * 60 * 24))
Vinay Sajip17c52d82004-07-03 11:48:34 +0000236 if day < self.dayOfWeek:
237 daysToWait = (6 - self.dayOfWeek) + day
Vinay Sajipe7d40662004-10-03 19:12:07 +0000238 self.rolloverAt = self.rolloverAt + (daysToWait * (60 * 60 * 24))
Vinay Sajip17c52d82004-07-03 11:48:34 +0000239
Vinay Sajip5e9e9e12004-07-12 09:21:41 +0000240 #print "Will rollover at %d, %d seconds from now" % (self.rolloverAt, self.rolloverAt - currentTime)
Vinay Sajip17c52d82004-07-03 11:48:34 +0000241
242 def shouldRollover(self, record):
243 """
244 Determine if rollover should occur
245
246 record is not used, as we are just comparing times, but it is needed so
247 the method siguratures are the same
248 """
249 t = int(time.time())
250 if t >= self.rolloverAt:
251 return 1
Vinay Sajip5e9e9e12004-07-12 09:21:41 +0000252 #print "No need to rollover: %d, %d" % (t, self.rolloverAt)
Vinay Sajip17c52d82004-07-03 11:48:34 +0000253 return 0
254
255 def doRollover(self):
256 """
257 do a rollover; in this case, a date/time stamp is appended to the filename
258 when the rollover happens. However, you want the file to be named for the
259 start of the interval, not the current time. If there is a backup count,
260 then we have to get a list of matching filenames, sort them and remove
261 the one with the oldest suffix.
262 """
263 self.stream.close()
264 # get the time that this sequence started at and make it a TimeTuple
265 t = self.rolloverAt - self.interval
266 timeTuple = time.localtime(t)
267 dfn = self.baseFilename + "." + time.strftime(self.suffix, timeTuple)
268 if os.path.exists(dfn):
269 os.remove(dfn)
Vinay Sajip6dd59f12006-06-27 07:34:37 +0000270 os.rename(self.baseFilename, dfn)
Vinay Sajip17c52d82004-07-03 11:48:34 +0000271 if self.backupCount > 0:
272 # find the oldest log file and delete it
273 s = glob.glob(self.baseFilename + ".20*")
274 if len(s) > self.backupCount:
Vinay Sajip5e9e9e12004-07-12 09:21:41 +0000275 s.sort()
Vinay Sajip17c52d82004-07-03 11:48:34 +0000276 os.remove(s[0])
Vinay Sajip5e9e9e12004-07-12 09:21:41 +0000277 #print "%s -> %s" % (self.baseFilename, dfn)
Vinay Sajipb3d8a062007-01-16 09:50:07 +0000278 self.mode = 'w'
279 self.stream = self._open()
Vinay Sajipd9520412006-01-16 09:13:58 +0000280 self.rolloverAt = self.rolloverAt + self.interval
Guido van Rossum57102f82002-11-13 16:15:58 +0000281
Vinay Sajip73306b02007-01-14 21:49:59 +0000282class WatchedFileHandler(logging.FileHandler):
283 """
284 A handler for logging to a file, which watches the file
285 to see if it has changed while in use. This can happen because of
286 usage of programs such as newsyslog and logrotate which perform
287 log file rotation. This handler, intended for use under Unix,
288 watches the file to see if it has changed since the last emit.
289 (A file has changed if its device or inode have changed.)
290 If it has changed, the old file stream is closed, and the file
291 opened to get a new stream.
292
293 This handler is not appropriate for use under Windows, because
294 under Windows open files cannot be moved or renamed - logging
295 opens the files with exclusive locks - and so there is no need
296 for such a handler. Furthermore, ST_INO is not supported under
297 Windows; stat always returns zero for this value.
298
299 This handler is based on a suggestion and patch by Chad J.
300 Schroeder.
301 """
302 def __init__(self, filename, mode='a', encoding=None):
303 logging.FileHandler.__init__(self, filename, mode, encoding)
304 stat = os.stat(self.baseFilename)
305 self.dev, self.ino = stat[ST_DEV], stat[ST_INO]
306
307 def emit(self, record):
308 """
309 Emit a record.
310
311 First check if the underlying file has changed, and if it
312 has, close the old stream and reopen the file to get the
313 current stream.
314 """
315 if not os.path.exists(self.baseFilename):
316 stat = None
317 changed = 1
318 else:
319 stat = os.stat(self.baseFilename)
320 changed = (stat[ST_DEV] != self.dev) or (stat[ST_INO] != self.ino)
321 if changed:
322 self.stream.flush()
323 self.stream.close()
324 self.stream = self._open()
325 if stat is None:
326 stat = os.stat(self.baseFilename)
327 self.dev, self.ino = stat[ST_DEV], stat[ST_INO]
328 logging.FileHandler.emit(self, record)
329
Guido van Rossum57102f82002-11-13 16:15:58 +0000330class SocketHandler(logging.Handler):
331 """
332 A handler class which writes logging records, in pickle format, to
333 a streaming socket. The socket is kept open across logging calls.
334 If the peer resets it, an attempt is made to reconnect on the next call.
Raymond Hettinger6f3eaa62003-06-27 21:43:39 +0000335 The pickle which is sent is that of the LogRecord's attribute dictionary
336 (__dict__), so that the receiver does not need to have the logging module
337 installed in order to process the logging event.
338
339 To unpickle the record at the receiving end into a LogRecord, use the
340 makeLogRecord function.
Guido van Rossum57102f82002-11-13 16:15:58 +0000341 """
342
343 def __init__(self, host, port):
344 """
345 Initializes the handler with a specific host address and port.
346
347 The attribute 'closeOnError' is set to 1 - which means that if
348 a socket error occurs, the socket is silently closed and then
349 reopened on the next logging call.
350 """
351 logging.Handler.__init__(self)
352 self.host = host
353 self.port = port
354 self.sock = None
355 self.closeOnError = 0
Vinay Sajip48cfe382004-02-20 13:17:27 +0000356 self.retryTime = None
357 #
358 # Exponential backoff parameters.
359 #
360 self.retryStart = 1.0
361 self.retryMax = 30.0
362 self.retryFactor = 2.0
Guido van Rossum57102f82002-11-13 16:15:58 +0000363
364 def makeSocket(self):
365 """
366 A factory method which allows subclasses to define the precise
367 type of socket they want.
368 """
369 s = socket.socket(socket.AF_INET, socket.SOCK_STREAM)
370 s.connect((self.host, self.port))
371 return s
372
Vinay Sajip48cfe382004-02-20 13:17:27 +0000373 def createSocket(self):
374 """
375 Try to create a socket, using an exponential backoff with
376 a max retry time. Thanks to Robert Olson for the original patch
377 (SF #815911) which has been slightly refactored.
378 """
379 now = time.time()
380 # Either retryTime is None, in which case this
381 # is the first time back after a disconnect, or
382 # we've waited long enough.
383 if self.retryTime is None:
Tim Peters4e0e1b62004-07-07 20:54:48 +0000384 attempt = 1
Vinay Sajip48cfe382004-02-20 13:17:27 +0000385 else:
Tim Peters4e0e1b62004-07-07 20:54:48 +0000386 attempt = (now >= self.retryTime)
Vinay Sajip48cfe382004-02-20 13:17:27 +0000387 if attempt:
388 try:
389 self.sock = self.makeSocket()
390 self.retryTime = None # next time, no delay before trying
Vinay Sajipc683a872007-01-08 18:50:32 +0000391 except socket.error:
Vinay Sajip48cfe382004-02-20 13:17:27 +0000392 #Creation failed, so set the retry time and return.
393 if self.retryTime is None:
394 self.retryPeriod = self.retryStart
395 else:
396 self.retryPeriod = self.retryPeriod * self.retryFactor
397 if self.retryPeriod > self.retryMax:
398 self.retryPeriod = self.retryMax
399 self.retryTime = now + self.retryPeriod
400
Guido van Rossum57102f82002-11-13 16:15:58 +0000401 def send(self, s):
402 """
403 Send a pickled string to the socket.
404
405 This function allows for partial sends which can happen when the
406 network is busy.
407 """
Vinay Sajip48cfe382004-02-20 13:17:27 +0000408 if self.sock is None:
409 self.createSocket()
410 #self.sock can be None either because we haven't reached the retry
411 #time yet, or because we have reached the retry time and retried,
412 #but are still unable to connect.
413 if self.sock:
414 try:
415 if hasattr(self.sock, "sendall"):
416 self.sock.sendall(s)
417 else:
418 sentsofar = 0
419 left = len(s)
420 while left > 0:
421 sent = self.sock.send(s[sentsofar:])
422 sentsofar = sentsofar + sent
423 left = left - sent
424 except socket.error:
425 self.sock.close()
426 self.sock = None # so we can call createSocket next time
Guido van Rossum57102f82002-11-13 16:15:58 +0000427
428 def makePickle(self, record):
429 """
430 Pickles the record in binary format with a length prefix, and
431 returns it ready for transmission across the socket.
432 """
Vinay Sajip48cfe382004-02-20 13:17:27 +0000433 ei = record.exc_info
434 if ei:
Tim Peters4e0e1b62004-07-07 20:54:48 +0000435 dummy = self.format(record) # just to get traceback text into record.exc_text
436 record.exc_info = None # to avoid Unpickleable error
Guido van Rossum57102f82002-11-13 16:15:58 +0000437 s = cPickle.dumps(record.__dict__, 1)
Vinay Sajip48cfe382004-02-20 13:17:27 +0000438 if ei:
Tim Peters4e0e1b62004-07-07 20:54:48 +0000439 record.exc_info = ei # for next handler
Guido van Rossum57102f82002-11-13 16:15:58 +0000440 slen = struct.pack(">L", len(s))
441 return slen + s
442
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000443 def handleError(self, record):
Guido van Rossum57102f82002-11-13 16:15:58 +0000444 """
445 Handle an error during logging.
446
447 An error has occurred during logging. Most likely cause -
448 connection lost. Close the socket so that we can retry on the
449 next event.
450 """
451 if self.closeOnError and self.sock:
452 self.sock.close()
453 self.sock = None #try to reconnect next time
454 else:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000455 logging.Handler.handleError(self, record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000456
457 def emit(self, record):
458 """
459 Emit a record.
460
461 Pickles the record and writes it to the socket in binary format.
462 If there is an error with the socket, silently drop the packet.
463 If there was a problem with the socket, re-establishes the
464 socket.
465 """
466 try:
467 s = self.makePickle(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000468 self.send(s)
Vinay Sajip85c19092005-10-31 13:14:19 +0000469 except (KeyboardInterrupt, SystemExit):
470 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000471 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000472 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000473
474 def close(self):
475 """
476 Closes the socket.
477 """
478 if self.sock:
479 self.sock.close()
480 self.sock = None
Vinay Sajip48cfe382004-02-20 13:17:27 +0000481 logging.Handler.close(self)
Guido van Rossum57102f82002-11-13 16:15:58 +0000482
483class DatagramHandler(SocketHandler):
484 """
485 A handler class which writes logging records, in pickle format, to
Raymond Hettinger6f3eaa62003-06-27 21:43:39 +0000486 a datagram socket. The pickle which is sent is that of the LogRecord's
487 attribute dictionary (__dict__), so that the receiver does not need to
488 have the logging module installed in order to process the logging event.
489
490 To unpickle the record at the receiving end into a LogRecord, use the
491 makeLogRecord function.
Guido van Rossum57102f82002-11-13 16:15:58 +0000492
493 """
494 def __init__(self, host, port):
495 """
496 Initializes the handler with a specific host address and port.
497 """
498 SocketHandler.__init__(self, host, port)
499 self.closeOnError = 0
500
501 def makeSocket(self):
502 """
503 The factory method of SocketHandler is here overridden to create
504 a UDP socket (SOCK_DGRAM).
505 """
506 s = socket.socket(socket.AF_INET, socket.SOCK_DGRAM)
507 return s
508
509 def send(self, s):
510 """
511 Send a pickled string to a socket.
512
513 This function no longer allows for partial sends which can happen
514 when the network is busy - UDP does not guarantee delivery and
515 can deliver packets out of sequence.
516 """
Vinay Sajipfb154172004-08-24 09:36:23 +0000517 if self.sock is None:
518 self.createSocket()
Guido van Rossum57102f82002-11-13 16:15:58 +0000519 self.sock.sendto(s, (self.host, self.port))
520
521class SysLogHandler(logging.Handler):
522 """
523 A handler class which sends formatted logging records to a syslog
524 server. Based on Sam Rushing's syslog module:
525 http://www.nightmare.com/squirl/python-ext/misc/syslog.py
526 Contributed by Nicolas Untz (after which minor refactoring changes
527 have been made).
528 """
529
530 # from <linux/sys/syslog.h>:
531 # ======================================================================
532 # priorities/facilities are encoded into a single 32-bit quantity, where
533 # the bottom 3 bits are the priority (0-7) and the top 28 bits are the
534 # facility (0-big number). Both the priorities and the facilities map
535 # roughly one-to-one to strings in the syslogd(8) source code. This
536 # mapping is included in this file.
537 #
538 # priorities (these are ordered)
539
540 LOG_EMERG = 0 # system is unusable
541 LOG_ALERT = 1 # action must be taken immediately
542 LOG_CRIT = 2 # critical conditions
543 LOG_ERR = 3 # error conditions
544 LOG_WARNING = 4 # warning conditions
545 LOG_NOTICE = 5 # normal but significant condition
546 LOG_INFO = 6 # informational
547 LOG_DEBUG = 7 # debug-level messages
548
549 # facility codes
550 LOG_KERN = 0 # kernel messages
551 LOG_USER = 1 # random user-level messages
552 LOG_MAIL = 2 # mail system
553 LOG_DAEMON = 3 # system daemons
554 LOG_AUTH = 4 # security/authorization messages
555 LOG_SYSLOG = 5 # messages generated internally by syslogd
556 LOG_LPR = 6 # line printer subsystem
557 LOG_NEWS = 7 # network news subsystem
558 LOG_UUCP = 8 # UUCP subsystem
559 LOG_CRON = 9 # clock daemon
560 LOG_AUTHPRIV = 10 # security/authorization messages (private)
561
562 # other codes through 15 reserved for system use
563 LOG_LOCAL0 = 16 # reserved for local use
564 LOG_LOCAL1 = 17 # reserved for local use
565 LOG_LOCAL2 = 18 # reserved for local use
566 LOG_LOCAL3 = 19 # reserved for local use
567 LOG_LOCAL4 = 20 # reserved for local use
568 LOG_LOCAL5 = 21 # reserved for local use
569 LOG_LOCAL6 = 22 # reserved for local use
570 LOG_LOCAL7 = 23 # reserved for local use
571
572 priority_names = {
573 "alert": LOG_ALERT,
574 "crit": LOG_CRIT,
575 "critical": LOG_CRIT,
576 "debug": LOG_DEBUG,
577 "emerg": LOG_EMERG,
578 "err": LOG_ERR,
579 "error": LOG_ERR, # DEPRECATED
580 "info": LOG_INFO,
581 "notice": LOG_NOTICE,
582 "panic": LOG_EMERG, # DEPRECATED
583 "warn": LOG_WARNING, # DEPRECATED
584 "warning": LOG_WARNING,
585 }
586
587 facility_names = {
588 "auth": LOG_AUTH,
589 "authpriv": LOG_AUTHPRIV,
590 "cron": LOG_CRON,
591 "daemon": LOG_DAEMON,
592 "kern": LOG_KERN,
593 "lpr": LOG_LPR,
594 "mail": LOG_MAIL,
595 "news": LOG_NEWS,
596 "security": LOG_AUTH, # DEPRECATED
597 "syslog": LOG_SYSLOG,
598 "user": LOG_USER,
599 "uucp": LOG_UUCP,
600 "local0": LOG_LOCAL0,
601 "local1": LOG_LOCAL1,
602 "local2": LOG_LOCAL2,
603 "local3": LOG_LOCAL3,
604 "local4": LOG_LOCAL4,
605 "local5": LOG_LOCAL5,
606 "local6": LOG_LOCAL6,
607 "local7": LOG_LOCAL7,
608 }
609
Vinay Sajipdc579362006-07-20 23:20:12 +0000610 #The map below appears to be trivially lowercasing the key. However,
611 #there's more to it than meets the eye - in some locales, lowercasing
612 #gives unexpected results. See SF #1524081: in the Turkish locale,
613 #"INFO".lower() != "info"
614 priority_map = {
615 "DEBUG" : "debug",
616 "INFO" : "info",
617 "WARNING" : "warning",
618 "ERROR" : "error",
619 "CRITICAL" : "critical"
620 }
621
Guido van Rossum57102f82002-11-13 16:15:58 +0000622 def __init__(self, address=('localhost', SYSLOG_UDP_PORT), facility=LOG_USER):
623 """
624 Initialize a handler.
625
626 If address is specified as a string, UNIX socket is used.
627 If facility is not specified, LOG_USER is used.
628 """
629 logging.Handler.__init__(self)
630
631 self.address = address
632 self.facility = facility
633 if type(address) == types.StringType:
Guido van Rossum57102f82002-11-13 16:15:58 +0000634 self.unixsocket = 1
Vinay Sajip5492e172006-12-11 14:07:16 +0000635 self._connect_unixsocket(address)
Guido van Rossum57102f82002-11-13 16:15:58 +0000636 else:
Guido van Rossum57102f82002-11-13 16:15:58 +0000637 self.unixsocket = 0
Vinay Sajip5492e172006-12-11 14:07:16 +0000638 self.socket = socket.socket(socket.AF_INET, socket.SOCK_DGRAM)
Guido van Rossum57102f82002-11-13 16:15:58 +0000639
640 self.formatter = None
641
Vinay Sajipa1974c12005-01-13 08:23:56 +0000642 def _connect_unixsocket(self, address):
643 self.socket = socket.socket(socket.AF_UNIX, socket.SOCK_DGRAM)
644 # syslog may require either DGRAM or STREAM sockets
645 try:
646 self.socket.connect(address)
647 except socket.error:
648 self.socket.close()
649 self.socket = socket.socket(socket.AF_UNIX, socket.SOCK_STREAM)
Vinay Sajip8b6b53f2005-11-09 13:55:13 +0000650 self.socket.connect(address)
Vinay Sajipa1974c12005-01-13 08:23:56 +0000651
Guido van Rossum57102f82002-11-13 16:15:58 +0000652 # curious: when talking to the unix-domain '/dev/log' socket, a
653 # zero-terminator seems to be required. this string is placed
654 # into a class variable so that it can be overridden if
655 # necessary.
656 log_format_string = '<%d>%s\000'
657
Vinay Sajipdc579362006-07-20 23:20:12 +0000658 def encodePriority(self, facility, priority):
Guido van Rossum57102f82002-11-13 16:15:58 +0000659 """
660 Encode the facility and priority. You can pass in strings or
661 integers - if strings are passed, the facility_names and
662 priority_names mapping dictionaries are used to convert them to
663 integers.
664 """
665 if type(facility) == types.StringType:
666 facility = self.facility_names[facility]
667 if type(priority) == types.StringType:
668 priority = self.priority_names[priority]
669 return (facility << 3) | priority
670
671 def close (self):
672 """
673 Closes the socket.
674 """
675 if self.unixsocket:
676 self.socket.close()
Vinay Sajip48cfe382004-02-20 13:17:27 +0000677 logging.Handler.close(self)
Guido van Rossum57102f82002-11-13 16:15:58 +0000678
Vinay Sajipdc579362006-07-20 23:20:12 +0000679 def mapPriority(self, levelName):
680 """
681 Map a logging level name to a key in the priority_names map.
682 This is useful in two scenarios: when custom levels are being
683 used, and in the case where you can't do a straightforward
684 mapping by lowercasing the logging level name because of locale-
685 specific issues (see SF #1524081).
686 """
687 return self.priority_map.get(levelName, "warning")
688
Guido van Rossum57102f82002-11-13 16:15:58 +0000689 def emit(self, record):
690 """
691 Emit a record.
692
693 The record is formatted, and then sent to the syslog server. If
694 exception information is present, it is NOT sent to the server.
695 """
696 msg = self.format(record)
697 """
698 We need to convert record level to lowercase, maybe this will
699 change in the future.
700 """
701 msg = self.log_format_string % (
702 self.encodePriority(self.facility,
Vinay Sajipdc579362006-07-20 23:20:12 +0000703 self.mapPriority(record.levelname)),
704 msg)
Guido van Rossum57102f82002-11-13 16:15:58 +0000705 try:
706 if self.unixsocket:
Vinay Sajipa1974c12005-01-13 08:23:56 +0000707 try:
708 self.socket.send(msg)
709 except socket.error:
710 self._connect_unixsocket(self.address)
711 self.socket.send(msg)
Guido van Rossum57102f82002-11-13 16:15:58 +0000712 else:
713 self.socket.sendto(msg, self.address)
Vinay Sajip85c19092005-10-31 13:14:19 +0000714 except (KeyboardInterrupt, SystemExit):
715 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000716 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000717 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000718
719class SMTPHandler(logging.Handler):
720 """
721 A handler class which sends an SMTP email for each logging event.
722 """
723 def __init__(self, mailhost, fromaddr, toaddrs, subject):
724 """
725 Initialize the handler.
726
727 Initialize the instance with the from and to addresses and subject
728 line of the email. To specify a non-standard SMTP port, use the
729 (host, port) tuple format for the mailhost argument.
730 """
731 logging.Handler.__init__(self)
732 if type(mailhost) == types.TupleType:
733 host, port = mailhost
734 self.mailhost = host
735 self.mailport = port
736 else:
737 self.mailhost = mailhost
738 self.mailport = None
739 self.fromaddr = fromaddr
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000740 if type(toaddrs) == types.StringType:
741 toaddrs = [toaddrs]
Guido van Rossum57102f82002-11-13 16:15:58 +0000742 self.toaddrs = toaddrs
743 self.subject = subject
744
745 def getSubject(self, record):
746 """
747 Determine the subject for the email.
748
749 If you want to specify a subject line which is record-dependent,
750 override this method.
751 """
752 return self.subject
753
Vinay Sajipe7d40662004-10-03 19:12:07 +0000754 weekdayname = ['Mon', 'Tue', 'Wed', 'Thu', 'Fri', 'Sat', 'Sun']
755
756 monthname = [None,
757 'Jan', 'Feb', 'Mar', 'Apr', 'May', 'Jun',
758 'Jul', 'Aug', 'Sep', 'Oct', 'Nov', 'Dec']
759
760 def date_time(self):
761 """
762 Return the current date and time formatted for a MIME header.
763 Needed for Python 1.5.2 (no email package available)
764 """
765 year, month, day, hh, mm, ss, wd, y, z = time.gmtime(time.time())
766 s = "%s, %02d %3s %4d %02d:%02d:%02d GMT" % (
767 self.weekdayname[wd],
768 day, self.monthname[month], year,
769 hh, mm, ss)
770 return s
771
Guido van Rossum57102f82002-11-13 16:15:58 +0000772 def emit(self, record):
773 """
774 Emit a record.
775
776 Format the record and send it to the specified addressees.
777 """
778 try:
779 import smtplib
Vinay Sajipe7d40662004-10-03 19:12:07 +0000780 try:
781 from email.Utils import formatdate
Vinay Sajipc683a872007-01-08 18:50:32 +0000782 except ImportError:
Vinay Sajipe7d40662004-10-03 19:12:07 +0000783 formatdate = self.date_time
Guido van Rossum57102f82002-11-13 16:15:58 +0000784 port = self.mailport
785 if not port:
786 port = smtplib.SMTP_PORT
787 smtp = smtplib.SMTP(self.mailhost, port)
788 msg = self.format(record)
Neal Norwitzf297bd12003-04-23 03:49:43 +0000789 msg = "From: %s\r\nTo: %s\r\nSubject: %s\r\nDate: %s\r\n\r\n%s" % (
Guido van Rossum57102f82002-11-13 16:15:58 +0000790 self.fromaddr,
791 string.join(self.toaddrs, ","),
Neal Norwitzf297bd12003-04-23 03:49:43 +0000792 self.getSubject(record),
Martin v. Löwis318a12e2004-08-18 12:27:40 +0000793 formatdate(), msg)
Guido van Rossum57102f82002-11-13 16:15:58 +0000794 smtp.sendmail(self.fromaddr, self.toaddrs, msg)
795 smtp.quit()
Vinay Sajip245a5ab2005-10-31 14:27:01 +0000796 except (KeyboardInterrupt, SystemExit):
797 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000798 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000799 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000800
801class NTEventLogHandler(logging.Handler):
802 """
803 A handler class which sends events to the NT Event Log. Adds a
804 registry entry for the specified application name. If no dllname is
805 provided, win32service.pyd (which contains some basic message
806 placeholders) is used. Note that use of these placeholders will make
807 your event logs big, as the entire message source is held in the log.
808 If you want slimmer logs, you have to pass in the name of your own DLL
809 which contains the message definitions you want to use in the event log.
810 """
811 def __init__(self, appname, dllname=None, logtype="Application"):
812 logging.Handler.__init__(self)
813 try:
814 import win32evtlogutil, win32evtlog
815 self.appname = appname
816 self._welu = win32evtlogutil
817 if not dllname:
818 dllname = os.path.split(self._welu.__file__)
819 dllname = os.path.split(dllname[0])
820 dllname = os.path.join(dllname[0], r'win32service.pyd')
821 self.dllname = dllname
822 self.logtype = logtype
823 self._welu.AddSourceToRegistry(appname, dllname, logtype)
824 self.deftype = win32evtlog.EVENTLOG_ERROR_TYPE
825 self.typemap = {
826 logging.DEBUG : win32evtlog.EVENTLOG_INFORMATION_TYPE,
827 logging.INFO : win32evtlog.EVENTLOG_INFORMATION_TYPE,
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000828 logging.WARNING : win32evtlog.EVENTLOG_WARNING_TYPE,
Guido van Rossum57102f82002-11-13 16:15:58 +0000829 logging.ERROR : win32evtlog.EVENTLOG_ERROR_TYPE,
830 logging.CRITICAL: win32evtlog.EVENTLOG_ERROR_TYPE,
831 }
832 except ImportError:
833 print "The Python Win32 extensions for NT (service, event "\
834 "logging) appear not to be available."
835 self._welu = None
836
837 def getMessageID(self, record):
838 """
839 Return the message ID for the event record. If you are using your
840 own messages, you could do this by having the msg passed to the
841 logger being an ID rather than a formatting string. Then, in here,
842 you could use a dictionary lookup to get the message ID. This
843 version returns 1, which is the base message ID in win32service.pyd.
844 """
845 return 1
846
847 def getEventCategory(self, record):
848 """
849 Return the event category for the record.
850
851 Override this if you want to specify your own categories. This version
852 returns 0.
853 """
854 return 0
855
856 def getEventType(self, record):
857 """
858 Return the event type for the record.
859
860 Override this if you want to specify your own types. This version does
861 a mapping using the handler's typemap attribute, which is set up in
862 __init__() to a dictionary which contains mappings for DEBUG, INFO,
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000863 WARNING, ERROR and CRITICAL. If you are using your own levels you will
Guido van Rossum57102f82002-11-13 16:15:58 +0000864 either need to override this method or place a suitable dictionary in
865 the handler's typemap attribute.
866 """
867 return self.typemap.get(record.levelno, self.deftype)
868
869 def emit(self, record):
870 """
871 Emit a record.
872
873 Determine the message ID, event category and event type. Then
874 log the message in the NT event log.
875 """
876 if self._welu:
877 try:
878 id = self.getMessageID(record)
879 cat = self.getEventCategory(record)
880 type = self.getEventType(record)
881 msg = self.format(record)
882 self._welu.ReportEvent(self.appname, id, cat, type, [msg])
Vinay Sajip245a5ab2005-10-31 14:27:01 +0000883 except (KeyboardInterrupt, SystemExit):
884 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000885 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000886 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000887
888 def close(self):
889 """
890 Clean up this handler.
891
892 You can remove the application name from the registry as a
893 source of event log entries. However, if you do this, you will
894 not be able to see the events as you intended in the Event Log
895 Viewer - it needs to be able to access the registry to get the
896 DLL name.
897 """
898 #self._welu.RemoveSourceFromRegistry(self.appname, self.logtype)
Vinay Sajip48cfe382004-02-20 13:17:27 +0000899 logging.Handler.close(self)
Guido van Rossum57102f82002-11-13 16:15:58 +0000900
901class HTTPHandler(logging.Handler):
902 """
903 A class which sends records to a Web server, using either GET or
904 POST semantics.
905 """
906 def __init__(self, host, url, method="GET"):
907 """
908 Initialize the instance with the host, the request URL, and the method
909 ("GET" or "POST")
910 """
911 logging.Handler.__init__(self)
912 method = string.upper(method)
913 if method not in ["GET", "POST"]:
914 raise ValueError, "method must be GET or POST"
915 self.host = host
916 self.url = url
917 self.method = method
918
Neal Norwitzf297bd12003-04-23 03:49:43 +0000919 def mapLogRecord(self, record):
920 """
921 Default implementation of mapping the log record into a dict
Vinay Sajip48cfe382004-02-20 13:17:27 +0000922 that is sent as the CGI data. Overwrite in your class.
Neal Norwitzf297bd12003-04-23 03:49:43 +0000923 Contributed by Franz Glasner.
924 """
925 return record.__dict__
926
Guido van Rossum57102f82002-11-13 16:15:58 +0000927 def emit(self, record):
928 """
929 Emit a record.
930
931 Send the record to the Web server as an URL-encoded dictionary
932 """
933 try:
934 import httplib, urllib
Vinay Sajipb7935062005-10-11 13:15:31 +0000935 host = self.host
936 h = httplib.HTTP(host)
Guido van Rossum57102f82002-11-13 16:15:58 +0000937 url = self.url
Neal Norwitzf297bd12003-04-23 03:49:43 +0000938 data = urllib.urlencode(self.mapLogRecord(record))
Guido van Rossum57102f82002-11-13 16:15:58 +0000939 if self.method == "GET":
940 if (string.find(url, '?') >= 0):
941 sep = '&'
942 else:
943 sep = '?'
944 url = url + "%c%s" % (sep, data)
945 h.putrequest(self.method, url)
Vinay Sajipb7935062005-10-11 13:15:31 +0000946 # support multiple hosts on one IP address...
947 # need to strip optional :port from host, if present
948 i = string.find(host, ":")
949 if i >= 0:
950 host = host[:i]
951 h.putheader("Host", host)
Guido van Rossum57102f82002-11-13 16:15:58 +0000952 if self.method == "POST":
Vinay Sajipb7935062005-10-11 13:15:31 +0000953 h.putheader("Content-type",
954 "application/x-www-form-urlencoded")
Guido van Rossum57102f82002-11-13 16:15:58 +0000955 h.putheader("Content-length", str(len(data)))
956 h.endheaders()
957 if self.method == "POST":
958 h.send(data)
959 h.getreply() #can't do anything with the result
Vinay Sajip245a5ab2005-10-31 14:27:01 +0000960 except (KeyboardInterrupt, SystemExit):
961 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000962 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000963 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000964
965class BufferingHandler(logging.Handler):
966 """
967 A handler class which buffers logging records in memory. Whenever each
968 record is added to the buffer, a check is made to see if the buffer should
969 be flushed. If it should, then flush() is expected to do what's needed.
970 """
971 def __init__(self, capacity):
972 """
973 Initialize the handler with the buffer size.
974 """
975 logging.Handler.__init__(self)
976 self.capacity = capacity
977 self.buffer = []
978
979 def shouldFlush(self, record):
980 """
981 Should the handler flush its buffer?
982
983 Returns true if the buffer is up to capacity. This method can be
984 overridden to implement custom flushing strategies.
985 """
986 return (len(self.buffer) >= self.capacity)
987
988 def emit(self, record):
989 """
990 Emit a record.
991
992 Append the record. If shouldFlush() tells us to, call flush() to process
993 the buffer.
994 """
995 self.buffer.append(record)
996 if self.shouldFlush(record):
997 self.flush()
998
999 def flush(self):
1000 """
1001 Override to implement custom flushing behaviour.
1002
1003 This version just zaps the buffer to empty.
1004 """
1005 self.buffer = []
1006
Vinay Sajipf42d95e2004-02-21 22:14:34 +00001007 def close(self):
1008 """
1009 Close the handler.
1010
1011 This version just flushes and chains to the parent class' close().
1012 """
1013 self.flush()
1014 logging.Handler.close(self)
1015
Guido van Rossum57102f82002-11-13 16:15:58 +00001016class MemoryHandler(BufferingHandler):
1017 """
1018 A handler class which buffers logging records in memory, periodically
1019 flushing them to a target handler. Flushing occurs whenever the buffer
1020 is full, or when an event of a certain severity or greater is seen.
1021 """
1022 def __init__(self, capacity, flushLevel=logging.ERROR, target=None):
1023 """
1024 Initialize the handler with the buffer size, the level at which
1025 flushing should occur and an optional target.
1026
1027 Note that without a target being set either here or via setTarget(),
1028 a MemoryHandler is no use to anyone!
1029 """
1030 BufferingHandler.__init__(self, capacity)
1031 self.flushLevel = flushLevel
1032 self.target = target
1033
1034 def shouldFlush(self, record):
1035 """
1036 Check for buffer full or a record at the flushLevel or higher.
1037 """
1038 return (len(self.buffer) >= self.capacity) or \
1039 (record.levelno >= self.flushLevel)
1040
1041 def setTarget(self, target):
1042 """
1043 Set the target handler for this handler.
1044 """
1045 self.target = target
1046
1047 def flush(self):
1048 """
1049 For a MemoryHandler, flushing means just sending the buffered
1050 records to the target, if there is one. Override if you want
1051 different behaviour.
1052 """
1053 if self.target:
1054 for record in self.buffer:
1055 self.target.handle(record)
1056 self.buffer = []
1057
1058 def close(self):
1059 """
1060 Flush, set the target to None and lose the buffer.
1061 """
1062 self.flush()
1063 self.target = None
Vinay Sajip48cfe382004-02-20 13:17:27 +00001064 BufferingHandler.close(self)