Journalisation Python: utilisez des millisecondes au format horaire

Par défaut, logging.Formatter('%(asctime)s')imprime avec le format suivant:

2011-06-09 10:54:40,638

où 638 est la milliseconde. J'ai besoin de changer la virgule en point:

2011-06-09 10:54:40.638

Pour formater l'heure que je peux utiliser:

logging.Formatter(fmt='%(asctime)s',datestr=date_format_str)

cependant la documentation ne spécifie pas comment formater les millisecondes. J'ai trouvé cette question SO qui parle de microsecondes, mais a) je préférerais les millisecondes et b) ce qui suit ne fonctionne pas sur Python 2.6 (sur lequel je travaille) en raison de %f:

logging.Formatter(fmt='%(asctime)s',datefmt='%Y-%m-%d,%H:%M:%S.%f')

Veuillez noter que la solution de Craig McDaniel est clairement meilleure.

La formatTimeméthode de Formatter ressemble à ceci:

def formatTime(self, record, datefmt=None):
    ct = self.converter(record.created)
    if datefmt:
        s = time.strftime(datefmt, ct)
    else:
        t = time.strftime("%Y-%m-%d %H:%M:%S", ct)
        s = "%s,%03d" % (t, record.msecs)
    return s

Remarquez la virgule "%s,%03d". Cela ne peut pas être résolu en spécifiant un datefmtcar ctest un time.struct_timeet ces objets n'enregistrent pas les millisecondes.

Si nous changeons la définition de ctpour en faire un datetimeobjet au lieu de a struct_time, alors (au moins avec les versions modernes de Python) nous pouvons appeler ct.strftimeet ensuite nous pouvons utiliser %fpour formater les microsecondes:

import logging
import datetime as dt

class MyFormatter(logging.Formatter):
    converter=dt.datetime.fromtimestamp
    def formatTime(self, record, datefmt=None):
        ct = self.converter(record.created)
        if datefmt:
            s = ct.strftime(datefmt)
        else:
            t = ct.strftime("%Y-%m-%d %H:%M:%S")
            s = "%s,%03d" % (t, record.msecs)
        return s

logger = logging.getLogger(__name__)
logger.setLevel(logging.DEBUG)

console = logging.StreamHandler()
logger.addHandler(console)

formatter = MyFormatter(fmt='%(asctime)s %(message)s',datefmt='%Y-%m-%d,%H:%M:%S.%f')
console.setFormatter(formatter)

logger.debug('Jackdaws love my big sphinx of quartz.')
# 2011-06-09,07:12:36.553554 Jackdaws love my big sphinx of quartz.

Ou, pour obtenir des millisecondes, remplacez la virgule par une virgule décimale et omettez l' datefmtargument:

class MyFormatter(logging.Formatter):
    converter=dt.datetime.fromtimestamp
    def formatTime(self, record, datefmt=None):
        ct = self.converter(record.created)
        if datefmt:
            s = ct.strftime(datefmt)
        else:
            t = ct.strftime("%Y-%m-%d %H:%M:%S")
            s = "%s.%03d" % (t, record.msecs)
        return s

...
formatter = MyFormatter(fmt='%(asctime)s %(message)s')
...
logger.debug('Jackdaws love my big sphinx of quartz.')
# 2011-06-09 08:14:38.343 Jackdaws love my big sphinx of quartz.

Cela devrait également fonctionner:

logging.Formatter(fmt='%(asctime)s.%(msecs)03d',datefmt='%Y-%m-%d,%H:%M:%S')

L'ajout de msecs était la meilleure option, merci. Voici mon amendement en utilisant ceci avec Python 3.5.3 dans Blender

import logging
logging.basicConfig(level=logging.DEBUG, format='%(asctime)s.%(msecs)03d %(levelname)s:\t%(message)s', datefmt='%Y-%m-%d %H:%M:%S')
log = logging.getLogger(__name__)
log.info("Logging Info")
log.debug("Logging Debug")

Le moyen le plus simple que j'ai trouvé était de remplacer default_msec_format:

formatter = logging.Formatter('%(asctime)s')
formatter.default_msec_format = '%s.%03d'

Après avoir instancié un, Formatterj'ai généralement défini formatter.converter = gmtime. Donc, pour que la réponse de @ unutbu fonctionne dans ce cas, vous aurez besoin de:

class MyFormatter(logging.Formatter):
    def formatTime(self, record, datefmt=None):
        ct = self.converter(record.created)
        if datefmt:
            s = time.strftime(datefmt, ct)
        else:
            t = time.strftime("%Y-%m-%d %H:%M:%S", ct)
            s = "%s.%03d" % (t, record.msecs)
        return s

Une extension simple qui ne nécessite pas le datetimemodule et qui n'est pas handicapée comme certaines autres solutions consiste à utiliser un simple remplacement de chaîne comme ceci:

import logging
import time

class MyFormatter(logging.Formatter):
    def formatTime(self, record, datefmt=None):
    ct = self.converter(record.created)
    if datefmt:
        if "%F" in datefmt:
            msec = "%03d" % record.msecs
            datefmt = datefmt.replace("%F", msec)
        s = time.strftime(datefmt, ct)
    else:
        t = time.strftime("%Y-%m-%d %H:%M:%S", ct)
        s = "%s,%03d" % (t, record.msecs)
    return s

De cette façon, un format de date peut être écrit comme vous le souhaitez, même en tenant compte des différences de région, en utilisant %Fpendant des millisecondes. Par exemple:

log = logging.getLogger(__name__)
log.setLevel(logging.INFO)

sh = logging.StreamHandler()
log.addHandler(sh)

fm = MyFormatter(fmt='%(asctime)s-%(levelname)s-%(message)s',datefmt='%H:%M:%S.%F')
sh.setFormatter(fm)

log.info("Foo, Bar, Baz")
# 03:26:33.757-INFO-Foo, Bar, Baz

Si vous utilisez la flèche ou si cela ne vous dérange pas d'utiliser la flèche. Vous pouvez remplacer le formatage de l'heure de python par celui de la flèche.

import logging

from arrow.arrow import Arrow


class ArrowTimeFormatter(logging.Formatter):

    def formatTime(self, record, datefmt=None):
        arrow_time = Arrow.fromtimestamp(record.created)

        if datefmt:
            arrow_time = arrow_time.format(datefmt)

        return str(arrow_time)


logger = logging.getLogger(__name__)

default_handler = logging.StreamHandler()
default_handler.setFormatter(ArrowTimeFormatter(
    fmt='%(asctime)s',
    datefmt='YYYY-MM-DD HH:mm:ss.SSS'
))

logger.setLevel(logging.DEBUG)
logger.addHandler(default_handler)

Vous pouvez maintenant utiliser toute la mise en forme de l'heure de la flèche dans l' datefmtattribut.

tl; dr pour les personnes qui recherchent ici une date au format ISO:

datefmt: '% Y-% m-% d% H:% M:% S.% 03d% z'

À partir de maintenant, ce qui suit fonctionne parfaitement avec python 3.

         logging.basicConfig(level=logging.DEBUG,
                     format='%(asctime)s %(levelname)-8s %(message)s',
                     datefmt='%Y/%m/%d %H:%M:%S.%03d',
                     filename=self.log_filepath,
                     filemode='w')

donne la sortie suivante

2020/01/11 18: 51: 19.011 INFO