Python logging 日志等级设置失效：Handler 与 Logger 优先级解析

问题现象：日志等级设置失效

在使用Python的 logging 模块时，开发者常遇到一种情况：明明在代码中设置了日志等级（例如 logger.setLevel("INFO")），但实际运行后发现，低于该等级的日志（如 DEBUG）依然被打印，或者高于该等级的日志（如 WARNING）未被打印。这种现象通常源于对 Logger 和 Handler 之间优先级关系的误解。

以下是一个典型的失效场景。代码中定义了文件处理器（FileHandler）和控制台处理器（StreamHandler），并尝试设置等级，但最终输出结果不符合预期：

console_level = "INFO"
handler_level = "INFO"
handler_file = logging.FileHandler(filename)
handler_file.setFormatter(formatter)
handler_file.setLevel(handler_level)
handler_console = logging.StreamHandler()
handler_console.setFormatter(formatter)
handler_console.setLevel(console_level)
logger = logging.getLogger('myloger')
# logger.setLevel("INFO")
from log import logger
logger.debug("debug---------------")
logger.info("info---------------")
logger.warning("warning---------------")
logger.error("error---------------")
logger.critical("critical---------------")
>>>>> 空 没有打印

在上述代码中，日志输出为空。这通常是因为 logger 实例在导入时（from log import logger）可能已经被其他模块初始化，或者 logger 的默认等级覆盖了后续设置。更关键的是，如果 logger 本身没有设置等级，它将继承父级（通常是根日志 root）的等级（默认为 WARNING）。此时，即使 Handler 设置了 INFO，如果 Logger 的等级高于 INFO，日志仍会被过滤。

核心原因：Handler 与 Logger 的优先级

Python logging 模块的日志过滤遵循一个关键原则：Handler 的优先级高于 Logger。

日志记录的过滤过程分为两步： 1. Logger 检查：日志首先经过 Logger。如果日志等级低于 Logger 设置的等级，记录将被直接丢弃，不会传递给 Handler。 2. Handler 检查：如果日志通过了 Logger 的检查，接着会经过 Handler。如果日志等级低于 Handler 设置的等级，记录将被 Handler 丢弃。

因此，如果 Logger 的等级设置得比 Handler 高（例如 Logger 为 WARNING，Handler 为 INFO），那么 INFO 级别的日志在 Logger 阶段就会被过滤掉，即使 Handler 允许输出 INFO 级别的日志，最终也不会看到任何输出。

解决方案：正确设置 Logger 与 Handler 等级

要解决日志等级设置失效的问题，需要遵循以下最佳实践：

1. Logger 等级设为最低：将 logger.setLevel() 设置为最低等级（如 logging.DEBUG），确保所有日志都能通过 Logger 的检查。
2. Handler 控制具体等级：将具体的日志等级控制交给 Handler。通过 handler.setLevel() 为不同的 Handler 设置不同的等级（例如，文件日志记录 DEBUG，控制台日志仅记录 INFO）。
3. 确保顺序正确：先实例化 Logger，再设置 Handler 及其等级，最后将 Handler 添加到 Logger。

以下是修正后的代码示例：

console_level = "INFO"
handler_level = "INFO"
handler_file = logging.FileHandler(filename)
handler_file.setFormatter(formatter)
handler_file.setLevel(handler_level)
handler_console = logging.StreamHandler()
handler_console.setFormatter(formatter)
handler_console.setLevel(console_level)
logger = logging.getLogger('myloger')
logger.setLevel("INFO")  # 确保 Logger 等级不高于 Handler
# 给logger添加handler
logger.addHandler(handler_file)
from log import logger
fee=3
data={}
data['trade_amount']=100
# logger.info("ddddddddddddddddddddddddddddd")
# logger.info('fee='+ str(fee) + "trade_amount"+ str(data['trade_amount']))
#logger.info('fee=' + "trade_amount"+ data['trade_amount'],)
logger.info('fee ={0}+"trade_amount"'.format(data['trade_amount']))
>>>>
import log start
2020-05-25 15:27:26,286 - log_level.py:17 - fee =100+"trade_amount"
import log end

在修正后的代码中，logger.setLevel("INFO") 被显式设置，并且 Handler 的等级也被设置为 INFO。这样，INFO 级别的日志能够顺利通过 Logger 和 Handler 的双重检查，最终正常输出。

完整配置示例

以下是一个完整的日志配置示例，展示了如何正确设置 Logger 和 Handler 的等级：

print "import log start"
import logging
import datetime
date = datetime.datetime.strftime(datetime.datetime.now(), '%Y%m%d')
filename = date + '.log'
fmt = '%(asctime)s - %(filename)s:%(lineno)s - %(message)s'
formatter = logging.Formatter(fmt)
logger = logging.getLogger('myloger')
logger.setLevel(logging.DEBUG)  # 将 Logger 等级设为最低
console_level = "INFO"
handler_level = "DEBUG"
# logging.basicConfig(level=logging.DEBUG)
handler_file = logging.FileHandler(filename)
handler_file.setFormatter(formatter)
handler_file.setLevel(handler_level)
handler_console = logging.StreamHandler()
handler_console.setFormatter(formatter)
handler_console.setLevel(console_level)
# 给logger添加handler
logger.addHandler(handler_file)
logger.addHandler(handler_console)

在这个示例中，logger.setLevel(logging.DEBUG) 确保了所有日志都能通过 Logger 的检查。然后，通过 handler_file.setLevel(handler_level) 和 handler_console.setLevel(console_level)，分别控制文件和控制台的日志输出等级。这种配置方式能够灵活地控制不同输出渠道的日志等级，避免日志等级设置失效的问题。

总结

Python logging 模块中日志等级设置失效的主要原因是 Handler 的优先级高于 Logger。解决该问题的关键在于将 Logger 的等级设置为最低（如 DEBUG），并将具体的日志等级控制交给 Handler。通过合理配置 Logger 和 Handler 的等级，可以确保日志按预期输出，提高日志管理的灵活性和准确性。

以上就是Python日志模块日志等级设置失效的解决方案的详细内容，更多关于Python日志模块配置的资料请关注本站其它相关文章！