Блог

Я только что обнаружил различное поведение ведения журнала Python, в зависимости от того, использую ли я ведение журнала с fileconfig и ведение журнала с programmatic config.

Для демонстрации я создал два минимальных примера.

В первом примере я настраиваю ведение журнала программно. Этот пример работает так, как ожидалось — сообщение журнала отладки выводится на консоль.

 # foo.py
import logging

logger = logging.getLogger(__name__)

class Foo(object):
    def __init__(self):
        logger.debug('debug log from Foo')

##########################################################################
# loggingtest.py
import logging.config

from foo import Foo

if __name__ == '__main__':
    consoleLogger = logging.StreamHandler()
    formatter = logging.Formatter(
        '%(asctime)-6s: %(name)s - %(levelname)s - %(message)s')
    consoleLogger = logging.StreamHandler()
    consoleLogger.setLevel(logging.DEBUG)
    consoleLogger.setFormatter(formatter)

    rootLogger = logging.getLogger() 
    rootLogger.addHandler(consoleLogger)
    rootLogger.setLevel(logging.NOTSET)
    # prints debug log message to console
    foo = Foo()
  

В моем втором примере я настраиваю ведение журнала с помощью fileConfig. Насколько я вижу, файл log-config должен иметь точно такое же поведение. Но все же сообщение журнала отладки в этом примере НЕ напечатано.

 # foo.py (same as above)
import logging

logger = logging.getLogger(__name__)

class Foo(object):
    def __init__(self):
        logger.debug('debug log from Foo')
##########################################################################
# loggingtest.py
import logging.config

from foo import Foo

if __name__ == '__main__':
    logging.config.fileConfig('logging.cfg')    

    # does NOT print debug log message to console. WHY???
    foo = Foo()

##########################################################################
# logging.cfg
[loggers]
keys = root

[logger_root]
level = NOTSET
handlers = consoleHandler

[formatters]
keys = complex

[formatter_complex]
format = %(asctime)s - %(name)s - %(levelname)s - %(module)s : %(lineno)d - %(message)s

[handlers]
keys = consoleHandler

[handler_consoleHandler]
class=StreamHandler
level=DEBUG
formatter=complex
args=(sys.stdout,)
  

Итак, почему во втором примере с использованием fileconfig ведения журнала НЕ выводится мое сообщение журнала отладки на консоль?

Поскольку fileConfig по умолчанию отключает существующие регистраторы, вызовите

 logging.config.fileConfig("logging.cfg")
  

перед

 from foo import Foo
  

или вызовите

 logging.config.fileConfig("logging.cfg",disable_existing_loggers=0)