2019-06-24 12:16:18 +00:00
|
|
|
# -*- coding: utf-8 -*-
|
|
|
|
#
|
2019-12-16 08:53:29 +00:00
|
|
|
import logging
|
2023-02-03 04:22:27 +00:00
|
|
|
import re
|
2019-06-24 12:16:18 +00:00
|
|
|
from collections import defaultdict
|
2023-02-03 04:22:27 +00:00
|
|
|
|
2019-06-24 12:16:18 +00:00
|
|
|
from django.conf import settings
|
|
|
|
from django.core.signals import request_finished
|
|
|
|
from django.db import connection
|
2023-02-03 04:22:27 +00:00
|
|
|
from django.db.models.signals import pre_save
|
|
|
|
from django.dispatch import receiver
|
2019-06-24 12:16:18 +00:00
|
|
|
|
2019-12-16 08:53:29 +00:00
|
|
|
from jumpserver.utils import get_current_request
|
2019-06-25 06:32:25 +00:00
|
|
|
from .local import thread_local
|
2019-06-24 12:16:18 +00:00
|
|
|
|
|
|
|
pattern = re.compile(r'FROM `(\w+)`')
|
2019-12-16 08:53:29 +00:00
|
|
|
logger = logging.getLogger("jumpserver.common")
|
2019-06-24 12:16:18 +00:00
|
|
|
|
|
|
|
|
|
|
|
class Counter:
|
|
|
|
def __init__(self):
|
|
|
|
self.counter = 0
|
|
|
|
self.time = 0
|
|
|
|
|
|
|
|
def __gt__(self, other):
|
|
|
|
return self.counter > other.counter
|
|
|
|
|
|
|
|
def __lt__(self, other):
|
|
|
|
return self.counter < other.counter
|
|
|
|
|
|
|
|
def __eq__(self, other):
|
|
|
|
return self.counter == other.counter
|
|
|
|
|
|
|
|
|
2023-02-24 06:33:37 +00:00
|
|
|
def digest_sql_query():
|
2019-06-24 12:16:18 +00:00
|
|
|
queries = connection.queries
|
|
|
|
counters = defaultdict(Counter)
|
2023-01-16 11:02:09 +00:00
|
|
|
table_queries = defaultdict(list)
|
|
|
|
|
2019-06-24 12:16:18 +00:00
|
|
|
for query in queries:
|
2019-10-18 07:05:45 +00:00
|
|
|
if not query['sql'] or not query['sql'].startswith('SELECT'):
|
2019-06-24 12:16:18 +00:00
|
|
|
continue
|
|
|
|
tables = pattern.findall(query['sql'])
|
|
|
|
table_name = ''.join(tables)
|
|
|
|
time = query['time']
|
|
|
|
counters[table_name].counter += 1
|
|
|
|
counters[table_name].time += float(time)
|
|
|
|
counters['total'].counter += 1
|
|
|
|
counters['total'].time += float(time)
|
2023-01-16 11:02:09 +00:00
|
|
|
table_queries[table_name].append(query)
|
2019-06-24 12:16:18 +00:00
|
|
|
|
|
|
|
counters = sorted(counters.items(), key=lambda x: x[1])
|
2019-12-16 08:53:29 +00:00
|
|
|
if not counters:
|
|
|
|
return
|
2023-01-16 11:02:09 +00:00
|
|
|
|
2019-12-16 08:53:29 +00:00
|
|
|
method = 'GET'
|
|
|
|
path = '/Unknown'
|
|
|
|
current_request = get_current_request()
|
|
|
|
if current_request:
|
|
|
|
method = current_request.method
|
|
|
|
path = current_request.get_full_path()
|
2023-01-16 11:02:09 +00:00
|
|
|
|
2023-02-09 12:48:25 +00:00
|
|
|
print(">>> [{}] {}".format(method, path))
|
|
|
|
for table_name, queries in table_queries.items():
|
|
|
|
if table_name.startswith('rbac_') or table_name.startswith('auth_permission'):
|
|
|
|
continue
|
|
|
|
if len(queries) < 3:
|
|
|
|
continue
|
|
|
|
print("- Table: {}".format(table_name))
|
|
|
|
for i, query in enumerate(queries, 1):
|
|
|
|
sql = query['sql']
|
|
|
|
if not sql or not sql.startswith('SELECT'):
|
|
|
|
continue
|
|
|
|
print('\t{}. {}'.format(i, sql))
|
2023-01-16 11:02:09 +00:00
|
|
|
|
2023-02-07 08:21:26 +00:00
|
|
|
logger.debug(">>> [{}] {}".format(method, path))
|
|
|
|
for name, counter in counters:
|
|
|
|
logger.debug("Query {:3} times using {:.2f}s {}".format(
|
|
|
|
counter.counter, counter.time, name)
|
|
|
|
)
|
|
|
|
|
2023-02-24 06:33:37 +00:00
|
|
|
|
|
|
|
def on_request_finished_logging_db_query(sender, **kwargs):
|
|
|
|
digest_sql_query()
|
2023-01-16 11:02:09 +00:00
|
|
|
on_request_finished_release_local(sender, **kwargs)
|
|
|
|
|
2019-06-24 12:16:18 +00:00
|
|
|
|
2019-06-25 06:32:25 +00:00
|
|
|
def on_request_finished_release_local(sender, **kwargs):
|
|
|
|
thread_local.__release_local__()
|
|
|
|
|
|
|
|
|
2023-02-03 04:22:27 +00:00
|
|
|
def _get_request_user_name():
|
|
|
|
user_name = 'System'
|
|
|
|
current_request = get_current_request()
|
|
|
|
if current_request and current_request.user.is_authenticated:
|
|
|
|
user_name = current_request.user.name
|
|
|
|
if isinstance(user_name, str):
|
|
|
|
user_name = user_name[:30]
|
|
|
|
return user_name
|
|
|
|
|
|
|
|
|
|
|
|
@receiver(pre_save)
|
|
|
|
def on_create_set_created_by(sender, instance=None, **kwargs):
|
|
|
|
if getattr(instance, '_ignore_auto_created_by', False):
|
|
|
|
return
|
|
|
|
if not hasattr(instance, 'created_by') or instance.created_by:
|
|
|
|
return
|
|
|
|
user_name = _get_request_user_name()
|
|
|
|
instance.created_by = user_name
|
|
|
|
|
|
|
|
|
|
|
|
@receiver(pre_save)
|
|
|
|
def on_update_set_updated_by(sender, instance=None, created=False, **kwargs):
|
|
|
|
if getattr(instance, '_ignore_auto_updated_by', False):
|
|
|
|
return
|
|
|
|
if not hasattr(instance, 'updated_by'):
|
|
|
|
return
|
|
|
|
user_name = _get_request_user_name()
|
|
|
|
instance.updated_by = user_name
|
|
|
|
|
|
|
|
|
2022-06-29 06:48:54 +00:00
|
|
|
if settings.DEBUG_DEV:
|
2019-06-24 12:16:18 +00:00
|
|
|
request_finished.connect(on_request_finished_logging_db_query)
|
2019-12-16 08:53:29 +00:00
|
|
|
else:
|
|
|
|
request_finished.connect(on_request_finished_release_local)
|