Dashboard cards involving joins are taking longer time to load

All the queries on the dashboard with join as a keyword is taking forever to load.

Hi @Anum
Can you please always include "Diagnostic Info" from Admin > Troubleshooting. I'm getting tired of having to ask for it every single time.

What is a "keyword"?

[a878ad16-7dcc-4f9e-a332-3768a2ebb94b] 2021-09-09T14:03:18+05:00 DEBUG metabase.middleware.log GET /api/embed/dashboard/eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJyZXNvdXJjZSI6eyJkYXNoYm9hcmQiOjJ9LCJwYXJhbXMiOnt9LCJleHAiOjE2MzExODE3MDgsImlhdCI6MTYzMTE3ODEwOH0.aBkYGN1MVIVhNwij6eZ7ebF0H4mdCz0o1dje-fpODRI/dashcard/21/card/23 202 [ASYNC: canceled] 1.5 mins (10 DB calls) App DB connections: 0/15 Jetty threads: 2/50 (5 idle, 0 queued) (122 total active threads) Queries in flight: 3 (0 queued)
[a878ad16-7dcc-4f9e-a332-3768a2ebb94b] 2021-09-09T14:03:18+05:00 DEBUG metabase.middleware.log GET /api/embed/dashboard/eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJyZXNvdXJjZSI6eyJkYXNoYm9hcmQiOjJ9LCJwYXJhbXMiOnt9LCJleHAiOjE2MzExODE3MDgsImlhdCI6MTYzMTE3ODEwOH0.aBkYGN1MVIVhNwij6eZ7ebF0H4mdCz0o1dje-fpODRI/dashcard/67/card/59 202 [ASYNC: canceled] 1.5 mins (10 DB calls) App DB connections: 0/15 Jetty threads: 2/50 (5 idle, 0 queued) (122 total active threads) Queries in flight: 2 (0 queued)
[a878ad16-7dcc-4f9e-a332-3768a2ebb94b] 2021-09-09T14:03:18+05:00 INFO metabase.api.card Question's average execution duration is 26.6 s; using 'magic' TTL of 2.2 mins :floppy_disk:
[a878ad16-7dcc-4f9e-a332-3768a2ebb94b] 2021-09-09T14:03:18+05:00 INFO metabase.api.card Question's average execution duration is 26.8 s; using 'magic' TTL of 2.2 mins :floppy_disk:
[a878ad16-7dcc-4f9e-a332-3768a2ebb94b] 2021-09-09T14:03:18+05:00 INFO metabase.api.card Question's average execution duration is 26.0 s; using 'magic' TTL of 2.2 mins :floppy_disk:
[a878ad16-7dcc-4f9e-a332-3768a2ebb94b] 2021-09-09T14:03:18+05:00 INFO metabase.api.card Question's average execution duration is 26.1 s; using 'magic' TTL of 2.2 mins :floppy_disk:
[a878ad16-7dcc-4f9e-a332-3768a2ebb94b] 2021-09-09T14:03:18+05:00 DEBUG metabase.middleware.log GET /api/embed/dashboard/eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJyZXNvdXJjZSI6eyJkYXNoYm9hcmQiOjJ9LCJwYXJhbXMiOnt9LCJleHAiOjE2MzExODE3MDgsImlhdCI6MTYzMTE3ODEwOH0.aBkYGN1MVIVhNwij6eZ7ebF0H4mdCz0o1dje-fpODRI/dashcard/64/card/25 202 [ASYNC: canceled] 1.5 mins (10 DB calls) App DB connections: 0/15 Jetty threads: 2/50 (5 idle, 0 queued) (125 total active threads) Queries in flight: 5 (0 queued)
[a878ad16-7dcc-4f9e-a332-3768a2ebb94b] 2021-09-09T14:03:19+05:00 INFO metabase.api.card Question's average execution duration is 33.0 s; using 'magic' TTL of 2.8 mins :floppy_disk:
[a878ad16-7dcc-4f9e-a332-3768a2ebb94b] 2021-09-09T14:03:21+05:00 ERROR metabase.query-processor.middleware.catch-exceptions Error processing query: null
{:database_id 2,
:started_at #t "2021-09-09T09:01:48.279179Z[UTC]",
:via
[{:status :failed,
:class org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException,
:error "Sort aborted: Query execution was interrupted",
:stacktrace
["org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException.of(MariaDbSqlException.java:34)"
"org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:194)"
"org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:177)"
"org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:321)"
"org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:220)"
"org.mariadb.jdbc.ClientSidePreparedStatement.execute(ClientSidePreparedStatement.java:149)"
"org.mariadb.jdbc.ClientSidePreparedStatement.executeQuery(ClientSidePreparedStatement.java:163)"
"com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:431)"
"--> driver.sql_jdbc.execute$fn__76636.invokeStatic(execute.clj:266)"
"driver.sql_jdbc.execute$fn__76636.invoke(execute.clj:264)"
"driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:391)"
"driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:376)"
"driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:385)"
"driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:376)"
"driver.sql_jdbc$fn__78141.invokeStatic(sql_jdbc.clj:49)"
"driver.sql_jdbc$fn__78141.invoke(sql_jdbc.clj:47)"
"query_processor.context$executef.invokeStatic(context.clj:59)"
"query_processor.context$executef.invoke(context.clj:48)"
"query_processor.context.default$default_runf.invokeStatic(default.clj:69)"
"query_processor.context.default$default_runf.invoke(default.clj:67)"
"query_processor.context$runf.invokeStatic(context.clj:45)"
"query_processor.context$runf.invoke(context.clj:39)"
"query_processor.reducible$pivot.invokeStatic(reducible.clj:34)"
"query_processor.reducible$pivot.invoke(reducible.clj:31)"
"query_processor.middleware.mbql_to_native$mbql__GT_native$fn__47457.invoke(mbql_to_native.clj:26)"
"query_processor.middleware.check_features$check_features$fn__46732.invoke(check_features.clj:42)"
"query_processor.middleware.optimize_datetime_filters$optimize_datetime_filters$fn__47622.invoke(optimize_datetime_filters.clj:133)"
"query_processor.middleware.auto_parse_filter_values$auto_parse_filter_values$fn__45533.invoke(auto_parse_filter_values.clj:44)"
"query_processor.middleware.wrap_value_literals$wrap_value_literals$fn__49188.invoke(wrap_value_literals.clj:149)"
"query_processor.middleware.annotate$add_column_info$fn__45295.invoke(annotate.clj:575)"
"query_processor.middleware.permissions$check_query_permissions$fn__46607.invoke(permissions.clj:70)"
"query_processor.middleware.pre_alias_aggregations$pre_alias_aggregations$fn__48140.invoke(pre_alias_aggregations.clj:40)"
"query_processor.middleware.cumulative_aggregations$handle_cumulative_aggregations$fn__46805.invoke(cumulative_aggregations.clj:61)"
"query_processor.middleware.resolve_joined_fields$resolve_joined_fields$fn__48377.invoke(resolve_joined_fields.clj:36)"
"query_processor.middleware.resolve_joins$resolve_joins$fn__48696.invoke(resolve_joins.clj:183)"
"query_processor.middleware.add_implicit_joins$add_implicit_joins$fn__41020.invoke(add_implicit_joins.clj:254)"
"query_processor.middleware.large_int_id$convert_id_to_string$fn__47418.invoke(large_int_id.clj:44)"
"query_processor.middleware.limit$limit$fn__47443.invoke(limit.clj:38)"
"query_processor.middleware.format_rows$format_rows$fn__47398.invoke(format_rows.clj:84)"
"query_processor.middleware.desugar$desugar$fn__46871.invoke(desugar.clj:22)"
"query_processor.middleware.binning$update_binning_strategy$fn__45892.invoke(binning.clj:229)"
"query_processor.middleware.resolve_fields$resolve_fields$fn__46409.invoke(resolve_fields.clj:24)"
"query_processor.middleware.add_dimension_projections$add_remapping$fn__40564.invoke(add_dimension_projections.clj:316)"
"query_processor.middleware.add_implicit_clauses$add_implicit_clauses$fn__40771.invoke(add_implicit_clauses.clj:141)"
"query_processor.middleware.add_source_metadata$add_source_metadata_for_source_queries$fn__41169.invoke(add_source_metadata.clj:105)"
"query_processor.middleware.reconcile_breakout_and_order_by_bucketing$reconcile_breakout_and_order_by_bucketing$fn__48337.invoke(reconcile_breakout_and_order_by_bucketing.clj:98)"
"query_processor.middleware.auto_bucket_datetimes$auto_bucket_datetimes$fn__45480.invoke(auto_bucket_datetimes.clj:125)"
"query_processor.middleware.resolve_source_table$resolve_source_tables$fn__46456.invoke(resolve_source_table.clj:46)"
"query_processor.middleware.parameters$substitute_parameters$fn__48122.invoke(parameters.clj:114)"
"query_processor.middleware.resolve_referenced$resolve_referenced_card_resources$fn__46508.invoke(resolve_referenced.clj:80)"
"query_processor.middleware.expand_macros$expand_macros$fn__47127.invoke(expand_macros.clj:158)"
"query_processor.middleware.add_timezone_info$add_timezone_info$fn__41200.invoke(add_timezone_info.clj:15)"
"query_processor.middleware.splice_params_in_response$splice_params_in_response$fn__49058.invoke(splice_params_in_response.clj:32)"
"query_processor.middleware.resolve_database_and_driver$resolve_database_and_driver$fn__48348$fn__48352.invoke(resolve_database_and_driver.clj:33)"
"driver$do_with_driver.invokeStatic(driver.clj:61)"
"driver$do_with_driver.invoke(driver.clj:57)"
"query_processor.middleware.resolve_database_and_driver$resolve_database_and_driver$fn__48348.invoke(resolve_database_and_driver.clj:27)"
"query_processor.middleware.fetch_source_query$resolve_card_id_source_tables$fn__47345.invoke(fetch_source_query.clj:267)"
"query_processor.middleware.store$initialize_store$fn__49067$fn__49068.invoke(store.clj:11)"
"query_processor.store$do_with_store.invokeStatic(store.clj:46)"
"query_processor.store$do_with_store.invoke(store.clj:40)"
"query_processor.middleware.store$initialize_store$fn__49067.invoke(store.clj:10)"
"query_processor.middleware.cache$run_query_with_cache.invokeStatic(cache.clj:187)"
"query_processor.middleware.cache$run_query_with_cache.invoke(cache.clj:178)"
"query_processor.middleware.cache$maybe_return_cached_results$fn__46385.invoke(cache.clj:213)"
"query_processor.middleware.validate$validate_query$fn__49076.invoke(validate.clj:10)"
"query_processor.middleware.normalize_query$normalize$fn__47470.invoke(normalize_query.clj:22)"
"query_processor.middleware.add_rows_truncated$add_rows_truncated$fn__41038.invoke(add_rows_truncated.clj:36)"
"query_processor.middleware.results_metadata$record_and_return_metadata_BANG_$fn__49043.invoke(results_metadata.clj:147)"
"query_processor.middleware.constraints$add_default_userland_constraints$fn__46748.invoke(constraints.clj:42)"
"query_processor.middleware.process_userland_query$process_userland_query$fn__48211.invoke(process_userland_query.clj:136)"
"query_processor.middleware.catch_exceptions$catch_exceptions$fn__46691.invoke(catch_exceptions.clj:174)"
"query_processor.reducible$async_qp$qp_STAR___39827$thunk__39828.invoke(reducible.clj:103)"
"query_processor.reducible$async_qp$qp_STAR___39827$fn__39830.invoke(reducible.clj:108)"],
:state "HY000"}
{:status :failed,
:class java.sql.SQLTransientConnectionException,
:error "(conn=1898161) Sort aborted: Query execution was interrupted",
:stacktrace
["org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:79)"
"org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:153)"
"org.mariadb.jdbc.MariaDbStatement.executeExceptionEpilogue(MariaDbStatement.java:274)"
"org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:229)"
"org.mariadb.jdbc.ClientSidePreparedStatement.execute(ClientSidePreparedStatement.java:149)"
"org.mariadb.jdbc.ClientSidePreparedStatement.executeQuery(ClientSidePreparedStatement.java:163)"
"com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:431)"
"--> driver.sql_jdbc.execute$fn__76636.invokeStatic(execute.clj:266)"
"driver.sql_jdbc.execute$fn__76636.invoke(execute.clj:264)"
"driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:391)"
"driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:376)"
"driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:385)"
"driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:376)"
"driver.sql_jdbc$fn__78141.invokeStatic(sql_jdbc.clj:49)"
"driver.sql_jdbc$fn__78141.invoke(sql_jdbc.clj:47)"
"query_processor.context$executef.invokeStatic(context.clj:59)"
"query_processor.context$executef.invoke(context.clj:48)"
"query_processor.context.default$default_runf.invokeStatic(default.clj:69)"
"query_processor.context.default$default_runf.invoke(default.clj:67)"
"query_processor.context$runf.invokeStatic(context.clj:45)"
"query_processor.context$runf.invoke(context.clj:39)"
"query_processor.reducible$pivot.invokeStatic(reducible.clj:34)"
"query_processor.reducible$pivot.invoke(reducible.clj:31)"
"query_processor.middleware.mbql_to_native$mbql__GT_native$fn__47457.invoke(mbql_to_native.clj:26)"
"query_processor.middleware.check_features$check_features$fn__46732.invoke(check_features.clj:42)"
"query_processor.middleware.optimize_datetime_filters$optimize_datetime_filters$fn__47622.invoke(optimize_datetime_filters.clj:133)"
"query_processor.middleware.auto_parse_filter_values$auto_parse_filter_values$fn__45533.invoke(auto_parse_filter_values.clj:44)"
"query_processor.middleware.wrap_value_literals$wrap_value_literals$fn__49188.invoke(wrap_value_literals.clj:149)"
"query_processor.middleware.annotate$add_column_info$fn__45295.invoke(annotate.clj:575)"
"query_processor.middleware.permissions$check_query_permissions$fn__46607.invoke(permissions.clj:70)"
"query_processor.middleware.pre_alias_aggregations$pre_alias_aggregations$fn__48140.invoke(pre_alias_aggregations.clj:40)"
"query_processor.middleware.cumulative_aggregations$handle_cumulative_aggregations$fn__46805.invoke(cumulative_aggregations.clj:61)"
"query_processor.middleware.resolve_joined_fields$resolve_joined_fields$fn__48377.invoke(resolve_joined_fields.clj:36)"
"query_processor.middleware.resolve_joins$resolve_joins$fn__48696.invoke(resolve_joins.clj:183)"
"query_processor.middleware.add_implicit_joins$add_implicit_joins$fn__41020.invoke(add_implicit_joins.clj:254)"
"query_processor.middleware.large_int_id$convert_id_to_string$fn__47418.invoke(large_int_id.clj:44)"
"query_processor.middleware.limit$limit$fn__47443.invoke(limit.clj:38)"
"query_processor.middleware.format_rows$format_rows$fn__47398.invoke(format_rows.clj:84)"
"query_processor.middleware.desugar$desugar$fn__46871.invoke(desugar.clj:22)"
"query_processor.middleware.binning$update_binning_strategy$fn__45892.invoke(binning.clj:229)"
"query_processor.middleware.resolve_fields$resolve_fields$fn__46409.invoke(resolve_fields.clj:24)"
"query_processor.middleware.add_dimension_projections$add_remapping$fn__40564.invoke(add_dimension_projections.clj:316)"
"query_processor.middleware.add_implicit_clauses$add_implicit_clauses$fn__40771.invoke(add_implicit_clauses.clj:141)"
"query_processor.middleware.add_source_metadata$add_source_metadata_for_source_queries$fn__41169.invoke(add_source_metadata.clj:105)"
"query_processor.middleware.reconcile_breakout_and_order_by_bucketing$reconcile_breakout_and_order_by_bucketing$fn__48337.invoke(reconcile_breakout_and_order_by_bucketing.clj:98)"
"query_processor.middleware.auto_bucket_datetimes$auto_bucket_datetimes$fn__45480.invoke(auto_bucket_datetimes.clj:125)"
"query_processor.middleware.resolve_source_table$resolve_source_tables$fn__46456.invoke(resolve_source_table.clj:46)"
"query_processor.middleware.parameters$substitute_parameters$fn__48122.invoke(parameters.clj:114)"
"query_processor.middleware.resolve_referenced$resolve_referenced_card_resources$fn__46508.invoke(resolve_referenced.clj:80)"
"query_processor.middleware.expand_macros$expand_macros$fn__47127.invoke(expand_macros.clj:158)"
"query_processor.middleware.add_timezone_info$add_timezone_info$fn__41200.invoke(add_timezone_info.clj:15)"
"query_processor.middleware.splice_params_in_response$splice_params_in_response$fn__49058.invoke(splice_params_in_response.clj:32)"
"query_processor.middleware.resolve_database_and_driver$resolve_database_and_driver$fn__48348$fn__48352.invoke(resolve_database_and_driver.clj:33)"
"driver$do_with_driver.invokeStatic(driver.clj:61)"
"driver$do_with_driver.invoke(driver.clj:57)"
"query_processor.middleware.resolve_database_and_driver$resolve_database_and_driver$fn__48348.invoke(resolve_database_and_driver.clj:27)"
"query_processor.middleware.fetch_source_query$resolve_card_id_source_tables$fn__47345.invoke(fetch_source_query.clj:267)"
"query_processor.middleware.store$initialize_store$fn__49067$fn__49068.invoke(store.clj:11)"
"query_processor.store$do_with_store.invokeStatic(store.clj:46)"
"query_processor.store$do_with_store.invoke(store.clj:40)"
"query_processor.middleware.store$initialize_store$fn__49067.invoke(store.clj:10)"
"query_processor.middleware.cache$run_query_with_cache.invokeStatic(cache.clj:187)"
"query_processor.middleware.cache$run_query_with_cache.invoke(cache.clj:178)"
"query_processor.middleware.cache$maybe_return_cached_results$fn__46385.invoke(cache.clj:213)"
"query_processor.middleware.validate$validate_query$fn__49076.invoke(validate.clj:10)"
"query_processor.middleware.normalize_query$normalize$fn__47470.invoke(normalize_query.clj:22)"
"query_processor.middleware.add_rows_truncated$add_rows_truncated$fn__41038.invoke(add_rows_truncated.clj:36)"
"query_processor.middleware.results_metadata$record_and_return_metadata_BANG_$fn__49043.invoke(results_metadata.clj:147)"
"query_processor.middleware.constraints$add_default_userland_constraints$fn__46748.invoke(constraints.clj:42)"
"query_processor.middleware.process_userland_query$process_userland_query$fn__48211.invoke(process_userland_query.clj:136)"
"query_processor.middleware.catch_exceptions$catch_exceptions$fn__46691.invoke(catch_exceptions.clj:174)"
"query_processor.reducible$async_qp$qp_STAR___39827$thunk__39828.invoke(reducible.clj:103)"
"query_processor.reducible$async_qp$qp_STAR___39827$fn__39830.invoke(reducible.clj:108)"],
:state "HY000"}],
:state "HY000",
:json_query

@Anum

If you are looking for help, then you need to provide more information.

You are showing a log, where it looks like someone has closed their browser connection (or you have a reverse-proxy that closed the connection after 90 seconds).

Post "Diagnostic Info" (not the logs) from Admin > Troubleshooting

{
"browser-info": {
"language": "en-US",
"platform": "Win32",
"userAgent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/93.0.4577.63 Safari/537.36",
"vendor": "Google Inc."
},
"system-info": {
"file.encoding": "UTF-8",
"java.runtime.name": "OpenJDK Runtime Environment",
"java.runtime.version": "11.0.12+7-LTS",
"java.vendor": "Amazon.com Inc.",
"java.vendor.url": "https://aws.amazon.com/corretto/",
"java.version": "11.0.12",
"java.vm.name": "OpenJDK 64-Bit Server VM",
"java.vm.version": "11.0.12+7-LTS",
"os.name": "Linux",
"os.version": "4.14.225-169.362.amzn2.x86_64",
"user.language": "en",
"user.timezone": "UTC"
},
"metabase-info": {
"databases": [
"h2",
"mysql"
],
"hosting-env": "unknown",
"application-database": "mysql",
"application-database-details": {
"database": {
"name": "MySQL",
"version": "5.7.34-log"
},
"jdbc-driver": {
"name": "MariaDB Connector/J",
"version": "2.6.2"
}
},
"run-mode": "prod",
"version": {
"date": "2020-12-03",
"tag": "v0.37.3",
"branch": "release-x.37.x",
"hash": "2f1e783"
},
"settings": {
"report-timezone": "UTC"
}
}
}

@Anum I don't know what to say. Upgrade to a newer release: https://github.com/metabase/metabase/releases/latest

Can I upgrade a running instance?

@Anum No, you have to shut it down.
Read this: https://metabase.com/docs/latest/operations-guide/upgrading-metabase.html
And remember to backup first!

But since you have not explained anything, then I have no idea if it will make any difference, but you don't write more than a couple of words, so it's not possible to help you.