Skip to content

Instantly share code, notes, and snippets.

@stephaniewilkinson
Last active November 25, 2019 23:19
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save stephaniewilkinson/10fdcf840f8f7f7a93a3a2c481fa4551 to your computer and use it in GitHub Desktop.
Save stephaniewilkinson/10fdcf840f8f7f7a93a3a2c481fa4551 to your computer and use it in GitHub Desktop.
2019-11-25T11:54:11-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 11.6 ms (1 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:11-08:00 DEBUG metabase.middleware.log GET /api/user/current 200 528.3 ms (3 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:11-08:00 DEBUG metabase.middleware.log GET /api/user/current 200 291.9 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:12-08:00 DEBUG metabase.middleware.log GET /api/database 200 39.2 ms (4 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:12-08:00 DEBUG metabase.middleware.log GET /api/setting 200 5.1 ms (0 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:12-08:00 DEBUG metabase.middleware.log GET /api/collection/root/items 200 167.1 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:12-08:00 DEBUG metabase.middleware.log GET /api/collection/root 200 14.8 ms (2 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:12-08:00 DEBUG metabase.middleware.log GET /api/database 200 7.7 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:13-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/database/2/candidates 200 756.7 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:21-08:00 DEBUG metabase.middleware.log GET /api/database/2/schemas 200 8.1 ms (4 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:21-08:00 DEBUG metabase.middleware.log GET /api/database/2/metadata 200 154.9 ms (9 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:23-08:00 DEBUG metabase.middleware.log GET /api/database 200 24.5 ms (5 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:24-08:00 DEBUG metabase.middleware.log GET /api/table/18/fks 200 19.2 ms (5 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:24-08:00 DEBUG metabase.middleware.log GET /api/table/18/query_metadata 200 88.0 ms (9 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (57 total active threads) Queries in flight: 0
2019-11-25T11:54:27-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 52.3 ms (1 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 1
2019-11-25T11:54:27-08:00 DEBUG metabase.middleware.log GET /api/setup/admin_checklist 200 90.9 ms (13 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 1
2019-11-25T11:54:28-08:00 DEBUG metabase.middleware.log GET /api/setting 200 1.3 ms (0 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 1
2019-11-25T11:54:30-08:00 DEBUG metabase.middleware.log GET /api/table 200 13.4 ms (2 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 1
2019-11-25T11:54:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 5.9 s (15 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 0
2019-11-25T11:54:31-08:00 DEBUG metabase.middleware.log GET /api/database/2 200 11.8 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 0
2019-11-25T11:54:32-08:00 DEBUG metabase.middleware.log GET /api/table/26 200 9.7 ms (5 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 0
2019-11-25T11:54:32-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 33.1 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 0
2019-11-25T11:54:32-08:00 DEBUG metabase.middleware.log GET /api/table/26/query_metadata 200 29.4 ms (11 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 0
2019-11-25T11:54:32-08:00 DEBUG metabase.middleware.log GET /api/table/7/query_metadata 200 23.9 ms (10 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (59 total active threads) Queries in flight: 0
2019-11-25T11:54:34-08:00 INFO metabase.api.table Table 'authors' is now visible. Resyncing.
2019-11-25T11:54:34-08:00 DEBUG metabase.middleware.log PUT /api/table/26 200 220.5 ms (30 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:35-08:00 DEBUG metabase.middleware.log GET /api/table 200 7.5 ms (2 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:37-08:00 DEBUG metabase.middleware.log GET /api/table/15 200 12.0 ms (5 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:38-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 14.9 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:38-08:00 DEBUG metabase.middleware.log GET /api/table/15/query_metadata 200 25.5 ms (11 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:38-08:00 DEBUG metabase.middleware.log GET /api/table/6/query_metadata 200 22.9 ms (8 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:39-08:00 INFO metabase.api.table Table 'collections' is now visible. Resyncing.
2019-11-25T11:54:39-08:00 DEBUG metabase.middleware.log PUT /api/table/15 200 100.9 ms (16 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:39-08:00 DEBUG metabase.middleware.log GET /api/table 200 8.7 ms (2 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:43-08:00 DEBUG metabase.middleware.log GET /api/table/14 200 9.3 ms (5 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:44-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 16.2 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:44-08:00 DEBUG metabase.middleware.log GET /api/table/14/query_metadata 200 19.6 ms (9 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:44-08:00 DEBUG metabase.middleware.log PUT /api/table/14 200 8.9 ms (4 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:45-08:00 DEBUG metabase.middleware.log GET /api/table 200 5.2 ms (2 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:45-08:00 INFO metabase.api.table Table 'dataitems' is now visible. Resyncing.
2019-11-25T11:54:45-08:00 DEBUG metabase.middleware.log PUT /api/table/14 200 100.8 ms (18 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:46-08:00 DEBUG metabase.middleware.log GET /api/table 200 7.6 ms (2 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:49-08:00 DEBUG metabase.middleware.log GET /api/table/5 200 10.0 ms (5 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:50-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 20.3 ms (6 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:50-08:00 DEBUG metabase.middleware.log GET /api/table/5/query_metadata 200 21.3 ms (9 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (60 total active threads) Queries in flight: 0
2019-11-25T11:54:51-08:00 INFO metabase.api.table Table 'nces_schools' is now visible. Resyncing.
2019-11-25T11:54:51-08:00 DEBUG metabase.middleware.log PUT /api/table/5 200 298.5 ms (51 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:54:51-08:00 DEBUG metabase.middleware.log GET /api/table 200 6.5 ms (2 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:54:54-08:00 DEBUG metabase.middleware.log GET /api/table/7 200 15.3 ms (5 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:54:54-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 13.1 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:54:55-08:00 INFO metabase.api.table Table 'users' is now visible. Resyncing.
2019-11-25T11:54:55-08:00 DEBUG metabase.middleware.log PUT /api/table/7 200 452.3 ms (90 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T11:54:56-08:00 DEBUG metabase.middleware.log GET /api/table 200 6.4 ms (2 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T11:54:57-08:00 DEBUG metabase.middleware.log GET /api/table/19 200 10.3 ms (5 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T11:54:57-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 15.8 ms (6 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T11:54:57-08:00 DEBUG metabase.middleware.log GET /api/table/19/query_metadata 200 17.1 ms (9 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T11:54:58-08:00 INFO metabase.api.table Table 'zctas' is now visible. Resyncing.
2019-11-25T11:55:01-08:00 DEBUG metabase.middleware.log PUT /api/table/19 200 16.4 ms (4 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T11:55:01-08:00 DEBUG metabase.middleware.log GET /api/table 200 13.1 ms (2 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T11:55:04-08:00 DEBUG metabase.middleware.log GET /api/table/12 200 28.8 ms (5 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T11:55:05-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 57.1 ms (6 DB calls) Jetty threads: 7/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T11:55:05-08:00 DEBUG metabase.middleware.log GET /api/table/12/query_metadata 200 78.4 ms (11 DB calls) Jetty threads: 7/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T11:55:05-08:00 INFO metabase.api.table Table 'user_preferences' is now visible. Resyncing.
2019-11-25T11:55:06-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T11:55:06-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_varchar' to a Field base_type, falling back to :type/*.
2019-11-25T11:55:06-08:00 DEBUG metabase.middleware.log PUT /api/table/12 200 857.8 ms (58 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T11:55:07-08:00 DEBUG metabase.middleware.log GET /api/table 200 9.4 ms (2 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T11:55:07-08:00 DEBUG metabase.middleware.log PUT /api/table/19 200 9.4 s (30 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T11:55:08-08:00 DEBUG metabase.middleware.log GET /api/table 200 5.7 ms (2 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T11:55:09-08:00 DEBUG metabase.middleware.log GET /api/table/20 200 10.3 ms (5 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:09-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 19.6 ms (6 DB calls) Jetty threads: 6/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:09-08:00 DEBUG metabase.middleware.log GET /api/table/20/query_metadata 200 17.7 ms (9 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:11-08:00 INFO metabase.api.table Table 'us_counties' is now visible. Resyncing.
2019-11-25T11:55:11-08:00 DEBUG metabase.middleware.log PUT /api/table/20 200 79.2 ms (14 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:11-08:00 DEBUG metabase.middleware.log GET /api/table 200 8.2 ms (2 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:16-08:00 DEBUG metabase.middleware.log GET /api/table/6 200 8.7 ms (5 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:16-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 13.9 ms (6 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:17-08:00 INFO metabase.api.table Table 'schools' is now visible. Resyncing.
2019-11-25T11:55:17-08:00 DEBUG metabase.middleware.log PUT /api/table/6 200 373.3 ms (91 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:18-08:00 DEBUG metabase.middleware.log GET /api/table 200 15.5 ms (2 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:20-08:00 DEBUG metabase.middleware.log GET /api/table/22 200 19.6 ms (5 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:20-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 17.7 ms (6 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:20-08:00 DEBUG metabase.middleware.log GET /api/table/22/query_metadata 200 27.6 ms (11 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:21-08:00 INFO metabase.api.table Table 'reports' is now visible. Resyncing.
2019-11-25T11:55:21-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_int4' to a Field base_type, falling back to :type/*.
2019-11-25T11:55:21-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T11:55:22-08:00 DEBUG metabase.middleware.log PUT /api/table/22 200 1.0 s (104 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:22-08:00 DEBUG metabase.middleware.log GET /api/table 200 9.9 ms (2 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:26-08:00 DEBUG metabase.middleware.log GET /api/table/23 200 9.1 ms (5 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:27-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 11.3 ms (6 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:27-08:00 DEBUG metabase.middleware.log GET /api/table/23/query_metadata 200 17.8 ms (9 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:34-08:00 INFO metabase.api.table Table 'cbsas' is now visible. Resyncing.
2019-11-25T11:55:34-08:00 DEBUG metabase.middleware.log PUT /api/table/23 200 128.1 ms (26 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:34-08:00 DEBUG metabase.middleware.log GET /api/table 200 12.6 ms (2 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:39-08:00 DEBUG metabase.middleware.log GET /api/table/25 200 9.3 ms (5 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:40-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 15.8 ms (6 DB calls) Jetty threads: 6/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:40-08:00 DEBUG metabase.middleware.log GET /api/table/25/query_metadata 200 21.1 ms (11 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:41-08:00 INFO metabase.api.table Table 'datasets' is now visible. Resyncing.
2019-11-25T11:55:41-08:00 DEBUG metabase.middleware.log PUT /api/table/25 200 125.3 ms (27 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:41-08:00 DEBUG metabase.middleware.log GET /api/table 200 6.2 ms (2 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:43-08:00 DEBUG metabase.middleware.log GET /api/table/11 200 11.9 ms (5 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:43-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 12.8 ms (6 DB calls) Jetty threads: 6/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:43-08:00 DEBUG metabase.middleware.log GET /api/table/11/query_metadata 200 18.3 ms (11 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:44-08:00 INFO metabase.api.table Table 'datasets_dataitems' is now visible. Resyncing.
2019-11-25T11:55:44-08:00 DEBUG metabase.middleware.log PUT /api/table/11 200 104.1 ms (16 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:44-08:00 DEBUG metabase.middleware.log GET /api/table 200 5.7 ms (2 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:55:58-08:00 DEBUG metabase.middleware.log GET /api/table/11 200 9.8 ms (5 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:56:01-08:00 DEBUG metabase.middleware.log GET /api/table/11 200 10.7 ms (5 DB calls) Jetty threads: 6/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:56:01-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 17.1 ms (6 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T11:56:11-08:00 DEBUG metabase.middleware.log GET /api/table/26 200 10.0 ms (5 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:11-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 18.9 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:14-08:00 DEBUG metabase.middleware.log GET /api/table/26 200 9.0 ms (5 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:14-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 13.6 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:16-08:00 DEBUG metabase.middleware.log GET /api/table/26 200 10.7 ms (5 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:18-08:00 DEBUG metabase.middleware.log GET /api/table/26 200 17.2 ms (5 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:18-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 17.6 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:21-08:00 DEBUG metabase.middleware.log GET /api/table/17 200 15.1 ms (5 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:22-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 22.1 ms (6 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:22-08:00 DEBUG metabase.middleware.log GET /api/table/17/query_metadata 200 64.8 ms (9 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:25-08:00 DEBUG metabase.middleware.log GET /api/table/17 200 15.1 ms (5 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:25-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 18.7 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:29-08:00 DEBUG metabase.middleware.log GET /api/database/2 200 6.9 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:39-08:00 INFO metabase.models.database postgres Database 'Market View' sync/analyze schedules have changed!
Sync metadata was: '0 50 * * * ? *' is now: '0 0 * * * ? *'
Cache FieldValues was: '0 50 0 * * ? *', is now: '0 0 0 * * ? *'
2019-11-25T11:56:40-08:00 DEBUG metabase.middleware.log PUT /api/database/2 200 125.6 ms (4 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T11:56:40-08:00 DEBUG metabase.middleware.log GET /api/database 200 8.9 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:58:30-08:00 DEBUG metabase.middleware.log GET /api/database 200 6.2 ms (3 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (59 total active threads) Queries in flight: 0
2019-11-25T11:58:31-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/database/2/candidates 200 57.5 ms (6 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:58:46-08:00 INFO metabase.automagic-dashboards.core Applying heuristic GenericTable to Schools table.
2019-11-25T11:58:46-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"ZIP" {:field_type [:type/ZipCode], :score 100, :matches ("zip_code")},
"Long" {:field_type [:entity/GenericTable :type/Longitude], :score 100, :matches ("long")},
"Country" {:field_type [:entity/GenericTable :type/Country], :score 100, :matches ("country")},
"GenericCategoryMedium" {:field_type [:entity/GenericTable :type/Category], :score 75, :max_cardinality 10, :matches ("nais_school_id" "address_2" "city" "address_1" "name")},
"Timestamp" {:field_type [:type/DateTime], :score 60, :matches ("updated_at" "inserted_at")},
"Lat" {:field_type [:entity/GenericTable :type/Latitude], :score 100, :matches ("lat")},
"State" {:field_type [:entity/GenericTable :type/State], :score 100, :matches ("state")}}
2019-11-25T11:58:46-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"], "CountDistinctFKs" ["distinct" ["dimension" "FK"]], "Sum" ["sum" ["dimension" "GenericNumber"]], "Avg" ["avg" ["dimension" "GenericNumber"]]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "Timestamp"] -30 "day"], :score 80}}
2019-11-25T11:58:46-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your Schools table:
Total Schools; Schools added in the last 30 days; Schools added in the last 30 days; Schools per Na Is School ID; Schools per Address 2; Schools per City; Schools per Address 1; Schools per Name; Schools per country; Schools per state; Schools by coordinates; Updated At by day of the week; Inserted At by day of the week; Updated At by hour of the day; Inserted At by hour of the day
2019-11-25T11:58:46-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/6 200 449.5 ms (34 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:58:46-08:00 DEBUG metabase.middleware.log GET /api/field/331/values 200 11.4 ms (4 DB calls) Jetty threads: 8/50 (2 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:58:46-08:00 DEBUG metabase.middleware.log GET /api/field/336 200 29.6 ms (7 DB calls) Jetty threads: 7/50 (2 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:58:46-08:00 DEBUG metabase.middleware.log GET /api/field/331 200 30.7 ms (6 DB calls) Jetty threads: 7/50 (2 idle, 0 queued) (63 total active threads) Queries in flight: 0
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log GET /api/database/2/metadata 200 94.3 ms (9 DB calls) Jetty threads: 8/50 (2 idle, 0 queued) (65 total active threads) Queries in flight: 0
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log GET /api/field/336/values 200 19.7 ms (4 DB calls) Jetty threads: 7/50 (2 idle, 0 queued) (65 total active threads) Queries in flight: 0
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log GET /api/field/330 200 25.6 ms (6 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (65 total active threads) Queries in flight: 0
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log GET /api/field/330/values 200 6.5 ms (4 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (65 total active threads) Queries in flight: 0
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log GET /api/field/332 200 13.0 ms (6 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (65 total active threads) Queries in flight: 0
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log GET /api/field/332/values 200 7.3 ms (3 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (65 total active threads) Queries in flight: 0
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 216.6 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 238.6 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 322.3 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 415.5 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 124.1 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T11:58:47-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 120.1 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T11:58:48-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 59.5 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 3
2019-11-25T11:58:48-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 59.6 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T11:58:48-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 52.5 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T11:58:48-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 53.6 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T11:58:48-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 54.1 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T11:58:48-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 64.5 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T11:58:48-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 52.5 ms (15 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T11:58:48-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 57.6 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T11:58:48-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 48.4 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:00:00-08:00 INFO metabase.sync.util STARTING: Sync metadata for postgres Database 2 'Market View'
2019-11-25T12:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-timezone' for postgres Database 2 'Market View'
2019-11-25T12:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-timezone' for postgres Database 2 'Market View' (18.7 ms)
2019-11-25T12:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-tables' for postgres Database 2 'Market View'
2019-11-25T12:00:00-08:00 INFO metabase.task.send-pulses Sending scheduled pulses...
2019-11-25T12:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-tables' for postgres Database 2 'Market View' (39.3 ms)
2019-11-25T12:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fields' for postgres Database 2 'Market View'
2019-11-25T12:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T12:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_varchar' to a Field base_type, falling back to :type/*.
2019-11-25T12:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_int4' to a Field base_type, falling back to :type/*.
2019-11-25T12:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T12:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-fields' for postgres Database 2 'Market View' (1.4 s)
2019-11-25T12:00:01-08:00 INFO metabase.sync.util STARTING: step 'sync-fks' for postgres Database 2 'Market View'
2019-11-25T12:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-fks' for postgres Database 2 'Market View' (294.2 ms)
2019-11-25T12:00:01-08:00 INFO metabase.sync.util STARTING: step 'sync-metabase-metadata' for postgres Database 2 'Market View'
2019-11-25T12:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-metabase-metadata' for postgres Database 2 'Market View' (13.5 ms)
2019-11-25T12:00:01-08:00 INFO metabase.sync.util FINISHED: Sync metadata for postgres Database 2 'Market View' (1.8 s)
2019-11-25T12:00:01-08:00 INFO metabase.sync.util STARTING: Analyze data for postgres Database 2 'Market View'
2019-11-25T12:00:01-08:00 INFO metabase.sync.util STARTING: step 'fingerprint-fields' for postgres Database 2 'Market View'
2019-11-25T12:00:01-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [*****·············································] 😢 12% Table 23 'public.cbsas'
2019-11-25T12:00:01-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [***********·······································] 😒 23% Table 14 'public.dataitems'
2019-11-25T12:00:01-08:00 INFO metabase.sync.util FINISHED: step 'fingerprint-fields' for postgres Database 2 'Market View' (74.4 ms)
2019-11-25T12:00:01-08:00 INFO metabase.sync.util STARTING: step 'classify-fields' for postgres Database 2 'Market View'
2019-11-25T12:00:02-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************·································] 😕 35% Table 12 'public.user_preferences'
2019-11-25T12:00:02-08:00 INFO metabase.sync.analyze classify-fields Analyzed [***********************···························] 😬 47% Table 26 'public.authors'
2019-11-25T12:00:02-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************************·····················] 😌 58% Table 5 'public.nces_schools'
2019-11-25T12:00:02-08:00 INFO metabase.sync.util FINISHED: step 'classify-fields' for postgres Database 2 'Market View' (49.5 ms)
2019-11-25T12:00:02-08:00 INFO metabase.sync.util STARTING: step 'classify-tables' for postgres Database 2 'Market View'
2019-11-25T12:00:02-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************················] 😏 70% Table 20 'public.us_counties'
2019-11-25T12:00:02-08:00 INFO metabase.sync.analyze classify-tables Analyzed [****************************************··········] 😊 81% Table 15 'public.collections'
2019-11-25T12:00:02-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************************····] 😍 93% Table 7 'public.users'
2019-11-25T12:00:02-08:00 INFO metabase.sync.util FINISHED: step 'classify-tables' for postgres Database 2 'Market View' (29.4 ms)
2019-11-25T12:00:02-08:00 INFO metabase.sync.util FINISHED: Analyze data for postgres Database 2 'Market View' (199.9 ms)
2019-11-25T12:04:22-08:00 DEBUG metabase.middleware.log GET /api/database 200 51.9 ms (5 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (62 total active threads) Queries in flight: 0
2019-11-25T12:04:22-08:00 DEBUG metabase.middleware.log GET /api/table/6/fks 200 10.7 ms (5 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:04:24-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 620.7 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:04:33-08:00 DEBUG metabase.middleware.log GET /api/collection 200 183.5 ms (3 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:04:35-08:00 INFO metabase.api.card Card results metadata passed in to API is VALID. Thanks!
2019-11-25T12:04:36-08:00 DEBUG metabase.async.util Running metabase.api.card$save_new_card_async_BANG_$fn__47818@1818a805 on separate thread...
2019-11-25T12:04:36-08:00 DEBUG metabase.middleware.log POST /api/card 200 [ASYNC: completed] 229.8 ms (27 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 2
2019-11-25T12:04:38-08:00 DEBUG metabase.middleware.log GET /api/collection/root/items 200 8.8 ms (3 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:04:49-08:00 DEBUG metabase.middleware.log POST /api/dashboard 200 19.8 ms (4 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:04:50-08:00 DEBUG metabase.middleware.log GET /api/dashboard/1 200 19.7 ms (4 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:04:50-08:00 DEBUG metabase.middleware.log GET /api/card 200 39.1 ms (5 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:04:50-08:00 DEBUG metabase.middleware.log POST /api/card/1/query 200 [ASYNC: completed] 78.2 ms (16 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:05:19-08:00 DEBUG metabase.middleware.log GET /api/card 200 12.0 ms (5 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:05:44-08:00 DEBUG metabase.middleware.log GET /api/database/2/metadata 200 255.6 ms (9 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:05:45-08:00 DEBUG metabase.middleware.log GET /api/collection/root/items 200 16.0 ms (3 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:05:45-08:00 DEBUG metabase.middleware.log GET /api/table/26/fks 200 9.2 ms (5 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:05:46-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 76.1 ms (16 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:05:52-08:00 DEBUG metabase.middleware.log GET /api/table/15/fks 200 17.6 ms (5 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:05:53-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 67.5 ms (17 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:06:04-08:00 INFO metabase.automagic-dashboards.core Applying heuristic GenericTable to Datasets table.
2019-11-25T12:06:04-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"GenericCategoryMedium" {:field_type [:entity/GenericTable :type/Category], :score 75, :max_cardinality 10, :matches ("name")},
"Timestamp" {:field_type [:type/DateTime], :score 60, :matches ("updated_at" "inserted_at")},
"FK" {:field_type [:type/FK], :score 100, :matches ("collection_id")}}
2019-11-25T12:06:04-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"], "CountDistinctFKs" ["distinct" ["dimension" "FK"]], "Sum" ["sum" ["dimension" "GenericNumber"]], "Avg" ["avg" ["dimension" "GenericNumber"]]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "Timestamp"] -30 "day"], :score 80}}
2019-11-25T12:06:04-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your Datasets table:
Total Datasets; Datasets added in the last 30 days; Datasets added in the last 30 days; Distinct Collection ID; Datasets per Name; Datasets by Updated At; Datasets by Inserted At; Updated At by day of the week; Inserted At by day of the week; Updated At by hour of the day; Inserted At by hour of the day; Updated At by month of the year; Inserted At by month of the year; Updated At by quarter of the year; Inserted At by quarter of the year
2019-11-25T12:06:04-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/25 200 304.3 ms (44 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:06:04-08:00 DEBUG metabase.middleware.log GET /api/field/59 200 11.1 ms (7 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:06:04-08:00 DEBUG metabase.middleware.log GET /api/field/59/values 200 7.2 ms (3 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:06:04-08:00 DEBUG metabase.middleware.log GET /api/field/58/values 200 10.1 ms (4 DB calls) Jetty threads: 8/50 (1 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:06:04-08:00 DEBUG metabase.middleware.log GET /api/field/60 200 17.4 ms (6 DB calls) Jetty threads: 8/50 (1 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:06:04-08:00 DEBUG metabase.middleware.log GET /api/field/60/values 200 9.2 ms (3 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:06:04-08:00 DEBUG metabase.middleware.log GET /api/field/58 200 16.0 ms (6 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:06:04-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 45.2 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 45.1 ms (14 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 43.5 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 84.1 ms (15 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 1
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 171.6 ms (14 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 3
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 113.9 ms (14 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 2
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 220.6 ms (14 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 3
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 200.7 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 2
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 505.7 ms (17 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 1
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 77.3 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 153.7 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 1
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 134.8 ms (14 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 1
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 101.2 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 1
2019-11-25T12:06:05-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 81.7 ms (14 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 1
2019-11-25T12:06:06-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 196.8 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:06:39-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 10.2 ms (1 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:06:39-08:00 DEBUG metabase.middleware.log GET /api/setup/admin_checklist 200 29.4 ms (11 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:06:39-08:00 DEBUG metabase.middleware.log GET /api/setting 200 1.3 ms (0 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:06:50-08:00 DEBUG metabase.middleware.log GET /api/user 200 6.7 ms (3 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:06:50-08:00 DEBUG metabase.middleware.log GET /api/permissions/group 200 132.2 ms (3 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:06:50-08:00 DEBUG metabase.middleware.log GET /api/permissions/membership 200 2.6 ms (1 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:01-08:00 INFO metabase.models.user Adding User 2 to All Users permissions group...
2019-11-25T12:07:03-08:00 DEBUG metabase.middleware.log POST /api/user 200 2.0 s (11 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:03-08:00 DEBUG metabase.middleware.log GET /api/permissions/membership 200 2.1 ms (1 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:03-08:00 DEBUG metabase.middleware.log GET /api/user 200 29.7 ms (7 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:03-08:00 DEBUG metabase.middleware.log GET /api/user/2 200 4.1 ms (2 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:11-08:00 DEBUG metabase.middleware.log GET /api/database 200 13.1 ms (4 DB calls) Jetty threads: 6/50 (5 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:11-08:00 DEBUG metabase.middleware.log GET /api/permissions/graph 200 69.8 ms (3 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:17-08:00 DEBUG metabase.middleware.log GET /api/collection/root/items 200 17.5 ms (7 DB calls) Jetty threads: 7/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:17-08:00 DEBUG metabase.middleware.log GET /api/database 200 7.9 ms (3 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:17-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/database/2/candidates 200 32.0 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:22-08:00 INFO metabase.automagic-dashboards.core Applying heuristic GenericTable to Schools table.
2019-11-25T12:07:22-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"ZIP" {:field_type [:type/ZipCode], :score 100, :matches ("zip_code")},
"Long" {:field_type [:entity/GenericTable :type/Longitude], :score 100, :matches ("long")},
"Country" {:field_type [:entity/GenericTable :type/Country], :score 100, :matches ("country")},
"GenericCategoryMedium" {:field_type [:entity/GenericTable :type/Category], :score 75, :max_cardinality 10, :matches ("nais_school_id" "address_2" "city" "address_1" "name")},
"Timestamp" {:field_type [:type/DateTime], :score 60, :matches ("updated_at" "inserted_at")},
"Lat" {:field_type [:entity/GenericTable :type/Latitude], :score 100, :matches ("lat")},
"State" {:field_type [:entity/GenericTable :type/State], :score 100, :matches ("state")}}
2019-11-25T12:07:22-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"], "CountDistinctFKs" ["distinct" ["dimension" "FK"]], "Sum" ["sum" ["dimension" "GenericNumber"]], "Avg" ["avg" ["dimension" "GenericNumber"]]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "Timestamp"] -30 "day"], :score 80}}
2019-11-25T12:07:22-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your Schools table:
Total Schools; Schools added in the last 30 days; Schools added in the last 30 days; Schools per Na Is School ID; Schools per Address 2; Schools per City; Schools per Address 1; Schools per Name; Schools per country; Schools per state; Schools by coordinates; Updated At by day of the week; Inserted At by day of the week; Updated At by hour of the day; Inserted At by hour of the day
2019-11-25T12:07:22-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/6 200 564.7 ms (34 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 47.9 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 47.4 ms (13 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 50.9 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 48.2 ms (14 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 44.3 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 50.9 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 46.9 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 62.2 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 1
2019-11-25T12:07:24-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 46.9 ms (14 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:24-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 53.1 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:24-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 48.5 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:24-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 71.5 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 1
2019-11-25T12:07:24-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 76.0 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:24-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 46.9 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:07:24-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 58.1 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:08:07-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 53.0 ms (15 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:12-08:00 INFO metabase.automagic-dashboards.core Applying heuristic GenericTable to Schools table.
2019-11-25T12:08:12-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"ZIP" {:field_type [:type/ZipCode], :score 100, :matches ("zip_code")},
"Long" {:field_type [:entity/GenericTable :type/Longitude], :score 100, :matches ("long")},
"Country" {:field_type [:entity/GenericTable :type/Country], :score 100, :matches ("country")},
"GenericCategoryMedium" {:field_type [:entity/GenericTable :type/Category], :score 75, :max_cardinality 10, :matches ("nais_school_id" "address_2" "city" "address_1" "name")},
"Timestamp" {:field_type [:type/DateTime], :score 60, :matches ("updated_at" "inserted_at")},
"Lat" {:field_type [:entity/GenericTable :type/Latitude], :score 100, :matches ("lat")},
"State" {:field_type [:entity/GenericTable :type/State], :score 100, :matches ("state")}}
2019-11-25T12:08:12-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"], "CountDistinctFKs" ["distinct" ["dimension" "FK"]], "Sum" ["sum" ["dimension" "GenericNumber"]], "Avg" ["avg" ["dimension" "GenericNumber"]]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "Timestamp"] -30 "day"], :score 80}}
2019-11-25T12:08:12-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your Schools table:
Total Schools; Schools added in the last 30 days; Schools added in the last 30 days; Schools per Na Is School ID; Schools per Address 2; Schools per City; Schools per Address 1; Schools per Name; Schools per country; Schools per state; Schools by coordinates; Updated At by day of the week; Inserted At by day of the week; Updated At by hour of the day; Inserted At by hour of the day
2019-11-25T12:08:12-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/6 200 323.5 ms (34 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:13-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 47.7 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:13-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 51.5 ms (13 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:13-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 45.9 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:13-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 45.8 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 1
2019-11-25T12:08:13-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 54.5 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 47.4 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 53.8 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 1
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 90.6 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 60.2 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 64.8 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 1
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 93.7 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 1
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 83.4 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 1
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 51.1 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 47.7 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:14-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 49.9 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:08:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 75.7 ms (17 DB calls) Jetty threads: 4/50 (5 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:08:33-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 69.6 ms (16 DB calls) Jetty threads: 4/50 (5 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:08:55-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 57.6 ms (16 DB calls) Jetty threads: 4/50 (5 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:09:12-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 5.7 ms (1 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:12-08:00 DEBUG metabase.middleware.log GET /api/setup/admin_checklist 200 28.6 ms (11 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:12-08:00 DEBUG metabase.middleware.log GET /api/setting 200 1.0 ms (0 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:22-08:00 DEBUG metabase.middleware.log GET /api/database/2 200 10.5 ms (3 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:22-08:00 DEBUG metabase.middleware.log GET /api/table/6 200 13.8 ms (5 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:22-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 20.4 ms (6 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:26-08:00 DEBUG metabase.middleware.log GET /api/table/6 200 11.6 ms (5 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:26-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 13.3 ms (6 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:26-08:00 DEBUG metabase.middleware.log GET /api/table/6 200 8.7 ms (5 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:28-08:00 DEBUG metabase.middleware.log POST /api/table/6/rescan_values 200 2.6 ms (0 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:09:33-08:00 DEBUG metabase.middleware.log GET /api/table/6 200 8.6 ms (5 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:09:33-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 12.0 ms (6 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:09:54-08:00 DEBUG metabase.middleware.log GET /api/database 200 5.6 ms (3 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:09:54-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/database/2/candidates 200 22.5 ms (6 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:09:56-08:00 INFO metabase.automagic-dashboards.core Applying heuristic UserTable to User Preferences table.
2019-11-25T12:09:56-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"GenericCategoryMedium"
{:field_type [:entity/GenericTable :type/Category], :score 75, :matches ("favorite_zip_codes" "last_name" "age_prefs" "show_tips" "co_number" "co_id" "first_name" "member_type" "hidden_zip_codes")},
"JoinDate" {:field_type [:type/DateTime], :score 30, :matches ("inserted_at" "updated_at")}}
2019-11-25T12:09:56-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "JoinDate"] -30 "day"], :score 100}}
2019-11-25T12:09:56-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your User Preferences table:
Total User Preferences; New User Preferences in the last 30 days; New User Preferences in the last 30 days; User growth; User growth; New User Preferences per month; New User Preferences per month; Per Favorite Zip Codes; Per User → Last Name; Per Age Pre Fs; Per Show Tips; Per User → Co Number; Per User → Co ID; Per User → First Name; Per User → Member Type
2019-11-25T12:09:56-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/12 200 170.3 ms (44 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log GET /api/field/347 200 14.1 ms (7 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log GET /api/field/347/values 200 4.9 ms (3 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (67 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log GET /api/field/343 200 10.3 ms (6 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log GET /api/field/343/values 200 6.7 ms (4 DB calls) Jetty threads: 7/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log GET /api/field/349 200 8.9 ms (6 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log GET /api/field/349/values 200 7.4 ms (4 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log GET /api/field/344/values 200 6.2 ms (4 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log GET /api/field/344 200 9.9 ms (6 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 41.8 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 48.1 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 52.1 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 101.5 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 73.0 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 74.9 ms (13 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:57-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 73.0 ms (13 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:09:58-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 111.7 ms (15 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:09:58-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 70.4 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:58-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 55.4 ms (15 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:09:58-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 54.1 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:58-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 54.0 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:09:58-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 59.6 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:58-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 65.2 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:09:58-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 64.3 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:13-08:00 DEBUG metabase.middleware.log GET /api/database 200 5.6 ms (3 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:13-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/database/2/candidates 200 31.0 ms (6 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:18-08:00 INFO metabase.automagic-dashboards.core Applying heuristic UserTable to Users table.
2019-11-25T12:10:18-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"JoinDate" {:field_type [:type/DateTime], :score 30, :matches ("inserted_at" "updated_at")},
"Name" {:field_type [:type/Name], :score 100, :matches ("last_name" "first_name")},
"GenericCategoryMedium"
{:field_type [:entity/GenericTable :type/Category], :score 75, :matches ("co_number" "country" "nais_school_id" "address_2" "co_id" "city" "member_type" "address_1" "name" "state")},
"Long" {:field_type [:entity/GenericTable :type/Longitude], :score 100, :matches ("long")},
"Lat" {:field_type [:entity/GenericTable :type/Latitude], :score 100, :matches ("lat")}}
2019-11-25T12:10:18-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "JoinDate"] -30 "day"], :score 100}}
2019-11-25T12:10:18-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your Users table:
Total Users; New Users in the last 30 days; New Users in the last 30 days; User growth; User growth; New Users per month; New Users per month; By coordinates; Per Co Number; Per School → Country; Per School → Na Is School ID; Per School → Address 2; Per Co ID; Per School → City; Per Member Type
2019-11-25T12:10:18-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/7 200 266.8 ms (50 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:18-08:00 DEBUG metabase.middleware.log GET /api/field/361/values 200 24.1 ms (4 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:18-08:00 DEBUG metabase.middleware.log GET /api/field/361 200 28.9 ms (7 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 78.0 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 151.1 ms (14 DB calls) Jetty threads: 7/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 94.6 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 3
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 187.3 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 119.8 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 112.9 ms (13 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 64.6 ms (13 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 133.6 ms (18 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 93.9 ms (15 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 223.8 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 233.3 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 140.2 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:19-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 188.4 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:20-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 223.4 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:20-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 71.7 ms (16 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:28-08:00 INFO metabase.automagic-dashboards.core Applying heuristic UserTable to Users table.
2019-11-25T12:10:28-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"JoinDate" {:field_type [:type/DateTime], :score 30, :matches ("inserted_at" "updated_at")},
"Name" {:field_type [:type/Name], :score 100, :matches ("last_name" "first_name")},
"GenericCategoryMedium"
{:field_type [:entity/GenericTable :type/Category], :score 75, :matches ("co_number" "country" "nais_school_id" "address_2" "co_id" "city" "member_type" "address_1" "name" "state")},
"Long" {:field_type [:entity/GenericTable :type/Longitude], :score 100, :matches ("long")},
"Lat" {:field_type [:entity/GenericTable :type/Latitude], :score 100, :matches ("lat")}}
2019-11-25T12:10:28-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "JoinDate"] -30 "day"], :score 100}}
2019-11-25T12:10:29-08:00 INFO metabase.automagic-dashboards.populate Adding 18 cards to dashboard A look at your Users table:
Total Users; New Users in the last 30 days; New Users in the last 30 days; User growth; User growth; New Users per month; New Users per month; By coordinates; Per Co Number; Per School → Country; Per School → Na Is School ID; Per School → Address 2; Per Co ID; Per School → City; Per Member Type; Per School → Address 1; Per School → Name; Per School → State
2019-11-25T12:10:29-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/7 200 259.5 ms (50 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 73.4 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 57.8 ms (13 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 116.4 ms (13 DB calls) Jetty threads: 5/50 (1 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 68.9 ms (13 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 70.6 ms (13 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 53.8 ms (13 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 117.7 ms (17 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 67.2 ms (17 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 87.9 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 100.0 ms (17 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 83.1 ms (17 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 60.3 ms (14 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 80.5 ms (15 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 190.9 ms (18 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T12:10:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 155.7 ms (12 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 2
2019-11-25T12:10:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 146.5 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:10:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 201.1 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:10:32-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 85.0 ms (18 DB calls) Jetty threads: 4/50 (2 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:18:40-08:00 INFO metabase.automagic-dashboards.core Applying heuristic GenericTable to Authors table.
2019-11-25T12:18:40-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"GenericNumber" {:field_type [:entity/GenericTable :type/Number], :score 80, :matches ("reports_generated")},
"GenericCategoryMedium" {:field_type [:entity/GenericTable :type/Category], :score 75, :max_cardinality 10, :matches ("co_number" "member_type")},
"Date" {:field_type [:entity/GenericTable :type/Date], :score 50, :matches ("reset_at")},
"Timestamp" {:field_type [:type/DateTime], :score 60, :matches ("updated_at" "inserted_at")},
"FK" {:field_type [:type/FK], :score 100, :matches ("user_id")}}
2019-11-25T12:18:40-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"], "CountDistinctFKs" ["distinct" ["dimension" "FK"]], "Sum" ["sum" ["dimension" "GenericNumber"]], "Avg" ["avg" ["dimension" "GenericNumber"]]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "Timestamp"] -30 "day"], :score 80}}
2019-11-25T12:18:40-08:00 INFO metabase.automagic-dashboards.populate Adding 14 cards to dashboard A look at your Authors table:
Total Authors; Authors added in the last 30 days; Authors added in the last 30 days; Distinct User ID; Authors by Reports Generated; Authors per User → Co Number; Authors per User → Member Type; Authors by Timestamp; Reports Generated over time; Timestamp by day of the week; Updated At by hour of the day; Inserted At by hour of the day; Timestamp by month of the year; Timestamp by quarter of the year
2019-11-25T12:18:41-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/26 200 679.5 ms (49 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (62 total active threads) Queries in flight: 0
2019-11-25T12:18:41-08:00 DEBUG metabase.middleware.log GET /api/field/350 200 12.1 ms (6 DB calls) Jetty threads: 6/50 (1 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T12:18:41-08:00 DEBUG metabase.middleware.log GET /api/field/350/values 200 9.6 ms (4 DB calls) Jetty threads: 8/50 (1 idle, 4 queued) (66 total active threads) Queries in flight: 0
2019-11-25T12:18:41-08:00 DEBUG metabase.middleware.log GET /api/field/40/values 200 17.8 ms (4 DB calls) Jetty threads: 8/50 (3 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:41-08:00 DEBUG metabase.middleware.log GET /api/field/41 200 12.4 ms (6 DB calls) Jetty threads: 7/50 (3 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:41-08:00 DEBUG metabase.middleware.log GET /api/field/41/values 200 9.8 ms (3 DB calls) Jetty threads: 7/50 (3 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:41-08:00 DEBUG metabase.middleware.log GET /api/field/40 200 24.5 ms (6 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:42-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 54.8 ms (14 DB calls) Jetty threads: 5/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:42-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 52.7 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:42-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 88.5 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 1
2019-11-25T12:18:42-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 53.5 ms (17 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 1
2019-11-25T12:18:42-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 87.1 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 1
2019-11-25T12:18:42-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 75.2 ms (18 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:42-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 63.4 ms (18 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:42-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 50.9 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:42-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 59.5 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:43-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 46.9 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 2
2019-11-25T12:18:43-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 48.4 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 1
2019-11-25T12:18:43-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 51.8 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:43-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 55.6 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:18:43-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 59.9 ms (14 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:04-08:00 DEBUG metabase.middleware.log GET /api/search 200 55.7 ms (3 DB calls) Jetty threads: 5/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:11-08:00 DEBUG metabase.middleware.log GET /api/table/23/fks 200 10.5 ms (5 DB calls) Jetty threads: 5/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:12-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 235.3 ms (17 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 95.0 ms (17 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:36-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 2.4 s (16 DB calls) Jetty threads: 4/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:38-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 17.0 ms (1 DB calls) Jetty threads: 6/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:38-08:00 DEBUG metabase.middleware.log GET /api/setup/admin_checklist 200 49.8 ms (11 DB calls) Jetty threads: 5/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:38-08:00 DEBUG metabase.middleware.log GET /api/setting 200 1.6 ms (0 DB calls) Jetty threads: 5/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:41-08:00 DEBUG metabase.middleware.log GET /api/table/26 200 14.6 ms (5 DB calls) Jetty threads: 6/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:41-08:00 DEBUG metabase.middleware.log GET /api/database/2/idfields 200 48.9 ms (6 DB calls) Jetty threads: 5/50 (6 idle, 0 queued) (73 total active threads) Queries in flight: 0
2019-11-25T12:19:49-08:00 DEBUG metabase.middleware.log GET /api/table/12 200 12.2 ms (5 DB calls) Jetty threads: 5/50 (8 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:20:08-08:00 DEBUG metabase.middleware.log PUT /api/field/347 200 33.5 ms (5 DB calls) Jetty threads: 5/50 (8 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:20:11-08:00 DEBUG metabase.middleware.log GET /api/table/14 200 141.6 ms (5 DB calls) Jetty threads: 5/50 (8 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:20:21-08:00 DEBUG metabase.middleware.log PUT /api/field/54 200 10.4 ms (5 DB calls) Jetty threads: 5/50 (8 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:20:40-08:00 DEBUG metabase.middleware.log GET /api/database 200 101.1 ms (3 DB calls) Jetty threads: 5/50 (6 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:20:40-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/database/2/candidates 200 73.9 ms (6 DB calls) Jetty threads: 5/50 (6 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:20:45-08:00 DEBUG metabase.middleware.log GET /api/collection/root 200 29.6 ms (2 DB calls) Jetty threads: 5/50 (6 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T12:20:53-08:00 DEBUG metabase.middleware.log GET /api/dashboard/1 200 10.6 ms (4 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:20:57-08:00 DEBUG metabase.middleware.log GET /api/collection/root 200 3.9 ms (2 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:20:58-08:00 DEBUG metabase.middleware.log GET /api/dashboard/1 200 125.2 ms (4 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:00-08:00 DEBUG metabase.middleware.log GET /api/collection/root 200 16.3 ms (2 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:08-08:00 DEBUG metabase.async.util Running metabase.api.card$update_card_async_BANG_$fn__48002@4687ae05 on separate thread...
2019-11-25T12:21:08-08:00 DEBUG metabase.middleware.log PUT /api/card/1 200 [ASYNC: completed] 742.8 ms (8 DB calls) Jetty threads: 4/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 1
2019-11-25T12:21:09-08:00 DEBUG metabase.middleware.log GET /api/collection/root/items 200 32.8 ms (7 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:14-08:00 DEBUG metabase.middleware.log GET /api/dashboard/1 200 139.0 ms (4 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:15-08:00 DEBUG metabase.middleware.log GET /api/collection/root/items 200 21.0 ms (4 DB calls) Jetty threads: 6/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:15-08:00 DEBUG metabase.middleware.log GET /api/card 200 27.6 ms (5 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:17-08:00 DEBUG metabase.middleware.log POST /api/card/1/query 200 [ASYNC: completed] 114.2 ms (15 DB calls) Jetty threads: 4/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:21-08:00 DEBUG metabase.middleware.log POST /api/dashboard/1/cards 200 669.5 ms (14 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:21-08:00 DEBUG metabase.middleware.log PUT /api/dashboard/1/cards 200 233.0 ms (14 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:22-08:00 DEBUG metabase.middleware.log PUT /api/dashboard/1 200 49.5 ms (5 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:21:22-08:00 DEBUG metabase.middleware.log GET /api/dashboard/1 200 190.5 ms (7 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: Sync metadata for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-timezone' for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-timezone' for h2 Database 1 'Sample Dataset' (50.7 ms)
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-tables' for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-tables' for h2 Database 1 'Sample Dataset' (47.2 ms)
2019-11-25T12:50:00-08:00 INFO metabase.sync.sync-metadata.tables Updating description for tables: (Table 'PUBLIC.PEOPLE' Table 'PUBLIC.REVIEWS' Table 'PUBLIC.ORDERS' Table 'PUBLIC.PRODUCTS')
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fields' for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-fields' for h2 Database 1 'Sample Dataset' (64.7 ms)
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fks' for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-fks' for h2 Database 1 'Sample Dataset' (29.0 ms)
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-metabase-metadata' for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-metabase-metadata' for h2 Database 1 'Sample Dataset' (334.7 ms)
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: Sync metadata for h2 Database 1 'Sample Dataset' (550.1 ms)
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: Analyze data for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: step 'fingerprint-fields' for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [*******···········································] 😞 15% Table 3 'PUBLIC.PEOPLE'
2019-11-25T12:50:00-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [***************···································] 😕 31% Table 4 'PUBLIC.REVIEWS'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: step 'fingerprint-fields' for h2 Database 1 'Sample Dataset' (20.6 ms)
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: step 'classify-fields' for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.analyze classify-fields Analyzed [***********************···························] 😬 46% Table 3 'PUBLIC.PEOPLE'
2019-11-25T12:50:00-08:00 INFO metabase.sync.analyze classify-fields Analyzed [******************************····················] 😌 62% Table 4 'PUBLIC.REVIEWS'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: step 'classify-fields' for h2 Database 1 'Sample Dataset' (8.1 ms)
2019-11-25T12:50:00-08:00 INFO metabase.sync.util STARTING: step 'classify-tables' for h2 Database 1 'Sample Dataset'
2019-11-25T12:50:00-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**************************************············] 😋 77% Table 3 'PUBLIC.PEOPLE'
2019-11-25T12:50:00-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************************····] 😍 92% Table 4 'PUBLIC.REVIEWS'
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: step 'classify-tables' for h2 Database 1 'Sample Dataset' (4.0 ms)
2019-11-25T12:50:00-08:00 INFO metabase.sync.util FINISHED: Analyze data for h2 Database 1 'Sample Dataset' (52.2 ms)
2019-11-25T13:00:00-08:00 INFO metabase.sync.util STARTING: Sync metadata for postgres Database 2 'Market View'
2019-11-25T13:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-timezone' for postgres Database 2 'Market View'
2019-11-25T13:00:00-08:00 INFO metabase.task.send-pulses Sending scheduled pulses...
2019-11-25T13:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-timezone' for postgres Database 2 'Market View' (23.5 ms)
2019-11-25T13:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-tables' for postgres Database 2 'Market View'
2019-11-25T13:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-tables' for postgres Database 2 'Market View' (29.5 ms)
2019-11-25T13:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fields' for postgres Database 2 'Market View'
2019-11-25T13:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T13:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_varchar' to a Field base_type, falling back to :type/*.
2019-11-25T13:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_int4' to a Field base_type, falling back to :type/*.
2019-11-25T13:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T13:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-fields' for postgres Database 2 'Market View' (1.0 s)
2019-11-25T13:00:01-08:00 INFO metabase.sync.util STARTING: step 'sync-fks' for postgres Database 2 'Market View'
2019-11-25T13:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-fks' for postgres Database 2 'Market View' (251.7 ms)
2019-11-25T13:00:01-08:00 INFO metabase.sync.util STARTING: step 'sync-metabase-metadata' for postgres Database 2 'Market View'
2019-11-25T13:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-metabase-metadata' for postgres Database 2 'Market View' (21.0 ms)
2019-11-25T13:00:01-08:00 INFO metabase.sync.util FINISHED: Sync metadata for postgres Database 2 'Market View' (1.4 s)
2019-11-25T13:00:01-08:00 INFO metabase.sync.util STARTING: Analyze data for postgres Database 2 'Market View'
2019-11-25T13:00:01-08:00 INFO metabase.sync.util STARTING: step 'fingerprint-fields' for postgres Database 2 'Market View'
2019-11-25T13:00:01-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [*****·············································] 😢 12% Table 23 'public.cbsas'
2019-11-25T13:00:01-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [***********·······································] 😒 23% Table 14 'public.dataitems'
2019-11-25T13:00:01-08:00 INFO metabase.sync.util FINISHED: step 'fingerprint-fields' for postgres Database 2 'Market View' (93.9 ms)
2019-11-25T13:00:01-08:00 INFO metabase.sync.util STARTING: step 'classify-fields' for postgres Database 2 'Market View'
2019-11-25T13:00:01-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************·································] 😕 35% Table 12 'public.user_preferences'
2019-11-25T13:00:01-08:00 INFO metabase.sync.analyze classify-fields Analyzed [***********************···························] 😬 47% Table 26 'public.authors'
2019-11-25T13:00:01-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************************·····················] 😌 58% Table 5 'public.nces_schools'
2019-11-25T13:00:01-08:00 INFO metabase.sync.util FINISHED: step 'classify-fields' for postgres Database 2 'Market View' (38.8 ms)
2019-11-25T13:00:01-08:00 INFO metabase.sync.util STARTING: step 'classify-tables' for postgres Database 2 'Market View'
2019-11-25T13:00:01-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************················] 😏 70% Table 20 'public.us_counties'
2019-11-25T13:00:01-08:00 INFO metabase.sync.analyze classify-tables Analyzed [****************************************··········] 😊 81% Table 15 'public.collections'
2019-11-25T13:00:01-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************************····] 😍 93% Table 7 'public.users'
2019-11-25T13:00:01-08:00 INFO metabase.sync.util FINISHED: step 'classify-tables' for postgres Database 2 'Market View' (29.5 ms)
2019-11-25T13:00:01-08:00 INFO metabase.sync.util FINISHED: Analyze data for postgres Database 2 'Market View' (203.3 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: Sync metadata for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-timezone' for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-timezone' for h2 Database 1 'Sample Dataset' (4.7 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-tables' for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-tables' for h2 Database 1 'Sample Dataset' (9.4 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fields' for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.sync-metadata.tables Updating description for tables: (Table 'PUBLIC.PEOPLE' Table 'PUBLIC.REVIEWS' Table 'PUBLIC.ORDERS' Table 'PUBLIC.PRODUCTS')
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-fields' for h2 Database 1 'Sample Dataset' (41.7 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fks' for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-fks' for h2 Database 1 'Sample Dataset' (10.0 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-metabase-metadata' for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-metabase-metadata' for h2 Database 1 'Sample Dataset' (250.4 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: Sync metadata for h2 Database 1 'Sample Dataset' (332.9 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: Analyze data for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: step 'fingerprint-fields' for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [*******···········································] 😞 15% Table 3 'PUBLIC.PEOPLE'
2019-11-25T13:50:00-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [***************···································] 😕 31% Table 4 'PUBLIC.REVIEWS'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: step 'fingerprint-fields' for h2 Database 1 'Sample Dataset' (11.6 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: step 'classify-fields' for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.analyze classify-fields Analyzed [***********************···························] 😬 46% Table 3 'PUBLIC.PEOPLE'
2019-11-25T13:50:00-08:00 INFO metabase.sync.analyze classify-fields Analyzed [******************************····················] 😌 62% Table 4 'PUBLIC.REVIEWS'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: step 'classify-fields' for h2 Database 1 'Sample Dataset' (6.9 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**************************************············] 😋 77% Table 3 'PUBLIC.PEOPLE'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util STARTING: step 'classify-tables' for h2 Database 1 'Sample Dataset'
2019-11-25T13:50:00-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************************····] 😍 92% Table 4 'PUBLIC.REVIEWS'
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: step 'classify-tables' for h2 Database 1 'Sample Dataset' (2.5 ms)
2019-11-25T13:50:00-08:00 INFO metabase.sync.util FINISHED: Analyze data for h2 Database 1 'Sample Dataset' (35.1 ms)
2019-11-25T14:00:00-08:00 INFO metabase.sync.util STARTING: Sync metadata for postgres Database 2 'Market View'
2019-11-25T14:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-timezone' for postgres Database 2 'Market View'
2019-11-25T14:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-timezone' for postgres Database 2 'Market View' (25.3 ms)
2019-11-25T14:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-tables' for postgres Database 2 'Market View'
2019-11-25T14:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-tables' for postgres Database 2 'Market View' (19.4 ms)
2019-11-25T14:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fields' for postgres Database 2 'Market View'
2019-11-25T14:00:00-08:00 INFO metabase.task.send-pulses Sending scheduled pulses...
2019-11-25T14:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T14:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_varchar' to a Field base_type, falling back to :type/*.
2019-11-25T14:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_varchar' to a Field base_type, falling back to :type/*.
2019-11-25T14:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_int4' to a Field base_type, falling back to :type/*.
2019-11-25T14:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T14:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-fields' for postgres Database 2 'Market View' (902.8 ms)
2019-11-25T14:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fks' for postgres Database 2 'Market View'
2019-11-25T14:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-fks' for postgres Database 2 'Market View' (331.1 ms)
2019-11-25T14:00:01-08:00 INFO metabase.sync.util STARTING: step 'sync-metabase-metadata' for postgres Database 2 'Market View'
2019-11-25T14:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-metabase-metadata' for postgres Database 2 'Market View' (15.3 ms)
2019-11-25T14:00:01-08:00 INFO metabase.sync.util FINISHED: Sync metadata for postgres Database 2 'Market View' (1.3 s)
2019-11-25T14:00:01-08:00 INFO metabase.sync.util STARTING: Analyze data for postgres Database 2 'Market View'
2019-11-25T14:00:01-08:00 INFO metabase.sync.util STARTING: step 'fingerprint-fields' for postgres Database 2 'Market View'
2019-11-25T14:00:01-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [*****·············································] 😢 12% Table 23 'public.cbsas'
2019-11-25T14:00:01-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [***********·······································] 😒 23% Table 14 'public.dataitems'
2019-11-25T14:00:01-08:00 INFO metabase.sync.util FINISHED: step 'fingerprint-fields' for postgres Database 2 'Market View' (106.7 ms)
2019-11-25T14:00:01-08:00 INFO metabase.sync.util STARTING: step 'classify-fields' for postgres Database 2 'Market View'
2019-11-25T14:00:01-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************·································] 😕 35% Table 12 'public.user_preferences'
2019-11-25T14:00:01-08:00 INFO metabase.sync.analyze classify-fields Analyzed [***********************···························] 😬 47% Table 26 'public.authors'
2019-11-25T14:00:01-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************************·····················] 😌 58% Table 5 'public.nces_schools'
2019-11-25T14:00:01-08:00 INFO metabase.sync.util FINISHED: step 'classify-fields' for postgres Database 2 'Market View' (39.7 ms)
2019-11-25T14:00:01-08:00 INFO metabase.sync.util STARTING: step 'classify-tables' for postgres Database 2 'Market View'
2019-11-25T14:00:01-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************················] 😏 70% Table 20 'public.us_counties'
2019-11-25T14:00:01-08:00 INFO metabase.sync.analyze classify-tables Analyzed [****************************************··········] 😊 81% Table 15 'public.collections'
2019-11-25T14:00:01-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************************····] 😍 93% Table 7 'public.users'
2019-11-25T14:00:01-08:00 INFO metabase.sync.util FINISHED: step 'classify-tables' for postgres Database 2 'Market View' (33.6 ms)
2019-11-25T14:00:01-08:00 INFO metabase.sync.util FINISHED: Analyze data for postgres Database 2 'Market View' (202.0 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: Sync metadata for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-timezone' for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-timezone' for h2 Database 1 'Sample Dataset' (3.8 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-tables' for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-tables' for h2 Database 1 'Sample Dataset' (13.9 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fields' for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.sync-metadata.tables Updating description for tables: (Table 'PUBLIC.PEOPLE' Table 'PUBLIC.REVIEWS' Table 'PUBLIC.ORDERS' Table 'PUBLIC.PRODUCTS')
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-fields' for h2 Database 1 'Sample Dataset' (83.3 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fks' for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-fks' for h2 Database 1 'Sample Dataset' (12.1 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: step 'sync-metabase-metadata' for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-metabase-metadata' for h2 Database 1 'Sample Dataset' (293.1 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: Sync metadata for h2 Database 1 'Sample Dataset' (429.7 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: Analyze data for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: step 'fingerprint-fields' for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [*******···········································] 😞 15% Table 1 'PUBLIC.PRODUCTS'
2019-11-25T14:50:00-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [***************···································] 😕 31% Table 2 'PUBLIC.ORDERS'
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: step 'fingerprint-fields' for h2 Database 1 'Sample Dataset' (17.9 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: step 'classify-fields' for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.analyze classify-fields Analyzed [***********************···························] 😬 46% Table 1 'PUBLIC.PRODUCTS'
2019-11-25T14:50:00-08:00 INFO metabase.sync.analyze classify-fields Analyzed [******************************····················] 😌 62% Table 2 'PUBLIC.ORDERS'
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: step 'classify-fields' for h2 Database 1 'Sample Dataset' (8.0 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util STARTING: step 'classify-tables' for h2 Database 1 'Sample Dataset'
2019-11-25T14:50:00-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**************************************············] 😋 77% Table 1 'PUBLIC.PRODUCTS'
2019-11-25T14:50:00-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************************····] 😍 92% Table 2 'PUBLIC.ORDERS'
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: step 'classify-tables' for h2 Database 1 'Sample Dataset' (4.9 ms)
2019-11-25T14:50:00-08:00 INFO metabase.sync.util FINISHED: Analyze data for h2 Database 1 'Sample Dataset' (48.4 ms)
2019-11-25T15:00:00-08:00 INFO metabase.sync.util STARTING: Sync metadata for postgres Database 2 'Market View'
2019-11-25T15:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-timezone' for postgres Database 2 'Market View'
2019-11-25T15:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-timezone' for postgres Database 2 'Market View' (28.5 ms)
2019-11-25T15:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-tables' for postgres Database 2 'Market View'
2019-11-25T15:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-tables' for postgres Database 2 'Market View' (23.7 ms)
2019-11-25T15:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fields' for postgres Database 2 'Market View'
2019-11-25T15:00:00-08:00 INFO metabase.task.send-pulses Sending scheduled pulses...
2019-11-25T15:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T15:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_varchar' to a Field base_type, falling back to :type/*.
2019-11-25T15:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_varchar' to a Field base_type, falling back to :type/*.
2019-11-25T15:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_int4' to a Field base_type, falling back to :type/*.
2019-11-25T15:00:00-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T15:00:00-08:00 INFO metabase.sync.util FINISHED: step 'sync-fields' for postgres Database 2 'Market View' (830.6 ms)
2019-11-25T15:00:00-08:00 INFO metabase.sync.util STARTING: step 'sync-fks' for postgres Database 2 'Market View'
2019-11-25T15:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-fks' for postgres Database 2 'Market View' (221.5 ms)
2019-11-25T15:00:01-08:00 INFO metabase.sync.util STARTING: step 'sync-metabase-metadata' for postgres Database 2 'Market View'
2019-11-25T15:00:01-08:00 INFO metabase.sync.util FINISHED: step 'sync-metabase-metadata' for postgres Database 2 'Market View' (13.3 ms)
2019-11-25T15:00:01-08:00 INFO metabase.sync.util FINISHED: Sync metadata for postgres Database 2 'Market View' (1.1 s)
2019-11-25T15:00:01-08:00 INFO metabase.sync.util STARTING: Analyze data for postgres Database 2 'Market View'
2019-11-25T15:00:01-08:00 INFO metabase.sync.util STARTING: step 'fingerprint-fields' for postgres Database 2 'Market View'
2019-11-25T15:00:01-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [*****·············································] 😢 12% Table 23 'public.cbsas'
2019-11-25T15:00:01-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [***********·······································] 😒 23% Table 14 'public.dataitems'
2019-11-25T15:00:01-08:00 INFO metabase.sync.util FINISHED: step 'fingerprint-fields' for postgres Database 2 'Market View' (53.3 ms)
2019-11-25T15:00:01-08:00 INFO metabase.sync.util STARTING: step 'classify-fields' for postgres Database 2 'Market View'
2019-11-25T15:00:01-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************·································] 😕 35% Table 12 'public.user_preferences'
2019-11-25T15:00:01-08:00 INFO metabase.sync.analyze classify-fields Analyzed [***********************···························] 😬 47% Table 26 'public.authors'
2019-11-25T15:00:01-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************************·····················] 😌 58% Table 5 'public.nces_schools'
2019-11-25T15:00:01-08:00 INFO metabase.sync.util FINISHED: step 'classify-fields' for postgres Database 2 'Market View' (23.1 ms)
2019-11-25T15:00:01-08:00 INFO metabase.sync.util STARTING: step 'classify-tables' for postgres Database 2 'Market View'
2019-11-25T15:00:01-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************················] 😏 70% Table 20 'public.us_counties'
2019-11-25T15:00:01-08:00 INFO metabase.sync.analyze classify-tables Analyzed [****************************************··········] 😊 81% Table 15 'public.collections'
2019-11-25T15:00:01-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************************····] 😍 93% Table 7 'public.users'
2019-11-25T15:00:01-08:00 INFO metabase.sync.util FINISHED: step 'classify-tables' for postgres Database 2 'Market View' (22.9 ms)
2019-11-25T15:00:01-08:00 INFO metabase.sync.util FINISHED: Analyze data for postgres Database 2 'Market View' (115.9 ms)
2019-11-25T15:01:36-08:00 INFO metabase.middleware.exceptions Request canceled before finishing.
2019-11-25T15:01:37-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 16.9 ms (1 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (65 total active threads) Queries in flight: 0
2019-11-25T15:01:37-08:00 DEBUG metabase.middleware.log GET /api/user/current 200 11.5 ms (3 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (66 total active threads) Queries in flight: 0
2019-11-25T15:01:37-08:00 DEBUG metabase.middleware.log GET /api/database 200 10.7 ms (4 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T15:01:37-08:00 DEBUG metabase.middleware.log GET /api/setting 200 1.1 ms (0 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T15:01:37-08:00 DEBUG metabase.middleware.log GET /api/collection/root/items 200 51.2 ms (7 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (68 total active threads) Queries in flight: 0
2019-11-25T15:01:38-08:00 DEBUG metabase.middleware.log GET /api/collection/root 200 51.5 ms (2 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T15:01:38-08:00 DEBUG metabase.middleware.log GET /api/database 200 6.3 ms (3 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T15:01:38-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/database/2/candidates 200 43.9 ms (6 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T15:01:43-08:00 INFO metabase.automagic-dashboards.core Applying heuristic GenericTable to Schools table.
2019-11-25T15:01:43-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"ZIP" {:field_type [:type/ZipCode], :score 100, :matches ("zip_code")},
"Long" {:field_type [:entity/GenericTable :type/Longitude], :score 100, :matches ("long")},
"Country" {:field_type [:entity/GenericTable :type/Country], :score 100, :matches ("country")},
"GenericCategoryMedium" {:field_type [:entity/GenericTable :type/Category], :score 75, :max_cardinality 10, :matches ("nais_school_id" "address_2" "city" "address_1" "name")},
"Timestamp" {:field_type [:type/DateTime], :score 60, :matches ("updated_at" "inserted_at")},
"Lat" {:field_type [:entity/GenericTable :type/Latitude], :score 100, :matches ("lat")},
"State" {:field_type [:entity/GenericTable :type/State], :score 100, :matches ("state")}}
2019-11-25T15:01:43-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"], "CountDistinctFKs" ["distinct" ["dimension" "FK"]], "Sum" ["sum" ["dimension" "GenericNumber"]], "Avg" ["avg" ["dimension" "GenericNumber"]]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "Timestamp"] -30 "day"], :score 80}}
2019-11-25T15:01:43-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your Schools table:
Total Schools; Schools added in the last 30 days; Schools added in the last 30 days; Schools per Na Is School ID; Schools per Address 2; Schools per City; Schools per Address 1; Schools per Name; Schools per country; Schools per state; Schools by coordinates; Updated At by day of the week; Inserted At by day of the week; Updated At by hour of the day; Inserted At by hour of the day
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/6 200 683.5 ms (34 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/field/336/values 200 7.4 ms (4 DB calls) Jetty threads: 10/50 (1 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/field/331/values 200 29.7 ms (4 DB calls) Jetty threads: 9/50 (2 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/field/330 200 20.7 ms (6 DB calls) Jetty threads: 8/50 (2 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/field/331 200 109.9 ms (7 DB calls) Jetty threads: 8/50 (2 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/field/336 200 36.1 ms (6 DB calls) Jetty threads: 6/50 (2 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/database/2/metadata 200 161.1 ms (9 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/field/330/values 200 21.1 ms (4 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/field/332 200 16.5 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:44-08:00 DEBUG metabase.middleware.log GET /api/field/332/values 200 4.9 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 89.9 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 2
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 56.5 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 48.8 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 52.9 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 66.1 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 103.1 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 73.8 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 2
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 82.4 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 91.2 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 55.2 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 49.3 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 61.2 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 48.3 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 62.5 ms (13 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:01:45-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 59.1 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:02:37-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 6.6 ms (1 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:02:37-08:00 DEBUG metabase.middleware.log GET /api/setup/admin_checklist 200 24.2 ms (11 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:02:37-08:00 DEBUG metabase.middleware.log GET /api/setting 200 944.9 µs (0 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (71 total active threads) Queries in flight: 0
2019-11-25T15:08:27-08:00 DEBUG metabase.middleware.log GET /api/database/2 200 4.3 ms (3 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (62 total active threads) Queries in flight: 0
2019-11-25T15:08:35-08:00 DEBUG metabase.middleware.log POST /api/database/2/sync_schema 200 8.9 ms (1 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (64 total active threads) Queries in flight: 0
2019-11-25T15:08:35-08:00 INFO metabase.sync.util STARTING: Sync metadata for postgres Database 2 'Market View'
2019-11-25T15:08:35-08:00 INFO metabase.sync.util STARTING: step 'sync-timezone' for postgres Database 2 'Market View'
2019-11-25T15:08:35-08:00 INFO metabase.sync.util FINISHED: step 'sync-timezone' for postgres Database 2 'Market View' (12.3 ms)
2019-11-25T15:08:35-08:00 INFO metabase.sync.util STARTING: step 'sync-tables' for postgres Database 2 'Market View'
2019-11-25T15:08:35-08:00 INFO metabase.sync.util FINISHED: step 'sync-tables' for postgres Database 2 'Market View' (14.5 ms)
2019-11-25T15:08:35-08:00 INFO metabase.sync.util STARTING: step 'sync-fields' for postgres Database 2 'Market View'
2019-11-25T15:08:35-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T15:08:35-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_varchar' to a Field base_type, falling back to :type/*.
2019-11-25T15:08:35-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_varchar' to a Field base_type, falling back to :type/*.
2019-11-25T15:08:35-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_int4' to a Field base_type, falling back to :type/*.
2019-11-25T15:08:35-08:00 WARN metabase.driver.sql-jdbc.sync Don't know how to map column type '_jsonb' to a Field base_type, falling back to :type/*.
2019-11-25T15:08:36-08:00 INFO metabase.sync.util FINISHED: step 'sync-fields' for postgres Database 2 'Market View' (805.8 ms)
2019-11-25T15:08:36-08:00 INFO metabase.sync.util STARTING: step 'sync-fks' for postgres Database 2 'Market View'
2019-11-25T15:08:36-08:00 INFO metabase.sync.util FINISHED: step 'sync-fks' for postgres Database 2 'Market View' (181.2 ms)
2019-11-25T15:08:36-08:00 INFO metabase.sync.util STARTING: step 'sync-metabase-metadata' for postgres Database 2 'Market View'
2019-11-25T15:08:36-08:00 INFO metabase.sync.util FINISHED: step 'sync-metabase-metadata' for postgres Database 2 'Market View' (13.7 ms)
2019-11-25T15:08:36-08:00 INFO metabase.sync.util FINISHED: Sync metadata for postgres Database 2 'Market View' (1.1 s)
2019-11-25T15:08:36-08:00 INFO metabase.sync.util STARTING: Analyze data for postgres Database 2 'Market View'
2019-11-25T15:08:36-08:00 INFO metabase.sync.util STARTING: step 'fingerprint-fields' for postgres Database 2 'Market View'
2019-11-25T15:08:36-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [*****·············································] 😢 12% Table 23 'public.cbsas'
2019-11-25T15:08:36-08:00 INFO metabase.sync.analyze fingerprint-fields Analyzed [***********·······································] 😒 23% Table 14 'public.dataitems'
2019-11-25T15:08:36-08:00 INFO metabase.sync.util FINISHED: step 'fingerprint-fields' for postgres Database 2 'Market View' (68.4 ms)
2019-11-25T15:08:36-08:00 INFO metabase.sync.util STARTING: step 'classify-fields' for postgres Database 2 'Market View'
2019-11-25T15:08:36-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************·································] 😕 35% Table 12 'public.user_preferences'
2019-11-25T15:08:36-08:00 INFO metabase.sync.analyze classify-fields Analyzed [***********************···························] 😬 47% Table 26 'public.authors'
2019-11-25T15:08:36-08:00 INFO metabase.sync.analyze classify-fields Analyzed [*****************************·····················] 😌 58% Table 5 'public.nces_schools'
2019-11-25T15:08:36-08:00 INFO metabase.sync.util FINISHED: step 'classify-fields' for postgres Database 2 'Market View' (24.9 ms)
2019-11-25T15:08:36-08:00 INFO metabase.sync.util STARTING: step 'classify-tables' for postgres Database 2 'Market View'
2019-11-25T15:08:36-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************················] 😏 70% Table 20 'public.us_counties'
2019-11-25T15:08:36-08:00 INFO metabase.sync.analyze classify-tables Analyzed [****************************************··········] 😊 81% Table 15 'public.collections'
2019-11-25T15:08:36-08:00 INFO metabase.sync.analyze classify-tables Analyzed [**********************************************····] 😍 93% Table 7 'public.users'
2019-11-25T15:08:36-08:00 INFO metabase.sync.util FINISHED: step 'classify-tables' for postgres Database 2 'Market View' (25.0 ms)
2019-11-25T15:08:36-08:00 INFO metabase.sync.util FINISHED: Analyze data for postgres Database 2 'Market View' (139.2 ms)
2019-11-25T15:08:40-08:00 DEBUG metabase.middleware.log POST /api/database/2/rescan_values 200 4.1 ms (1 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (65 total active threads) Queries in flight: 0
2019-11-25T15:08:40-08:00 INFO metabase.sync.util STARTING: Cache field values in postgres Database 2 'Market View'
2019-11-25T15:08:40-08:00 INFO metabase.sync.util STARTING: step 'update-field-values' for postgres Database 2 'Market View'
2019-11-25T15:08:46-08:00 INFO metabase.sync.util FINISHED: step 'update-field-values' for postgres Database 2 'Market View' (5.3 s)
2019-11-25T15:08:46-08:00 INFO metabase.sync.util FINISHED: Cache field values in postgres Database 2 'Market View' (5.3 s)
2019-11-25T15:08:49-08:00 DEBUG metabase.middleware.log GET /api/util/bug_report_details 200 4.3 ms (1 DB calls) Jetty threads: 5/50 (2 idle, 0 queued) (65 total active threads) Queries in flight: 0
2019-11-25T15:10:03-08:00 INFO metabase.middleware.exceptions Request canceled before finishing.
2019-11-25T15:10:06-08:00 DEBUG metabase.middleware.log GET /api/user/current 200 4.3 ms (3 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:10:06-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 4.8 ms (1 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:10:06-08:00 DEBUG metabase.middleware.log GET /api/database 200 5.0 ms (3 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:10:06-08:00 DEBUG metabase.middleware.log GET /api/setting 200 866.3 µs (0 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:09-08:00 DEBUG metabase.middleware.log GET /api/user/current 200 5.3 ms (3 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:09-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 6.4 ms (1 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:10-08:00 DEBUG metabase.middleware.log GET /api/database 200 4.9 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:10-08:00 DEBUG metabase.middleware.log GET /api/setting 200 824.7 µs (0 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:18-08:00 DEBUG metabase.middleware.log GET /api/user/current 200 4.2 ms (3 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:18-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 4.9 ms (1 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:18-08:00 DEBUG metabase.middleware.log GET /api/database 200 5.3 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:18-08:00 DEBUG metabase.middleware.log GET /api/collection/root/items 200 10.4 ms (7 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:18-08:00 DEBUG metabase.middleware.log GET /api/setting 200 764.4 µs (0 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:18-08:00 DEBUG metabase.middleware.log GET /api/collection/root 200 3.7 ms (2 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:19-08:00 DEBUG metabase.middleware.log GET /api/database 200 4.9 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:19-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/database/2/candidates 200 21.8 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:21-08:00 INFO metabase.automagic-dashboards.core Applying heuristic UserTable to Users table.
2019-11-25T15:11:22-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"JoinDate" {:field_type [:type/DateTime], :score 30, :matches ("inserted_at" "updated_at")},
"Name" {:field_type [:type/Name], :score 100, :matches ("last_name" "first_name")},
"GenericCategoryMedium"
{:field_type [:entity/GenericTable :type/Category], :score 75, :matches ("co_number" "country" "nais_school_id" "address_2" "co_id" "city" "member_type" "address_1" "name" "state")},
"Long" {:field_type [:entity/GenericTable :type/Longitude], :score 100, :matches ("long")},
"Lat" {:field_type [:entity/GenericTable :type/Latitude], :score 100, :matches ("lat")}}
2019-11-25T15:11:22-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "JoinDate"] -30 "day"], :score 100}}
2019-11-25T15:11:22-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your Users table:
Total Users; New Users in the last 30 days; New Users in the last 30 days; User growth; User growth; New Users per month; New Users per month; By coordinates; Per Co Number; Per School → Country; Per School → Na Is School ID; Per School → Address 2; Per Co ID; Per School → City; Per Member Type
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/7 200 156.5 ms (50 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log GET /api/field/331 200 9.5 ms (6 DB calls) Jetty threads: 9/50 (3 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log GET /api/field/331/values 200 5.9 ms (4 DB calls) Jetty threads: 9/50 (3 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log GET /api/field/336/values 200 6.0 ms (4 DB calls) Jetty threads: 8/50 (2 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log GET /api/field/336 200 9.6 ms (6 DB calls) Jetty threads: 7/50 (2 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log GET /api/field/330 200 8.7 ms (6 DB calls) Jetty threads: 7/50 (2 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log GET /api/database/2/metadata 200 77.9 ms (9 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log GET /api/field/330/values 200 5.7 ms (4 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log GET /api/field/361 200 9.8 ms (7 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 40.9 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:22-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 40.2 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 39.7 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 42.3 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 38.0 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 41.2 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 37.4 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 40.1 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 2
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 93.8 ms (17 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 47.0 ms (17 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 46.8 ms (17 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 45.3 ms (17 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 44.1 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 50.3 ms (17 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:23-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 38.0 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:24-08:00 DEBUG metabase.middleware.log GET /api/field/361/values 200 6.0 ms (4 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:27-08:00 DEBUG metabase.middleware.log GET /api/database 200 4.7 ms (3 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:27-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/database/2/candidates 200 17.5 ms (6 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:29-08:00 INFO metabase.automagic-dashboards.core Applying heuristic GenericTable to Schools table.
2019-11-25T15:11:29-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"ZIP" {:field_type [:type/ZipCode], :score 100, :matches ("zip_code")},
"Long" {:field_type [:entity/GenericTable :type/Longitude], :score 100, :matches ("long")},
"Country" {:field_type [:entity/GenericTable :type/Country], :score 100, :matches ("country")},
"GenericCategoryMedium" {:field_type [:entity/GenericTable :type/Category], :score 75, :max_cardinality 10, :matches ("nais_school_id" "address_2" "city" "address_1" "name")},
"Timestamp" {:field_type [:type/DateTime], :score 60, :matches ("updated_at" "inserted_at")},
"Lat" {:field_type [:entity/GenericTable :type/Latitude], :score 100, :matches ("lat")},
"State" {:field_type [:entity/GenericTable :type/State], :score 100, :matches ("state")}}
2019-11-25T15:11:29-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"], "CountDistinctFKs" ["distinct" ["dimension" "FK"]], "Sum" ["sum" ["dimension" "GenericNumber"]], "Avg" ["avg" ["dimension" "GenericNumber"]]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "Timestamp"] -30 "day"], :score 80}}
2019-11-25T15:11:29-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your Schools table:
Total Schools; Schools added in the last 30 days; Schools added in the last 30 days; Schools per Na Is School ID; Schools per Address 2; Schools per City; Schools per Address 1; Schools per Name; Schools per country; Schools per state; Schools by coordinates; Updated At by day of the week; Inserted At by day of the week; Updated At by hour of the day; Inserted At by hour of the day
2019-11-25T15:11:29-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/6 200 250.0 ms (34 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log GET /api/field/332/values 200 6.3 ms (3 DB calls) Jetty threads: 6/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log GET /api/field/332 200 9.9 ms (7 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 31.4 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 33.1 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 53.8 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 2
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 56.0 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 40.4 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 37.4 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 35.4 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:30-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 36.1 ms (14 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 35.4 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 36.9 ms (14 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 1
2019-11-25T15:11:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 34.9 ms (14 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 33.8 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 32.3 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 33.5 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:31-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 34.5 ms (13 DB calls) Jetty threads: 4/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:43-08:00 DEBUG metabase.middleware.log GET /api/task/info 200 21.9 ms (0 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:11:49-08:00 DEBUG metabase.middleware.log GET /api/task 200 8.6 ms (2 DB calls) Jetty threads: 5/50 (4 idle, 0 queued) (72 total active threads) Queries in flight: 0
2019-11-25T15:12:32-08:00 DEBUG metabase.middleware.log GET /api/user/current 200 4.6 ms (3 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 3.7 ms (1 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (69 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/database 200 4.9 ms (3 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/setting 200 928.0 µs (0 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 INFO metabase.automagic-dashboards.core Applying heuristic GenericTable to Schools table.
2019-11-25T15:12:33-08:00 INFO metabase.automagic-dashboards.core Dimensions bindings:
{"ZIP" {:field_type [:type/ZipCode], :score 100, :matches ("zip_code")},
"Long" {:field_type [:entity/GenericTable :type/Longitude], :score 100, :matches ("long")},
"Country" {:field_type [:entity/GenericTable :type/Country], :score 100, :matches ("country")},
"GenericCategoryMedium" {:field_type [:entity/GenericTable :type/Category], :score 75, :max_cardinality 10, :matches ("nais_school_id" "address_2" "city" "address_1" "name")},
"Timestamp" {:field_type [:type/DateTime], :score 60, :matches ("updated_at" "inserted_at")},
"Lat" {:field_type [:entity/GenericTable :type/Latitude], :score 100, :matches ("lat")},
"State" {:field_type [:entity/GenericTable :type/State], :score 100, :matches ("state")}}
2019-11-25T15:12:33-08:00 INFO metabase.automagic-dashboards.core Using definitions:
Metrics:
{"Count" ["count"], "CountDistinctFKs" ["distinct" ["dimension" "FK"]], "Sum" ["sum" ["dimension" "GenericNumber"]], "Avg" ["avg" ["dimension" "GenericNumber"]]}
Filters:
{"Last30Days" {:filter ["time-interval" ["dimension" "Timestamp"] -30 "day"], :score 80}}
2019-11-25T15:12:33-08:00 INFO metabase.automagic-dashboards.populate Adding 15 cards to dashboard A look at your Schools table:
Total Schools; Schools added in the last 30 days; Schools added in the last 30 days; Schools per Na Is School ID; Schools per Address 2; Schools per City; Schools per Address 1; Schools per Name; Schools per country; Schools per state; Schools by coordinates; Updated At by day of the week; Inserted At by day of the week; Updated At by hour of the day; Inserted At by hour of the day
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/automagic-dashboards/table/6 200 225.4 ms (34 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/field/331 200 11.8 ms (7 DB calls) Jetty threads: 7/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/field/331/values 200 5.7 ms (4 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/field/336 200 12.4 ms (6 DB calls) Jetty threads: 8/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/database/2/metadata 200 50.5 ms (9 DB calls) Jetty threads: 7/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/field/336/values 200 7.8 ms (4 DB calls) Jetty threads: 7/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:33-08:00 DEBUG metabase.middleware.log GET /api/field/330 200 8.7 ms (6 DB calls) Jetty threads: 6/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log GET /api/field/330/values 200 5.5 ms (4 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log GET /api/field/332 200 7.4 ms (6 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log GET /api/field/332/values 200 6.7 ms (3 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 33.8 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 41.4 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 36.2 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 42.3 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 38.3 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 36.3 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 36.1 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 42.3 ms (14 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 1
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 39.5 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 36.5 ms (14 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 44.4 ms (14 DB calls) Jetty threads: 5/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 1
2019-11-25T15:12:34-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 38.5 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:35-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 43.1 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 1
2019-11-25T15:12:35-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 41.8 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:12:35-08:00 DEBUG metabase.middleware.log POST /api/dataset 200 [ASYNC: completed] 37.6 ms (13 DB calls) Jetty threads: 4/50 (3 idle, 0 queued) (70 total active threads) Queries in flight: 0
2019-11-25T15:14:41-08:00 DEBUG metabase.middleware.log GET /api/user/current 200 5.9 ms (3 DB calls) Jetty threads: 6/50 (5 idle, 0 queued) (74 total active threads) Queries in flight: 0
2019-11-25T15:14:41-08:00 DEBUG metabase.middleware.log GET /api/session/properties 200 5.0 ms (1 DB calls) Jetty threads: 6/50 (5 idle, 0 queued) (74 total active threads) Queries in flight: 0
2019-11-25T15:14:41-08:00 DEBUG metabase.middleware.log GET /api/database 200 5.0 ms (3 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (74 total active threads) Queries in flight: 0
2019-11-25T15:14:42-08:00 DEBUG metabase.middleware.log GET /api/setting 200 976.3 µs (0 DB calls) Jetty threads: 5/50 (5 idle, 0 queued) (74 total active threads) Queries in flight: 0
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment