淺析python日志重復輸出問題

問題起源：

在學習了python的函數式編程后，又接觸到了logging這樣一個強大的日志模塊。為了減少重復代碼，應該不少同學和我一樣便迫不及待的寫了一個自己的日志函數，比如下面這樣：

import logging# 這里為了便于理解，簡單的展示了一個輸出到屏幕的日志函數 def my_log():logger = logging.getLogger('mysql.log')ch = logging.StreamHandler()ch.setLevel(logging.ERROR)fmt = logging.Formatter('%(asctime)s - %(name)s - %(levelname)s - %(message)s')ch.setFormatter(fmt)logger.addHandler(ch)return loggermy_log().error('run one') my_log().error('run two') my_log().error('run three')

函數寫好了，看起來似乎也沒有問題，我們來運行一下！

結果如下：

2018-06-21 13:06:37,569 - mysql.log - ERROR - run one2018-06-21 13:06:37,569 - mysql.log - ERROR - run two2018-06-21 13:06:37,569 - mysql.log - ERROR - run two2018-06-21 13:06:37,569 - mysql.log - ERROR - run three2018-06-21 13:06:37,569 - mysql.log - ERROR - run three2018-06-21 13:06:37,569 - mysql.log - ERROR - run three

日志居然重復輸出了，且數量遞增。

問題解析

• 實際上logger = logging.getLogger('mysql.log')在執行時，沒有每次生成一個新的logger，而是先檢查內存中是否存在一個叫做‘mysql.log’的logger對象，存在則取出，不存在則新建。
• 實例化的logger對象具有‘handlers’這樣一個屬性來存儲 Handler，代碼演示如下：

''' 遇到問題沒人解答？小編創建了一個Python學習交流QQ群：857662006 尋找有志同道合的小伙伴，互幫互助,群里還有不錯的視頻學習教程和PDF電子書！ ''' import loggingdef my_log():logger = logging.getLogger('mysql.log')# 每次被調用后打印出logger的handlers列表print(logger.handlers)ch = logging.StreamHandler()ch.setLevel(logging.ERROR)fmt = logging.Formatter('%(asctime)s - %(name)s - %(levelname)s - %(message)s')ch.setFormatter(fmt)logger.addHandler(ch)return loggermy_log().error('run one') my_log().error('run two') my_log().error('run three')

運行結果：

[]2018-06-21 13:26:14,059 - mysql.log - ERROR - run one[<StreamHandler <stderr> (ERROR)>]2018-06-21 13:26:14,060 - mysql.log - ERROR - run two2018-06-21 13:26:14,060 - mysql.log - ERROR - run two[<StreamHandler <stderr> (ERROR)>, <StreamHandler <stderr> (ERROR)>]2018-06-21 13:26:14,060 - mysql.log - ERROR - run three2018-06-21 13:26:14,060 - mysql.log - ERROR - run three2018-06-21 13:26:14,060 - mysql.log - ERROR - run three

logger.handlers最初是一個空列表，執行‘logger.addHandler(ch)’添加一個‘StreamHandler’，輸出一條日志

在第二次被調用時，logger.handlers已經存在一個‘StreamHandler’，再次執行‘logger.addHandler(ch)’就會再次添加一個‘StreamHandler’，此時的logger有兩個‘StreamHandler’，輸出兩條重復的日志

在第三次被調用時，logger.handlers已經存在兩個‘StreamHandler’，再次執行‘logger.addHandler(ch)’就會再次添加一個，此時的logger有三個‘StreamHandler’，輸出三條重復的日志

解決辦法

1.改名換姓

''' 遇到問題沒人解答？小編創建了一個Python學習交流QQ群：857662006 尋找有志同道合的小伙伴，互幫互助,群里還有不錯的視頻學習教程和PDF電子書！ ''' import logging# 為日志函數添加一個name，每次調用時傳入不同的日志名 def my_log(name):logger = logging.getLogger(name)ch = logging.StreamHandler()ch.setLevel(logging.ERROR)fmt = logging.Formatter('%(asctime)s - %(name)s - %(levelname)s - %(message)s')ch.setFormatter(fmt)logger.addHandler(ch)return loggermy_log('log1').error('run one') my_log('log2').error('run two') my_log('log3').error('run three')

運行結果：

2018-06-21 13:40:51,685 - log1 - ERROR - run one2018-06-21 13:40:51,685 - log2 - ERROR - run two2018-06-21 13:40:51,685 - log3 - ERROR - run three

2.及時清理（logger.handlers.clear）

import loggingdef my_log():logger = logging.getLogger('mysql.log')# 每次被調用后，清空已經存在handlerlogger.handlers.clear()ch = logging.StreamHandler()ch.setLevel(logging.ERROR)fmt = logging.Formatter('%(asctime)s - %(name)s - %(levelname)s - %(message)s')ch.setFormatter(fmt)logger.addHandler(ch)return loggermy_log().error('run one') my_log().error('run two') my_log().error('run three')

ps：removeHandler方法（兼容性較差）

''' 遇到問題沒人解答？小編創建了一個Python學習交流QQ群：857662006 尋找有志同道合的小伙伴，互幫互助,群里還有不錯的視頻學習教程和PDF電子書！ ''' # 這種寫法下的可以使用removeHandler方法(logger.handlers.clear也可以使用在這種寫法的函數內) import loggingdef my_log(msg):logger = logging.getLogger('mysql.log')ch = logging.StreamHandler()ch.setLevel(logging.ERROR)fmt = logging.Formatter('%(asctime)s - %(name)s - %(levelname)s - %(message)s')ch.setFormatter(fmt)logger.addHandler(ch)logger.error(msg)# 在使用完ch后從移除Handlerlogger.removeHandler(ch)my_log('run one') my_log('run two') my_log('run three')

3.用前判斷

import loggingdef my_log():logger = logging.getLogger('mysql.log')# 判斷logger是否已經添加過handler，是則直接返回logger對象，否則執行handler設定以及addHandler(ch)if not logger.handlers:ch = logging.StreamHandler()ch.setLevel(logging.ERROR)fmt = logging.Formatter('%(asctime)s - %(name)s - %(levelname)s - %(message)s')ch.setFormatter(fmt)logger.addHandler(ch)return loggermy_log().error('run one') my_log().error('run two') my_log().error('run three')

總結

第一次遇到日志重復輸出問題，那時還沒有學習到面向對象編程的內容，當時并沒有真正理解logging模塊。學習完面向對象編程后，回過頭來再思考這些問題有了豁然開朗的感覺。

比如起初對logging.getLogger的實際原理不是很理解，在學習了面向對象編程中的hasattr、getattr、setattr這樣一些方法后就恍然大悟了。所以諸君如果現在還是對logging模塊不太理解，不妨先不糾結于這些細節，繼續學下去。

總結

以上是生活随笔為你收集整理的python打印log重复问题的全部內容，希望文章能夠幫你解決所遇到的問題。

如果覺得生活随笔網站內容還不錯，歡迎將生活随笔推薦給好友。