Deployment to cloud fails for springboot application

[adnansenyurt]

Last couple of days, with no change to any configuration, I've started getting the following exception when deploying my jhipster/springboot based applications to cloudfoundry. containers on cloud. I've tried different simple and complex apps, different cloud providers (IBM and Pivotal) and result is the same. Applications run as expected on local machine.

Can this be a java build pack issue?

Beginning of log:

Creating container
Successfully created container
Downloading build artifacts cache...
Downloading app package...
Downloaded app package (64.2M)
-----> Java Buildpack 96dac92 | https://github.com/cloudfoundry/java-buildpack#96dac92
-----> Downloading Jvmkill Agent 1.11.0_RELEASE from https://java-buildpack.cloudfoundry.org/jvmkill/trusty/x86_64/jvmkill-1.11.0_RELEASE.so (0.0s)
-----> Downloading Open Jdk JRE 1.8.0_152 from https://java-buildpack.cloudfoundry.org/openjdk/trusty/x86_64/openjdk-1.8.0_152.tar.gz (0.7s)
       Expanding Open Jdk JRE to .java-buildpack/open_jdk_jre (1.2s)
       JVM DNS caching disabled in lieu of BOSH DNS caching
-----> Downloading Open JDK Like Memory Calculator 3.10.0_RELEASE from https://java-buildpack.cloudfoundry.org/memory-calculator/trusty/x86_64/memory-calculator-3.10.0_RELEASE.tar.gz (0.0s)
       Loaded Classes: 27326, Threads: 300
-----> Downloading Client Certificate Mapper 1.3.0_RELEASE from https://java-buildpack.cloudfoundry.org/client-certificate-mapper/client-certificate-mapper-1.3.0_RELEASE.jar (0.0s)
-----> Downloading Container Customizer 2.2.0_RELEASE from https://java-buildpack.cloudfoundry.org/container-customizer/container-customizer-2.2.0_RELEASE.jar (0.0s)
-----> Downloading Container Security Provider 1.10.0_RELEASE from https://java-buildpack.cloudfoundry.org/container-security-provider/container-security-provider-1.10.0_RELEASE.jar (0.0s)
-----> Downloading Spring Auto Reconfiguration 2.2.0_RELEASE from https://java-buildpack.cloudfoundry.org/auto-reconfiguration/auto-reconfiguration-2.2.0_RELEASE.jar (0.0s)

Exception:

2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 2017-11-11 23:24:45.430 ERROR 18 --- [           main] o.s.boot.SpringApplication               : Application startup failed
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'allowLinkingEmbeddedServletContainerCustomizer' defined in class path resource [org/cloudfoundry/container/customizer/boot1/AllowLinkingAutoConfiguration.class]: Post-processing of merged bean definition failed; nested exception is java.lang.IllegalStateException: Failed to introspect bean class [org.cloudfoundry.container.customizer.boot1.AllowLinkingEmbeddedServletContainerCustomizer] for persistence metadata: could not find class that it depends on
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:526)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:483)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:306)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:302)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:761)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:867)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:543)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.context.embedded.EmbeddedWebApplicationContext.refresh(EmbeddedWebApplicationContext.java:122)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:693)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.SpringApplication.refreshContext(SpringApplication.java:360)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.SpringApplication.run(SpringApplication.java:303)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at com.coviot.DenemeuaaApp.main(DenemeuaaApp.java:67)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at java.lang.reflect.Method.invoke(Method.java:498)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:48)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.Launcher.launch(Launcher.java:87)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.Launcher.launch(Launcher.java:50)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.WarLauncher.main(WarLauncher.java:59)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT Caused by: java.lang.IllegalStateException: Failed to introspect bean class [org.cloudfoundry.container.customizer.boot1.AllowLinkingEmbeddedServletContainerCustomizer] for persistence metadata: could not find class that it depends on
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor.findPersistenceMetadata(PersistenceAnnotationBeanPostProcessor.java:401)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor.postProcessMergedBeanDefinition(PersistenceAnnotationBeanPostProcessor.java:333)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.applyMergedBeanDefinitionPostProcessors(AbstractAutowireCapableBeanFactory.java:992)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:523)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	... 21 common frames omitted
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT Caused by: java.lang.NoClassDefFoundError: org/apache/catalina/Context
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at java.lang.Class.getDeclaredMethods0(Native Method)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at java.lang.Class.privateGetDeclaredMethods(Class.java:2701)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at java.lang.Class.getDeclaredMethods(Class.java:1975)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.util.ReflectionUtils.getDeclaredMethods(ReflectionUtils.java:613)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.util.ReflectionUtils.doWithLocalMethods(ReflectionUtils.java:489)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor.buildPersistenceMetadata(PersistenceAnnotationBeanPostProcessor.java:431)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor.findPersistenceMetadata(PersistenceAnnotationBeanPostProcessor.java:397)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	... 24 common frames omitted
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT Caused by: java.lang.ClassNotFoundException: org.apache.catalina.Context
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at java.net.URLClassLoader.findClass(URLClassLoader.java:381)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at java.lang.ClassLoader.loadClass(ClassLoader.java:424)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.LaunchedURLClassLoader.loadClass(LaunchedURLClassLoader.java:94)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
2017-11-12T02:24:45.43+0300 [APP/PROC/WEB/0] OUT 	... 31 common frames omitted
2017-11-12T02:24:45.78+0300 [APP/PROC/WEB/0] OUT Exit status 1
2017-11-12T02:24:45.78+0300 [CELL/SSHD/0] OUT Exit status 0
2017-11-12T02:24:45.79+0300 [CELL/0] OUT Stopping instance f434c874-3ed8-428f-5ccc-0722
2017-11-12T02:24:45.79+0300 [CELL/0] OUT Destroying container

