Query takes forever


#1

2016-12-27 16:35:30 +0000] [24754] [INFO] Listening at: http://127.0.0.1:5000 (24754)
[2016-12-27 16:35:30 +0000] [24754] [INFO] Using worker: sync
[2016-12-27 16:35:30 +0000] [24762] [INFO] Booting worker with pid: 24762
[2016-12-27 16:35:31 +0000] [24765] [INFO] Booting worker with pid: 24765
[2016-12-27 16:35:31,104][PID:24762][INFO][requests.packages.urllib3.connectionpool] Starting new HTTP connection (1): metadata.google.internal
[2016-12-27 16:35:31 +0000] [24768] [INFO] Booting worker with pid: 24768
[2016-12-27 16:35:31,158][PID:24765][INFO][requests.packages.urllib3.connectionpool] Starting new HTTP connection (1): metadata.google.internal
[2016-12-27 16:35:31 +0000] [24771] [INFO] Booting worker with pid: 24771
[2016-12-27 16:35:31,261][PID:24768][INFO][requests.packages.urllib3.connectionpool] Starting new HTTP connection (1): metadata.google.internal
[2016-12-27 16:35:31,296][PID:24771][INFO][requests.packages.urllib3.connectionpool] Starting new HTTP connection (1): metadata.google.internal
[2016-12-27 16:35:33 +0000] [24754] [INFO] Handling signal: winch
[2016-12-27 16:35:33,949][PID:24765][WARNING][redash.query_runner] BigQueryGCE query runner enabled but not supported, not registering. Either disable or install missing dependencies.
[2016-12-27 16:35:35 +0000] [24754] [INFO] Handling signal: winch
[2016-12-27 16:35:44,790][PID:24768][INFO][metrics] method=GET path=/ endpoint=redash.index status=302 content_type=text/html; charset=utf-8 content_length=295 duration=9.82 query_count=0 query_duration=0.00
[2016-12-27 16:35:44,880][PID:24771][INFO][metrics] method=GET path=/login endpoint=redash.login status=200 content_type=text/html; charset=utf-8 content_length=2059 duration=73.64 query_count=0 query_duration=0.00
[2016-12-27 16:35:44,988][PID:24762][INFO][metrics] method=GET path=/styles/main_login.551f048e.css endpoint=redash.send_static status=200 content_type=text/css; charset=utf-8 content_length=173600 duration=96.51 query_count=0 query_duration=0.00
[2016-12-27 16:35:44,989][PID:24768][INFO][metrics] method=GET path=/images/logo_white.png endpoint=redash.send_static status=200 content_type=image/png content_length=16125 duration=91.12 query_count=0 query_duration=0.00
[2016-12-27 16:35:45,004][PID:24768][INFO][metrics] method=GET path=/scripts/layout_vendor.2e77fa7a.js endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=4.10 query_count=0 query_duration=0.00
[2016-12-27 16:35:45,216][PID:24768][INFO][metrics] method=GET path=/fonts/roboto/Roboto-Medium-webfont.woff endpoint=redash.send_static status=200 content_type=application/font-woff content_length=25048 duration=4.65 query_count=0 query_duration=0.00
[2016-12-27 16:35:45,222][PID:24771][INFO][metrics] method=GET path=/fonts/roboto/Roboto-Regular-webfont.woff endpoint=redash.send_static status=200 content_type=application/font-woff content_length=25020 duration=8.99 query_count=0 query_duration=0.00
[2016-12-27 16:35:45,443][PID:24771][INFO][metrics] method=GET path=/images/favicon-16x16.png endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=5.80 query_count=0 query_duration=0.00
[2016-12-27 16:35:45,453][PID:24771][INFO][metrics] method=GET path=/images/favicon-96x96.png endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=3.17 query_count=0 query_duration=0.00
[2016-12-27 16:35:45,463][PID:24768][INFO][metrics] method=GET path=/images/favicon-32x32.png endpoint=redash.send_static status=200 content_type=image/png content_length=1407 duration=3.18 query_count=0 query_duration=0.00
[2016-12-27 16:35:56,420][PID:24771][INFO][metrics] method=GET path=/styles/main.fca37674.css endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=5.87 query_count=0 query_duration=0.00
[2016-12-27 16:35:56,428][PID:24771][INFO][metrics] method=GET path=/scripts/plugins.3564a8b0.js endpoint=redash.send_static status=200 content_type=application/javascript content_length=2106313 duration=4.80 query_count=0 query_duration=0.00
[2016-12-27 16:35:56,443][PID:24771][INFO][metrics] method=GET path=/scripts/scripts.0f5671e3.js endpoint=redash.send_static status=200 content_type=application/javascript content_length=120404 duration=4.50 query_count=0 query_duration=0.00
[2016-12-27 16:35:57,317][PID:24771][INFO][metrics] method=GET path=/views/app_header.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=4607 duration=3.70 query_count=0 query_duration=0.00
[2016-12-27 16:35:57,326][PID:24771][INFO][metrics] method=GET path=/views/edit_dashboard.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=1074 duration=4.05 query_count=0 query_duration=0.00
[2016-12-27 16:35:57,333][PID:24771][INFO][metrics] method=GET path=/views/index.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=1277 duration=3.54 query_count=0 query_duration=0.00
[2016-12-27 16:35:57,399][PID:24771][INFO][metrics] method=GET path=/api/dashboards endpoint=dashboards status=200 content_type=application/json content_length=2 duration=19.61 query_count=5 query_duration=10.17
[2016-12-27 16:35:57,400][PID:24771][INFO][metrics] method=GET path=/api/dashboards endpoint=dashboards status=500 content_type=? content_length=-1 duration=20.56 query_count=5 query_duration=10.17
[2016-12-27 16:35:57,406][PID:24771][INFO][metrics] method=GET path=/images/redash_icon_small.png endpoint=redash.send_static status=200 content_type=image/png content_length=3123 duration=4.43 query_count=0 query_duration=0.00
[2016-12-27 16:35:57,413][PID:24771][INFO][metrics] method=GET path=/fonts/Material-Design-Iconic-Font.woff2 endpoint=redash.send_static status=200 content_type=application/octet-stream content_length=38384 duration=3.74 query_count=0 query_duration=0.00
[2016-12-27 16:35:57,420][PID:24771][INFO][metrics] method=GET path=/fonts/fontawesome-webfont.woff endpoint=redash.send_static status=200 content_type=application/font-woff content_length=65452 duration=3.49 query_count=0 query_duration=0.00
[2016-12-27 16:35:57,497][PID:24771][INFO][metrics] method=GET path=/api/queries/recent endpoint=recent_queries status=200 content_type=application/json content_length=2 duration=28.30 query_count=5 query_duration=15.59
[2016-12-27 16:35:57,498][PID:24771][INFO][metrics] method=GET path=/api/queries/recent endpoint=recent_queries status=500 content_type=? content_length=-1 duration=29.76 query_count=5 query_duration=15.59
[2016-12-27 16:35:57,537][PID:24771][INFO][metrics] method=GET path=/api/dashboards/recent endpoint=recent_dashboards status=200 content_type=application/json content_length=2 duration=35.95 query_count=7 query_duration=16.81
[2016-12-27 16:35:58,478][PID:24771][INFO][metrics] method=POST path=/api/events endpoint=events status=200 content_type=application/json content_length=4 duration=8.77 query_count=3 query_duration=2.75
[2016-12-27 16:35:58,479][PID:24771][INFO][metrics] method=POST path=/api/events endpoint=events status=500 content_type=? content_length=-1 duration=9.67 query_count=3 query_duration=2.75
[2016-12-27 16:36:52 +0000] [24754] [INFO] Handling signal: winch
[2016-12-27 16:37:26 +0000] [24754] [INFO] Handling signal: winch
[2016-12-27 16:43:36,054][PID:24765][INFO][metrics] method=GET path=/api/data_sources endpoint=data_sources status=200 content_type=application/json content_length=128 duration=18.85 query_count=7 query_duration=7.66
[2016-12-27 16:43:36,174][PID:24771][INFO][metrics] method=GET path=/views/directives/schema_browser.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=750 duration=3.28 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,175][PID:24771][INFO][metrics] method=GET path=/views/directives/schema_browser.html endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=4.28 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,184][PID:24765][INFO][metrics] method=GET path=/views/directives/parameters.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=679 duration=4.35 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,186][PID:24765][INFO][metrics] method=GET path=/views/directives/parameters.html endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=5.77 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,187][PID:24771][INFO][metrics] method=GET path=/views/visualizations/filters.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=1005 duration=4.32 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,189][PID:24762][INFO][metrics] method=GET path=/views/grid_renderer.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=163 duration=3.89 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,189][PID:24771][INFO][metrics] method=GET path=/views/visualizations/filters.html endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=6.78 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,190][PID:24762][INFO][metrics] method=GET path=/views/grid_renderer.html endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=5.16 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,200][PID:24768][INFO][metrics] method=GET path=/views/visualizations/chart.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=103 duration=3.83 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,201][PID:24768][INFO][metrics] method=GET path=/views/visualizations/chart.html endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=5.41 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,202][PID:24762][INFO][metrics] method=GET path=/views/visualizations/map.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=131 duration=4.43 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,204][PID:24762][INFO][metrics] method=GET path=/views/visualizations/map.html endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=5.90 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,215][PID:24768][INFO][metrics] method=GET path=/views/visualizations/counter.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=293 duration=4.06 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,216][PID:24771][INFO][metrics] method=GET path=/views/visualizations/boxplot.html endpoint=redash.send_static status=200 content_type=text/html; charset=utf-8 content_length=21 duration=3.92 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,216][PID:24768][INFO][metrics] method=GET path=/views/visualizations/counter.html endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=5.19 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,219][PID:24771][INFO][metrics] method=GET path=/views/visualizations/boxplot.html endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=6.83 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,265][PID:24771][INFO][metrics] method=GET path=/api/data_sources/1/schema endpoint=datasourceschemaresource status=200 content_type=application/json content_length=1453 duration=38.79 query_count=6 query_duration=7.16
[2016-12-27 16:43:36,266][PID:24771][INFO][metrics] method=GET path=/api/data_sources/1/schema endpoint=datasourceschemaresource status=500 content_type=? content_length=-1 duration=39.92 query_count=6 query_duration=7.16
[2016-12-27 16:43:36,308][PID:24771][INFO][metrics] method=GET path=/worker-json.js endpoint=redash.send_static status=404 content_type=text/html content_length=233 duration=3.62 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,309][PID:24771][INFO][metrics] method=GET path=/worker-json.js endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=4.56 query_count=0 query_duration=0.00
[2016-12-27 16:43:36,357][PID:24765][INFO][metrics] method=GET path=/api/query_snippets endpoint=query_snippets status=200 content_type=application/json content_length=2 duration=13.42 query_count=4 query_duration=5.17
[2016-12-27 16:43:36,358][PID:24765][INFO][metrics] method=GET path=/api/query_snippets endpoint=query_snippets status=500 content_type=? content_length=-1 duration=14.80 query_count=4 query_duration=5.17
[2016-12-27 16:43:37,166][PID:24762][INFO][metrics] method=POST path=/api/events endpoint=events status=200 content_type=application/json content_length=4 duration=12.20 query_count=4 query_duration=3.37
[2016-12-27 16:43:37,167][PID:24762][INFO][metrics] method=POST path=/api/events endpoint=events status=500 content_type=? content_length=-1 duration=13.16 query_count=4 query_duration=3.37
[2016-12-27 16:51:56,533][PID:24771][INFO][metrics] method=GET path=/queries/new endpoint=redash.index status=200 content_type=text/html; charset=utf-8 content_length=3438 duration=65.24 query_count=4 query_duration=3.63
[2016-12-27 16:51:56,534][PID:24771][INFO][metrics] method=GET path=/queries/new endpoint=redash.index status=500 content_type=? content_length=-1 duration=66.04 query_count=4 query_duration=3.63
[2016-12-27 16:51:57,697][PID:24765][INFO][metrics] method=GET path=/api/data_sources endpoint=data_sources status=200 content_type=application/json content_length=128 duration=24.98 query_count=7 query_duration=14.03
[2016-12-27 16:51:57,698][PID:24765][INFO][metrics] method=GET path=/api/data_sources endpoint=data_sources status=500 content_type=? content_length=-1 duration=26.04 query_count=7 query_duration=14.03
[2016-12-27 16:51:57,738][PID:24768][INFO][metrics] method=GET path=/api/dashboards endpoint=dashboards status=200 content_type=application/json content_length=2 duration=14.22 query_count=5 query_duration=6.71
[2016-12-27 16:51:57,739][PID:24768][INFO][metrics] method=GET path=/api/dashboards endpoint=dashboards status=500 content_type=? content_length=-1 duration=15.24 query_count=5 query_duration=6.71
[2016-12-27 16:51:57,882][PID:24762][INFO][metrics] method=GET path=/api/data_sources/1/schema endpoint=datasourceschemaresource status=200 content_type=application/json content_length=1453 duration=13.06 query_count=6 query_duration=5.08
[2016-12-27 16:51:57,883][PID:24762][INFO][metrics] method=GET path=/api/data_sources/1/schema endpoint=datasourceschemaresource status=500 content_type=? content_length=-1 duration=13.95 query_count=6 query_duration=5.08
[2016-12-27 16:51:57,914][PID:24771][INFO][metrics] method=GET path=/worker-json.js endpoint=redash.send_static status=404 content_type=text/html content_length=233 duration=3.08 query_count=0 query_duration=0.00
[2016-12-27 16:51:57,948][PID:24765][INFO][metrics] method=GET path=/api/query_snippets endpoint=query_snippets status=200 content_type=application/json content_length=2 duration=9.65 query_count=4 query_duration=3.09
[2016-12-27 16:51:58,885][PID:24768][INFO][metrics] method=POST path=/api/events endpoint=events status=200 content_type=application/json content_length=4 duration=36.24 query_count=4 query_duration=6.14
[2016-12-27 16:51:58,886][PID:24768][INFO][metrics] method=POST path=/api/events endpoint=events status=500 content_type=? content_length=-1 duration=37.30 query_count=4 query_duration=6.14
[2016-12-27 16:52:05,343][PID:24771][INFO][root] Inserting job for 8b3bcfc217aca1fb0acec6337c0a94e7 with metadata={‘Username’: u’admin’, ‘Query ID’: ‘adhoc’}
[2016-12-27 16:52:05,346][PID:24771][INFO][root] [8b3bcfc217aca1fb0acec6337c0a94e7] Created new job: f1978dba-13c5-432b-9fd2-3d9344354585
[2016-12-27 16:52:05,347][PID:24771][INFO][metrics] method=POST path=/api/query_results endpoint=query_results status=200 content_type=application/json content_length=123 duration=23.05 query_count=8 query_duration=7.89
[2016-12-27 16:52:05,348][PID:24771][INFO][metrics] method=POST path=/api/query_results endpoint=query_results status=500 content_type=? content_length=-1 duration=23.95 query_count=8 query_duration=7.89
[2016-12-27 16:53:19,317][PID:24765][INFO][metrics] method=GET path=/api/jobs/f1978dba-13c5-432b-9fd2-3d9344354585 endpoint=job status=500 content_type=? content_length=-1 duration=6.85 query_count=2 query_duration=1.68
[2016-12-27 16:54:03,487][PID:24768][INFO][metrics] method=GET path=/ endpoint=redash.index status=200 content_type=text/html; charset=utf-8 content_length=3438 duration=19.92 query_count=4 query_duration=3.34
[2016-12-27 16:54:03,487][PID:24768][INFO][metrics] method=GET path=/ endpoint=redash.index status=500 content_type=? content_length=-1 duration=20.78 query_count=4 query_duration=3.34
[2016-12-27 16:54:04,825][PID:24762][INFO][metrics] method=GET path=/api/dashboards endpoint=dashboards status=200 content_type=application/json content_length=2 duration=13.29 query_count=5 query_duration=6.13
[2016-12-27 16:54:04,826][PID:24762][INFO][metrics] method=GET path=/api/dashboards endpoint=dashboards status=500 content_type=? content_length=-1 duration=14.31 query_count=5 query_duration=6.13
[2016-12-27 16:54:04,894][PID:24765][INFO][metrics] method=GET path=/api/queries/recent endpoint=recent_queries status=200 content_type=application/json content_length=2 duration=17.26 query_count=5 query_duration=7.77
[2016-12-27 16:54:04,895][PID:24765][INFO][metrics] method=GET path=/api/queries/recent endpoint=recent_queries status=500 content_type=? content_length=-1 duration=18.25 query_count=5 query_duration=7.77
[2016-12-27 16:54:04,915][PID:24771][INFO][metrics] method=GET path=/api/dashboards/recent endpoint=recent_dashboards status=200 content_type=application/json content_length=2 duration=26.62 query_count=7 query_duration=12.28
[2016-12-27 16:54:04,916][PID:24771][INFO][metrics] method=GET path=/api/dashboards/recent endpoint=recent_dashboards status=500 content_type=? content_length=-1 duration=27.93 query_count=7 query_duration=12.28
[2016-12-27 16:54:05,888][PID:24768][INFO][metrics] method=POST path=/api/events endpoint=events status=200 content_type=application/json content_length=4 duration=8.09 query_count=3 query_duration=2.49
[2016-12-27 16:54:06,616][PID:24762][INFO][metrics] method=GET path=/api/data_sources endpoint=data_sources status=200 content_type=application/json content_length=128 duration=22.59 query_count=7 query_duration=8.10
[2016-12-27 16:54:06,728][PID:24762][INFO][metrics] method=GET path=/api/data_sources/1/schema endpoint=datasourceschemaresource status=200 content_type=application/json content_length=1453 duration=12.07 query_count=6 query_duration=4.75
[2016-12-27 16:54:06,729][PID:24762][INFO][metrics] method=GET path=/api/data_sources/1/schema endpoint=datasourceschemaresource status=500 content_type=? content_length=-1 duration=13.30 query_count=6 query_duration=4.75
[2016-12-27 16:54:06,822][PID:24768][INFO][metrics] method=GET path=/worker-json.js endpoint=redash.send_static status=404 content_type=text/html content_length=233 duration=4.22 query_count=0 query_duration=0.00
[2016-12-27 16:54:06,823][PID:24768][INFO][metrics] method=GET path=/worker-json.js endpoint=redash.send_static status=500 content_type=? content_length=-1 duration=5.59 query_count=0 query_duration=0.00
[2016-12-27 16:54:06,870][PID:24765][INFO][metrics] method=GET path=/api/query_snippets endpoint=query_snippets status=200 content_type=application/json content_length=2 duration=14.84 query_count=4 query_duration=7.04
[2016-12-27 16:54:06,872][PID:24765][INFO][metrics] method=GET path=/api/query_snippets endpoint=query_snippets status=500 content_type=? content_length=-1 duration=16.34 query_count=4 query_duration=7.04
[2016-12-27 16:54:07,705][PID:24762][INFO][metrics] method=POST path=/api/events endpoint=events status=200 content_type=application/json content_length=4 duration=13.74 query_count=4 query_duration=5.02
[2016-12-27 16:54:07,706][PID:24762][INFO][metrics] method=POST path=/api/events endpoint=events status=500 content_type=? content_length=-1 duration=14.79 query_count=4 query_duration=5.02
[2016-12-27 16:54:13,745][PID:24768][INFO][root] Inserting job for a49931fa198bea1bc038ef060b373c18 with metadata={‘Username’: u’admin’, ‘Query ID’: ‘adhoc’}
[2016-12-27 16:54:13,746][PID:24768][INFO][root] [a49931fa198bea1bc038ef060b373c18] Created new job: 79d599c9-e53c-4c25-833b-e03aa3b2b6bc
[2016-12-27 16:54:13,747][PID:24768][INFO][metrics] method=POST path=/api/query_results endpoint=query_results status=200 content_type=application/json content_length=123 duration=29.42 query_count=8 query_duration=7.72
[2016-12-27 16:54:13,748][PID:24768][INFO][metrics] method=POST path=/api/query_results endpoint=query_results status=500 content_type=? content_length=-1 duration=30.25 query_count=8 query_duration=7.72
[2016-12-27 16:54:13,763][PID:24768][INFO][metrics] method=GET path=/api/jobs/79d599c9-e53c-4c25-833b-e03aa3b2b6bc endpoint=job status=200 content_type=application/json content_length=123 duration=7.59 query_count=2 query_duration=2.41
[2016-12-27 16:54:13,763][PID:24768][INFO][metrics] method=GET path=/api/jobs/79d599c9-e53c-4c25-833b-e03aa3b2b6bc endpoint=job status=500 content_type=? content_length=-1 duration=8.51 query_count=2 query_duration=2.41
[2016-12-27 16:54:14,727][PID:24768][INFO][metrics] method=POST path=/api/events endpoint=events status=200 content_type=application/json content_length=4 duration=7.70 query_count=3 query_duration=1.87
[2016-12-27 16:54:14,727][PID:24768][INFO][metrics] method=POST path=/api/events endpoint=events status=500 content_type=? content_length=-1 duration=8.46 query_count=3 query_duration=1.87
[2016-12-27 16:54:16,778][PID:24768][INFO][metrics] method=GET path=/api/jobs/79d599c9-e53c-4c25-833b-e03aa3b2b6bc endpoint=job status=200 content_type=application/json content_length=123 duration=7.64 query_count=2 query_duration=2.87
[2016-12-27 16:54:16,779][PID:24768][INFO][metrics] method=GET path=/api/jobs/79d599c9-e53c-4c25-833b-e03aa3b2b6bc endpoint=job status=500 content_type=? content_length=-1 duration=8.47 query_count=2 query_duration=2.87
[2016-12-27 16:55:02,624][PID:24765][INFO][metrics] method=POST path=/api/queries endpoint=queries status=200 content_type=application/json content_length=997 duration=79.37 query_count=12 query_duration=66.68
[2016-12-27 16:55:02,625][PID:24765][INFO][metrics] method=POST path=/api/queries endpoint=queries status=500 content_type=? content_length=-1 duration=80.34 query_count=12 query_duration=66.68
[2016-12-27 16:55:02,677][PID:24765][INFO][metrics] method=GET path=/api/queries/1 endpoint=query status=200 content_type=application/json content_length=1226 duration=29.64 query_count=11 query_duration=14.53
[2016-12-27 16:55:02,678][PID:24765][INFO][metrics] method=GET path=/api/queries/1 endpoint=query status=500 content_type=? content_length=-1 duration=30.77 query_count=11 query_duration=14.53
[2016-12-27 16:55:02,775][PID:24762][INFO][metrics] method=GET path=/api/data_sources endpoint=data_sources status=200 content_type=application/json content_length=128 duration=12.11 query_count=7 query_duration=4.63
[2016-12-27 16:55:02,776][PID:24762][INFO][metrics] method=GET path=/api/data_sources endpoint=data_sources status=500 content_type=? content_length=-1 duration=13.08 query_count=7 query_duration=4.63
[2016-12-27 16:55:02,856][PID:24762][INFO][metrics] method=GET path=/worker-json.js endpoint=redash.send_static status=404 content_type=text/html content_length=233 duration=3.80 query_count=0 query_duration=0.00
[2016-12-27 16:55:02,892][PID:24771][INFO][metrics] method=GET path=/api/query_snippets endpoint=query_snippets status=500 content_type=? content_length=-1 duration=12.69 query_count=4 query_duration=5.02
[2016-12-27 16:55:03,774][PID:24765][INFO][metrics] method=POST path=/api/events endpoint=events status=500 content_type=? content_length=-1 duration=14.81 query_count=4 query_duration=4.65
[2016-12-27 16:55:04,571][PID:24762][INFO][root] Inserting job for a49931fa198bea1bc038ef060b373c18 with metadata={‘Username’: u’admin’, ‘Query ID’: 1}
[2016-12-27 16:55:04,571][PID:24762][INFO][root] [a49931fa198bea1bc038ef060b373c18] Found existing job: 79d599c9-e53c-4c25-833b-e03aa3b2b6bc
[2016-12-27 16:55:04,572][PID:24762][INFO][metrics] method=POST path=/api/query_results endpoint=query_results status=200 content_type=application/json content_length=123 duration=18.58 query_count=8 query_duration=6.94
[2016-12-27 16:55:04,573][PID:24762][INFO][metrics] method=POST path=/api/query_results endpoint=query_results status=500 content_type=? content_length=-1 duration=19.45 query_count=8 query_duration=6.94
[2016-12-27 16:55:04,589][PID:24765][INFO][metrics] method=GET path=/api/jobs/79d599c9-e53c-4c25-833b-e03aa3b2b6bc endpoint=job status=200 content_type=application/json content_length=123 duration=9.59 query_count=2 query_duration=2.97

This is the some of the log for my run. Query takes forever to run, I am running it on the redash_metadata itself.
Also there was too much issue with gunicorn workers timeout. Finally when it ran it gave me this.
For every status=200, a status= 500 is also accompanied (which isn’t present in the above log but is there in actual log)
Ubuntu 16.04 , setup using bootstrap.sh


#2

Did you start the Celery workers?