search

alibaba / nacos

an easy-to-use dynamic service discovery, configuration and service management platform for building cloud native applications.
https://nacos.io
Apache License 2.0
30.3k stars 12.84k forks source link

After adding the NacosConfig dependency, the Hikari database connection pool is automatically closed when the project is started (see the last three lines of the console output). #752

Closed polluxxing closed 5 years ago

polluxxing commented 5 years ago

Connected to the target VM, address: '127.0.0.1:11073', transport: 'socket' 2019-02-12 22:20:17.713 INFO [user-web,,,] 4384 --- [ main] s.c.a.AnnotationConfigApplicationContext : Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@ed3068a: startup date [Tue Feb 12 22:20:17 CST 2019]; root of context hierarchy 2019-02-12 22:20:18.232 INFO [user-web,,,] 4384 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'configurationPropertiesRebinderAutoConfiguration' of type [org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration$$EnhancerBySpringCGLIB$$e6cf8a1f] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)

. _ _ /\ / '_ () \ \ \ \ ( ( )\ | ' | '| | ' \/ ` | \ \ \ \ \/ _)| |)| | | | | || (| | ) ) ) ) ' |__| .|| ||| |\, | / / / / =========|_|==============|__/=//// :: Spring Boot :: (v2.0.3.RELEASE)

Tue Feb 12 22:20:19 CST 2019 sun.misc.Launcher$AppClassLoader@18b4aac2 JM.Log:INFO Init JM logger with Slf4jLoggerFactory success, sun.misc.Launcher$AppClassLoader@18b4aac2 Tue Feb 12 22:20:19 CST 2019 sun.misc.Launcher$AppClassLoader@18b4aac2 JM.Log:INFO Log root path: C:\Users\44804\logs\ Tue Feb 12 22:20:19 CST 2019 sun.misc.Launcher$AppClassLoader@18b4aac2 JM.Log:INFO Set nacos log path: C:\Users\44804\logs\nacos 2019-02-12 22:20:19.342 INFO [user-web,,,] 4384 --- [ main] c.a.n.client.identify.CredentialWatcher : [] [] [] No credential found 2019-02-12 22:20:19.479 INFO [user-web,,,] 4384 --- [ main] o.s.c.a.n.c.NacosPropertySourceBuilder : Loading nacos data, dataId: 'user-web-dev.yml', group: 'DEFAULT_GROUP' 2019-02-12 22:20:19.482 INFO [user-web,,,] 4384 --- [ main] b.c.PropertySourceBootstrapConfiguration : Located property source: CompositePropertySource {name='NACOS', propertySources=[NacosPropertySource {name='user-web-dev.yml'}, NacosPropertySource {name='user-web.yml'}]} 2019-02-12 22:20:19.545 INFO [user-web,,,] 4384 --- [ main] nickzxing.user.web.UserWebApplication : The following profiles are active: dev 2019-02-12 22:20:19.558 INFO [user-web,,,] 4384 --- [ main] ConfigServletWebServerApplicationContext : Refreshing org.springframework.boot.web.servlet.context.AnnotationConfigServletWebServerApplicationContext@3605c4d3: startup date [Tue Feb 12 22:20:19 CST 2019]; parent: org.springframework.context.annotation.AnnotationConfigApplicationContext@ed3068a 2019-02-12 22:20:20.453 INFO [user-web,,,] 4384 --- [ main] o.s.b.f.s.DefaultListableBeanFactory : Overriding bean definition for bean 'dataSource' with a different definition: replacing [Root bean: class [null]; scope=; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.jdbc.DataSourceConfiguration$Generic; factoryMethodName=dataSource; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/jdbc/DataSourceConfiguration$Generic.class]] with [Root bean: class [null]; scope=; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.jdbc.DataSourceConfiguration$Hikari; factoryMethodName=dataSource; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/jdbc/DataSourceConfiguration$Hikari.class]] 2019-02-12 22:20:21.012 INFO [user-web,,,] 4384 --- [ main] o.s.b.f.s.DefaultListableBeanFactory : Overriding bean definition for bean 'dataSource' with a different definition: replacing [Root bean: class [null]; scope=refresh; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=false; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.jdbc.DataSourceConfiguration$Hikari; factoryMethodName=dataSource; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/jdbc/DataSourceConfiguration$Hikari.class]] with [Root bean: class [org.springframework.aop.scope.ScopedProxyFactoryBean]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null; defined in BeanDefinition defined in class path resource [org/springframework/boot/autoconfigure/jdbc/DataSourceConfiguration$Hikari.class]] 2019-02-12 22:20:21.352 INFO [user-web,,,] 4384 --- [ main] o.s.cloud.context.scope.GenericScope : BeanFactory id=eefe417a-d326-38c1-a6ec-e574932fe959 2019-02-12 22:20:21.490 INFO [user-web,,,] 4384 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'springConfiguration' of type [nickzxing.user.web.config.SpringConfiguration$$EnhancerBySpringCGLIB$$a326ea94] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2019-02-12 22:20:21.935 INFO [user-web,,,] 4384 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration' of type [org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration$$EnhancerBySpringCGLIB$$cab58722] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2019-02-12 22:20:21.999 INFO [user-web,,,] 4384 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration' of type [org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration$$EnhancerBySpringCGLIB$$e6cf8a1f] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2019-02-12 22:20:22.410 INFO [user-web,,,] 4384 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 8080 (http) 2019-02-12 22:20:22.430 INFO [user-web,,,] 4384 --- [ main] o.apache.catalina.core.StandardService : Starting service [Tomcat] 2019-02-12 22:20:22.430 INFO [user-web,,,] 4384 --- [ main] org.apache.catalina.core.StandardEngine : Starting Servlet Engine: Apache Tomcat/8.5.31 2019-02-12 22:20:22.435 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.a.catalina.core.AprLifecycleListener : The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: [C:\Program Files\Java\jdk1.8.0_131\bin;C:\WINDOWS\Sun\Java\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\ProgramData\Oracle\Java\javapath;C:\Program Files (x86)\Intel\iCLS Client\;C:\Program Files\Intel\iCLS Client\;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\IPT;C:\Program Files\Intel\Intel(R) Management Engine Components\IPT;C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\Program Files\Intel\WiFi\bin\;C:\Program Files\Common Files\Intel\WirelessCommon\;C:\Program Files\TortoiseGit\bin;%M2_HOME%\bin;C:\Program Files\TortoiseSVN\bin;C:\Program Files\MySQL\MySQL Utilities 1.6\;C:\Program Files (x86)\GtkSharp\2.12\bin;C:\Program Files\nodejs\;%GIT_HOME%\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\WINDOWS\System32\WindowsPowerShell\v1.0\;C:\WINDOWS\System32\OpenSSH\;C:\Program Files\Redis\;%ZOOKEEPER_HOME%\bin;C:\Users\44804\AppData\Local\Microsoft\WindowsApps;C:\Users\44804\AppData\Roaming\npm;;.] 2019-02-12 22:20:22.583 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext 2019-02-12 22:20:22.583 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.web.context.ContextLoader : Root WebApplicationContext: initialization completed in 3025 ms 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'characterEncodingFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'tracingFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'exceptionLoggingFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'hiddenHttpMethodFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'httpPutFormContentFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'requestContextFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'httpTraceFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'webMvcMetricsFilter' to: [/] 2019-02-12 22:20:25.642 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.ServletRegistrationBean : Servlet dispatcherServlet mapped to [/] 2019-02-12 22:20:25.755 INFO [user-web,,,] 4384 --- [ main] com.zaxxer.hikari.HikariDataSource : DatebookHikariCP - Starting... 2019-02-12 22:20:25.862 INFO [user-web,,,] 4384 --- [ main] com.zaxxer.hikari.HikariDataSource : DatebookHikariCP - Start completed. 2019-02-12 22:20:25.917 INFO [user-web,,,] 4384 --- [ main] j.LocalContainerEntityManagerFactoryBean : Building JPA container EntityManagerFactory for persistence unit 'default' 2019-02-12 22:20:25.931 INFO [user-web,,,] 4384 --- [ main] o.hibernate.jpa.internal.util.LogHelper : HHH000204: Processing PersistenceUnitInfo [ name: default ...] 2019-02-12 22:20:26.073 INFO [user-web,,,] 4384 --- [ main] org.hibernate.Version : HHH000412: Hibernate Core {5.2.17.Final} 2019-02-12 22:20:26.076 INFO [user-web,,,] 4384 --- [ main] org.hibernate.cfg.Environment : HHH000206: hibernate.properties not found 2019-02-12 22:20:26.126 INFO [user-web,,,] 4384 --- [ main] o.hibernate.annotations.common.Version : HCANN000001: Hibernate Commons Annotations {5.0.1.Final} 2019-02-12 22:20:26.294 INFO [user-web,,,] 4384 --- [ main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.hibernate.dialect.H2Dialect Hibernate: create table user_table (id bigint not null, password varchar(255), username varchar(255), primary key (id)) Hibernate: create sequence hibernate_sequence start with 1 increment by 1 2019-02-12 22:20:27.143 INFO [user-web,,,] 4384 --- [ main] j.LocalContainerEntityManagerFactoryBean : Initialized JPA EntityManagerFactory for persistence unit 'default' 2019-02-12 22:20:27.297 INFO [user-web,,,] 4384 --- [ main] o.s.jdbc.datasource.init.ScriptUtils : Executing SQL script from class path resource [data/data.sql] 2019-02-12 22:20:27.299 INFO [user-web,,,] 4384 --- [ main] o.s.jdbc.datasource.init.ScriptUtils : Executed SQL script from class path resource [data/data.sql] in 2 ms. 2019-02-12 22:20:28.019 INFO [user-web,,,] 4384 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [//favicon.ico] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2019-02-12 22:20:28.440 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerAdapter : Looking for @ControllerAdvice: org.springframework.boot.web.servlet.context.AnnotationConfigServletWebServerApplicationContext@3605c4d3: startup date [Tue Feb 12 22:20:19 CST 2019]; parent: org.springframework.context.annotation.AnnotationConfigApplicationContext@ed3068a 2019-02-12 22:20:28.482 WARN [user-web,,,] 4384 --- [ main] aWebConfiguration$JpaWebMvcConfiguration : spring.jpa.open-in-view is enabled by default. Therefore, database queries may be performed during view rendering. Explicitly configure spring.jpa.open-in-view to disable this warning 2019-02-12 22:20:28.529 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/save],methods=[POST]}" onto public abstract nickzxing.user.api.pojo.vo.UserVO nickzxing.user.api.UserAPI.save(nickzxing.user.api.pojo.bo.UserBO) 2019-02-12 22:20:28.530 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/delete_by_id],methods=[GET]}" onto public abstract java.lang.Integer nickzxing.user.api.UserAPI.deleteById(java.lang.Long) 2019-02-12 22:20:28.530 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/get_by_id],methods=[GET]}" onto public abstract nickzxing.user.api.pojo.vo.UserVO nickzxing.user.api.UserAPI.getById(java.lang.Long) 2019-02-12 22:20:28.531 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/batch_save],methods=[POST]}" onto public abstract java.util.List nickzxing.user.api.UserAPI.batchSave(java.util.List) 2019-02-12 22:20:28.531 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/list_by_query],methods=[POST]}" onto public abstract java.util.List nickzxing.user.api.UserAPI.listByQuery(nickzxing.user.api.pojo.query.UserQuery) 2019-02-12 22:20:28.532 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error]}" onto public java.lang.String nickzxing.user.web.handle.ErrorControllerHandler.error(javax.servlet.http.HttpServletResponse) 2019-02-12 22:20:28.586 INFO [user-web,,,] 4384 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/webjars/] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2019-02-12 22:20:28.586 INFO [user-web,,,] 4384 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/**] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2019-02-12 22:20:28.611 INFO [user-web,,,] 4384 --- [ main] .m.m.a.ExceptionHandlerExceptionResolver : Detected @ExceptionHandler methods in globalExceptionHandler 2019-02-12 22:20:31.178 INFO [user-web,,,] 4384 --- [ main] o.s.b.a.e.web.EndpointLinksResolver : Exposing 17 endpoint(s) beneath base path '/actuator' 2019-02-12 22:20:31.231 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/auditevents],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.235 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/beans],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.236 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/health],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.237 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/conditions],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.238 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/configprops],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.239 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.240 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env/{toMatch}],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.243 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env],methods=[POST],consumes=[application/vnd.spring-boot.actuator.v2+json || application/json],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.245 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env],methods=[DELETE],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.246 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/info],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.246 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/loggers],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.247 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/loggers/{name}],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.248 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/loggers/{name}],methods=[POST],consumes=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.249 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/heapdump],methods=[GET],produces=[application/octet-stream]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.250 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/threaddump],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.251 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/metrics],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.252 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/metrics/{requiredMetricName}],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.253 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/scheduledtasks],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.254 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/httptrace],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.256 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/mappings],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.257 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/nacos-config],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.258 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/refresh],methods=[POST],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.259 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/features],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.261 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto protected java.util.Map<java.lang.String, java.util.Map<java.lang.String, org.springframework.boot.actuate.endpoint.web.Link>> org.springframework.boot.actuate.endpoint.web.servlet.WebMvcEndpointHandlerMapping.links(javax.servlet.http.HttpServletRequest,javax.servlet.http.HttpServletResponse) 2019-02-12 22:20:31.458 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Registering beans for JMX exposure on startup 2019-02-12 22:20:31.459 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Bean with name 'dataSource' has been autodetected for JMX exposure 2019-02-12 22:20:31.467 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Bean with name 'environmentManager' has been autodetected for JMX exposure 2019-02-12 22:20:31.469 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Bean with name 'refreshScope' has been autodetected for JMX exposure 2019-02-12 22:20:31.469 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Bean with name 'configurationPropertiesRebinder' has been autodetected for JMX exposure 2019-02-12 22:20:31.473 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Located managed bean 'environmentManager': registering with JMX server as MBean [org.springframework.cloud.context.environment:name=environmentManager,type=EnvironmentManager] 2019-02-12 22:20:31.482 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Located managed bean 'refreshScope': registering with JMX server as MBean [org.springframework.cloud.context.scope.refresh:name=refreshScope,type=RefreshScope] 2019-02-12 22:20:31.494 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Located managed bean 'configurationPropertiesRebinder': registering with JMX server as MBean [org.springframework.cloud.context.properties:name=configurationPropertiesRebinder,context=3605c4d3,type=ConfigurationPropertiesRebinder] 2019-02-12 22:20:31.500 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Located MBean 'dataSource': registering with JMX server as MBean [com.zaxxer.hikari:name=dataSource,type=HikariDataSource] 2019-02-12 22:20:31.647 INFO [user-web,,,] 4384 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port(s): 8080 (http) with context path '' 2019-02-12 22:20:31.658 INFO [user-web,,,] 4384 --- [ main] nickzxing.user.web.UserWebApplication : Started UserWebApplication in 15.368 seconds (JVM running for 16.765) 2019-02-12 22:20:31.674 INFO [user-web,,,] 4384 --- [ main] c.a.n.client.config.impl.ClientWorker : [fixed-192.168.1.20_8848] [] [] [subscribe] user-web.yml+DEFAULT_GROUP 2019-02-12 22:20:31.676 INFO [user-web,,,] 4384 --- [ main] c.a.nacos.client.config.impl.CacheData : [fixed-192.168.1.20_8848] [] [] [add-listener] ok, tenant=, dataId=user-web.yml, group=DEFAULT_GROUP, cnt=1 2019-02-12 22:20:31.678 INFO [user-web,,,] 4384 --- [ main] c.a.n.client.config.impl.ClientWorker : [fixed-192.168.1.20_8848] [] [] [subscribe] user-web-dev.yml+DEFAULT_GROUP 2019-02-12 22:20:31.679 INFO [user-web,,,] 4384 --- [ main] c.a.nacos.client.config.impl.CacheData : [fixed-192.168.1.20_8848] [] [] [add-listener] ok, tenant=, dataId=user-web-dev.yml, group=DEFAULT_GROUP, cnt=1 2019-02-12 22:20:32.625 INFO [user-web,,,] 4384 --- [n(14)-127.0.0.1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring FrameworkServlet 'dispatcherServlet' 2019-02-12 22:20:32.625 INFO [user-web,,,] 4384 --- [n(14)-127.0.0.1] o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization started 2019-02-12 22:20:32.671 INFO [user-web,,,] 4384 --- [n(14)-127.0.0.1] o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization completed in 46 ms 2019-02-12 22:20:32.884 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] s.c.a.AnnotationConfigApplicationContext : Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@7cea5e9: startup date [Tue Feb 12 22:20:32 CST 2019]; root of context hierarchy 2019-02-12 22:20:32.923 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] trationDelegate$BeanPostProcessorChecker : Bean 'configurationPropertiesRebinderAutoConfiguration' of type [org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration$$EnhancerBySpringCGLIB$$e6cf8a1f] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2019-02-12 22:20:34.821 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] o.s.c.a.n.c.NacosPropertySourceBuilder : Loading nacos data, dataId: 'user-web-dev.yml', group: 'DEFAULT_GROUP' 2019-02-12 22:20:34.823 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] b.c.PropertySourceBootstrapConfiguration : Located property source: CompositePropertySource {name='NACOS', propertySources=[NacosPropertySource {name='user-web-dev.yml'}, NacosPropertySource {name='user-web.yml'}]} 2019-02-12 22:20:34.870 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] o.s.boot.SpringApplication : The following profiles are active: dev 2019-02-12 22:20:34.874 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] s.c.a.AnnotationConfigApplicationContext : Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@273768d4: startup date [Tue Feb 12 22:20:34 CST 2019]; parent: org.springframework.context.annotation.AnnotationConfigApplicationContext@7cea5e9 2019-02-12 22:20:34.942 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] o.s.boot.SpringApplication : Started application in 3.235 seconds (JVM running for 20.051) 2019-02-12 22:20:34.943 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] s.c.a.AnnotationConfigApplicationContext : Closing org.springframework.context.annotation.AnnotationConfigApplicationContext@273768d4: startup date [Tue Feb 12 22:20:34 CST 2019]; parent: org.springframework.context.annotation.AnnotationConfigApplicationContext@7cea5e9 2019-02-12 22:20:34.945 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] s.c.a.AnnotationConfigApplicationContext : Closing org.springframework.context.annotation.AnnotationConfigApplicationContext@7cea5e9: startup date [Tue Feb 12 22:20:32 CST 2019]; root of context hierarchy 2019-02-12 22:20:35.149 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] com.zaxxer.hikari.HikariDataSource : DatebookHikariCP - Shutdown initiated... 2019-02-12 22:20:35.155 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] com.zaxxer.hikari.HikariDataSource : DatebookHikariCP - Shutdown completed. 2019-02-12 22:20:35.158 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] o.s.c.e.event.RefreshEventListener : Refresh keys changed: []

nacos-bot commented 5 years ago

Hi @nickzxing, we detect non-English characters in the issue. This comment is an auto translation from @nacos-bot to help other users to understand this issue. We encourage you to describe your issue in English which is more friendly to other users.

After adding the NacosConfig dependency, the Hikari database connection pool is automatically closed when the project is started (see the last three lines of the console output).

Connected to the target VM, address: '127.0.0.1:11073', transport: 'socket' 2019-02-12 22:20:17.713 INFO [user-web,,,] 4384 --- [ main] s.c.a.AnnotationConfigApplicationContext : Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@ed3068a: startup date [Tue Feb 12 22:20:17 CST 2019]; root of context hierarchy 2019-02-12 22:20:18.232 INFO [user-web,,,] 4384 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'configurationPropertiesRebinderAutoConfiguration' of type [org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration$EnhancerBySpringCGLIB$e6cf8a1f] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)

. _ _ /\ / '_ () \ \ \ \ ( ( )\ | ' | '| | ' \/ ` | \ \ \ \ \/ _)| |)| | | | | || (| | ) ) ) ) ' |__| .|| ||| |\, | / / / / =========|_|==============|__/=//// :: Spring Boot :: (v2.0.3.RELEASE)