[nebhale]

Over the last week, we’ve been doing work to get the buildpack ready for the forthcoming Spring Boot 2 and this has made master unstable. As a work around, you can push your application with -b https://github.com/cloudfoundry/java-buildpack.git#v4.6 to stage against a stable version of the buildpack until we stabilize master again.

However, this appears that it could be a legitimate bug in our work, so I’m glad that it’s been identified. Can you either point me at your application or tell me a little bit about it? I’m looking for what version of Spring Boot you’re using and what starters you’ve got as dependencies.

[adnansenyurt]

Hi,
This is a Spring Boot based application generated by JHipster. An example startup log is like below, for the case I don't set a specific java buildpack version:

2017-11-14T13:37:03.13+0300 [STG/0] OUT Downloaded build artifacts cache (136.1M)
2017-11-14T13:37:03.13+0300 [STG/0] OUT Staging...
2017-11-14T13:37:16.57+0300 [STG/0] OUT -----> Java Buildpack 96dac92 | https://github.com/cloudfoundry/java-buildpack#96dac92
2017-11-14T13:37:17.14+0300 [STG/0] OUT -----> Downloading Jvmkill Agent 1.11.0_RELEASE from https://java-buildpack.cloudfoundry.org/jvmkill/trusty/x86_64/jvmkill-1.11.0_RELEASE.so (found in cache)
2017-11-14T13:37:17.25+0300 [STG/0] OUT -----> Downloading Open Jdk JRE 1.8.0_152 from https://java-buildpack.cloudfoundry.org/openjdk/trusty/x86_64/openjdk-1.8.0_152.tar.gz (found in cache)
2017-11-14T13:37:20.38+0300 [STG/0] OUT        Expanding Open Jdk JRE to .java-buildpack/open_jdk_jre (3.1s)
2017-11-14T13:37:20.48+0300 [STG/0] OUT -----> Downloading Open JDK Like Memory Calculator 3.10.0_RELEASE from https://java-buildpack.cloudfoundry.org/memory-calculator/trusty/x86_64/memory-calculator-3.10.0_RELEASE.tar.gz (found in cache)
2017-11-14T13:37:27.36+0300 [STG/0] OUT        Loaded Classes: 28322, Threads: 300
2017-11-14T13:37:27.52+0300 [STG/0] OUT -----> Downloading Client Certificate Mapper 1.3.0_RELEASE from https://java-buildpack.cloudfoundry.org/client-certificate-mapper/client-certificate-mapper-1.3.0_RELEASE.jar (found in cache)
2017-11-14T13:37:27.64+0300 [STG/0] OUT -----> Downloading Container Customizer 2.2.0_RELEASE from https://java-buildpack.cloudfoundry.org/container-customizer/container-customizer-2.2.0_RELEASE.jar (found in cache)
2017-11-14T13:37:27.70+0300 [STG/0] OUT -----> Downloading Container Security Provider 1.10.0_RELEASE from https://java-buildpack.cloudfoundry.org/container-security-provider/container-security-provider-1.10.0_RELEASE.jar (found in cache)
2017-11-14T13:37:27.89+0300 [STG/0] OUT -----> Downloading Spring Auto Reconfiguration 2.2.0_RELEASE from https://java-buildpack.cloudfoundry.org/auto-reconfiguration/auto-reconfiguration-2.2.0_RELEASE.jar (found in cache)
2017-11-14T13:38:17.58+0300 [STG/0] OUT Uploading build artifacts cache...
2017-11-14T13:38:17.58+0300 [STG/0] OUT Uploading droplet...
2017-11-14T13:38:17.58+0300 [STG/0] OUT Staging complete
2017-11-14T13:38:17.58+0300 [STG/0] OUT Exit status 0
2017-11-14T13:38:17.58+0300 [STG/0] OUT Uploading droplet, build artifacts cache...
2017-11-14T13:38:26.12+0300 [API/4] OUT Creating droplet for app with guid 1d26164c-6528-41eb-813e-28a514ef6a0c
2017-11-14T13:38:29.30+0300 [STG/0] OUT Uploaded build artifacts cache (136.1M)
2017-11-14T13:38:31.90+0300 [STG/0] OUT Uploaded droplet (113.2M)
2017-11-14T13:38:31.95+0300 [STG/0] OUT Uploading complete
2017-11-14T13:38:32.11+0300 [STG/0] OUT Stopping instance 26241b0d-b59b-4424-9695-6625777209df
2017-11-14T13:38:32.11+0300 [STG/0] OUT Destroying container
2017-11-14T13:38:32.66+0300 [CELL/0] OUT Creating container
2017-11-14T13:38:34.97+0300 [STG/0] OUT Successfully destroyed container
2017-11-14T13:38:35.99+0300 [CELL/0] OUT Successfully created container
2017-11-14T13:38:45.53+0300 [APP/PROC/WEB/0] OUT JVM Memory Configuration: -XX:ReservedCodeCacheSize=240M -XX:MaxDirectMemorySize=10M -XX:MaxMetaspaceSize=178116K -Xss1M -Xmx307259K
2017-11-14T13:39:23.30+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:23.196  INFO 12 --- [           main] pertySourceApplicationContextInitializer : 'cloud' property source added
2017-11-14T13:39:23.35+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:23.342  INFO 12 --- [           main] nfigurationApplicationContextInitializer : Reconfiguration enabled
2017-11-14T13:39:38.37+0300 [APP/PROC/WEB/0] OUT         ██║ ████████║    ██║    ███████╔╝ ╚█████╗     ██║    ██████╗   ███████╔╝
2017-11-14T13:39:38.37+0300 [APP/PROC/WEB/0] OUT   ╚██████╔╝ ██║   ██║ ████████╗ ██║       ██████╔╝    ██║    ████████╗ ██║  ╚██╗
2017-11-14T13:39:38.37+0300 [APP/PROC/WEB/0] OUT    ╚═════╝  ╚═╝   ╚═╝ ╚═══════╝ ╚═╝       ╚═════╝     ╚═╝    ╚═══════╝ ╚═╝   ╚═╝
2017-11-14T13:39:38.37+0300 [APP/PROC/WEB/0] OUT :: http://jhipster.github.io ::
2017-11-14T13:39:38.37+0300 [APP/PROC/WEB/0] OUT         ██╗ ██╗   ██╗ ████████╗ ███████╗   ██████╗ ████████╗ ████████╗ ███████╗
2017-11-14T13:39:38.37+0300 [APP/PROC/WEB/0] OUT         ██║ ██║   ██║ ╚══██╔══╝ ██╔═══██╗ ██╔════╝ ╚══██╔══╝ ██╔═════╝ ██╔═══██╗
2017-11-14T13:39:38.37+0300 [APP/PROC/WEB/0] OUT :: JHipster 🤓  :: Running Spring Boot 1.5.6.RELEASE ::
2017-11-14T13:39:38.37+0300 [APP/PROC/WEB/0] OUT   ██╗   ██║ ██╔═══██║    ██║    ██╔════╝   ╚═══██╗    ██║    ██╔═══╝   ██╔══██║
2017-11-14T13:39:40.96+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:40.943  INFO 12 --- [           main] ContainerTrustManagerFactory$PKIXFactory : Adding System Trust Manager
2017-11-14T13:39:40.99+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:40.986  INFO 12 --- [           main] ContainerTrustManagerFactory$PKIXFactory : Adding TrustManager for /etc/ssl/certs/ca-certificates.crt
2017-11-14T13:39:41.36+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:41.367  INFO 12 --- [ertificates.crt] org.cloudfoundry.security.FileWatcher    : Start watching /etc/ssl/certs/ca-certificates.crt
2017-11-14T13:39:44.15+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:44.122  INFO 12 --- [           main] c.s.FileWatchingX509ExtendedTrustManager : Initialized TrustManager for /etc/ssl/certs/ca-certificates.crt
2017-11-14T13:39:47.37+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:47.349  INFO 12 --- [           main] oundryContainerKeyManagerFactory$SunX509 : Adding System Key Manager
2017-11-14T13:39:49.89+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:49.891  INFO 12 --- [           main] pertySourceApplicationContextInitializer : 'cloud' property source added
2017-11-14T13:39:49.93+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:49.903  INFO 12 --- [           main] nfigurationApplicationContextInitializer : Reconfiguration enabled
2017-11-14T13:39:49.93+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:39:49.926  INFO 12 --- [           main] com.coviot.CoviotrestApp                 : The following profiles are active: swagger,prod,cloudfoundry,cloud
2017-11-14T13:40:18.96+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:18.917  WARN 12 --- [           main] eReconfigurationBeanFactoryPostProcessor : Skipping reconfiguration because cloud services already configured
2017-11-14T13:40:38.94+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:38.921  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Initializing Eureka in region us-east-1
2017-11-14T13:40:41.11+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:41.104  INFO 12 --- [           main] ContainerTrustManagerFactory$PKIXFactory : Adding System Trust Manager
2017-11-14T13:40:42.15+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:42.126  INFO 12 --- [           main] c.n.d.provider.DiscoveryJerseyProvider   : Using JSON decoding codec LegacyJacksonJson
2017-11-14T13:40:42.15+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:42.126  INFO 12 --- [           main] c.n.d.provider.DiscoveryJerseyProvider   : Using JSON encoding codec LegacyJacksonJson
2017-11-14T13:40:44.53+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:44.527  INFO 12 --- [           main] c.n.d.provider.DiscoveryJerseyProvider   : Using XML encoding codec XStreamXml
2017-11-14T13:40:44.53+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:44.531  INFO 12 --- [           main] c.n.d.provider.DiscoveryJerseyProvider   : Using XML decoding codec XStreamXml
2017-11-14T13:40:47.79+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:47.784  INFO 12 --- [           main] c.n.d.s.r.aws.ConfigClusterResolver      : Resolving eureka endpoints via configuration
2017-11-14T13:40:48.11+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:48.119  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Disable delta property : false
2017-11-14T13:40:48.12+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:48.120  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Getting all instance registry info from the eureka server
2017-11-14T13:40:48.12+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:48.119  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Force full registry fetch : false
2017-11-14T13:40:48.12+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:48.120  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Registered Applications size is zero : true
2017-11-14T13:40:48.12+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:48.120  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Application version is -1: true
2017-11-14T13:40:48.11+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:48.119  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Single vip registry refresh property : null
2017-11-14T13:40:48.12+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:48.119  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Application is null : false
2017-11-14T13:40:50.66+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:50.610  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : The response status is 200
2017-11-14T13:40:50.66+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:50.622  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Starting heartbeat executor: renew interval is: 5
2017-11-14T13:40:50.75+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:50.753  INFO 12 --- [           main] c.n.discovery.InstanceInfoReplicator     : InstanceInfoReplicator onDemand update allowed rate per min is 12
2017-11-14T13:40:50.80+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:50.799  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Discovery Client initialized at timestamp 1510656050799 with initial instances count: 2
2017-11-14T13:40:52.16+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:52.154  INFO 12 --- [           main] c.h.instance.DefaultAddressPicker        : [LOCAL] [dev] [3.7.8] Interfaces is disabled, trying to pick one address from TCP-IP config addresses: []
2017-11-14T13:40:52.19+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:52.197  INFO 12 --- [           main] c.h.instance.DefaultAddressPicker        : [LOCAL] [dev] [3.7.8] Prefer IPv4 stack is true.
2017-11-14T13:40:52.19+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:52.198  WARN 12 --- [           main] c.h.instance.DefaultAddressPicker        : [LOCAL] [dev] [3.7.8] Could not find a matching address to start with! Picking one of non-loopback addresses.
2017-11-14T13:40:52.35+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:52.321  INFO 12 --- [           main] c.h.instance.DefaultAddressPicker        : [LOCAL] [dev] [3.7.8] Picked [10.254.0.166]:5701, using socket ServerSocket[addr=/0.0.0.0,localport=5701], bind any local is true
2017-11-14T13:40:52.85+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:52.851  INFO 12 --- [           main] com.hazelcast.system                     : [10.254.0.166]:5701 [dev] [3.7.8] Copyright (c) 2008-2016, Hazelcast, Inc. All Rights Reserved.
2017-11-14T13:40:52.85+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:52.832  INFO 12 --- [           main] com.hazelcast.system                     : [10.254.0.166]:5701 [dev] [3.7.8] Hazelcast 3.7.8 (20170525 - 4e820fa) starting at [10.254.0.166]:5701
2017-11-14T13:40:52.85+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:52.851  INFO 12 --- [           main] com.hazelcast.system                     : [10.254.0.166]:5701 [dev] [3.7.8] Configured Hazelcast Serialization version : 1
2017-11-14T13:40:55.01+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:54.968  INFO 12 --- [           main] c.h.s.i.o.impl.BackpressureRegulator     : [10.254.0.166]:5701 [dev] [3.7.8] Backpressure is disabled
2017-11-14T13:40:58.57+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:58.571  INFO 12 --- [tbeatExecutor-0] com.netflix.discovery.DiscoveryClient    : DiscoveryClient_COVIOTREST/coviotrest:75e9d920aed0b6bc01b2121516acd111 - Re-registering apps/COVIOTREST
2017-11-14T13:40:58.57+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:58.575  INFO 12 --- [tbeatExecutor-0] com.netflix.discovery.DiscoveryClient    : DiscoveryClient_COVIOTREST/coviotrest:75e9d920aed0b6bc01b2121516acd111: registering service...
2017-11-14T13:40:59.14+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:40:59.089  INFO 12 --- [tbeatExecutor-0] com.netflix.discovery.DiscoveryClient    : DiscoveryClient_COVIOTREST/coviotrest:75e9d920aed0b6bc01b2121516acd111 - registration status: 204
2017-11-14T13:41:02.82+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:02.779  INFO 12 --- [           main] com.hazelcast.instance.Node              : [10.254.0.166]:5701 [dev] [3.7.8] Creating TcpIpJoiner
2017-11-14T13:41:04.65+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:04.640  INFO 12 --- [           main] c.h.s.i.o.impl.OperationExecutorImpl     : [10.254.0.166]:5701 [dev] [3.7.8] Starting 4 partition threads
2017-11-14T13:41:04.68+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:04.682  INFO 12 --- [           main] c.h.s.i.o.impl.OperationExecutorImpl     : [10.254.0.166]:5701 [dev] [3.7.8] Starting 3 generic threads (1 dedicated for priority tasks)
2017-11-14T13:41:05.04+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:04.959  INFO 12 --- [           main] com.hazelcast.core.LifecycleService      : [10.254.0.166]:5701 [dev] [3.7.8] [10.254.0.166]:5701 is STARTING
2017-11-14T13:41:05.04+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:04.964  INFO 12 --- [           main] c.h.n.t.n.NonBlockingIOThreadingModel    : [10.254.0.166]:5701 [dev] [3.7.8] TcpIpConnectionManager configured with Non Blocking IO-threading model: 3 input threads and 3 output threads
2017-11-14T13:41:05.22+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:05.154  INFO 12 --- [           main] com.hazelcast.cluster.impl.TcpIpJoiner   : [10.254.0.166]:5701 [dev] [3.7.8]
2017-11-14T13:41:05.22+0300 [APP/PROC/WEB/0] OUT Members [1] {
2017-11-14T13:41:05.22+0300 [APP/PROC/WEB/0] OUT 	Member [10.254.0.166]:5701 - 2160f8d2-c026-432a-b899-eb653f591734 this
2017-11-14T13:41:05.22+0300 [APP/PROC/WEB/0] OUT }
2017-11-14T13:41:05.80+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:05.757  INFO 12 --- [           main] com.hazelcast.core.LifecycleService      : [10.254.0.166]:5701 [dev] [3.7.8] [10.254.0.166]:5701 is STARTED
2017-11-14T13:41:24.87+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:24.873  INFO 12 --- [           main] com.coviot.config.WebConfigurer          : Web application configuration, using profiles: swagger
2017-11-14T13:41:25.06+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:25.011  INFO 12 --- [           main] com.coviot.config.WebConfigurer          : Web application fully configured
2017-11-14T13:41:27.31+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:27.290  INFO 12 --- [           main] c.c.config.CloudDatabaseConfiguration    : Configuring JDBC datasource from a cloud provider
2017-11-14T13:41:30.84+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:30.821  INFO 12 --- [nfoReplicator-0] com.netflix.discovery.DiscoveryClient    : DiscoveryClient_COVIOTREST/coviotrest:75e9d920aed0b6bc01b2121516acd111: registering service...
2017-11-14T13:41:30.97+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:30.943  INFO 12 --- [nfoReplicator-0] com.netflix.discovery.DiscoveryClient    : DiscoveryClient_COVIOTREST/coviotrest:75e9d920aed0b6bc01b2121516acd111 - registration status: 204
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 	at com.netflix.discovery.TimedSupervisorTask.run(TimedSupervisorTask.java:63)
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT java.util.concurrent.TimeoutException: null
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.FutureTask.get(FutureTask.java:205)
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:41.566 ERROR 12 --- [scoveryClient-2] c.netflix.discovery.TimedSupervisorTask  : task supervisor timed out
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
2017-11-14T13:41:41.56+0300 [APP/PROC/WEB/0] OUT 	at java.lang.Thread.run(Thread.java:748)
2017-11-14T13:41:42.06+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:42.036 DEBUG 12 --- [           main] i.g.j.c.liquibase.AsyncSpringLiquibase   : Starting Liquibase synchronously
2017-11-14T13:41:42.18+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:42.161  WARN 12 --- [           main] o.a.tomcat.jdbc.pool.ConnectionPool      : maxIdle is larger than maxActive, setting maxIdle to: 4
2017-11-14T13:41:57.09+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:57.093  WARN 12 --- [           main] i.g.j.c.liquibase.AsyncSpringLiquibase   : Warning, Liquibase took more than 5 seconds to start up!
2017-11-14T13:41:57.09+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:41:57.092 DEBUG 12 --- [           main] i.g.j.c.liquibase.AsyncSpringLiquibase   : Liquibase has updated your database in 15053 ms
2017-11-14T13:42:06.57+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:06.577  INFO 12 --- [           main] c.h.h.HazelcastCacheRegionFactory        : Starting up HazelcastCacheRegionFactory
2017-11-14T13:42:06.59+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:06.583  INFO 12 --- [           main] c.h.h.instance.HazelcastInstanceFactory  : Using existing HazelcastInstance [coviotrest].
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 	at com.netflix.discovery.TimedSupervisorTask.run(TimedSupervisorTask.java:63)
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 	at java.lang.Thread.run(Thread.java:748)
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.FutureTask.get(FutureTask.java:205)
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:11.839 ERROR 12 --- [scoveryClient-0] c.netflix.discovery.TimedSupervisorTask  : task supervisor timed out
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT java.util.concurrent.TimeoutException: null
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
2017-11-14T13:42:11.89+0300 [APP/PROC/WEB/0] OUT 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
2017-11-14T13:42:21.61+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:21.613  INFO 12 --- [           main] c.c.s.DeviceAuthenticationProvider       : Device Authentication Provider is created..
2017-11-14T13:42:38.00+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:37.999  WARN 12 --- [           main] c.n.c.sources.URLConfigurationSource     : No URLs will be polled as dynamic configuration sources.
2017-11-14T13:42:43.01+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:42.984 DEBUG 12 --- [           main] i.g.j.c.apidoc.SwaggerConfiguration      : Starting Swagger
2017-11-14T13:42:43.03+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.005 DEBUG 12 --- [           main] i.g.j.c.apidoc.SwaggerConfiguration      : Started Swagger in 21 ms
2017-11-14T13:42:43.29+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.297  WARN 12 --- [           main] ationConfigEmbeddedWebApplicationContext : Exception encountered during context initialization - cancelling refresh attempt: org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'allowLinkingEmbeddedServletContainerCustomizer' defined in class path resource [org/cloudfoundry/container/customizer/boot1/AllowLinkingAutoConfiguration.class]: Post-processing of merged bean definition failed; nested exception is java.lang.IllegalStateException: Failed to introspect bean class [org.cloudfoundry.container.customizer.boot1.AllowLinkingEmbeddedServletContainerCustomizer] for persistence metadata: could not find class that it depends on
2017-11-14T13:42:43.49+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.489  WARN 12 --- [           main] c.h.h.instance.HazelcastInstanceFactory  : hibernate.cache.hazelcast.shutdown_on_session_factory_close property is set to 'false'. Leaving current HazelcastInstance active! (Warning: Do not disable Hazelcast hazelcast.shutdownhook.enabled property!)
2017-11-14T13:42:43.49+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.489  INFO 12 --- [           main] c.h.h.HazelcastCacheRegionFactory        : Shutting down HazelcastCacheRegionFactory
2017-11-14T13:42:43.50+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.503  INFO 12 --- [           main] com.hazelcast.instance.Node              : [10.254.0.166]:5701 [dev] [3.7.8] Shutting down connection manager...
2017-11-14T13:42:43.50+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.502  INFO 12 --- [           main] com.hazelcast.core.LifecycleService      : [10.254.0.166]:5701 [dev] [3.7.8] [10.254.0.166]:5701 is SHUTTING_DOWN
2017-11-14T13:42:43.50+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.505  INFO 12 --- [           main] com.hazelcast.instance.Node              : [10.254.0.166]:5701 [dev] [3.7.8] Shutting down node engine...
2017-11-14T13:42:43.61+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.608  INFO 12 --- [           main] com.hazelcast.instance.NodeExtension     : [10.254.0.166]:5701 [dev] [3.7.8] Destroying node NodeExtension.
2017-11-14T13:42:43.63+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.615  INFO 12 --- [           main] com.hazelcast.instance.Node              : [10.254.0.166]:5701 [dev] [3.7.8] Hazelcast Shutdown is completed in 113 ms.
2017-11-14T13:42:43.63+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.622  INFO 12 --- [           main] com.hazelcast.core.LifecycleService      : [10.254.0.166]:5701 [dev] [3.7.8] [10.254.0.166]:5701 is SHUTDOWN
2017-11-14T13:42:43.63+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.623  INFO 12 --- [           main] com.coviot.config.CacheConfiguration     : Closing Cache Manager
2017-11-14T13:42:43.79+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.788  INFO 12 --- [           main] com.netflix.discovery.DiscoveryClient    : Shutting down DiscoveryClient ...
2017-11-14T13:42:43.81+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.797  WARN 12 --- [           main] .s.c.a.CommonAnnotationBeanPostProcessor : Invocation of destroy method failed on bean with name 'scopedTarget.eurekaClient': org.springframework.beans.factory.BeanCreationNotAllowedException: Error creating bean with name 'eurekaInstanceConfigBean': Singleton bean creation not allowed while singletons of this factory are in destruction (Do not request a bean from a BeanFactory in a destroy method implementation!)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'allowLinkingEmbeddedServletContainerCustomizer' defined in class path resource [org/cloudfoundry/container/customizer/boot1/AllowLinkingAutoConfiguration.class]: Post-processing of merged bean definition failed; nested exception is java.lang.IllegalStateException: Failed to introspect bean class [org.cloudfoundry.container.customizer.boot1.AllowLinkingEmbeddedServletContainerCustomizer] for persistence metadata: could not find class that it depends on
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.SpringApplication.refreshContext(SpringApplication.java:360)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:48)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT Caused by: java.lang.IllegalStateException: Failed to introspect bean class [org.cloudfoundry.container.customizer.boot1.AllowLinkingEmbeddedServletContainerCustomizer] for persistence metadata: could not find class that it depends on
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor.postProcessMergedBeanDefinition(PersistenceAnnotationBeanPostProcessor.java:333)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.applyMergedBeanDefinitionPostProcessors(AbstractAutowireCapableBeanFactory.java:992)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT Caused by: java.lang.NoClassDefFoundError: org/apache/catalina/Context
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at java.lang.Class.getDeclaredMethods0(Native Method)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor.findPersistenceMetadata(PersistenceAnnotationBeanPostProcessor.java:397)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at java.net.URLClassLoader.findClass(URLClassLoader.java:381)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	... 31 common frames omitted
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:306)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:867)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:543)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.Launcher.launch(Launcher.java:87)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.util.ReflectionUtils.getDeclaredMethods(ReflectionUtils.java:613)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT Caused by: java.lang.ClassNotFoundException: org.apache.catalina.Context
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 2017-11-14 10:42:43.856 ERROR 12 --- [           main] o.s.boot.SpringApplication               : Application startup failed
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.context.embedded.EmbeddedWebApplicationContext.refresh(EmbeddedWebApplicationContext.java:122)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at java.lang.reflect.Method.invoke(Method.java:498)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.util.ReflectionUtils.doWithLocalMethods(ReflectionUtils.java:489)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:526)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:483)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:302)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:761)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.SpringApplication.run(SpringApplication.java:303)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.Launcher.launch(Launcher.java:50)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor.findPersistenceMetadata(PersistenceAnnotationBeanPostProcessor.java:401)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	... 21 common frames omitted
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at java.lang.Class.privateGetDeclaredMethods(Class.java:2701)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor.buildPersistenceMetadata(PersistenceAnnotationBeanPostProcessor.java:431)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	... 24 common frames omitted
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.LaunchedURLClassLoader.loadClass(LaunchedURLClassLoader.java:94)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:693)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at com.coviot.CoviotrestApp.main(CoviotrestApp.java:72)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.boot.loader.WarLauncher.main(WarLauncher.java:59)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:523)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at java.lang.Class.getDeclaredMethods(Class.java:1975)
2017-11-14T13:42:43.85+0300 [APP/PROC/WEB/0] OUT 	at java.lang.ClassLoader.loadClass(ClassLoader.java:424)
2017-11-14T13:42:44.49+0300 [APP/PROC/WEB/0] OUT Exit status 1
2017-11-14T13:42:44.50+0300 [CELL/0] OUT Exit status 0
2017-11-14T13:42:44.53+0300 [CELL/0] OUT Stopping instance fdfa50bf-b01a-43f6-757f-b9fa
2017-11-14T13:42:44.53+0300 [CELL/0] OUT Destroying container
2017-11-14T13:42:44.56+0300 [API/8] OUT Process has crashed with type: "web"
2017-11-14T13:42:44.58+0300 [API/8] OUT App instance exited with guid 1d26164c-6528-41eb-813e-28a514ef6a0c payload: {"instance"=>"fdfa50bf-b01a-43f6-757f-b9fa", "index"=>0, "reason"=>"CRASHED", "exit_description"=>"APP/PROC/WEB: Exited with status 1", "crash_count"=>1, "crash_timestamp"=>1510656164523621881, "version"=>"708e43ab-98be-41ab-a229-661524deb904"}
2017-11-14T13:42:44.82+0300 [CELL/0] OUT Creating container
2017-11-14T13:42:45.99+0300 [CELL/0] OUT Successfully destroyed container

