记一次因@Async引发的程序bug

Posted 2023-03-22

参考技术A

事情的起因是微服务A通过feign调用微服务B的某个接口，报了形如下的异常

负责微服务A的工程师小张就找到负责提供该接口的工程师小李，问小李是不是改动了接口，小李一脸无辜说他最近没对这个接口做任何改动，不过小李还是说道他排查一下。

小李排查的过程如下，他先通过swagger查看他提供给A服务接口是否存在，他一查发现他在swagger上看不到他提供给A服务的接口。于是他怀疑是不是有人动了他的代码，他就去查找最近的git提交记录，发现没人动他的代码，因为项目还没发布，都在测试阶段，他就根据项目集成的git-commit-id-maven-plugin插件定位到测试目前发布具体是哪个版本。（ps：对
git-commit-id-maven-plugin感兴趣的朋友，可以查看之前的文章聊聊如何验证线上的版本是符合预期的版本）。然后他将该版本的代码下到本地进行调试，他发现代码中提供给A的接口还在，target下的class也有提供给A的接口class，但诡异的是swagger就是没显示他提供出去的接口，他一度以为是swagger出了问题，于是他用postman直接请求他提供A的接口，发现报了404。然后他就叫负责同个微服务B的同事小王，也帮忙试一下，发现结果就是404。后面没招，小李就去求助他们项目资深同事小林。

小林的排查思路如下，他先走查一下小李的接口代码，发现他提供的接口实现层的方法上加了一个@Async，示例形如下

小林凭多年的经验直觉告诉小李说，应该是@Async引起。小李很斩钉截铁的说不可能啊，他@Async很早就加了，之前接口都可以访问的，小林一看小李说得那么肯定，他也不好打击小李。于是他接下来做了如下操作，先在项目中yml配置如下参数，开启springweb日志

然后在项目中加了形如下代码，来跟踪接口bean的类型

启动控制台，看日志形如下

发现确实没打印出相关requestMapping映射信息，这可以说明一点就是小李那个接口没有绑定到springmvc映射，也就是出现404的原因。接着观察控制台打印的bean，内容形如下

这很明显这个接口bean已经被jdk动态代理给替换。小李看到控制台打印的信息，若有所思，然后说，我把@Async去掉试下。小李把@Async去掉后，再观察下控制台

通过控制台可以发现，此时接口已经绑定到springmvc映射，而且打印出bean类型是真实对象bean。小李看到这个现象，也百思不得其解，他说道他之前确实是加了@Async，接口也能正常访问。于是小林就问一句，你确定你加了@Async，异步生效了吗，小李说开启spring异步，不都是加@Async吗。小林又问了一句，你在项目中开启异步，除了加@Async，还有做什么处理吗，小李说没了，他之前在项目使用异步就都是加了@Async，也能用了好好的，小林一听，基本上知道为什么小李之前@Async，接口还能正常访问了，小林为了验证想法，就问同负责该项目的小王，说你最近有加什么异步操作吗，小王说有，小林进一步问，你是怎么做的，小王说，他先加@EnabledAsyn，开启异步，然后在业务逻辑层上的方法上加@Async注解。小李一听，说原来使用@Async还要配合@EnabledAsyn啊，他之前都不知道

接着小李说 那在controller是不是就不能使用@Async注解了？ ，小林说最好是把加@Async的逻辑挪到service层去处理，不过也不是controller就不能使用@Async注解了，接着小林为了验证这个想法，他把原来实现的接口类去掉，形如下

启动后，查看控制台

此时bean的类型如下

访问接口，打印内容如下

从控制台可以发现，都是http-nio-8080-exec-1线程触发，说明异步没生效，即@Async失效。后面对controller做了如下改造

访问接口，打印内容如下

这说明在controller其实也是可以用@Async，只是要额外做处理。所以建议是把@Async从controller中抽离出去，在新类中进行处理，示例如下

访问接口，打印内容

说明异步生效

从mvc日志

我们可以知道，controller映射处理是在RequestMappingHandlerMapping 这个类中，但具体是哪个方法进行处理呢，我们可以通过日志打印的信息，进行倒推，也可以基于spring的特性加断点调试，比如通过afterPropertiesSet这一启动扩展点调试起，就会发现RequestMappingHandlerMapping的映射处理是在

进行处理，具体是通过processCandidateBean进行处理

最终是通过detectHandlerMethods进行处理

这个里面就是做了实际注册。而执行detectHandlerMethods的前提是

即只有加了@Controller或者@RequestMapping的类会进行处理，而@RestController为啥也处理，点击
@RestController发现

他本质就是@Controller。但我们通过反射查找注解，正常只会查找一层，比如

他找到@RestController这一层，而不会找继续再找@RestController里面的@Controller，而AnnotatedElementUtils.hasAnnotation，这个注解方法就不一样，他是可以找到合并注解，即使是使用
@RestController，他还会继续找到里面的@Controller。因此这个方法对于找复合型注解很有用

当我们使用jdk动态代理时，因为父类上没加@Controller或者@RequestMapping，因此他不会被mvc进行映射处理，导致404。而使用cglib时，因为他是作为子类继承了目标类，因此他会继承目标类上的注解，因此当为cglib代理时，他会正常被mvc进行映射处理

这是因为加了@Async后，controller变成代理了，而当要异步处理方法，用this时，他使用的是目标对象，而非代理对象。这跟现在面试事务为啥事务失效的八股文基本是一个套路

本文主要讲@Async导致controller 404，同时也使@Async失效的原因。解决的推荐方法就是将@Async抽离出controller，新建一个service类进行处理。

记一次因硬盘故障导致的docker服务无法启动

早上刚到公司，老大说，运行着gogs代码库和mariadb数据库的宿主机崩溃了(ubuntu 18.04 LTS)。

重启电脑，默认方式启动，进入系统过程中抛出异常，信息为end Kernel panic - not syncing: No working init found.
使用恢复模式启动，可选的启动项有6个，分别对应3个内核版本(Linux 4.15.0-118, Linux 4.15.0-117和Linux 4.15.0-112，以及各自对应的recovery mode)。
挑了个低版本的恢复模式(Linux 4.15.0-112)进入。可以见到恢复模式的粗糙页面。

选择resume，继续引导过程。途中出现好多报错，待载入完成后使用journalctl -xe命令查看。例如/bin/mount for / exited with exit status 32， 例如Failed to start Remount Root and Kernel File Systems，例如Failed to start Message of the Day 。

既然进了系统，肯定得先确认下docker服务的状态。
切到root，使用docker ps ，提示服务未启动。
systemctl status docker，提示Failed to start Docker Application Container Engine.此路不通

直接使用dockerd命令启动，有了新的收获，提示chmod /var/lib/docker: read-only file system
试了下，根目录所在分区变成了只读。执行mount -o remount rw，也不好使。
此时，已经大致确定了初步的方向，磁盘挂载失败。
再次进入恢复模式，进入root命令行，执行fsck -y /dev/sda2 (根目录挂载点)，果然，有大量的修复提示

完成后再次重启，进入系统过程中一路顺利，未发现报错。docker服务也正常自启动。

事后总结：使用的是台式机，出现过突然断电、使用固态硬盘。故障原因可能与这几项有关。待后续确定