By type
+ JAVA_HOME=/usr/lib/jvm/java-11-openjdk/ + KEYSTORE=/opt/app/osaaf/local/org.onap.policy.p12 + TRUSTSTORE=/opt/app/policy/distribution/etc/ssl/policy-truststore + KEYSTORE_PASSWD=Pol1cy_0nap + TRUSTSTORE_PASSWD=Pol1cy_0nap + '[' 1 -eq 1 ']' + CONFIG_FILE=/opt/app/policy/distribution/etc/mounted/config.json + '[' -z /opt/app/policy/distribution/etc/mounted/config.json ']' + [[ -f /opt/app/policy/distribution/etc/mounted/policy-truststore ]] + [[ -f /opt/app/policy/distribution/etc/mounted/policy-keystore ]] + [[ -f /opt/app/policy/distribution/etc/mounted/logback.xml ]] + echo 'overriding logback.xml' + cp -f /opt/app/policy/distribution/etc/mounted/logback.xml /opt/app/policy/distribution/etc/ overriding logback.xml + echo 'Policy distribution config file: /opt/app/policy/distribution/etc/mounted/config.json' Policy distribution config file: /opt/app/policy/distribution/etc/mounted/config.json + /usr/lib/jvm/java-11-openjdk//bin/java -cp '/opt/app/policy/distribution/etc:/opt/app/policy/distribution/lib/*' -Dlogback.configurationFile=/opt/app/policy/distribution/etc/logback.xml -Djavax.net.ssl.keyStore=/opt/app/osaaf/local/org.onap.policy.p12 -Djavax.net.ssl.keyStorePassword=Pol1cy_0nap -Djavax.net.ssl.trustStore=/opt/app/policy/distribution/etc/ssl/policy-truststore -Djavax.net.ssl.trustStorePassword=Pol1cy_0nap org.onap.policy.distribution.main.startstop.Main -c /opt/app/policy/distribution/etc/mounted/config.json [2021-04-30T03:30:23.117+00:00|INFO|Main|main] Starting policy distribution service with arguments - [-c, /opt/app/policy/distribution/etc/mounted/config.json] [2021-04-30T03:30:23.648+00:00|INFO|log|main] Logging initialized @1879ms to org.eclipse.jetty.util.log.Slf4jLog [2021-04-30T03:30:24.198+00:00|INFO|ServiceManager|main] service manager starting [2021-04-30T03:30:24.199+00:00|INFO|ServiceManager|main] service manager starting REST SDCDistributionGroup [2021-04-30T03:30:24.199+00:00|INFO|JettyServletServer|main] JettyJerseyServer [Jerseyservlets={/*=org.glassfish.jersey.servlet.ServletContainer-4716be8b@a6f2df23==org.glassfish.jersey.servlet.ServletContainer,jsp=null,order=0,inst=false,async=true}, swaggerId=swagger-6969, toString()=JettyServer [name=SDCDistributionGroup, host=0.0.0.0, port=6969, user=healthcheck, password=true, contextPath=/, jettyServer=Server@416c58f5{STOPPED}[9.4.30.v20200611], context=o.e.j.s.ServletContextHandler@5505ae1a{/,null,UNAVAILABLE}, connector=SDCDistributionGroup@11f0a5a1{SSL, (ssl, http/1.1)}{0.0.0.0:6969}, jettyThread=null]]: STARTING [2021-04-30T03:30:24.208+00:00|INFO|ServiceManager|main] service manager started [2021-04-30T03:30:24.209+00:00|INFO|JettyServletServer|SDCDistributionGroup-6969] JettyJerseyServer [Jerseyservlets={/*=org.glassfish.jersey.servlet.ServletContainer-4716be8b@a6f2df23==org.glassfish.jersey.servlet.ServletContainer,jsp=null,order=0,inst=false,async=true}, swaggerId=swagger-6969, toString()=JettyServer [name=SDCDistributionGroup, host=0.0.0.0, port=6969, user=healthcheck, password=true, contextPath=/, jettyServer=Server@416c58f5{STOPPED}[9.4.30.v20200611], context=o.e.j.s.ServletContextHandler@5505ae1a{/,null,UNAVAILABLE}, connector=SDCDistributionGroup@11f0a5a1{SSL, (ssl, http/1.1)}{0.0.0.0:6969}, jettyThread=Thread[SDCDistributionGroup-6969,5,main]]]: STARTING [2021-04-30T03:30:24.221+00:00|INFO|Server|SDCDistributionGroup-6969] jetty-9.4.30.v20200611; built: 2020-06-11T12:34:51.929Z; git: 271836e4c1f4612f12b7bb13ef5a92a927634b0d; jvm 11.0.8+11-alpine-r0 [2021-04-30T03:30:24.300+00:00|INFO|DistributionClientImpl|Timer-0] DistributionClient - init [2021-04-30T03:30:24.301+00:00|INFO|Main|main] Started policy-distribution service successfully. [2021-04-30T03:30:24.413+00:00|INFO|session|SDCDistributionGroup-6969] DefaultSessionIdManager workerName=node0 [2021-04-30T03:30:24.414+00:00|INFO|session|SDCDistributionGroup-6969] No SessionScavenger set, using defaults [2021-04-30T03:30:24.416+00:00|INFO|session|SDCDistributionGroup-6969] node0 Scavenging every 600000ms [2021-04-30T03:30:27.109+00:00|INFO|YamlMessageBodyHandler|SDCDistributionGroup-6969] Accepting YAML for REST calls [2021-04-30T03:30:27.110+00:00|INFO|GsonMessageBodyHandler|SDCDistributionGroup-6969] Using GSON for REST calls [2021-04-30T03:30:27.509+00:00|INFO|ContextHandler|SDCDistributionGroup-6969] Started o.e.j.s.ServletContextHandler@5505ae1a{/,null,AVAILABLE} [2021-04-30T03:30:27.512+00:00|INFO|HttpClient|Timer-0] POST https://message-router.onap:3905/apiKeys/create (anonymous) ... [2021-04-30T03:30:27.831+00:00|ERROR|JettyServletServer|SDCDistributionGroup-6969] JettyJerseyServer [Jerseyservlets={/*=org.glassfish.jersey.servlet.ServletContainer-4716be8b@a6f2df23==org.glassfish.jersey.servlet.ServletContainer,jsp=null,order=0,inst=true,async=true}, swaggerId=swagger-6969, toString()=JettyServer [name=SDCDistributionGroup, host=0.0.0.0, port=6969, user=healthcheck, password=true, contextPath=/, jettyServer=Server@416c58f5{FAILED}[9.4.30.v20200611], context=o.e.j.s.ServletContextHandler@5505ae1a{/,null,AVAILABLE}, connector=SDCDistributionGroup@11f0a5a1{SSL, (ssl, http/1.1)}{0.0.0.0:6969}, jettyThread=Thread[SDCDistributionGroup-6969,5,main]]]: error found while bringing up server java.io.IOException: keystore password was incorrect at java.base/sun.security.pkcs12.PKCS12KeyStore.engineLoad(PKCS12KeyStore.java:2117) at java.base/sun.security.util.KeyStoreDelegator.engineLoad(KeyStoreDelegator.java:243) at java.base/java.security.KeyStore.load(KeyStore.java:1479) at org.eclipse.jetty.util.security.CertificateUtils.getKeyStore(CertificateUtils.java:54) at org.eclipse.jetty.util.ssl.SslContextFactory.loadKeyStore(SslContextFactory.java:1188) at org.eclipse.jetty.util.ssl.SslContextFactory.load(SslContextFactory.java:323) at org.eclipse.jetty.util.ssl.SslContextFactory.doStart(SslContextFactory.java:245) at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72) at org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:169) at org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:117) at org.eclipse.jetty.server.SslConnectionFactory.doStart(SslConnectionFactory.java:97) at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72) at org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:169) at org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:117) at org.eclipse.jetty.server.AbstractConnector.doStart(AbstractConnector.java:321) at org.eclipse.jetty.server.AbstractNetworkConnector.doStart(AbstractNetworkConnector.java:81) at org.eclipse.jetty.server.ServerConnector.doStart(ServerConnector.java:234) at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72) at org.eclipse.jetty.server.Server.doStart(Server.java:386) at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72) at org.onap.policy.common.endpoints.http.server.internal.JettyServletServer.run(JettyServletServer.java:304) at java.base/java.lang.Thread.run(Thread.java:834) Caused by: java.security.UnrecoverableKeyException: failed to decrypt safe contents entry: javax.crypto.BadPaddingException: Given final block not properly padded. Such issues can arise if a bad key is used during decryption. ... 22 common frames omitted [2021-04-30T03:30:27.931+00:00|INFO|HttpClient|Timer-0] --> HTTP/1.1 200 OK [2021-04-30T03:30:28.119+00:00|INFO|DistributionClientImpl|Timer-0] start DistributionClient [2021-04-30T03:30:28.194+00:00|INFO|CambriaConsumerImpl|pool-3-thread-1] UEB GET /events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id [2021-04-30T03:30:28.198+00:00|INFO|HttpClient|pool-3-thread-1] GET https://message-router.onap:3905/events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id (as X37cEefzY2v7vOuZ) ... [2021-04-30T03:30:37.838+00:00|INFO|HttpClient|pool-3-thread-1] --> HTTP/1.1 200 OK [2021-04-30T03:30:48.126+00:00|INFO|CambriaConsumerImpl|pool-3-thread-1] UEB GET /events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id [2021-04-30T03:30:48.127+00:00|INFO|HttpClient|pool-3-thread-1] GET https://message-router.onap:3905/events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id (as X37cEefzY2v7vOuZ) ... [2021-04-30T03:30:57.715+00:00|INFO|HttpClient|pool-3-thread-1] --> HTTP/1.1 200 OK [2021-04-30T03:31:08.126+00:00|INFO|CambriaConsumerImpl|pool-3-thread-2] UEB GET /events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id [2021-04-30T03:31:08.128+00:00|INFO|HttpClient|pool-3-thread-2] GET https://message-router.onap:3905/events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id (as X37cEefzY2v7vOuZ) ... [2021-04-30T03:31:17.737+00:00|INFO|HttpClient|pool-3-thread-2] --> HTTP/1.1 200 OK [2021-04-30T03:31:28.126+00:00|INFO|CambriaConsumerImpl|pool-3-thread-1] UEB GET /events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id [2021-04-30T03:31:28.127+00:00|INFO|HttpClient|pool-3-thread-1] GET https://message-router.onap:3905/events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id (as X37cEefzY2v7vOuZ) ... [2021-04-30T03:31:37.665+00:00|INFO|HttpClient|pool-3-thread-1] --> HTTP/1.1 200 OK [2021-04-30T03:31:48.126+00:00|INFO|CambriaConsumerImpl|pool-3-thread-3] UEB GET /events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id [2021-04-30T03:31:48.127+00:00|INFO|HttpClient|pool-3-thread-3] GET https://message-router.onap:3905/events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id (as X37cEefzY2v7vOuZ) ... [2021-04-30T03:31:57.666+00:00|INFO|HttpClient|pool-3-thread-3] --> HTTP/1.1 200 OK [2021-04-30T03:32:08.126+00:00|INFO|CambriaConsumerImpl|pool-3-thread-2] UEB GET /events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id [2021-04-30T03:32:08.127+00:00|INFO|HttpClient|pool-3-thread-2] GET https://message-router.onap:3905/events/SDC-DISTR-NOTIF-TOPIC-AUTO/policy-group/policy-id (as X37cEefzY2v7vOuZ) ...