聊聊 WebFlux 线程调度

前言

如果你不太了解 Project Reactor,以及非阻塞 IO 编程。强烈建议阅读我的前几篇文章

背景

今天在用 WebFlux 开发时偶然发现了一个问题,代码简化为如下

@Slf4j
@RestController
@SpringBootApplication
public class WebfluxScheduleApplication {

    public static void main(String[] args) {
        SpringApplication.run(WebfluxScheduleApplication.class, args);
    }

    @Component
    public static class LogFilter implements WebFilter {

        @NotNull
        @Override
        public Mono<Void> filter(@NotNull ServerWebExchange serverWebExchange,
                                 WebFilterChain webFilterChain) {
            log.info("filter start");
            return webFilterChain.filter(serverWebExchange)
                    .doFinally(signalType -> log.info("filter end"));
        }
    }

    @GetMapping("subscribeOn")
    public Mono<String> subscribeOn() {
        return Mono.fromCallable(() -> {
                    String result = "hello world";
                    log.info("{}", result);
                    return result;
                }).subscribeOn(Schedulers.boundedElastic())
                .doOnNext(result -> log.info("doOnNext: {}", result));
    }

}

/subscribeOn 接口中,我通过 Mono.subscribeOn 将当前发布者调度到 boundedElastic 线程。按照我对 Reactor 的理解,后续所有的消费逻辑都应该在 boundedElastic 上进行。

但是实际程序运行效果如下:

2023-12-14 22:19:17 [reactor-http-nio-2] INFO  c.g.s.WebfluxScheduleApplication - filter start
2023-12-14 22:19:17 [boundedElastic-1] INFO  c.g.s.WebfluxScheduleApplication - hello world
2023-12-14 22:19:17 [boundedElastic-1] INFO  c.g.s.WebfluxScheduleApplication - doOnNext: hello world
2023-12-14 22:19:17 [reactor-http-nio-2] INFO  c.g.s.WebfluxScheduleApplication - filter end

与预期不一致的是 filter end 这句日志并没有在 boundedElastic-1 线程输出,而是输出在了 reactor-http-nio-2 线程。

更诡异的是,当我测试了十几次后发现,filter startfilter end 这两句日志,永远都在同一个线程。

分析

看了几个晚上的 Reactor 源码实在是没有找到 Webflux 在什么地方进行的线程调度,并且我对 Scheduler 添加了 hook 和断点,也就是说只要有线程调度,一定能被我 debug 到,但是发现并没有走到我的 hook 中。这个时候其实已经证明了不是在 Reactor 这一层做的线程调度。

就在我即将放弃的时候,突然想到,会不会和 Webflux 底层的 Netty 有关系呢?通过 Debug 后发现真的和 Netty 有关系

Netty

我们先了解 Netty 以下几点

  • NioEventLoop:Netty 实现非阻塞 IO 的核心,由于不是本文重点,就不过多赘述了
  • Channel:可以理解为是 Socket 的包装,可以通过 Channel 进行 Socket 的读写操作
  • 一个 NioEventLoop 会关联多个 Channel
  • 每个 NioEventLoop 会在一个专门的线程上执行

这里我就直接说结论了,Netty 中一个 Channel(Socket)的读写操作全部在单线程上完成的,即使中间发生了线程调度也不会影响这个结论

简单讲讲这是怎么实现的

首先如何保证 NioEventLoop 只在一个线程上执行?

很简单,NioEventLoop 的 run() 就是一个死循环,不断地处理已经就绪的 IO 事件和提交到 NioEventLoop 中的 Task。

将 NioEventLoop 的 run() 提交到线程池,就实现了 NioEventLoop 只在一个专门的线程上执行

发生线程调度后,如何保证 Channel 的读写在同一个线程?

NioEventLoop 中包含一个 taskQueue 属性。上面说过了 NioEventLoop 会不断执行 “提交到 NioEventLoop 中的 Task”,这个 Task 会存储在 taskQueue 中。

由于 NioEventLoop 和 Channel 存在一个关联关系。Channel 可以找到自己对应的 NioEventLoop,在执行 Channel 写操作时,会将写操作转换成一个 Task 提交到 NioEventLoop 中,这就保证了 Channel 的读写在同一个线程

Netty 将读写操作控制在单线程上,也解决了用户使用时需要考虑线程切换的问题

通过 Debug 验证

当 Webflux 处理完整个请求时,会调用 Netty 的 Channel.writeAndFlush,可以看到该方法调用时线程还是处于 boundedElastic 线程,与我最开始的猜想是一致的。

