[cloud-user@pnailush-bastion che-operator]$ oc logs pod/che-65cfd996d8-b6lpg Using embedded assembly. Found a custom cert. Adding it to java trust store /home/user/cacerts based on /docker-java-home/lib/security/cacerts Trust this certificate? [no]: Certificate was added to keystore NOTE: Picked up JDK_JAVA_OPTIONS: --add-opens=java.base/java.lang=ALL-UNNAMED --add-opens=java.base/java.io=ALL-UNNAMED --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED 20-Jul-2020 07:49:33.894 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version name: Apache Tomcat/8.5.56 20-Jul-2020 07:49:33.904 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server built: Jun 3 2020 20:18:30 UTC 20-Jul-2020 07:49:33.904 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version number: 8.5.56.0 20-Jul-2020 07:49:33.904 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name: Linux 20-Jul-2020 07:49:33.905 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version: 4.18.0-147.8.1.el8_1.ppc64le 20-Jul-2020 07:49:33.905 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture: ppc64le 20-Jul-2020 07:49:33.905 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home: /usr/lib/jvm/java-11-openjdk-ppc64el 20-Jul-2020 07:49:33.905 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version: 11.0.3+1-Debian-1bpo91 20-Jul-2020 07:49:33.905 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor: Oracle Corporation 20-Jul-2020 07:49:33.905 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE: /home/user/eclipse-che/tomcat 20-Jul-2020 07:49:33.906 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME: /home/user/eclipse-che/tomcat 20-Jul-2020 07:49:33.914 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.lang=ALL-UNNAMED 20-Jul-2020 07:49:33.914 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.io=ALL-UNNAMED 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=/home/user/eclipse-che//tomcat/conf/logging.properties 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:MaxRAMPercentage=85.0 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.docker.network=bridge 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStore=/home/user/cacerts 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStorePassword=changeit 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dport.http=8080 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.home=/home/user/eclipse-che/ 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.logs.dir=/logs/ 20-Jul-2020 07:49:33.915 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.logs.level=INFO 20-Jul-2020 07:49:33.916 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djuli-logback.configurationFile=file:/home/user/eclipse-che//tomcat/conf/tomcat-logger.xml 20-Jul-2020 07:49:33.916 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048 20-Jul-2020 07:49:33.916 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources 20-Jul-2020 07:49:33.916 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.apache.catalina.security.SecurityListener.UMASK=0022 20-Jul-2020 07:49:33.916 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.local.conf.dir=/home/user/eclipse-che//tomcat/conf/ 20-Jul-2020 07:49:33.916 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs= 20-Jul-2020 07:49:33.916 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=/home/user/eclipse-che//tomcat 20-Jul-2020 07:49:33.916 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=/home/user/eclipse-che//tomcat 20-Jul-2020 07:49:33.917 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=/home/user/eclipse-che//tomcat/temp 20-Jul-2020 07:49:34.063 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8080"] 20-Jul-2020 07:49:34.081 INFO [main] org.apache.tomcat.util.net.NioSelectorPool.getSharedSelector Using a shared selector for servlet write/read 20-Jul-2020 07:49:34.169 INFO [main] org.apache.catalina.startup.Catalina.load Initialization processed in 1773 ms 20-Jul-2020 07:49:34.255 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina] 20-Jul-2020 07:49:34.255 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.5.56 20-Jul-2020 07:49:34.500 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [/home/user/eclipse-che/tomcat/webapps/ROOT.war] 20-Jul-2020 07:49:36.260 CONFIG [localhost-startStop-1] sun.util.locale.provider.LocaleServiceProviderPool.config A locale sensitive service provider returned null for a localized objects, which should not happen. provider: sun.util.cldr.CLDRCalendarDataProviderImpl@1ca5752f locale: en 20-Jul-2020 07:49:36.280 CONFIG [localhost-startStop-1] sun.util.locale.provider.LocaleServiceProviderPool.config A locale sensitive service provider returned null for a localized objects, which should not happen. provider: sun.util.cldr.CLDRCalendarDataProviderImpl@1ca5752f locale: en 20-Jul-2020 07:49:36.281 CONFIG [localhost-startStop-1] sun.util.locale.provider.LocaleServiceProviderPool.config A locale sensitive service provider returned null for a localized objects, which should not happen. provider: sun.util.cldr.CLDRCalendarDataProviderImpl@1ca5752f locale: en 20-Jul-2020 07:49:36.281 CONFIG [localhost-startStop-1] sun.util.locale.provider.LocaleServiceProviderPool.config A locale sensitive service provider returned null for a localized objects, which should not happen. provider: sun.util.cldr.CLDRCalendarDataProviderImpl@1ca5752f locale: en 20-Jul-2020 07:49:41.255 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deployment of web application archive [/home/user/eclipse-che/tomcat/webapps/ROOT.war] has finished in [6,755] ms 20-Jul-2020 07:49:41.266 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [/home/user/eclipse-che/tomcat/webapps/api.war] 2020-07-20 07:49:51,693[ost-startStop-1] [INFO ] [.e.c.c.d.JNDIDataSourceFactory 63] - This=org.eclipse.che.core.db.postgresql.PostgreSQLJndiDataSourceFactory@730ae6a7 obj=ResourceRef[className=javax.sql.DataSource,factoryClassLocation=null,factoryClassName=org.apache.naming.factory.ResourceFactory,{type=scope,content=Shareable},{type=auth,content=Container},{type=singleton,content=true},{type=factory,content=org.eclipse.che.api.CommonJndiDataSourceFactory}] name=che Context=org.apache.naming.NamingContext@4a59b77 environment={} WARNING: An illegal reflective access operation has occurred WARNING: Illegal reflective access by com.google.inject.assistedinject.FactoryProvider2$MethodHandleWrapper (file:/home/user/eclipse-che/tomcat/webapps/api/WEB-INF/lib/guice-assistedinject-4.2.2.jar) to constructor java.lang.invoke.MethodHandles$Lookup(java.lang.Class,int) WARNING: Please consider reporting this to the maintainers of com.google.inject.assistedinject.FactoryProvider2$MethodHandleWrapper WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations WARNING: All illegal access operations will be denied in a future release 2020-07-20 07:50:00,240[ost-startStop-1] [INFO ] [o.j.p.kubernetes.KUBE_PING 131] - namespace che09 set; clustering enabled ------------------------------------------------------------------- GMS: address=che-65cfd996d8-b6lpg-64417, cluster=RemoteSubscriptionChannel, physical address=10.128.2.153:7800 ------------------------------------------------------------------- 2020-07-20 07:50:05,118[ost-startStop-1] [INFO ] [o.jgroups.protocols.pbcast.GMS 125] - che-65cfd996d8-b6lpg-64417: no members discovered after 4780 ms: creating cluster as coordinator 2020-07-20 07:50:05,251[ost-startStop-1] [INFO ] [o.j.p.kubernetes.KUBE_PING 131] - namespace che09 set; clustering enabled ------------------------------------------------------------------- GMS: address=che-65cfd996d8-b6lpg-57768, cluster=WorkspaceLocks, physical address=10.128.2.153:7801 ------------------------------------------------------------------- 2020-07-20 07:50:09,078[ost-startStop-1] [INFO ] [o.jgroups.protocols.pbcast.GMS 125] - che-65cfd996d8-b6lpg-57768: no members discovered after 3768 ms: creating cluster as coordinator 2020-07-20 07:50:09,609[ost-startStop-1] [INFO ] [o.j.p.kubernetes.KUBE_PING 131] - namespace che09 set; clustering enabled ------------------------------------------------------------------- GMS: address=che-65cfd996d8-b6lpg-9777, cluster=WorkspaceStateCache, physical address=10.128.2.153:7802 ------------------------------------------------------------------- 2020-07-20 07:50:12,830[ost-startStop-1] [INFO ] [o.jgroups.protocols.pbcast.GMS 125] - che-65cfd996d8-b6lpg-9777: no members discovered after 3177 ms: creating cluster as coordinator 2020-07-20 07:50:12,832[ost-startStop-1] [INFO ] [o.e.c.m.k.s.KeycloakSettings 92] - Retrieving OpenId configuration from endpoint: https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/.well-known/openid-configuration 2020-07-20 07:50:13,568[ost-startStop-1] [INFO ] [o.e.c.m.k.s.KeycloakSettings 109] - openid configuration = {issuer=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che, authorization_endpoint=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/auth, token_endpoint=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/token, token_introspection_endpoint=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/token/introspect, userinfo_endpoint=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/userinfo, end_session_endpoint=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/logout, jwks_uri=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/certs, check_session_iframe=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/login-status-iframe.html, grant_types_supported=[authorization_code, implicit, refresh_token, password, client_credentials], response_types_supported=[code, none, id_token, token, id_token token, code id_token, code token, code id_token token], subject_types_supported=[public, pairwise], id_token_signing_alg_values_supported=[PS384, ES384, RS384, HS256, HS512, ES256, RS256, HS384, ES512, PS256, PS512, RS512], userinfo_signing_alg_values_supported=[PS384, ES384, RS384, HS256, HS512, ES256, RS256, HS384, ES512, PS256, PS512, RS512, none], request_object_signing_alg_values_supported=[PS384, ES384, RS384, ES256, RS256, ES512, PS256, PS512, RS512, none], response_modes_supported=[query, fragment, form_post], registration_endpoint=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/clients-registrations/openid-connect, token_endpoint_auth_methods_supported=[private_key_jwt, client_secret_basic, client_secret_post, client_secret_jwt], token_endpoint_auth_signing_alg_values_supported=[RS256], claims_supported=[aud, sub, iss, auth_time, name, given_name, family_name, preferred_username, email], claim_types_supported=[normal], claims_parameter_supported=false, scopes_supported=[openid, microprofile-jwt, web-origins, roles, phone, address, email, profile, offline_access], request_parameter_supported=true, request_uri_parameter_supported=true, code_challenge_methods_supported=[plain, S256], tls_client_certificate_bound_access_tokens=true, introspection_endpoint=https://keycloak-che09.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/token/introspect} 2020-07-20 07:50:14,505[ost-startStop-1] [INFO ] [o.f.c.i.d.DbSupportFactory 44] - Database: jdbc:postgresql://postgres:5432/dbche (PostgreSQL 10.6) 2020-07-20 07:50:14,674[ost-startStop-1] [INFO ] [o.f.c.i.util.VersionPrinter 44] - Flyway 4.2.0 by Boxfuse 2020-07-20 07:50:14,730[ost-startStop-1] [INFO ] [o.f.c.i.d.DbSupportFactory 44] - Database: jdbc:postgresql://postgres:5432/dbche (PostgreSQL 10.6) 2020-07-20 07:50:14,986[ost-startStop-1] [INFO ] [i.f.CustomSqlMigrationResolver 158] - Searching for SQL scripts in locations [classpath:che-schema] 2020-07-20 07:50:15,294[ost-startStop-1] [INFO ] [o.f.c.i.command.DbValidate 44] - Successfully validated 59 migrations (execution time 00:00.365s) 2020-07-20 07:50:15,502[ost-startStop-1] [INFO ] [o.f.c.i.command.DbMigrate 44] - Current version of schema "public": 7.16.0.1 2020-07-20 07:50:15,513[ost-startStop-1] [INFO ] [o.f.c.i.command.DbMigrate 44] - Schema "public" is up to date. No migration necessary. 2020-07-20 07:50:18,643[ost-startStop-1] [INFO ] [o.j.p.kubernetes.KUBE_PING 131] - namespace che09 set; clustering enabled ------------------------------------------------------------------- GMS: address=che-65cfd996d8-b6lpg-4227, cluster=EclipseLinkCommandChannel, physical address=10.128.2.153:7803 ------------------------------------------------------------------- 2020-07-20 07:50:22,789[ost-startStop-1] [INFO ] [o.jgroups.protocols.pbcast.GMS 125] - che-65cfd996d8-b6lpg-4227: no members discovered after 4073 ms: creating cluster as coordinator 2020-07-20 07:50:23,107[ost-startStop-1] [INFO ] [o.e.c.a.w.s.WorkspaceRuntimes 174] - Configured factories for environments: '[openshift, kubernetes, no-environment]' 2020-07-20 07:50:23,108[ost-startStop-1] [INFO ] [o.e.c.a.w.s.WorkspaceRuntimes 175] - Registered infrastructure 'openshift' 2020-07-20 07:50:23,259[ost-startStop-1] [INFO ] [o.e.c.a.w.s.WorkspaceRuntimes 661] - Infrastructure is tracking 0 active runtimes 2020-07-20 07:50:23,375[ost-startStop-1] [INFO ] [o.e.c.a.c.u.ApiInfoLogInformer 36] - Eclipse Che Api Core: Build info '7.16.0-SNAPSHOT' scmRevision 'd2c42c782a791051107ae8d703d4de445009f0b0' implementationVersion '7.16.0-SNAPSHOT' 2020-07-20 07:50:23,516[ost-startStop-1] [WARN ] [p.s.AdminPermissionInitializer 69] - Admin admin not found yet. 20-Jul-2020 07:50:23.964 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deployment of web application archive [/home/user/eclipse-che/tomcat/webapps/api.war] has finished in [42,697] ms 20-Jul-2020 07:50:23.965 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [/home/user/eclipse-che/tomcat/webapps/swagger.war] 20-Jul-2020 07:50:24.066 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deployment of web application archive [/home/user/eclipse-che/tomcat/webapps/swagger.war] has finished in [101] ms 20-Jul-2020 07:50:24.101 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/home/user/eclipse-che/tomcat/webapps/dashboard] 20-Jul-2020 07:50:24.144 INFO [localhost-startStop-1] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time. 20-Jul-2020 07:50:24.151 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory [/home/user/eclipse-che/tomcat/webapps/dashboard] has finished in [50] ms 20-Jul-2020 07:50:24.151 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/home/user/eclipse-che/tomcat/webapps/workspace-loader] 20-Jul-2020 07:50:24.195 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory [/home/user/eclipse-che/tomcat/webapps/workspace-loader] has finished in [43] ms 20-Jul-2020 07:50:24.222 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8080"] 20-Jul-2020 07:50:24.261 INFO [main] org.apache.catalina.startup.Catalina.start Server startup in 50091 ms