python的logging库中TimedRotatingFileHandler类问题

本文主要是介绍python的logging库中TimedRotatingFileHandler类问题，希望对大家解决编程问题提供一定的参考价值，需要的开发者们随着小编来一起学习吧！

原文网址：http://www.5dcode.com/?p=545

第一次用python，第一次用logging，第一次用TimedRotatingFileHandler，居然发现了其中的BUG，记录下吧。

      用TimedRotatingFileHandler的目的是让其自动在日志文件名后面加上日期时间，可以按秒、分、时、天、周或者其倍数来设置，BUG出现的场景是：手动设置时间，并把时间往未来时间调（比如把2012-03-15调成2014-03-15），这时就出问题了，这时产生每条日志后会产生一个日志文件，这并不是我们想要的效果，如果把当前时间再往历史时间调（比如把2012-03-15调成2010-03-15），这时也会产生问题：所有产生的日志都会记录到一个没有日期后缀的文件，并不会按日期分类。如果时间是正确的并按正常的流程走并不会产生问题，所以想看看logging是怎么实现的，看了其源码：C:\Python25\Lib\logging\handlers.py，果然不出所料，它的设计是有问题的，根本不考虑手动调时间或者时间可能不对需要同步的情况：

1. def shouldRollover(self, record):
2.         """
3.         Determine if rollover should occur
4.  
5.         record is not used, as we are just comparing times, but it is needed so
6.         the method siguratures are the same
7.         """
8.         t = int(time.time())
9.         if t >= self.rolloverAt:
10.             return 1
11.         #print "No need to rollover: %d, %d" % (t, self.rolloverAt)
12.         return 0
13.  
14.     def doRollover(self):
15.         """
16.         do a rollover; in this case, a date/time stamp is appended to the filename
17.         when the rollover happens.  However, you want the file to be named for the
18.         start of the interval, not the current time.  If there is a backup count,
19.         then we have to get a list of matching filenames, sort them and remove
20.         the one with the oldest suffix.
21.         """
22.         self.stream.close()
23.         # get the time that this sequence started at and make it a TimeTuple
24.         t = self.rolloverAt - self.interval
25.         timeTuple = time.localtime(t)
26.         dfn = self.baseFilename + "." + time.strftime(self.suffix, timeTuple)
27.         if os.path.exists(dfn):
28.             os.remove(dfn)
29.         os.rename(self.baseFilename, dfn)
30.         if self.backupCount > 0:
31.             # find the oldest log file and delete it
32.             s = glob.glob(self.baseFilename + ".20*")
33.             if len(s) > self.backupCount:
34.                 s.sort()
35.                 os.remove(s[0])
36.         #print "%s -> %s" % (self.baseFilename, dfn)
37.         if self.encoding:
38.             self.stream = codecs.open(self.baseFilename, 'w', self.encoding)
39.         else:
40.             self.stream = open(self.baseFilename, 'w')
41.         self.rolloverAt = self.rolloverAt + self.interval

第9行判断中只判断时间大的情况，并没有判断时间小的情况，第41行中self.rolloverAt永远是上一次的值加上self.interval，如果时间往大的调的话，第9行判断就会永远是True，所以就会产生问题，如果时间往小的调，第9行判断就会永远是False，也会产生问题。上面的python版本是2.5.4，再看最新的版本：3.1，这个版本修复了def doRollover(self)，但并没有修复def shouldRollover(self, record)，所以综合这两个版本的考虑，还是自己来实现吧，修复之后的代码如下（测试成功通过）：

 

1. def shouldRollover(self, record):
2.         """
3.         Determine if rollover should occur
4.  
5.         record is not used, as we are just comparing times, but it is needed so
6.         the method siguratures are the same
7.         """
8.         t = int(time.time())
9.         #print "self.rolloverAt: %d. currentTime: %d." % (self.rolloverAt, t)
10.         #start: recompare slef.rolloverAt, Modify by 5dcode. 2012-03-14 
11.         if t >= self.rolloverAt or t < (self.rolloverAt - self.interval):
12.             return 1
13.         #end: recompare slef.rolloverAt, Modify by 5dcode. 2012-03-14 
14.         #print "No need to rollover: %d, %d" % (t, self.rolloverAt)
15.         return 0
16.  
17.     def doRollover(self):
18.         """
19.         do a rollover; in this case, a date/time stamp is appended to the filename
20.         when the rollover happens.  However, you want the file to be named for the
21.         start of the interval, not the current time.  If there is a backup count,
22.         then we have to get a list of matching filenames, sort them and remove
23.         the one with the oldest suffix.
24.         """
25.         self.stream.close()
26.         # get the time that this sequence started at and make it a TimeTuple
27.         t = self.rolloverAt - self.interval
28.         timeTuple = time.localtime(t)
29.         dfn = self.baseFilename + "." + time.strftime(self.suffix, timeTuple)
30.         if os.path.exists(dfn):
31.             os.remove(dfn)
32.         os.rename(self.baseFilename, dfn)
33.         if self.backupCount > 0:
34.             # find the oldest log file and delete it
35.             s = glob.glob(self.baseFilename + ".20*")
36.             if len(s) > self.backupCount:
37.                 s.sort()
38.                 os.remove(s[0])
39.         #print "%s -> %s" % (self.baseFilename, dfn)
40.         if self.encoding:
41.             self.stream = codecs.open(self.baseFilename, 'w', self.encoding)
42.         else:
43.             self.stream = open(self.baseFilename, 'w')
44.         
45.         #start: recompute self.rolloverAt, Modify by 5dcode. 2012-03-14 
46.         currentTime = int(time.time())
47.         newRolloverAt = currentTime + self.interval
48.         if self.when == 'MIDNIGHT' or self.when.startswith('W'):
49.             # This could be done with less code, but I wanted it to be clear
50.             t = time.localtime(currentTime)
51.             currentHour = t[3]
52.             currentMinute = t[4]
53.             currentSecond = t[5]
54.             # r is the number of seconds left between now and midnight
55.             r = _MIDNIGHT - ((currentHour * 60 + currentMinute) * 60 +
56.                     currentSecond)
57.             newRolloverAt = currentTime + r
59.         #newRolloverAt = self.computeRollover(currentTime)
60.         while newRolloverAt <= currentTime:
61.             newRolloverAt = newRolloverAt + self.interval
62.         #If DST changes and midnight or weekly rollover, adjust for this.
63.         if self.when == 'MIDNIGHT' or self.when.startswith('W'):
64.             dstNow = time.localtime(currentTime)[-1]
65.             dstAtRollover = time.localtime(newRolloverAt)[-1]
66.             if dstNow != dstAtRollover:
67.                 if not dstNow:  # DST kicks in before next rollover, so we need to deduct an hour
68.                     newRolloverAt = newRolloverAt - 3600
69.                 else:           # DST bows out before next rollover, so we need to add an hour
70.                     newRolloverAt = newRolloverAt + 3600
71.         self.rolloverAt = newRolloverAt
72.         #print "self.rolloverAt: %d." % self.rolloverAt
73.         #end: recompute self.rolloverAt, Modify by 5dcode. 2012-03-14

 

 

 

 

这篇关于python的logging库中TimedRotatingFileHandler类问题的文章就介绍到这儿，希望我们推荐的文章对编程师们有所帮助！

---