Python-Protokollierung: Verwenden Sie Millisekunden im Zeitformat

Standardmäßig wird logging.Formatter('%(asctime)s')im folgenden Format gedruckt:

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

wobei 638 die Millisekunde ist. Ich muss das Komma in einen Punkt ändern:

2011-06-09 10:54:40.638

So formatieren Sie die Zeit, die ich verwenden kann:

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

In der Dokumentation wird jedoch nicht angegeben, wie Millisekunden formatiert werden sollen. Ich habe diese SO-Frage gefunden, die sich mit Mikrosekunden befasst, aber a) ich würde Millisekunden bevorzugen und b) das Folgende funktioniert unter Python 2.6 (an dem ich arbeite) nicht, weil %f:

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

Bitte beachten Sie, dass die Lösung von Craig McDaniel deutlich besser ist.

Die formatTimeMethode von logging.Formatter sieht folgendermaßen aus:

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

Beachten Sie das Komma in "%s,%03d". Dies kann nicht durch Angabe von a behoben werden, datefmtda a ctist time.struct_timeund diese Objekte keine Millisekunden aufzeichnen.

Wenn wir die Definition von ändern ct, um es zu einem datetimeObjekt anstelle von a zu machen, können wir struct_time(zumindest bei modernen Versionen von Python) aufrufen ct.strftimeund dann %fMikrosekunden formatieren:

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.

Um Millisekunden zu erhalten, ändern Sie das Komma in einen Dezimalpunkt und lassen Sie das datefmtArgument weg :

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.

Das sollte auch funktionieren:

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

Das Hinzufügen von ms war die bessere Option. Danke. Hier ist meine Änderung, die dies mit Python 3.5.3 in Blender verwendet

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")

Der einfachste Weg, den ich gefunden habe, war das Überschreiben von default_msec_format:

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

Nach dem Instanziieren eines Formattersetze ich normalerweise formatter.converter = gmtime. Damit die Antwort von @ unutbu in diesem Fall funktioniert, benötigen Sie:

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

Eine einfache Erweiterung, die das datetimeModul nicht benötigt und nicht wie einige andere Lösungen behindert ist, besteht darin, einen einfachen String-Ersatz wie folgt zu verwenden:

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

Auf diese Weise kann ein Datumsformat geschrieben werden, wie Sie möchten, auch unter Berücksichtigung von Regionsunterschieden, indem es %Ffür Millisekunden verwendet wird. Beispielsweise:

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

Wenn Sie Pfeil verwenden oder wenn es Ihnen nichts ausmacht, Pfeil zu verwenden. Sie können die Zeitformatierung von Python durch die von Pfeil ersetzen.

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)

Jetzt können Sie die gesamte Zeitformatierung des Pfeils im datefmtAttribut verwenden.

tl; dr für Leute, die hier nach einem ISO-formatierten Datum suchen:

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

Ab sofort funktioniert das Folgende perfekt mit 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')

gibt die folgende Ausgabe

2020/01/11 18: 51: 19.011 INFO