Spring接口访问时长统计

目前在线上的应用需要统计一下接口访问的时长，在不变动已有的业务代码的情况下，选择了用Filter来完成这个功能。代码实现如下：

1. 首先创建一个类，实现Filter接口，将创建好的filter注册到web容器中有两种方法

//1. 一个是用注解的方式.
@WebFilter(filterName = "ApiAccessFilter", urlPatterns = "/*")
//2. 另一个是在配置文件中声明

	<!-- 接口统计时长过滤器 -->
		<filter>
			<filter-name>apiAccessFilter</filter-name>
			<filter-class>com.bda.zjtag.app.filter.ApiAccessFilter</filter-class>
		</filter>
		<filter-mapping>
			<filter-name>apiAccessFilter</filter-name>
			<url-pattern>/*</url-pattern>
		</filter-mapping>

2. 在doFilter中实现统计接口时长的逻辑

 @Override
    public void doFilter(ServletRequest servletRequest, ServletResponse servletResponse,
                         FilterChain filterChain) throws IOException, ServletException {

        HttpServletRequest request = (HttpServletRequest) servletRequest;

        long start = System.currentTimeMillis();

        log.info("[Api Access] start. , uri: {}, method: {}, client: {}",
                request.getRequestURI(), request.getMethod());
        filterChain.doFilter(servletRequest, servletResponse);
        log.info("[Api Access]   end. duration: {}ms",
                System.currentTimeMillis() - start);

    }

启动之后，访问接口就会被统计了

2019-10-22 10:03:51.956 [http-nio-8080-exec-1] INFO  c.b.zjtag.app.filter.ApiAccessFilter.doFilter - [Api Access] start. , uri: /, method: GET, client: {}
2019-10-22 10:03:51.997 [http-nio-8080-exec-1] INFO  c.b.zjtag.app.filter.ApiAccessFilter.doFilter - [Api Access]   end. duration: 41ms
2019-10-22 10:03:52.010 [http-nio-8080-exec-1] INFO  c.b.zjtag.app.filter.ApiAccessFilter.doFilter - [Api Access] start. , uri: /, method: GET, client: {}
2019-10-22 10:03:52.015 [http-nio-8080-exec-1] INFO  c.b.zjtag.app.filter.ApiAccessFilter.doFilter - [Api Access]   end. duration: 5ms
2019-10-22 10:03:52.432 [http-nio-8080-exec-5] INFO  c.b.zjtag.app.filter.ApiAccessFilter.doFilter - [Api Access] start. , uri: /, method: GET, client: {}
2019-10-22 10:03:52.447 [http-nio-8080-exec-5] INFO  c.b.zjtag.app.filter.ApiAccessFilter.doFilter - [Api Access]   end. duration: 15ms
2019-10-22 10:04:24.343 [http-nio-8080-exec-6] INFO  c.b.zjtag.app.filter.ApiAccessFilter.doFilter - [Api Access] start. , uri: /, method: GET, client: {}
2019-10-22 10:04:24.347 [http-nio-8080-exec-6] INFO  c.b.zjtag.app.filter.ApiAccessFilter.doFilter - [Api Access]   end. duration: 4ms

完整代码

import org.slf4j.Logger;
import org.slf4j.LoggerFactory;

import javax.servlet.*;
import javax.servlet.annotation.WebFilter;
import javax.servlet.http.HttpServletRequest;
import java.io.IOException;


/**
 * @author lxa
 * @date 2019/10/22 9:40
 */
@WebFilter(filterName = "ApiAccessFilter", urlPatterns = "/*")
public class ApiAccessFilter implements Filter {

    private final Logger log = LoggerFactory.getLogger(this.getClass());

    @Override
    public void init(FilterConfig filterConfig) {

    }

    @Override
    public void doFilter(ServletRequest servletRequest, ServletResponse servletResponse,
                         FilterChain filterChain) throws IOException, ServletException {

        HttpServletRequest request = (HttpServletRequest) servletRequest;

        long start = System.currentTimeMillis();

        log.info("[Api Access] start. , uri: {}, method: {}, client: {}",
                request.getRequestURI(), request.getMethod());
        filterChain.doFilter(servletRequest, servletResponse);
        log.info("[Api Access]   end. duration: {}ms",
                System.currentTimeMillis() - start);

    }

    @Override
    public void destroy() {

    }


}