blob: ef17081908da55bb5e4bb77540443bc40273915c [file] [log] [blame]
Vinay Sajipdb81c4c2010-02-25 23:13:06 +00001# Copyright 2001-2010 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
Vinay Sajipdb81c4c2010-02-25 23:13:06 +000022Copyright (C) 2001-2010 Vinay Sajip. All Rights Reserved.
Guido van Rossum57102f82002-11-13 16:15:58 +000023
Vinay Sajip6268cbc2009-01-21 00:19:28 +000024To use, simply 'import logging.handlers' and log away!
Guido van Rossum57102f82002-11-13 16:15:58 +000025"""
26
Benjamin Petersonad9d48d2008-04-02 21:49:44 +000027import logging, socket, os, pickle, struct, time, re
Benjamin Peterson9451a1c2010-03-13 22:30:34 +000028from stat import ST_DEV, ST_INO, ST_MTIME
Vinay Sajipe723e962011-04-15 22:27:17 +010029import queue
Victor Stinnercafa2ef2011-05-02 16:11:28 +020030try:
31 import threading
Vinay Sajip0372e102011-05-05 12:59:14 +010032except ImportError: #pragma: no cover
Victor Stinnercafa2ef2011-05-02 16:11:28 +020033 threading = None
Guido van Rossum57102f82002-11-13 16:15:58 +000034
Vinay Sajip4600f112005-03-13 09:56:36 +000035try:
36 import codecs
Vinay Sajip985ef872011-04-26 19:34:04 +010037except ImportError: #pragma: no cover
Vinay Sajip4600f112005-03-13 09:56:36 +000038 codecs = None
39
Guido van Rossum57102f82002-11-13 16:15:58 +000040#
41# Some constants...
42#
43
44DEFAULT_TCP_LOGGING_PORT = 9020
45DEFAULT_UDP_LOGGING_PORT = 9021
46DEFAULT_HTTP_LOGGING_PORT = 9022
47DEFAULT_SOAP_LOGGING_PORT = 9023
48SYSLOG_UDP_PORT = 514
Vinay Sajipcbabd7e2009-10-10 20:32:36 +000049SYSLOG_TCP_PORT = 514
Guido van Rossum57102f82002-11-13 16:15:58 +000050
Thomas Wouters477c8d52006-05-27 19:21:47 +000051_MIDNIGHT = 24 * 60 * 60 # number of seconds in a day
52
Vinay Sajip17c52d82004-07-03 11:48:34 +000053class BaseRotatingHandler(logging.FileHandler):
54 """
55 Base class for handlers that rotate log files at a certain point.
56 Not meant to be instantiated directly. Instead, use RotatingFileHandler
57 or TimedRotatingFileHandler.
58 """
Christian Heimese7a15bb2008-01-24 16:21:45 +000059 def __init__(self, filename, mode, encoding=None, delay=0):
Vinay Sajip17c52d82004-07-03 11:48:34 +000060 """
61 Use the specified filename for streamed logging
62 """
Vinay Sajip985ef872011-04-26 19:34:04 +010063 if codecs is None: #pragma: no cover
Vinay Sajip4600f112005-03-13 09:56:36 +000064 encoding = None
Christian Heimese7a15bb2008-01-24 16:21:45 +000065 logging.FileHandler.__init__(self, filename, mode, encoding, delay)
Vinay Sajip4600f112005-03-13 09:56:36 +000066 self.mode = mode
67 self.encoding = encoding
Guido van Rossum57102f82002-11-13 16:15:58 +000068
Vinay Sajip17c52d82004-07-03 11:48:34 +000069 def emit(self, record):
70 """
71 Emit a record.
72
73 Output the record to the file, catering for rollover as described
74 in doRollover().
75 """
Vinay Sajip3970c112004-07-08 10:24:04 +000076 try:
77 if self.shouldRollover(record):
78 self.doRollover()
79 logging.FileHandler.emit(self, record)
Vinay Sajip985ef872011-04-26 19:34:04 +010080 except (KeyboardInterrupt, SystemExit): #pragma: no cover
Vinay Sajip85c19092005-10-31 13:14:19 +000081 raise
Vinay Sajip3970c112004-07-08 10:24:04 +000082 except:
83 self.handleError(record)
Vinay Sajip17c52d82004-07-03 11:48:34 +000084
85class RotatingFileHandler(BaseRotatingHandler):
86 """
87 Handler for logging to a set of files, which switches from one file
88 to the next when the current file reaches a certain size.
89 """
Christian Heimese7a15bb2008-01-24 16:21:45 +000090 def __init__(self, filename, mode='a', maxBytes=0, backupCount=0, encoding=None, delay=0):
Guido van Rossum57102f82002-11-13 16:15:58 +000091 """
92 Open the specified file and use it as the stream for logging.
93
94 By default, the file grows indefinitely. You can specify particular
95 values of maxBytes and backupCount to allow the file to rollover at
96 a predetermined size.
97
98 Rollover occurs whenever the current log file is nearly maxBytes in
99 length. If backupCount is >= 1, the system will successively create
100 new files with the same pathname as the base file, but with extensions
101 ".1", ".2" etc. appended to it. For example, with a backupCount of 5
102 and a base file name of "app.log", you would get "app.log",
103 "app.log.1", "app.log.2", ... through to "app.log.5". The file being
104 written to is always "app.log" - when it gets filled up, it is closed
105 and renamed to "app.log.1", and if files "app.log.1", "app.log.2" etc.
106 exist, then they are renamed to "app.log.2", "app.log.3" etc.
107 respectively.
108
109 If maxBytes is zero, rollover never occurs.
110 """
Vinay Sajip89994b22010-08-22 18:11:02 +0000111 # If rotation/rollover is wanted, it doesn't make sense to use another
112 # mode. If for example 'w' were specified, then if there were multiple
113 # runs of the calling application, the logs from previous runs would be
114 # lost if the 'w' is respected, because the log file would be truncated
115 # on each run.
Vinay Sajip17c52d82004-07-03 11:48:34 +0000116 if maxBytes > 0:
Vinay Sajip89994b22010-08-22 18:11:02 +0000117 mode = 'a'
Christian Heimese7a15bb2008-01-24 16:21:45 +0000118 BaseRotatingHandler.__init__(self, filename, mode, encoding, delay)
Guido van Rossum57102f82002-11-13 16:15:58 +0000119 self.maxBytes = maxBytes
120 self.backupCount = backupCount
Guido van Rossum57102f82002-11-13 16:15:58 +0000121
122 def doRollover(self):
123 """
124 Do a rollover, as described in __init__().
125 """
Vinay Sajip6268cbc2009-01-21 00:19:28 +0000126 if self.stream:
127 self.stream.close()
Vinay Sajip01241d62011-01-21 23:35:57 +0000128 self.stream = None
Guido van Rossum57102f82002-11-13 16:15:58 +0000129 if self.backupCount > 0:
130 for i in range(self.backupCount - 1, 0, -1):
131 sfn = "%s.%d" % (self.baseFilename, i)
132 dfn = "%s.%d" % (self.baseFilename, i + 1)
133 if os.path.exists(sfn):
Guido van Rossum57102f82002-11-13 16:15:58 +0000134 if os.path.exists(dfn):
135 os.remove(dfn)
136 os.rename(sfn, dfn)
137 dfn = self.baseFilename + ".1"
138 if os.path.exists(dfn):
139 os.remove(dfn)
Thomas Wouters0e3f5912006-08-11 14:57:12 +0000140 os.rename(self.baseFilename, dfn)
Thomas Woutersb2137042007-02-01 18:02:27 +0000141 self.mode = 'w'
142 self.stream = self._open()
Guido van Rossum57102f82002-11-13 16:15:58 +0000143
Vinay Sajip17c52d82004-07-03 11:48:34 +0000144 def shouldRollover(self, record):
Guido van Rossum57102f82002-11-13 16:15:58 +0000145 """
Vinay Sajip17c52d82004-07-03 11:48:34 +0000146 Determine if rollover should occur.
Guido van Rossum57102f82002-11-13 16:15:58 +0000147
Vinay Sajip17c52d82004-07-03 11:48:34 +0000148 Basically, see if the supplied record would cause the file to exceed
149 the size limit we have.
Guido van Rossum57102f82002-11-13 16:15:58 +0000150 """
Vinay Sajip6268cbc2009-01-21 00:19:28 +0000151 if self.stream is None: # delay was set...
152 self.stream = self._open()
Guido van Rossum57102f82002-11-13 16:15:58 +0000153 if self.maxBytes > 0: # are we rolling over?
154 msg = "%s\n" % self.format(record)
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000155 self.stream.seek(0, 2) #due to non-posix-compliant Windows feature
Guido van Rossum57102f82002-11-13 16:15:58 +0000156 if self.stream.tell() + len(msg) >= self.maxBytes:
Vinay Sajip17c52d82004-07-03 11:48:34 +0000157 return 1
158 return 0
Guido van Rossum57102f82002-11-13 16:15:58 +0000159
Vinay Sajip17c52d82004-07-03 11:48:34 +0000160class TimedRotatingFileHandler(BaseRotatingHandler):
161 """
162 Handler for logging to a file, rotating the log file at certain timed
163 intervals.
164
165 If backupCount is > 0, when rollover is done, no more than backupCount
166 files are kept - the oldest ones are deleted.
167 """
Vinay Sajipcbabd7e2009-10-10 20:32:36 +0000168 def __init__(self, filename, when='h', interval=1, backupCount=0, encoding=None, delay=False, utc=False):
Christian Heimese7a15bb2008-01-24 16:21:45 +0000169 BaseRotatingHandler.__init__(self, filename, 'a', encoding, delay)
Neal Norwitz9d72bb42007-04-17 08:48:32 +0000170 self.when = when.upper()
Vinay Sajip17c52d82004-07-03 11:48:34 +0000171 self.backupCount = backupCount
Benjamin Petersona37cfc62008-05-26 13:48:34 +0000172 self.utc = utc
Vinay Sajip17c52d82004-07-03 11:48:34 +0000173 # Calculate the real rollover interval, which is just the number of
174 # seconds between rollovers. Also set the filename suffix used when
175 # a rollover occurs. Current 'when' events supported:
176 # S - Seconds
177 # M - Minutes
178 # H - Hours
179 # D - Days
180 # midnight - roll over at midnight
181 # W{0-6} - roll over on a certain day; 0 - Monday
182 #
183 # Case of the 'when' specifier is not important; lower or upper case
184 # will work.
Vinay Sajip17c52d82004-07-03 11:48:34 +0000185 if self.when == 'S':
186 self.interval = 1 # one second
187 self.suffix = "%Y-%m-%d_%H-%M-%S"
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000188 self.extMatch = r"^\d{4}-\d{2}-\d{2}_\d{2}-\d{2}-\d{2}$"
Vinay Sajip17c52d82004-07-03 11:48:34 +0000189 elif self.when == 'M':
190 self.interval = 60 # one minute
191 self.suffix = "%Y-%m-%d_%H-%M"
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000192 self.extMatch = r"^\d{4}-\d{2}-\d{2}_\d{2}-\d{2}$"
Vinay Sajip17c52d82004-07-03 11:48:34 +0000193 elif self.when == 'H':
194 self.interval = 60 * 60 # one hour
195 self.suffix = "%Y-%m-%d_%H"
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000196 self.extMatch = r"^\d{4}-\d{2}-\d{2}_\d{2}$"
Vinay Sajip17c52d82004-07-03 11:48:34 +0000197 elif self.when == 'D' or self.when == 'MIDNIGHT':
198 self.interval = 60 * 60 * 24 # one day
199 self.suffix = "%Y-%m-%d"
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000200 self.extMatch = r"^\d{4}-\d{2}-\d{2}$"
Vinay Sajip17c52d82004-07-03 11:48:34 +0000201 elif self.when.startswith('W'):
202 self.interval = 60 * 60 * 24 * 7 # one week
203 if len(self.when) != 2:
204 raise ValueError("You must specify a day for weekly rollover from 0 to 6 (0 is Monday): %s" % self.when)
205 if self.when[1] < '0' or self.when[1] > '6':
206 raise ValueError("Invalid day specified for weekly rollover: %s" % self.when)
207 self.dayOfWeek = int(self.when[1])
208 self.suffix = "%Y-%m-%d"
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000209 self.extMatch = r"^\d{4}-\d{2}-\d{2}$"
Vinay Sajip17c52d82004-07-03 11:48:34 +0000210 else:
211 raise ValueError("Invalid rollover interval specified: %s" % self.when)
212
Antoine Pitroufd036452008-08-19 17:56:33 +0000213 self.extMatch = re.compile(self.extMatch, re.ASCII)
Vinay Sajipe7d40662004-10-03 19:12:07 +0000214 self.interval = self.interval * interval # multiply by units requested
Benjamin Peterson9451a1c2010-03-13 22:30:34 +0000215 if os.path.exists(filename):
216 t = os.stat(filename)[ST_MTIME]
217 else:
218 t = int(time.time())
219 self.rolloverAt = self.computeRollover(t)
Vinay Sajip17c52d82004-07-03 11:48:34 +0000220
Vinay Sajipaffbd872009-06-11 10:11:47 +0000221 def computeRollover(self, currentTime):
222 """
223 Work out the rollover time based on the specified time.
224 """
225 result = currentTime + self.interval
Vinay Sajip17c52d82004-07-03 11:48:34 +0000226 # If we are rolling over at midnight or weekly, then the interval is already known.
227 # What we need to figure out is WHEN the next interval is. In other words,
228 # if you are rolling over at midnight, then your base interval is 1 day,
229 # but you want to start that one day clock at midnight, not now. So, we
230 # have to fudge the rolloverAt value in order to trigger the first rollover
231 # at the right time. After that, the regular interval will take care of
232 # the rest. Note that this code doesn't care about leap seconds. :)
233 if self.when == 'MIDNIGHT' or self.when.startswith('W'):
234 # This could be done with less code, but I wanted it to be clear
Vinay Sajipaffbd872009-06-11 10:11:47 +0000235 if self.utc:
Benjamin Petersona37cfc62008-05-26 13:48:34 +0000236 t = time.gmtime(currentTime)
237 else:
238 t = time.localtime(currentTime)
Vinay Sajip17c52d82004-07-03 11:48:34 +0000239 currentHour = t[3]
240 currentMinute = t[4]
241 currentSecond = t[5]
242 # r is the number of seconds left between now and midnight
Thomas Wouters477c8d52006-05-27 19:21:47 +0000243 r = _MIDNIGHT - ((currentHour * 60 + currentMinute) * 60 +
244 currentSecond)
Vinay Sajipaffbd872009-06-11 10:11:47 +0000245 result = currentTime + r
Vinay Sajip17c52d82004-07-03 11:48:34 +0000246 # If we are rolling over on a certain day, add in the number of days until
247 # the next rollover, but offset by 1 since we just calculated the time
248 # until the next day starts. There are three cases:
249 # Case 1) The day to rollover is today; in this case, do nothing
250 # Case 2) The day to rollover is further in the interval (i.e., today is
251 # day 2 (Wednesday) and rollover is on day 6 (Sunday). Days to
252 # next rollover is simply 6 - 2 - 1, or 3.
253 # Case 3) The day to rollover is behind us in the interval (i.e., today
254 # is day 5 (Saturday) and rollover is on day 3 (Thursday).
255 # Days to rollover is 6 - 5 + 3, or 4. In this case, it's the
256 # number of days left in the current week (1) plus the number
257 # of days in the next week until the rollover day (3).
Georg Brandl86def6c2008-01-21 20:36:10 +0000258 # The calculations described in 2) and 3) above need to have a day added.
259 # This is because the above time calculation takes us to midnight on this
260 # day, i.e. the start of the next day.
Vinay Sajipaffbd872009-06-11 10:11:47 +0000261 if self.when.startswith('W'):
Vinay Sajip17c52d82004-07-03 11:48:34 +0000262 day = t[6] # 0 is Monday
Guido van Rossum8ce8a782007-11-01 19:42:39 +0000263 if day != self.dayOfWeek:
264 if day < self.dayOfWeek:
Georg Brandl86def6c2008-01-21 20:36:10 +0000265 daysToWait = self.dayOfWeek - day
Guido van Rossum8ce8a782007-11-01 19:42:39 +0000266 else:
Georg Brandl86def6c2008-01-21 20:36:10 +0000267 daysToWait = 6 - day + self.dayOfWeek + 1
Vinay Sajipaffbd872009-06-11 10:11:47 +0000268 newRolloverAt = result + (daysToWait * (60 * 60 * 24))
269 if not self.utc:
Benjamin Petersona37cfc62008-05-26 13:48:34 +0000270 dstNow = t[-1]
271 dstAtRollover = time.localtime(newRolloverAt)[-1]
272 if dstNow != dstAtRollover:
273 if not dstNow: # DST kicks in before next rollover, so we need to deduct an hour
274 newRolloverAt = newRolloverAt - 3600
275 else: # DST bows out before next rollover, so we need to add an hour
276 newRolloverAt = newRolloverAt + 3600
Vinay Sajipaffbd872009-06-11 10:11:47 +0000277 result = newRolloverAt
278 return result
Vinay Sajip17c52d82004-07-03 11:48:34 +0000279
280 def shouldRollover(self, record):
281 """
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000282 Determine if rollover should occur.
Vinay Sajip17c52d82004-07-03 11:48:34 +0000283
284 record is not used, as we are just comparing times, but it is needed so
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000285 the method signatures are the same
Vinay Sajip17c52d82004-07-03 11:48:34 +0000286 """
287 t = int(time.time())
288 if t >= self.rolloverAt:
289 return 1
Vinay Sajip17c52d82004-07-03 11:48:34 +0000290 return 0
291
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000292 def getFilesToDelete(self):
293 """
294 Determine the files to delete when rolling over.
295
296 More specific than the earlier method, which just used glob.glob().
297 """
298 dirName, baseName = os.path.split(self.baseFilename)
299 fileNames = os.listdir(dirName)
300 result = []
301 prefix = baseName + "."
302 plen = len(prefix)
303 for fileName in fileNames:
304 if fileName[:plen] == prefix:
305 suffix = fileName[plen:]
306 if self.extMatch.match(suffix):
Benjamin Petersona37cfc62008-05-26 13:48:34 +0000307 result.append(os.path.join(dirName, fileName))
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000308 result.sort()
309 if len(result) < self.backupCount:
310 result = []
311 else:
312 result = result[:len(result) - self.backupCount]
313 return result
314
Vinay Sajip17c52d82004-07-03 11:48:34 +0000315 def doRollover(self):
316 """
317 do a rollover; in this case, a date/time stamp is appended to the filename
318 when the rollover happens. However, you want the file to be named for the
319 start of the interval, not the current time. If there is a backup count,
320 then we have to get a list of matching filenames, sort them and remove
321 the one with the oldest suffix.
322 """
Vinay Sajip6268cbc2009-01-21 00:19:28 +0000323 if self.stream:
324 self.stream.close()
Vinay Sajip01241d62011-01-21 23:35:57 +0000325 self.stream = None
Vinay Sajip17c52d82004-07-03 11:48:34 +0000326 # get the time that this sequence started at and make it a TimeTuple
327 t = self.rolloverAt - self.interval
Benjamin Petersona37cfc62008-05-26 13:48:34 +0000328 if self.utc:
329 timeTuple = time.gmtime(t)
330 else:
331 timeTuple = time.localtime(t)
Vinay Sajip17c52d82004-07-03 11:48:34 +0000332 dfn = self.baseFilename + "." + time.strftime(self.suffix, timeTuple)
333 if os.path.exists(dfn):
334 os.remove(dfn)
Thomas Wouters0e3f5912006-08-11 14:57:12 +0000335 os.rename(self.baseFilename, dfn)
Vinay Sajip17c52d82004-07-03 11:48:34 +0000336 if self.backupCount > 0:
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000337 for s in self.getFilesToDelete():
338 os.remove(s)
Thomas Woutersb2137042007-02-01 18:02:27 +0000339 self.mode = 'w'
340 self.stream = self._open()
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000341 currentTime = int(time.time())
Vinay Sajipaffbd872009-06-11 10:11:47 +0000342 newRolloverAt = self.computeRollover(currentTime)
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000343 while newRolloverAt <= currentTime:
344 newRolloverAt = newRolloverAt + self.interval
345 #If DST changes and midnight or weekly rollover, adjust for this.
Benjamin Petersona37cfc62008-05-26 13:48:34 +0000346 if (self.when == 'MIDNIGHT' or self.when.startswith('W')) and not self.utc:
Benjamin Petersonad9d48d2008-04-02 21:49:44 +0000347 dstNow = time.localtime(currentTime)[-1]
348 dstAtRollover = time.localtime(newRolloverAt)[-1]
349 if dstNow != dstAtRollover:
350 if not dstNow: # DST kicks in before next rollover, so we need to deduct an hour
351 newRolloverAt = newRolloverAt - 3600
352 else: # DST bows out before next rollover, so we need to add an hour
353 newRolloverAt = newRolloverAt + 3600
354 self.rolloverAt = newRolloverAt
Guido van Rossum57102f82002-11-13 16:15:58 +0000355
Thomas Woutersfc7bb8c2007-01-15 15:49:28 +0000356class WatchedFileHandler(logging.FileHandler):
357 """
358 A handler for logging to a file, which watches the file
359 to see if it has changed while in use. This can happen because of
360 usage of programs such as newsyslog and logrotate which perform
361 log file rotation. This handler, intended for use under Unix,
362 watches the file to see if it has changed since the last emit.
363 (A file has changed if its device or inode have changed.)
364 If it has changed, the old file stream is closed, and the file
365 opened to get a new stream.
366
367 This handler is not appropriate for use under Windows, because
368 under Windows open files cannot be moved or renamed - logging
369 opens the files with exclusive locks - and so there is no need
370 for such a handler. Furthermore, ST_INO is not supported under
371 Windows; stat always returns zero for this value.
372
373 This handler is based on a suggestion and patch by Chad J.
374 Schroeder.
375 """
Christian Heimese7a15bb2008-01-24 16:21:45 +0000376 def __init__(self, filename, mode='a', encoding=None, delay=0):
377 logging.FileHandler.__init__(self, filename, mode, encoding, delay)
378 if not os.path.exists(self.baseFilename):
379 self.dev, self.ino = -1, -1
380 else:
381 stat = os.stat(self.baseFilename)
382 self.dev, self.ino = stat[ST_DEV], stat[ST_INO]
Thomas Woutersfc7bb8c2007-01-15 15:49:28 +0000383
384 def emit(self, record):
385 """
386 Emit a record.
387
388 First check if the underlying file has changed, and if it
389 has, close the old stream and reopen the file to get the
390 current stream.
391 """
392 if not os.path.exists(self.baseFilename):
393 stat = None
Vinay Sajipde19e082011-04-30 21:52:26 +0100394 changed = True
Thomas Woutersfc7bb8c2007-01-15 15:49:28 +0000395 else:
396 stat = os.stat(self.baseFilename)
397 changed = (stat[ST_DEV] != self.dev) or (stat[ST_INO] != self.ino)
Christian Heimese7a15bb2008-01-24 16:21:45 +0000398 if changed and self.stream is not None:
Thomas Woutersfc7bb8c2007-01-15 15:49:28 +0000399 self.stream.flush()
400 self.stream.close()
401 self.stream = self._open()
402 if stat is None:
403 stat = os.stat(self.baseFilename)
404 self.dev, self.ino = stat[ST_DEV], stat[ST_INO]
405 logging.FileHandler.emit(self, record)
406
Guido van Rossum57102f82002-11-13 16:15:58 +0000407class SocketHandler(logging.Handler):
408 """
409 A handler class which writes logging records, in pickle format, to
410 a streaming socket. The socket is kept open across logging calls.
411 If the peer resets it, an attempt is made to reconnect on the next call.
Raymond Hettinger6f3eaa62003-06-27 21:43:39 +0000412 The pickle which is sent is that of the LogRecord's attribute dictionary
413 (__dict__), so that the receiver does not need to have the logging module
414 installed in order to process the logging event.
415
416 To unpickle the record at the receiving end into a LogRecord, use the
417 makeLogRecord function.
Guido van Rossum57102f82002-11-13 16:15:58 +0000418 """
419
420 def __init__(self, host, port):
421 """
422 Initializes the handler with a specific host address and port.
423
Vinay Sajipde19e082011-04-30 21:52:26 +0100424 When the attribute *closeOnError* is set to True - if a socket error
425 occurs, the socket is silently closed and then reopened on the next
426 logging call.
Guido van Rossum57102f82002-11-13 16:15:58 +0000427 """
428 logging.Handler.__init__(self)
429 self.host = host
430 self.port = port
431 self.sock = None
Vinay Sajipde19e082011-04-30 21:52:26 +0100432 self.closeOnError = False
Vinay Sajip48cfe382004-02-20 13:17:27 +0000433 self.retryTime = None
434 #
435 # Exponential backoff parameters.
436 #
437 self.retryStart = 1.0
438 self.retryMax = 30.0
439 self.retryFactor = 2.0
Guido van Rossum57102f82002-11-13 16:15:58 +0000440
Guido van Rossumd8faa362007-04-27 19:54:29 +0000441 def makeSocket(self, timeout=1):
Guido van Rossum57102f82002-11-13 16:15:58 +0000442 """
443 A factory method which allows subclasses to define the precise
444 type of socket they want.
445 """
446 s = socket.socket(socket.AF_INET, socket.SOCK_STREAM)
Guido van Rossumd8faa362007-04-27 19:54:29 +0000447 if hasattr(s, 'settimeout'):
448 s.settimeout(timeout)
Vinay Sajipb37cd392011-05-07 15:55:47 +0100449 try:
450 s.connect((self.host, self.port))
451 return s
452 except socket.error:
453 s.close()
454 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000455
Vinay Sajip48cfe382004-02-20 13:17:27 +0000456 def createSocket(self):
457 """
458 Try to create a socket, using an exponential backoff with
459 a max retry time. Thanks to Robert Olson for the original patch
460 (SF #815911) which has been slightly refactored.
461 """
462 now = time.time()
463 # Either retryTime is None, in which case this
464 # is the first time back after a disconnect, or
465 # we've waited long enough.
466 if self.retryTime is None:
Vinay Sajipde19e082011-04-30 21:52:26 +0100467 attempt = True
Vinay Sajip48cfe382004-02-20 13:17:27 +0000468 else:
Tim Peters4e0e1b62004-07-07 20:54:48 +0000469 attempt = (now >= self.retryTime)
Vinay Sajip48cfe382004-02-20 13:17:27 +0000470 if attempt:
471 try:
472 self.sock = self.makeSocket()
473 self.retryTime = None # next time, no delay before trying
Thomas Wouters902d6eb2007-01-09 23:18:33 +0000474 except socket.error:
Vinay Sajip48cfe382004-02-20 13:17:27 +0000475 #Creation failed, so set the retry time and return.
476 if self.retryTime is None:
477 self.retryPeriod = self.retryStart
478 else:
479 self.retryPeriod = self.retryPeriod * self.retryFactor
480 if self.retryPeriod > self.retryMax:
481 self.retryPeriod = self.retryMax
482 self.retryTime = now + self.retryPeriod
483
Guido van Rossum57102f82002-11-13 16:15:58 +0000484 def send(self, s):
485 """
486 Send a pickled string to the socket.
487
488 This function allows for partial sends which can happen when the
489 network is busy.
490 """
Vinay Sajip48cfe382004-02-20 13:17:27 +0000491 if self.sock is None:
492 self.createSocket()
493 #self.sock can be None either because we haven't reached the retry
494 #time yet, or because we have reached the retry time and retried,
495 #but are still unable to connect.
496 if self.sock:
497 try:
498 if hasattr(self.sock, "sendall"):
499 self.sock.sendall(s)
Vinay Sajip7fe1d512011-04-28 12:04:58 +0100500 else: #pragma: no cover
Vinay Sajip48cfe382004-02-20 13:17:27 +0000501 sentsofar = 0
502 left = len(s)
503 while left > 0:
504 sent = self.sock.send(s[sentsofar:])
505 sentsofar = sentsofar + sent
506 left = left - sent
Vinay Sajip7fe1d512011-04-28 12:04:58 +0100507 except socket.error: #pragma: no cover
Vinay Sajip48cfe382004-02-20 13:17:27 +0000508 self.sock.close()
509 self.sock = None # so we can call createSocket next time
Guido van Rossum57102f82002-11-13 16:15:58 +0000510
511 def makePickle(self, record):
512 """
513 Pickles the record in binary format with a length prefix, and
514 returns it ready for transmission across the socket.
515 """
Vinay Sajip48cfe382004-02-20 13:17:27 +0000516 ei = record.exc_info
517 if ei:
Tim Peters4e0e1b62004-07-07 20:54:48 +0000518 dummy = self.format(record) # just to get traceback text into record.exc_text
519 record.exc_info = None # to avoid Unpickleable error
Guido van Rossumba205d62006-08-17 08:57:26 +0000520 s = pickle.dumps(record.__dict__, 1)
Vinay Sajip48cfe382004-02-20 13:17:27 +0000521 if ei:
Tim Peters4e0e1b62004-07-07 20:54:48 +0000522 record.exc_info = ei # for next handler
Guido van Rossum57102f82002-11-13 16:15:58 +0000523 slen = struct.pack(">L", len(s))
524 return slen + s
525
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000526 def handleError(self, record):
Guido van Rossum57102f82002-11-13 16:15:58 +0000527 """
528 Handle an error during logging.
529
530 An error has occurred during logging. Most likely cause -
531 connection lost. Close the socket so that we can retry on the
532 next event.
533 """
534 if self.closeOnError and self.sock:
535 self.sock.close()
536 self.sock = None #try to reconnect next time
537 else:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000538 logging.Handler.handleError(self, record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000539
540 def emit(self, record):
541 """
542 Emit a record.
543
544 Pickles the record and writes it to the socket in binary format.
545 If there is an error with the socket, silently drop the packet.
546 If there was a problem with the socket, re-establishes the
547 socket.
548 """
549 try:
550 s = self.makePickle(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000551 self.send(s)
Vinay Sajip985ef872011-04-26 19:34:04 +0100552 except (KeyboardInterrupt, SystemExit): #pragma: no cover
Vinay Sajip85c19092005-10-31 13:14:19 +0000553 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000554 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000555 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000556
557 def close(self):
558 """
559 Closes the socket.
560 """
561 if self.sock:
562 self.sock.close()
563 self.sock = None
Vinay Sajip48cfe382004-02-20 13:17:27 +0000564 logging.Handler.close(self)
Guido van Rossum57102f82002-11-13 16:15:58 +0000565
566class DatagramHandler(SocketHandler):
567 """
568 A handler class which writes logging records, in pickle format, to
Raymond Hettinger6f3eaa62003-06-27 21:43:39 +0000569 a datagram socket. The pickle which is sent is that of the LogRecord's
570 attribute dictionary (__dict__), so that the receiver does not need to
571 have the logging module installed in order to process the logging event.
572
573 To unpickle the record at the receiving end into a LogRecord, use the
574 makeLogRecord function.
Guido van Rossum57102f82002-11-13 16:15:58 +0000575
576 """
577 def __init__(self, host, port):
578 """
579 Initializes the handler with a specific host address and port.
580 """
581 SocketHandler.__init__(self, host, port)
Vinay Sajipde19e082011-04-30 21:52:26 +0100582 self.closeOnError = False
Guido van Rossum57102f82002-11-13 16:15:58 +0000583
584 def makeSocket(self):
585 """
586 The factory method of SocketHandler is here overridden to create
587 a UDP socket (SOCK_DGRAM).
588 """
589 s = socket.socket(socket.AF_INET, socket.SOCK_DGRAM)
590 return s
591
592 def send(self, s):
593 """
594 Send a pickled string to a socket.
595
596 This function no longer allows for partial sends which can happen
597 when the network is busy - UDP does not guarantee delivery and
598 can deliver packets out of sequence.
599 """
Vinay Sajipfb154172004-08-24 09:36:23 +0000600 if self.sock is None:
601 self.createSocket()
Guido van Rossum57102f82002-11-13 16:15:58 +0000602 self.sock.sendto(s, (self.host, self.port))
603
604class SysLogHandler(logging.Handler):
605 """
606 A handler class which sends formatted logging records to a syslog
607 server. Based on Sam Rushing's syslog module:
608 http://www.nightmare.com/squirl/python-ext/misc/syslog.py
609 Contributed by Nicolas Untz (after which minor refactoring changes
610 have been made).
611 """
612
613 # from <linux/sys/syslog.h>:
614 # ======================================================================
615 # priorities/facilities are encoded into a single 32-bit quantity, where
616 # the bottom 3 bits are the priority (0-7) and the top 28 bits are the
617 # facility (0-big number). Both the priorities and the facilities map
618 # roughly one-to-one to strings in the syslogd(8) source code. This
619 # mapping is included in this file.
620 #
621 # priorities (these are ordered)
622
623 LOG_EMERG = 0 # system is unusable
624 LOG_ALERT = 1 # action must be taken immediately
625 LOG_CRIT = 2 # critical conditions
626 LOG_ERR = 3 # error conditions
627 LOG_WARNING = 4 # warning conditions
628 LOG_NOTICE = 5 # normal but significant condition
629 LOG_INFO = 6 # informational
630 LOG_DEBUG = 7 # debug-level messages
631
632 # facility codes
633 LOG_KERN = 0 # kernel messages
634 LOG_USER = 1 # random user-level messages
635 LOG_MAIL = 2 # mail system
636 LOG_DAEMON = 3 # system daemons
637 LOG_AUTH = 4 # security/authorization messages
638 LOG_SYSLOG = 5 # messages generated internally by syslogd
639 LOG_LPR = 6 # line printer subsystem
640 LOG_NEWS = 7 # network news subsystem
641 LOG_UUCP = 8 # UUCP subsystem
642 LOG_CRON = 9 # clock daemon
Benjamin Peterson22005fc2010-04-11 16:25:06 +0000643 LOG_AUTHPRIV = 10 # security/authorization messages (private)
644 LOG_FTP = 11 # FTP daemon
Guido van Rossum57102f82002-11-13 16:15:58 +0000645
646 # other codes through 15 reserved for system use
647 LOG_LOCAL0 = 16 # reserved for local use
648 LOG_LOCAL1 = 17 # reserved for local use
649 LOG_LOCAL2 = 18 # reserved for local use
650 LOG_LOCAL3 = 19 # reserved for local use
651 LOG_LOCAL4 = 20 # reserved for local use
652 LOG_LOCAL5 = 21 # reserved for local use
653 LOG_LOCAL6 = 22 # reserved for local use
654 LOG_LOCAL7 = 23 # reserved for local use
655
656 priority_names = {
657 "alert": LOG_ALERT,
658 "crit": LOG_CRIT,
659 "critical": LOG_CRIT,
660 "debug": LOG_DEBUG,
661 "emerg": LOG_EMERG,
662 "err": LOG_ERR,
663 "error": LOG_ERR, # DEPRECATED
664 "info": LOG_INFO,
665 "notice": LOG_NOTICE,
666 "panic": LOG_EMERG, # DEPRECATED
667 "warn": LOG_WARNING, # DEPRECATED
668 "warning": LOG_WARNING,
669 }
670
671 facility_names = {
672 "auth": LOG_AUTH,
673 "authpriv": LOG_AUTHPRIV,
674 "cron": LOG_CRON,
675 "daemon": LOG_DAEMON,
Benjamin Peterson22005fc2010-04-11 16:25:06 +0000676 "ftp": LOG_FTP,
Guido van Rossum57102f82002-11-13 16:15:58 +0000677 "kern": LOG_KERN,
678 "lpr": LOG_LPR,
679 "mail": LOG_MAIL,
680 "news": LOG_NEWS,
681 "security": LOG_AUTH, # DEPRECATED
682 "syslog": LOG_SYSLOG,
683 "user": LOG_USER,
684 "uucp": LOG_UUCP,
685 "local0": LOG_LOCAL0,
686 "local1": LOG_LOCAL1,
687 "local2": LOG_LOCAL2,
688 "local3": LOG_LOCAL3,
689 "local4": LOG_LOCAL4,
690 "local5": LOG_LOCAL5,
691 "local6": LOG_LOCAL6,
692 "local7": LOG_LOCAL7,
693 }
694
Thomas Wouters0e3f5912006-08-11 14:57:12 +0000695 #The map below appears to be trivially lowercasing the key. However,
696 #there's more to it than meets the eye - in some locales, lowercasing
697 #gives unexpected results. See SF #1524081: in the Turkish locale,
698 #"INFO".lower() != "info"
699 priority_map = {
700 "DEBUG" : "debug",
701 "INFO" : "info",
702 "WARNING" : "warning",
703 "ERROR" : "error",
704 "CRITICAL" : "critical"
705 }
706
Vinay Sajipcbabd7e2009-10-10 20:32:36 +0000707 def __init__(self, address=('localhost', SYSLOG_UDP_PORT),
708 facility=LOG_USER, socktype=socket.SOCK_DGRAM):
Guido van Rossum57102f82002-11-13 16:15:58 +0000709 """
710 Initialize a handler.
711
Guido van Rossume7ba4952007-06-06 23:52:48 +0000712 If address is specified as a string, a UNIX socket is used. To log to a
713 local syslogd, "SysLogHandler(address="/dev/log")" can be used.
Guido van Rossum57102f82002-11-13 16:15:58 +0000714 If facility is not specified, LOG_USER is used.
715 """
716 logging.Handler.__init__(self)
717
718 self.address = address
719 self.facility = facility
Vinay Sajipcbabd7e2009-10-10 20:32:36 +0000720 self.socktype = socktype
721
Guido van Rossum13257902007-06-07 23:15:56 +0000722 if isinstance(address, str):
Vinay Sajip5a35b062011-04-27 11:31:14 +0100723 self.unixsocket = True
Thomas Wouters89f507f2006-12-13 04:49:30 +0000724 self._connect_unixsocket(address)
Guido van Rossum57102f82002-11-13 16:15:58 +0000725 else:
Vinay Sajip5a35b062011-04-27 11:31:14 +0100726 self.unixsocket = False
Vinay Sajipcbabd7e2009-10-10 20:32:36 +0000727 self.socket = socket.socket(socket.AF_INET, socktype)
728 if socktype == socket.SOCK_STREAM:
729 self.socket.connect(address)
Guido van Rossum57102f82002-11-13 16:15:58 +0000730 self.formatter = None
731
Vinay Sajipa1974c12005-01-13 08:23:56 +0000732 def _connect_unixsocket(self, address):
733 self.socket = socket.socket(socket.AF_UNIX, socket.SOCK_DGRAM)
734 # syslog may require either DGRAM or STREAM sockets
735 try:
736 self.socket.connect(address)
737 except socket.error:
738 self.socket.close()
739 self.socket = socket.socket(socket.AF_UNIX, socket.SOCK_STREAM)
Vinay Sajip8b6b53f2005-11-09 13:55:13 +0000740 self.socket.connect(address)
Vinay Sajipa1974c12005-01-13 08:23:56 +0000741
Thomas Wouters0e3f5912006-08-11 14:57:12 +0000742 def encodePriority(self, facility, priority):
Guido van Rossum57102f82002-11-13 16:15:58 +0000743 """
744 Encode the facility and priority. You can pass in strings or
745 integers - if strings are passed, the facility_names and
746 priority_names mapping dictionaries are used to convert them to
747 integers.
748 """
Guido van Rossum13257902007-06-07 23:15:56 +0000749 if isinstance(facility, str):
Guido van Rossum57102f82002-11-13 16:15:58 +0000750 facility = self.facility_names[facility]
Guido van Rossum13257902007-06-07 23:15:56 +0000751 if isinstance(priority, str):
Guido van Rossum57102f82002-11-13 16:15:58 +0000752 priority = self.priority_names[priority]
753 return (facility << 3) | priority
754
755 def close (self):
756 """
757 Closes the socket.
758 """
Vinay Sajipfd285022011-05-07 17:01:22 +0100759 self.socket.close()
Vinay Sajip48cfe382004-02-20 13:17:27 +0000760 logging.Handler.close(self)
Guido van Rossum57102f82002-11-13 16:15:58 +0000761
Thomas Wouters0e3f5912006-08-11 14:57:12 +0000762 def mapPriority(self, levelName):
763 """
764 Map a logging level name to a key in the priority_names map.
765 This is useful in two scenarios: when custom levels are being
766 used, and in the case where you can't do a straightforward
767 mapping by lowercasing the logging level name because of locale-
768 specific issues (see SF #1524081).
769 """
770 return self.priority_map.get(levelName, "warning")
771
Vinay Sajip2353e352011-06-27 15:40:06 +0100772 ident = '' # prepended to all messages
Vinay Sajip8168d102011-06-09 16:50:49 +0100773 append_nul = True # some old syslog daemons expect a NUL terminator
774
Guido van Rossum57102f82002-11-13 16:15:58 +0000775 def emit(self, record):
776 """
777 Emit a record.
778
779 The record is formatted, and then sent to the syslog server. If
780 exception information is present, it is NOT sent to the server.
781 """
Vinay Sajip8168d102011-06-09 16:50:49 +0100782 msg = self.format(record)
Vinay Sajip2353e352011-06-27 15:40:06 +0100783 if self.ident:
784 msg = self.ident + msg
Vinay Sajip8168d102011-06-09 16:50:49 +0100785 if self.append_nul:
786 msg += '\000'
Guido van Rossum57102f82002-11-13 16:15:58 +0000787 """
788 We need to convert record level to lowercase, maybe this will
789 change in the future.
790 """
Vinay Sajip467d12f2010-08-19 22:20:22 +0000791 prio = '<%d>' % self.encodePriority(self.facility,
792 self.mapPriority(record.levelname))
793 prio = prio.encode('utf-8')
Vinay Sajip609364a2010-08-30 18:31:13 +0000794 # Message is a string. Convert to bytes as required by RFC 5424
Vinay Sajip42ead482009-10-21 20:22:14 +0000795 msg = msg.encode('utf-8')
796 if codecs:
797 msg = codecs.BOM_UTF8 + msg
Vinay Sajip467d12f2010-08-19 22:20:22 +0000798 msg = prio + msg
Guido van Rossum57102f82002-11-13 16:15:58 +0000799 try:
800 if self.unixsocket:
Vinay Sajipa1974c12005-01-13 08:23:56 +0000801 try:
802 self.socket.send(msg)
803 except socket.error:
804 self._connect_unixsocket(self.address)
805 self.socket.send(msg)
Vinay Sajipcbabd7e2009-10-10 20:32:36 +0000806 elif self.socktype == socket.SOCK_DGRAM:
Guido van Rossum57102f82002-11-13 16:15:58 +0000807 self.socket.sendto(msg, self.address)
Vinay Sajipcbabd7e2009-10-10 20:32:36 +0000808 else:
809 self.socket.sendall(msg)
Vinay Sajip985ef872011-04-26 19:34:04 +0100810 except (KeyboardInterrupt, SystemExit): #pragma: no cover
Vinay Sajip85c19092005-10-31 13:14:19 +0000811 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000812 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000813 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000814
815class SMTPHandler(logging.Handler):
816 """
817 A handler class which sends an SMTP email for each logging event.
818 """
Vinay Sajip540f2152009-12-06 17:57:11 +0000819 def __init__(self, mailhost, fromaddr, toaddrs, subject,
Vinay Sajip25fcd222009-12-06 18:05:04 +0000820 credentials=None, secure=None):
Guido van Rossum57102f82002-11-13 16:15:58 +0000821 """
822 Initialize the handler.
823
824 Initialize the instance with the from and to addresses and subject
825 line of the email. To specify a non-standard SMTP port, use the
Guido van Rossum360e4b82007-05-14 22:51:27 +0000826 (host, port) tuple format for the mailhost argument. To specify
827 authentication credentials, supply a (username, password) tuple
Vinay Sajip25fcd222009-12-06 18:05:04 +0000828 for the credentials argument. To specify the use of a secure
829 protocol (TLS), pass in a tuple for the secure argument. This will
830 only be used when authentication credentials are supplied. The tuple
831 will be either an empty tuple, or a single-value tuple with the name
832 of a keyfile, or a 2-value tuple with the names of the keyfile and
833 certificate file. (This tuple is passed to the `starttls` method).
Guido van Rossum57102f82002-11-13 16:15:58 +0000834 """
835 logging.Handler.__init__(self)
Guido van Rossum13257902007-06-07 23:15:56 +0000836 if isinstance(mailhost, tuple):
Guido van Rossum360e4b82007-05-14 22:51:27 +0000837 self.mailhost, self.mailport = mailhost
Guido van Rossum57102f82002-11-13 16:15:58 +0000838 else:
Guido van Rossum360e4b82007-05-14 22:51:27 +0000839 self.mailhost, self.mailport = mailhost, None
Guido van Rossum13257902007-06-07 23:15:56 +0000840 if isinstance(credentials, tuple):
Guido van Rossum360e4b82007-05-14 22:51:27 +0000841 self.username, self.password = credentials
842 else:
843 self.username = None
Guido van Rossum57102f82002-11-13 16:15:58 +0000844 self.fromaddr = fromaddr
Guido van Rossum13257902007-06-07 23:15:56 +0000845 if isinstance(toaddrs, str):
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000846 toaddrs = [toaddrs]
Guido van Rossum57102f82002-11-13 16:15:58 +0000847 self.toaddrs = toaddrs
848 self.subject = subject
Vinay Sajip540f2152009-12-06 17:57:11 +0000849 self.secure = secure
Guido van Rossum57102f82002-11-13 16:15:58 +0000850
851 def getSubject(self, record):
852 """
853 Determine the subject for the email.
854
855 If you want to specify a subject line which is record-dependent,
856 override this method.
857 """
858 return self.subject
859
860 def emit(self, record):
861 """
862 Emit a record.
863
864 Format the record and send it to the specified addressees.
865 """
866 try:
867 import smtplib
Vinay Sajipdb81c4c2010-02-25 23:13:06 +0000868 from email.utils import formatdate
Guido van Rossum57102f82002-11-13 16:15:58 +0000869 port = self.mailport
870 if not port:
871 port = smtplib.SMTP_PORT
872 smtp = smtplib.SMTP(self.mailhost, port)
873 msg = self.format(record)
Neal Norwitzf297bd12003-04-23 03:49:43 +0000874 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 +0000875 self.fromaddr,
Neal Norwitz9d72bb42007-04-17 08:48:32 +0000876 ",".join(self.toaddrs),
Neal Norwitzf297bd12003-04-23 03:49:43 +0000877 self.getSubject(record),
Martin v. Löwis318a12e2004-08-18 12:27:40 +0000878 formatdate(), msg)
Guido van Rossum360e4b82007-05-14 22:51:27 +0000879 if self.username:
Vinay Sajip25fcd222009-12-06 18:05:04 +0000880 if self.secure is not None:
Vinay Sajip540f2152009-12-06 17:57:11 +0000881 smtp.ehlo()
Vinay Sajip25fcd222009-12-06 18:05:04 +0000882 smtp.starttls(*self.secure)
Vinay Sajip540f2152009-12-06 17:57:11 +0000883 smtp.ehlo()
Guido van Rossum360e4b82007-05-14 22:51:27 +0000884 smtp.login(self.username, self.password)
Guido van Rossum57102f82002-11-13 16:15:58 +0000885 smtp.sendmail(self.fromaddr, self.toaddrs, msg)
886 smtp.quit()
Vinay Sajip985ef872011-04-26 19:34:04 +0100887 except (KeyboardInterrupt, SystemExit): #pragma: no cover
Vinay Sajip245a5ab2005-10-31 14:27:01 +0000888 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000889 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000890 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000891
892class NTEventLogHandler(logging.Handler):
893 """
894 A handler class which sends events to the NT Event Log. Adds a
895 registry entry for the specified application name. If no dllname is
896 provided, win32service.pyd (which contains some basic message
897 placeholders) is used. Note that use of these placeholders will make
898 your event logs big, as the entire message source is held in the log.
899 If you want slimmer logs, you have to pass in the name of your own DLL
900 which contains the message definitions you want to use in the event log.
901 """
902 def __init__(self, appname, dllname=None, logtype="Application"):
903 logging.Handler.__init__(self)
904 try:
905 import win32evtlogutil, win32evtlog
906 self.appname = appname
907 self._welu = win32evtlogutil
908 if not dllname:
909 dllname = os.path.split(self._welu.__file__)
910 dllname = os.path.split(dllname[0])
911 dllname = os.path.join(dllname[0], r'win32service.pyd')
912 self.dllname = dllname
913 self.logtype = logtype
914 self._welu.AddSourceToRegistry(appname, dllname, logtype)
915 self.deftype = win32evtlog.EVENTLOG_ERROR_TYPE
916 self.typemap = {
917 logging.DEBUG : win32evtlog.EVENTLOG_INFORMATION_TYPE,
918 logging.INFO : win32evtlog.EVENTLOG_INFORMATION_TYPE,
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000919 logging.WARNING : win32evtlog.EVENTLOG_WARNING_TYPE,
Guido van Rossum57102f82002-11-13 16:15:58 +0000920 logging.ERROR : win32evtlog.EVENTLOG_ERROR_TYPE,
921 logging.CRITICAL: win32evtlog.EVENTLOG_ERROR_TYPE,
922 }
923 except ImportError:
Guido van Rossumbe19ed72007-02-09 05:37:30 +0000924 print("The Python Win32 extensions for NT (service, event "\
925 "logging) appear not to be available.")
Guido van Rossum57102f82002-11-13 16:15:58 +0000926 self._welu = None
927
928 def getMessageID(self, record):
929 """
930 Return the message ID for the event record. If you are using your
931 own messages, you could do this by having the msg passed to the
932 logger being an ID rather than a formatting string. Then, in here,
933 you could use a dictionary lookup to get the message ID. This
934 version returns 1, which is the base message ID in win32service.pyd.
935 """
936 return 1
937
938 def getEventCategory(self, record):
939 """
940 Return the event category for the record.
941
942 Override this if you want to specify your own categories. This version
943 returns 0.
944 """
945 return 0
946
947 def getEventType(self, record):
948 """
949 Return the event type for the record.
950
951 Override this if you want to specify your own types. This version does
952 a mapping using the handler's typemap attribute, which is set up in
953 __init__() to a dictionary which contains mappings for DEBUG, INFO,
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000954 WARNING, ERROR and CRITICAL. If you are using your own levels you will
Guido van Rossum57102f82002-11-13 16:15:58 +0000955 either need to override this method or place a suitable dictionary in
956 the handler's typemap attribute.
957 """
958 return self.typemap.get(record.levelno, self.deftype)
959
960 def emit(self, record):
961 """
962 Emit a record.
963
964 Determine the message ID, event category and event type. Then
965 log the message in the NT event log.
966 """
967 if self._welu:
968 try:
969 id = self.getMessageID(record)
970 cat = self.getEventCategory(record)
971 type = self.getEventType(record)
972 msg = self.format(record)
973 self._welu.ReportEvent(self.appname, id, cat, type, [msg])
Vinay Sajip985ef872011-04-26 19:34:04 +0100974 except (KeyboardInterrupt, SystemExit): #pragma: no cover
Vinay Sajip245a5ab2005-10-31 14:27:01 +0000975 raise
Guido van Rossum57102f82002-11-13 16:15:58 +0000976 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +0000977 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +0000978
979 def close(self):
980 """
981 Clean up this handler.
982
983 You can remove the application name from the registry as a
984 source of event log entries. However, if you do this, you will
985 not be able to see the events as you intended in the Event Log
986 Viewer - it needs to be able to access the registry to get the
987 DLL name.
988 """
989 #self._welu.RemoveSourceFromRegistry(self.appname, self.logtype)
Vinay Sajip48cfe382004-02-20 13:17:27 +0000990 logging.Handler.close(self)
Guido van Rossum57102f82002-11-13 16:15:58 +0000991
992class HTTPHandler(logging.Handler):
993 """
994 A class which sends records to a Web server, using either GET or
995 POST semantics.
996 """
Vinay Sajipaf9d10a2010-09-13 20:40:30 +0000997 def __init__(self, host, url, method="GET", secure=False, credentials=None):
Guido van Rossum57102f82002-11-13 16:15:58 +0000998 """
999 Initialize the instance with the host, the request URL, and the method
1000 ("GET" or "POST")
1001 """
1002 logging.Handler.__init__(self)
Neal Norwitz9d72bb42007-04-17 08:48:32 +00001003 method = method.upper()
Guido van Rossum57102f82002-11-13 16:15:58 +00001004 if method not in ["GET", "POST"]:
Collin Winterce36ad82007-08-30 01:19:48 +00001005 raise ValueError("method must be GET or POST")
Guido van Rossum57102f82002-11-13 16:15:58 +00001006 self.host = host
1007 self.url = url
1008 self.method = method
Vinay Sajipaf9d10a2010-09-13 20:40:30 +00001009 self.secure = secure
1010 self.credentials = credentials
Guido van Rossum57102f82002-11-13 16:15:58 +00001011
Neal Norwitzf297bd12003-04-23 03:49:43 +00001012 def mapLogRecord(self, record):
1013 """
1014 Default implementation of mapping the log record into a dict
Vinay Sajip48cfe382004-02-20 13:17:27 +00001015 that is sent as the CGI data. Overwrite in your class.
Vinay Sajipaf9d10a2010-09-13 20:40:30 +00001016 Contributed by Franz Glasner.
Neal Norwitzf297bd12003-04-23 03:49:43 +00001017 """
1018 return record.__dict__
1019
Guido van Rossum57102f82002-11-13 16:15:58 +00001020 def emit(self, record):
1021 """
1022 Emit a record.
1023
Senthil Kumaran30e86a42010-08-09 20:01:35 +00001024 Send the record to the Web server as a percent-encoded dictionary
Guido van Rossum57102f82002-11-13 16:15:58 +00001025 """
1026 try:
Georg Brandl029986a2008-06-23 11:44:14 +00001027 import http.client, urllib.parse
Vinay Sajipb7935062005-10-11 13:15:31 +00001028 host = self.host
Vinay Sajipaf9d10a2010-09-13 20:40:30 +00001029 if self.secure:
1030 h = http.client.HTTPSConnection(host)
1031 else:
1032 h = http.client.HTTPConnection(host)
Guido van Rossum57102f82002-11-13 16:15:58 +00001033 url = self.url
Georg Brandl029986a2008-06-23 11:44:14 +00001034 data = urllib.parse.urlencode(self.mapLogRecord(record))
Guido van Rossum57102f82002-11-13 16:15:58 +00001035 if self.method == "GET":
Neal Norwitz9d72bb42007-04-17 08:48:32 +00001036 if (url.find('?') >= 0):
Guido van Rossum57102f82002-11-13 16:15:58 +00001037 sep = '&'
1038 else:
1039 sep = '?'
1040 url = url + "%c%s" % (sep, data)
1041 h.putrequest(self.method, url)
Vinay Sajipb7935062005-10-11 13:15:31 +00001042 # support multiple hosts on one IP address...
1043 # need to strip optional :port from host, if present
Neal Norwitz9d72bb42007-04-17 08:48:32 +00001044 i = host.find(":")
Vinay Sajipb7935062005-10-11 13:15:31 +00001045 if i >= 0:
1046 host = host[:i]
1047 h.putheader("Host", host)
Guido van Rossum57102f82002-11-13 16:15:58 +00001048 if self.method == "POST":
Vinay Sajipb7935062005-10-11 13:15:31 +00001049 h.putheader("Content-type",
1050 "application/x-www-form-urlencoded")
Guido van Rossum57102f82002-11-13 16:15:58 +00001051 h.putheader("Content-length", str(len(data)))
Vinay Sajipaf9d10a2010-09-13 20:40:30 +00001052 if self.credentials:
1053 import base64
1054 s = ('u%s:%s' % self.credentials).encode('utf-8')
1055 s = 'Basic ' + base64.b64encode(s).strip()
1056 h.putheader('Authorization', s)
Vinay Sajip0372e102011-05-05 12:59:14 +01001057 h.endheaders()
1058 if self.method == "POST":
1059 h.send(data.encode('utf-8'))
Vinay Sajipaf9d10a2010-09-13 20:40:30 +00001060 h.getresponse() #can't do anything with the result
Vinay Sajip985ef872011-04-26 19:34:04 +01001061 except (KeyboardInterrupt, SystemExit): #pragma: no cover
Vinay Sajip245a5ab2005-10-31 14:27:01 +00001062 raise
Guido van Rossum57102f82002-11-13 16:15:58 +00001063 except:
Neal Norwitz6fa635d2003-02-18 14:20:07 +00001064 self.handleError(record)
Guido van Rossum57102f82002-11-13 16:15:58 +00001065
1066class BufferingHandler(logging.Handler):
1067 """
1068 A handler class which buffers logging records in memory. Whenever each
1069 record is added to the buffer, a check is made to see if the buffer should
1070 be flushed. If it should, then flush() is expected to do what's needed.
1071 """
1072 def __init__(self, capacity):
1073 """
1074 Initialize the handler with the buffer size.
1075 """
1076 logging.Handler.__init__(self)
1077 self.capacity = capacity
1078 self.buffer = []
1079
1080 def shouldFlush(self, record):
1081 """
1082 Should the handler flush its buffer?
1083
1084 Returns true if the buffer is up to capacity. This method can be
1085 overridden to implement custom flushing strategies.
1086 """
1087 return (len(self.buffer) >= self.capacity)
1088
1089 def emit(self, record):
1090 """
1091 Emit a record.
1092
1093 Append the record. If shouldFlush() tells us to, call flush() to process
1094 the buffer.
1095 """
1096 self.buffer.append(record)
1097 if self.shouldFlush(record):
1098 self.flush()
1099
1100 def flush(self):
1101 """
1102 Override to implement custom flushing behaviour.
1103
1104 This version just zaps the buffer to empty.
1105 """
1106 self.buffer = []
1107
Vinay Sajipf42d95e2004-02-21 22:14:34 +00001108 def close(self):
1109 """
1110 Close the handler.
1111
1112 This version just flushes and chains to the parent class' close().
1113 """
1114 self.flush()
1115 logging.Handler.close(self)
1116
Guido van Rossum57102f82002-11-13 16:15:58 +00001117class MemoryHandler(BufferingHandler):
1118 """
1119 A handler class which buffers logging records in memory, periodically
1120 flushing them to a target handler. Flushing occurs whenever the buffer
1121 is full, or when an event of a certain severity or greater is seen.
1122 """
1123 def __init__(self, capacity, flushLevel=logging.ERROR, target=None):
1124 """
1125 Initialize the handler with the buffer size, the level at which
1126 flushing should occur and an optional target.
1127
1128 Note that without a target being set either here or via setTarget(),
1129 a MemoryHandler is no use to anyone!
1130 """
1131 BufferingHandler.__init__(self, capacity)
1132 self.flushLevel = flushLevel
1133 self.target = target
1134
1135 def shouldFlush(self, record):
1136 """
1137 Check for buffer full or a record at the flushLevel or higher.
1138 """
1139 return (len(self.buffer) >= self.capacity) or \
1140 (record.levelno >= self.flushLevel)
1141
1142 def setTarget(self, target):
1143 """
1144 Set the target handler for this handler.
1145 """
1146 self.target = target
1147
1148 def flush(self):
1149 """
1150 For a MemoryHandler, flushing means just sending the buffered
1151 records to the target, if there is one. Override if you want
1152 different behaviour.
Vinay Sajipc84f0162010-09-21 11:25:39 +00001153
1154 The record buffer is also cleared by this operation.
Guido van Rossum57102f82002-11-13 16:15:58 +00001155 """
1156 if self.target:
1157 for record in self.buffer:
1158 self.target.handle(record)
1159 self.buffer = []
1160
1161 def close(self):
1162 """
1163 Flush, set the target to None and lose the buffer.
1164 """
1165 self.flush()
1166 self.target = None
Vinay Sajip48cfe382004-02-20 13:17:27 +00001167 BufferingHandler.close(self)
Vinay Sajip121a1c42010-09-08 10:46:15 +00001168
1169
1170class QueueHandler(logging.Handler):
1171 """
1172 This handler sends events to a queue. Typically, it would be used together
1173 with a multiprocessing Queue to centralise logging to file in one process
1174 (in a multi-process application), so as to avoid file write contention
1175 between processes.
1176
1177 This code is new in Python 3.2, but this class can be copy pasted into
1178 user code for use with earlier Python versions.
1179 """
1180
1181 def __init__(self, queue):
1182 """
1183 Initialise an instance, using the passed queue.
1184 """
1185 logging.Handler.__init__(self)
1186 self.queue = queue
1187
1188 def enqueue(self, record):
1189 """
1190 Enqueue a record.
1191
1192 The base implementation uses put_nowait. You may want to override
1193 this method if you want to use blocking, timeouts or custom queue
1194 implementations.
1195 """
1196 self.queue.put_nowait(record)
1197
Vinay Sajip0258ce82010-09-22 20:34:53 +00001198 def prepare(self, record):
1199 """
Vinay Sajip0637d492010-09-23 08:15:54 +00001200 Prepares a record for queuing. The object returned by this method is
1201 enqueued.
Vinay Sajip0258ce82010-09-22 20:34:53 +00001202
1203 The base implementation formats the record to merge the message
1204 and arguments, and removes unpickleable items from the record
1205 in-place.
1206
1207 You might want to override this method if you want to convert
1208 the record to a dict or JSON string, or send a modified copy
1209 of the record while leaving the original intact.
1210 """
1211 # The format operation gets traceback text into record.exc_text
1212 # (if there's exception data), and also puts the message into
1213 # record.message. We can then use this to replace the original
1214 # msg + args, as these might be unpickleable. We also zap the
1215 # exc_info attribute, as it's no longer needed and, if not None,
1216 # will typically not be pickleable.
1217 self.format(record)
1218 record.msg = record.message
1219 record.args = None
1220 record.exc_info = None
1221 return record
1222
Vinay Sajip121a1c42010-09-08 10:46:15 +00001223 def emit(self, record):
1224 """
1225 Emit a record.
1226
Vinay Sajip0637d492010-09-23 08:15:54 +00001227 Writes the LogRecord to the queue, preparing it for pickling first.
Vinay Sajip121a1c42010-09-08 10:46:15 +00001228 """
1229 try:
Vinay Sajip0258ce82010-09-22 20:34:53 +00001230 self.enqueue(self.prepare(record))
Vinay Sajip985ef872011-04-26 19:34:04 +01001231 except (KeyboardInterrupt, SystemExit): #pragma: no cover
Vinay Sajip121a1c42010-09-08 10:46:15 +00001232 raise
1233 except:
1234 self.handleError(record)
Vinay Sajip0637d492010-09-23 08:15:54 +00001235
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001236if threading:
1237 class QueueListener(object):
1238 """
1239 This class implements an internal threaded listener which watches for
1240 LogRecords being added to a queue, removes them and passes them to a
1241 list of handlers for processing.
1242 """
1243 _sentinel = None
Vinay Sajip0637d492010-09-23 08:15:54 +00001244
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001245 def __init__(self, queue, *handlers):
1246 """
1247 Initialise an instance with the specified queue and
1248 handlers.
1249 """
1250 self.queue = queue
1251 self.handlers = handlers
1252 self._stop = threading.Event()
1253 self._thread = None
Vinay Sajip0637d492010-09-23 08:15:54 +00001254
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001255 def dequeue(self, block):
1256 """
1257 Dequeue a record and return it, optionally blocking.
Vinay Sajip0637d492010-09-23 08:15:54 +00001258
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001259 The base implementation uses get. You may want to override this method
1260 if you want to use timeouts or work with custom queue implementations.
1261 """
1262 return self.queue.get(block)
Vinay Sajip0637d492010-09-23 08:15:54 +00001263
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001264 def start(self):
1265 """
1266 Start the listener.
Vinay Sajip0637d492010-09-23 08:15:54 +00001267
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001268 This starts up a background thread to monitor the queue for
1269 LogRecords to process.
1270 """
1271 self._thread = t = threading.Thread(target=self._monitor)
1272 t.setDaemon(True)
1273 t.start()
Vinay Sajip0637d492010-09-23 08:15:54 +00001274
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001275 def prepare(self , record):
1276 """
1277 Prepare a record for handling.
Vinay Sajip0637d492010-09-23 08:15:54 +00001278
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001279 This method just returns the passed-in record. You may want to
1280 override this method if you need to do any custom marshalling or
1281 manipulation of the record before passing it to the handlers.
1282 """
1283 return record
Vinay Sajip0637d492010-09-23 08:15:54 +00001284
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001285 def handle(self, record):
1286 """
1287 Handle a record.
Vinay Sajip0637d492010-09-23 08:15:54 +00001288
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001289 This just loops through the handlers offering them the record
1290 to handle.
1291 """
1292 record = self.prepare(record)
1293 for handler in self.handlers:
1294 handler.handle(record)
Vinay Sajip0637d492010-09-23 08:15:54 +00001295
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001296 def _monitor(self):
1297 """
1298 Monitor the queue for records, and ask the handler
1299 to deal with them.
Vinay Sajip0637d492010-09-23 08:15:54 +00001300
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001301 This method runs on a separate, internal thread.
1302 The thread will terminate if it sees a sentinel object in the queue.
1303 """
1304 q = self.queue
1305 has_task_done = hasattr(q, 'task_done')
1306 while not self._stop.isSet():
1307 try:
1308 record = self.dequeue(True)
1309 if record is self._sentinel:
1310 break
1311 self.handle(record)
1312 if has_task_done:
1313 q.task_done()
1314 except queue.Empty:
1315 pass
1316 # There might still be records in the queue.
1317 while True:
1318 try:
1319 record = self.dequeue(False)
1320 if record is self._sentinel:
1321 break
1322 self.handle(record)
1323 if has_task_done:
1324 q.task_done()
1325 except queue.Empty:
Vinay Sajip0637d492010-09-23 08:15:54 +00001326 break
Vinay Sajip0637d492010-09-23 08:15:54 +00001327
Victor Stinner59bec362011-05-02 16:14:16 +02001328 def enqueue_sentinel(self):
1329 """
1330 This is used to enqueue the sentinel record.
Vinay Sajipaa7c1792011-02-25 15:56:55 +00001331
Victor Stinner59bec362011-05-02 16:14:16 +02001332 The base implementation uses put_nowait. You may want to override this
1333 method if you want to use timeouts or work with custom queue
1334 implementations.
1335 """
1336 self.queue.put_nowait(self._sentinel)
Vinay Sajipaa7c1792011-02-25 15:56:55 +00001337
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001338 def stop(self):
1339 """
1340 Stop the listener.
Vinay Sajip0637d492010-09-23 08:15:54 +00001341
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001342 This asks the thread to terminate, and then waits for it to do so.
1343 Note that if you don't call this before your application exits, there
1344 may be some records still left on the queue, which won't be processed.
1345 """
1346 self._stop.set()
Victor Stinner59bec362011-05-02 16:14:16 +02001347 self.enqueue_sentinel()
Victor Stinnercafa2ef2011-05-02 16:11:28 +02001348 self._thread.join()
1349 self._thread = None