IBM Support

AnalyticsProxy can not be installed due to store-api-deployment pod crash

Troubleshooting


Problem

store-api-deployment pod keeps crashing and AnalyticsProxy installation cannot complete.
 
Trace logs which can be seen in store-api-deployment pod.
2023-07-15 06:29:57.124  INFO 1 --- [           main] com.ibm.edge.StoreApiApplication         : Starting StoreApiApplication v2.0.8 using Java 11.0.18 on store-api-deployment-794c7dc65c-5h7tm with PID 1 (/usr/local/lib/store-api.jar started by store-api in /)
2023-07-15 06:29:57.129  INFO 1 --- [           main] com.ibm.edge.StoreApiApplication         : No active profile set, falling back to 1 default profile: "default"
2023-07-15 06:30:07.515  INFO 1 --- [           main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2023-07-15 06:30:08.117  INFO 1 --- [           main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 589 ms. Found 3 JPA repository interfaces.
2023-07-15 06:30:08.215  INFO 1 --- [           main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2023-07-15 06:30:08.419  INFO 1 --- [           main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 204 ms. Found 3 JPA repository interfaces.
2023-07-15 06:30:23.713  INFO 1 --- [           main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat initialized with port(s): 8443 (https)
2023-07-15 06:30:23.819  INFO 1 --- [           main] o.apache.catalina.core.StandardService   : Starting service [Tomcat]
2023-07-15 06:30:23.820  INFO 1 --- [           main] org.apache.catalina.core.StandardEngine  : Starting Servlet engine: [Apache Tomcat/9.0.68]
2023-07-15 06:30:24.617  INFO 1 --- [           main] o.a.c.c.C.[Tomcat].[localhost].[/]       : Initializing Spring embedded WebApplicationContext
2023-07-15 06:30:24.617  INFO 1 --- [           main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 26804 ms
2023-07-15 06:30:32.523  INFO 1 --- [           main] com.zaxxer.hikari.HikariDataSource       : HikariPool-1 - Starting...
2023-07-15 06:30:44.147 ERROR 1 --- [           main] com.zaxxer.hikari.pool.HikariPool        : HikariPool-1 - Exception during pool initialization.

org.postgresql.util.PSQLException: The connection attempt failed.
	at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:331) ~[postgresql-42.4.1.jar!/:42.4.1]
	at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:49) ~[postgresql-42.4.1.jar!/:42.4.1]
	at org.postgresql.jdbc.PgConnection.<init>(PgConnection.java:247) ~[postgresql-42.4.1.jar!/:42.4.1]
	at org.postgresql.Driver.makeConnection(Driver.java:434) ~[postgresql-42.4.1.jar!/:42.4.1]
	at org.postgresql.Driver.connect(Driver.java:291) ~[postgresql-42.4.1.jar!/:42.4.1]
	at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:138) 

2023-07-15 06:30:44.150  WARN 1 --- [           main] ConfigServletWebServerApplicationContext : Exception encountered during context initialization - cancelling refresh attempt: org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'flyway' defined in class path resource [org/springframework/boot/autoconfigure/flyway/FlywayAutoConfiguration$FlywayConfiguration.class]: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.flywaydb.core.Flyway]: Factory method 'flyway' threw exception; nested exception is java.lang.IllegalStateException: org.springframework.jdbc.support.MetaDataAccessException: Could not get Connection for extracting meta-data; nested exception is org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection; nested exception is org.postgresql.util.PSQLException: The connection attempt failed.
2023-07-15 06:30:44.156  INFO 1 --- [           main] o.apache.catalina.core.StandardService   : Stopping service [Tomcat]
2023-07-15 06:30:44.315  INFO 1 --- [           main] ConditionEvaluationReportLoggingListener : 

Error starting ApplicationContext. To display the conditions report re-run your application with 'debug' enabled.
2023-07-15 06:30:44.622 ERROR 1 --- [           main] o.s.boot.SpringApplication               : Application run failed

org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'flyway' defined in class path resource [org/springframework/boot/autoconfigure/flyway/FlywayAutoConfiguration$FlywayConfiguration.class]: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.flywaydb.core.Flyway]: Factory method 'flyway' threw exception; nested exception is java.lang.IllegalStateException: org.springframework.jdbc.support.MetaDataAccessException: Could not get Connection for extracting meta-data; nested exception is org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection; nested exception is org.postgresql.util.PSQLException: The connection attempt failed.
	
Trace logs from "pgo" (Postgres Operator) pod:
time="2023-07-15T06:17:38Z" level=debug msg="debug flag set to true" version=5.4.0-0
time="2023-07-15T06:17:38Z" level=info msg="feature gates enabled" PGO_FEATURE_GATES= version=5.4.0-0
I0715 06:17:39.282677       1 request.go:601] Waited for 1.034374937s due to client-side throttling, not priority and fairness, request: GET:https://172.30.0.1:443/apis/apps.openshift.io/v1?timeout=32s
time="2023-07-15T06:17:41Z" level=info msg="Metrics server is starting to listen" addr=":8080" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="detected OpenShift environment" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="upgrade checking enabled" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="starting controller runtime manager and will wait for signal to exit" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting server" addr="[::]:8080" kind=metrics path=/metrics version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=postgrescluster controllerGroup=postgres-operator.crunchydata.com controllerKind=PostgresCluster source="kind source: *v1beta1.PostgresCluster" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=pgupgrade controllerGroup=postgres-operator.crunchydata.com controllerKind=PGUpgrade source="kind source: *v1beta1.PGUpgrade" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=postgrescluster controllerGroup=postgres-operator.crunchydata.com controllerKind=PostgresCluster source="kind source: *v1.ConfigMap" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=pgupgrade controllerGroup=postgres-operator.crunchydata.com controllerKind=PGUpgrade source="kind source: *v1.Job" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=postgrescluster controllerGroup=postgres-operator.crunchydata.com controllerKind=PostgresCluster source="kind source: *v1.Endpoints" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=pgupgrade controllerGroup=postgres-operator.crunchydata.com controllerKind=PGUpgrade source="kind source: *v1beta1.PostgresCluster" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=postgrescluster controllerGroup=postgres-operator.crunchydata.com controllerKind=PostgresCluster source="kind source: *v1.PersistentVolumeClaim" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting Controller" controller=pgupgrade controllerGroup=postgres-operator.crunchydata.com controllerKind=PGUpgrade version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=postgrescluster controllerGroup=postgres-operator.crunchydata.com controllerKind=PostgresCluster source="kind source: *v1.Secret" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=postgrescluster controllerGroup=postgres-operator.crunchydata.com controllerKind=PostgresCluster source="kind source: *v1.Service" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=postgrescluster controllerGroup=postgres-operator.crunchydata.com controllerKind=PostgresCluster source="kind source: *v1.ServiceAccount" version=5.4.0-0
time="2023-07-15T06:17:41Z" level=info msg="Starting EventSource" controller=postgrescluster controllerGroup=postgres-op

Resolving The Problem

Two new catalogs are released providing the fix delivered by the User Data Services team for this bug:

The v8-230721-amd64 catalog update is a republish of the previous 0627 catalog with only the UDS operator package updated. The v8-230725-amd64 catalog is a standard monthly update including updates to IBM Maximo Application Suite.

Document Location

Worldwide

[{"Type":"MASTER","Line of Business":{"code":"LOB59","label":"Sustainability Software"},"Business Unit":{"code":"BU059","label":"IBM Software w\/o TPS"},"Product":{"code":"SSRHPA","label":"IBM Maximo Application Suite"},"ARM Category":[{"code":"a8m3p000000hAeeAAE","label":"Maximo Application Suite-\u003ECore"}],"ARM Case Number":"","Platform":[{"code":"PF025","label":"Platform Independent"}],"Version":"All Versions"}]

Document Information

Modified date:
27 July 2023

UID

ibm17015063