Fixed:Failed to parse multipart servlet request; nested exception is java.io.IOException
前言
今天在生产环境发生一个很诡异的bug,后台管理系统有一个文件上传功能。
奇怪的是,有时候文件上传可以成功,有时候上传文件会失败,诡异的很。
后台抓过来错误日志报错如下:
Servlet.service() for servlet [dispatcherServlet] in context with path [/xxxx/test-api] threw exception [Request processing failed; nested exception is org.springframework.web.multipart.MultipartException: Failed to parse multipart servlet request; nested exception is java.io.IOException: org.apache.tomcat.util.http.fileupload.impl.IOFileUploadException: Processing of multipart/form-data request failed. Stream closed] with root cause
java.io.IOException: Stream closed
at org.apache.catalina.connector.InputBuffer.throwIfClosed(InputBuffer.java:527)
at org.apache.catalina.connector.InputBuffer.read(InputBuffer.java:338)
at org.apache.catalina.connector.CoyoteInputStream.read(CoyoteInputStream.java:132)
at java.io.FilterInputStream.read(FilterInputStream.java:133)
at org.apache.tomcat.util.http.fileupload.util.LimitedInputStream.read(LimitedInputStream.java:132)
at org.apache.tomcat.util.http.fileupload.MultipartStream$ItemInputStream.makeAvailable(MultipartStream.java:975)
at org.apache.tomcat.util.http.fileupload.MultipartStream$ItemInputStream.read(MultipartStream.java:879)
at java.io.FilterInputStream.read(FilterInputStream.java:133)
at org.apache.tomcat.util.http.fileupload.util.LimitedInputStream.read(LimitedInputStream.java:132)
at java.io.FilterInputStream.read(FilterInputStream.java:107)
at org.apache.tomcat.util.http.fileupload.util.Streams.copy(Streams.java:98)
at org.apache.tomcat.util.http.fileupload.FileUploadBase.parseRequest(FileUploadBase.java:291)
at org.apache.catalina.connector.Request.parseParts(Request.java:2922)
at org.apache.catalina.connector.Request.parseParameters(Request.java:3253)
at org.apache.catalina.connector.Request.getParameter(Request.java:1142)
at org.apache.catalina.connector.RequestFacade.getParameter(RequestFacade.java:381)
at javax.servlet.ServletRequestWrapper.getParameter(ServletRequestWrapper.java:158)
at org.springframework.security.web.firewall.StrictHttpFirewall$StrictFirewalledRequest.getParameter(StrictHttpFirewall.java:687)
at javax.servlet.ServletRequestWrapper.getParameter(ServletRequestWrapper.java:158)
at javax.servlet.ServletRequestWrapper.getParameter(ServletRequestWrapper.java:158)
at javax.servlet.ServletRequestWrapper.getParameter(ServletRequestWrapper.java:158)
问题分析
针对报错信息,刚开始谷歌搜了一些资料
有的说需要配置修改下temp路径:
有的说是tomcat的一个bug,需要打开如下设置:
spring:
mvc:
hiddenmethod:
filter:
enabled: true
但是测试后发现并不好使。
于是尝试将Spring Boot 内置的tomcat 换成了Jetty,
但是发现切换成Jetty 之后虽然可以上传了,但是上传的图片都是一半,有另外一半压根显示不出来,也就是说上传的图片是残缺不完整的。
于是我又换成了Undertow ,发现问题和使用tomcat 一样。
直到饭后吃过饭后我继续追查日志,才发现一个问题根源:
有一个过滤器最开始是这么写的:
@Order(1)
@WebFilter(filterName = "appTokenAuthenticationFilter",urlPatterns = {"/*"},description = "APP接口权限过滤器")
@Slf4j
public class AppTokenAuthenticationFilter extends OncePerRequestFilter {
@Autowired
private CustomerInfoAppService customerInfoAppService;
@Autowired
private UserInfoLoginService userInfoLoginService;
@Override
protected void doFilterInternal(HttpServletRequest request, HttpServletResponse response, FilterChain filterChain) throws ServletException, IOException {
try {
MyAppThreadFactory.myCachedThreadPool.execute(() -> {
String token = request.getParameter("token_id");
String appType= request.getHeader("appType");
...
} catch (Exception e) {
log.error("更新出错",e);
}
//继续调用其他过滤器
filterChain.doFilter(request,response);
}
}
初步看好像也没啥的,但是这里却是最可疑的:
String token = request.getParameter("token_id");
String appType= request.getHeader("appType");
解决方案
当我尝试将这两行代码放到线程外面后果然好了。
修复后代码如下:
当在过滤器中开启一个线程,并且把request,response 同时带进这个线程中:
@Order(1)
@WebFilter(filterName = "appTokenAuthenticationFilter",urlPatterns = {"/*"},description = "APP接口权限过滤器")
@Slf4j
public class AppTokenAuthenticationFilter extends OncePerRequestFilter {
@Autowired
private CustomerInfoAppService customerInfoAppService;
@Autowired
private UserInfoLoginService userInfoLoginService;
@Override
protected void doFilterInternal(HttpServletRequest request, HttpServletResponse response, FilterChain filterChain) throws ServletException, IOException {
try {
String token = request.getParameter("token_id");
String appType= request.getHeader("appType");
MyAppThreadFactory.myCachedThreadPool.execute(() -> {
if(null!= SmartStringUtils.trimToNull(appType)&&null!=SmartStringUtils.trimToNull(token)){
...
});
} catch (Exception e) {
log.error("更新出错",e);
}
//继续调用其他过滤器
filterChain.doFilter(request,response);
}
}
思考
为什么呢?
这里大胆猜测下,
-
首先我们知道tomcat,Jetty,Undertow 都是基于Servlet API设计的web容器
-
其次,每发出一次请求都是一个线程中处理,经过过滤器, 然后request和response 由于传入了新开的线程,当同时有两个线程先后请求的时候可能会出现一个数据错位。
为了解释清楚,我们这里假设有两个管理员在执行上传文件操作:
第一个用户张三发出了一个请求,系统为该用户分配一个线程A 去处理。
后来发现新开了一个线程 W 要去处理点东西,将线程A的request 和response 传递了进入。
第二个用户李四这时候也发出了一个请求,系统同样为该用户分配一个线程B 去处理。
后来发现新开了一个线程 W 要去处理点东西,将线程B 的request 和response 传递了进入。
B 等了一会,结果W现场先结束,把线程A的request 和response 返回了,但是由于线程A
没有等待W 处理完,由于自己已经完成了文件上传,因此就把inputstream 关闭了。
而这时候线程B 读到了线程A 已经关闭的request 和response。
因此,这个问题就产生了,除此之外,一定要保证自己打开的inputstream 等I/O流用完后要记得关闭。
总结
多线程下操作数据还是要多当心,用完的I/O流要记得关闭,否则可能会造成内存溢出。