localBlock在java_springboot异步mvc使用threadlocal的正确姿势

最新推荐文章于 2022-05-03 23:52:00 发布
最新推荐文章于 2022-05-03 23:52:00 发布
阅读量92 收藏
点赞数
文章标签： localBlock在java
版权声明：本文为博主原创文章，遵循 CC 4.0 BY-SA 版权协议，转载请附上原文出处链接和本声明。
本文链接：https://blog.csdn.net/weixin_39988779/article/details/111779986
版权

log

2017-02-08 23:13:25.902 INFO 1516 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Request received,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-08 23:13:25.904 INFO 1516 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Servlet thread released,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-08 23:13:25.906 INFO 1516 --- [nio-8080-exec-1] c.p.config.TraceAsyncRequestInterceptor : beforeConcurrentHandling get from mdc:null,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-08 23:13:25.909 INFO 1516 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : preProcess get from mdc:null,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:13:30.914 INFO 1516 --- [ MvcAsync1] com.xixicat.service.TaskService : task service get from mdc:localhost get by mdc,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:13:30.914 INFO 1516 --- [ MvcAsync1] com.xixicat.service.TaskService : Slow task executed,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:13:30.914 INFO 1516 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : postProcess CALLED,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:13:30.937 INFO 1516 --- [nio-8080-exec-2] c.p.config.TraceAsyncRequestInterceptor : afterCompletion CALLED,thread:Thread[http-nio-8080-exec-2,5,main]

接收请求与返回的响应不是同一个线程

beforeConcurrentHandling是在接收线程里头执行

preProcess是在异步线程里执行

postProcess是在异步线程里执行

afterCompletion是在响应线程

或者

2017-02-08 23:13:57.555 INFO 1516 --- [nio-8080-exec-3] c.p.controller.AsyncCallableController : Request received,thread:Thread[http-nio-8080-exec-3,5,main]

2017-02-08 23:13:57.555 INFO 1516 --- [nio-8080-exec-3] c.p.controller.AsyncCallableController : Servlet thread released,thread:Thread[http-nio-8080-exec-3,5,main]

2017-02-08 23:13:57.555 INFO 1516 --- [nio-8080-exec-3] c.p.config.TraceAsyncRequestInterceptor : beforeConcurrentHandling get from mdc:null,thread:Thread[http-nio-8080-exec-3,5,main]

2017-02-08 23:13:57.556 INFO 1516 --- [ MvcAsync2] c.p.config.TraceAsyncRequestInterceptor : preProcess get from mdc:null,thread:Thread[MvcAsync2,5,main]

2017-02-08 23:14:02.559 INFO 1516 --- [ MvcAsync2] com.xixicat.service.TaskService : task service get from mdc:localhost get by mdc,thread:Thread[MvcAsync2,5,main]

2017-02-08 23:14:02.560 INFO 1516 --- [ MvcAsync2] com.xixicat.service.TaskService : Slow task executed,thread:Thread[MvcAsync2,5,main]

2017-02-08 23:14:02.560 INFO 1516 --- [ MvcAsync2] c.p.config.TraceAsyncRequestInterceptor : postProcess CALLED,thread:Thread[MvcAsync2,5,main]

2017-02-08 23:14:02.566 INFO 1516 --- [nio-8080-exec-4] c.p.config.TraceAsyncRequestInterceptor : afterCompletion CALLED,thread:Thread[http-nio-8080-exec-4,5,main]

3s超时,处理sleep 5s

2017-02-08 23:15:26.660 INFO 1530 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Request received,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-08 23:15:26.662 INFO 1530 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Servlet thread released,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-08 23:15:26.664 INFO 1530 --- [nio-8080-exec-1] c.p.config.TraceAsyncRequestInterceptor : beforeConcurrentHandling get from mdc:null,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-08 23:15:26.667 INFO 1530 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : preProcess get from mdc:null,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:15:30.076 INFO 1530 --- [nio-8080-exec-2] c.p.config.TraceAsyncRequestInterceptor : handleTimeout CALLED,thread:Thread[http-nio-8080-exec-2,5,main]

