由浅入深写java分布式(4)基于注解 dubbo 一个app同时存在consumer和provider自启动失败的问题，以dubbo和spring注解加载顺序的问题

问题描述：

将提供者和消费者写再同一个项目，要么提前启动一个纯的提供者app。否则会rpc调用失败。

解决过程：

通过dubbo admin观察要么再linux上只启动成功消费者 要么再windows启动有消费者和生产者，但是调用失败。

一开始分析是@Reference 在spring被dubbo注入的时候没有spring的已经注入结束了，造成NPE。但是这个问题之前用将@Reference注解的接口引用放在spring的service查下就可以避免。还有人说@Reference注解check属性为false,说dubbo注解有坑。

测试如下

linux启动报错

2017-02-18 19:34:49.530  INFO 5908 --- [           main] c.a.dubbo.common.logger.LoggerFactory    : using logger: com.alibaba.dubbo.common.logger.slf4j.Slf4jLoggerAdapter2017-02-18 19:34:49.726  INFO 5908 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Load registry store file /root/.dubbo/dubbo-registry-123.56.13.70.cache, data: {com.sincetimes.website.app.jedis.JedisService:myversion=empty://172.17.251.157:20880/com.sincetimes.website.app.jedis.JedisService?anyhost=true&application=testApp&category=configurators&check=false&dubbo=2.5.3&interface=com.sincetimes.website.app.jedis.JedisService&methods=zrange,incrBy,hgetall,set,zincrby,getSet,incr,zscore,del,hset,rpoplpush,rpush,get,hsetnx,zrem,llen,hget,zadd&pid=11218&proxy=javassist&retries=3&revision=myversion&side=provider&timeout=5000×tamp=1487150079387&version=myversion, com.sincetimes.website.app.rpc.dubbo.IHelloDubboService:1.0.0=empty://123.56.13.70:20882/com.sincetimes.website.app.rpc.dubbo.IHelloDubboService?anyhost=true&application=application_hello&category=configurators&check=false&default.delay=-1&default.retries=1&default.timeout=3000&delay=-1&dubbo=2.5.3&interface=com.sincetimes.website.app.rpc.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=27722&revision=1.0.0&side=provider&threads=200×tamp=1487314187978&version=1.0.0, com.williamy.dubbo.IHelloDubboService:1.0.0=empty://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=configurators&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5641&revision=1.0.0&side=consumer×tamp=1487416289082&version=1.0.0 empty://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=routers&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5641&revision=1.0.0&side=consumer×tamp=1487416289082&version=1.0.0 dubbo://123.56.13.70:20886/com.williamy.dubbo.IHelloDubboService?anyhost=true&application=application_hello&default.delay=-1&default.retries=1&default.timeout=3000&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5641&revision=1.0.0&side=provider&threads=200×tamp=1487416289883&version=1.0.0, com.sincetimes.website.app.rpc.dubbo.DubboTestService:myversion=empty://172.17.251.157:20880/com.sincetimes.website.app.rpc.dubbo.DubboTestService?anyhost=true&application=testApp&category=configurators&check=false&dubbo=2.5.3&interface=com.sincetimes.website.app.rpc.dubbo.DubboTestService&methods=getInfos&pid=13344&proxy=javassist&retries=3&revision=myversion&side=provider&timeout=5000×tamp=1487169440677&version=myversion}, dubbo version: 2.5.3, current host: 127.0.0.12017-02-18 19:34:49.796  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:zookeeper.version=3.4.9-1757313, built on 08/23/2016 06:50 GMT2017-02-18 19:34:49.803  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:host.name=iZ2zei0nwllapkwklisoncZ2017-02-18 19:34:49.804  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.version=1.8.0_912017-02-18 19:34:49.804  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.vendor=Oracle Corporation2017-02-18 19:34:49.805  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.home=/usr/local/services/jdk1.8.0_91/jre2017-02-18 19:34:49.805  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.class.path=/usr/local/services/apache-maven-3.3.9/boot/plexus-classworlds-2.5.2.jar2017-02-18 19:34:49.809  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.library.path=/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib2017-02-18 19:34:49.809  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.io.tmpdir=/tmp2017-02-18 19:34:49.810  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.compiler=<NA>2017-02-18 19:34:49.810  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:os.name=Linux2017-02-18 19:34:49.810  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:os.arch=amd642017-02-18 19:34:49.810  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:os.version=3.10.0-327.22.2.el7.x86_642017-02-18 19:34:49.810  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:user.name=root2017-02-18 19:34:49.810  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:user.home=/root2017-02-18 19:34:49.811  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:user.dir=/data/git_workspace/springboot_dubbo_consumer2017-02-18 19:34:49.813  INFO 5908 --- [           main] org.apache.zookeeper.ZooKeeper           : Initiating client connection, connectString=123.56.13.70:2181 sessionTimeout=30000 watcher=org.I0Itec.zkclient.ZkClient@526bb3fe2017-02-18 19:34:49.871  INFO 5908 --- [.56.13.70:2181)] org.apache.zookeeper.ClientCnxn          : Opening socket connection to server 123.56.13.70/123.56.13.70:2181. Will not attempt to authenticate using SASL (unknown error)2017-02-18 19:34:49.947  INFO 5908 --- [.56.13.70:2181)] org.apache.zookeeper.ClientCnxn          : Socket connection established to 123.56.13.70/123.56.13.70:2181, initiating session2017-02-18 19:34:49.969  INFO 5908 --- [.56.13.70:2181)] org.apache.zookeeper.ClientCnxn          : Session establishment complete on server 123.56.13.70/123.56.13.70:2181, sessionid = 0x15a4a890024004d, negotiated timeout = 300002017-02-18 19:34:50.069  INFO 5908 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Register: consumer://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=consumers&check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5908&revision=1.0.0&side=consumer×tamp=1487417689536&version=1.0.0, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:34:50.120  INFO 5908 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Subscribe: consumer://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=providers,configurators,routers&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5908&revision=1.0.0&side=consumer×tamp=1487417689536&version=1.0.0, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:34:50.189  INFO 5908 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Notify urls for subscribe url consumer://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=providers,configurators,routers&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5908&revision=1.0.0&side=consumer×tamp=1487417689536&version=1.0.0, urls: [empty://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=providers&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5908&revision=1.0.0&side=consumer×tamp=1487417689536&version=1.0.0, empty://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=configurators&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5908&revision=1.0.0&side=consumer×tamp=1487417689536&version=1.0.0, empty://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=routers&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5908&revision=1.0.0&side=consumer×tamp=1487417689536&version=1.0.0], dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:34:50.223 ERROR 5908 --- [           main] com.alibaba.dubbo.common.logger.Logger   :  [DUBBO] Failed to init remote service reference at filed helloservice in class com.williamy.dubbo.DubboServiceHandler, cause: Failed to check the status of the service com.williamy.dubbo.IHelloDubboService. No provider available for the service com.williamy.dubbo.IHelloDubboService:1.0.0 from the url zookeeper://123.56.13.70:2181/com.alibaba.dubbo.registry.RegistryService?application=application_hello&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5908&revision=1.0.0&side=consumer×tamp=1487417689536&version=1.0.0 to the consumer 123.56.13.70 use dubbo version 2.5.3, dubbo version: 2.5.3, current host: 123.56.13.70java.lang.IllegalStateException: Failed to check the status of the service com.williamy.dubbo.IHelloDubboService. No provider available for the service com.williamy.dubbo.IHelloDubboService:1.0.0 from the url zookeeper://123.56.13.70:2181/com.alibaba.dubbo.registry.RegistryService?application=application_hello&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5908&revision=1.0.0&side=consumer×tamp=1487417689536&version=1.0.0 to the consumer 123.56.13.70 use dubbo version 2.5.3at com.alibaba.dubbo.config.ReferenceConfig.createProxy(ReferenceConfig.java:420) ~[dubbo-2.5.3.jar:2.5.3]at com.alibaba.dubbo.config.ReferenceConfig.init(ReferenceConfig.java:300) ~[dubbo-2.5.3.jar:2.5.3]at com.alibaba.dubbo.config.ReferenceConfig.get(ReferenceConfig.java:138) ~[dubbo-2.5.3.jar:2.5.3]at com.alibaba.dubbo.config.spring.AnnotationBean.refer(AnnotationBean.java:302) ~[dubbo-2.5.3.jar:2.5.3]at com.alibaba.dubbo.config.spring.AnnotationBean.postProcessBeforeInitialization(AnnotationBean.java:233) ~[dubbo-2.5.3.jar:2.5.3]at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.applyBeanPostProcessorsBeforeInitialization(AbstractAutowireCapableBeanFactory.java:408) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1570) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:545) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:482) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:306) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:302) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.DefaultListableBeanFactory.findAutowireCandidates(DefaultListableBeanFactory.java:1192) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.DefaultListableBeanFactory.doResolveDependency(DefaultListableBeanFactory.java:1116) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.DefaultListableBeanFactory.resolveDependency(DefaultListableBeanFactory.java:1014) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.annotation.AutowiredAnnotationBeanPostProcessor$AutowiredFieldElement.inject(AutowiredAnnotationBeanPostProcessor.java:545) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.annotation.InjectionMetadata.inject(InjectionMetadata.java:88) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.annotation.AutowiredAnnotationBeanPostProcessor.postProcessPropertyValues(AutowiredAnnotationBeanPostProcessor.java:331) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.populateBean(AbstractAutowireCapableBeanFactory.java:1214) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:543) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:482) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:306) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:302) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:772) [spring-beans-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:839) [spring-context-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:538) [spring-context-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.boot.context.embedded.EmbeddedWebApplicationContext.refresh(EmbeddedWebApplicationContext.java:118) [spring-boot-1.3.5.RELEASE.jar:1.3.5.RELEASE]at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:766) [spring-boot-1.3.5.RELEASE.jar:1.3.5.RELEASE]at org.springframework.boot.SpringApplication.createAndRefreshContext(SpringApplication.java:361) [spring-boot-1.3.5.RELEASE.jar:1.3.5.RELEASE]at org.springframework.boot.SpringApplication.run(SpringApplication.java:307) [spring-boot-1.3.5.RELEASE.jar:1.3.5.RELEASE]at org.springframework.boot.SpringApplication.run(SpringApplication.java:1191) [spring-boot-1.3.5.RELEASE.jar:1.3.5.RELEASE]at org.springframework.boot.SpringApplication.run(SpringApplication.java:1180) [spring-boot-1.3.5.RELEASE.jar:1.3.5.RELEASE]at com.williamy.App.main(App.java:45) [classes/:na]at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_91]at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_91]at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_91]at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_91]at org.springframework.boot.maven.AbstractRunMojo$LaunchRunner.run(AbstractRunMojo.java:478) [spring-boot-maven-plugin-1.3.5.RELEASE.jar:1.3.5.RELEASE]at java.lang.Thread.run(Thread.java:745) [na:1.8.0_91]2017-02-18 19:34:50.282  INFO 5908 --- [           main] RPC                                      : protocolConfig:5584134072017-02-18 19:34:50.551  INFO 5908 --- [           main] com.alibaba.dubbo.config.AbstractConfig  :  [DUBBO] Export dubbo service

调用报错

Request processing failed; nested exception is java.lang.NullPointerException] with root causejava.lang.NullPointerException: nullat com.williamy.App.testDubboDemo(App.java:41) ~[classes/:na]at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_91]at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_91]at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_91]at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_91]at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:221) ~[spring-web-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:136) ~[spring-web-4.2.6.RELEASE.jar:4.2.6.RELEASE]at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:110) ~[spring-webmvc-4.2.6.RELEASE.jar:4.2.6.RELEASE]

