sinat_38955460
sinat_38955460
采纳率100%
2021-02-26 11:22

大家好,我在用ZuulFilter做过滤请求,为什么一次请求会触发好多次过滤器?

2021-02-26 11:09:29.639  INFO 1184 --- [           main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration' of type [org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration$$EnhancerBySpringCGLIB$$ac6ce252] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)

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

2021-02-26 11:09:30.047  INFO 1184 --- [           main] com.main.CrowdMainClass                  : No active profile set, falling back to default profiles: default
2021-02-26 11:09:30.631  INFO 1184 --- [           main] .s.d.r.c.RepositoryConfigurationDelegate : Multiple Spring Data modules found, entering strict repository configuration mode!
2021-02-26 11:09:30.634  INFO 1184 --- [           main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data repositories in DEFAULT mode.
2021-02-26 11:09:30.657  INFO 1184 --- [           main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 10ms. Found 0 repository interfaces.
2021-02-26 11:09:30.731  WARN 1184 --- [           main] o.s.boot.actuate.endpoint.EndpointId     : Endpoint ID 'service-registry' contains invalid characters, please migrate to a valid format.
2021-02-26 11:09:30.739  WARN 1184 --- [           main] o.s.boot.actuate.endpoint.EndpointId     : Endpoint ID 'hystrix.stream' contains invalid characters, please migrate to a valid format.
2021-02-26 11:09:30.953  INFO 1184 --- [           main] o.s.cloud.context.scope.GenericScope     : BeanFactory id=7d3370f8-66b8-321b-9478-559e1d7e395a
2021-02-26 11:09:31.247  INFO 1184 --- [           main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration' of type [org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration$$EnhancerBySpringCGLIB$$ac6ce252] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
2021-02-26 11:09:31.498  INFO 1184 --- [           main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat initialized with port(s): 80 (http)
2021-02-26 11:09:31.520  INFO 1184 --- [           main] o.apache.catalina.core.StandardService   : Starting service [Tomcat]
2021-02-26 11:09:31.520  INFO 1184 --- [           main] org.apache.catalina.core.StandardEngine  : Starting Servlet engine: [Apache Tomcat/9.0.21]
2021-02-26 11:09:31.653  INFO 1184 --- [           main] o.a.c.c.C.[Tomcat].[localhost].[/]       : Initializing Spring embedded WebApplicationContext
2021-02-26 11:09:31.653  INFO 1184 --- [           main] o.s.web.context.ContextLoader            : Root WebApplicationContext: initialization completed in 1595 ms
2021-02-26 11:09:31.762  WARN 1184 --- [           main] c.n.c.sources.URLConfigurationSource     : No URLs will be polled as dynamic configuration sources.
2021-02-26 11:09:31.762  INFO 1184 --- [           main] c.n.c.sources.URLConfigurationSource     : To enable URLs as dynamic configuration sources, define System property archaius.configurationSource.additionalUrls or make config.properties available on classpath.
2021-02-26 11:09:31.775  INFO 1184 --- [           main] c.netflix.config.DynamicPropertyFactory  : DynamicPropertyFactory is initialized with configuration sources: com.netflix.config.ConcurrentCompositeConfiguration@1ec22831
2021-02-26 11:09:33.222  WARN 1184 --- [           main] c.n.c.sources.URLConfigurationSource     : No URLs will be polled as dynamic configuration sources.
2021-02-26 11:09:33.222  INFO 1184 --- [           main] c.n.c.sources.URLConfigurationSource     : To enable URLs as dynamic configuration sources, define System property archaius.configurationSource.additionalUrls or make config.properties available on classpath.
2021-02-26 11:09:33.441  INFO 1184 --- [           main] o.s.s.concurrent.ThreadPoolTaskExecutor  : Initializing ExecutorService 'applicationTaskExecutor'
2021-02-26 11:09:33.833  INFO 1184 --- [           main] io.lettuce.core.EpollProvider            : Starting without optional epoll library
2021-02-26 11:09:33.834  INFO 1184 --- [           main] io.lettuce.core.KqueueProvider           : Starting without optional kqueue library
2021-02-26 11:09:34.903  INFO 1184 --- [           main] o.s.c.n.zuul.ZuulFilterInitializer       : Starting filter initializer
2021-02-26 11:09:34.916  INFO 1184 --- [           main] o.s.b.a.e.web.EndpointLinksResolver      : Exposing 2 endpoint(s) beneath base path '/actuator'
2021-02-26 11:09:34.997  INFO 1184 --- [           main] o.s.c.n.eureka.InstanceInfoFactory       : Setting initial instance status as: STARTING
2021-02-26 11:09:35.032  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Initializing Eureka in region us-east-1
2021-02-26 11:09:35.213  INFO 1184 --- [           main] c.n.d.provider.DiscoveryJerseyProvider   : Using JSON encoding codec LegacyJacksonJson
2021-02-26 11:09:35.213  INFO 1184 --- [           main] c.n.d.provider.DiscoveryJerseyProvider   : Using JSON decoding codec LegacyJacksonJson
2021-02-26 11:09:35.334  INFO 1184 --- [           main] c.n.d.provider.DiscoveryJerseyProvider   : Using XML encoding codec XStreamXml
2021-02-26 11:09:35.334  INFO 1184 --- [           main] c.n.d.provider.DiscoveryJerseyProvider   : Using XML decoding codec XStreamXml
2021-02-26 11:09:35.486  INFO 1184 --- [           main] c.n.d.s.r.aws.ConfigClusterResolver      : Resolving eureka endpoints via configuration
2021-02-26 11:09:35.668  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Disable delta property : false
2021-02-26 11:09:35.668  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Single vip registry refresh property : null
2021-02-26 11:09:35.668  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Force full registry fetch : false
2021-02-26 11:09:35.668  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Application is null : false
2021-02-26 11:09:35.668  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Registered Applications size is zero : true
2021-02-26 11:09:35.668  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Application version is -1: true
2021-02-26 11:09:35.668  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Getting all instance registry info from the eureka server
2021-02-26 11:09:35.821  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : The response status is 200
2021-02-26 11:09:35.823  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Starting heartbeat executor: renew interval is: 30
2021-02-26 11:09:35.825  INFO 1184 --- [           main] c.n.discovery.InstanceInfoReplicator     : InstanceInfoReplicator onDemand update allowed rate per min is 4
2021-02-26 11:09:35.827  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Discovery Client initialized at timestamp 1614308975827 with initial instances count: 3
2021-02-26 11:09:35.829  INFO 1184 --- [           main] o.s.c.n.e.s.EurekaServiceRegistry        : Registering application SYD-CROWD-ZUUL with eureka with status UP
2021-02-26 11:09:35.830  INFO 1184 --- [           main] com.netflix.discovery.DiscoveryClient    : Saw local status change event StatusChangeEvent [timestamp=1614308975830, current=UP, previous=STARTING]
2021-02-26 11:09:35.832  INFO 1184 --- [nfoReplicator-0] com.netflix.discovery.DiscoveryClient    : DiscoveryClient_SYD-CROWD-ZUUL/192.168.106.144:syd-crowd-zuul:80: registering service...
2021-02-26 11:09:35.864  INFO 1184 --- [nfoReplicator-0] com.netflix.discovery.DiscoveryClient    : DiscoveryClient_SYD-CROWD-ZUUL/192.168.106.144:syd-crowd-zuul:80 - registration status: 204
2021-02-26 11:09:36.172  INFO 1184 --- [on(3)-127.0.0.1] o.a.c.c.C.[Tomcat].[localhost].[/]       : Initializing Spring DispatcherServlet 'dispatcherServlet'
2021-02-26 11:09:36.172  INFO 1184 --- [on(3)-127.0.0.1] o.s.web.servlet.DispatcherServlet        : Initializing Servlet 'dispatcherServlet'
2021-02-26 11:09:36.182  INFO 1184 --- [on(3)-127.0.0.1] o.s.web.servlet.DispatcherServlet        : Completed initialization in 9 ms
2021-02-26 11:09:36.404  INFO 1184 --- [           main] s.a.ScheduledAnnotationBeanPostProcessor : No TaskScheduler/ScheduledExecutorService bean found for scheduled processing
2021-02-26 11:09:36.424  INFO 1184 --- [           main] o.s.b.w.embedded.tomcat.TomcatWebServer  : Tomcat started on port(s): 80 (http) with context path ''
2021-02-26 11:09:36.425  INFO 1184 --- [           main] .s.c.n.e.s.EurekaAutoServiceRegistration : Updating port to 80
2021-02-26 11:09:36.426  INFO 1184 --- [           main] com.main.CrowdMainClass                  : Started CrowdMainClass in 7.635 seconds (JVM running for 8.345)
2021-02-26 11:09:44.846  INFO 1184 --- [p-nio-80-exec-1] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:09:44.991  INFO 1184 --- [p-nio-80-exec-1] c.netflix.config.ChainedDynamicProperty  : Flipping property: syd-crowd-auth.ribbon.ActiveConnectionsLimit to use NEXT property: niws.loadbalancer.availabilityFilteringRule.activeConnectionsLimit = 2147483647
2021-02-26 11:09:45.020  INFO 1184 --- [p-nio-80-exec-1] c.n.u.concurrent.ShutdownEnabledTimer    : Shutdown hook installed for: NFLoadBalancer-PingTimer-syd-crowd-auth
2021-02-26 11:09:45.020  INFO 1184 --- [p-nio-80-exec-1] c.netflix.loadbalancer.BaseLoadBalancer  : Client: syd-crowd-auth instantiated a LoadBalancer: DynamicServerListLoadBalancer:{NFLoadBalancer:name=syd-crowd-auth,current list of Servers=[],Load balancer stats=Zone stats: {},Server stats: []}ServerList:null
2021-02-26 11:09:45.027  INFO 1184 --- [p-nio-80-exec-1] c.n.l.DynamicServerListLoadBalancer      : Using serverListUpdater PollingServerListUpdater
2021-02-26 11:09:45.045  INFO 1184 --- [p-nio-80-exec-1] c.netflix.config.ChainedDynamicProperty  : Flipping property: syd-crowd-auth.ribbon.ActiveConnectionsLimit to use NEXT property: niws.loadbalancer.availabilityFilteringRule.activeConnectionsLimit = 2147483647
2021-02-26 11:09:45.046  INFO 1184 --- [p-nio-80-exec-1] c.n.l.DynamicServerListLoadBalancer      : DynamicServerListLoadBalancer for client syd-crowd-auth initialized: DynamicServerListLoadBalancer:{NFLoadBalancer:name=syd-crowd-auth,current list of Servers=[192.168.106.144:4000],Load balancer stats=Zone stats: {defaultzone=[Zone:defaultzone;	Instance count:1;	Active connections count: 0;	Circuit breaker tripped count: 0;	Active connections per server: 0.0;]
},Server stats: [[Server:192.168.106.144:4000;	Zone:defaultZone;	Total Requests:0;	Successive connection failure:0;	Total blackout seconds:0;	Last connection made:Thu Jan 01 08:00:00 CST 1970;	First connection made: Thu Jan 01 08:00:00 CST 1970;	Active Connections:0;	total failure count in last (1000) msecs:0;	average resp time:0.0;	90 percentile resp time:0.0;	95 percentile resp time:0.0;	min resp time:0.0;	max resp time:0.0;	stddev resp time:0.0]
]}ServerList:org.springframework.cloud.netflix.ribbon.eureka.DomainExtractingServerList@6dad3cdd
2021-02-26 11:09:46.031  INFO 1184 --- [erListUpdater-0] c.netflix.config.ChainedDynamicProperty  : Flipping property: syd-crowd-auth.ribbon.ActiveConnectionsLimit to use NEXT property: niws.loadbalancer.availabilityFilteringRule.activeConnectionsLimit = 2147483647
2021-02-26 11:10:00.193  INFO 1184 --- [p-nio-80-exec-5] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.193  INFO 1184 --- [p-nio-80-exec-5] com.main.MyZuulFilter                    : 打印结果:true
2021-02-26 11:10:00.193  INFO 1184 --- [p-nio-80-exec-5] com.main.MyZuulFilter                    : 进入了run方法过滤器执行了逻辑
2021-02-26 11:10:00.198  INFO 1184 --- [p-nio-80-exec-5] com.main.MyZuulFilter                    : 打印session里的用户信息null
2021-02-26 11:10:00.271  INFO 1184 --- [p-nio-80-exec-7] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.335  INFO 1184 --- [p-nio-80-exec-2] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.335  INFO 1184 --- [p-nio-80-exec-8] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.335  INFO 1184 --- [p-nio-80-exec-2] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.335  INFO 1184 --- [p-nio-80-exec-8] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.337  INFO 1184 --- [p-nio-80-exec-3] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.337  INFO 1184 --- [p-nio-80-exec-3] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.356  INFO 1184 --- [p-nio-80-exec-9] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.356  INFO 1184 --- [p-nio-80-exec-9] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.356  INFO 1184 --- [p-nio-80-exec-4] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.356  INFO 1184 --- [p-nio-80-exec-4] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.390  INFO 1184 --- [p-nio-80-exec-1] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.390  INFO 1184 --- [p-nio-80-exec-1] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.394  INFO 1184 --- [-nio-80-exec-10] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.394  INFO 1184 --- [p-nio-80-exec-6] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.394  INFO 1184 --- [p-nio-80-exec-6] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.394  INFO 1184 --- [-nio-80-exec-10] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.402  INFO 1184 --- [p-nio-80-exec-9] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.402  INFO 1184 --- [p-nio-80-exec-9] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.403  INFO 1184 --- [p-nio-80-exec-7] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.403  INFO 1184 --- [p-nio-80-exec-7] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:10:00.499  INFO 1184 --- [p-nio-80-exec-3] com.main.MyZuulFilter                    : 进入了shouldFilter方法
2021-02-26 11:10:00.499  INFO 1184 --- [p-nio-80-exec-3] com.main.MyZuulFilter                    : 打印结果:false
2021-02-26 11:14:35.671  INFO 1184 --- [trap-executor-0] c.n.d.s.r.aws.ConfigClusterResolver      : Resolving eureka endpoints via configuration

献上日志,特别疑惑,希望得到解答,谢谢!

  • 点赞
  • 写回答
  • 关注问题
  • 收藏
  • 复制链接分享
  • 邀请回答