PostgreSQL
 sql >> Base de données >  >> RDS >> PostgreSQL

Comment puis-je obtenir la journalisation psycopg2 du temps d'exécution des requêtes ?

Assez facile pour définir l'horodatage au début de l'exécution et calculer la durée à la fin. Vous aurez besoin de vos propres sous-classes simples de LoggingConnection et LoggingCursor. Voir mon exemple de code.

Ceci est basé sur la source de MinTimeLoggingConnection que vous pouvez trouver dans psycopg2/extras.py source.

import time
import psycopg2
import psycopg2.extensions
from psycopg2.extras import LoggingConnection, LoggingCursor
import logging

logging.basicConfig(level=logging.DEBUG)
logger = logging.getLogger(__name__)

# MyLoggingCursor simply sets self.timestamp at start of each query                                                                 
class MyLoggingCursor(LoggingCursor):
    def execute(self, query, vars=None):
        self.timestamp = time.time()
        return super(MyLoggingCursor, self).execute(query, vars)

    def callproc(self, procname, vars=None):
        self.timestamp = time.time()
        return super(MyLoggingCursor, self).callproc(procname, vars)

# MyLogging Connection:                                                                                                             
#   a) calls MyLoggingCursor rather than the default                                                                                
#   b) adds resulting execution (+ transport) time via filter()                                                                     
class MyLoggingConnection(LoggingConnection):
    def filter(self, msg, curs):
        return msg + "   %d ms" % int((time.time() - curs.timestamp) * 1000)

    def cursor(self, *args, **kwargs):
        kwargs.setdefault('cursor_factory', MyLoggingCursor)
        return LoggingConnection.cursor(self, *args, **kwargs)

db_settings = {
    ....
}

query_txt = "[query_text_from file]"

conn = psycopg2.connect(connection_factory=MyLoggingConnection, **db_settings)
conn.initialize(logger)

cur = conn.cursor()
cur.execute(query_text)

et vous obtiendrez :

DEBUG: __main__:[query]     3 ms

dans votre filter() vous pouvez modifier la mise en forme ou choisir de ne pas afficher si elle est inférieure à une certaine valeur.