diff options
| author | Richard van der Hoff <richard@matrix.org> | 2018-01-12 00:27:14 +0000 |
|---|---|---|
| committer | Richard van der Hoff <richard@matrix.org> | 2018-01-16 17:23:32 +0000 |
| commit | 3d12d97415ac6d6a4ab8188af31c7df12c5d19f8 (patch) | |
| tree | f1fdd0749715818986f82aa89e8887cd53940b12 /synapse/http/site.py | |
| parent | Merge branch 'rav/db_txn_time_in_millis' into rav/track_db_scheduling (diff) | |
| download | synapse-3d12d97415ac6d6a4ab8188af31c7df12c5d19f8.tar.xz | |
Track DB scheduling delay per-request
For each request, track the amount of time spent waiting for a db connection. This entails adding it to the LoggingContext and we may as well add metrics for it while we are passing.
Diffstat (limited to 'synapse/http/site.py')
| -rw-r--r-- | synapse/http/site.py | 4 |
1 files changed, 3 insertions, 1 deletions
diff --git a/synapse/http/site.py b/synapse/http/site.py index dc64f0f6f5..e422c8dfae 100644 --- a/synapse/http/site.py +++ b/synapse/http/site.py @@ -67,13 +67,14 @@ class SynapseRequest(Request): ru_utime, ru_stime = context.get_resource_usage() db_txn_count = context.db_txn_count db_txn_duration_ms = context.db_txn_duration_ms + db_sched_duration_ms = context.db_sched_duration_ms except Exception: ru_utime, ru_stime = (0, 0) db_txn_count, db_txn_duration_ms = (0, 0) self.site.access_logger.info( "%s - %s - {%s}" - " Processed request: %dms (%dms, %dms) (%dms/%d)" + " Processed request: %dms (%dms, %dms) (%dms/%dms/%d)" " %sB %s \"%s %s %s\" \"%s\"", self.getClientIP(), self.site.site_tag, @@ -81,6 +82,7 @@ class SynapseRequest(Request): int(time.time() * 1000) - self.start_time, int(ru_utime * 1000), int(ru_stime * 1000), + db_sched_duration_ms, db_txn_duration_ms, int(db_txn_count), self.sentLength, |