Master build for Spring Analytics

Build: #50 was successful

Job: Build and publish was successful

Stages & jobs

  1. Default Stage

Build log

The build generated 2,957 lines of output.The output is too long and has been truncated to the last 1,000 lines. Download or view full build log

21-Jun-2018 15:14:01 15:14:01.245 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'viewControllerHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.245 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.245 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcPathMatcher'
21-Jun-2018 15:14:01 15:14:01.246 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcUrlPathHelper'
21-Jun-2018 15:14:01 15:14:01.246 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'viewControllerHandlerMapping' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.247 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'viewControllerHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.247 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'beanNameHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.247 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'beanNameHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.247 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.248 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'beanNameHandlerMapping' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Looking for URL mappings in application context: org.springframework.web.context.support.GenericWebApplicationContext@40a72ecd: startup date [Thu Jun 21 15:14:00 UTC 2018]; root of context hierarchy
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.context.annotation.internalConfigurationAnnotationProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.context.annotation.internalAutowiredAnnotationProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.context.annotation.internalRequiredAnnotationProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.context.annotation.internalCommonAnnotationProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.context.event.internalEventListenerProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.context.event.internalEventListenerFactory': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'counterControllerTests.Config': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.test.mock.mockito.MockitoPostProcessor$SpyPostProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.test.mock.mockito.MockitoPostProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.data.web.config.ProjectingArgumentResolverRegistrar': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'projectingArgumentResolverBeanPostProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.data.web.config.HateoasAwareSpringDataWebConfiguration': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'pageableResolver': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'sortResolver': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'pagedResourcesAssembler': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'pagedResourcesAssemblerArgumentResolver': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.data.web.config.SpringDataJacksonConfiguration': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'jacksonGeoModule': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.hateoas.config.HateoasConfiguration': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'linkRelationMessageSource': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'requestMappingHandlerMapping': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'mvcPathMatcher': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'mvcUrlPathHelper': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'mvcContentNegotiationManager': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'viewControllerHandlerMapping': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'beanNameHandlerMapping': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'resourceHandlerMapping': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'mvcResourceUrlProvider': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'defaultServletHandlerMapping': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'requestMappingHandlerAdapter': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.249 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'mvcConversionService': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'mvcValidator': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'mvcUriComponentsContributor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'httpRequestHandlerAdapter': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'simpleControllerHandlerAdapter': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'handlerExceptionResolver': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'mvcViewResolver': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'mvcHandlerMappingIntrospector': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.autoconfigure.data.redis.LettuceConnectionConfiguration': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.autoconfigure.condition.BeanTypeRegistry': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'lettuceClientResources': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'redisConnectionFactory': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.autoconfigure.data.redis.RedisAutoConfiguration': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'redisTemplate': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'stringRedisTemplate': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'spring.redis-org.springframework.boot.autoconfigure.data.redis.RedisProperties': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.context.properties.ConfigurationPropertiesBindingPostProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.context.properties.ConfigurationBeanFactoryMetadata': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'counterRepository': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'counterController': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'counterService': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'entityLinksPluginRegistry': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'controllerEntityLinks': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'delegatingEntityLinks': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.hateoas.hal.HalLinkDiscoverer#0': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name '_halObjectMapper': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$DefaultObjectMapperCustomizer#0': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$Jackson2ModuleRegisteringBeanPostProcessor#0': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.hateoas.hal.HalConfiguration#0': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name '_linkDiscovererRegistry': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.hateoas.LinkDiscoverers#0': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'defaultRelProvider': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'annotationRelProvider': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'relProviderPluginRegistry': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name '_relProvider': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.250 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.test.context.filter.TestTypeExcludeFilter': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer$PropertyMappingCheckBeanPostProcessor': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'environment': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'systemProperties': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'systemEnvironment': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'servletContext': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'contextParameters': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'contextAttributes': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'autoConfigurationReport': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.context.annotation.ConfigurationClassPostProcessor.importRegistry': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'org.springframework.boot.test.mock.mockito.MockitoBeans': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'messageSource': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping - Rejected bean name 'applicationEventMulticaster': no URL paths identified
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'beanNameHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'resourceHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'resourceHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.251 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcContentNegotiationManager'
21-Jun-2018 15:14:01 15:14:01.252 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcUrlPathHelper'
21-Jun-2018 15:14:01 15:14:01.252 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'resourceHandlerMapping' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.252 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'resourceHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.252 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcResourceUrlProvider'
21-Jun-2018 15:14:01 15:14:01.252 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'defaultServletHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.252 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'defaultServletHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.252 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.253 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'defaultServletHandlerMapping' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.253 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'defaultServletHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.253 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'requestMappingHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.253 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'requestMappingHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.253 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.255 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcContentNegotiationManager'
21-Jun-2018 15:14:01 15:14:01.257 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean '_halObjectMapper'
21-Jun-2018 15:14:01 15:14:01.257 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean '_halObjectMapper'
21-Jun-2018 15:14:01 15:14:01.259 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean '_halObjectMapper' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.261 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean '_halObjectMapper'
21-Jun-2018 15:14:01 15:14:01.262 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcConversionService'
21-Jun-2018 15:14:01 15:14:01.262 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'mvcValidator'
21-Jun-2018 15:14:01 15:14:01.262 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'mvcValidator'
21-Jun-2018 15:14:01 15:14:01.262 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.263 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'mvcValidator' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.263 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'mvcValidator'
21-Jun-2018 15:14:01 15:14:01.264 [main] DEBUG org.hibernate.validator.internal.engine.resolver.TraversableResolvers - Cannot find javax.persistence.Persistence on classpath. Assuming non JPA 2 environment. All properties will per default be traversable.
21-Jun-2018 15:14:01 15:14:01.264 [main] DEBUG org.hibernate.validator.messageinterpolation.ResourceBundleMessageInterpolator - Loaded expression factory via original TCCL
21-Jun-2018 15:14:01 15:14:01.265 [main] DEBUG org.hibernate.validator.internal.engine.ConfigurationImpl - Setting custom MessageInterpolator of type org.springframework.validation.beanvalidation.LocaleContextMessageInterpolator
21-Jun-2018 15:14:01 15:14:01.265 [main] DEBUG org.hibernate.validator.internal.engine.ConfigurationImpl - Setting custom ConstraintValidatorFactory of type org.springframework.validation.beanvalidation.SpringConstraintValidatorFactory
21-Jun-2018 15:14:01 15:14:01.265 [main] DEBUG org.hibernate.validator.internal.engine.ConfigurationImpl - Setting custom ParameterNameProvider of type org.springframework.validation.beanvalidation.LocalValidatorFactoryBean$1
21-Jun-2018 15:14:01 15:14:01.265 [main] DEBUG org.hibernate.validator.internal.xml.ValidationXmlParser - Trying to load META-INF/validation.xml for XML based Validator configuration.
21-Jun-2018 15:14:01 15:14:01.265 [main] DEBUG org.hibernate.validator.internal.xml.ResourceLoaderHelper - Trying to load META-INF/validation.xml via user class loader
21-Jun-2018 15:14:01 15:14:01.265 [main] DEBUG org.hibernate.validator.internal.xml.ResourceLoaderHelper - Trying to load META-INF/validation.xml via TCCL
21-Jun-2018 15:14:01 15:14:01.265 [main] DEBUG org.hibernate.validator.internal.xml.ResourceLoaderHelper - Trying to load META-INF/validation.xml via Hibernate Validator's class loader
21-Jun-2018 15:14:01 15:14:01.266 [main] DEBUG org.hibernate.validator.internal.xml.ValidationXmlParser - No META-INF/validation.xml found. Using annotation based configuration only.
21-Jun-2018 15:14:01 15:14:01.272 [main] DEBUG org.hibernate.validator.internal.engine.ValidatorFactoryImpl - HV000234: Using org.springframework.validation.beanvalidation.LocaleContextMessageInterpolator as ValidatorFactory-scoped message interpolator.
21-Jun-2018 15:14:01 15:14:01.272 [main] DEBUG org.hibernate.validator.internal.engine.ValidatorFactoryImpl - HV000234: Using org.hibernate.validator.internal.engine.resolver.TraverseAllTraversableResolver as ValidatorFactory-scoped traversable resolver.
21-Jun-2018 15:14:01 15:14:01.272 [main] DEBUG org.hibernate.validator.internal.engine.ValidatorFactoryImpl - HV000234: Using org.hibernate.validator.internal.util.ExecutableParameterNameProvider as ValidatorFactory-scoped parameter name provider.
21-Jun-2018 15:14:01 15:14:01.272 [main] DEBUG org.hibernate.validator.internal.engine.ValidatorFactoryImpl - HV000234: Using org.hibernate.validator.internal.engine.DefaultClockProvider as ValidatorFactory-scoped clock provider.
21-Jun-2018 15:14:01 15:14:01.272 [main] DEBUG org.hibernate.validator.internal.engine.ValidatorFactoryImpl - HV000234: Using org.hibernate.validator.internal.engine.scripting.DefaultScriptEvaluatorFactory as ValidatorFactory-scoped script evaluator factory.
21-Jun-2018 15:14:01 15:14:01.273 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'mvcValidator'
21-Jun-2018 15:14:01 15:14:01.274 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'sortResolver'
21-Jun-2018 15:14:01 15:14:01.274 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'pageableResolver'
21-Jun-2018 15:14:01 15:14:01.275 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'pagedResourcesAssemblerArgumentResolver'
21-Jun-2018 15:14:01 15:14:01.276 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'requestMappingHandlerAdapter' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.279 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean '_relProvider'
21-Jun-2018 15:14:01 15:14:01.279 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean '_relProvider'
21-Jun-2018 15:14:01 15:14:01.279 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean '(inner bean)#111d5c97'
21-Jun-2018 15:14:01 15:14:01.280 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name '(inner bean)#111d5c97'
21-Jun-2018 15:14:01 15:14:01.280 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean '(inner bean)#111d5c97'
21-Jun-2018 15:14:01 15:14:01.280 [main] DEBUG org.springframework.aop.framework.JdkDynamicAopProxy - Creating JDK dynamic proxy: target source is org.springframework.plugin.core.support.AbstractTypeAwareSupport$BeansOfTypeTargetSource@250a9031
21-Jun-2018 15:14:01 15:14:01.281 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean '_relProvider' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.282 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean '_relProvider'
21-Jun-2018 15:14:01 15:14:01.282 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean '_halObjectMapper'
21-Jun-2018 15:14:01 15:14:01.282 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'linkRelationMessageSource'
21-Jun-2018 15:14:01 15:14:01.282 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'org.springframework.hateoas.hal.HalConfiguration#0'
21-Jun-2018 15:14:01 15:14:01.282 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.hateoas.hal.HalConfiguration#0'
21-Jun-2018 15:14:01 15:14:01.282 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'org.springframework.hateoas.hal.HalConfiguration#0' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.283 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.hateoas.hal.HalConfiguration#0'
21-Jun-2018 15:14:01 15:14:01.283 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'requestMappingHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.283 [main] INFO org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter - Looking for @ControllerAdvice: org.springframework.web.context.support.GenericWebApplicationContext@40a72ecd: startup date [Thu Jun 21 15:14:00 UTC 2018]; root of context hierarchy
21-Jun-2018 15:14:01 15:14:01.285 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'requestMappingHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.285 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcConversionService'
21-Jun-2018 15:14:01 15:14:01.285 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcValidator'
21-Jun-2018 15:14:01 15:14:01.285 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'mvcUriComponentsContributor'
21-Jun-2018 15:14:01 15:14:01.285 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'mvcUriComponentsContributor'
21-Jun-2018 15:14:01 15:14:01.286 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.286 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'requestMappingHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.286 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcConversionService'
21-Jun-2018 15:14:01 15:14:01.287 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'mvcUriComponentsContributor' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.287 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'mvcUriComponentsContributor'
21-Jun-2018 15:14:01 15:14:01.287 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'httpRequestHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.287 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'httpRequestHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.287 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.287 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'httpRequestHandlerAdapter' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.288 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'httpRequestHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.288 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'simpleControllerHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.288 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'simpleControllerHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.288 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.288 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'simpleControllerHandlerAdapter' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.289 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'simpleControllerHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.289 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'handlerExceptionResolver'
21-Jun-2018 15:14:01 15:14:01.289 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'handlerExceptionResolver'
21-Jun-2018 15:14:01 15:14:01.289 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.291 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcContentNegotiationManager'
21-Jun-2018 15:14:01 15:14:01.291 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.ExceptionHandlerExceptionResolver - Looking for exception mappings: org.springframework.web.context.support.GenericWebApplicationContext@40a72ecd: startup date [Thu Jun 21 15:14:00 UTC 2018]; root of context hierarchy
21-Jun-2018 15:14:01 15:14:01.293 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'handlerExceptionResolver' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.293 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'handlerExceptionResolver'
21-Jun-2018 15:14:01 15:14:01.293 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'mvcViewResolver'
21-Jun-2018 15:14:01 15:14:01.293 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'mvcViewResolver'
21-Jun-2018 15:14:01 15:14:01.294 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration'
21-Jun-2018 15:14:01 15:14:01.294 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcContentNegotiationManager'
21-Jun-2018 15:14:01 15:14:01.295 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'mvcViewResolver' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.295 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'mvcViewResolver'
21-Jun-2018 15:14:01 15:14:01.295 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'mvcViewResolver'
21-Jun-2018 15:14:01 15:14:01.295 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.autoconfigure.data.redis.LettuceConnectionConfiguration'
21-Jun-2018 15:14:01 15:14:01.296 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.autoconfigure.condition.BeanTypeRegistry'
21-Jun-2018 15:14:01 15:14:01.296 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'lettuceClientResources'
21-Jun-2018 15:14:01 15:14:01.296 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'redisConnectionFactory'
21-Jun-2018 15:14:01 15:14:01.296 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'org.springframework.boot.autoconfigure.data.redis.RedisAutoConfiguration'
21-Jun-2018 15:14:01 15:14:01.296 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.boot.autoconfigure.data.redis.RedisAutoConfiguration'
21-Jun-2018 15:14:01 15:14:01.296 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'org.springframework.boot.autoconfigure.data.redis.RedisAutoConfiguration' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.299 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.boot.autoconfigure.data.redis.RedisAutoConfiguration'
21-Jun-2018 15:14:01 15:14:01.299 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'redisTemplate'
21-Jun-2018 15:14:01 15:14:01.299 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'redisTemplate'
21-Jun-2018 15:14:01 15:14:01.299 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.autoconfigure.data.redis.RedisAutoConfiguration'
21-Jun-2018 15:14:01 15:14:01.300 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'redisConnectionFactory'
21-Jun-2018 15:14:01 15:14:01.300 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Autowiring by type from bean name 'redisTemplate' via factory method to bean named 'redisConnectionFactory'
21-Jun-2018 15:14:01 15:14:01.316 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'redisTemplate' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.326 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'redisTemplate'
21-Jun-2018 15:14:01 15:14:01.330 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'redisTemplate'
21-Jun-2018 15:14:01 15:14:01.330 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'stringRedisTemplate'
21-Jun-2018 15:14:01 15:14:01.330 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'stringRedisTemplate'
21-Jun-2018 15:14:01 15:14:01.331 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.autoconfigure.data.redis.RedisAutoConfiguration'
21-Jun-2018 15:14:01 15:14:01.331 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'redisConnectionFactory'
21-Jun-2018 15:14:01 15:14:01.331 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Autowiring by type from bean name 'stringRedisTemplate' via factory method to bean named 'redisConnectionFactory'
21-Jun-2018 15:14:01 15:14:01.332 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'stringRedisTemplate' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.334 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'stringRedisTemplate'
21-Jun-2018 15:14:01 15:14:01.334 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'stringRedisTemplate'
21-Jun-2018 15:14:01 15:14:01.334 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'spring.redis-org.springframework.boot.autoconfigure.data.redis.RedisProperties'
21-Jun-2018 15:14:01 15:14:01.334 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.context.properties.ConfigurationPropertiesBindingPostProcessor'
21-Jun-2018 15:14:01 15:14:01.334 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.context.properties.ConfigurationBeanFactoryMetadata'
21-Jun-2018 15:14:01 15:14:01.334 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'counterRepository'
21-Jun-2018 15:14:01 15:14:01.334 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'counterRepository'
21-Jun-2018 15:14:01 15:14:01.334 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterControllerTests.Config'
21-Jun-2018 15:14:01 15:14:01.342 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'counterRepository' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.344 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'counterRepository'
21-Jun-2018 15:14:01 15:14:01.344 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'counterController'
21-Jun-2018 15:14:01 15:14:01.344 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'counterController'
21-Jun-2018 15:14:01 15:14:01.344 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterControllerTests.Config'
21-Jun-2018 15:14:01 15:14:01.345 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterRepository'
21-Jun-2018 15:14:01 15:14:01.345 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Autowiring by type from bean name 'counterController' via factory method to bean named 'counterRepository'
21-Jun-2018 15:14:01 15:14:01.346 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'counterController' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.348 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'counterController'
21-Jun-2018 15:14:01 15:14:01.348 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'counterService'
21-Jun-2018 15:14:01 15:14:01.348 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'counterService'
21-Jun-2018 15:14:01 15:14:01.348 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterControllerTests.Config'
21-Jun-2018 15:14:01 15:14:01.348 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterRepository'
21-Jun-2018 15:14:01 15:14:01.348 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Autowiring by type from bean name 'counterService' via factory method to bean named 'counterRepository'
21-Jun-2018 15:14:01 15:14:01.349 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'counterService' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.351 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'counterService'
21-Jun-2018 15:14:01 15:14:01.351 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'entityLinksPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.351 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'entityLinksPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.351 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'entityLinksPluginRegistry' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.351 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'entityLinksPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.351 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'entityLinksPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.351 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'controllerEntityLinks'
21-Jun-2018 15:14:01 15:14:01.351 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'controllerEntityLinks'
21-Jun-2018 15:14:01 15:14:01.352 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'controllerEntityLinks' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.352 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean '(inner bean)#32eae6f2'
21-Jun-2018 15:14:01 15:14:01.355 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'pageableResolver'
21-Jun-2018 15:14:01 15:14:01.355 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'sortResolver'
21-Jun-2018 15:14:01 15:14:01.355 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Autowiring by type from bean name '(inner bean)#32eae6f2' via property 'uriComponentsContributors' to bean named 'pageableResolver'
21-Jun-2018 15:14:01 15:14:01.355 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Autowiring by type from bean name '(inner bean)#32eae6f2' via property 'uriComponentsContributors' to bean named 'sortResolver'
21-Jun-2018 15:14:01 15:14:01.355 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean '(inner bean)#32eae6f2'
21-Jun-2018 15:14:01 15:14:01.355 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'controllerEntityLinks'
21-Jun-2018 15:14:01 15:14:01.356 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'controllerEntityLinks'
21-Jun-2018 15:14:01 15:14:01.356 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'controllerEntityLinks'
21-Jun-2018 15:14:01 15:14:01.356 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'delegatingEntityLinks'
21-Jun-2018 15:14:01 15:14:01.356 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'delegatingEntityLinks'
21-Jun-2018 15:14:01 15:14:01.357 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean '(inner bean)#1f2f0109'
21-Jun-2018 15:14:01 15:14:01.357 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name '(inner bean)#1f2f0109'
21-Jun-2018 15:14:01 15:14:01.357 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean '(inner bean)#1f2f0109'
21-Jun-2018 15:14:01 15:14:01.357 [main] DEBUG org.springframework.aop.framework.JdkDynamicAopProxy - Creating JDK dynamic proxy: target source is org.springframework.plugin.core.support.AbstractTypeAwareSupport$BeansOfTypeTargetSource@687e6293
21-Jun-2018 15:14:01 15:14:01.358 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'delegatingEntityLinks' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.358 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'delegatingEntityLinks'
21-Jun-2018 15:14:01 15:14:01.358 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'org.springframework.hateoas.hal.HalLinkDiscoverer#0'
21-Jun-2018 15:14:01 15:14:01.358 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.hateoas.hal.HalLinkDiscoverer#0'
21-Jun-2018 15:14:01 15:14:01.358 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'org.springframework.hateoas.hal.HalLinkDiscoverer#0' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.hateoas.hal.HalLinkDiscoverer#0'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean '_halObjectMapper'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$DefaultObjectMapperCustomizer#0'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$Jackson2ModuleRegisteringBeanPostProcessor#0'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.hateoas.hal.HalConfiguration#0'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean '_linkDiscovererRegistry'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean '_linkDiscovererRegistry'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean '_linkDiscovererRegistry' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name '_linkDiscovererRegistry'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean '_linkDiscovererRegistry'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'org.springframework.hateoas.LinkDiscoverers#0'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.hateoas.LinkDiscoverers#0'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean '_linkDiscovererRegistry'
21-Jun-2018 15:14:01 15:14:01.359 [main] DEBUG org.springframework.aop.framework.JdkDynamicAopProxy - Creating JDK dynamic proxy: target source is org.springframework.plugin.core.support.AbstractTypeAwareSupport$BeansOfTypeTargetSource@6a5e167a
21-Jun-2018 15:14:01 15:14:01.360 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'org.springframework.hateoas.LinkDiscoverers#0' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.360 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.hateoas.LinkDiscoverers#0'
21-Jun-2018 15:14:01 15:14:01.360 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'defaultRelProvider'
21-Jun-2018 15:14:01 15:14:01.360 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'defaultRelProvider'
21-Jun-2018 15:14:01 15:14:01.360 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'defaultRelProvider' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.361 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'defaultRelProvider'
21-Jun-2018 15:14:01 15:14:01.361 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'annotationRelProvider'
21-Jun-2018 15:14:01 15:14:01.361 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'annotationRelProvider'
21-Jun-2018 15:14:01 15:14:01.361 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'annotationRelProvider' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.361 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'annotationRelProvider'
21-Jun-2018 15:14:01 15:14:01.361 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating shared instance of singleton bean 'relProviderPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.361 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'relProviderPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.361 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Eagerly caching bean 'relProviderPluginRegistry' to allow for resolving potential circular references
21-Jun-2018 15:14:01 15:14:01.362 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Invoking afterPropertiesSet() on bean with name 'relProviderPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.362 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'relProviderPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.362 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean '_relProvider'
21-Jun-2018 15:14:01 15:14:01.362 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.context.event.internalEventListenerFactory'
21-Jun-2018 15:14:01 15:14:01.372 [main] DEBUG org.springframework.web.context.support.GenericWebApplicationContext - Unable to locate LifecycleProcessor with name 'lifecycleProcessor': using default [org.springframework.context.support.DefaultLifecycleProcessor@e95595b]
21-Jun-2018 15:14:01 15:14:01.372 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'lifecycleProcessor'
21-Jun-2018 15:14:01 15:14:01.372 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcResourceUrlProvider'
21-Jun-2018 15:14:01 15:14:01.373 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'entityLinksPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.373 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean '_linkDiscovererRegistry'
21-Jun-2018 15:14:01 15:14:01.373 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'relProviderPluginRegistry'
21-Jun-2018 15:14:01 15:14:01.373 [main] DEBUG org.springframework.web.servlet.resource.ResourceUrlProvider - Looking for resource handler mappings
21-Jun-2018 15:14:01 15:14:01.373 [main] DEBUG org.springframework.web.servlet.resource.ResourceUrlProvider - No resource handling mappings found
21-Jun-2018 15:14:01 15:14:01.373 [main] DEBUG org.springframework.core.env.PropertySourcesPropertyResolver - Could not find key 'spring.liveBeansView.mbeanDomain' in any property source
21-Jun-2018 15:14:01 15:14:01.373 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Storing ApplicationContext in cache under key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:01 15:14:01.374 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 22, missCount = 3]
21-Jun-2018 15:14:01 15:14:01.374 [main] DEBUG org.springframework.test.context.web.ServletTestExecutionListener - Setting up MockHttpServletRequest, MockHttpServletResponse, ServletWebRequest, and RequestContextHolder for test context [DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@7e4579c7, testMethod = [null], testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]].
21-Jun-2018 15:14:01 15:14:01.374 [main] DEBUG org.springframework.test.context.support.DependencyInjectionTestExecutionListener - Performing dependency injection for test context [[DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@7e4579c7, testMethod = [null], testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.web.ServletTestExecutionListener.populatedRequestContextHolder' -> true, 'org.springframework.test.context.web.ServletTestExecutionListener.resetRequestContextHolder' -> true]]].
21-Jun-2018 15:14:01 15:14:01.374 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:01 15:14:01.374 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 23, missCount = 3]
21-Jun-2018 15:14:01 15:14:01.376 [main] DEBUG org.springframework.beans.factory.annotation.InjectionMetadata - Processing injected element of bean 'org.springframework.analytics.rest.controller.CounterControllerTests': AutowiredFieldElement for private org.springframework.analytics.metrics.redis.RedisMetricRepository org.springframework.analytics.rest.controller.CounterControllerTests.repository
21-Jun-2018 15:14:01 15:14:01.376 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterRepository'
21-Jun-2018 15:14:01 15:14:01.376 [main] DEBUG org.springframework.beans.factory.annotation.AutowiredAnnotationBeanPostProcessor - Autowiring by type from bean name 'org.springframework.analytics.rest.controller.CounterControllerTests' to bean named 'counterRepository'
21-Jun-2018 15:14:01 15:14:01.376 [main] DEBUG org.springframework.beans.factory.annotation.InjectionMetadata - Processing injected element of bean 'org.springframework.analytics.rest.controller.CounterControllerTests': AutowiredFieldElement for private org.springframework.analytics.test.support.CounterService org.springframework.analytics.rest.controller.CounterControllerTests.counterService
21-Jun-2018 15:14:01 15:14:01.377 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterService'
21-Jun-2018 15:14:01 15:14:01.377 [main] DEBUG org.springframework.beans.factory.annotation.AutowiredAnnotationBeanPostProcessor - Autowiring by type from bean name 'org.springframework.analytics.rest.controller.CounterControllerTests' to bean named 'counterService'
21-Jun-2018 15:14:01 15:14:01.377 [main] DEBUG org.springframework.beans.factory.annotation.InjectionMetadata - Processing injected element of bean 'org.springframework.analytics.rest.controller.CounterControllerTests': AutowiredFieldElement for private org.springframework.web.context.WebApplicationContext org.springframework.analytics.rest.controller.CounterControllerTests.wac
21-Jun-2018 15:14:01 15:14:01.377 [main] DEBUG org.springframework.beans.factory.annotation.AutowiredAnnotationBeanPostProcessor - Autowiring by type from bean name 'org.springframework.analytics.rest.controller.CounterControllerTests' to bean named 'org.springframework.web.context.support.GenericWebApplicationContext@40a72ecd'
21-Jun-2018 15:14:01 15:14:01.378 [main] DEBUG io.lettuce.core.RedisClient - Trying to get a Redis connection for: RedisURI [host='localhost', port=6379]
21-Jun-2018 15:14:01 15:14:01.379 [main] DEBUG io.lettuce.core.resource.DefaultEventLoopGroupProvider - Adding reference to io.netty.channel.nio.NioEventLoopGroup@53ce2392, existing ref count 0
21-Jun-2018 15:14:01 15:14:01.379 [main] DEBUG io.lettuce.core.RedisClient - Resolved SocketAddress localhost:6379 using RedisURI [host='localhost', port=6379]
21-Jun-2018 15:14:01 15:14:01.379 [main] DEBUG io.lettuce.core.RedisClient - Connecting to Redis at localhost:6379
21-Jun-2018 15:14:01 15:14:01.383 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x9ae8906c, [id: 0x895fb33a] (inactive), chid=0x3] channelRegistered()
21-Jun-2018 15:14:01 15:14:01.384 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, chid=0x3] channelActive()
21-Jun-2018 15:14:01 15:14:01.388 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, epid=0x3] activateEndpointAndExecuteBufferedCommands 0 command(s) buffered
21-Jun-2018 15:14:01 15:14:01.388 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, epid=0x3] activating endpoint
21-Jun-2018 15:14:01 15:14:01.388 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, epid=0x3] flushCommands()
21-Jun-2018 15:14:01 15:14:01.389 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, epid=0x3] flushCommands() Flushing 0 commands
21-Jun-2018 15:14:01 15:14:01.389 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelActive()
21-Jun-2018 15:14:01 15:14:01.390 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelActive()
21-Jun-2018 15:14:01 15:14:01.391 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, chid=0x3] channelActive() done
21-Jun-2018 15:14:01 15:14:01.391 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.RedisClient - Connecting to Redis at localhost:6379: Success
21-Jun-2018 15:14:01 15:14:01.391 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] userEventTriggered(ctx, io.lettuce.core.ConnectionEvents$Activated@33a17162)
21-Jun-2018 15:14:01 15:14:01.391 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] userEventTriggered(ctx, io.lettuce.core.ConnectionEvents$Activated@33a17162)
21-Jun-2018 15:14:01 15:14:01.392 [main] DEBUG org.springframework.test.context.support.AbstractDirtiesContextTestExecutionListener - Before test method: context [DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@7e4579c7, testMethod = testList@CounterControllerTests, testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.web.ServletTestExecutionListener.populatedRequestContextHolder' -> true, 'org.springframework.test.context.web.ServletTestExecutionListener.resetRequestContextHolder' -> true]], class annotated with @DirtiesContext [false] with mode [null], method annotated with @DirtiesContext [false] with mode [null].
21-Jun-2018 15:14:01 15:14:01.392 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:01 15:14:01.392 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 24, missCount = 3]
21-Jun-2018 15:14:01 15:14:01.392 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.test.mock.mockito.MockitoBeans'
21-Jun-2018 15:14:01 15:14:01.393 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Initializing servlet ''
21-Jun-2018 15:14:01 15:14:01.393 [main] INFO org.springframework.mock.web.MockServletContext - Initializing Spring FrameworkServlet ''
21-Jun-2018 15:14:01 15:14:01.393 [main] INFO org.springframework.test.web.servlet.TestDispatcherServlet - FrameworkServlet '': initialization started
21-Jun-2018 15:14:01 15:14:01.393 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate MultipartResolver with name 'multipartResolver': no multipart request handling provided
21-Jun-2018 15:14:01 15:14:01.393 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.i18n.AcceptHeaderLocaleResolver'
21-Jun-2018 15:14:01 15:14:01.394 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.i18n.AcceptHeaderLocaleResolver'
21-Jun-2018 15:14:01 15:14:01.394 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate LocaleResolver with name 'localeResolver': using default [org.springframework.web.servlet.i18n.AcceptHeaderLocaleResolver@32d5279]
21-Jun-2018 15:14:01 15:14:01.394 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.theme.FixedThemeResolver'
21-Jun-2018 15:14:01 15:14:01.394 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.theme.FixedThemeResolver'
21-Jun-2018 15:14:01 15:14:01.394 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate ThemeResolver with name 'themeResolver': using default [org.springframework.web.servlet.theme.FixedThemeResolver@1c067c0d]
21-Jun-2018 15:14:01 15:14:01.394 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'requestMappingHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.395 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'viewControllerHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.395 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'beanNameHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.395 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'resourceHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.395 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'defaultServletHandlerMapping'
21-Jun-2018 15:14:01 15:14:01.395 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'requestMappingHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.395 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'httpRequestHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.395 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'simpleControllerHandlerAdapter'
21-Jun-2018 15:14:01 15:14:01.395 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'handlerExceptionResolver'
21-Jun-2018 15:14:01 15:14:01.395 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.view.DefaultRequestToViewNameTranslator'
21-Jun-2018 15:14:01 15:14:01.396 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.view.DefaultRequestToViewNameTranslator'
21-Jun-2018 15:14:01 15:14:01.396 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate RequestToViewNameTranslator with name 'viewNameTranslator': using default [org.springframework.web.servlet.view.DefaultRequestToViewNameTranslator@5d0b0cb9]
21-Jun-2018 15:14:01 15:14:01.396 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcViewResolver'
21-Jun-2018 15:14:01 15:14:01.396 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.support.SessionFlashMapManager'
21-Jun-2018 15:14:01 15:14:01.396 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.support.SessionFlashMapManager'
21-Jun-2018 15:14:01 15:14:01.396 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate FlashMapManager with name 'flashMapManager': using default [org.springframework.web.servlet.support.SessionFlashMapManager@7f7b6639]
21-Jun-2018 15:14:01 15:14:01.396 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Published WebApplicationContext of servlet '' as ServletContext attribute with name [org.springframework.web.servlet.FrameworkServlet.CONTEXT.]
21-Jun-2018 15:14:01 15:14:01.396 [main] INFO org.springframework.test.web.servlet.TestDispatcherServlet - FrameworkServlet '': initialization completed in 3 ms
21-Jun-2018 15:14:01 15:14:01.396 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Servlet '' configured successfully
21-Jun-2018 15:14:01 15:14:01.402 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.402 [main] DEBUG io.lettuce.core.RedisClient - Trying to get a Redis connection for: RedisURI [host='localhost', port=6379]
21-Jun-2018 15:14:01 15:14:01.402 [main] DEBUG io.lettuce.core.resource.DefaultEventLoopGroupProvider - Adding reference to io.netty.channel.nio.NioEventLoopGroup@20a967fe, existing ref count 0
21-Jun-2018 15:14:01 15:14:01.402 [main] DEBUG io.lettuce.core.RedisClient - Resolved SocketAddress localhost:6379 using RedisURI [host='localhost', port=6379]
21-Jun-2018 15:14:01 15:14:01.402 [main] DEBUG io.lettuce.core.RedisClient - Connecting to Redis at localhost:6379
21-Jun-2018 15:14:01 15:14:01.407 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, [id: 0x2bec020d] (inactive), chid=0x4] channelRegistered()
21-Jun-2018 15:14:01 15:14:01.408 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] channelActive()
21-Jun-2018 15:14:01 15:14:01.408 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] activateEndpointAndExecuteBufferedCommands 0 command(s) buffered
21-Jun-2018 15:14:01 15:14:01.408 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] activating endpoint
21-Jun-2018 15:14:01 15:14:01.409 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] flushCommands()
21-Jun-2018 15:14:01 15:14:01.409 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] flushCommands() Flushing 0 commands
21-Jun-2018 15:14:01 15:14:01.409 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelActive()
21-Jun-2018 15:14:01 15:14:01.409 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelActive()
21-Jun-2018 15:14:01 15:14:01.409 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] channelActive() done
21-Jun-2018 15:14:01 15:14:01.410 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.RedisClient - Connecting to Redis at localhost:6379: Success
21-Jun-2018 15:14:01 15:14:01.411 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] userEventTriggered(ctx, io.lettuce.core.ConnectionEvents$Activated@28c3d1f8)
21-Jun-2018 15:14:01 15:14:01.411 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] userEventTriggered(ctx, io.lettuce.core.ConnectionEvents$Activated@28c3d1f8)
21-Jun-2018 15:14:01 15:14:01.425 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.426 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.427 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.428 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.434 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.489 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.489 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.490 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.492 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=0.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.506 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.506 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.506 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.506 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.506 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.507 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.508 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.509 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.509 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.509 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.509 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=1.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.509 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.511 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.513 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.513 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.514 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.514 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.515 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.515 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 5 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.516 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.516 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.516 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=SET, output=StatusOutput [output=OK, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.519 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.519 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.519 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.519 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.519 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.519 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.520 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.520 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.520 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.520 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.520 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=0.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.521 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.521 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.521 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.521 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.521 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.521 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.524 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.525 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.525 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.525 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.525 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=1.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.526 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.526 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.526 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.526 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.526 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.527 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.528 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.528 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 5 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.528 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.529 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.529 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=SET, output=StatusOutput [output=OK, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.529 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.529 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - DispatcherServlet with name '' processing GET request for [/metrics/counters]
21-Jun-2018 15:14:01 15:14:01.530 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping - Looking up handler method for path /metrics/counters
21-Jun-2018 15:14:01 15:14:01.530 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping - Returning handler method [public org.springframework.hateoas.PagedResources<? extends org.springframework.analytics.rest.domain.MetricResource> org.springframework.analytics.rest.controller.CounterController.list(org.springframework.data.domain.Pageable,org.springframework.data.web.PagedResourcesAssembler<org.springframework.analytics.rest.domain.Metric<java.lang.Double>>,boolean)]
21-Jun-2018 15:14:01 15:14:01.530 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterController'
21-Jun-2018 15:14:01 15:14:01.530 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Last-Modified value for [/metrics/counters] is: -1
21-Jun-2018 15:14:01 15:14:01.534 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.536 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.536 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.536 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.537 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.538 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.545 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 70 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.545 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.545 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.546 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZRANGE, output=ValueListOutput [output=[[B@2d75f899, [B@771d01c7], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.547 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.548 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.549 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.549 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.549 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.549 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.551 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.553 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 44 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.554 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.554 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.554 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=MGET, output=KeyValueListOutput [output=[KeyValue[[B@fbabf6b, [B@10368462], KeyValue[[B@7e5d03d1, [B@3aeb594e]], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.556 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.556 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.556 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.557 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.557 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.557 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.558 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.560 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.560 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.561 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.561 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=1.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.561 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.561 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.562 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.562 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.562 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.562 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.564 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.565 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.565 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.565 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.566 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=1.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.566 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.580 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestResponseBodyMethodProcessor - Written [PagedResource { content: [links: [<http://localhost/metrics/counters/bar>;rel="self"], links: [<http://localhost/metrics/counters/foo>;rel="self"]], metadata: Metadata { number: 0, total pages: 1, total elements: 2, size: 20 }, links: [<http://localhost/metrics/counters?page=0&size=20>;rel="self"] }] as "application/json" using [org.springframework.http.converter.json.MappingJackson2HttpMessageConverter@5792c08c]
21-Jun-2018 15:14:01 15:14:01.581 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Null ModelAndView returned to DispatcherServlet with name '': assuming HandlerAdapter completed request handling
21-Jun-2018 15:14:01 15:14:01.581 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Successfully completed request
21-Jun-2018 15:14:01 15:14:01.581 [main] DEBUG com.jayway.jsonpath.internal.path.CompiledPath - Evaluating path: $['page']['totalElements']
21-Jun-2018 15:14:01 15:14:01.583 [main] DEBUG com.jayway.jsonpath.internal.path.CompiledPath - Evaluating path: $['content'][*]['name']
21-Jun-2018 15:14:01 15:14:01.583 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.583 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.584 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.584 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.584 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.584 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.585 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 70 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.585 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.585 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.585 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZRANGE, output=ValueListOutput [output=[[B@60f0f89f, [B@44417577], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.586 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.586 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.586 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.586 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.586 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.586 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.587 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.587 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 44 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.587 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.587 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=MGET, output=KeyValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.588 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=MGET, output=KeyValueListOutput [output=[KeyValue[[B@5214a5a5, [B@3255b780], KeyValue[[B@55869555, [B@1aa3b85f]], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.588 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.588 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.588 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.588 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.588 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.588 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.589 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.589 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.589 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.590 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.590 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=1.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.590 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.590 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.590 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.590 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.590 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.590 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.591 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.591 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.591 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.592 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.592 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=1.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.592 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.593 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.593 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.593 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.593 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.593 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.594 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.594 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 4 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.594 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.595 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.595 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZREM, output=IntegerOutput [output=1, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.595 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.596 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.597 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.597 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.598 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.598 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.598 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.599 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 4 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.599 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.599 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.599 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=DEL, output=IntegerOutput [output=1, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.599 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.600 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.600 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.600 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.600 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.600 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.600 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.601 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 4 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.602 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.602 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.602 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZREM, output=IntegerOutput [output=1, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.602 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.602 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:01 15:14:01.602 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.602 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.602 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:01 15:14:01.602 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:01 15:14:01.603 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:01 15:14:01.603 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 4 bytes, 1 commands in the stack
21-Jun-2018 15:14:01 15:14:01.603 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:01 15:14:01.604 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:01 15:14:01.604 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=DEL, output=IntegerOutput [output=1, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:01 15:14:01.604 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:01 15:14:01.604 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:01 15:14:01.604 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 25, missCount = 3]
21-Jun-2018 15:14:01 15:14:01.604 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:01 15:14:01.605 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 26, missCount = 3]
21-Jun-2018 15:14:01 15:14:01.605 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:01 15:14:01.606 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 27, missCount = 3]
21-Jun-2018 15:14:01 15:14:01.606 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.test.mock.mockito.MockitoBeans'
21-Jun-2018 15:14:01 15:14:01.606 [main] DEBUG org.springframework.test.context.support.AbstractDirtiesContextTestExecutionListener - After test method: context [DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@7e4579c7, testMethod = testList@CounterControllerTests, testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.web.ServletTestExecutionListener.populatedRequestContextHolder' -> true, 'org.springframework.test.context.web.ServletTestExecutionListener.resetRequestContextHolder' -> true]], class annotated with @DirtiesContext [false] with mode [null], method annotated with @DirtiesContext [false] with mode [null].
21-Jun-2018 15:14:01 15:14:01.606 [main] DEBUG org.springframework.test.context.web.ServletTestExecutionListener - Resetting RequestContextHolder for test context [DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@7e4579c7, testMethod = testList@CounterControllerTests, testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.web.ServletTestExecutionListener.populatedRequestContextHolder' -> true, 'org.springframework.test.context.web.ServletTestExecutionListener.resetRequestContextHolder' -> true]].
21-Jun-2018 15:14:01 15:14:01.606 [main] DEBUG io.lettuce.core.RedisChannelHandler - close()
21-Jun-2018 15:14:01 15:14:01.606 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, epid=0x3] close()
21-Jun-2018 15:14:01 15:14:01.607 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, chid=0x3] channelInactive()
21-Jun-2018 15:14:01 15:14:01.607 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, epid=0x3] deactivating endpoint handler
21-Jun-2018 15:14:01 15:14:01.607 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, chid=0x3] channelInactive() done
21-Jun-2018 15:14:01 15:14:01.607 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelInactive()
21-Jun-2018 15:14:01 15:14:01.607 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] Reconnect scheduling disabled
21-Jun-2018 15:14:01 15:14:01.607 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelInactive()
21-Jun-2018 15:14:01 15:14:01.607 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] Reconnect scheduling disabled
21-Jun-2018 15:14:01 15:14:01.607 [lettuce-nioEventLoop-12-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x9ae8906c, /127.0.0.1:35890 -> localhost/127.0.0.1:6379, chid=0x3] channelUnregistered()
21-Jun-2018 15:14:02 15:14:02.715 [lettuce-nioEventLoop-12-1] DEBUG io.netty.buffer.PoolThreadCache - Freed 1 thread-local buffer(s) from thread: lettuce-nioEventLoop-12-1
21-Jun-2018 15:14:02 15:14:02.729 [main] DEBUG org.springframework.test.annotation.ProfileValueUtils - Retrieved @ProfileValueSourceConfiguration [null] for test class [org.springframework.analytics.rest.controller.CounterControllerTests]
21-Jun-2018 15:14:02 15:14:02.729 [main] DEBUG org.springframework.test.annotation.ProfileValueUtils - Retrieved ProfileValueSource type [class org.springframework.test.annotation.SystemProfileValueSource] for class [org.springframework.analytics.rest.controller.CounterControllerTests]
21-Jun-2018 15:14:02 15:14:02.730 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:02 15:14:02.730 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 28, missCount = 3]
21-Jun-2018 15:14:02 15:14:02.730 [main] DEBUG org.springframework.test.context.web.ServletTestExecutionListener - Setting up MockHttpServletRequest, MockHttpServletResponse, ServletWebRequest, and RequestContextHolder for test context [DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@5e13f156, testMethod = [null], testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.support.DependencyInjectionTestExecutionListener.reinjectDependencies' -> true]].
21-Jun-2018 15:14:02 15:14:02.730 [main] DEBUG org.springframework.test.context.support.DependencyInjectionTestExecutionListener - Performing dependency injection for test context [[DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@5e13f156, testMethod = [null], testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.web.ServletTestExecutionListener.populatedRequestContextHolder' -> true, 'org.springframework.test.context.web.ServletTestExecutionListener.resetRequestContextHolder' -> true, 'org.springframework.test.context.support.DependencyInjectionTestExecutionListener.reinjectDependencies' -> true]]].
21-Jun-2018 15:14:02 15:14:02.730 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:02 15:14:02.730 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 29, missCount = 3]
21-Jun-2018 15:14:02 15:14:02.731 [main] DEBUG org.springframework.beans.factory.annotation.InjectionMetadata - Processing injected element of bean 'org.springframework.analytics.rest.controller.CounterControllerTests': AutowiredFieldElement for private org.springframework.analytics.metrics.redis.RedisMetricRepository org.springframework.analytics.rest.controller.CounterControllerTests.repository
21-Jun-2018 15:14:02 15:14:02.731 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterRepository'
21-Jun-2018 15:14:02 15:14:02.731 [main] DEBUG org.springframework.beans.factory.annotation.InjectionMetadata - Processing injected element of bean 'org.springframework.analytics.rest.controller.CounterControllerTests': AutowiredFieldElement for private org.springframework.analytics.test.support.CounterService org.springframework.analytics.rest.controller.CounterControllerTests.counterService
21-Jun-2018 15:14:02 15:14:02.731 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterService'
21-Jun-2018 15:14:02 15:14:02.731 [main] DEBUG org.springframework.beans.factory.annotation.InjectionMetadata - Processing injected element of bean 'org.springframework.analytics.rest.controller.CounterControllerTests': AutowiredFieldElement for private org.springframework.web.context.WebApplicationContext org.springframework.analytics.rest.controller.CounterControllerTests.wac
21-Jun-2018 15:14:02 15:14:02.736 [main] DEBUG io.lettuce.core.RedisClient - Trying to get a Redis connection for: RedisURI [host='localhost', port=6379]
21-Jun-2018 15:14:02 15:14:02.737 [main] DEBUG io.lettuce.core.resource.DefaultEventLoopGroupProvider - Adding reference to io.netty.channel.nio.NioEventLoopGroup@47f04e4d, existing ref count 0
21-Jun-2018 15:14:02 15:14:02.737 [main] DEBUG io.lettuce.core.RedisClient - Resolved SocketAddress localhost:6379 using RedisURI [host='localhost', port=6379]
21-Jun-2018 15:14:02 15:14:02.737 [main] DEBUG io.lettuce.core.RedisClient - Connecting to Redis at localhost:6379
21-Jun-2018 15:14:02 15:14:02.744 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x88dce336, [id: 0xd5bb000e] (inactive), chid=0x5] channelRegistered()
21-Jun-2018 15:14:02 15:14:02.746 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, chid=0x5] channelActive()
21-Jun-2018 15:14:02 15:14:02.746 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, epid=0x5] activateEndpointAndExecuteBufferedCommands 0 command(s) buffered
21-Jun-2018 15:14:02 15:14:02.746 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, epid=0x5] activating endpoint
21-Jun-2018 15:14:02 15:14:02.746 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, epid=0x5] flushCommands()
21-Jun-2018 15:14:02 15:14:02.746 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, epid=0x5] flushCommands() Flushing 0 commands
21-Jun-2018 15:14:02 15:14:02.746 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelActive()
21-Jun-2018 15:14:02 15:14:02.747 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelActive()
21-Jun-2018 15:14:02 15:14:02.747 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, chid=0x5] channelActive() done
21-Jun-2018 15:14:02 15:14:02.747 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.RedisClient - Connecting to Redis at localhost:6379: Success
21-Jun-2018 15:14:02 15:14:02.750 [main] DEBUG org.springframework.test.context.support.AbstractDirtiesContextTestExecutionListener - Before test method: context [DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@5e13f156, testMethod = testGetAndDelete@CounterControllerTests, testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.web.ServletTestExecutionListener.populatedRequestContextHolder' -> true, 'org.springframework.test.context.web.ServletTestExecutionListener.resetRequestContextHolder' -> true]], class annotated with @DirtiesContext [false] with mode [null], method annotated with @DirtiesContext [false] with mode [null].
21-Jun-2018 15:14:02 15:14:02.751 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:02 15:14:02.751 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 30, missCount = 3]
21-Jun-2018 15:14:02 15:14:02.751 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.test.mock.mockito.MockitoBeans'
21-Jun-2018 15:14:02 15:14:02.752 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Initializing servlet ''
21-Jun-2018 15:14:02 15:14:02.752 [main] INFO org.springframework.mock.web.MockServletContext - Initializing Spring FrameworkServlet ''
21-Jun-2018 15:14:02 15:14:02.752 [main] INFO org.springframework.test.web.servlet.TestDispatcherServlet - FrameworkServlet '': initialization started
21-Jun-2018 15:14:02 15:14:02.752 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate MultipartResolver with name 'multipartResolver': no multipart request handling provided
21-Jun-2018 15:14:02 15:14:02.752 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.i18n.AcceptHeaderLocaleResolver'
21-Jun-2018 15:14:02 15:14:02.753 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.i18n.AcceptHeaderLocaleResolver'
21-Jun-2018 15:14:02 15:14:02.753 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate LocaleResolver with name 'localeResolver': using default [org.springframework.web.servlet.i18n.AcceptHeaderLocaleResolver@3520963d]
21-Jun-2018 15:14:02 15:14:02.753 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.theme.FixedThemeResolver'
21-Jun-2018 15:14:02 15:14:02.753 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.theme.FixedThemeResolver'
21-Jun-2018 15:14:02 15:14:02.753 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate ThemeResolver with name 'themeResolver': using default [org.springframework.web.servlet.theme.FixedThemeResolver@388d14e]
21-Jun-2018 15:14:02 15:14:02.753 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'requestMappingHandlerMapping'
21-Jun-2018 15:14:02 15:14:02.754 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'viewControllerHandlerMapping'
21-Jun-2018 15:14:02 15:14:02.754 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'beanNameHandlerMapping'
21-Jun-2018 15:14:02 15:14:02.754 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'resourceHandlerMapping'
21-Jun-2018 15:14:02 15:14:02.754 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'defaultServletHandlerMapping'
21-Jun-2018 15:14:02 15:14:02.754 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'requestMappingHandlerAdapter'
21-Jun-2018 15:14:02 15:14:02.754 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'httpRequestHandlerAdapter'
21-Jun-2018 15:14:02 15:14:02.754 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'simpleControllerHandlerAdapter'
21-Jun-2018 15:14:02 15:14:02.755 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'handlerExceptionResolver'
21-Jun-2018 15:14:02 15:14:02.755 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.view.DefaultRequestToViewNameTranslator'
21-Jun-2018 15:14:02 15:14:02.755 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.view.DefaultRequestToViewNameTranslator'
21-Jun-2018 15:14:02 15:14:02.755 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate RequestToViewNameTranslator with name 'viewNameTranslator': using default [org.springframework.web.servlet.view.DefaultRequestToViewNameTranslator@1cd43562]
21-Jun-2018 15:14:02 15:14:02.756 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'mvcViewResolver'
21-Jun-2018 15:14:02 15:14:02.756 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Creating instance of bean 'org.springframework.web.servlet.support.SessionFlashMapManager'
21-Jun-2018 15:14:02 15:14:02.756 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Finished creating instance of bean 'org.springframework.web.servlet.support.SessionFlashMapManager'
21-Jun-2018 15:14:02 15:14:02.756 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Unable to locate FlashMapManager with name 'flashMapManager': using default [org.springframework.web.servlet.support.SessionFlashMapManager@59939293]
21-Jun-2018 15:14:02 15:14:02.756 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Published WebApplicationContext of servlet '' as ServletContext attribute with name [org.springframework.web.servlet.FrameworkServlet.CONTEXT.]
21-Jun-2018 15:14:02 15:14:02.756 [main] INFO org.springframework.test.web.servlet.TestDispatcherServlet - FrameworkServlet '': initialization completed in 4 ms
21-Jun-2018 15:14:02 15:14:02.756 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Servlet '' configured successfully
21-Jun-2018 15:14:02 15:14:02.757 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.757 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.757 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.757 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.758 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.758 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.758 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.758 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.758 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=0.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.759 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.759 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.759 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.759 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.760 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.760 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.760 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.760 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.760 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.760 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.761 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=1.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.761 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.761 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.762 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.762 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.762 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.762 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.762 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.763 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 5 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.763 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.763 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.763 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=SET, output=StatusOutput [output=OK, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.764 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.764 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.764 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.764 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.764 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.765 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.765 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.765 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.765 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.765 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.765 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=1.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.766 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.766 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.766 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.766 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.767 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.767 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.767 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.759 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] userEventTriggered(ctx, io.lettuce.core.ConnectionEvents$Activated@3cdc1660)
21-Jun-2018 15:14:02 15:14:02.767 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] userEventTriggered(ctx, io.lettuce.core.ConnectionEvents$Activated@3cdc1660)
21-Jun-2018 15:14:02 15:14:02.768 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.768 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.768 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.768 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZINCRBY, output=DoubleOutput [output=2.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.768 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.768 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.768 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.768 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.768 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.768 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.769 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.769 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.770 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 5 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.770 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.770 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=SET, output=StatusOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.770 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=SET, output=StatusOutput [output=OK, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.771 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.771 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - DispatcherServlet with name '' processing GET request for [/metrics/counters/foo]
21-Jun-2018 15:14:02 15:14:02.771 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping - Looking up handler method for path /metrics/counters/foo
21-Jun-2018 15:14:02 15:14:02.772 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping - Returning handler method [public org.springframework.analytics.rest.domain.CounterResource org.springframework.analytics.rest.controller.CounterController.display(java.lang.String)]
21-Jun-2018 15:14:02 15:14:02.772 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterController'
21-Jun-2018 15:14:02 15:14:02.772 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Last-Modified value for [/metrics/counters/foo] is: -1
21-Jun-2018 15:14:02 15:14:02.773 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.773 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.773 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.773 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.773 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.774 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.774 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 20 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.775 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.775 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.775 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=GET, output=ValueOutput [output=[B@6ded1f23, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.776 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.776 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.777 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.777 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.777 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.777 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.777 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.778 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.778 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.778 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.778 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=2.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.778 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.785 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestResponseBodyMethodProcessor - Written [links: [<http://localhost/metrics/counters/foo>;rel="self"]] as "application/json" using [org.springframework.http.converter.json.MappingJackson2HttpMessageConverter@5792c08c]
21-Jun-2018 15:14:02 15:14:02.785 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Null ModelAndView returned to DispatcherServlet with name '': assuming HandlerAdapter completed request handling
21-Jun-2018 15:14:02 15:14:02.785 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Successfully completed request
21-Jun-2018 15:14:02 15:14:02.786 [main] DEBUG com.jayway.jsonpath.internal.path.CompiledPath - Evaluating path: $['name']
21-Jun-2018 15:14:02 15:14:02.786 [main] DEBUG com.jayway.jsonpath.internal.path.CompiledPath - Evaluating path: $['value']
21-Jun-2018 15:14:02 15:14:02.786 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - DispatcherServlet with name '' processing DELETE request for [/metrics/counters/foo]
21-Jun-2018 15:14:02 15:14:02.786 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping - Looking up handler method for path /metrics/counters/foo
21-Jun-2018 15:14:02 15:14:02.786 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping - Returning handler method [protected void org.springframework.analytics.rest.controller.CounterController.delete(java.lang.String)]
21-Jun-2018 15:14:02 15:14:02.786 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterController'
21-Jun-2018 15:14:02 15:14:02.787 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.787 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.787 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.787 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.787 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.788 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.788 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 20 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.788 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.789 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.789 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=GET, output=ValueOutput [output=[B@721b5ca9, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.789 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.789 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.789 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.789 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.789 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.789 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.790 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.791 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 7 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.791 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.791 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.791 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=2.0, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.795 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.795 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.795 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.795 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.795 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.795 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.796 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.796 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 4 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.796 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.797 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZREM, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.797 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZREM, output=IntegerOutput [output=1, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.797 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.797 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.797 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.797 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.797 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.797 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.798 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.798 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 4 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.798 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.798 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=DEL, output=IntegerOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.799 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=DEL, output=IntegerOutput [output=1, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.799 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.799 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Null ModelAndView returned to DispatcherServlet with name '': assuming HandlerAdapter completed request handling
21-Jun-2018 15:14:02 15:14:02.799 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Successfully completed request
21-Jun-2018 15:14:02 15:14:02.799 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - DispatcherServlet with name '' processing GET request for [/metrics/counters/foo]
21-Jun-2018 15:14:02 15:14:02.799 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping - Looking up handler method for path /metrics/counters/foo
21-Jun-2018 15:14:02 15:14:02.800 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping - Returning handler method [public org.springframework.analytics.rest.domain.CounterResource org.springframework.analytics.rest.controller.CounterController.display(java.lang.String)]
21-Jun-2018 15:14:02 15:14:02.800 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'counterController'
21-Jun-2018 15:14:02 15:14:02.800 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Last-Modified value for [/metrics/counters/foo] is: -1
21-Jun-2018 15:14:02 15:14:02.800 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.800 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.800 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.800 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.800 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.801 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.802 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 5 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.802 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.802 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.802 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=GET, output=ValueOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.803 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.803 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.803 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.803 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.803 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.803 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.804 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.804 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 5 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.804 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.804 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.804 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZSCORE, output=DoubleOutput [output=null, error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.805 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.805 [main] DEBUG org.springframework.web.servlet.mvc.method.annotation.ExceptionHandlerExceptionResolver - Resolving exception from handler [public org.springframework.analytics.rest.domain.CounterResource org.springframework.analytics.rest.controller.CounterController.display(java.lang.String)]: org.springframework.analytics.rest.controller.NoSuchMetricException: foo
21-Jun-2018 15:14:02 15:14:02.805 [main] DEBUG org.springframework.web.servlet.mvc.annotation.ResponseStatusExceptionResolver - Resolving exception from handler [public org.springframework.analytics.rest.domain.CounterResource org.springframework.analytics.rest.controller.CounterController.display(java.lang.String)]: org.springframework.analytics.rest.controller.NoSuchMetricException: foo
21-Jun-2018 15:14:02 15:14:02.805 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Null ModelAndView returned to DispatcherServlet with name '': assuming HandlerAdapter completed request handling
21-Jun-2018 15:14:02 15:14:02.806 [main] DEBUG org.springframework.test.web.servlet.TestDispatcherServlet - Successfully completed request
21-Jun-2018 15:14:02 15:14:02.806 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Opening RedisConnection
21-Jun-2018 15:14:02 15:14:02.806 [main] DEBUG io.lettuce.core.RedisChannelHandler - dispatching command AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.806 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() writeAndFlush command AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.806 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] write() done
21-Jun-2018 15:14:02 15:14:02.806 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] write(ctx, AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command], promise)
21-Jun-2018 15:14:02 15:14:02.807 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandEncoder - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379] writing command AsyncCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.Command]
21-Jun-2018 15:14:02 15:14:02.807 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Received: 4 bytes, 1 commands in the stack
21-Jun-2018 15:14:02 15:14:02.807 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] Stack contains: 1 commands
21-Jun-2018 15:14:02 15:14:02.807 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decode LatencyMeteredCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand]
21-Jun-2018 15:14:02 15:14:02.807 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.RedisStateMachine - Decoded LatencyMeteredCommand [type=ZRANGE, output=ValueListOutput [output=[], error='null'], commandType=io.lettuce.core.protocol.AsyncCommand], empty stack: true
21-Jun-2018 15:14:02 15:14:02.808 [main] DEBUG org.springframework.data.redis.core.RedisConnectionUtils - Closing Redis Connection
21-Jun-2018 15:14:02 15:14:02.808 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:02 15:14:02.808 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 31, missCount = 3]
21-Jun-2018 15:14:02 15:14:02.808 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:02 15:14:02.808 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 32, missCount = 3]
21-Jun-2018 15:14:02 15:14:02.809 [main] DEBUG org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate - Retrieved ApplicationContext from cache with key [[WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]]]
21-Jun-2018 15:14:02 15:14:02.809 [main] DEBUG org.springframework.test.context.cache - Spring test ApplicationContext cache statistics: [DefaultContextCache@5eb97ced size = 3, maxSize = 32, parentContextCount = 0, hitCount = 33, missCount = 3]
21-Jun-2018 15:14:02 15:14:02.809 [main] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'org.springframework.boot.test.mock.mockito.MockitoBeans'
21-Jun-2018 15:14:02 15:14:02.810 [main] DEBUG org.springframework.test.context.support.AbstractDirtiesContextTestExecutionListener - After test method: context [DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@5e13f156, testMethod = testGetAndDelete@CounterControllerTests, testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.web.ServletTestExecutionListener.populatedRequestContextHolder' -> true, 'org.springframework.test.context.web.ServletTestExecutionListener.resetRequestContextHolder' -> true]], class annotated with @DirtiesContext [false] with mode [null], method annotated with @DirtiesContext [false] with mode [null].
21-Jun-2018 15:14:02 15:14:02.810 [main] DEBUG org.springframework.test.context.web.ServletTestExecutionListener - Resetting RequestContextHolder for test context [DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = org.springframework.analytics.rest.controller.CounterControllerTests@5e13f156, testMethod = testGetAndDelete@CounterControllerTests, testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.web.ServletTestExecutionListener.populatedRequestContextHolder' -> true, 'org.springframework.test.context.web.ServletTestExecutionListener.resetRequestContextHolder' -> true]].
21-Jun-2018 15:14:02 15:14:02.810 [main] DEBUG io.lettuce.core.RedisChannelHandler - close()
21-Jun-2018 15:14:02 15:14:02.810 [main] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, epid=0x5] close()
21-Jun-2018 15:14:02 15:14:02.811 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, chid=0x5] channelInactive()
21-Jun-2018 15:14:02 15:14:02.811 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, epid=0x5] deactivating endpoint handler
21-Jun-2018 15:14:02 15:14:02.811 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, chid=0x5] channelInactive() done
21-Jun-2018 15:14:02 15:14:02.811 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelInactive()
21-Jun-2018 15:14:02 15:14:02.811 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] Reconnect scheduling disabled
21-Jun-2018 15:14:02 15:14:02.811 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelInactive()
21-Jun-2018 15:14:02 15:14:02.811 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] Reconnect scheduling disabled
21-Jun-2018 15:14:02 15:14:02.811 [lettuce-nioEventLoop-16-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x88dce336, /127.0.0.1:35894 -> localhost/127.0.0.1:6379, chid=0x5] channelUnregistered()
21-Jun-2018 15:14:03 15:14:03.913 [lettuce-nioEventLoop-16-1] DEBUG io.netty.buffer.PoolThreadCache - Freed 1 thread-local buffer(s) from thread: lettuce-nioEventLoop-16-1
21-Jun-2018 15:14:03 15:14:03.916 [main] DEBUG org.springframework.test.context.support.AbstractDirtiesContextTestExecutionListener - After test class: context [DefaultTestContext@22f4f8f2 testClass = CounterControllerTests, testInstance = [null], testMethod = [null], testException = [null], mergedContextConfiguration = [WebMergedContextConfiguration@bbd4791 testClass = CounterControllerTests, locations = '{}', classes = '{class org.springframework.analytics.rest.controller.CounterControllerTests$Config}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7ba18f1b, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@aecb35a, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@0, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@40f08448, org.springframework.test.context.web.socket.MockServerContainerContextCustomizer@33b37288], resourceBasePath = 'src/main/webapp', contextLoader = 'org.springframework.test.context.web.WebDelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.support.DependencyInjectionTestExecutionListener.reinjectDependencies' -> true]], class annotated with @DirtiesContext [false] with mode [null].
21-Jun-2018 15:14:03 Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.931 sec - in org.springframework.analytics.rest.controller.CounterControllerTests
21-Jun-2018 15:14:03 15:14:03.920 [Thread-4] INFO org.springframework.web.context.support.GenericWebApplicationContext - Closing org.springframework.web.context.support.GenericWebApplicationContext@40a72ecd: startup date [Thu Jun 21 15:14:00 UTC 2018]; root of context hierarchy
21-Jun-2018 15:14:03 15:14:03.923 [Thread-2] INFO org.springframework.web.context.support.GenericWebApplicationContext - Closing org.springframework.web.context.support.GenericWebApplicationContext@1b4ae4e0: startup date [Thu Jun 21 15:13:57 UTC 2018]; root of context hierarchy
21-Jun-2018 15:14:03 15:14:03.924 [Thread-2] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'lifecycleProcessor'
21-Jun-2018 15:14:03 15:14:03.924 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'lifecycleProcessor'
21-Jun-2018 15:14:03 15:14:03.924 [Thread-1] INFO org.springframework.web.context.support.GenericWebApplicationContext - Closing org.springframework.web.context.support.GenericWebApplicationContext@5b239d7d: startup date [Thu Jun 21 15:13:54 UTC 2018]; root of context hierarchy
21-Jun-2018 15:14:03 15:14:03.924 [Thread-1] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Returning cached instance of singleton bean 'lifecycleProcessor'
21-Jun-2018 15:14:03 15:14:03.924 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@1fd9893c: defining beans [org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.context.event.internalEventListenerProcessor,org.springframework.context.event.internalEventListenerFactory,counterControllerTests.Config,org.springframework.boot.test.mock.mockito.MockitoPostProcessor$SpyPostProcessor,org.springframework.boot.test.mock.mockito.MockitoPostProcessor,org.springframework.data.web.config.ProjectingArgumentResolverRegistrar,projectingArgumentResolverBeanPostProcessor,org.springframework.data.web.config.HateoasAwareSpringDataWebConfiguration,pageableResolver,sortResolver,pagedResourcesAssembler,pagedResourcesAssemblerArgumentResolver,org.springframework.data.web.config.SpringDataJacksonConfiguration,jacksonGeoModule,org.springframework.hateoas.config.HateoasConfiguration,linkRelationMessageSource,org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration,requestMappingHandlerMapping,mvcPathMatcher,mvcUrlPathHelper,mvcContentNegotiationManager,viewControllerHandlerMapping,beanNameHandlerMapping,resourceHandlerMapping,mvcResourceUrlProvider,defaultServletHandlerMapping,requestMappingHandlerAdapter,mvcConversionService,mvcValidator,mvcUriComponentsContributor,httpRequestHandlerAdapter,simpleControllerHandlerAdapter,handlerExceptionResolver,mvcViewResolver,mvcHandlerMappingIntrospector,org.springframework.boot.autoconfigure.data.redis.LettuceConnectionConfiguration,org.springframework.boot.autoconfigure.condition.BeanTypeRegistry,lettuceClientResources,redisConnectionFactory,org.springframework.boot.autoconfigure.data.redis.RedisAutoConfiguration,redisTemplate,stringRedisTemplate,spring.redis-org.springframework.boot.autoconfigure.data.redis.RedisProperties,org.springframework.boot.context.properties.ConfigurationPropertiesBindingPostProcessor,org.springframework.boot.context.properties.ConfigurationBeanFactoryMetadata,counterRepository,counterController,counterService,entityLinksPluginRegistry,controllerEntityLinks,delegatingEntityLinks,org.springframework.hateoas.hal.HalLinkDiscoverer#0,_halObjectMapper,org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$DefaultObjectMapperCustomizer#0,org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$Jackson2ModuleRegisteringBeanPostProcessor#0,org.springframework.hateoas.hal.HalConfiguration#0,_linkDiscovererRegistry,org.springframework.hateoas.LinkDiscoverers#0,defaultRelProvider,annotationRelProvider,relProviderPluginRegistry,_relProvider]; root of factory hierarchy
21-Jun-2018 15:14:03 15:14:03.924 [Thread-1] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@15ca7889: defining beans [org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.context.event.internalEventListenerProcessor,org.springframework.context.event.internalEventListenerFactory,aggregateCounterControllerTests.Config,org.springframework.boot.test.mock.mockito.MockitoPostProcessor$SpyPostProcessor,org.springframework.boot.test.mock.mockito.MockitoPostProcessor,org.springframework.data.web.config.ProjectingArgumentResolverRegistrar,projectingArgumentResolverBeanPostProcessor,org.springframework.data.web.config.HateoasAwareSpringDataWebConfiguration,pageableResolver,sortResolver,pagedResourcesAssembler,pagedResourcesAssemblerArgumentResolver,org.springframework.data.web.config.SpringDataJacksonConfiguration,jacksonGeoModule,org.springframework.hateoas.config.HateoasConfiguration,linkRelationMessageSource,org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration,requestMappingHandlerMapping,mvcPathMatcher,mvcUrlPathHelper,mvcContentNegotiationManager,viewControllerHandlerMapping,beanNameHandlerMapping,resourceHandlerMapping,mvcResourceUrlProvider,defaultServletHandlerMapping,requestMappingHandlerAdapter,mvcConversionService,mvcValidator,mvcUriComponentsContributor,httpRequestHandlerAdapter,simpleControllerHandlerAdapter,handlerExceptionResolver,mvcViewResolver,mvcHandlerMappingIntrospector,aggregateCounterRepository,aggregateCounterController,entityLinksPluginRegistry,controllerEntityLinks,delegatingEntityLinks,org.springframework.hateoas.hal.HalLinkDiscoverer#0,_halObjectMapper,org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$DefaultObjectMapperCustomizer#0,org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$Jackson2ModuleRegisteringBeanPostProcessor#0,org.springframework.hateoas.hal.HalConfiguration#0,_linkDiscovererRegistry,org.springframework.hateoas.LinkDiscoverers#0,defaultRelProvider,annotationRelProvider,relProviderPluginRegistry,_relProvider]; root of factory hierarchy
21-Jun-2018 15:14:03 15:14:03.924 [Thread-2] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@37d871c2: defining beans [org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.context.event.internalEventListenerProcessor,org.springframework.context.event.internalEventListenerFactory,fieldValueCounterControllerTests.Config,org.springframework.boot.test.mock.mockito.MockitoPostProcessor$SpyPostProcessor,org.springframework.boot.test.mock.mockito.MockitoPostProcessor,org.springframework.data.web.config.ProjectingArgumentResolverRegistrar,projectingArgumentResolverBeanPostProcessor,org.springframework.data.web.config.HateoasAwareSpringDataWebConfiguration,pageableResolver,sortResolver,pagedResourcesAssembler,pagedResourcesAssemblerArgumentResolver,org.springframework.data.web.config.SpringDataJacksonConfiguration,jacksonGeoModule,org.springframework.hateoas.config.HateoasConfiguration,linkRelationMessageSource,org.springframework.web.servlet.config.annotation.DelegatingWebMvcConfiguration,requestMappingHandlerMapping,mvcPathMatcher,mvcUrlPathHelper,mvcContentNegotiationManager,viewControllerHandlerMapping,beanNameHandlerMapping,resourceHandlerMapping,mvcResourceUrlProvider,defaultServletHandlerMapping,requestMappingHandlerAdapter,mvcConversionService,mvcValidator,mvcUriComponentsContributor,httpRequestHandlerAdapter,simpleControllerHandlerAdapter,handlerExceptionResolver,mvcViewResolver,mvcHandlerMappingIntrospector,fieldValueCounterRepository,fieldValueCounterController,entityLinksPluginRegistry,controllerEntityLinks,delegatingEntityLinks,org.springframework.hateoas.hal.HalLinkDiscoverer#0,_halObjectMapper,org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$DefaultObjectMapperCustomizer#0,org.springframework.hateoas.config.HypermediaSupportBeanDefinitionRegistrar$Jackson2ModuleRegisteringBeanPostProcessor#0,org.springframework.hateoas.hal.HalConfiguration#0,_linkDiscovererRegistry,org.springframework.hateoas.LinkDiscoverers#0,defaultRelProvider,annotationRelProvider,relProviderPluginRegistry,_relProvider]; root of factory hierarchy
21-Jun-2018 15:14:03 15:14:03.926 [Thread-2] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '_linkDiscovererRegistry': [org.springframework.hateoas.LinkDiscoverers#0]
21-Jun-2018 15:14:03 15:14:03.926 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '_linkDiscovererRegistry': [org.springframework.hateoas.LinkDiscoverers#0]
21-Jun-2018 15:14:03 15:14:03.926 [Thread-2] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '(inner bean)#b835727': [delegatingEntityLinks]
21-Jun-2018 15:14:03 15:14:03.926 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '(inner bean)#1f2f0109': [delegatingEntityLinks]
21-Jun-2018 15:14:03 15:14:03.926 [Thread-4] DEBUG org.springframework.beans.factory.support.DisposableBeanAdapter - Invoking destroy() on bean with name 'controllerEntityLinks'
21-Jun-2018 15:14:03 15:14:03.927 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '(inner bean)#32eae6f2': [controllerEntityLinks]
21-Jun-2018 15:14:03 15:14:03.927 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '(inner bean)#111d5c97': [_relProvider]
21-Jun-2018 15:14:03 15:14:03.927 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'mvcValidator': [requestMappingHandlerAdapter]
21-Jun-2018 15:14:03 15:14:03.927 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'requestMappingHandlerAdapter': [mvcUriComponentsContributor]
21-Jun-2018 15:14:03 15:14:03.927 [Thread-4] DEBUG org.springframework.beans.factory.support.DisposableBeanAdapter - Invoking destroy() on bean with name 'mvcValidator'
21-Jun-2018 15:14:03 15:14:03.928 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'mvcResourceUrlProvider': [requestMappingHandlerMapping]
21-Jun-2018 15:14:03 15:14:03.928 [Thread-4] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'redisConnectionFactory': [counterControllerTests.Config, redisTemplate, stringRedisTemplate]
21-Jun-2018 15:14:03 15:14:03.928 [Thread-4] DEBUG org.springframework.beans.factory.support.DisposableBeanAdapter - Invoking destroy() on bean with name 'redisConnectionFactory'
21-Jun-2018 15:14:03 15:14:03.928 [Thread-4] DEBUG io.lettuce.core.RedisChannelHandler - close()
21-Jun-2018 15:14:03 15:14:03.928 [Thread-4] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] close()
21-Jun-2018 15:14:03 15:14:03.929 [Thread-1] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '_linkDiscovererRegistry': [org.springframework.hateoas.LinkDiscoverers#0]
21-Jun-2018 15:14:03 15:14:03.929 [Thread-1] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '(inner bean)#4d0b0fd4': [delegatingEntityLinks]
21-Jun-2018 15:14:03 15:14:03.929 [Thread-1] DEBUG org.springframework.beans.factory.support.DisposableBeanAdapter - Invoking destroy() on bean with name 'controllerEntityLinks'
21-Jun-2018 15:14:03 15:14:03.929 [Thread-1] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '(inner bean)#dffa30b': [controllerEntityLinks]
21-Jun-2018 15:14:03 15:14:03.929 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] channelInactive()
21-Jun-2018 15:14:03 15:14:03.929 [Thread-1] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '(inner bean)#332f25c8': [_relProvider]
21-Jun-2018 15:14:03 15:14:03.929 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.DefaultEndpoint - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, epid=0x4] deactivating endpoint handler
21-Jun-2018 15:14:03 15:14:03.929 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] channelInactive() done
21-Jun-2018 15:14:03 15:14:03.929 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelInactive()
21-Jun-2018 15:14:03 15:14:03.929 [Thread-1] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'mvcValidator': [requestMappingHandlerAdapter]
21-Jun-2018 15:14:03 15:14:03.929 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] Reconnect scheduling disabled
21-Jun-2018 15:14:03 15:14:03.929 [Thread-1] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'requestMappingHandlerAdapter': [mvcUriComponentsContributor]
21-Jun-2018 15:14:03 15:14:03.929 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] channelInactive()
21-Jun-2018 15:14:03 15:14:03.929 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.ConnectionWatchdog - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, last known addr=localhost/127.0.0.1:6379] Reconnect scheduling disabled
21-Jun-2018 15:14:03 15:14:03.929 [Thread-1] DEBUG org.springframework.beans.factory.support.DisposableBeanAdapter - Invoking destroy() on bean with name 'mvcValidator'
21-Jun-2018 15:14:03 15:14:03.929 [lettuce-nioEventLoop-13-1] DEBUG io.lettuce.core.protocol.CommandHandler - [channel=0x390ba314, /127.0.0.1:35892 -> localhost/127.0.0.1:6379, chid=0x4] channelUnregistered()
21-Jun-2018 15:14:03 15:14:03.929 [Thread-1] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'mvcResourceUrlProvider': [requestMappingHandlerMapping]
21-Jun-2018 15:14:03 15:14:03.930 [Thread-2] DEBUG org.springframework.beans.factory.support.DisposableBeanAdapter - Invoking destroy() on bean with name 'controllerEntityLinks'
21-Jun-2018 15:14:03 15:14:03.930 [Thread-2] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '(inner bean)#3901f6af': [controllerEntityLinks]
21-Jun-2018 15:14:03 15:14:03.939 [Thread-2] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean '(inner bean)#2eadc9f6': [_relProvider]
21-Jun-2018 15:14:03 15:14:03.939 [Thread-2] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'mvcValidator': [requestMappingHandlerAdapter]
21-Jun-2018 15:14:03 15:14:03.939 [Thread-2] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'requestMappingHandlerAdapter': [mvcUriComponentsContributor]
21-Jun-2018 15:14:03 15:14:03.939 [Thread-2] DEBUG org.springframework.beans.factory.support.DisposableBeanAdapter - Invoking destroy() on bean with name 'mvcValidator'
21-Jun-2018 15:14:03 15:14:03.939 [Thread-2] DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - Retrieved dependent beans for bean 'mvcResourceUrlProvider': [requestMappingHandlerMapping]
21-Jun-2018 15:14:05 15:14:05.032 [lettuce-nioEventLoop-13-1] DEBUG io.netty.buffer.PoolThreadCache - Freed 20 thread-local buffer(s) from thread: lettuce-nioEventLoop-13-1
21-Jun-2018 15:14:05 15:14:05.041 [Thread-4] DEBUG org.springframework.beans.factory.support.DisposableBeanAdapter - Invoking destroy method 'shutdown' on bean with name 'lettuceClientResources'
21-Jun-2018 15:14:05
21-Jun-2018 15:14:05 Results :
21-Jun-2018 15:14:05
21-Jun-2018 15:14:05 Tests run: 6, Failures: 0, Errors: 0, Skipped: 0
21-Jun-2018 15:14:05
21-Jun-2018 15:14:05 [INFO]
21-Jun-2018 15:14:05 [INFO] --- maven-jar-plugin:2.4:jar (default-jar) @ spring-analytics ---
21-Jun-2018 15:14:05 [INFO] Building jar: /opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1/target/spring-analytics-2.0.1.BUILD-SNAPSHOT.jar
21-Jun-2018 15:14:05 [INFO]
21-Jun-2018 15:14:05 [INFO] --- maven-javadoc-plugin:2.10.4:jar (javadoc) @ spring-analytics ---
21-Jun-2018 15:14:06 [WARNING] Source files encoding has not been set, using platform encoding UTF-8, i.e. build is platform dependent!
21-Jun-2018 15:14:08 [INFO] Building jar: /opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1/target/spring-analytics-2.0.1.BUILD-SNAPSHOT-javadoc.jar
21-Jun-2018 15:14:08 [INFO]
21-Jun-2018 15:14:08 [INFO] >>> maven-source-plugin:3.0.1:jar (attach-sources) > generate-sources @ spring-analytics >>>
21-Jun-2018 15:14:08 [INFO]
21-Jun-2018 15:14:08 [INFO] <<< maven-source-plugin:3.0.1:jar (attach-sources) < generate-sources @ spring-analytics <<<
21-Jun-2018 15:14:08 [INFO]
21-Jun-2018 15:14:08 [INFO] --- maven-source-plugin:3.0.1:jar (attach-sources) @ spring-analytics ---
21-Jun-2018 15:14:08 [INFO] Building jar: /opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1/target/spring-analytics-2.0.1.BUILD-SNAPSHOT-sources.jar
21-Jun-2018 15:14:08 [INFO]
21-Jun-2018 15:14:08 [INFO] --- maven-install-plugin:2.4:install (default-install) @ spring-analytics ---
21-Jun-2018 15:14:08 [INFO] Installing /opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1/target/spring-analytics-2.0.1.BUILD-SNAPSHOT.jar to /home/bamboo/.m2/repository/org/springframework/analytics/spring-analytics/2.0.1.BUILD-SNAPSHOT/spring-analytics-2.0.1.BUILD-SNAPSHOT.jar
21-Jun-2018 15:14:08 [INFO] Installing /opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1/pom.xml to /home/bamboo/.m2/repository/org/springframework/analytics/spring-analytics/2.0.1.BUILD-SNAPSHOT/spring-analytics-2.0.1.BUILD-SNAPSHOT.pom
21-Jun-2018 15:14:08 [INFO] Installing /opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1/target/spring-analytics-2.0.1.BUILD-SNAPSHOT-javadoc.jar to /home/bamboo/.m2/repository/org/springframework/analytics/spring-analytics/2.0.1.BUILD-SNAPSHOT/spring-analytics-2.0.1.BUILD-SNAPSHOT-javadoc.jar
21-Jun-2018 15:14:08 [INFO] Installing /opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1/target/spring-analytics-2.0.1.BUILD-SNAPSHOT-sources.jar to /home/bamboo/.m2/repository/org/springframework/analytics/spring-analytics/2.0.1.BUILD-SNAPSHOT/spring-analytics-2.0.1.BUILD-SNAPSHOT-sources.jar
21-Jun-2018 15:14:09 [INFO] Artifactory Build Info Recorder: Saving Build Info to '/opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1/target/build-info.json'
21-Jun-2018 15:14:09 [INFO] Deploying artifact: https://repo.spring.io/libs-snapshot-local/org/springframework/analytics/spring-analytics/2.0.1.BUILD-SNAPSHOT/spring-analytics-2.0.1.BUILD-SNAPSHOT-javadoc.jar
21-Jun-2018 15:14:10 [INFO] Deploying artifact: https://repo.spring.io/libs-snapshot-local/org/springframework/analytics/spring-analytics/2.0.1.BUILD-SNAPSHOT/spring-analytics-2.0.1.BUILD-SNAPSHOT.jar
21-Jun-2018 15:14:11 [INFO] Deploying artifact: https://repo.spring.io/libs-snapshot-local/org/springframework/analytics/spring-analytics/2.0.1.BUILD-SNAPSHOT/spring-analytics-2.0.1.BUILD-SNAPSHOT-sources.jar
21-Jun-2018 15:14:11 [INFO] Deploying artifact: https://repo.spring.io/libs-snapshot-local/org/springframework/analytics/spring-analytics/2.0.1.BUILD-SNAPSHOT/spring-analytics-2.0.1.BUILD-SNAPSHOT.pom
21-Jun-2018 15:14:11 [INFO] Artifactory Build Info Recorder: Deploying build info ...
21-Jun-2018 15:14:11 [INFO] Deploying build descriptor to: https://repo.spring.io/api/build
21-Jun-2018 15:14:12 [INFO] Build successfully deployed. Browse it in Artifactory under https://repo.spring.io/webapp/builds/Spring%20Analytics%20-%20Master%20JDK7%20-%20Build%20and%20publish/50
21-Jun-2018 15:14:12 [INFO] ------------------------------------------------------------------------
21-Jun-2018 15:14:12 [INFO] BUILD SUCCESS
21-Jun-2018 15:14:12 [INFO] ------------------------------------------------------------------------
21-Jun-2018 15:14:12 [INFO] Total time: 34.828 s
21-Jun-2018 15:14:12 [INFO] Finished at: 2018-06-21T15:14:12+00:00
21-Jun-2018 15:14:12 [INFO] Final Memory: 41M/326M
21-Jun-2018 15:14:12 [INFO] ------------------------------------------------------------------------
21-Jun-2018 15:14:12 Parsing test results under /opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1...
21-Jun-2018 15:14:12 Finished task 'Build and publish Spring Analytics' with result: Success
21-Jun-2018 15:14:12 Running post build plugin 'Docker Container Cleanup'
21-Jun-2018 15:14:12 Running post build plugin 'NCover Results Collector'
21-Jun-2018 15:14:12 Running post build plugin 'Artifactory Release Management Staging'
21-Jun-2018 15:14:12 Running post build plugin 'Artifactory Build Info Copier'
21-Jun-2018 15:14:12 Copying the buildinfo artifacts for build: SA-BMASTER-JOB1-50
21-Jun-2018 15:14:12 Running post build plugin 'Artifactory Gradle Properties Info Copier'
21-Jun-2018 15:14:12 Running post build plugin 'Clover Results Collector'
21-Jun-2018 15:14:12 Running post build plugin 'npm Cache Cleanup'
21-Jun-2018 15:14:12 Running post build plugin 'Artifact Copier'
21-Jun-2018 15:14:12 Publishing an artifact: Test Results
21-Jun-2018 15:14:12 Finished publishing of artifact Shared artifact: [Test Results], pattern: [**/target/surefire-reports/**/*.*] in 27.18 ms
21-Jun-2018 15:14:12 Successfully removed working directory at '/opt/bamboo-home/xml-data/build-dir/SA-BMASTER-JOB1'
21-Jun-2018 15:14:12 Finalising the build...
21-Jun-2018 15:14:12 Stopping timer.
21-Jun-2018 15:14:12 Build SA-BMASTER-JOB1-50 completed.
21-Jun-2018 15:14:12 Running on server: post build plugin 'NCover Results Collector'
21-Jun-2018 15:14:12 Running on server: post build plugin 'Build Hanging Detection Configuration'
21-Jun-2018 15:14:12 Running on server: post build plugin 'Clover Delta Calculator'
21-Jun-2018 15:14:12 Running on server: post build plugin 'Maven Dependencies Postprocessor'
21-Jun-2018 15:14:12 All post build plugins have finished
21-Jun-2018 15:14:12 Generating build results summary...
21-Jun-2018 15:14:12 Saving build results to disk...
21-Jun-2018 15:14:12 Logging substituted variables...
21-Jun-2018 15:14:12 Indexing build results...
21-Jun-2018 15:14:12 Finished building SA-BMASTER-JOB1-50.