springboot配置aop切面日志打印过程解析

更新时间：2020年01月16日 09:15:03 作者：森林木马

这篇文章主要介绍了springboot配置aop切面日志打印过程解析,文中通过示例代码介绍的非常详细，对大家的学习或者工作具有一定的参考学习价值,需要的朋友可以参考下

一、SpringBoot Aop说明

1. Aop

AOP(Aspect-Oriented Programming，面向切面编程)，它利用一种”横切”的技术，将那些多个类的共同行为封装到一个可重用的模块。便于减少系统的重复代码，降低模块之间的耦合度，并有利于未来的可操作性和可维护性。

2. AOP相关概念：
Aspect（切面）：声明类似于Java中的类声明，在Aspect中会包含一些Pointcut及相应的Advice。

Joint point（连接点）：表示在程序中明确定义的点。包括方法的调用、对类成员的访问等。

Pointcut（切入点）：表示一个组Joint point，如方法名、参数类型、返回类型等等。

Advice（通知）：Advice定义了在Pointcut里面定义的程序点具体要做的操作，它通过(before、around、after(return、throw)、finally来区别实在每个Joint point之前、之后还是执行前后要调用的代码。

Before：在执行方法前调用Advice，比如请求接口之前的登录验证。

Around：在执行方法前后调用Advice，这是最常用的方法。

After：在执行方法后调用Advice，after、return是方法正常返回后调用，after\throw是方法抛出异常后调用。

Finally：方法调用后执行Advice，无论是否抛出异常还是正常返回。

AOP proxy：AOP proxy也是Java对象，是由AOP框架创建，用来完成上述动作，AOP对象通常可以通过JDK dynamic proxy完成，或者使用CGLIb完成。

Weaving：实现上述切面编程的代码织入，可以在编译时刻，也可以在运行时刻，Spring和其它大多数Java框架都是在运行时刻生成代理。

二、代码示例

1. POM引入

<dependencies>
  <dependency>
    <groupId>org.springframework.boot</groupId>
    <artifactId>spring-boot-starter-web</artifactId>
  </dependency>
  <dependency>
    <groupId>org.springframework.boot</groupId>
    <artifactId>spring-boot-starter-aop</artifactId>
  </dependency>
  <!-- 分析客户端信息的工具类-->
  <dependency>
    <groupId>eu.bitwalker</groupId>
    <artifactId>UserAgentUtils</artifactId>
    <version>1.21</version>
  </dependency>
  <!-- lombok -->
  <dependency>
    <groupId>org.projectlombok</groupId>
    <artifactId>lombok</artifactId>
    <scope>1.18.10</scope>
  </dependency>
</dependencies>

2、切面：WebLogAspect代码

/**
 * 添加aop日志打印
 *
 * @author 马振全 2020/1/13 14:42
 */
@Aspect
@Component
@Slf4j
public class WebLogAspect {
  /**
   * 进入方法时间戳
   */
  private Long startTime;
  /**
   * 方法结束时间戳(计时)
   */
  private Long endTime;
 
  public WebLogAspect() {
  }
 
 
  /**
   * 定义请求日志切入点，其切入点表达式有多种匹配方式,这里是指定路径
   */
  @Pointcut("execution(public * com.soyoung.ad.engine.controller.*.*(..))")
  public void webLogPointcut() {
  }
 
  /**
   * 前置通知：
   * 1. 在执行目标方法之前执行，比如请求接口之前的登录验证;
   * 2. 在前置通知中设置请求日志信息，如开始时间，请求参数，注解内容等
   *
   * @param joinPoint
   * @throws Throwable
   */
  @Before("webLogPointcut()")
  public void doBefore(JoinPoint joinPoint) {
 
    // 接收到请求，记录请求内容
    ServletRequestAttributes attributes = (ServletRequestAttributes) RequestContextHolder.getRequestAttributes();
    HttpServletRequest request = attributes.getRequest();
    //获取请求头中的User-Agent
    UserAgent userAgent = UserAgent.parseUserAgentString(request.getHeader("User-Agent"));
    //打印请求的内容
    startTime = System.currentTimeMillis();
    log.info("请求开始时间：{}", LocalDateTime.now());
    log.info("请求Url : {}", request.getRequestURL().toString());
    log.info("请求方式 : {}", request.getMethod());
    log.info("请求ip : {}", request.getRemoteAddr());
    log.info("请求方法 : ", joinPoint.getSignature().getDeclaringTypeName() + "." + joinPoint.getSignature().getName());
    log.info("请求参数 : {}", Arrays.toString(joinPoint.getArgs()));
    // 系统信息
    log.info("浏览器：{}", userAgent.getBrowser().toString());
    log.info("浏览器版本：{}", userAgent.getBrowserVersion());
    log.info("操作系统: {}", userAgent.getOperatingSystem().toString());
  }
 
  /**
   * 返回通知：
   * 1. 在目标方法正常结束之后执行
   * 1. 在返回通知中补充请求日志信息，如返回时间，方法耗时，返回值，并且保存日志信息
   *
   * @param ret
   * @throws Throwable
   */
  @AfterReturning(returning = "ret", pointcut = "webLogPointcut()")
  public void doAfterReturning(Object ret) throws Throwable {
    endTime = System.currentTimeMillis();
    log.info("请求结束时间：{}", LocalDateTime.now());
    log.info("请求耗时：{}", (endTime - startTime));
    // 处理完请求，返回内容
    log.info("请求返回 : {}", ret);
  }
 
  /**
   * 异常通知：
   * 1. 在目标方法非正常结束，发生异常或者抛出异常时执行
   * 1. 在异常通知中设置异常信息，并将其保存
   *
   * @param throwable
   */
  @AfterThrowing(value = "webLogPointcut()", throwing = "throwable")
  public void doAfterThrowing(Throwable throwable) {
    // 保存异常日志记录
    log.error("发生异常时间：{}", LocalDateTime.now());
    log.error("抛出异常：{}", throwable.getMessage());
  }
}

3、@Before和@AfterReturning部分也可使用以下代码替代

/**
 * 在执行方法前后调用Advice，这是最常用的方法，相当于@Before和@AfterReturning全部做的事儿
 * @param pjp
 * @return
 * @throws Throwable
 */
@Around("webLogPointcut()")
public Object doAround(ProceedingJoinPoint pjp) throws Throwable {
  // 接收到请求，记录请求内容
  ServletRequestAttributes attributes = (ServletRequestAttributes) RequestContextHolder.getRequestAttributes();
  HttpServletRequest request = attributes.getRequest();
  //获取请求头中的User-Agent
  UserAgent userAgent = UserAgent.parseUserAgentString(request.getHeader("User-Agent"));
  //打印请求的内容
  startTime = System.currentTimeMillis();
  log.info("请求Url : {}" , request.getRequestURL().toString());
  log.info("请求方式 : {}" , request.getMethod());
  log.info("请求ip : {}" , request.getRemoteAddr());
  log.info("请求方法 : " , pjp.getSignature().getDeclaringTypeName() , "." , pjp.getSignature().getName());
  log.info("请求参数 : {}" , Arrays.toString(pjp.getArgs()));
// 系统信息
  log.info("浏览器：{}", userAgent.getBrowser().toString());
  log.info("浏览器版本：{}",userAgent.getBrowserVersion());
  log.info("操作系统: {}", userAgent.getOperatingSystem().toString());
  // pjp.proceed()：当我们执行完切面代码之后，还有继续处理业务相关的代码。proceed()方法会继续执行业务代码，并且其返回值，就是业务处理完成之后的返回值。
  Object ret = pjp.proceed();
  log.info("请求结束时间："+ LocalDateTime.now());
  log.info("请求耗时：{}" , (System.currentTimeMillis() - startTime));
  // 处理完请求，返回内容
  log.info("请求返回 : " , ret);
  return ret;
}

4、测试结果

2020-01-13 15:18:21.309 INFO xxx.WebLogAspect : 请求开始时间：2020-01-13T15:18:21.309
2020-01-13 15:18:21.309 INFO xxx.WebLogAspect : 请求Url : http://localhost:8020/api/v1/hourlyStat/findHourlyStatReportList
2020-01-13 15:18:21.320 INFO xxx.WebLogAspect : 请求方式 : POST
2020-01-13 15:18:21.321 INFO xxx.WebLogAspect : 请求ip : 0:0:0:0:0:0:0:1
2020-01-13 15:18:21.322 INFO xxx.WebLogAspect : 请求方法 : 
2020-01-13 15:18:21.325 INFO xxx.WebLogAspect : 请求参数 : [HourlyStat{subStrategyId=null}]
2020-01-13 15:18:21.326 INFO xxx.WebLogAspect : 浏览器：CHROME
2020-01-13 15:18:21.327 INFO xxx.WebLogAspect : 浏览器版本：78.0.3904.108
2020-01-13 15:18:21.333 INFO xxx.WebLogAspect : 操作系统: WINDOWS_10
2020-01-13 15:18:21.403 INFO xxx.WebLogAspect : 请求结束时间：2020-01-13T15:18:21.403
2020-01-13 15:18:21.405 INFO xxx.WebLogAspect : 请求耗时：94
2020-01-13 15:18:21.405 INFO xxx.WebLogAspect : 请求返回 : com.soyoung.ad.engine.common.Result@2f935d03
2020-01-13 15:18:21.492 INFO xxx.WebLogAspect : 请求结束时间：2020-01-13T15:18:21.492
2020-01-13 15:18:21.493 INFO xxx.WebLogAspect : 请求耗时：183
2020-01-13 15:18:21.494 INFO xxx.WebLogAspect : 请求返回 : com.soyoung.ad.engine.common.Result@7199e922
2020-01-13 15:18:42.859 INFO xxx.WebLogAspect : 请求开始时间：2020-01-13T15:18:42.859
2020-01-13 15:18:42.860 INFO xxx.WebLogAspect : 请求Url : http://localhost:8020/api/v1/hourlyStat/findHourlyStatReportList
2020-01-13 15:18:42.860 INFO xxx.WebLogAspect : 请求方式 : POST
2020-01-13 15:18:42.861 INFO xxx.WebLogAspect : 请求ip : 0:0:0:0:0:0:0:1
2020-01-13 15:18:42.861 INFO xxx.WebLogAspect : 请求方法 : 
2020-01-13 15:18:42.862 INFO xxx.WebLogAspect : 请求参数 : [HourlyStat{subStrategyId=1003}]
2020-01-13 15:18:42.862 INFO xxx.WebLogAspect : 浏览器：CHROME
2020-01-13 15:18:42.863 INFO xxx.WebLogAspect : 浏览器版本：78.0.3904.108
2020-01-13 15:18:42.864 INFO xxx.WebLogAspect : 操作系统: WINDOWS_10
2020-01-13 15:18:42.909 INFO xxx.WebLogAspect : 请求结束时间：2020-01-13T15:18:42.909
2020-01-13 15:18:42.910 INFO xxx.WebLogAspect : 请求耗时：50
2020-01-13 15:18:42.910 INFO xxx.WebLogAspect : 请求返回 : com.soyoung.ad.engine.common.Result@7d494cbd

以上就是本文的全部内容，希望对大家的学习有所帮助，也希望大家多多支持脚本之家。

您可能感兴趣的文章:

springboot中shiro使用自定义注解屏蔽接口鉴权实现
本文主要介绍了springboot中shiro使用自定义注解屏蔽接口鉴权实现，文中通过示例代码介绍的非常详细，对大家的学习或者工作具有一定的参考学习价值，需要的朋友们下面随着小编来一起学习学习吧
2022-07-07
Spring Boot集成validation实现参数校验功能
Bean Validation 是一个运行时的数据验证框架,在验证之后验证的错误信息会被马上返回,这篇文章主要介绍了Spring Boot集成validation实现参数校验功能,需要的朋友可以参考下
2024-05-05
MyBatis中RowBounds实现内存分页
RowBounds是MyBatis提供的一种内存分页方式,适用于小数据量的分页场景,本文就来详细的介绍一下,具有一定的参考价值,感兴趣的可以了解一下
2024-12-12
Mybatis打印SQL语句的几种常用方式
当我们动态sql拼接的块很多的时候,我们要想从*mapper.xml中直接找出完整的sql就会非常的难,这个时候经常会需要把组合之后的完整SQL语句打印出来,对调试非常有帮助的,所以本文小编给大家介绍了几种Mybatis打印SQL语句的常用方式,需要的朋友可以参考下
2023-11-11
spring boot获取session的值为null问题及解决方法
我在登陆的时候，登陆成功后将name存进了session，然后在获取个人信息时取出session里的name的值为null，接下来通过本文给大家分享springboot获取session的值为null问题,需要的朋友可以参考下
2023-05-05
解决Spring session(redis存储方式)监听导致创建大量redisMessageListenerConta
这篇文章主要介绍了解决Spring session(redis存储方式)监听导致创建大量redisMessageListenerContailner-X线程问题,需要的朋友可以参考下
2018-08-08
jmeter+ant+jenkins自动化测试环境配置搭建过程
在搭建jmeter+ant+jenkins环境有些前提条件，那就是要先配置好java环境、安装好jenkins以及配置好jmeter，这样才能省去很多的事情，对jmeter+ant+jenkins自动化测试环境配置搭建过程感兴趣的朋友一起看看吧
2021-12-12
json序列化时忽略值为null的字段2种方式实例
这篇文章主要给大家介绍了关于json序列化时忽略值为null的字段的2种方式,当对象中某个字段为null时,我们希望将对象转换成json时为null的字段不会被转换到json字符串,里面需要的朋友可以参考下
2023-10-10
远程debug调试入门
这篇文章主要介绍了Eclipse的Debug调试技巧大全（总结）,小编觉得挺不错的，现在分享给大家，也给大家做个参考。一起跟随小编过来看看吧吗，希望能给你带来帮助
2021-06-06
详解springboot 使用c3p0数据库连接池的方法
本篇文章主要介绍了springboot 使用c3p0数据库连接池的方法，具有一定的参考价值，感兴趣的小伙伴们可以参考一下
2017-09-09

springboot配置aop切面日志打印过程解析

相关文章

最新评论

大家感兴趣的内容

最近更新的内容

常用在线小工具