python 日志记录 - 消息未显示在 child 中

Question

我在使用 python 的日志记录时遇到了一些困难。我有两个文件，main.py 和 mymodule.py。通常运行 main.py，它会导入 mymodule.py 并使用那里的一些函数。但有时，我会直接运行 mymodule.py。

我试图让它只在 1 个位置配置日志记录，但似乎有问题。

这是代码。

# main.py
import logging
import mymodule

logger = logging.getLogger(__name__)

def setup_logging():
    # only cofnigure logger if script is main module
    # configuring logger in multiple places is bad
    # only top-level module should configure logger
    if not len(logger.handlers):
        logger.setLevel(logging.DEBUG)
        # create console handler with a higher log level
        ch = logging.StreamHandler()
        ch.setLevel(logging.DEBUG)
        formatter = logging.Formatter('%(levelname)s: %(asctime)s %(funcName)s(%(lineno)d) -- %(message)s', datefmt = '%Y-%m-%d %H:%M:%S')
        ch.setFormatter(formatter)
        logger.addHandler(ch)

if __name__ == '__main__':
    setup_logging()
    logger.info('calling mymodule.myfunc()')
    mymodule.myfunc()

和导入的模块:

# mymodule.py
import logging

logger = logging.getLogger(__name__)

def myfunc():
    msg = 'myfunc is being called'
    logger.info(msg)
    print('done with myfunc')


if __name__ == '__main__':
     # only cofnigure logger if script is main module
    # configuring logger in multiple places is bad
    # only top-level module should configure logger
    if not len(logger.handlers):
        logger.setLevel(logging.DEBUG)
        # create console handler with a higher log level
        ch = logging.StreamHandler()
        ch.setLevel(logging.DEBUG)
        formatter = logging.Formatter('%(levelname)s: %(asctime)s %(funcName)s(%(lineno)d) -- %(message)s', datefmt = '%Y-%m-%d %H:%M:%S')
        ch.setFormatter(formatter)
        logger.addHandler(ch)
    logger.info('myfunc was executed directly')
    myfunc()

当我运行代码时，我看到了这个输出:

$>python main.py
INFO: 2016-07-14 18:13:04 <module>(22) -- calling mymodule.myfunc()
done with myfunc

但我希望看到这个:

$>python main.py
INFO: 2016-07-14 18:13:04 <module>(22) -- calling mymodule.myfunc()
INFO: 2016-07-14 18:15:09 myfunc(8) -- myfunc is being called
done with myfunc

有人知道为什么第二个 logging.info 调用没有打印到屏幕吗？提前致谢!

Answer 1

记录器存在于层次结构中，根记录器(使用 logging.getLogger() 检索，无参数)位于顶部。每个记录器都从其父项继承配置，记录器本身的任何配置都会覆盖继承的配置。在这种情况下，您从不配置根记录器，只配置 main.py 中的特定于模块的记录器。因此，从未配置 mymodule.py 中的特定于模块的记录器。

最简单的修复可能是在 main.py 中使用 logging.basicConfig 来设置您希望由 所有 记录器共享的选项。 p>