[adnansenyurt]

btw, 3.9.2 and 4.6 doesn't work. 3.9.1 works as before.
This is from 3.9.2 log:

2017-11-14T14:04:42.80+0300 [APP/PROC/WEB/0] OUT 2017-11-14 11:04:42.802  WARN 6 --- [           main] c.n.c.sources.URLConfigurationSource     : No URLs will be polled as dynamic configuration sources.
2017-11-14T14:04:47.86+0300 [APP/PROC/WEB/0] OUT 2017-11-14 11:04:47.864 DEBUG 6 --- [           main] i.g.j.c.apidoc.SwaggerConfiguration      : Starting Swagger
2017-11-14T14:04:47.88+0300 [APP/PROC/WEB/0] OUT 2017-11-14 11:04:47.888 DEBUG 6 --- [           main] i.g.j.c.apidoc.SwaggerConfiguration      : Started Swagger in 23 ms
2017-11-14T14:04:59.55+0300 [APP/PROC/WEB/0] OUT #
2017-11-14T14:04:59.55+0300 [APP/PROC/WEB/0] OUT # java.lang.OutOfMemoryError: Metaspace
2017-11-14T14:04:59.55+0300 [APP/PROC/WEB/0] OUT # -XX:OnOutOfMemoryError="/home/vcap/app/.java-buildpack/open_jdk_jre/bin/killjava.sh"
2017-11-14T14:04:59.55+0300 [APP/PROC/WEB/0] OUT #   Executing /bin/sh -c "/home/vcap/app/.java-buildpack/open_jdk_jre/bin/killjava.sh"...
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT max locked memory       (kbytes, -l) 64
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT vcap           6       0 42 10:59 ?        00:02:11 /home/vcap/app/.java-buildpack/open_jdk_jre/bin/java -Djava.io.tmpdir=/home/vcap/tmp -XX:OnOutOfMemoryError=/home/vcap/app/.java-buildpack/open_jdk_jre/bin/killjava.sh -Xms681574K -XX:MetaspaceSize=104857K -XX:MaxMetaspaceSize=104857K -Xss349K -Xmx681574K -Djava.ext.dirs=/home/vcap/app/.java-buildpack/container_security_provider:/home/vcap/app/.java-buildpack/open_jdk_jre/lib/ext -Djava.security.properties=/home/vcap/app/.java-buildpack/security_providers/java.security -cp /home/vcap/app/. org.springframework.boot.loader.WarLauncher
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT vcap          12       0  0 10:59 ?        00:00:00 /tmp/lifecycle/diego-sshd --allowedKeyExchanges= --address=0.0.0.0:2222 --allowUnauthenticatedClients=false --inheritDaemonEnv=true --allowedCiphers= --allowedMACs= --logLevel=fatal --debugAddr=
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT vcap         121       6  1 11:04 ?        00:00:00 sh -c /home/vcap/app/.java-buildpack/open_jdk_jre/bin/killjava.sh
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT vcap         122     121  0 11:04 ?        00:00:00 bash /home/vcap/app/.java-buildpack/open_jdk_jre/bin/killjava.sh
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT ===============
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT Process Status (Before)
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT =======================
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT core file size          (blocks, -c) 0
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT data seg size           (kbytes, -d) unlimited
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT pipe size            (512 bytes, -p) 8
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT POSIX message queues     (bytes, -q) 819200
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT real-time priority              (-r) 0
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT max user processes              (-u) unlimited
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT virtual memory          (kbytes, -v) unlimited
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT stack size              (kbytes, -s) 8192
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT Free Disk Space (Before)
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT ========================
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT none           1008M  201M  740M  22% /
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT udev             16G  4.0K   16G   1% /dev/tty
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT /dev/xvdc2      265G   78G  174G  31% /etc/hosts
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT UID          PID    PPID  C STIME TTY          TIME CMD
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT root           1       0  0 10:59 ?        00:00:00 /proc/self/exe init
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT vcap         123     122  0 11:04 ?        00:00:00 ps -ef
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT ulimit (Before)
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT pending signals                 (-i) 128582
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT scheduling priority             (-e) 0
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT file size               (blocks, -f) unlimited
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT max memory size         (kbytes, -m) unlimited
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT open files                      (-n) 16384
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT cpu time               (seconds, -t) unlimited
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT file locks                      (-x) unlimited
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT Filesystem      Size  Used Avail Use% Mounted on
2017-11-14T14:04:59.63+0300 [APP/PROC/WEB/0] OUT tmpfs            16G     0   16G   0% /dev/shm
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT ======================
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT vcap          12       0  0 10:59 ?        00:00:00 /tmp/lifecycle/diego-sshd --allowedKeyExchanges= --address=0.0.0.0:2222 --allowUnauthenticatedClients=false --inheritDaemonEnv=true --allowedCiphers= --allowedMACs= --logLevel=fatal --debugAddr=
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT vcap         122     121  0 11:04 ?        00:00:00 bash /home/vcap/app/.java-buildpack/open_jdk_jre/bin/killjava.sh
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT ulimit (After)
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT root           1       0  0 10:59 ?        00:00:00 /proc/self/exe init
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT vcap           6       0 42 10:59 ?        00:02:11 [java] <defunct>
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT ==============
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT data seg size           (kbytes, -d) unlimited
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT max memory size         (kbytes, -m) unlimited
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT stack size              (kbytes, -s) 8192
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT virtual memory          (kbytes, -v) unlimited
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT POSIX message queues     (bytes, -q) 819200
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT cpu time               (seconds, -t) unlimited
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT =======================
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT Process Status (After)
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT vcap         121       6  1 11:04 ?        00:00:00 sh -c /home/vcap/app/.java-buildpack/open_jdk_jre/bin/killjava.sh
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT scheduling priority             (-e) 0
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT pending signals                 (-i) 128582
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT max locked memory       (kbytes, -l) 64
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT open files                      (-n) 16384
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT max user processes              (-u) unlimited
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT Filesystem      Size  Used Avail Use% Mounted on
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT UID          PID    PPID  C STIME TTY          TIME CMD
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT vcap         127     122  0 11:04 ?        00:00:00 ps -ef
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT core file size          (blocks, -c) 0
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT file size               (blocks, -f) unlimited
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT pipe size            (512 bytes, -p) 8
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT real-time priority              (-r) 0
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT file locks                      (-x) unlimited
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT Free Disk Space (After)
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT tmpfs            16G     0   16G   0% /dev/shm
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT udev             16G  4.0K   16G   1% /dev/tty
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT none           1008M  201M  740M  22% /
2017-11-14T14:04:59.69+0300 [APP/PROC/WEB/0] OUT /dev/xvdc2      265G   78G  174G  31% /etc/hosts
2017-11-14T14:04:59.77+0300 [APP/PROC/WEB/0] OUT Exit status 137
2017-11-14T14:04:59.80+0300 [CELL/0] OUT Exit status 0
2017-11-14T14:04:59.83+0300 [CELL/0] OUT Stopping instance b9c6b72e-a9f2-47d6-770f-9568
2017-11-14T14:04:59.83+0300 [CELL/0] OUT Destroying container

