python - Pytest 日志记录忽略 pytest.ini 中的选项

Question

我有一个正在运行的测试:

pytest --capture=no --verbose --rootdir=testing/ testing/tests/docker_test.py

来自 /home/user/development/。该测试检查某些容器是否正在运行并使用 Python 3.6 的默认日志记录框架。测试文件中的记录器配置如下:

logger = logging.getLogger(__name__)
logger.setLevel(logging.INFO)
logging.basicConfig(level=logging.INFO, stream=sys.stdout, format="%(asctime)s %(levelname)s %(message)s")

内部测试我使用记录器如下:

logger.info(f"TEST SUCCESSFUL: container {container_name} is running")
logger.info(f"TEST SUCCESSFUL: all required containers are running")

在testing(根目录)中我有一个文件pytest.ini:

[pytest]
log_level = INFO
log_cli_level = INFO
log_format = %(asctime)s %(levelname)s %(message)s
log_cli_format = %(asctime)s %(levelname)s %(message)s
log_date_format = %H:%M:%S
log_cli_date_format = %H:%M:%S

基本上我不希望任何日期出现在时间戳中，我希望 pytest 在我运行测试时实时记录到命令行。

首先，我想知道 asctime 代表什么。它看起来像“ascii 时间”。我不需要标准化的时间戳，而是我在 pytest.ini 中描述的格式。这就是为什么我还尝试使用 date、datetime 和 timestamp 而不是 asctime，所有这些都导致了错误。所以我想 asctime 是获取时间戳的唯一方法。

但是，pytest 似乎忽略了我在我的 pytest.ini 文件中设置的所有选项，尽管它表明它在我运行测试时找到了该文件:

cachedir: testing/.pytest_cache
rootdir: /home/user/development/testing, inifile: pytest.ini

如何更改 pytest 日志记录中的时间戳？

Answer 1

我猜你缺少的是 pytest.ini 中的 log_cli = 1(或 true/yes/etc) 。除此之外，根据您提供的配置，日志记录以您在 log_cli_format 中指定的格式打印。您甚至可以将 pytest.ini 缩减为:

[pytest]
log_cli = 1
log_cli_level = INFO
log_cli_format = %(asctime)s %(levelname)s %(message)s
log_cli_date_format = %H:%M:%S

此外，上面的配置将在测试 session 中处理根记录器配置，因此您不需要在测试中为实时记录配置记录器。只需在测试中调用记录器:

import logging

def test_spam():
    logger = logging.getLogger(__name__)
    logger.info('spam')
    logger.warning('eggs')
    logger.error('bacon')

这将打印:

$ pytest
============================== test session starts ================================
platform linux -- Python 3.6.5, pytest-3.4.1, py-1.5.3, pluggy-0.6.0 -- /data/gentoo64/usr/bin/python3.6
cachedir: .pytest_cache
rootdir: /data/gentoo64/home/u0_a82/projects/stackoverflow/so-50677656, inifile: pytest.ini
plugins: mock-1.6.3, cov-2.5.1, flaky-3.4.0
collected 1 item

testing/tests/test_docker.py::test_logs
---------------------------------- live log call ----------------------------------
16:29:12 INFO spam
16:29:13 WARNING eggs
16:29:13 ERROR bacon
PASSED                                                                       [100%]
============================ 1 passed in 1.08 seconds =============================

For one I am wondering what asctime stands for

logging docs对此有点简洁:

Human-readable time when the LogRecord was created. By default this is of the form ‘2003-07-08 16:49:45,896’ (the numbers after the comma are millisecond portion of the time).

但是，asctime 并不意味着记录将始终使用 time.asctime 进行格式化。 - 它只是当您不将自己的日期时间格式传递给 logging.Formatter ( second argument in the formatter constructor ) 时使用的默认日期时间格式。