writeAndFlush 方法最终会将 Task 添加到 NioEventLoop 的队列中。当 Socket 写操作结束后,Netty 通过 Listener 通知写成功事件,会执行到 Reactor 的 onComplete,最终反应到我们代码里就是执行了 Filter 中的 doFinally 输出日志。

至此,问题解决。

最后

本文完整 demo

©著作权归作者所有,转载或内容合作请联系作者
  • 序言:七十年代末,一起剥皮案震惊了整个滨河市,随后出现的几起案子,更是在滨河造成了极大的恐慌,老刑警刘岩,带你破解...
    沈念sama阅读 203,772评论 6 477
  • 序言:滨河连续发生了三起死亡事件,死亡现场离奇诡异,居然都是意外死亡,警方通过查阅死者的电脑和手机,发现死者居然都...
    沈念sama阅读 85,458评论 2 381
  • 文/潘晓璐 我一进店门,熙熙楼的掌柜王于贵愁眉苦脸地迎上来,“玉大人,你说我怎么就摊上这事。” “怎么了?”我有些...
    开封第一讲书人阅读 150,610评论 0 337
  • 文/不坏的土叔 我叫张陵,是天一观的道长。 经常有香客问我,道长,这世上最难降的妖魔是什么? 我笑而不...
    开封第一讲书人阅读 54,640评论 1 276
  • 正文 为了忘掉前任,我火速办了婚礼,结果婚礼上,老公的妹妹穿的比我还像新娘。我一直安慰自己,他们只是感情好,可当我...
    茶点故事阅读 63,657评论 5 365
  • 文/花漫 我一把揭开白布。 她就那样静静地躺着,像睡着了一般。 火红的嫁衣衬着肌肤如雪。 梳的纹丝不乱的头发上,一...
    开封第一讲书人阅读 48,590评论 1 281
  • 那天,我揣着相机与录音,去河边找鬼。 笑死,一个胖子当着我的面吹牛,可吹牛的内容都是我干的。 我是一名探鬼主播,决...
    沈念sama阅读 37,962评论 3 395
  • 文/苍兰香墨 我猛地睁开眼,长吁一口气:“原来是场噩梦啊……” “哼!你这毒妇竟也来了?” 一声冷哼从身侧响起,我...
    开封第一讲书人阅读 36,631评论 0 258
  • 序言:老挝万荣一对情侣失踪,失踪者是张志新(化名)和其女友刘颖,没想到半个月后,有当地人在树林里发现了一具尸体,经...
    沈念sama阅读 40,870评论 1 297
  • 正文 独居荒郊野岭守林人离奇死亡,尸身上长有42处带血的脓包…… 初始之章·张勋 以下内容为张勋视角 年9月15日...
    茶点故事阅读 35,611评论 2 321
  • 正文 我和宋清朗相恋三年,在试婚纱的时候发现自己被绿了。 大学时的朋友给我发了我未婚夫和他白月光在一起吃饭的照片。...
    茶点故事阅读 37,704评论 1 329
  • 序言:一个原本活蹦乱跳的男人离奇死亡,死状恐怖,灵堂内的尸体忽然破棺而出,到底是诈尸还是另有隐情,我是刑警宁泽,带...
    沈念sama阅读 33,386评论 4 319
  • 正文 年R本政府宣布,位于F岛的核电站,受9级特大地震影响,放射性物质发生泄漏。R本人自食恶果不足惜,却给世界环境...
    茶点故事阅读 38,969评论 3 307
  • 文/蒙蒙 一、第九天 我趴在偏房一处隐蔽的房顶上张望。 院中可真热闹,春花似锦、人声如沸。这庄子的主人今日做“春日...
    开封第一讲书人阅读 29,944评论 0 19
  • 文/苍兰香墨 我抬头看了看天上的太阳。三九已至,却和暖如春,着一层夹袄步出监牢的瞬间,已是汗流浃背。 一阵脚步声响...
    开封第一讲书人阅读 31,179评论 1 260
  • 我被黑心中介骗来泰国打工, 没想到刚下飞机就差点儿被人妖公主榨干…… 1. 我叫王不留,地道东北人。 一个月前我还...
    沈念sama阅读 44,742评论 2 349
  • 正文 我出身青楼,却偏偏与公主长得像,于是被迫代替她去往敌国和亲。 传闻我的和亲对象是个残疾皇子,可洞房花烛夜当晚...
    茶点故事阅读 42,440评论 2 342

推荐阅读更多精彩内容