Tue Feb 12 22:20:19 CST 2019 sun.misc.Launcher$AppClassLoader@18b4aac2 JM.Log:INFO Init JM logger with Slf4jLoggerFactory success, sun.misc.Launcher$AppClassLoader@18b4aac2 Tue Feb 12 22:20:19 CST 2019 sun.misc.Launcher$AppClassLoader@18b4aac2 JM.Log:INFO Log root path: C:\Users\44804\logs\ Tue Feb 12 22:20:19 CST 2019 sun.misc.Launcher$AppClassLoader@18b4aac2 JM.Log:INFO Set nacos log path: C:\Users\44804\logs\nacos 2019-02-12 22:20:19.342 INFO [user-web,,,] 4384 --- [ main] c.a.n.client.identify.CredentialWatcher : [] [] [] No credential found 2019-02-12 22:20:19.479 INFO [user-web,,,] 4384 --- [ main] o.s.c.a.n.c.NacosPropertySourceBuilder : Loading nacos data, dataId: 'user-web-dev.yml', group: 'DEFAULT_GROUP' 2019-02-12 22:20:19.482 INFO [user-web,,,] 4384 --- [ main] b.c.PropertySourceBootstrapConfiguration : Located property source: CompositePropertySource {name='NACOS', propertySources=[NacosPropertySource {name='user-web-dev.yml'}, NacosPropertySource {name='user-web.yml'}]} 2019-02-12 22:20:19.545 INFO [user-web,,,] 4384 --- [ main] nickzxing.user.web.UserWebApplication : The following profiles are active: dev 2019-02-12 22:20:19.558 INFO [user-web,,,] 4384 --- [ main] ConfigServletWebServerApplicationContext : Refreshing org.springframework.boot.web.servlet.context.AnnotationConfigServletWebServerApplicationContext@3605c4d3: startup date [Tue Feb 12 22:20:19 CST 2019]; parent: org.springframework.context.annotation.AnnotationConfigApplicationContext@ed3068a 2019-02-12 22:20:20.453 INFO [user-web,,,] 4384 --- [ main] o.s.b.f.s.DefaultListableBeanFactory : Overriding bean definition for bean 'dataSource' with a different definition: replacing [Root bean: class [null]; scope=; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.jdbc.DataSourceConfiguration$Generic; factoryMethodName=dataSource; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/jdbc/DataSourceConfiguration$Generic.class]] with [Root bean: class [null]; scope=; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.jdbc.DataSourceConfiguration$Hikari; factoryMethodName=dataSource; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/jdbc/DataSourceConfiguration$Hikari.class]] 2019-02-12 22:20:21.012 INFO [user-web,,,] 4384 --- [ main] o.s.b.f.s.DefaultListableBeanFactory : Overriding bean definition for bean 'dataSource' with a different definition: replacing [Root bean: class [null]; scope=refresh; abstract=false; lazyInit=false; autowireMode=3; dependencyCheck=0; autowireCandidate=false; primary=false; factoryBeanName=org.springframework.boot.autoconfigure.jdbc.DataSourceConfiguration$Hikari; factoryMethodName=dataSource; initMethodName=null; destroyMethodName=(inferred); defined in class path resource [org/springframework/boot/autoconfigure/jdbc/DataSourceConfiguration$Hikari.class]] with [Root bean: class [org.springframework.aop.scope.ScopedProxyFactoryBean]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null; defined in BeanDefinition defined in class path resource [org/springframework/boot/autoconfigure/jdbc/DataSourceConfiguration$Hikari.class]] 2019-02-12 22:20:21.352 INFO [user-web,,,] 4384 --- [ main] o.s.cloud.context.scope.GenericScope : BeanFactory id=eefe417a-d326-38c1-a6ec-e574932fe959 2019-02-12 22:20:21.490 INFO [user-web,,,] 4384 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'springConfiguration' of type [nickzxing.user.web.config.SpringConfiguration$EnhancerBySpringCGLIB$a326ea94] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2019-02-12 22:20:21.935 INFO [user-web,,,] 4384 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration' of type [org.springframework.transaction.annotation.ProxyTransactionManagementConfiguration$EnhancerBySpringCGLIB$cab58722] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2019-02-12 22:20:21.999 INFO [user-web,,,] 4384 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration' of type [org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration$EnhancerBySpringCGLIB$e6cf8a1f] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2019-02-12 22:20:22.410 INFO [user-web,,,] 4384 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 8080 (http) 2019-02-12 22:20:22.430 INFO [user-web,,,] 4384 --- [ main] o.apache.catalina.core.StandardService : Starting service [Tomcat] 2019-02-12 22:20:22.430 INFO [user-web,,,] 4384 --- [ main] org.apache.catalina.core.StandardEngine : Starting Servlet Engine: Apache Tomcat/8.5.31 2019-02-12 22:20:22.435 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.a.catalina.core.AprLifecycleListener : The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: [C:\Program Files\Java\jdk1.8.0_131\bin;C:\WINDOWS\Sun\Java\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\ProgramData\Oracle\Java\javapath;C:\Program Files (x86)\Intel\iCLS Client\;C:\Program Files\Intel\iCLS Client\;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\IPT;C:\Program Files\Intel\Intel(R) Management Engine Components\IPT;C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\Program Files\Intel\WiFi\bin\;C:\Program Files\Common Files\Intel\WirelessCommon\;C:\Program Files\TortoiseGit\bin;%M2_HOME%\bin;C:\Program Files\TortoiseSVN\bin;C:\Program Files\MySQL\MySQL Utilities 1.6\;C:\Program Files (x86)\GtkSharp\2.12\bin;C:\Program Files\nodejs\;%GIT_HOME%\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\WINDOWS\System32\WindowsPowerShell\v1.0\;C:\WINDOWS\System32\OpenSSH\;C:\Program Files\Redis\;%ZOOKEEPER_HOME%\bin;C:\Users\44804\AppData\Local\Microsoft\WindowsApps;C:\Users\44804\AppData\Roaming\npm;;.] 2019-02-12 22:20:22.583 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext 2019-02-12 22:20:22.583 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.web.context.ContextLoader : Root WebApplicationContext: initialization completed in 3025 ms 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'characterEncodingFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'tracingFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'exceptionLoggingFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'hiddenHttpMethodFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'httpPutFormContentFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'requestContextFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'httpTraceFilter' to: [/] 2019-02-12 22:20:25.641 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'webMvcMetricsFilter' to: [/] 2019-02-12 22:20:25.642 INFO [user-web,,,] 4384 --- [ost-startStop-1] o.s.b.w.servlet.ServletRegistrationBean : Servlet dispatcherServlet mapped to [/] 2019-02-12 22:20:25.755 INFO [user-web,,,] 4384 --- [ main] com.zaxxer.hikari.HikariDataSource : DatebookHikariCP - Starting... 2019-02-12 22:20:25.862 INFO [user-web,,,] 4384 --- [ main] com.zaxxer.hikari.HikariDataSource : DatebookHikariCP - Start completed. 2019-02-12 22:20:25.917 INFO [user-web,,,] 4384 --- [ main] j.LocalContainerEntityManagerFactoryBean : Building JPA container EntityManagerFactory for persistence unit 'default' 2019-02-12 22:20:25.931 INFO [user-web,,,] 4384 --- [ main] o.hibernate.jpa.internal.util.LogHelper : HHH000204: Processing PersistenceUnitInfo [ name: default ...] 2019-02-12 22:20:26.073 INFO [user-web,,,] 4384 --- [ main] org.hibernate.Version : HHH000412: Hibernate Core {5.2.17.Final} 2019-02-12 22:20:26.076 INFO [user-web,,,] 4384 --- [ main] org.hibernate.cfg.Environment : HHH000206: hibernate.properties not found 2019-02-12 22:20:26.126 INFO [user-web,,,] 4384 --- [ main] o.hibernate.annotations.common.Version : HCANN000001: Hibernate Commons Annotations {5.0.1.Final} 2019-02-12 22:20:26.294 INFO [user-web,,,] 4384 --- [ main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.hibernate.dialect.H2Dialect Hibernate: create table user_table (id bigint not null, password varchar(255), username varchar(255), primary key (id)) Hibernate: create sequence hibernate_sequence start with 1 increment by 1 2019-02-12 22:20:27.143 INFO [user-web,,,] 4384 --- [ main] j.LocalContainerEntityManagerFactoryBean : Initialized JPA EntityManagerFactory for persistence unit 'default' 2019-02-12 22:20:27.297 INFO [user-web,,,] 4384 --- [ main] o.s.jdbc.datasource.init.ScriptUtils : Executing SQL script from class path resource [data/data.sql] 2019-02-12 22:20:27.299 INFO [user-web,,,] 4384 --- [ main] o.s.jdbc.datasource.init.ScriptUtils : Executed SQL script from class path resource [data/data.sql] in 2 ms. 2019-02-12 22:20:28.019 INFO [user-web,,,] 4384 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [//favicon.ico] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2019-02-12 22:20:28.440 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerAdapter : Looking for @ControllerAdvice: org.springframework.boot.web.servlet.context.AnnotationConfigServletWebServerApplicationContext@3605c4d3: startup date [Tue Feb 12 22:20:19 CST 2019]; parent: org.springframework.context.annotation.AnnotationConfigApplicationContext@ed3068a 2019-02-12 22:20:28.482 WARN [user-web,,,] 4384 --- [ main] aWebConfiguration$JpaWebMvcConfiguration : spring.jpa.open-in-view is enabled by default. Therefore, database queries may be performed during view rendering. Explicitly configure spring.jpa.open-in-view to disable this warning 2019-02-12 22:20:28.529 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/save],methods=[POST]}" onto public abstract nickzxing.user.api.pojo.vo.UserVO nickzxing.user.api.UserAPI.save(nickzxing.user.api.pojo.bo.UserBO) 2019-02-12 22:20:28.530 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/delete_by_id],methods=[GET]}" onto public abstract java.lang.Integer nickzxing.user.api.UserAPI.deleteById(java.lang.Long) 2019-02-12 22:20:28.530 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/get_by_id],methods=[GET]}" onto public abstract nickzxing.user.api.pojo.vo.UserVO nickzxing.user.api.UserAPI.getById(java.lang.Long) 2019-02-12 22:20:28.531 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/batch_save],methods=[POST]}" onto public abstract java.util.List nickzxing.user.api.UserAPI.batchSave(java.util.List) 2019-02-12 22:20:28.531 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/user/list_by_query],methods=[POST]}" onto public abstract java.util.List nickzxing.user.api.UserAPI.listByQuery(nickzxing.user.api.pojo.query.UserQuery) 2019-02-12 22:20:28.532 INFO [user-web,,,] 4384 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error]}" onto public java.lang.String nickzxing.user.web.handle.ErrorControllerHandler.error(javax.servlet.http.HttpServletResponse) 2019-02-12 22:20:28.586 INFO [user-web,,,] 4384 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/webjars/] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2019-02-12 22:20:28.586 INFO [user-web,,,] 4384 --- [ main] o.s.w.s.handler.SimpleUrlHandlerMapping : Mapped URL path [/**] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler] 2019-02-12 22:20:28.611 INFO [user-web,,,] 4384 --- [ main] .m.m.a.ExceptionHandlerExceptionResolver : Detected @ExceptionHandler methods in globalExceptionHandler 2019-02-12 22:20:31.178 INFO [user-web,,,] 4384 --- [ main] o.s.b.a.e.web.EndpointLinksResolver : Exposing 17 endpoint(s) beneath base path '/actuator' 2019-02-12 22:20:31.231 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/auditevents],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.235 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/beans],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.236 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/health],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.237 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/conditions],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.238 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/configprops],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.239 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.240 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env/{toMatch}],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.243 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env],methods=[POST],consumes=[application/vnd.spring-boot.actuator.v2+json || application/json],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.245 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env],methods=[DELETE],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.246 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/info],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.246 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/loggers],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.247 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/loggers/{name}],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.248 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/loggers/{name}],methods=[POST],consumes=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.249 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/heapdump],methods=[GET],produces=[application/octet-stream]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.250 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/threaddump],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.251 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/metrics],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.252 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/metrics/{requiredMetricName}],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.253 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/scheduledtasks],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.254 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/httptrace],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.256 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/mappings],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.257 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/nacos-config],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.258 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/refresh],methods=[POST],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.259 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/features],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map<java.lang.String, java.lang.String>) 2019-02-12 22:20:31.261 INFO [user-web,,,] 4384 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto protected java.util.Map<java.lang.String, java.util.Map<java.lang.String, org.springframework.boot.actuate.endpoint.web.Link>> org.springframework.boot.actuate.endpoint.web.servlet.WebMvcEndpointHandlerMapping.links(javax.servlet.http.HttpServletRequest,javax.servlet.http.HttpServletResponse) 2019-02-12 22:20:31.458 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Registering beans for JMX exposure on startup 2019-02-12 22:20:31.459 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Bean with name 'dataSource' has been autodetected for JMX exposure 2019-02-12 22:20:31.467 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Bean with name 'environmentManager' has been autodetected for JMX exposure 2019-02-12 22:20:31.469 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Bean with name 'refreshScope' has been autodetected for JMX exposure 2019-02-12 22:20:31.469 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Bean with name 'configurationPropertiesRebinder' has been autodetected for JMX exposure 2019-02-12 22:20:31.473 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Located managed bean 'environmentManager': registering with JMX server as MBean [org.springframework.cloud.context.environment:name=environmentManager,type=EnvironmentManager] 2019-02-12 22:20:31.482 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Located managed bean 'refreshScope': registering with JMX server as MBean [org.springframework.cloud.context.scope.refresh:name=refreshScope,type=RefreshScope] 2019-02-12 22:20:31.494 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Located managed bean 'configurationPropertiesRebinder': registering with JMX server as MBean [org.springframework.cloud.context.properties:name=configurationPropertiesRebinder,context=3605c4d3,type=ConfigurationPropertiesRebinder] 2019-02-12 22:20:31.500 INFO [user-web,,,] 4384 --- [ main] o.s.j.e.a.AnnotationMBeanExporter : Located MBean 'dataSource': registering with JMX server as MBean [com.zaxxer.hikari:name=dataSource,type=HikariDataSource] 2019-02-12 22:20:31.647 INFO [user-web,,,] 4384 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port(s): 8080 (http) with context path '' 2019-02-12 22:20:31.658 INFO [user-web,,,] 4384 --- [ main] nickzxing.user.web.UserWebApplication : Started UserWebApplication in 15.368 seconds (JVM running for 16.765) 2019-02-12 22:20:31.674 INFO [user-web,,,] 4384 --- [ main] c.a.n.client.config.impl.ClientWorker : [fixed-192.168.1.20_8848] [] [] [subscribe] user-web.yml+DEFAULT_GROUP 2019-02-12 22:20:31.676 INFO [user-web,,,] 4384 --- [ main] c.a.nacos.client.config.impl.CacheData : [fixed-192.168.1.20_8848] [] [] [add-listener] ok, tenant=, dataId=user-web.yml, group=DEFAULT_GROUP, cnt=1 2019-02-12 22:20:31.678 INFO [user-web,,,] 4384 --- [ main] c.a.n.client.config.impl.ClientWorker : [fixed-192.168.1.20_8848] [] [] [subscribe] user-web-dev.yml+DEFAULT_GROUP 2019-02-12 22:20:31.679 INFO [user-web,,,] 4384 --- [ main] c.a.nacos.client.config.impl.CacheData : [fixed-192.168.1.20_8848] [] [] [add-listener] ok, tenant=, dataId=user-web-dev.yml, group=DEFAULT_GROUP, cnt=1 2019-02-12 22:20:32.625 INFO [user-web,,,] 4384 --- [n(14)-127.0.0.1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring FrameworkServlet 'dispatcherServlet' 2019-02-12 22:20:32.625 INFO [user-web,,,] 4384 --- [n(14)-127.0.0.1] o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization started 2019-02-12 22:20:32.671 INFO [user-web,,,] 4384 --- [n(14)-127.0.0.1] o.s.web.servlet.DispatcherServlet : FrameworkServlet 'dispatcherServlet': initialization completed in 46 ms 2019-02-12 22:20:32.884 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] s.c.a.AnnotationConfigApplicationContext : Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@7cea5e9: startup date [Tue Feb 12 22:20:32 CST 2019]; root of context hierarchy 2019-02-12 22:20:32.923 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] trationDelegate$BeanPostProcessorChecker : Bean 'configurationPropertiesRebinderAutoConfiguration' of type [org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration$EnhancerBySpringCGLIB$e6cf8a1f] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2019-02-12 22:20:34.821 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] o.s.c.a.n.c.NacosPropertySourceBuilder : Loading nacos data, dataId: 'user-web-dev.yml', group: 'DEFAULT_GROUP' 2019-02-12 22:20:34.823 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] b.c.PropertySourceBootstrapConfiguration : Located property source: CompositePropertySource {name='NACOS', propertySources=[NacosPropertySource {name='user-web-dev.yml'}, NacosPropertySource {name='user-web.yml'}]} 2019-02-12 22:20:34.870 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] o.s.boot.SpringApplication : The following profiles are active: dev 2019-02-12 22:20:34.874 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] s.c.a.AnnotationConfigApplicationContext : Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@273768d4: startup date [Tue Feb 12 22:20:34 CST 2019]; parent: org.springframework.context.annotation.AnnotationConfigApplicationContext@7cea5e9 2019-02-12 22:20:34.942 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] o.s.boot.SpringApplication : Started application in 3.235 seconds (JVM running for 20.051) 2019-02-12 22:20:34.943 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] s.c.a.AnnotationConfigApplicationContext : Closing org.springframework.context.annotation.AnnotationConfigApplicationContext@273768d4: startup date [Tue Feb 12 22:20:34 CST 2019]; parent: org.springframework.context.annotation.AnnotationConfigApplicationContext@7cea5e9 2019-02-12 22:20:34.945 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] s.c.a.AnnotationConfigApplicationContext : Closing org.springframework.context.annotation.AnnotationConfigApplicationContext@7cea5e9: startup date [Tue Feb 12 22:20:32 CST 2019]; root of context hierarchy 2019-02-12 22:20:35.149 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] com.zaxxer.hikari.HikariDataSource : DatebookHikariCP - Shutdown initiated... 2019-02-12 22:20:35.155 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] com.zaxxer.hikari.HikariDataSource : DatebookHikariCP - Shutdown completed. 2019-02-12 22:20:35.158 INFO [user-web,,,] 4384 --- [2.168.1.20_8848] o.s.c.e.event.RefreshEventListener : Refresh keys changed: []

hxy1991 commented 5 years ago

目前，Nacos 添加监控器是会调用 Listener.receiveConfigInfo 方法。

Nacos Spring Cloud 的 NacosContextRefresher 在 Listener.receiveConfigInfo 方法里触发一个 RefreshEvent，其会被 org.springframework.cloud.context.refresh.ContextRefresher 处理，继而调用到将所有 scope=refresh 的 Bean 的 destroy 方法。

而在 Spring Cloud 下 com.zaxxer.hikari.HikariDataSource 的 scope 默认就是 refresh 的，所以会出现关闭数据库连接池的日志。不过这个日志不影响程序的正常运行，当程序运行需要连接到数据库时，会重新初始化一个 HikariDataSource 实例。

xlb commented 5 years ago

@hxy1991 但是如果我用单元测试（一个使用事务的足够长的连接），一旦程序启动完就会开始执行，这时候由于进行了ContextRefresher ，导致最后在事务提交阶段提示HikariDataSource已经不存在了。我看了下源码，nacos最开始会将本地的配置文件同nacos端的比较，但是最开始没有进行MD5 校验，导致认为第一次拉下来的是过期的（com.alibaba.nacos.client.config.impl.CacheData的 checkListenerMd5），那能不能把第一次加载进来的md5直接计算下呢，因为本来就是一样的

xlb commented 5 years ago

@hxy1991 比如我暂时改成这样，没有看到什么问题；

void checkListenerMd5() {
    for (ManagerListenerWrap wrap : listeners) {
        if(wrap.lastCallMd5=="" ||wrap.lastCallMd5==null)  //最开始lastmd5是空字符串
        {
            wrap.lastCallMd5=md5;
        }
        if (!md5.equals(wrap.lastCallMd5)) {
            safeNotifyListener(dataId, group, content, md5, wrap);
        }
    }
}