Since upgrading from v0.4.. something (Jan 2024 version) to the latest, I have had this error (Invalid column name 'STKEY'.) a couple of times and would like to know the steps to fix. I suspect it's due to nested questions. The latest question I am working on only has nested questions. Another one that was throwing the same error had some nested models. In that one, I went into each model and changed the metadata of the display name to match the column name and suddenly, it started working.
The sub-questions I suspect are causing the issues are very similar - doing a Max of datetime field, grouping by STKEY.
Do I need to convert these to models and possibly clean some metadata up first?
Thanks in advance.
[1e93adeb-8aba-4c50-ab59-28316177d392] 2025-02-04T16:49:24+11:00 ERROR metabase.query-processor.middleware.catch-exceptions Error processing query: Invalid column name 'STKEY'.
{:database_id 3,
:started_at #t "2025-02-04T16:49:23.185165200+11:00[Australia/Sydney]",
:via
[{:status :failed,
:class clojure.lang.ExceptionInfo,
:error "Error executing query: Invalid column name 'STKEY'.",
:stacktrace
["--> driver.sql_jdbc.execute$execute_reducible_query$fn__87832$fn__87833.invoke(execute.clj:716)"
"driver.sql_jdbc.execute$execute_reducible_query$fn__87832.invoke(execute.clj:713)"
"driver.sql_jdbc.execute$fn__87638$fn__87639.invoke(execute.clj:398)"
"driver.sql_jdbc.execute$do_with_resolved_connection87608__87609.invokeStatic(execute.clj:338)"
"driver.sql_jdbc.execute$do_with_resolved_connection87608__87609.invoke(execute.clj:321)"
"driver.sql_jdbc.execute$fn__87638.invokeStatic(execute.clj:392)"
"driver.sql_jdbc.execute$fn__87638.invoke(execute.clj:390)"
"driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:707)"
"driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:693)"
"driver.sql_jdbc.execute$execute_reducible_query.invokeStatic(execute.clj:704)"
"driver.sql_jdbc.execute$execute_reducible_query.invoke(execute.clj:693)"
"driver.sql_jdbc$fn__116057.invokeStatic(sql_jdbc.clj:79)"
"driver.sql_jdbc$fn__116057.invoke(sql_jdbc.clj:77)"
"query_processor.pipeline$STAR_execute_STAR.invokeStatic(pipeline.clj:52)"
"query_processor.pipeline$STAR_execute_STAR.invoke(pipeline.clj:39)"
"query_processor.pipeline$STAR_run_STAR.invokeStatic(pipeline.clj:102)"
"query_processor.pipeline$STAR_run_STAR.invoke(pipeline.clj:95)"
"query_processor.execute$run.invokeStatic(execute.clj:62)"
"query_processor.execute$run.invoke(execute.clj:56)"
"query_processor.middleware.update_used_cards$update_used_cards_BANG_76007__76008$fn__76009.invoke(update_used_cards.clj:60)"
"query_processor.execute$add_native_form_to_result_metadata$fn__76024.invoke(execute.clj:25)"
"query_processor.execute$add_preprocessed_query_to_result_metadata_for_userland_query$fn__76030.invoke(execute.clj:36)"
"query_processor.middleware.cache$maybe_return_cached_results$maybe_return_cached_results_STAR___75980.invoke(cache.clj:241)"
"query_processor.middleware.permissions$check_query_permissions$fn__72652.invoke(permissions.clj:148)"
"query_processor.middleware.enterprise$check_download_permissions_middleware$fn__73373.invoke(enterprise.clj:51)"
"query_processor.middleware.enterprise$maybe_apply_column_level_perms_check_middleware$fn__73383.invoke(enterprise.clj:64)"
"query_processor.execute$execute76057__76058$fn__76059.invoke(execute.clj:94)"
"query_processor.setup$do_with_qp_setup73927__73928.invokeStatic(setup.clj:225)"
"query_processor.setup$do_with_qp_setup73927__73928.invoke(setup.clj:216)"
"query_processor.execute$execute76057__76058.invokeStatic(execute.clj:93)"
"query_processor.execute$execute76057__76058.invoke(execute.clj:89)"
"query_processor$process_query_STAR__STAR_.invokeStatic(query_processor.clj:49)"
"query_processor$process_query_STAR__STAR_.invoke(query_processor.clj:44)"
"query_processor.middleware.enterprise$fn__73400$handle_audit_app_internal_queries__73401$fn__73403.invoke(enterprise.clj:96)"
"query_processor.middleware.enterprise$handle_audit_app_internal_queries_middleware$fn__73411.invoke(enterprise.clj:103)"
"query_processor.middleware.process_userland_query$process_userland_query_middleware78670__78671$fn__78672.invoke(process_userland_query.clj:217)"
"query_processor.middleware.catch_exceptions$catch_exceptions78735__78736$fn__78737.invoke(catch_exceptions.clj:132)"
"query_processor$process_query78776__78777$fn__78778.invoke(query_processor.clj:80)"
"query_processor.setup$do_with_canceled_chan73922__73923$fn__73924.invoke(setup.clj:187)"
"query_processor.setup$do_with_database_local_settings73915__73916$fn__73917.invoke(setup.clj:181)"
"query_processor.setup$do_with...
[1e93adeb-8aba-4c50-ab59-28316177d392] 2025-02-04T16:49:24+11:00 DEBUG metabase.server.middleware.log POST /api/card/947/query 202 [ASYNC: completed] 1131ms (24 DB calls) App DB connections: 0/15 Jetty threads: 3/50 (4 idle, 0 queued) (103 total active threads) Queries in flight: 0 (0 queued); sqlserver DB 3 connections: 0/3 (0 threads blocked) {:metabase-user-id 1}
[1e93adeb-8aba-4c50-ab59-28316177d392] 2025-02-04T16:49:24+11:00 DEBUG metabase.server.middleware.log GET /api/database/3 200 5ms (1 DB calls) App DB connections: 0/15 Jetty threads: 4/50 (4 idle, 0 queued) (103 total active threads) Queries in flight: 0 (0 queued) {:metabase-user-id 1}
[1e93adeb-8aba-4c50-ab59-28316177d392] 2025-02-04T16:49:25+11:00 DEBUG metabase.server.middleware.log GET /api/session/properties 200 42ms (12 DB calls) App DB connections: 2/15 Jetty threads: 7/50 (3 idle, 0 queued) (103 total active threads) Queries in flight: 0 (0 queued) {:metabase-user-id 1}
[1e93adeb-8aba-4c50-ab59-28316177d392] 2025-02-04T16:49:25+11:00 DEBUG metabase.server.middleware.log GET /api/setting 200 56ms (15 DB calls) App DB connections: 1/15 Jetty threads: 7/50 (3 idle, 0 queued) (103 total active threads) Queries in flight: 0 (0 queued) {:metabase-user-id 1}
[1e93adeb-8aba-4c50-ab59-28316177d392] 2025-02-04T16:49:25+11:00 DEBUG metabase.server.middleware.log GET /api/setup/admin_checklist 200 105ms (11 DB calls) App DB connections: 0/15 Jetty threads: 6/50 (3 idle, 0 queued) (104 total active threads) Queries in flight: 0 (0 queued) {:metabase-user-id 1}
[1e93adeb-8aba-4c50-ab59-28316177d392] 2025-02-04T16:49:25+11:00 DEBUG metabase.server.middleware.log GET /api/session/properties 200 40ms (12 DB calls) App DB connections: 1/15 Jetty threads: 5/50 (4 idle, 0 queued) (105 total active threads) Queries in flight: 0 (0 queued) {:metabase-user-id 1}
[1e93adeb-8aba-4c50-ab59-28316177d392] 2025-02-04T16:49:26+11:00 DEBUG metabase.server.middleware.log GET /api/setting 200 61ms (15 DB calls) App DB connections: 0/15 Jetty threads: 5/50 (4 idle, 0 queued) (105 total active threads) Queries in flight: 0 (0 queued) {:metabase-user-id 1}
[1e93adeb-8aba-4c50-ab59-28316177d392] 2025-02-04T16:49:30+11:00 DEBUG metabase.server.middleware.log GET /api/util/bug_report_details 200 8ms (1 DB calls) App DB connections: 0/15 Jetty threads: 4/50 (4 idle, 0 queued) (105 total active threads) Queries in flight: 0 (0 queued) {:metabase-user-id 1}
{
"browser-info": {
"language": "en-US",
"platform": "Win32",
"userAgent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36",
"vendor": "Google Inc."
},
"metabase-info": {
"databases": [
"sqlserver",
"mysql"
],
"run-mode": "prod",
"plan-alias": "",
"version": {
"date": "2025-01-31",
"tag": "v0.52.9",
"hash": "f9fbbf8"
},
"settings": {
"report-timezone": "Australia/Victoria"
},
"hosting-env": "unknown",
"application-database": "mysql",
"application-database-details": {
"database": {
"name": "MySQL",
"version": "8.0.33"
},
"jdbc-driver": {
"name": "MariaDB Connector/J",
"version": "2.7.10"
}
}
},
"system-info": {
"file.encoding": "Cp1252",
"java.runtime.name": "OpenJDK Runtime Environment",
"java.runtime.version": "11.0.13+8",
"java.vendor": "Eclipse Adoptium",
"java.vendor.url": "https://adoptium.net/",
"java.version": "11.0.13",
"java.vm.name": "OpenJDK 64-Bit Server VM",
"java.vm.version": "11.0.13+8",
"os.name": "Windows Server 2019",
"os.version": "10.0",
"user.language": "en",
"user.timezone": "Australia/Sydney"
}
}