問題起源：

​ 在學習了python的函數語言程式設計後，又接觸到了logging這樣一個強大的日誌模組。為了減少重複程式碼，應該不少同學和我一樣便迫不及待的寫了一個自己的日誌函式，比如下面這樣：

“““python
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 logger
 

my_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 one
2018-06-21 13:06:37,569 - mysql.log - ERROR - run two
2018-06-21 13:06:37,569 - mysql.log - ERROR - run two
2018-06-21 13:06:37,569 - mysql.log - ERROR - run three
2018-06-21 13:06:37,569 - mysql.log - ERROR - run three
2018-06-21 13:06:37,569 - mysql.log - ERROR - run three

日誌居然重複輸出了，且數量遞增。

問題解析

• 實際上logger = logging.getLogger('mysql.log')在執行時，沒有每次生成一個新的logger，而是先檢查記憶體中是否存在一個叫做‘mysql.log’的logger物件，存在則取出，不存在則新建。

• 例項化的logger物件具有‘handlers’這樣一個屬性來儲存 Handler，程式碼演示如下：

“““python
import logging

def 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 logger

my_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
[

解決辦法

1.改名換姓

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 logger


my_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 one
2018-06-21 13:40:51,685 - log2 - ERROR - run two
2018-06-21 13:40:51,685 - log3 - ERROR - run three

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

“““python
import logging

def my_log():
logger = logging.getLogger(‘mysql.log’)
# 每次被呼叫後，清空已經存在handler
logger.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 logger

my_log().error(‘run one’)
my_log().error(‘run two’)
my_log().error(‘run three’)
“““

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

“““python

這種寫法下的可以使用removeHandler方法(logger.handlers.clear也可以使用在這種寫法的函式內)

import logging

def 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後從移除Handler
logger.removeHandler(ch)

my_log(‘run one’)
my_log(‘run two’)
my_log(‘run three’)
“““

3.用前判斷

“““python
import logging

def 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 logger

my_log().error(‘run one’)
my_log().error(‘run two’)
my_log().error(‘run three’)
“““

總結

​ 第一次遇到日誌重複輸出問題，那時還沒有學習到面向物件程式設計的內容，當時並沒有真正理解logging模組。學習完面向物件程式設計後，回過頭來再思考這些問題有了豁然開朗的感覺。

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

​ 知識面擴充後，曾經的一些難題自然就會迎刃而解：）