2017-02-08 23:15:30.089 INFO 1530 --- [nio-8080-exec-2] c.p.config.TraceAsyncRequestInterceptor : afterCompletion CALLED,thread:Thread[http-nio-8080-exec-2,5,main]

2017-02-08 23:15:31.668 INFO 1530 --- [ MvcAsync1] com.xixicat.service.TaskService : task service get from mdc:localhost get by mdc,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:15:31.668 INFO 1530 --- [ MvcAsync1] com.xixicat.service.TaskService : Slow task executed,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:15:31.668 INFO 1530 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : postProcess CALLED,thread:Thread[MvcAsync1,5,main]

handleTimeout是在响应线程里头执行

afterCompletion是在响应线程

3秒timeout完,返回请求线程执行handleTimeout,然后执行afterCompletion

5秒时,异步线程执行完,执行postProcess

没有超时,但task抛出异常情况

2017-02-08 23:27:31.164 INFO 1551 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Request received,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-08 23:27:31.166 INFO 1551 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Servlet thread released,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-08 23:27:31.168 INFO 1551 --- [nio-8080-exec-1] c.p.config.TraceAsyncRequestInterceptor : beforeConcurrentHandling get from mdc:null,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-08 23:27:31.171 INFO 1551 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : preProcess get from mdc:null,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:27:36.174 INFO 1551 --- [ MvcAsync1] com.xixicat.service.TaskService : task service get from mdc:localhost get by mdc,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:27:36.174 INFO 1551 --- [ MvcAsync1] com.xixicat.service.TaskService : Slow task executed,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:27:36.174 INFO 1551 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : postProcess CALLED,thread:Thread[MvcAsync1,5,main]

