I am able to run metabase via the java -jar metabase.jar command and can then access it via the browser. I then followed the directions at Running Metabase on Debian as a service with nginx completely. I cannot access metabase through the browser. "ps -aux" shows that the program is running as the proper user. netstat shows that the port 3000 is not open at all, though.
"systemctl status metabase" shows me:
Dec 09 15:01:02 dashboard systemd[1]: Started Metabase server.
Dec 09 15:01:05 dashboard metabase[4211]: Warning: protocol #'java-time.core/Amount is overwriting function abs
Dec 09 15:01:05 dashboard metabase[4211]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time.core, being replaced by: #'java-time.core/abs
Dec 09 15:01:06 dashboard metabase[4211]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time, being replaced by: #'java-time/abs
"journalctl -u metabase" shows the service started successfully with no errors and tells me:
Dec 09 15:01:54 dashboard systemd[1]: Stopped Metabase server.
Dec 09 15:01:54 dashboard systemd[1]: Started Metabase server.
Dec 09 15:01:57 dashboard metabase[4252]: Warning: protocol #'java-time.core/Amount is overwriting function abs
Dec 09 15:01:57 dashboard metabase[4252]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time.core, being replaced by: #'java-time.core/abs
Dec 09 15:01:58 dashboard metabase[4252]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time, being replaced by: #'java-time/abs
Dec 09 15:02:01 dashboard metabase[4252]: 2022-12-09 15:02:01,858 INFO metabase.util :: Maximum memory available to JVM: 982.0 MB
Dec 09 15:02:04 dashboard metabase[4252]: 2022-12-09 15:02:04,231 INFO util.encryption :: Saved credentials encryption is DISABLED for this Metabase instance.
Dec 09 15:02:04 dashboard metabase[4252]: For more information, see https://metabase.com/docs/latest/operations-guide/encrypting-database-details-at-rest.html
Dec 09 15:02:04 dashboard metabase[4252]: WARNING: abs already refers to: #'clojure.core/abs in namespace: taoensso.encore, being replaced by: #'taoensso.encore/abs
I have set this up and had it working on another machine. Can't seem to figure out why it's failing.
Hi @momentumrising
It's not possible to tell what is going on without the full logs. I would guess it's a permission problem, but that's difficult to say.
The logs you are showing from journalctl -u metabase is only the beginning, it does not show Metabase is started, which would be this line: INFO metabase.core Metabase Initialization COMPLETE
Here is the relevant output from the metabase.log file. Seems to be the main error is: "java.sql.SQLException: RSA public key is not available client side (option serverRsaPublicKeyFile not set)"
Dec 18 21:17:27 dashboard metabase[9372]: 2022-12-18 21:17:27,563 INFO metabase.core :: Setting up and migrating Metabase DB. Please sit tight, this may take a minute...
Dec 18 21:17:27 dashboard metabase[9372]: 2022-12-18 21:17:27,572 INFO db.setup :: #033[36mVerifying mysql Database Connection ...#033[0m
Dec 18 21:17:57 dashboard metabase[9372]: 2022-12-18 21:17:57,982 ERROR metabase.core :: Metabase Initialization FAILED
Dec 18 21:17:57 dashboard metabase[9372]: clojure.lang.ExceptionInfo: Unable to connect to Metabase mysql DB. {}
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349$fn__36350$fn__36351.invoke(setup.clj:100)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349$fn__36350.invoke(setup.clj:98)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349.invoke(setup.clj:90)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431$fn__36432$fn__36435$fn__36436.invoke(setup.clj:145)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.util$do_with_us_locale.invokeStatic(util.clj:707)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.util$do_with_us_locale.invoke(util.clj:693)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431$fn__36432$fn__36435.invoke(setup.clj:144)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431$fn__36432.invoke(setup.clj:143)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431.invoke(setup.clj:137)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db$setup_db_BANG_$fn__36461.invoke(db.clj:65)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db$setup_db_BANG_.invokeStatic(db.clj:60)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.db$setup_db_BANG_.invoke(db.clj:51)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.core$init_BANG__STAR_.invokeStatic(core.clj:101)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.core$init_BANG__STAR_.invoke(core.clj:87)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.core$init_BANG_.invokeStatic(core.clj:144)
Dec 18 21:17:57 dashboard metabase[9372]: #011at metabase.core$init_BANG_.invoke(core.clj:139)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.core$start_normally.invokeStatic(core.clj:156)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.core$start_normally.invoke(core.clj:150)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.core$_main.invokeStatic(core.clj:189)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.core$_main.doInvoke(core.clj:183)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.lang.RestFn.invoke(RestFn.java:397)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.lang.AFn.applyToHelper(AFn.java:152)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.lang.RestFn.applyTo(RestFn.java:132)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.lang.Var.applyTo(Var.java:705)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.core$apply.invokeStatic(core.clj:667)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.core$apply.invoke(core.clj:662)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.bootstrap$_main.invokeStatic(bootstrap.clj:23)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.bootstrap$_main.doInvoke(bootstrap.clj:20)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.lang.RestFn.invoke(RestFn.java:397)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.lang.AFn.applyToHelper(AFn.java:152)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.lang.RestFn.applyTo(RestFn.java:132)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.bootstrap.main(Unknown Source)
Dec 18 21:17:58 dashboard metabase[9372]: Caused by: java.sql.SQLException: Connections could not be acquired from the underlying database!
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:118)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:692)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:140)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.java.jdbc$get_connection.invokeStatic(jdbc.clj:372)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.java.jdbc$get_connection.invoke(jdbc.clj:274)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.java.jdbc$db_query_with_resultset_STAR_.invokeStatic(jdbc.clj:1111)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.java.jdbc$db_query_with_resultset_STAR_.invoke(jdbc.clj:1093)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.java.jdbc$query.invokeStatic(jdbc.clj:1182)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.java.jdbc$query.invoke(jdbc.clj:1144)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.java.jdbc$query.invokeStatic(jdbc.clj:1160)
Dec 18 21:17:58 dashboard metabase[9372]: #011at clojure.java.jdbc$query.invoke(jdbc.clj:1144)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.driver.sql_jdbc.connection$can_connect_with_spec_QMARK_.invokeStatic(connection.clj:297)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.driver.sql_jdbc.connection$can_connect_with_spec_QMARK_.invoke(connection.clj:294)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349$fn__36350$fn__36351.invoke(setup.clj:98)
Dec 18 21:17:58 dashboard metabase[9372]: #011... 31 more
Dec 18 21:17:58 dashboard metabase[9372]: Caused by: com.mchange.v2.resourcepool.CannotAcquireResourceException: A ResourcePool could not acquire a resource from its primary factory or source.
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1507)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:644)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:554)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutAndMarkConnectionInUse(C3P0PooledConnectionPool.java:758)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:685)
Dec 18 21:17:58 dashboard metabase[9372]: #011... 43 more
Dec 18 21:17:58 dashboard metabase[9372]: Caused by: java.sql.SQLTransientConnectionException: Could not connect to address=(host=***.***.***(port=3306)(type=master) : RSA public key is not available client side (option serverRsaPublicKeyFile not set)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:79)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:197)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.connectWithoutProxy(AbstractConnectProtocol.java:1394)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.internal.util.Utils.retrieveProxy(Utils.java:635)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.MariaDbConnection.newConnection(MariaDbConnection.java:150)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.Driver.connect(Driver.java:89)
Dec 18 21:17:58 dashboard metabase[9372]: #011at java.sql/java.sql.DriverManager.getConnection(DriverManager.java:677)
Dec 18 21:17:58 dashboard metabase[9372]: #011at java.sql/java.sql.DriverManager.getConnection(DriverManager.java:189)
Dec 18 21:17:58 dashboard metabase[9372]: #011at metabase.db.data_source.DataSource.getConnection(data_source.clj:25)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:161)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:147)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:202)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1176)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.resourcepool.BasicResourcePool.doAcquireAndDecrementPendingAcquiresWithinLockOnSuccess(BasicResourcePool.java:1163)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.resourcepool.BasicResourcePool.access$700(BasicResourcePool.java:44)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.resourcepool.BasicResourcePool$ScatteredAcquireTask.run(BasicResourcePool.java:1908)
Dec 18 21:17:58 dashboard metabase[9372]: #011at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:696)
Dec 18 21:17:58 dashboard metabase[9372]: Caused by: java.sql.SQLException: RSA public key is not available client side (option serverRsaPublicKeyFile not set)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.internal.com.send.authentication.CachingSha2PasswordPlugin.process(CachingSha2PasswordPlugin.java:189)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.authenticationHandler(AbstractConnectProtocol.java:757)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.createConnection(AbstractConnectProtocol.java:558)
Dec 18 21:17:58 dashboard metabase[9372]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.connectWithoutProxy(AbstractConnectProtocol.java:1389)
Dec 18 21:17:58 dashboard metabase[9372]: #011... 14 more
Dec 18 21:17:58 dashboard metabase[9372]: 2022-12-18 21:17:58,003 INFO metabase.core :: Metabase Shutting Down ...
Dec 18 21:17:58 dashboard metabase[9372]: 2022-12-18 21:17:58,007 INFO metabase.server :: Shutting Down Embedded Jetty Webserver
Dec 18 21:17:58 dashboard metabase[9372]: 2022-12-18 21:17:58,020 INFO metabase.core :: Metabase Shutdown COMPLETE
Dec 18 21:18:01 dashboard metabase[9486]: Warning: protocol #'java-time.core/Amount is overwriting function abs
Dec 18 21:18:01 dashboard metabase[9486]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time.core, being replaced by: #'java-time.core/abs
Dec 18 21:18:02 dashboard metabase[9486]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time, being replaced by: #'java-time/abs
Dec 18 21:18:06 dashboard metabase[9486]: 2022-12-18 21:18:06,043 INFO metabase.util :: Maximum memory available to JVM: 982.0 MB
Dec 18 21:18:08 dashboard metabase[9486]: 2022-12-18 21:18:08,547 INFO util.encryption :: Saved credentials encryption is DISABLED for this Metabase instance.
Dec 18 21:18:08 dashboard metabase[9486]: For more information, see https://metabase.com/docs/latest/operations-guide/encrypting-database-details-at-rest.html
Dec 18 21:18:08 dashboard metabase[9486]: WARNING: abs already refers to: #'clojure.core/abs in namespace: taoensso.encore, being replaced by: #'taoensso.encore/abs
I read that article now. I changed to use "identified with mysql_native_password" in the user definition in the mysql server. Also I verified from the metabase server via nmap that it detects port 3306 on the mysql server as open. It seems to have a little bit different of an error set now:
Dec 22 06:19:18 dashboard metabase[2779]: 2022-12-22 06:19:18,285 INFO metabase.core :: Setting up and migrating Metabase DB. Please sit tight, this may take a minute...
Dec 22 06:19:18 dashboard metabase[2779]: 2022-12-22 06:19:18,291 INFO db.setup :: #033[36mVerifying mysql Database Connection ...#033[0m
Dec 22 06:19:48 dashboard metabase[2779]: 2022-12-22 06:19:48,698 ERROR metabase.core :: Metabase Initialization FAILED
Dec 22 06:19:48 dashboard metabase[2779]: clojure.lang.ExceptionInfo: Unable to connect to Metabase mysql DB. {}
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349$fn__36350$fn__36351.invoke(setup.clj:100)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349$fn__36350.invoke(setup.clj:98)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349.invoke(setup.clj:90)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431$fn__36432$fn__36435$fn__36436.invoke(setup.clj:145)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.util$do_with_us_locale.invokeStatic(util.clj:707)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.util$do_with_us_locale.invoke(util.clj:693)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431$fn__36432$fn__36435.invoke(setup.clj:144)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431$fn__36432.invoke(setup.clj:143)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431.invoke(setup.clj:137)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db$setup_db_BANG_$fn__36461.invoke(db.clj:65)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db$setup_db_BANG_.invokeStatic(db.clj:60)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db$setup_db_BANG_.invoke(db.clj:51)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$init_BANG__STAR_.invokeStatic(core.clj:101)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$init_BANG__STAR_.invoke(core.clj:87)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$init_BANG_.invokeStatic(core.clj:144)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$init_BANG_.invoke(core.clj:139)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$start_normally.invokeStatic(core.clj:156)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$start_normally.invoke(core.clj:150)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$_main.invokeStatic(core.clj:189)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$_main.doInvoke(core.clj:183)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.RestFn.invoke(RestFn.java:397)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.AFn.applyToHelper(AFn.java:152)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.RestFn.applyTo(RestFn.java:132)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.Var.applyTo(Var.java:705)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.core$apply.invokeStatic(core.clj:667)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.core$apply.invoke(core.clj:662)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.bootstrap$_main.invokeStatic(bootstrap.clj:23)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.bootstrap$_main.doInvoke(bootstrap.clj:20)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.RestFn.invoke(RestFn.java:397)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.AFn.applyToHelper(AFn.java:152)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.RestFn.applyTo(RestFn.java:132)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.bootstrap.main(Unknown Source)
Dec 22 06:19:48 dashboard metabase[2779]: Caused by: java.sql.SQLException: Connections could not be acquired from the underlying database!
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:118)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:692)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:140)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$get_connection.invokeStatic(jdbc.clj:372)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$get_connection.invoke(jdbc.clj:274)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$db_query_with_resultset_STAR_.invokeStatic(jdbc.clj:1111)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$db_query_with_resultset_STAR_.invoke(jdbc.clj:1093)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$query.invokeStatic(jdbc.clj:1182)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$query.invoke(jdbc.clj:1144)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$query.invokeStatic(jdbc.clj:1160)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$query.invoke(jdbc.clj:1144)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.driver.sql_jdbc.connection$can_connect_with_spec_QMARK_.invokeStatic(connection.clj:297)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.driver.sql_jdbc.connection$can_connect_with_spec_QMARK_.invoke(connection.clj:294)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349$fn__36350$fn__36351.invoke(setup.clj:98)
Dec 22 06:19:48 dashboard metabase[2779]: #011... 31 more
Dec 22 06:19:48 dashboard metabase[2779]: Caused by: com.mchange.v2.resourcepool.CannotAcquireResourceException: A ResourcePool could not acquire a resource from its primary factory or source.
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1507)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:644)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:554)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutAndMarkConnectionInUse(C3P0PooledConnectionPool.java:758)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:685)
Dec 22 06:19:48 dashboard metabase[2779]: #011... 43 more
Dec 22 06:19:48 dashboard metabase[2779]: Caused by: java.sql.SQLInvalidAuthorizationSpecException: Could not connect to address=(host=xxx.xxx.xxx)(port=3306)(type=master) : (conn=2801) Access denied for user 'metabase'@'xx.xx.xx.xx' (using password: YES)
Dec 22 06:19:48 dashboard metabase[2779]: Current charset is UTF-8. If password has been set using other charset, consider using option 'passwordCharacterEncoding'
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:66)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:197)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.connectWithoutProxy(AbstractConnectProtocol.java:1394)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.Utils.retrieveProxy(Utils.java:635)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.MariaDbConnection.newConnection(MariaDbConnection.java:150)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.Driver.connect(Driver.java:89)
Dec 22 06:19:48 dashboard metabase[2779]: #011at java.sql/java.sql.DriverManager.getConnection(DriverManager.java:677)
Dec 22 06:19:48 dashboard metabase[2779]: #011at java.sql/java.sql.DriverManager.getConnection(DriverManager.java:189)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.data_source.DataSource.getConnection(data_source.clj:25)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:161)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:147)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:202)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1176)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.doAcquireAndDecrementPendingAcquiresWithinLockOnSuccess(BasicResourcePool.java:1163)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.access$700(BasicResourcePool.java:44)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool$ScatteredAcquireTask.run(BasicResourcePool.java:1908)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:696)
Dec 22 06:19:48 dashboard metabase[2779]: Caused by: java.sql.SQLInvalidAuthorizationSpecException: (conn=2801) Access denied for user 'metabase'@'xx.xx.xx.xx' (using password: YES)
Dec 22 06:19:48 dashboard metabase[2779]: Current charset is UTF-8. If password has been set using other charset, consider using option 'passwordCharacterEncoding'
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:66)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:192)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.authenticationHandler(AbstractConnectProtocol.java:772)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.createConnection(AbstractConnectProtocol.java:558)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.connectWithoutProxy(AbstractConnectProtocol.java:1389)
Dec 22 06:19:48 dashboard metabase[2779]: #011... 14 more
Dec 22 06:19:48 dashboard metabase[2779]: 2022-12-22 06:19:48,724 INFO metabase.core :: Metabase Shutting Down ...
Dec 22 06:19:48 dashboard metabase[2779]: 2022-12-22 06:19:48,732 INFO metabase.server :: Shutting Down Embedded Jetty Webserver
Dec 22 06:19:48 dashboard metabase[2779]: 2022-12-22 06:19:48,744 INFO metabase.core :: Metabase Shutdown COMPLETE
Dec 22 06:19:52 dashboard metabase[2818]: Warning: protocol #'java-time.core/Amount is overwriting function abs
Dec 22 06:19:52 dashboard metabase[2818]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time.core, being replaced by: #'java-time.core/abs
Dec 22 06:19:53 dashboard metabase[2818]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time, being replaced by: #'java-time/abs
Dec 22 06:19:18 dashboard metabase[2779]: 2022-12-22 06:19:18,285 INFO metabase.core :: Setting up and migrating Metabase DB. Please sit tight, this may take a minute...
Dec 22 06:19:18 dashboard metabase[2779]: 2022-12-22 06:19:18,291 INFO db.setup :: #033[36mVerifying mysql Database Connection ...#033[0m
Dec 22 06:19:48 dashboard metabase[2779]: 2022-12-22 06:19:48,698 ERROR metabase.core :: Metabase Initialization FAILED
Dec 22 06:19:48 dashboard metabase[2779]: clojure.lang.ExceptionInfo: Unable to connect to Metabase mysql DB. {}
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349$fn__36350$fn__36351.invoke(setup.clj:100)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349$fn__36350.invoke(setup.clj:98)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349.invoke(setup.clj:90)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431$fn__36432$fn__36435$fn__36436.invoke(setup.clj:145)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.util$do_with_us_locale.invokeStatic(util.clj:707)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.util$do_with_us_locale.invoke(util.clj:693)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431$fn__36432$fn__36435.invoke(setup.clj:144)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431$fn__36432.invoke(setup.clj:143)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36426$setup_db_BANG___36431.invoke(setup.clj:137)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db$setup_db_BANG_$fn__36461.invoke(db.clj:65)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db$setup_db_BANG_.invokeStatic(db.clj:60)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db$setup_db_BANG_.invoke(db.clj:51)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$init_BANG__STAR_.invokeStatic(core.clj:101)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$init_BANG__STAR_.invoke(core.clj:87)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$init_BANG_.invokeStatic(core.clj:144)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$init_BANG_.invoke(core.clj:139)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$start_normally.invokeStatic(core.clj:156)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$start_normally.invoke(core.clj:150)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$_main.invokeStatic(core.clj:189)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.core$_main.doInvoke(core.clj:183)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.RestFn.invoke(RestFn.java:397)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.AFn.applyToHelper(AFn.java:152)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.RestFn.applyTo(RestFn.java:132)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.Var.applyTo(Var.java:705)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.core$apply.invokeStatic(core.clj:667)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.core$apply.invoke(core.clj:662)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.bootstrap$_main.invokeStatic(bootstrap.clj:23)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.bootstrap$_main.doInvoke(bootstrap.clj:20)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.RestFn.invoke(RestFn.java:397)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.AFn.applyToHelper(AFn.java:152)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.lang.RestFn.applyTo(RestFn.java:132)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.bootstrap.main(Unknown Source)
Dec 22 06:19:48 dashboard metabase[2779]: Caused by: java.sql.SQLException: Connections could not be acquired from the underlying database!
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:118)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:692)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:140)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$get_connection.invokeStatic(jdbc.clj:372)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$get_connection.invoke(jdbc.clj:274)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$db_query_with_resultset_STAR_.invokeStatic(jdbc.clj:1111)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$db_query_with_resultset_STAR_.invoke(jdbc.clj:1093)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$query.invokeStatic(jdbc.clj:1182)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$query.invoke(jdbc.clj:1144)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$query.invokeStatic(jdbc.clj:1160)
Dec 22 06:19:48 dashboard metabase[2779]: #011at clojure.java.jdbc$query.invoke(jdbc.clj:1144)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.driver.sql_jdbc.connection$can_connect_with_spec_QMARK_.invokeStatic(connection.clj:297)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.driver.sql_jdbc.connection$can_connect_with_spec_QMARK_.invoke(connection.clj:294)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.setup$fn__36344$verify_db_connection__36349$fn__36350$fn__36351.invoke(setup.clj:98)
Dec 22 06:19:48 dashboard metabase[2779]: #011... 31 more
Dec 22 06:19:48 dashboard metabase[2779]: Caused by: com.mchange.v2.resourcepool.CannotAcquireResourceException: A ResourcePool could not acquire a resource from its primary factory or source.
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1507)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:644)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:554)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutAndMarkConnectionInUse(C3P0PooledConnectionPool.java:758)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:685)
Dec 22 06:19:48 dashboard metabase[2779]: #011... 43 more
Dec 22 06:19:48 dashboard metabase[2779]: Caused by: java.sql.SQLInvalidAuthorizationSpecException: Could not connect to address=(host=xxx.xxx.xxx)(port=3306)(type=master) : (conn=2801) Access denied for user 'metabase'@'xx.xx.xx.xx' (using password: YES)
Dec 22 06:19:48 dashboard metabase[2779]: Current charset is UTF-8. If password has been set using other charset, consider using option 'passwordCharacterEncoding'
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:66)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:197)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.connectWithoutProxy(AbstractConnectProtocol.java:1394)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.Utils.retrieveProxy(Utils.java:635)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.MariaDbConnection.newConnection(MariaDbConnection.java:150)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.Driver.connect(Driver.java:89)
Dec 22 06:19:48 dashboard metabase[2779]: #011at java.sql/java.sql.DriverManager.getConnection(DriverManager.java:677)
Dec 22 06:19:48 dashboard metabase[2779]: #011at java.sql/java.sql.DriverManager.getConnection(DriverManager.java:189)
Dec 22 06:19:48 dashboard metabase[2779]: #011at metabase.db.data_source.DataSource.getConnection(data_source.clj:25)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:161)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:147)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:202)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1176)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.doAcquireAndDecrementPendingAcquiresWithinLockOnSuccess(BasicResourcePool.java:1163)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool.access$700(BasicResourcePool.java:44)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.resourcepool.BasicResourcePool$ScatteredAcquireTask.run(BasicResourcePool.java:1908)
Dec 22 06:19:48 dashboard metabase[2779]: #011at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:696)
Dec 22 06:19:48 dashboard metabase[2779]: Caused by: java.sql.SQLInvalidAuthorizationSpecException: (conn=2801) Access denied for user 'metabase'@'xx.xx.xx.xx' (using password: YES)
Dec 22 06:19:48 dashboard metabase[2779]: Current charset is UTF-8. If password has been set using other charset, consider using option 'passwordCharacterEncoding'
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:66)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:192)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.authenticationHandler(AbstractConnectProtocol.java:772)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.createConnection(AbstractConnectProtocol.java:558)
Dec 22 06:19:48 dashboard metabase[2779]: #011at org.mariadb.jdbc.internal.protocol.AbstractConnectProtocol.connectWithoutProxy(AbstractConnectProtocol.java:1389)
Dec 22 06:19:48 dashboard metabase[2779]: #011... 14 more
Dec 22 06:19:48 dashboard metabase[2779]: 2022-12-22 06:19:48,724 INFO metabase.core :: Metabase Shutting Down ...
Dec 22 06:19:48 dashboard metabase[2779]: 2022-12-22 06:19:48,732 INFO metabase.server :: Shutting Down Embedded Jetty Webserver
Dec 22 06:19:48 dashboard metabase[2779]: 2022-12-22 06:19:48,744 INFO metabase.core :: Metabase Shutdown COMPLETE
Dec 22 06:19:52 dashboard metabase[2818]: Warning: protocol #'java-time.core/Amount is overwriting function abs
Dec 22 06:19:52 dashboard metabase[2818]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time.core, being replaced by: #'java-time.core/abs
Dec 22 06:19:53 dashboard metabase[2818]: WARNING: abs already refers to: #'clojure.core/abs in namespace: java-time, being replaced by: #'java-time/abs
@momentumrising You'll need to set the password again, when you are changing authentication method, and you need to modify the correct user.
Remember that MySQL can have a single "user", but that user can access from different hosts (or all hosts, which is written like %).
If you have multiple hosts for the same user, then make sure they are set correctly for the host that Metabase is using.
So, it seems to have initialized properly now. It turns out that I had to recreate the user and make sure not to do "alter user metabase@ipaddress require ssl". Does metabase not use SSL when connecting to a mysql server? I notice that after the initial setup succeeds, then I go to add a database with some data to play with, I choose to use SSL encrypted connection, paste the server's entire certificate, (which I'm not sure why I would need to), then it tells me the following:
Could not connect to address=(host=xxx.xxx.xxx)(port=3306)(type=master) : Could not connect to xxx.xxx.xxx:3306 : PKIX path building failed: sun.security.provider.certpath.SunCertPathBuilderException: unable to find valid certification path to requested target