Logging 之root 打印器来捣乱

 先上解决方案：（来自：https://blog.csdn.net/xuan_010/article/details/118566749 ）

loger = logging.getLogger(name)
loger.propagate = False

 原因：

1、依据logging包官方的注释，日志记录会向上传播到他的父节点也就是root logger
2、当root logger 同时也被添加了屏幕输出handler的情况，日志就会输出第二次

3、root logger 若被多次添加屏幕输出handler，同一日志就会多次输出。

另外：如果有一个专门用来创建新loger对象的函数（例如 def newLoger(name):），那么要注意避免root 多次addHandler。（可以通过判断语句，在root 添加 handler之前就直接return。）

或者handler尽量不要写在函数里面，可以在函数外层创建一个全局变量保存handler，避免每次调用newLoger()都创建一个新的handler对象，造成root 添加了很多个hanlder。（root 多次add同一个handler是不会拥有多个handler的，但add不同的handler就会拥有多个handler）

验证：

import logging,sys,os
def newLoger(name):
    loger = logging.getLogger(name)
    loger.setLevel(logging.INFO)
    logging_format = logging.Formatter("[%(name)s][%(asctime)s]: %(message)s","%H:%M:%S")   # "%Y-%m-%d %H:%M:%S"

    handler = logging.StreamHandler(sys.stdout)
    handler.setFormatter(logging_format)
    loger.addHandler(handler)

    return loger

rootLoger = logging.getLogger()
print(f'rootLoger 的 handler 数量：{len(rootLoger.handlers)}')

tom =newLoger('')      # 此时变量tom指向[root loger], 然后给[root Loger]添加了一个handler
print(f'root 的 handler 数量：{len(rootLoger.handlers)}')

tom =newLoger('tom')    # 此时变量tom指向一个名为tom的loger, 而[root loger]没有变化
print(f'root 的 handler 数量：{len(rootLoger.handlers)}')

jack =newLoger('')      # 此时变量jack指向[root loger], 然后给[root Loger]添加了一个handler
print(f'tom 的 handler 数量：{len(tom.handlers)}')
print(f'root 的 handler 数量：{len(rootLoger.handlers)}')

jack =newLoger('jack')      # 此时变量tom指向一个名为tom的loger, 而[root loger]没有变化
print(f'tom 的 handler 数量：{len(tom.handlers)}')
print(f'jack 的 handler 数量：{len(tom.handlers)}')
print(f'root 的 handler 数量：{len(rootLoger.handlers)}')

折腾过程：

代码中要对多个用户的资料进行管理。为了让每个用户单独一个日志文件。使用了logging 。

在屏幕输出的时候却遇到怪异的情况：每引用一次root logger【根打印器】之后，所有打印器的输出都会增加一个重复。（创建logger时没有指定名字 logger = logging.getLogger()，就会返回root loger ，参见:Python 日志打印之logging.getLogger源码分析 - 授客 - 博客园）

感觉就是 logger = logging.getLogger() 不是简单的返回root loger，而是创建一个新的root loger，经过多次  logger = logging.getLogger() 后，内存里面就有很多个 root logger。并且当有名字的logger输出的时候，这些root logger全部都一并跑出来也输出一番。

import logging,sys,os
import time

def newLoger(name):
    loger = logging.getLogger(name)
    loger.setLevel(logging.INFO)
    logging_format = logging.Formatter("[%(name)s][%(asctime)s]: %(message)s","%H:%M:%S")   # "%Y-%m-%d %H:%M:%S"

    handler = logging.StreamHandler(sys.stdout)     # 屏幕输出log
    handler.setFormatter(logging_format)
    loger.addHandler(handler)

    return loger

class Player:

    def __init__(self,account):
        self.account: str = account
        self.log = newLoger(self.account)

    def hi(self):
        self.log.info(f'hi,{self.log.name}')
        time.sleep(1)



tom = Player('tom')
tom.hi()

jack = Player('')
jack.hi()

jack = Player('jack')
jack.hi()

mike = Player('')
mike.hi()

tom.hi()

输出：

===================

以下摘自 关于logging的那些坑_weixin_30888413的博客-CSDN博客

任何自定义的logger对象都是rootLogger的子对象，

而当你使用自定义的logger记录日志的时候，它会从子到父，依次执行所有的handler来输出，