We've been getting reports from users of dashboards failing to load. The challenge with debugging is that it's sporadic and unpredictable - two users in the same location can load the same dashboard at the same time, and it will work for one but not the other.
When the dashboard fails to load, the user will get the "This usually only takes a minute but it's taking longer" message, but the page will simply hang there. We've also gotten reports of the dashboard showing 0s and nulls (as if the queries returned 0 results). Often, refreshing the page will cause the dashboard to load properly.
Looking through our logs, we see two main types of errors:
Error Type: Invalid query and an Assertion Error with "QP unexpectedly returned nil" as the message. The queries themselves are not the issue - they work when we run them directly on our warehouse, and they work when the page is reloaded.
Has anyone run into these issues before / know what might be causing them?
Specs:
{
"browser-info": {
"language": "en-US",
"platform": "Win32",
"userAgent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36",
"vendor": "Google Inc."
},
"metabase-info": {
"databases": [
"snowflake"
],
"run-mode": "prod",
"plan-alias": "",
"version": {
"date": "2025-03-03",
"tag": "v0.53.4.4",
"hash": "cf7a57c"
},
"settings": {
"report-timezone": null
},
"hosting-env": "unknown",
"application-database": "postgres",
"application-database-details": {
"database": {
"name": "PostgreSQL",
"version": "12.15 (Ubuntu 12.15-0ubuntu0.20.04.1)"
},
"jdbc-driver": {
"name": "PostgreSQL JDBC Driver",
"version": "42.7.4"
}
}
},
"system-info": {
"file.encoding": "UTF-8",
"java.runtime.name": "OpenJDK Runtime Environment",
"java.runtime.version": "21.0.6+7-Ubuntu-122.04.1",
"java.vendor": "Ubuntu",
"java.vendor.url": "https://ubuntu.com/",
"java.version": "21.0.6",
"java.vm.name": "OpenJDK 64-Bit Server VM",
"java.vm.version": "21.0.6+7-Ubuntu-122.04.1",
"os.name": "Linux",
"os.version": "5.15.0-133-generic",
"user.language": "en",
"user.timezone": "Etc/UTC"
}
}
Stacktrace for one of the Error Type: Invalid query cases:
Mar 06 16:31:52 metabase metabase.sh[853]: 2025-03-06 16:31:52,836 ERROR middleware.catch-exceptions :: Error processing query: SQL execution canceled
Mar 06 16:31:52 metabase metabase.sh[853]: {:database_id 2,
Mar 06 16:31:52 metabase metabase.sh[853]: :parameterized true,
Mar 06 16:31:52 metabase metabase.sh[853]: :started_at #t "2025-03-06T16:31:44.233783220Z[Etc/UTC]",
Mar 06 16:31:52 metabase metabase.sh[853]: :via
Mar 06 16:31:52 metabase metabase.sh[853]: [{:status :failed,
Mar 06 16:31:52 metabase metabase.sh[853]: :class clojure.lang.ExceptionInfo,
Mar 06 16:31:52 metabase metabase.sh[853]: :error "Error executing query: SQL execution canceled",
Mar 06 16:31:52 metabase metabase.sh[853]: :stacktrace
Mar 06 16:31:52 metabase metabase.sh[853]: ["--> driver.sql_jdbc.execute$execute_reducible_query$fn__85732$fn__85733.invoke(execute.clj:723)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query$fn__85732.invoke(execute.clj:720)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$fn__85533$fn__85534.invoke(execute.clj:398)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$do_with_resolved_connection85503__85504.invokeStatic(execute.clj:338)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$do_with_resolved_connection85503__85504.invoke(execute.clj:321)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$fn__85533.invokeStatic(execute.clj:392)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$fn__85533.invoke(execute.clj:390)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:714)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:700)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:711)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:700)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc$fn__117822.invokeStatic(sql_jdbc.clj:79)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc$fn__117822.invoke(sql_jdbc.clj:77)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.pipeline$_STAR_execute_STAR_.invokeStatic(pipeline.clj:52)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.pipeline$_STAR_execute_STAR_.invoke(pipeline.clj:39)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.pipeline$_STAR_run_STAR_.invokeStatic(pipeline.clj:102)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.pipeline$_STAR_run_STAR_.invoke(pipeline.clj:95)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$run.invokeStatic(execute.clj:62)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$run.invoke(execute.clj:56)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.update_used_cards$update_used_cards_BANG_72307__72308$fn__72309.invoke(update_used_cards.clj:60)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$add_native_form_to_result_metadata$fn__72412.invoke(execute.clj:25)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$add_preprocessed_query_to_result_metadata_for_userland_query$fn__72418.invoke(execute.clj:36)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.cache$run_query_with_cache72256__72258.invokeStatic(cache.clj:216)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.cache$run_query_with_cache72256__72258.invoke(cache.clj:189)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.cache$maybe_return_cached_results$maybe_return_cached_results_STAR___72280.invoke(cache.clj:245)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.permissions$check_query_permissions$fn__72051.invoke(permissions.clj:148)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.enterprise$check_download_permissions_middleware$fn__72145.invoke(enterprise.clj:51)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.enterprise$maybe_apply_column_level_perms_check_middleware$fn__72155.invoke(enterprise.clj:64)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$execute72445__72446$fn__72447.invoke(execute.clj:94)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_qp_setup72398__72399.invokeStatic(setup.clj:225)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_qp_setup72398__72399.invoke(setup.clj:216)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$execute72445__72446.invokeStatic(execute.clj:93)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$execute72445__72446.invoke(execute.clj:89)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query_STAR__STAR_.invokeStatic(query_processor.clj:49)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query_STAR__STAR_.invoke(query_processor.clj:44)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.enterprise$fn__72172$handle_audit_app_internal_queries__72173$fn__72175.invoke(enterprise.clj:96)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.enterprise$handle_audit_app_internal_queries_middleware$fn__72183.invoke(enterprise.clj:103)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.process_userland_query$process_userland_query_middleware79027__79028$fn__79029.invoke(process_userland_query.clj:221)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.catch_exceptions$catch_exceptions79092__79093$fn__79094.invoke(catch_exceptions.clj:132)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query79133__79134$fn__79135.invoke(query_processor.clj:80)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_canceled_chan72393__72394$fn__72395.invoke(setup.clj:187)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_database_local_settings72386__72387$fn__72388.invoke(setup.clj:181)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_driver72379__72380$fn__72381$fn__72382.invoke(setup.clj:166)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver$do_with_driver.invokeStatic(driver.clj:107)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver$do_with_driver.invoke(driver.clj:102)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_driver72379__72380$fn__72381.invoke(setup.clj:165)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_metadata_provider72370__72371$fn__72372$fn__72375.invoke(setup.clj:151)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.store$do_with_metadata_provider58091__58092.invokeStatic(store.clj:170)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.store$do_with_metadata_provider58091__58092.invoke(store.clj:150)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.store$do_with_metadata_provider58091__58092.invokeStatic(store.clj:159)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.store$do_with_metadata_provider58091__58092.invoke(store.clj:150)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_metadata_provider72370__72371$fn__72372.invoke(setup.clj:150)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_resolved_database72360__72361$fn__72362.invoke(setup.clj:128)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_qp_setup72398__72399.invokeStatic(setup.clj:232)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_qp_setup72398__72399.invoke(setup.clj:216)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query79133__79134.invokeStatic(query_processor.clj:78)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query79133__79134.invoke(query_processor.clj:71)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.card$process_query_for_card_default_qp85939__85940.invokeStatic(card.clj:232)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.card$process_query_for_card_default_qp85939__85940.invoke(card.clj:228)"
Mar 06 16:31:52 metabase metabase.sh[853]: "api.public$process_query_for_card_with_id_run_fn$run__101043$fn__101044$fn__101045.invoke(public.clj:137)"
Mar 06 16:31:52 metabase metabase.sh[853]: "request.session$do_with_current_user.invokeStatic(session.clj:47)"
Mar 06 16:31:52 metabase metabase.sh[853]: "request.session$do_with_current_user.invoke(session.clj:30)"
Mar 06 16:31:52 metabase metabase.sh[853]: "api.public$process_query_for_card_with_id_run_fn$run__101043$fn__101044.invoke(public.clj:136)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$_streaming_response$fn__83601$fn__83602$fn__83603.invoke(streaming.clj:185)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$_streaming_response$fn__83601$fn__83602.invoke(streaming.clj:183)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$do_with_streaming_rff.invokeStatic(streaming.clj:174)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$do_with_streaming_rff.invoke(streaming.clj:161)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$_streaming_response$fn__83601.invoke(streaming.clj:180)"
Mar 06 16:31:52 metabase metabase.sh[853]: "server.streaming_response$do_f_STAR_.invokeStatic(streaming_response.clj:78)"
Mar 06 16:31:52 metabase metabase.sh[853]: "server.streaming_response$do_f_STAR_.invoke(streaming_response.clj:76)"
Mar 06 16:31:52 metabase metabase.sh[853]: "server.streaming_response$do_f_async$task__81591.invoke(streaming_response.clj:93)"],
Mar 06 16:31:52 metabase metabase.sh[853]: :error_type :invalid-query,
Mar 06 16:31:52 metabase metabase.sh[853]: :ex-data
Mar 06 16:31:52 metabase metabase.sh[853]: {:driver :snowflake,
Mar 06 16:31:52 metabase metabase.sh[853]: :sql
Mar 06 16:31:52 metabase metabase.sh[853]: ["with students_last_day AS ("
Mar 06 16:31:52 metabase metabase.sh[853]: " select"
Mar 06 16:31:52 metabase metabase.sh[853]: " student_id,"
Mar 06 16:31:52 metabase metabase.sh[853]: " max(school_date) as max_date"
Mar 06 16:31:52 metabase metabase.sh[853]: " from"
Mar 06 16:31:52 metabase metabase.sh[853]: " public.students_historical"
Mar 06 16:31:52 metabase metabase.sh[853]: " group by"
Mar 06 16:31:52 metabase metabase.sh[853]: " 1"
Mar 06 16:31:52 metabase metabase.sh[853]: ")"
Mar 06 16:31:52 metabase metabase.sh[853]: "SELECT"
Mar 06 16:31:52 metabase metabase.sh[853]: " first_name || ' ' || last_name as student_name"
Mar 06 16:31:52 metabase metabase.sh[853]: "FROM"
Mar 06 16:31:52 metabase metabase.sh[853]: " public.students_historical s"
Mar 06 16:31:52 metabase metabase.sh[853]: " INNER JOIN students_last_day on s.student_id = students_last_day.student_id"
Mar 06 16:31:52 metabase metabase.sh[853]: " AND s.school_date = students_last_day.max_date"
Mar 06 16:31:52 metabase metabase.sh[853]: "WHERE"
Mar 06 16:31:52 metabase metabase.sh[853]: " s.platform_student_id = ?"
Mar 06 16:31:52 metabase metabase.sh[853]: " AND s.platform_type = 'canvas' -- {\"pulseId\":null,\"serverId\":\"94c66753-086a-4d9b-a47c-2cd80aca3dee\",\"client\":\"Metabase\",\"queryHash\":\"726026de4162356006270cd4bf9f3d50f64627c10da6231b53929e91e8d61e10\",\"queryType\":\"native\",\"cardId\":2080,\"dashboardId\":208,\"context\":\"embedded-dashboard\",\"userId\":null,\"databaseId\":2}"],
Mar 06 16:31:52 metabase metabase.sh[853]: :params ["14985"],
Mar 06 16:31:52 metabase metabase.sh[853]: :type :invalid-query}}],
Mar 06 16:31:52 metabase metabase.sh[853]: :action_id nil,
Mar 06 16:31:52 metabase metabase.sh[853]: :state "57014",
Mar 06 16:31:52 metabase metabase.sh[853]: :error_type :invalid-query,
Mar 06 16:31:52 metabase metabase.sh[853]: :json_query
Mar 06 16:31:52 metabase metabase.sh[853]: {:constraints {:max-results 10000, :max-results-bare-rows 2000},
Mar 06 16:31:52 metabase metabase.sh[853]: :type :native,
Mar 06 16:31:52 metabase metabase.sh[853]: :middleware {:js-int-to-string? true, :ignore-cached-results? false, :userland-query? true},
Mar 06 16:31:52 metabase metabase.sh[853]: :cache-strategy {:multiplier 100, :min_duration_ms 5, :type :ttl, :avg-execution-ms 2811},
Mar 06 16:31:52 metabase metabase.sh[853]: :native
Mar 06 16:31:52 metabase metabase.sh[853]: {:template-tags
Mar 06 16:31:52 metabase metabase.sh[853]: {"student_id"
Mar 06 16:31:52 metabase metabase.sh[853]: {:type :text, :name "student_id", :id "445c1d9d-73a8-4200-b92f-8041507d2a92", :display-name "Student ID"}},
Mar 06 16:31:52 metabase metabase.sh[853]: :query
Mar 06 16:31:52 metabase metabase.sh[853]: "with students_last_day AS (\n select\n student_id\n , max(school_date) as max_date\n from public.students_historical\n group by 1\n)\n\nSELECT\n first_name || ' ' || last_name as student_name\nFROM public.students_historical s\nINNER JOIN students_last_day on s.student_id = students_last_day.student_id\n AND s.school_date = students_last_day.max_date\nWHERE s.platform_student_id = {{student_id}}\n AND s.platform_type = 'canvas'"},
Mar 06 16:31:52 metabase metabase.sh[853]: :viz-settings {:card.title ""},
Mar 06 16:31:52 metabase metabase.sh[853]: :database 2,
Mar 06 16:31:52 metabase metabase.sh[853]: :parameters
Mar 06 16:31:52 metabase metabase.sh[853]: [{:type :id,
Mar 06 16:31:52 metabase metabase.sh[853]: :value "14985",
Mar 06 16:31:52 metabase metabase.sh[853]: :slug "user_canvas_id",
Mar 06 16:31:52 metabase metabase.sh[853]: :id "1d4b944d",
Mar 06 16:31:52 metabase metabase.sh[853]: :target [:variable [:template-tag "student_id"]]}]},
Mar 06 16:31:52 metabase metabase.sh[853]: :status :failed,
Mar 06 16:31:52 metabase metabase.sh[853]: :class net.snowflake.client.jdbc.SnowflakeSQLException,
Mar 06 16:31:52 metabase metabase.sh[853]: :stacktrace
Mar 06 16:31:52 metabase metabase.sh[853]: ["net.snowflake.client.jdbc.SnowflakeUtil.checkErrorAndThrowExceptionSub(SnowflakeUtil.java:176)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.jdbc.SnowflakeUtil.checkErrorAndThrowException(SnowflakeUtil.java:109)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.core.StmtUtil.pollForOutput(StmtUtil.java:490)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.core.StmtUtil.execute(StmtUtil.java:396)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.core.SFStatement.executeHelper(SFStatement.java:498)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.core.SFStatement.executeQueryInternal(SFStatement.java:215)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.core.SFStatement.executeQuery(SFStatement.java:149)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.core.SFStatement.execute(SFStatement.java:786)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.core.SFStatement.execute(SFStatement.java:693)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.jdbc.SnowflakeStatementV1.executeQueryInternal(SnowflakeStatementV1.java:297)"
Mar 06 16:31:52 metabase metabase.sh[853]: "net.snowflake.client.jdbc.SnowflakePreparedStatementV1.executeQuery(SnowflakePreparedStatementV1.java:158)"
Mar 06 16:31:52 metabase metabase.sh[853]: "com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:743)"
Mar 06 16:31:52 metabase metabase.sh[853]: "--> driver.sql_jdbc.execute$fn__85655.invokeStatic(execute.clj:566)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$fn__85655.invoke(execute.clj:564)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_statement_or_prepared_statement_BANG_.invokeStatic(execute.clj:579)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_statement_or_prepared_statement_BANG_.invoke(execute.clj:575)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query$fn__85732$fn__85733.invoke(execute.clj:721)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query$fn__85732.invoke(execute.clj:720)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$fn__85533$fn__85534.invoke(execute.clj:398)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$do_with_resolved_connection85503__85504.invokeStatic(execute.clj:338)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$do_with_resolved_connection85503__85504.invoke(execute.clj:321)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$fn__85533.invokeStatic(execute.clj:392)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$fn__85533.invoke(execute.clj:390)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:714)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:700)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:711)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:700)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc$fn__117822.invokeStatic(sql_jdbc.clj:79)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver.sql_jdbc$fn__117822.invoke(sql_jdbc.clj:77)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.pipeline$_STAR_execute_STAR_.invokeStatic(pipeline.clj:52)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.pipeline$_STAR_execute_STAR_.invoke(pipeline.clj:39)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.pipeline$_STAR_run_STAR_.invokeStatic(pipeline.clj:102)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.pipeline$_STAR_run_STAR_.invoke(pipeline.clj:95)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$run.invokeStatic(execute.clj:62)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$run.invoke(execute.clj:56)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.update_used_cards$update_used_cards_BANG_72307__72308$fn__72309.invoke(update_used_cards.clj:60)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$add_native_form_to_result_metadata$fn__72412.invoke(execute.clj:25)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$add_preprocessed_query_to_result_metadata_for_userland_query$fn__72418.invoke(execute.clj:36)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.cache$run_query_with_cache72256__72258.invokeStatic(cache.clj:216)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.cache$run_query_with_cache72256__72258.invoke(cache.clj:189)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.cache$maybe_return_cached_results$maybe_return_cached_results_STAR___72280.invoke(cache.clj:245)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.permissions$check_query_permissions$fn__72051.invoke(permissions.clj:148)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.enterprise$check_download_permissions_middleware$fn__72145.invoke(enterprise.clj:51)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.enterprise$maybe_apply_column_level_perms_check_middleware$fn__72155.invoke(enterprise.clj:64)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$execute72445__72446$fn__72447.invoke(execute.clj:94)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_qp_setup72398__72399.invokeStatic(setup.clj:225)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_qp_setup72398__72399.invoke(setup.clj:216)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$execute72445__72446.invokeStatic(execute.clj:93)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.execute$execute72445__72446.invoke(execute.clj:89)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query_STAR__STAR_.invokeStatic(query_processor.clj:49)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query_STAR__STAR_.invoke(query_processor.clj:44)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.enterprise$fn__72172$handle_audit_app_internal_queries__72173$fn__72175.invoke(enterprise.clj:96)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.enterprise$handle_audit_app_internal_queries_middleware$fn__72183.invoke(enterprise.clj:103)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.process_userland_query$process_userland_query_middleware79027__79028$fn__79029.invoke(process_userland_query.clj:221)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.middleware.catch_exceptions$catch_exceptions79092__79093$fn__79094.invoke(catch_exceptions.clj:132)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query79133__79134$fn__79135.invoke(query_processor.clj:80)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_canceled_chan72393__72394$fn__72395.invoke(setup.clj:187)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_database_local_settings72386__72387$fn__72388.invoke(setup.clj:181)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_driver72379__72380$fn__72381$fn__72382.invoke(setup.clj:166)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver$do_with_driver.invokeStatic(driver.clj:107)"
Mar 06 16:31:52 metabase metabase.sh[853]: "driver$do_with_driver.invoke(driver.clj:102)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_driver72379__72380$fn__72381.invoke(setup.clj:165)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_metadata_provider72370__72371$fn__72372$fn__72375.invoke(setup.clj:151)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.store$do_with_metadata_provider58091__58092.invokeStatic(store.clj:170)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.store$do_with_metadata_provider58091__58092.invoke(store.clj:150)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.store$do_with_metadata_provider58091__58092.invokeStatic(store.clj:159)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.store$do_with_metadata_provider58091__58092.invoke(store.clj:150)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_metadata_provider72370__72371$fn__72372.invoke(setup.clj:150)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_resolved_database72360__72361$fn__72362.invoke(setup.clj:128)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_qp_setup72398__72399.invokeStatic(setup.clj:232)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.setup$do_with_qp_setup72398__72399.invoke(setup.clj:216)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query79133__79134.invokeStatic(query_processor.clj:78)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor$process_query79133__79134.invoke(query_processor.clj:71)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.card$process_query_for_card_default_qp85939__85940.invokeStatic(card.clj:232)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.card$process_query_for_card_default_qp85939__85940.invoke(card.clj:228)"
Mar 06 16:31:52 metabase metabase.sh[853]: "api.public$process_query_for_card_with_id_run_fn$run__101043$fn__101044$fn__101045.invoke(public.clj:137)"
Mar 06 16:31:52 metabase metabase.sh[853]: "request.session$do_with_current_user.invokeStatic(session.clj:47)"
Mar 06 16:31:52 metabase metabase.sh[853]: "request.session$do_with_current_user.invoke(session.clj:30)"
Mar 06 16:31:52 metabase metabase.sh[853]: "api.public$process_query_for_card_with_id_run_fn$run__101043$fn__101044.invoke(public.clj:136)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$_streaming_response$fn__83601$fn__83602$fn__83603.invoke(streaming.clj:185)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$_streaming_response$fn__83601$fn__83602.invoke(streaming.clj:183)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$do_with_streaming_rff.invokeStatic(streaming.clj:174)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$do_with_streaming_rff.invoke(streaming.clj:161)"
Mar 06 16:31:52 metabase metabase.sh[853]: "query_processor.streaming$_streaming_response$fn__83601.invoke(streaming.clj:180)"
Mar 06 16:31:52 metabase metabase.sh[853]: "server.streaming_response$do_f_STAR_.invokeStatic(streaming_response.clj:78)"
Mar 06 16:31:52 metabase metabase.sh[853]: "server.streaming_response$do_f_STAR_.invoke(streaming_response.clj:76)"
Mar 06 16:31:52 metabase metabase.sh[853]: "server.streaming_response$do_f_async$task__81591.invoke(streaming_response.clj:93)"],
Mar 06 16:31:52 metabase metabase.sh[853]: :card_id 2080,
Mar 06 16:31:52 metabase metabase.sh[853]: :context :embedded-dashboard,
Mar 06 16:31:52 metabase metabase.sh[853]: :error "SQL execution canceled",
Mar 06 16:31:52 metabase metabase.sh[853]: :row_count 0,
Mar 06 16:31:52 metabase metabase.sh[853]: :running_time 0,
Mar 06 16:31:52 metabase metabase.sh[853]: :data {:rows [], :cols []}}
Stacktrace for an assertion error:
Mar 06 16:33:58 metabase metabase.sh[853]: 2025-03-06 16:33:58,426 ERROR server.streaming-response :: Caught unexpected Exception in streaming response body
Mar 06 16:33:58 metabase metabase.sh[853]: java.lang.AssertionError: Assert failed: QP unexpectedly returned nil.
Mar 06 16:33:58 metabase metabase.sh[853]: (some? result)
Mar 06 16:33:58 metabase metabase.sh[853]: at metabase.query_processor.streaming$_streaming_response$fn__83601$fn__83602.invoke(streaming.clj:188)
Mar 06 16:33:58 metabase metabase.sh[853]: at metabase.query_processor.streaming$do_with_streaming_rff.invokeStatic(streaming.clj:174)
Mar 06 16:33:58 metabase metabase.sh[853]: at metabase.query_processor.streaming$do_with_streaming_rff.invoke(streaming.clj:161)
Mar 06 16:33:58 metabase metabase.sh[853]: at metabase.query_processor.streaming$_streaming_response$fn__83601.invoke(streaming.clj:180)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.lang.AFn.applyToHelper(AFn.java:156)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.lang.AFn.applyTo(AFn.java:144)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.core$apply.invokeStatic(core.clj:667)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.core$with_bindings_STAR_.invokeStatic(core.clj:1990)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.core$with_bindings_STAR_.doInvoke(core.clj:1990)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.lang.RestFn.applyTo(RestFn.java:145)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.core$apply.invokeStatic(core.clj:671)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.core$bound_fn_STAR_$fn__5837.doInvoke(core.clj:2020)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.lang.RestFn.invoke(RestFn.java:424)
Mar 06 16:33:58 metabase metabase.sh[853]: at metabase.server.streaming_response$do_f_STAR_.invokeStatic(streaming_response.clj:78)
Mar 06 16:33:58 metabase metabase.sh[853]: at metabase.server.streaming_response$do_f_STAR_.invoke(streaming_response.clj:76)
Mar 06 16:33:58 metabase metabase.sh[853]: at metabase.server.streaming_response$do_f_async$task__81591.invoke(streaming_response.clj:93)
Mar 06 16:33:58 metabase metabase.sh[853]: at clojure.lang.AFn.run(AFn.java:22)
Mar 06 16:33:58 metabase metabase.sh[853]: at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:572)
Mar 06 16:33:58 metabase metabase.sh[853]: at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317)
Mar 06 16:33:58 metabase metabase.sh[853]: at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
Mar 06 16:33:58 metabase metabase.sh[853]: at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
Mar 06 16:33:58 metabase metabase.sh[853]: at java.base/java.lang.Thread.run(Thread.java:1583)