我看了下dubbo@Reference的注解

int和check有两个注解都是默认的。

这时候想到消费者可能没有找到提供者。造成循引用的问题。

目前的解决方式是

在dubbo.properties文件里增加

重新启动

日志：

017-02-18 19:43:58.074  INFO 6023 --- [           main] c.a.dubbo.common.logger.LoggerFactory    : using logger: com.alibaba.dubbo.common.logger.slf4j.Slf4jLoggerAdapter2017-02-18 19:43:58.286  INFO 6023 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Load registry store file /root/.dubbo/dubbo-registry-123.56.13.70.cache, data: {com.sincetimes.website.app.jedis.JedisService:myversion=empty://172.17.251.157:20880/com.sincetimes.website.app.jedis.JedisService?anyhost=true&application=testApp&category=configurators&check=false&dubbo=2.5.3&interface=com.sincetimes.website.app.jedis.JedisService&methods=zrange,incrBy,hgetall,set,zincrby,getSet,incr,zscore,del,hset,rpoplpush,rpush,get,hsetnx,zrem,llen,hget,zadd&pid=11218&proxy=javassist&retries=3&revision=myversion&side=provider&timeout=5000×tamp=1487150079387&version=myversion, com.sincetimes.website.app.rpc.dubbo.IHelloDubboService:1.0.0=empty://123.56.13.70:20882/com.sincetimes.website.app.rpc.dubbo.IHelloDubboService?anyhost=true&application=application_hello&category=configurators&check=false&default.delay=-1&default.retries=1&default.timeout=3000&delay=-1&dubbo=2.5.3&interface=com.sincetimes.website.app.rpc.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=27722&revision=1.0.0&side=provider&threads=200×tamp=1487314187978&version=1.0.0, com.sincetimes.website.app.rpc.dubbo.DubboTestService:myversion=empty://172.17.251.157:20880/com.sincetimes.website.app.rpc.dubbo.DubboTestService?anyhost=true&application=testApp&category=configurators&check=false&dubbo=2.5.3&interface=com.sincetimes.website.app.rpc.dubbo.DubboTestService&methods=getInfos&pid=13344&proxy=javassist&retries=3&revision=myversion&side=provider&timeout=5000×tamp=1487169440677&version=myversion, com.williamy.dubbo.IHelloDubboService:1.0.0=empty://123.56.13.70:20886/com.williamy.dubbo.IHelloDubboService?anyhost=true&application=application_hello&category=configurators&check=false&default.delay=-1&default.retries=1&default.timeout=3000&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=5908&revision=1.0.0&side=provider&threads=200×tamp=1487417690332&version=1.0.0}, dubbo version: 2.5.3, current host: 127.0.0.12017-02-18 19:43:58.338  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:zookeeper.version=3.4.9-1757313, built on 08/23/2016 06:50 GMT2017-02-18 19:43:58.340  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:host.name=iZ2zei0nwllapkwklisoncZ2017-02-18 19:43:58.340  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.version=1.8.0_912017-02-18 19:43:58.340  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.vendor=Oracle Corporation2017-02-18 19:43:58.341  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.home=/usr/local/services/jdk1.8.0_91/jre2017-02-18 19:43:58.341  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.class.path=/usr/local/services/apache-maven-3.3.9/boot/plexus-classworlds-2.5.2.jar2017-02-18 19:43:58.341  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.library.path=/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib2017-02-18 19:43:58.342  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.io.tmpdir=/tmp2017-02-18 19:43:58.342  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:java.compiler=<NA>2017-02-18 19:43:58.342  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:os.name=Linux2017-02-18 19:43:58.342  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:os.arch=amd642017-02-18 19:43:58.342  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:os.version=3.10.0-327.22.2.el7.x86_642017-02-18 19:43:58.342  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:user.name=root2017-02-18 19:43:58.342  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:user.home=/root2017-02-18 19:43:58.343  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Client environment:user.dir=/data/git_workspace/springboot_dubbo_consumer2017-02-18 19:43:58.344  INFO 6023 --- [           main] org.apache.zookeeper.ZooKeeper           : Initiating client connection, connectString=123.56.13.70:2181 sessionTimeout=30000 watcher=org.I0Itec.zkclient.ZkClient@73b030a22017-02-18 19:43:58.373  INFO 6023 --- [.56.13.70:2181)] org.apache.zookeeper.ClientCnxn          : Opening socket connection to server 123.56.13.70/123.56.13.70:2181. Will not attempt to authenticate using SASL (unknown error)2017-02-18 19:43:58.440  INFO 6023 --- [.56.13.70:2181)] org.apache.zookeeper.ClientCnxn          : Socket connection established to 123.56.13.70/123.56.13.70:2181, initiating session2017-02-18 19:43:58.455  INFO 6023 --- [.56.13.70:2181)] org.apache.zookeeper.ClientCnxn          : Session establishment complete on server 123.56.13.70/123.56.13.70:2181, sessionid = 0x15a4a890024004e, negotiated timeout = 300002017-02-18 19:43:58.539  INFO 6023 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Register: consumer://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=consumers&check=false&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=consumer×tamp=1487418238076&version=1.0.0, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:58.591  INFO 6023 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Subscribe: consumer://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=providers,configurators,routers&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=consumer×tamp=1487418238076&version=1.0.0, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:58.677  INFO 6023 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Notify urls for subscribe url consumer://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=providers,configurators,routers&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=consumer×tamp=1487418238076&version=1.0.0, urls: [empty://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=providers&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=consumer×tamp=1487418238076&version=1.0.0, empty://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=configurators&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=consumer×tamp=1487418238076&version=1.0.0, empty://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=routers&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=consumer×tamp=1487418238076&version=1.0.0], dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:58.699  INFO 6023 --- [           main] com.alibaba.dubbo.config.AbstractConfig  :  [DUBBO] Refer dubbo service com.williamy.dubbo.IHelloDubboService from url zookeeper://123.56.13.70:2181/com.alibaba.dubbo.registry.RegistryService?application=application_hello&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=consumer×tamp=1487418238076&version=1.0.0, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:58.784  INFO 6023 --- [           main] RPC                                      : protocolConfig:20909751232017-02-18 19:43:59.077  INFO 6023 --- [           main] com.alibaba.dubbo.config.AbstractConfig  :  [DUBBO] Export dubbo service com.williamy.dubbo.IHelloDubboService to local registry, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:59.084  INFO 6023 --- [           main] com.alibaba.dubbo.config.AbstractConfig  :  [DUBBO] Export dubbo service com.williamy.dubbo.IHelloDubboService to url dubbo://123.56.13.70:20886/com.williamy.dubbo.IHelloDubboService?anyhost=true&application=application_hello&default.delay=-1&default.retries=1&default.timeout=3000&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=provider&threads=200×tamp=1487418238845&version=1.0.0, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:59.085  INFO 6023 --- [           main] com.alibaba.dubbo.config.AbstractConfig  :  [DUBBO] Register dubbo service com.williamy.dubbo.IHelloDubboService url dubbo://123.56.13.70:20886/com.williamy.dubbo.IHelloDubboService?anyhost=true&application=application_hello&default.delay=-1&default.retries=1&default.timeout=3000&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=provider&threads=200×tamp=1487418238845&version=1.0.0 to registry registry://123.56.13.70:2181/com.alibaba.dubbo.registry.RegistryService?application=application_hello&dubbo=2.5.3&logger=slf4j&pid=6023&register=true&registry=zookeeper&subscribe=true×tamp=1487418238837, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:59.482  INFO 6023 --- [           main] c.a.d.remoting.transport.AbstractServer  :  [DUBBO] Start NettyServer bind /0.0.0.0:20886, export /123.56.13.70:20886, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:59.492  INFO 6023 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Register: dubbo://123.56.13.70:20886/com.williamy.dubbo.IHelloDubboService?anyhost=true&application=application_hello&default.delay=-1&default.retries=1&default.timeout=3000&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=provider&threads=200×tamp=1487418238845&version=1.0.0, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:59.523  INFO 6023 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Subscribe: provider://123.56.13.70:20886/com.williamy.dubbo.IHelloDubboService?anyhost=true&application=application_hello&category=configurators&check=false&default.delay=-1&default.retries=1&default.timeout=3000&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=provider&threads=200×tamp=1487418238845&version=1.0.0, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:59.530  INFO 6023 --- [3.56.13.70:2181] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Notify urls for subscribe url consumer://123.56.13.70/com.williamy.dubbo.IHelloDubboService?application=application_hello&category=providers,configurators,routers&default.check=false&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=consumer×tamp=1487418238076&version=1.0.0, urls: [dubbo://123.56.13.70:20886/com.williamy.dubbo.IHelloDubboService?anyhost=true&application=application_hello&default.delay=-1&default.retries=1&default.timeout=3000&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=provider&threads=200×tamp=1487418238845&version=1.0.0], dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:59.553  INFO 6023 --- [           main] c.a.d.r.zookeeper.ZookeeperRegistry      :  [DUBBO] Notify urls for subscribe url provider://123.56.13.70:20886/com.williamy.dubbo.IHelloDubboService?anyhost=true&application=application_hello&category=configurators&check=false&default.delay=-1&default.retries=1&default.timeout=3000&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=provider&threads=200×tamp=1487418238845&version=1.0.0, urls: [empty://123.56.13.70:20886/com.williamy.dubbo.IHelloDubboService?anyhost=true&application=application_hello&category=configurators&check=false&default.delay=-1&default.retries=1&default.timeout=3000&dubbo=2.5.3&interface=com.williamy.dubbo.IHelloDubboService&logger=slf4j&methods=sayHello&pid=6023&revision=1.0.0&side=provider&threads=200×tamp=1487418238845&version=1.0.0], dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:59.777  INFO 6023 --- [3.56.13.70:2181] c.a.d.remoting.transport.AbstractClient  :  [DUBBO] Successed connect to server /123.56.13.70:20886 from NettyClient 123.56.13.70 using dubbo version 2.5.3, channel is NettyChannel [channel=[id: 0xfc2606de, /172.17.251.157:32972 => /123.56.13.70:20886]], dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:43:59.777  INFO 6023 --- [3.56.13.70:2181] c.a.d.remoting.transport.AbstractClient  :  [DUBBO] Start NettyClient iZ2zei0nwllapkwklisoncZ/123.56.13.70 connect to the server /123.56.13.70:20886, dubbo version: 2.5.3, current host: 123.56.13.702017-02-18 19:44:00.270  INFO 6023 --- [           main] s.w.s.m.m.a.RequestMappingHandlerAdapter : Looking for @ControllerAdvice: org.springframework.boot.context.embedded.AnnotationConfigEmbeddedWebApplicationContext@28db5fae: startup date [Sat Feb 18 19:43:48 CST 2017]; root of context hierarchy2017-02-18 19:44:00.551  INFO 6023 --- [           main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/]}" onto java.lang.String com.williamy.App.home()2017-02-18 19:44:00.556  INFO 6023 --- [           main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/hello]}" onto java.lang.String com.williamy.App.testDubboDemo()2017-02-18 19:44:00.559  INFO 6023 --- [           main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/a]}" onto java.lang.String com.williamy.App.a()2017-02-18 19:44:00.568  INFO 6023 --- [           main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error],produces=[text/html]}" onto public org.springframework.web.servlet.ModelAndView org.springframework.boot.autoconfigure.web.BasicErrorController.errorHtml(javax.servlet.http.HttpServletRequest,javax.servlet.http.HttpServletResponse)2017-02-18 19:44:00.572  INFO 6023 --- [           main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error]}" onto public org.springframework.http.ResponseEntity<java.util.Map<java.lang.String, java.lang.Object>> org.springframework.boot.autoconfigure.web.BasicErrorController.error(javax.servlet.http.HttpServletRequest)2017-02-18 19:44:00.677  INFO 6023 --- [           main] o.s.w.s.handler.SimpleUrlHandlerMapping  : Mapped URL path [/webjars/**] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler]2017-02-18 19:44:00.677  INFO 6023 --- [           main] o.s.w.s.handler.SimpleUrlHandlerMapping  : Mapped URL path [/**] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler]2017-02-18 19:44:00.792  INFO 6023 --- [           main] o.s.w.s.handler.SimpleUrlHandlerMapping  : Mapped URL path [/**/favicon.ico] onto handler of type [class org.springframework.web.servlet.resource.ResourceHttpRequestHandler]2017-02-18 19:44:02.248  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/metrics/{name:.*}],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.MetricsMvcEndpoint.value(java.lang.String)2017-02-18 19:44:02.253  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/metrics || /metrics.json],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke()2017-02-18 19:44:02.260  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/configprops || /configprops.json],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke()2017-02-18 19:44:02.268  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/mappings || /mappings.json],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke()2017-02-18 19:44:02.292  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/env/{name:.*}],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EnvironmentMvcEndpoint.value(java.lang.String)2017-02-18 19:44:02.298  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/env || /env.json],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke()2017-02-18 19:44:02.299  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/autoconfig || /autoconfig.json],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke()2017-02-18 19:44:02.303  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/health || /health.json],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.HealthMvcEndpoint.invoke(java.security.Principal)2017-02-18 19:44:02.311  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/info || /info.json],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke()2017-02-18 19:44:02.312  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/dump || /dump.json],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke()2017-02-18 19:44:02.313  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/beans || /beans.json],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke()2017-02-18 19:44:02.319  INFO 6023 --- [           main] o.s.b.a.e.mvc.EndpointHandlerMapping     : Mapped "{[/trace || /trace.json],methods=[GET],produces=[application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.mvc.EndpointMvcAdapter.invoke()2017-02-18 19:44:02.878  INFO 6023 --- [           main] o.s.j.e.a.AnnotationMBeanExporter        : Registering beans for JMX exposure on startup2017-02-18 19:44:02.925  INFO 6023 --- [           main] o.s.c.support.DefaultLifecycleProcessor  : Starting beans in phase 02017-02-18 19:44:03.449  INFO 6023 --- [           main] s.b.c.e.t.TomcatEmbeddedServletContainer : Tomcat started on port(s): 8013 (http)2017-02-18 19:44:03.471  INFO 6023 --- [           main] com.williamy.App                         : Started App in 16.434 seconds (JVM running for 26.487)2017-02-18 19:44:03.480  INFO 6023 --- [           main] com.williamy.LogCore                     : app all services={helloDubboService=com.williamy.dubbo.HelloDubboService@31ce856b}2017-02-18 19:44:03.493  INFO 6023 --- [           main] com.williamy.LogCore                     : app all referens={}

访问成功：