2017-02-08 23:27:36.196 ERROR 1551 --- [nio-8080-exec-2] o.a.c.c.C.[.[.[/].[dispatcherServlet] : Servlet.service() for servlet dispatcherServlet threw exception

java.lang.RuntimeException: test

at com.xixicat.service.TaskService.execute(TaskService.java:17) ~[classes/:na]

at org.springframework.web.context.request.async.WebAsyncManager$4.run(WebAsyncManager.java:316) ~[spring-web-4.3.5.RELEASE.jar:4.3.5.RELEASE]

at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) ~[na:1.8.0_71]

at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[na:1.8.0_71]

at java.lang.Thread.run(Thread.java:745) [na:1.8.0_71]

2017-02-08 23:27:36.197 ERROR 1551 --- [nio-8080-exec-2] o.a.c.c.C.[.[.[/].[dispatcherServlet] : Servlet.service() for servlet [dispatcherServlet] in context with path [] threw exception [Request processing failed; nested exception is java.lang.RuntimeException: test] with root cause

java.lang.RuntimeException: test

at com.xixicat.service.TaskService.execute(TaskService.java:17) ~[classes/:na]

at org.springframework.web.context.request.async.WebAsyncManager$4.run(WebAsyncManager.java:316) ~[spring-web-4.3.5.RELEASE.jar:4.3.5.RELEASE]

at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) ~[na:1.8.0_71]

at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[na:1.8.0_71]

at java.lang.Thread.run(Thread.java:745) [na:1.8.0_71]

2017-02-08 23:27:36.238 INFO 1551 --- [nio-8080-exec-2] c.p.config.TraceAsyncRequestInterceptor : afterCompletion CALLED,thread:Thread[http-nio-8080-exec-2,5,main]

2017-02-08 23:27:36.238 INFO 1551 --- [nio-8080-exec-2] c.p.config.TraceAsyncRequestInterceptor : afterCompletion CALLED,thread:Thread[http-nio-8080-exec-2,5,main]

task抛出异常,还是会调用postProcess

afterCompletion在响应线程执行了两次

加上spring filter

2017-02-09 00:03:17.711 INFO 1672 --- [nio-8080-exec-1] com.xixicat.config.TraceFilter : OncePerRequestFilter before,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:03:17.724 INFO 1672 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Request received,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:03:17.724 INFO 1672 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Servlet thread released,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:03:17.726 INFO 1672 --- [nio-8080-exec-1] c.p.config.TraceAsyncRequestInterceptor : beforeConcurrentHandling get from mdc:null,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:03:17.729 INFO 1672 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : preProcess get from mdc:null,thread:Thread[MvcAsync1,5,main]

2017-02-09 00:03:17.729 INFO 1672 --- [nio-8080-exec-1] com.xixicat.config.TraceFilter : OncePerRequestFilter after,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:03:22.730 INFO 1672 --- [ MvcAsync1] com.xixicat.service.TaskService : task service get from mdc:localhost get by mdc,thread:Thread[MvcAsync1,5,main]

2017-02-09 00:03:22.730 INFO 1672 --- [ MvcAsync1] com.xixicat.service.TaskService : Slow task executed,thread:Thread[MvcAsync1,5,main]

2017-02-09 00:03:22.730 INFO 1672 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : postProcess CALLED,thread:Thread[MvcAsync1,5,main]

2017-02-09 00:03:22.750 INFO 1672 --- [nio-8080-exec-2] c.p.config.TraceAsyncRequestInterceptor : afterCompletion CALLED,thread:Thread[http-nio-8080-exec-2,5,main]

加上MDC

2017-02-09 00:05:46.870 INFO 1682 --- [nio-8080-exec-1] com.xixicat.config.TraceFilter : OncePerRequestFilter before,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:05:46.883 INFO 1682 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Request received,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:05:46.884 INFO 1682 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Servlet thread released,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:05:46.886 INFO 1682 --- [nio-8080-exec-1] c.p.config.TraceAsyncRequestInterceptor : beforeConcurrentHandling get from mdc:remote ip set from OncePerRequestFilter,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:05:46.889 INFO 1682 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : preProcess get from mdc:null,thread:Thread[MvcAsync1,5,main]

2017-02-09 00:05:46.889 INFO 1682 --- [nio-8080-exec-1] com.xixicat.config.TraceFilter : OncePerRequestFilter after,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:05:51.891 INFO 1682 --- [ MvcAsync1] com.xixicat.service.TaskService : task service get from mdc:remote ip set from OncePerRequestFilter,thread:Thread[MvcAsync1,5,main]

2017-02-09 00:05:51.891 INFO 1682 --- [ MvcAsync1] com.xixicat.service.TaskService : Slow task executed,thread:Thread[MvcAsync1,5,main]

2017-02-09 00:05:51.891 INFO 1682 --- [ MvcAsync1] c.p.config.TraceAsyncRequestInterceptor : postProcess CALLED,thread:Thread[MvcAsync1,5,main]

2017-02-09 00:05:51.914 INFO 1682 --- [nio-8080-exec-2] c.p.config.TraceAsyncRequestInterceptor : afterCompletion CALLED,thread:Thread[http-nio-8080-exec-2,5,main]

block

2017-02-09 00:08:52.271 INFO 1691 --- [nio-8080-exec-1] com.xixicat.config.TraceFilter : OncePerRequestFilter before,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:08:52.284 INFO 1691 --- [nio-8080-exec-1] c.p.controller.BlockingController : Request received,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:08:57.291 INFO 1691 --- [nio-8080-exec-1] com.xixicat.service.TaskService : task service get from mdc:remote ip set from OncePerRequestFilter,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:08:57.291 INFO 1691 --- [nio-8080-exec-1] com.xixicat.service.TaskService : Slow task executed,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:08:57.291 INFO 1691 --- [nio-8080-exec-1] c.p.controller.BlockingController : Servlet thread released,thread:Thread[http-nio-8080-exec-1,5,main]

2017-02-09 00:08:57.305 INFO 1691 --- [nio-8080-exec-1] com.xixicat.config.TraceFilter : OncePerRequestFilter after,thread:Thread[http-nio-8080-exec-1,5,main]

总结

OncePerRequestFilter里头before添加MDC,after删除MDC,这个是请求线程的

CallableProcessingInterceptorAdapter这个preProcess添加到异步线程MDC,postProcess删除异步线程MDC

doc

weixin_39988779
关注
  • 0
    点赞
  • 踩
  • 0
    收藏
    觉得还不错? 一键收藏
  • 0
    评论
java多线程学习之通过ThreadLocal实现每个线程拥有自己的变量
cjwdemo的博客
05-25 595
package learn.thread;/* * ThreadLocal实现线程拥有自己的变量值 */ public class Demo12 { public static ThreadLocal tl = new ThreadLocal(); public static void main(String[] args) { if (tl.get() == nu
springboot异步mvc使用threadlocal的正确姿势
weixin_34096182的博客
02-09 910
log 2017-02-08 23:13:25.902 INFO 1516 --- [nio-8080-exec-1] c.p.controller.AsyncCallableController : Request received,thread:Thread[http-nio-8080-exec-1,5,main] 2017-0...
多线程系列-ThreadLocal
ahao' Blog
04-15 1413
线程安全-ThreadLocal 前言 共享资源被多个线程同时访问可能出现不安全的事情。线程安全一直是很重要的事情，没处理好线程安全的问题可能导致错误甚至很难复现排查。 常见的解决办法有定义不可变(immutable)变量：例如Java中的String类型、Guava库里的ImmutableCollections。还有就是对访问共享资源的线程加上锁：例如JUC包下的ReentrantLock和JDK自带的synchronized关键字，或者借助Unsafe类来实现的自旋锁。还有一种是保证所有执行的任务都一个
Java中ThreadLocal详解（一篇就够了）
starsray的博客
05-03 1万+
前言 ThreadLocal直译为线程局部变量，或许将它命名为ThreadLocalVariable更为合适。其主要作用就是实现线程本地存储功能，通过线程本地资源隔离，解决多线程并发场景下线程安全问题。 ThreadLocal 接下来，通过ThreadLocal的使用案例、应用场景、源码分析来进行深层次的剖析，说明如何避免使用中出现问题以及解决方案。 使用案例 前面提到关于ThreadLocal.........
Java中多线程同步的6种方式和ThreadLocal
哈哈彬的博客
07-27 2213
网上有些资料将使用ThreadLocal也定义为多线程同步的一种方式，但是多线程同步的前提是变量共享。 ThreadLocal并不是为了解决多线程间共享变量的问题。举个例子，在一个电商系统中，用一个Long型变量表示某个商品的库存量，多个线程需要访问库存量进行销售，并减去销售数量，以更新库存量。在这个场景中，是不能使用ThreadLocal类的。 ...
java 中ThreadLocal 的正确用法
08-31
java 中ThreadLocal 的正确用法 ThreadLocal 是 Java 中的一个特殊类，它可以让每个线程拥有自己独立的变量副本，避免了多线程之间的共享变量问题。下面我们将详细介绍 Java 中 ThreadLocal 的正确用法。 用法一...
mybatis_springboot_mybatis_
10-01
MyBatis 可以使用简单的 XML 或注解进行配置和原始映射，将接口和 Java 的 POJOs(Plain Old Java Objects，普通的 Java 对象)映射成数据库中的记录。 **SpringBoot 与 MyBatis 集成** 在 SpringBoot 中集成 MyBatis...
ThreadLocal使用案例_动力节点Java学院整理
08-29
在本例中，我们使用ThreadLocal来记录操作日志，以便在多线程环境中能够正确地记录操作日志。通过使用ThreadLocal，我们可以确保数据的一致性和线程安全。同时，我们也需要注意ThreadLocal的缺点，以避免可能出现的...
Java源码解析ThreadLocal及使用场景
08-26
ThreadLocal是Java中一个非常重要的类，它在多线程环境下经常使用，用于提供线程本地变量。这些变量使每个线程都有自己的一份拷贝，使得多个线程可以独立地使用变量，不会彼此影响。 ThreadLocal的使用场景非常广泛...
java ThreadLocal使用案例详解
08-27
在本文中，我们将详细介绍Java ThreadLocal的使用案例，并通过一个实际的优化案例，帮助大家理解ThreadLocal的使用。 ThreadLocal的使用场景 在Java多线程编程中，变量的线程安全是一个非常重要的问题。特别是在...
谈谈Java中的ThreadLocal
weixin_30607659的博客
12-14 193
ThreadLocal介绍&跳出误区 看看源码 线程独享变量？ ThreadLocal介绍&跳出误区 　　ThreadLocal一般称为线程本地变量，它是一种特殊的线程绑定机制，将变量与线程绑定在一起，为每一个线程维护一个独立的变量副本。通过ThreadLocal可以将对象的可见范围限制在同一个线程内。 跳出误区 　　需要重点强调的的是，不要拿ThreadLocal和s...
java异步临界区_Java多线程 之 临界区、ThreadLocal
weixin_34061200的博客
02-13 581
Java多线程 之 临界区、ThreadLocal1.临界区临界区就是在同一时刻只能有一个任务访问的代码区。在java中通常使用下面的方式来实现：synchronized(syncObject) {//critical section}当然也可以使用Lock对象来实现临界区。要访问临界区就要先获得syncObject这个对象的锁。注意， 每个java对象都隐含有一把锁 。使用临界区的执行效率要比使...
ThreadLocal父子线程传递实现方案
热门推荐
蜗牛的专栏
09-30 2万+
前言 介绍InheritableThreadLocal之前，假设对 ThreadLocal 已经有了一定的理解，比如基本概念，原理，如果没有，可以参考：ThreadLocal源码分析解密.在讲解之前我们先列举有关ThreadLocal的几个关键点 每一个Thread线程都有属于自己的ThreadLocalMap,里面有一个弱引用的Entry(ThreadLocal,Object),
Java | 多线程 | ThreadLocal结合线程池的正确使用方式
程序员阿康
07-27 9381
1）问题： 才发现，写这篇博客之前，自己一直在以一种错误的姿势在用threadLocal对象。但我不信就我一人姿势不对。 场景就是threadLocal在项目中使用时，出现取值错误的情况。原因是 threadLocal在多线程环境下使用不当，花了不少时间排查，因为在不该出问题的地方出了问题，最终还是排查到线程池上。之前一直没有问题，或许是因为并发不高。最终今天还是遇到了问题（出来混，迟早是要还...
java多线程 ThreadLocal理论总结
许诗宇的博客
05-09 2063
目录 什么是ThreadLocal变量 使用样例 threadlocal的内部属性-哈希 ThreadLocalMap ThreadLocal 内存泄漏，remove方法 ThreadLocal 的 set 方法 ThreadLocal 的 get 方法 ThreadLocalMap 的 resize 方法 ThreadLocal 应用场景 注意：本文参考了https://baijiahao.baidu.com/s?id=1663127810801876375 什么是ThreadLoc
springmvc异步处理请求
404NotFound的博客
05-08 1540
有两种情况，第一种是业务逻辑复杂，但不需要业务逻辑的结果，第二种是需要返回业务逻辑的处理结果 第一种比较简单，利用多线程处理业务逻辑，或者利用spring中@Asyn注解更简单， 使用@Asyn注解，要首先要配置开启异步注解 @Configuration @EnableAsync public class AsyncConfig { } 然后直接在方法上注解即可 @Service
Spring 异步线程中传递ThreadLocal
keep_learn的专栏
12-28 1522
ThreadLocal 的传递
如何解决ThreadLocal在异步调用中的问题
weixin_30488313的博客
03-02 1291
1、首先大家都知道ThreadLocal中的get之所以能够保证线程安全是依赖于每个线程都会有一个ThreadLocalMap. 当执行set方法的时候首先会获取当前线程的ThreadLocalMap，然后给map赋值。 public void set(T value) { Thread t = Thread.currentThread(); Threa...
springboot 线程池如何使用ThreadLocal
最新发布
06-07
在 Spring Boot 中使用线程池时，可以通过实现 `ThreadPoolTaskExecutor` 类来自定义线程池，然后在其中使用 `ThreadLocal`。 具体来说，可以在 `ThreadPoolTaskExecutor` 的子类中重写 `execute` 方法，在任务执行...
评论
添加红包

请填写红包祝福语或标题

个

红包个数最小为10个

元

红包金额最低5元

当前余额3.43元 前往充值 >
需支付：10.00元
成就一亿技术人!
领取后你会自动成为博主和红包主的粉丝 规则
hope_wisdom
发出的红包
实付元
使用余额支付
点击重新获取
扫码支付
钱包余额 0

抵扣说明：

1.余额是钱包充值的虚拟货币，按照1:1的比例进行支付金额的抵扣。
2.余额无法直接购买下载，可以购买VIP、付费专栏及课程。

余额充值