Add log for elapsed time for processing query.

irrdnet · Jan 22, 2019 · ede8b3d · ede8b3d
1 parent b0ae50f
commit ede8b3d
Showing 1 changed file with 5 additions and 0 deletions.
diff --git a/irrd/server/whois/query_pipeline.py b/irrd/server/whois/query_pipeline.py
@@ -1,3 +1,5 @@
+import time
+
 import logging
 import queue
 import threading
@@ -79,6 +81,7 @@ def _fetch_process_query(self) -> None:
         except queue.Empty:
             return
 
+        start_time = time.perf_counter()
         query = query_bytes.decode('utf-8', errors='backslashreplace').strip()
 
         if not query:
@@ -96,6 +99,8 @@ def _fetch_process_query(self) -> None:
         self.ready_to_send_result.wait()
         self.ready_to_send_result.clear()
         self.response_callback(response.generate_response().encode('utf-8'))
+        elapsed = time.perf_counter() - start_time
+        logger.info(f'{self.peer_str}: sent answer to query, elapsed {elapsed}s: {query}')
 
     def ready_for_next_result(self) -> None:
         """