[nebhale]

I've updated the container customizer to properly handle Boot applications built upon Undertow instead of Tomcat. Please restage your application, paying particular attention to the output to ensure that you receive Container Customizer 2.3.0_RELEASE.

[adnansenyurt]

Thanks, it works now.

2017-11-14T15:05:19.47+0300 [STG/0] OUT -----> Java Buildpack 96dac92 | https://github.com/cloudfoundry/java-buildpack#96dac92
2017-11-14T15:05:19.88+0300 [STG/0] OUT -----> Downloading Jvmkill Agent 1.11.0_RELEASE from https://java-buildpack.cloudfoundry.org/jvmkill/trusty/x86_64/jvmkill-1.11.0_RELEASE.so (found in cache)
2017-11-14T15:05:19.96+0300 [STG/0] OUT -----> Downloading Open Jdk JRE 1.8.0_152 from https://java-buildpack.cloudfoundry.org/openjdk/trusty/x86_64/openjdk-1.8.0_152.tar.gz (found in cache)
2017-11-14T15:05:21.90+0300 [STG/0] OUT        Expanding Open Jdk JRE to .java-buildpack/open_jdk_jre (1.9s)
2017-11-14T15:05:21.94+0300 [STG/0] OUT -----> Downloading Open JDK Like Memory Calculator 3.10.0_RELEASE from https://java-buildpack.cloudfoundry.org/memory-calculator/trusty/x86_64/memory-calculator-3.10.0_RELEASE.tar.gz (found in cache)
2017-11-14T15:05:26.33+0300 [STG/0] OUT        Loaded Classes: 28322, Threads: 300
2017-11-14T15:05:26.50+0300 [STG/0] OUT -----> Downloading Client Certificate Mapper 1.3.0_RELEASE from https://java-buildpack.cloudfoundry.org/client-certificate-mapper/client-certificate-mapper-1.3.0_RELEASE.jar (found in cache)
2017-11-14T15:05:26.87+0300 [STG/0] OUT -----> Downloading Container Customizer 2.3.0_RELEASE from https://java-buildpack.cloudfoundry.org/container-customizer/container-customizer-2.3.0_RELEASE.jar (0.4s)
2017-11-14T15:05:26.94+0300 [STG/0] OUT -----> Downloading Container Security Provider 1.10.0_RELEASE from https://java-buildpack.cloudfoundry.org/container-security-provider/container-security-provider-1.10.0_RELEASE.jar (found in cache)
2017-11-14T15:05:27.04+0300 [STG/0] OUT -----> Downloading Spring Auto Reconfiguration 2.2.0_RELEASE from https://java-buildpack.cloudfoundry.org/auto-reconfiguration/auto-reconfiguration-2.2.0_RELEASE.jar (found in cache)

[nebhale]

Glad to hear it.