Importing certificates to the default Java certificate trust store. Starting the Cloudbreak application... . ____ _ __ _ _ /\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \ ( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \ \\/ ___)| |_)| | | | | || (_| | ) ) ) ) ' |____| .__|_| |_|_| |_\__, | / / / / =========|_|==============|___/=/_/_/_/ :: Spring Boot :: (v1.5.3.RELEASE) 2018-05-22 19:21:36,953 [main] logStarting:48 INFO c.s.c.CloudbreakApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Starting CloudbreakApplication on 5120a11d5db6 with PID 7 (/cloudbreak.jar started by root in /) 2018-05-22 19:21:37,189 [main] logStartupProfileInfo:641 INFO c.s.c.CloudbreakApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] The following profiles are active: prod 2018-05-22 19:21:39,272 [main] prepareRefresh:582 INFO o.s.b.c.e.AnnotationConfigEmbeddedWebApplicationContext - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Refreshing org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext@754ba872: startup date [Tue May 22 19:21:39 UTC 2018]; root of context hierarchy 2018-05-22 19:21:40,223 [background-preinit] :30 INFO o.h.v.i.u.Version - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HV000001: Hibernate Validator 5.4.1.Final 2018-05-22 19:21:58,930 [main] :155 INFO o.s.b.f.a.AutowiredAnnotationBeanPostProcessor - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] JSR-330 'javax.inject.Inject' annotation found and supported for autowiring 2018-05-22 19:21:59,032 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'conversionConfig' of type [com.sequenceiq.cloudbreak.conf.ConversionConfig$$EnhancerBySpringCGLIB$$e93e619d] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:21:59,065 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'conversionService' of type [com.sequenceiq.cloudbreak.converter.CloudbreakConversionServiceFactoryBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:21:59,066 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'conversionService' of type [com.sequenceiq.cloudbreak.converter.CloudbreakConversionServiceFactoryBean$CloudbreakConversionService] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:21:59,202 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'asyncConfig' of type [com.sequenceiq.cloudbreak.conf.AsyncConfig$$EnhancerBySpringCGLIB$$ba03be47] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:21:59,208 [main] initialize:165 INFO o.s.s.c.ThreadPoolTaskExecutor - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Initializing ExecutorService 2018-05-22 19:21:59,520 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.kafka.annotation.KafkaBootstrapConfiguration' of type [org.springframework.kafka.annotation.KafkaBootstrapConfiguration$$EnhancerBySpringCGLIB$$9e6798a5] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:21:59,613 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.retry.annotation.RetryConfiguration' of type [org.springframework.retry.annotation.RetryConfiguration$$EnhancerBySpringCGLIB$$c0791f47] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:21:59,827 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'resourceDefinitionCache' of type [com.sequenceiq.cloudbreak.cache.ResourceDefinitionCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:00,293 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'awsCachingConfig' of type [com.sequenceiq.cloudbreak.cloud.aws.cache.AwsCachingConfig] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:00,303 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cloudResourceRegionCache' of type [com.sequenceiq.cloudbreak.cache.common.CloudResourceRegionCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:00,311 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cloudResourceVmTypeCache' of type [com.sequenceiq.cloudbreak.cache.common.CloudResourceVmTypeCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:00,321 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'tokenCache' of type [com.sequenceiq.cloudbreak.cache.common.TokenCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:00,329 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'userCache' of type [com.sequenceiq.cloudbreak.cache.common.UserCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:00,341 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'imageCatalogCache' of type [com.sequenceiq.cloudbreak.cache.common.ImageCatalogCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:00,366 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cachingConfig' of type [com.sequenceiq.cloudbreak.cache.CachingConfig$$EnhancerBySpringCGLIB$$d08022b0] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:00,987 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'ehCacheManager' of type [net.sf.ehcache.CacheManager] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:01,231 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cacheManager' of type [org.springframework.cache.ehcache.EhCacheCacheManager] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:01,281 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'keyGenerator' of type [com.sequenceiq.cloudbreak.cache.CachingConfig$SpecificKeyGenerator] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:01,285 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.cache.annotation.ProxyCachingConfiguration' of type [org.springframework.cache.annotation.ProxyCachingConfiguration$$EnhancerBySpringCGLIB$$13c7bd40] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:01,464 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.security.config.annotation.configuration.ObjectPostProcessorConfiguration' of type [org.springframework.security.config.annotation.configuration.ObjectPostProcessorConfiguration$$EnhancerBySpringCGLIB$$63634f5c] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:01,507 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'objectPostProcessor' of type [org.springframework.security.config.annotation.configuration.AutowireBeanFactoryObjectPostProcessor] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:01,522 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.security.access.expression.method.DefaultMethodSecurityExpressionHandler@3005db4a' of type [org.springframework.security.oauth2.provider.expression.OAuth2MethodSecurityExpressionHandler] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:01,580 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'securityConfig.MethodSecurityConfig' of type [com.sequenceiq.cloudbreak.conf.SecurityConfig$MethodSecurityConfig$$EnhancerBySpringCGLIB$$cef6b80e] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:01,660 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'methodSecurityMetadataSource' of type [org.springframework.security.access.method.DelegatingMethodSecurityMetadataSource] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:01,696 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration' of type [org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration$$EnhancerBySpringCGLIB$$cab58722] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:22:03,535 [main] initialize:89 INFO o.s.b.c.e.t.TomcatEmbeddedServletContainer - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Tomcat initialized with port(s): 8080 (http) 2018-05-22 19:22:03,581 [main] log:179 INFO o.a.c.c.StandardService - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Starting service Tomcat 2018-05-22 19:22:03,588 [main] log:179 INFO o.a.c.c.StandardEngine - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Starting Servlet Engine: Apache Tomcat/8.5.14 2018-05-22 19:22:04,034 [localhost-startStop-1] log:179 INFO o.a.c.c.C.[.[.[/cb] - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Initializing Spring embedded WebApplicationContext 2018-05-22 19:22:04,034 [localhost-startStop-1] prepareEmbeddedWebApplicationContext:276 INFO o.s.w.c.ContextLoader - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Root WebApplicationContext: initialization completed in 24762 ms 2018-05-22 19:22:10,121 [localhost-startStop-1] scan:229 INFO o.r.Reflections - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Reflections took 286 ms to scan 1 urls, producing 424 keys and 998 values 2018-05-22 19:22:15,570 [localhost-startStop-1] createClient:89 WARN c.s.c.c.RestClientUtil - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] RestClient has been constructed: ConfigKey{secure=true, debug=false, ignorePreValidation=false}, client: org.glassfish.jersey.client.JerseyClient@5c395b05, sslContext: javax.net.ssl.SSLContext@55fb449c 2018-05-22 19:22:15,588 [localhost-startStop-1] get:39 INFO c.s.c.c.RestClientUtil - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] RestClient cache size: 1, key: ConfigKey{secure=true, debug=false, ignorePreValidation=false}, fetched client: org.glassfish.jersey.client.JerseyClient@5c395b05 2018-05-22 19:22:16,056 [localhost-startStop-1] :49 INFO c.s.c.c.IdentityClient - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] IdentityClient has been created. identity: http://node1.node.dc1.consul:8089, clientId: cloudbreak, configKey: ConfigKey{secure=true, debug=false, ignorePreValidation=false} 2018-05-22 19:22:16,095 [localhost-startStop-1] get:39 INFO c.s.c.c.RestClientUtil - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] RestClient cache size: 1, key: ConfigKey{secure=true, debug=false, ignorePreValidation=false}, fetched client: org.glassfish.jersey.client.JerseyClient@5c395b05 2018-05-22 19:22:17,578 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'metricsFilter' to: [/*] 2018-05-22 19:22:17,579 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'characterEncodingFilter' to: [/*] 2018-05-22 19:22:17,580 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'hiddenHttpMethodFilter' to: [/*] 2018-05-22 19:22:17,580 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'httpPutFormContentFilter' to: [/*] 2018-05-22 19:22:17,580 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'requestContextFilter' to: [/*] 2018-05-22 19:22:17,583 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.DelegatingFilterProxyRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'springSecurityFilterChain' to: [/*] 2018-05-22 19:22:17,583 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'webRequestLoggingFilter' to: [/*] 2018-05-22 19:22:17,583 [localhost-startStop-1] configure:271 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'genericFilterBean' to urls: [/*] 2018-05-22 19:22:17,583 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'scimAccountGroupReaderFilter' to: [/*] 2018-05-22 19:22:17,584 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'applicationContextIdFilter' to: [/*] 2018-05-22 19:22:17,584 [localhost-startStop-1] onStartup:190 INFO o.s.b.w.s.ServletRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping servlet: 'com.sequenceiq.cloudbreak.controller.EndpointConfig' to [/api/*] 2018-05-22 19:22:17,600 [localhost-startStop-1] onStartup:190 INFO o.s.b.w.s.ServletRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping servlet: 'dispatcherServlet' to [/] 2018-05-22 19:22:18,273 [main] upMigrationLoader:86 INFO c.s.c.c.DatabaseMigrationConfig - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Creating up operation migration loader for location: '/schema/mybatis'..... 2018-05-22 19:22:18,982 [main] pendingMigrationLoader:100 INFO c.s.c.c.DatabaseMigrationConfig - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Creating pending operation migration loader for location: '/schema/app'..... 2018-05-22 19:22:19,033 [main] databaseUpMigration:70 INFO c.s.c.c.DatabaseMigrationConfig - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Schema is up to date. No migration necessary. 2018-05-22 19:22:19,190 [main] createNativeEntityManagerFactory:349 INFO o.s.o.j.LocalContainerEntityManagerFactoryBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Building JPA container EntityManagerFactory for persistence unit 'default' 2018-05-22 19:22:19,218 [main] logPersistenceUnitInformation:31 INFO o.h.j.i.u.LogHelper - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000204: Processing PersistenceUnitInfo [ name: default ...] 2018-05-22 19:22:19,377 [main] logVersion:37 INFO o.h.Version - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000412: Hibernate Core {5.0.12.Final} 2018-05-22 19:22:19,380 [main] :213 INFO o.h.c.Environment - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000206: hibernate.properties not found 2018-05-22 19:22:19,383 [main] buildBytecodeProvider:317 INFO o.h.c.Environment - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000021: Bytecode provider name : javassist 2018-05-22 19:22:19,512 [main] :66 INFO o.h.a.c.Version - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HCANN000001: Hibernate Commons Annotations {5.0.1.Final} 2018-05-22 19:22:20,330 [main] :156 INFO o.h.d.Dialect - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000400: Using dialect: org.hibernate.dialect.PostgreSQLDialect 2018-05-22 19:22:20,586 [main] useContextualLobCreation:124 INFO o.h.e.j.e.i.LobCreatorBuilderImpl - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000424: Disabling contextual LOB creation as createClob() method threw error : java.lang.reflect.InvocationTargetException 2018-05-22 19:22:20,590 [main] register:139 INFO o.h.t.BasicTypeRegistry - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000270: Type registration [java.util.UUID] overrides previous : org.hibernate.type.UUIDBinaryType@6824b913 2018-05-22 19:22:22,220 [main] validate:69 INFO o.h.t.h.SchemaValidator - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000229: Running schema validator 2018-05-22 19:22:22,984 [main] refresh:550 WARN o.s.b.c.e.AnnotationConfigEmbeddedWebApplicationContext - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Exception encountered during context initialization - cancelling refresh attempt: org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'entityManagerFactory' defined in class path resource [com/sequenceiq/cloudbreak/conf/DatabaseConfig.class]: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean]: Factory method 'entityManagerFactory' threw exception; nested exception is javax.persistence.PersistenceException: [PersistenceUnit: default] Unable to build Hibernate SessionFactory 2018-05-22 19:22:22,999 [main] log:179 INFO o.a.c.c.StandardService - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Stopping service Tomcat 2018-05-22 19:22:23,021 [main] callFinishedListener:91 WARN o.s.b.SpringApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Error handling failed (Error creating bean with name 'delegatingApplicationListener' defined in class path resource [org/springframework/security/config/annotation/web/configuration/WebSecurityConfiguration.class]: BeanPostProcessor before instantiation of bean failed; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration': Initialization of bean failed; nested exception is org.springframework.beans.factory.NoSuchBeanDefinitionException: No bean named 'org.springframework.context.annotation.ConfigurationClassPostProcessor.importRegistry' available) 2018-05-22 19:22:23,031 [main] reportFailure:815 ERROR o.s.b.SpringApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Application startup failed org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'entityManagerFactory' defined in class path resource [com/sequenceiq/cloudbreak/conf/DatabaseConfig.class]: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean]: Factory method 'entityManagerFactory' threw exception; nested exception is javax.persistence.PersistenceException: [PersistenceUnit: default] Unable to build Hibernate SessionFactory at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:599) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1173) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1067) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:513) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:483) at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:306) at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230) at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:302) at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197) at org.springframework.context.support.AbstractApplicationContext.getBean(AbstractApplicationContext.java:1081) at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:856) at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:542) at org.springframework.boot.context.embedded.EmbeddedWebApplicationContext.refresh(EmbeddedWebApplicationContext.java:122) at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:737) at org.springframework.boot.SpringApplication.refreshContext(SpringApplication.java:370) at org.springframework.boot.SpringApplication.run(SpringApplication.java:314) at org.springframework.boot.SpringApplication.run(SpringApplication.java:1162) at org.springframework.boot.SpringApplication.run(SpringApplication.java:1151) at com.sequenceiq.cloudbreak.CloudbreakApplication.main(CloudbreakApplication.java:20) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:48) at org.springframework.boot.loader.Launcher.launch(Launcher.java:87) at org.springframework.boot.loader.Launcher.launch(Launcher.java:50) at org.springframework.boot.loader.JarLauncher.main(JarLauncher.java:51) Caused by: org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean]: Factory method 'entityManagerFactory' threw exception; nested exception is javax.persistence.PersistenceException: [PersistenceUnit: default] Unable to build Hibernate SessionFactory at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:189) at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:588) ... 26 common frames omitted Caused by: javax.persistence.PersistenceException: [PersistenceUnit: default] Unable to build Hibernate SessionFactory at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.persistenceException(EntityManagerFactoryBuilderImpl.java:954) at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.build(EntityManagerFactoryBuilderImpl.java:882) at org.springframework.orm.jpa.vendor.SpringHibernateJpaPersistenceProvider.createContainerEntityManagerFactory(SpringHibernateJpaPersistenceProvider.java:60) at org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean.createNativeEntityManagerFactory(LocalContainerEntityManagerFactoryBean.java:353) at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.buildNativeEntityManagerFactory(AbstractEntityManagerFactoryBean.java:370) at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.afterPropertiesSet(AbstractEntityManagerFactoryBean.java:359) at com.sequenceiq.cloudbreak.conf.DatabaseConfig.entityManagerFactory(DatabaseConfig.java:102) at com.sequenceiq.cloudbreak.conf.DatabaseConfig$$EnhancerBySpringCGLIB$$249aa162.CGLIB$entityManagerFactory$2() at com.sequenceiq.cloudbreak.conf.DatabaseConfig$$EnhancerBySpringCGLIB$$249aa162$$FastClassBySpringCGLIB$$6fd667d4.invoke() at org.springframework.cglib.proxy.MethodProxy.invokeSuper(MethodProxy.java:228) at org.springframework.context.annotation.ConfigurationClassEnhancer$BeanMethodInterceptor.intercept(ConfigurationClassEnhancer.java:358) at com.sequenceiq.cloudbreak.conf.DatabaseConfig$$EnhancerBySpringCGLIB$$249aa162.entityManagerFactory() at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:162) ... 27 common frames omitted Caused by: org.hibernate.tool.schema.spi.SchemaManagementException: Schema-validation: missing column [attributes] in table [RDSConfig] at org.hibernate.tool.schema.internal.SchemaValidatorImpl.validateTable(SchemaValidatorImpl.java:85) at org.hibernate.tool.schema.internal.SchemaValidatorImpl.doValidation(SchemaValidatorImpl.java:50) at org.hibernate.tool.hbm2ddl.SchemaValidator.validate(SchemaValidator.java:91) at org.hibernate.internal.SessionFactoryImpl.(SessionFactoryImpl.java:475) at org.hibernate.boot.internal.SessionFactoryBuilderImpl.build(SessionFactoryBuilderImpl.java:444) at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.build(EntityManagerFactoryBuilderImpl.java:879) ... 42 common frames omitted Importing certificates to the default Java certificate trust store. Starting the Cloudbreak application... . ____ _ __ _ _ /\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \ ( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \ \\/ ___)| |_)| | | | | || (_| | ) ) ) ) ' |____| .__|_| |_|_| |_\__, | / / / / =========|_|==============|___/=/_/_/_/ :: Spring Boot :: (v1.5.3.RELEASE) 2018-05-22 19:49:22,718 [main] logStarting:48 INFO c.s.c.CloudbreakApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Starting CloudbreakApplication on 5120a11d5db6 with PID 7 (/cloudbreak.jar started by root in /) 2018-05-22 19:49:22,785 [main] logStartupProfileInfo:641 INFO c.s.c.CloudbreakApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] The following profiles are active: prod 2018-05-22 19:49:23,415 [main] prepareRefresh:582 INFO o.s.b.c.e.AnnotationConfigEmbeddedWebApplicationContext - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Refreshing org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext@754ba872: startup date [Tue May 22 19:49:23 UTC 2018]; root of context hierarchy 2018-05-22 19:49:23,665 [background-preinit] :30 INFO o.h.v.i.u.Version - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HV000001: Hibernate Validator 5.4.1.Final 2018-05-22 19:49:36,014 [main] :155 INFO o.s.b.f.a.AutowiredAnnotationBeanPostProcessor - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] JSR-330 'javax.inject.Inject' annotation found and supported for autowiring 2018-05-22 19:49:36,111 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'conversionConfig' of type [com.sequenceiq.cloudbreak.conf.ConversionConfig$$EnhancerBySpringCGLIB$$b89a47ab] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:36,145 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'conversionService' of type [com.sequenceiq.cloudbreak.converter.CloudbreakConversionServiceFactoryBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:36,146 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'conversionService' of type [com.sequenceiq.cloudbreak.converter.CloudbreakConversionServiceFactoryBean$CloudbreakConversionService] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:36,286 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'asyncConfig' of type [com.sequenceiq.cloudbreak.conf.AsyncConfig$$EnhancerBySpringCGLIB$$895fa455] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:36,295 [main] initialize:165 INFO o.s.s.c.ThreadPoolTaskExecutor - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Initializing ExecutorService 2018-05-22 19:49:36,610 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.kafka.annotation.KafkaBootstrapConfiguration' of type [org.springframework.kafka.annotation.KafkaBootstrapConfiguration$$EnhancerBySpringCGLIB$$6dc37eb3] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:36,702 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.retry.annotation.RetryConfiguration' of type [org.springframework.retry.annotation.RetryConfiguration$$EnhancerBySpringCGLIB$$8fd50555] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:36,917 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'resourceDefinitionCache' of type [com.sequenceiq.cloudbreak.cache.ResourceDefinitionCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:37,294 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'awsCachingConfig' of type [com.sequenceiq.cloudbreak.cloud.aws.cache.AwsCachingConfig] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:37,311 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cloudResourceRegionCache' of type [com.sequenceiq.cloudbreak.cache.common.CloudResourceRegionCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:37,320 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cloudResourceVmTypeCache' of type [com.sequenceiq.cloudbreak.cache.common.CloudResourceVmTypeCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:37,328 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'tokenCache' of type [com.sequenceiq.cloudbreak.cache.common.TokenCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:37,337 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'userCache' of type [com.sequenceiq.cloudbreak.cache.common.UserCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:37,345 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'imageCatalogCache' of type [com.sequenceiq.cloudbreak.cache.common.ImageCatalogCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:37,367 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cachingConfig' of type [com.sequenceiq.cloudbreak.cache.CachingConfig$$EnhancerBySpringCGLIB$$9fdc08be] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:37,849 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'ehCacheManager' of type [net.sf.ehcache.CacheManager] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:38,089 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cacheManager' of type [org.springframework.cache.ehcache.EhCacheCacheManager] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:38,116 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'keyGenerator' of type [com.sequenceiq.cloudbreak.cache.CachingConfig$SpecificKeyGenerator] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:38,119 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.cache.annotation.ProxyCachingConfiguration' of type [org.springframework.cache.annotation.ProxyCachingConfiguration$$EnhancerBySpringCGLIB$$e323a34e] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:38,292 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.security.config.annotation.configuration.ObjectPostProcessorConfiguration' of type [org.springframework.security.config.annotation.configuration.ObjectPostProcessorConfiguration$$EnhancerBySpringCGLIB$$32bf356a] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:38,335 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'objectPostProcessor' of type [org.springframework.security.config.annotation.configuration.AutowireBeanFactoryObjectPostProcessor] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:38,351 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.security.access.expression.method.DefaultMethodSecurityExpressionHandler@a7f0ab6' of type [org.springframework.security.oauth2.provider.expression.OAuth2MethodSecurityExpressionHandler] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:38,421 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'securityConfig.MethodSecurityConfig' of type [com.sequenceiq.cloudbreak.conf.SecurityConfig$MethodSecurityConfig$$EnhancerBySpringCGLIB$$9e529e1c] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:38,500 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'methodSecurityMetadataSource' of type [org.springframework.security.access.method.DelegatingMethodSecurityMetadataSource] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:38,535 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration' of type [org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration$$EnhancerBySpringCGLIB$$9a116d30] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-22 19:49:39,835 [main] initialize:89 INFO o.s.b.c.e.t.TomcatEmbeddedServletContainer - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Tomcat initialized with port(s): 8080 (http) 2018-05-22 19:49:39,862 [main] log:179 INFO o.a.c.c.StandardService - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Starting service Tomcat 2018-05-22 19:49:39,868 [main] log:179 INFO o.a.c.c.StandardEngine - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Starting Servlet Engine: Apache Tomcat/8.5.14 2018-05-22 19:49:40,088 [localhost-startStop-1] log:179 INFO o.a.c.c.C.[.[.[/cb] - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Initializing Spring embedded WebApplicationContext 2018-05-22 19:49:40,089 [localhost-startStop-1] prepareEmbeddedWebApplicationContext:276 INFO o.s.w.c.ContextLoader - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Root WebApplicationContext: initialization completed in 16674 ms 2018-05-22 19:49:45,297 [localhost-startStop-1] scan:229 INFO o.r.Reflections - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Reflections took 164 ms to scan 1 urls, producing 424 keys and 998 values 2018-05-22 19:49:48,593 [localhost-startStop-1] createClient:89 WARN c.s.c.c.RestClientUtil - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] RestClient has been constructed: ConfigKey{secure=true, debug=false, ignorePreValidation=false}, client: org.glassfish.jersey.client.JerseyClient@fc8b882, sslContext: javax.net.ssl.SSLContext@4c6770bd 2018-05-22 19:49:48,609 [localhost-startStop-1] get:39 INFO c.s.c.c.RestClientUtil - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] RestClient cache size: 1, key: ConfigKey{secure=true, debug=false, ignorePreValidation=false}, fetched client: org.glassfish.jersey.client.JerseyClient@fc8b882 2018-05-22 19:49:48,958 [localhost-startStop-1] :49 INFO c.s.c.c.IdentityClient - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] IdentityClient has been created. identity: http://node1.node.dc1.consul:8089, clientId: cloudbreak, configKey: ConfigKey{secure=true, debug=false, ignorePreValidation=false} 2018-05-22 19:49:48,970 [localhost-startStop-1] get:39 INFO c.s.c.c.RestClientUtil - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] RestClient cache size: 1, key: ConfigKey{secure=true, debug=false, ignorePreValidation=false}, fetched client: org.glassfish.jersey.client.JerseyClient@fc8b882 2018-05-22 19:49:49,698 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'metricsFilter' to: [/*] 2018-05-22 19:49:49,699 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'characterEncodingFilter' to: [/*] 2018-05-22 19:49:49,699 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'hiddenHttpMethodFilter' to: [/*] 2018-05-22 19:49:49,699 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'httpPutFormContentFilter' to: [/*] 2018-05-22 19:49:49,699 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'requestContextFilter' to: [/*] 2018-05-22 19:49:49,702 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.DelegatingFilterProxyRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'springSecurityFilterChain' to: [/*] 2018-05-22 19:49:49,702 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'webRequestLoggingFilter' to: [/*] 2018-05-22 19:49:49,703 [localhost-startStop-1] configure:271 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'genericFilterBean' to urls: [/*] 2018-05-22 19:49:49,703 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'scimAccountGroupReaderFilter' to: [/*] 2018-05-22 19:49:49,703 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'applicationContextIdFilter' to: [/*] 2018-05-22 19:49:49,703 [localhost-startStop-1] onStartup:190 INFO o.s.b.w.s.ServletRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping servlet: 'com.sequenceiq.cloudbreak.controller.EndpointConfig' to [/api/*] 2018-05-22 19:49:49,706 [localhost-startStop-1] onStartup:190 INFO o.s.b.w.s.ServletRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping servlet: 'dispatcherServlet' to [/] 2018-05-22 19:49:50,194 [main] upMigrationLoader:86 INFO c.s.c.c.DatabaseMigrationConfig - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Creating up operation migration loader for location: '/schema/mybatis'..... 2018-05-22 19:49:50,693 [main] pendingMigrationLoader:100 INFO c.s.c.c.DatabaseMigrationConfig - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Creating pending operation migration loader for location: '/schema/app'..... 2018-05-22 19:49:50,717 [main] databaseUpMigration:70 INFO c.s.c.c.DatabaseMigrationConfig - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Schema is up to date. No migration necessary. 2018-05-22 19:49:50,865 [main] createNativeEntityManagerFactory:349 INFO o.s.o.j.LocalContainerEntityManagerFactoryBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Building JPA container EntityManagerFactory for persistence unit 'default' 2018-05-22 19:49:50,892 [main] logPersistenceUnitInformation:31 INFO o.h.j.i.u.LogHelper - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000204: Processing PersistenceUnitInfo [ name: default ...] 2018-05-22 19:49:51,044 [main] logVersion:37 INFO o.h.Version - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000412: Hibernate Core {5.0.12.Final} 2018-05-22 19:49:51,048 [main] :213 INFO o.h.c.Environment - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000206: hibernate.properties not found 2018-05-22 19:49:51,050 [main] buildBytecodeProvider:317 INFO o.h.c.Environment - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000021: Bytecode provider name : javassist 2018-05-22 19:49:51,156 [main] :66 INFO o.h.a.c.Version - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HCANN000001: Hibernate Commons Annotations {5.0.1.Final} 2018-05-22 19:49:51,826 [main] :156 INFO o.h.d.Dialect - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000400: Using dialect: org.hibernate.dialect.PostgreSQLDialect 2018-05-22 19:49:52,047 [main] useContextualLobCreation:124 INFO o.h.e.j.e.i.LobCreatorBuilderImpl - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000424: Disabling contextual LOB creation as createClob() method threw error : java.lang.reflect.InvocationTargetException 2018-05-22 19:49:52,050 [main] register:139 INFO o.h.t.BasicTypeRegistry - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000270: Type registration [java.util.UUID] overrides previous : org.hibernate.type.UUIDBinaryType@756aadfc 2018-05-22 19:49:53,731 [main] validate:69 INFO o.h.t.h.SchemaValidator - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HHH000229: Running schema validator 2018-05-22 19:49:54,545 [main] refresh:550 WARN o.s.b.c.e.AnnotationConfigEmbeddedWebApplicationContext - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Exception encountered during context initialization - cancelling refresh attempt: org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'entityManagerFactory' defined in class path resource [com/sequenceiq/cloudbreak/conf/DatabaseConfig.class]: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean]: Factory method 'entityManagerFactory' threw exception; nested exception is javax.persistence.PersistenceException: [PersistenceUnit: default] Unable to build Hibernate SessionFactory 2018-05-22 19:49:54,560 [main] log:179 INFO o.a.c.c.StandardService - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Stopping service Tomcat 2018-05-22 19:49:54,581 [main] callFinishedListener:91 WARN o.s.b.SpringApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Error handling failed (Error creating bean with name 'delegatingApplicationListener' defined in class path resource [org/springframework/security/config/annotation/web/configuration/WebSecurityConfiguration.class]: BeanPostProcessor before instantiation of bean failed; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration': Initialization of bean failed; nested exception is org.springframework.beans.factory.NoSuchBeanDefinitionException: No bean named 'org.springframework.context.annotation.ConfigurationClassPostProcessor.importRegistry' available) 2018-05-22 19:49:54,591 [main] reportFailure:815 ERROR o.s.b.SpringApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Application startup failed org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'entityManagerFactory' defined in class path resource [com/sequenceiq/cloudbreak/conf/DatabaseConfig.class]: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean]: Factory method 'entityManagerFactory' threw exception; nested exception is javax.persistence.PersistenceException: [PersistenceUnit: default] Unable to build Hibernate SessionFactory at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:599) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1173) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1067) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:513) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:483) at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:306) at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230) at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:302) at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197) at org.springframework.context.support.AbstractApplicationContext.getBean(AbstractApplicationContext.java:1081) at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:856) at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:542) at org.springframework.boot.context.embedded.EmbeddedWebApplicationContext.refresh(EmbeddedWebApplicationContext.java:122) at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:737) at org.springframework.boot.SpringApplication.refreshContext(SpringApplication.java:370) at org.springframework.boot.SpringApplication.run(SpringApplication.java:314) at org.springframework.boot.SpringApplication.run(SpringApplication.java:1162) at org.springframework.boot.SpringApplication.run(SpringApplication.java:1151) at com.sequenceiq.cloudbreak.CloudbreakApplication.main(CloudbreakApplication.java:20) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:48) at org.springframework.boot.loader.Launcher.launch(Launcher.java:87) at org.springframework.boot.loader.Launcher.launch(Launcher.java:50) at org.springframework.boot.loader.JarLauncher.main(JarLauncher.java:51) Caused by: org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean]: Factory method 'entityManagerFactory' threw exception; nested exception is javax.persistence.PersistenceException: [PersistenceUnit: default] Unable to build Hibernate SessionFactory at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:189) at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:588) ... 26 common frames omitted Caused by: javax.persistence.PersistenceException: [PersistenceUnit: default] Unable to build Hibernate SessionFactory at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.persistenceException(EntityManagerFactoryBuilderImpl.java:954) at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.build(EntityManagerFactoryBuilderImpl.java:882) at org.springframework.orm.jpa.vendor.SpringHibernateJpaPersistenceProvider.createContainerEntityManagerFactory(SpringHibernateJpaPersistenceProvider.java:60) at org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean.createNativeEntityManagerFactory(LocalContainerEntityManagerFactoryBean.java:353) at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.buildNativeEntityManagerFactory(AbstractEntityManagerFactoryBean.java:370) at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.afterPropertiesSet(AbstractEntityManagerFactoryBean.java:359) at com.sequenceiq.cloudbreak.conf.DatabaseConfig.entityManagerFactory(DatabaseConfig.java:102) at com.sequenceiq.cloudbreak.conf.DatabaseConfig$$EnhancerBySpringCGLIB$$f3f68770.CGLIB$entityManagerFactory$1() at com.sequenceiq.cloudbreak.conf.DatabaseConfig$$EnhancerBySpringCGLIB$$f3f68770$$FastClassBySpringCGLIB$$9f06de93.invoke() at org.springframework.cglib.proxy.MethodProxy.invokeSuper(MethodProxy.java:228) at org.springframework.context.annotation.ConfigurationClassEnhancer$BeanMethodInterceptor.intercept(ConfigurationClassEnhancer.java:358) at com.sequenceiq.cloudbreak.conf.DatabaseConfig$$EnhancerBySpringCGLIB$$f3f68770.entityManagerFactory() at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:162) ... 27 common frames omitted Caused by: org.hibernate.tool.schema.spi.SchemaManagementException: Schema-validation: missing column [attributes] in table [RDSConfig] at org.hibernate.tool.schema.internal.SchemaValidatorImpl.validateTable(SchemaValidatorImpl.java:85) at org.hibernate.tool.schema.internal.SchemaValidatorImpl.doValidation(SchemaValidatorImpl.java:50) at org.hibernate.tool.hbm2ddl.SchemaValidator.validate(SchemaValidator.java:91) at org.hibernate.internal.SessionFactoryImpl.(SessionFactoryImpl.java:475) at org.hibernate.boot.internal.SessionFactoryBuilderImpl.build(SessionFactoryBuilderImpl.java:444) at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.build(EntityManagerFactoryBuilderImpl.java:879) ... 42 common frames omitted Importing certificates to the default Java certificate trust store. Starting the Cloudbreak application... . ____ _ __ _ _ /\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \ ( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \ \\/ ___)| |_)| | | | | || (_| | ) ) ) ) ' |____| .__|_| |_|_| |_\__, | / / / / =========|_|==============|___/=/_/_/_/ :: Spring Boot :: (v1.5.3.RELEASE) 2018-05-23 14:08:39,173 [main] logStarting:48 INFO c.s.c.CloudbreakApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Starting CloudbreakApplication on 5120a11d5db6 with PID 6 (/cloudbreak.jar started by root in /) 2018-05-23 14:08:39,483 [main] logStartupProfileInfo:641 INFO c.s.c.CloudbreakApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] The following profiles are active: prod 2018-05-23 14:08:41,287 [main] prepareRefresh:582 INFO o.s.b.c.e.AnnotationConfigEmbeddedWebApplicationContext - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Refreshing org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext@754ba872: startup date [Wed May 23 14:08:41 UTC 2018]; root of context hierarchy 2018-05-23 14:08:41,950 [background-preinit] :30 INFO o.h.v.i.u.Version - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] HV000001: Hibernate Validator 5.4.1.Final 2018-05-23 14:08:58,523 [main] :155 INFO o.s.b.f.a.AutowiredAnnotationBeanPostProcessor - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] JSR-330 'javax.inject.Inject' annotation found and supported for autowiring 2018-05-23 14:08:58,610 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'conversionConfig' of type [com.sequenceiq.cloudbreak.conf.ConversionConfig$$EnhancerBySpringCGLIB$$e93e619d] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:58,642 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'conversionService' of type [com.sequenceiq.cloudbreak.converter.CloudbreakConversionServiceFactoryBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:58,643 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'conversionService' of type [com.sequenceiq.cloudbreak.converter.CloudbreakConversionServiceFactoryBean$CloudbreakConversionService] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:58,776 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'asyncConfig' of type [com.sequenceiq.cloudbreak.conf.AsyncConfig$$EnhancerBySpringCGLIB$$ba03be47] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:58,782 [main] initialize:165 INFO o.s.s.c.ThreadPoolTaskExecutor - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Initializing ExecutorService 2018-05-23 14:08:59,143 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.kafka.annotation.KafkaBootstrapConfiguration' of type [org.springframework.kafka.annotation.KafkaBootstrapConfiguration$$EnhancerBySpringCGLIB$$9e6798a5] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:59,232 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.retry.annotation.RetryConfiguration' of type [org.springframework.retry.annotation.RetryConfiguration$$EnhancerBySpringCGLIB$$c0791f47] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:59,437 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'resourceDefinitionCache' of type [com.sequenceiq.cloudbreak.cache.ResourceDefinitionCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:59,870 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'awsCachingConfig' of type [com.sequenceiq.cloudbreak.cloud.aws.cache.AwsCachingConfig] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:59,879 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cloudResourceRegionCache' of type [com.sequenceiq.cloudbreak.cache.common.CloudResourceRegionCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:59,887 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cloudResourceVmTypeCache' of type [com.sequenceiq.cloudbreak.cache.common.CloudResourceVmTypeCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:59,894 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'tokenCache' of type [com.sequenceiq.cloudbreak.cache.common.TokenCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:59,901 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'userCache' of type [com.sequenceiq.cloudbreak.cache.common.UserCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:59,908 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'imageCatalogCache' of type [com.sequenceiq.cloudbreak.cache.common.ImageCatalogCache] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:08:59,927 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cachingConfig' of type [com.sequenceiq.cloudbreak.cache.CachingConfig$$EnhancerBySpringCGLIB$$d08022b0] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:00,366 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'ehCacheManager' of type [net.sf.ehcache.CacheManager] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:00,583 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'cacheManager' of type [org.springframework.cache.ehcache.EhCacheCacheManager] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:00,613 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'keyGenerator' of type [com.sequenceiq.cloudbreak.cache.CachingConfig$SpecificKeyGenerator] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:00,617 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.cache.annotation.ProxyCachingConfiguration' of type [org.springframework.cache.annotation.ProxyCachingConfiguration$$EnhancerBySpringCGLIB$$13c7bd40] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:00,811 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.security.config.annotation.configuration.ObjectPostProcessorConfiguration' of type [org.springframework.security.config.annotation.configuration.ObjectPostProcessorConfiguration$$EnhancerBySpringCGLIB$$63634f5c] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:00,852 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'objectPostProcessor' of type [org.springframework.security.config.annotation.configuration.AutowireBeanFactoryObjectPostProcessor] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:00,867 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.security.access.expression.method.DefaultMethodSecurityExpressionHandler@198ef2ce' of type [org.springframework.security.oauth2.provider.expression.OAuth2MethodSecurityExpressionHandler] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:00,924 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'securityConfig.MethodSecurityConfig' of type [com.sequenceiq.cloudbreak.conf.SecurityConfig$MethodSecurityConfig$$EnhancerBySpringCGLIB$$cef6b80e] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:00,997 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'methodSecurityMetadataSource' of type [org.springframework.security.access.method.DelegatingMethodSecurityMetadataSource] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:01,031 [main] postProcessAfterInitialization:325 INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Bean 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration' of type [org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration$$EnhancerBySpringCGLIB$$cab58722] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2018-05-23 14:09:02,197 [main] initialize:89 INFO o.s.b.c.e.t.TomcatEmbeddedServletContainer - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Tomcat initialized with port(s): 8080 (http) 2018-05-23 14:09:02,224 [main] log:179 INFO o.a.c.c.StandardService - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Starting service Tomcat 2018-05-23 14:09:02,226 [main] log:179 INFO o.a.c.c.StandardEngine - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Starting Servlet Engine: Apache Tomcat/8.5.14 2018-05-23 14:09:02,429 [localhost-startStop-1] log:179 INFO o.a.c.c.C.[.[.[/cb] - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Initializing Spring embedded WebApplicationContext 2018-05-23 14:09:02,429 [localhost-startStop-1] prepareEmbeddedWebApplicationContext:276 INFO o.s.w.c.ContextLoader - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Root WebApplicationContext: initialization completed in 21142 ms 2018-05-23 14:09:07,725 [localhost-startStop-1] scan:229 INFO o.r.Reflections - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Reflections took 167 ms to scan 1 urls, producing 424 keys and 998 values 2018-05-23 14:09:10,922 [localhost-startStop-1] createClient:89 WARN c.s.c.c.RestClientUtil - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] RestClient has been constructed: ConfigKey{secure=true, debug=false, ignorePreValidation=false}, client: org.glassfish.jersey.client.JerseyClient@655298e9, sslContext: javax.net.ssl.SSLContext@2cfcc468 2018-05-23 14:09:10,936 [localhost-startStop-1] get:39 INFO c.s.c.c.RestClientUtil - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] RestClient cache size: 1, key: ConfigKey{secure=true, debug=false, ignorePreValidation=false}, fetched client: org.glassfish.jersey.client.JerseyClient@655298e9 2018-05-23 14:09:11,323 [localhost-startStop-1] :49 INFO c.s.c.c.IdentityClient - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] IdentityClient has been created. identity: http://node1.node.dc1.consul:8089, clientId: cloudbreak, configKey: ConfigKey{secure=true, debug=false, ignorePreValidation=false} 2018-05-23 14:09:11,335 [localhost-startStop-1] get:39 INFO c.s.c.c.RestClientUtil - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] RestClient cache size: 1, key: ConfigKey{secure=true, debug=false, ignorePreValidation=false}, fetched client: org.glassfish.jersey.client.JerseyClient@655298e9 2018-05-23 14:09:12,047 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'metricsFilter' to: [/*] 2018-05-23 14:09:12,048 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'characterEncodingFilter' to: [/*] 2018-05-23 14:09:12,048 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'hiddenHttpMethodFilter' to: [/*] 2018-05-23 14:09:12,048 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'httpPutFormContentFilter' to: [/*] 2018-05-23 14:09:12,049 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'requestContextFilter' to: [/*] 2018-05-23 14:09:12,052 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.DelegatingFilterProxyRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'springSecurityFilterChain' to: [/*] 2018-05-23 14:09:12,052 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'webRequestLoggingFilter' to: [/*] 2018-05-23 14:09:12,053 [localhost-startStop-1] configure:271 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'genericFilterBean' to urls: [/*] 2018-05-23 14:09:12,053 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'scimAccountGroupReaderFilter' to: [/*] 2018-05-23 14:09:12,053 [localhost-startStop-1] configure:258 INFO o.s.b.w.s.FilterRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping filter: 'applicationContextIdFilter' to: [/*] 2018-05-23 14:09:12,053 [localhost-startStop-1] onStartup:190 INFO o.s.b.w.s.ServletRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping servlet: 'com.sequenceiq.cloudbreak.controller.EndpointConfig' to [/api/*] 2018-05-23 14:09:12,056 [localhost-startStop-1] onStartup:190 INFO o.s.b.w.s.ServletRegistrationBean - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Mapping servlet: 'dispatcherServlet' to [/] 2018-05-23 14:09:12,697 [main] upMigrationLoader:86 INFO c.s.c.c.DatabaseMigrationConfig - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Creating up operation migration loader for location: '/schema/mybatis'..... 2018-05-23 14:09:12,790 [main] refresh:550 WARN o.s.b.c.e.AnnotationConfigEmbeddedWebApplicationContext - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Exception encountered during context initialization - cancelling refresh attempt: org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'databaseUpMigration' defined in class path resource [com/sequenceiq/cloudbreak/conf/DatabaseMigrationConfig.class]: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.apache.ibatis.migration.operations.UpOperation]: Factory method 'databaseUpMigration' threw exception; nested exception is org.apache.ibatis.migration.MigrationException: Error executing command. Cause: org.apache.ibatis.migration.MigrationException: Could not create SqlRunner. Cause: org.postgresql.util.PSQLException: Connection to node1.node.dc1.consul:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections. 2018-05-23 14:09:12,804 [main] log:179 INFO o.a.c.c.StandardService - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Stopping service Tomcat 2018-05-23 14:09:12,822 [main] callFinishedListener:91 WARN o.s.b.SpringApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Error handling failed (Error creating bean with name 'delegatingApplicationListener' defined in class path resource [org/springframework/security/config/annotation/web/configuration/WebSecurityConfiguration.class]: BeanPostProcessor before instantiation of bean failed; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration': Initialization of bean failed; nested exception is org.springframework.beans.factory.NoSuchBeanDefinitionException: No bean named 'org.springframework.context.annotation.ConfigurationClassPostProcessor.importRegistry' available) 2018-05-23 14:09:12,832 [main] reportFailure:815 ERROR o.s.b.SpringApplication - [owner:spring] [type:springLog] [id:] [name:] [flow:] [tracking:] Application startup failed org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'databaseUpMigration' defined in class path resource [com/sequenceiq/cloudbreak/conf/DatabaseMigrationConfig.class]: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.apache.ibatis.migration.operations.UpOperation]: Factory method 'databaseUpMigration' threw exception; nested exception is org.apache.ibatis.migration.MigrationException: Error executing command. Cause: org.apache.ibatis.migration.MigrationException: Could not create SqlRunner. Cause: org.postgresql.util.PSQLException: Connection to node1.node.dc1.consul:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections. at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:599) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1173) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1067) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:513) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:483) at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:306) at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230) at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:302) at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197) at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:296) at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197) at org.springframework.context.support.AbstractApplicationContext.getBean(AbstractApplicationContext.java:1081) at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:856) at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:542) at org.springframework.boot.context.embedded.EmbeddedWebApplicationContext.refresh(EmbeddedWebApplicationContext.java:122) at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:737) at org.springframework.boot.SpringApplication.refreshContext(SpringApplication.java:370) at org.springframework.boot.SpringApplication.run(SpringApplication.java:314) at org.springframework.boot.SpringApplication.run(SpringApplication.java:1162) at org.springframework.boot.SpringApplication.run(SpringApplication.java:1151) at com.sequenceiq.cloudbreak.CloudbreakApplication.main(CloudbreakApplication.java:20) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:48) at org.springframework.boot.loader.Launcher.launch(Launcher.java:87) at org.springframework.boot.loader.Launcher.launch(Launcher.java:50) at org.springframework.boot.loader.JarLauncher.main(JarLauncher.java:51) Caused by: org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.apache.ibatis.migration.operations.UpOperation]: Factory method 'databaseUpMigration' threw exception; nested exception is org.apache.ibatis.migration.MigrationException: Error executing command. Cause: org.apache.ibatis.migration.MigrationException: Could not create SqlRunner. Cause: org.postgresql.util.PSQLException: Connection to node1.node.dc1.consul:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections. at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:189) at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:588) ... 28 common frames omitted Caused by: org.apache.ibatis.migration.MigrationException: Error executing command. Cause: org.apache.ibatis.migration.MigrationException: Could not create SqlRunner. Cause: org.postgresql.util.PSQLException: Connection to node1.node.dc1.consul:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections. at org.apache.ibatis.migration.operations.UpOperation.operate(UpOperation.java:64) at com.sequenceiq.cloudbreak.conf.DatabaseMigrationConfig.databaseUpMigration(DatabaseMigrationConfig.java:64) at com.sequenceiq.cloudbreak.conf.DatabaseMigrationConfig$$EnhancerBySpringCGLIB$$f96627fe.CGLIB$databaseUpMigration$2() at com.sequenceiq.cloudbreak.conf.DatabaseMigrationConfig$$EnhancerBySpringCGLIB$$f96627fe$$FastClassBySpringCGLIB$$6df57459.invoke() at org.springframework.cglib.proxy.MethodProxy.invokeSuper(MethodProxy.java:228) at org.springframework.context.annotation.ConfigurationClassEnhancer$BeanMethodInterceptor.intercept(ConfigurationClassEnhancer.java:358) at com.sequenceiq.cloudbreak.conf.DatabaseMigrationConfig$$EnhancerBySpringCGLIB$$f96627fe.databaseUpMigration() at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:162) ... 29 common frames omitted Caused by: org.apache.ibatis.migration.MigrationException: Could not create SqlRunner. Cause: org.postgresql.util.PSQLException: Connection to node1.node.dc1.consul:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections. at org.apache.ibatis.migration.operations.DatabaseOperation.getSqlRunner(DatabaseOperation.java:76) at org.apache.ibatis.migration.operations.DatabaseOperation.changelogExists(DatabaseOperation.java:61) at org.apache.ibatis.migration.operations.UpOperation.operate(UpOperation.java:38) ... 40 common frames omitted Caused by: org.postgresql.util.PSQLException: Connection to node1.node.dc1.consul:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections. at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:262) at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:52) at org.postgresql.jdbc.PgConnection.(PgConnection.java:216) at org.postgresql.Driver.makeConnection(Driver.java:404) at org.postgresql.Driver.connect(Driver.java:272) at org.springframework.jdbc.datasource.SimpleDriverDataSource.getConnectionFromDriver(SimpleDriverDataSource.java:140) at org.springframework.jdbc.datasource.AbstractDriverBasedDataSource.getConnectionFromDriver(AbstractDriverBasedDataSource.java:196) at org.springframework.jdbc.datasource.AbstractDriverBasedDataSource.getConnection(AbstractDriverBasedDataSource.java:159) at org.apache.ibatis.migration.DataSourceConnectionProvider.getConnection(DataSourceConnectionProvider.java:19) at org.apache.ibatis.migration.operations.DatabaseOperation.getSqlRunner(DatabaseOperation.java:74) ... 42 common frames omitted Caused by: java.net.ConnectException: Connection refused (Connection refused) at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) at java.net.Socket.connect(Socket.java:589) at org.postgresql.core.PGStream.(PGStream.java:61) at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:144) ... 51 common frames omitted