python日志无输出

Fighting-年轻人就该张牙舞爪

已于 2022-05-20 18:03:05 修改

阅读量2k

点赞数 1

分类专栏： Python技术文章标签： python flask 后端 logging

于 2022-03-07 09:56:25 首次发布

本文链接：https://blog.csdn.net/weixin_43380311/article/details/123272353

版权

Python技术专栏收录该内容

102 篇文章 6 订阅

订阅专栏

python logging一场 disabled引发的血案
以fastapi为例，启动用的uvicorn.run()当用户配置了自己日志之后，框架自带的日志就无输出了
这篇文章以两个部分说明原理
第一部分: 伪代码复现场景
 第二部分: uvicorn源码

第一部分: 以下方代码为例复现场景

code

import logging
import logging.config

logging.basicConfig(
    level=logging.DEBUG,
    format="basicConfig:test >> %(asctime)s %(filename)s:%(lineno)d [%(levelname)s] %(message)s"
)

test_logger = logging.getLogger("demo")


def init_logger():
    config = {
        "version": 1,
        "formatters": {
            "simple": {
                "format": "init_logger>> %(asctime)s %(filename)s:%(lineno)d [%(levelname)s] [%(funcName)s] %(message)s"
            }
        },
        "handlers": {
            "console": {
                "class": "logging.StreamHandler",
                "formatter": "simple",
                "level": "DEBUG",
                "stream": "ext://sys.stdout"
            },
            "run": {
                "backupCount": 5,
                "class": "logging.handlers.RotatingFileHandler",
                "encoding": "utf-8",
                "filename": "./run.log",
                "formatter": "simple",
                "level": "DEBUG",
                "maxBytes": 104857600
            }},
        "loggers": {
            "run": {
                "handlers": [
                    "console",
                    "run"
                ],
                "level": "INFO",
                "propagate": False
            }
        },
        "root": {
            "handlers": [
                "console"
            ],
            "level": "DEBUG"
        }
    }

    logging.config.dictConfig(config)
    return logging.getLogger('run')


test_logger.info("test_logger start")

logger = init_logger()
logger.info("用户初始化的日志")
# test_logger.disabled = False
test_logger.info("test_logger end")

输出

如上以上test_logger end无输出，在放开 test_logger.disabled = False 这行注释后，可以正常输出如下

日志的disabled 属性意义在于显示地将隐藏的日志句柄打开，具体的实现原理可以翻看源码。
另外注意一点: 在解开注释之后test_logger.info("test_logger end")这行的输出并没有用test_logger.info("test_logger start")一样的格式，因为用户init_logger配置的formatters覆盖了之前的格式，这个是正常的。

第二部分：uvicorn源码
- site-packages/uvicorn/config.py 这个文件定义了uvicorn自带的日志配置
- site-packages/uvicorn/workers.py 日志实例化在这里，这里的两个日志句柄输出框架的基本打印信息
  
  用户init_logger之后会覆盖掉之前的配置，又因为新的配置没有以上两个配置，遂logging模块会将其的disabled置为True意为隐藏，想要继续输出需要显示的将其置为False