[cloud-user@pnailush-bastion che-operator]$ oc logs pod/che-7557866cf5-sstpt 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 23-Jul-2020 09:18:36.320 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version name: Apache Tomcat/8.5.56 23-Jul-2020 09:18:36.334 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server built: Jun 3 2020 20:18:30 UTC 23-Jul-2020 09:18:36.334 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version number: 8.5.56.0 23-Jul-2020 09:18:36.334 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name: Linux 23-Jul-2020 09:18:36.334 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version: 4.18.0-147.8.1.el8_1.ppc64le 23-Jul-2020 09:18:36.335 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture: ppc64le 23-Jul-2020 09:18:36.335 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home: /usr/lib/jvm/java-11-openjdk-ppc64el 23-Jul-2020 09:18:36.335 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version: 11.0.6+10-post-Debian-1bpo91 23-Jul-2020 09:18:36.335 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor: Debian 23-Jul-2020 09:18:36.335 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE: /home/user/eclipse-che/tomcat 23-Jul-2020 09:18:36.335 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME: /home/user/eclipse-che/tomcat 23-Jul-2020 09:18:36.337 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.lang=ALL-UNNAMED 23-Jul-2020 09:18:36.337 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.io=ALL-UNNAMED 23-Jul-2020 09:18:36.337 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED 23-Jul-2020 09:18:36.338 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=/home/user/eclipse-che//tomcat/conf/logging.properties 23-Jul-2020 09:18:36.338 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager 23-Jul-2020 09:18:36.338 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -XX:MaxRAMPercentage=85.0 23-Jul-2020 09:18:36.338 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.docker.network=bridge 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStore=/home/user/cacerts 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djavax.net.ssl.trustStorePassword=changeit 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dport.http=8080 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.home=/home/user/eclipse-che/ 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.logs.dir=/logs/ 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.logs.level=INFO 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djuli-logback.configurationFile=file:/home/user/eclipse-che//tomcat/conf/tomcat-logger.xml 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources 23-Jul-2020 09:18:36.339 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.apache.catalina.security.SecurityListener.UMASK=0022 23-Jul-2020 09:18:36.340 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dche.local.conf.dir=/home/user/eclipse-che//tomcat/conf/ 23-Jul-2020 09:18:36.340 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs= 23-Jul-2020 09:18:36.340 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=/home/user/eclipse-che//tomcat 23-Jul-2020 09:18:36.340 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=/home/user/eclipse-che//tomcat 23-Jul-2020 09:18:36.340 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=/home/user/eclipse-che//tomcat/temp 23-Jul-2020 09:18:36.441 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8080"] 23-Jul-2020 09:18:36.470 INFO [main] org.apache.tomcat.util.net.NioSelectorPool.getSharedSelector Using a shared selector for servlet write/read 23-Jul-2020 09:18:36.553 INFO [main] org.apache.catalina.startup.Catalina.load Initialization processed in 1586 ms 23-Jul-2020 09:18:36.688 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina] 23-Jul-2020 09:18:36.688 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.5.56 23-Jul-2020 09:18:37.230 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [/home/user/eclipse-che/tomcat/webapps/ROOT.war] 23-Jul-2020 09:18:43.770 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,538] ms 23-Jul-2020 09:18:43.814 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [/home/user/eclipse-che/tomcat/webapps/api.war] 2020-07-23 09:18:53,223[ost-startStop-1] [INFO ] [.e.c.c.d.JNDIDataSourceFactory 63] - This=org.eclipse.che.core.db.postgresql.PostgreSQLJndiDataSourceFactory@4a91c961 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@6f4f71ad 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-23 09:18:59,162[ost-startStop-1] [INFO ] [o.j.p.kubernetes.KUBE_PING 131] - namespace che17 set; clustering enabled ------------------------------------------------------------------- GMS: address=che-7557866cf5-sstpt-19729, cluster=RemoteSubscriptionChannel, physical address=10.128.3.103:7800 ------------------------------------------------------------------- 2020-07-23 09:19:03,002[ost-startStop-1] [INFO ] [o.jgroups.protocols.pbcast.GMS 125] - che-7557866cf5-sstpt-19729: no members discovered after 3722 ms: creating cluster as coordinator 2020-07-23 09:19:03,056[ost-startStop-1] [INFO ] [o.j.p.kubernetes.KUBE_PING 131] - namespace che17 set; clustering enabled ------------------------------------------------------------------- GMS: address=che-7557866cf5-sstpt-19124, cluster=WorkspaceLocks, physical address=10.128.3.103:7801 ------------------------------------------------------------------- 2020-07-23 09:19:06,200[ost-startStop-1] [INFO ] [o.jgroups.protocols.pbcast.GMS 125] - che-7557866cf5-sstpt-19124: no members discovered after 3131 ms: creating cluster as coordinator 2020-07-23 09:19:06,222[ost-startStop-1] [INFO ] [o.j.p.kubernetes.KUBE_PING 131] - namespace che17 set; clustering enabled ------------------------------------------------------------------- GMS: address=che-7557866cf5-sstpt-3530, cluster=WorkspaceStateCache, physical address=10.128.3.103:7802 ------------------------------------------------------------------- 2020-07-23 09:19:09,527[ost-startStop-1] [INFO ] [o.jgroups.protocols.pbcast.GMS 125] - che-7557866cf5-sstpt-3530: no members discovered after 3262 ms: creating cluster as coordinator 2020-07-23 09:19:09,530[ost-startStop-1] [INFO ] [o.e.c.m.k.s.KeycloakSettings 91] - Retrieving OpenId configuration from endpoint: https://keycloak-che17.apps.pnailush.example.com/auth/realms/che/.well-known/openid-configuration 2020-07-23 09:19:12,360[ost-startStop-1] [INFO ] [o.e.c.m.k.s.KeycloakSettings 108] - openid configuration = {issuer=https://keycloak-che17.apps.pnailush.example.com/auth/realms/che, authorization_endpoint=https://keycloak-che17.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/auth, token_endpoint=https://keycloak-che17.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/token, token_introspection_endpoint=https://keycloak-che17.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/token/introspect, userinfo_endpoint=https://keycloak-che17.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/userinfo, end_session_endpoint=https://keycloak-che17.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/logout, jwks_uri=https://keycloak-che17.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/certs, check_session_iframe=https://keycloak-che17.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-che17.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-che17.apps.pnailush.example.com/auth/realms/che/protocol/openid-connect/token/introspect} 2020-07-23 09:19:13,074[ost-startStop-1] [INFO ] [o.f.c.i.d.DbSupportFactory 44] - Database: jdbc:postgresql://postgres:5432/dbche (PostgreSQL 10.6) 2020-07-23 09:19:13,800[ost-startStop-1] [INFO ] [o.f.c.i.util.VersionPrinter 44] - Flyway 4.2.0 by Boxfuse 2020-07-23 09:19:13,956[ost-startStop-1] [INFO ] [o.f.c.i.d.DbSupportFactory 44] - Database: jdbc:postgresql://postgres:5432/dbche (PostgreSQL 10.6) 2020-07-23 09:19:14,387[ost-startStop-1] [INFO ] [i.f.CustomSqlMigrationResolver 158] - Searching for SQL scripts in locations [classpath:che-schema] 2020-07-23 09:19:14,611[ost-startStop-1] [INFO ] [o.f.c.i.command.DbValidate 44] - Successfully validated 58 migrations (execution time 00:00.235s) 2020-07-23 09:19:14,681[ost-startStop-1] [INFO ] [o.f.c.i.command.DbMigrate 44] - Current version of schema "public": 7.11.0.1 2020-07-23 09:19:14,705[ost-startStop-1] [INFO ] [o.f.c.i.command.DbMigrate 44] - Schema "public" is up to date. No migration necessary. 2020-07-23 09:19:17,085[ost-startStop-1] [INFO ] [o.j.p.kubernetes.KUBE_PING 131] - namespace che17 set; clustering enabled ------------------------------------------------------------------- GMS: address=che-7557866cf5-sstpt-46402, cluster=EclipseLinkCommandChannel, physical address=10.128.3.103:7803 ------------------------------------------------------------------- 2020-07-23 09:19:20,219[ost-startStop-1] [INFO ] [o.jgroups.protocols.pbcast.GMS 125] - che-7557866cf5-sstpt-46402: no members discovered after 3110 ms: creating cluster as coordinator 2020-07-23 09:19:20,439[ost-startStop-1] [INFO ] [o.e.c.a.w.s.WorkspaceRuntimes 174] - Configured factories for environments: '[openshift, kubernetes, no-environment]' 2020-07-23 09:19:20,440[ost-startStop-1] [INFO ] [o.e.c.a.w.s.WorkspaceRuntimes 175] - Registered infrastructure 'openshift' 2020-07-23 09:19:20,555[ost-startStop-1] [INFO ] [o.e.c.a.w.s.WorkspaceRuntimes 661] - Infrastructure is tracking 0 active runtimes 2020-07-23 09:19:20,600[ost-startStop-1] [INFO ] [o.e.c.a.c.u.ApiInfoLogInformer 36] - Eclipse Che Api Core: Build info '7.15.0-SNAPSHOT' scmRevision 'e96dbe28861fcea377561ce177e1eb577f693e3f' implementationVersion '7.15.0-SNAPSHOT' 2020-07-23 09:19:20,689[ost-startStop-1] [WARN ] [p.s.AdminPermissionInitializer 69] - Admin admin not found yet. 23-Jul-2020 09:19:20.916 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 [37,102] ms 23-Jul-2020 09:19:20.917 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [/home/user/eclipse-che/tomcat/webapps/swagger.war] 23-Jul-2020 09:19:20.961 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 [44] ms 23-Jul-2020 09:19:20.969 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/home/user/eclipse-che/tomcat/webapps/dashboard] 23-Jul-2020 09:19:20.986 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. 23-Jul-2020 09:19:20.989 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 [20] ms 23-Jul-2020 09:19:20.990 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/home/user/eclipse-che/tomcat/webapps/workspace-loader] 23-Jul-2020 09:19:21.006 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 [17] ms 23-Jul-2020 09:19:21.032 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8080"] 23-Jul-2020 09:19:21.068 INFO [main] org.apache.catalina.startup.Catalina.start Server startup in 44514 ms