log query fetch time (apache#6033)

graceguo-supercat · Oct 4, 2018 · e12d00a · e12d00a
1 parent ab5c910
commit e12d00a
Showing 1 changed file with 5 additions and 1 deletion.
diff --git a/superset/sql_lab.py b/superset/sql_lab.py
@@ -186,10 +186,14 @@ def handle_error(msg):
         logging.info('Handling cursor')
         db_engine_spec.handle_cursor(cursor, query, session)
         logging.info('Fetching data: {}'.format(query.to_dict()))
-        data = db_engine_spec.fetch_data(cursor, query.limit)
         stats_logger.timing(
             'sqllab.query.time_executing_query',
             now_as_float() - query_start_time)
+        fetching_start_time = now_as_float()
+        data = db_engine_spec.fetch_data(cursor, query.limit)
+        stats_logger.timing(
+            'sqllab.query.time_fetching_results',
+            now_as_float() - fetching_start_time)
     except SoftTimeLimitExceeded as e:
         logging.exception(e)
         if conn is not None: