坚持,你才会成功

坚持,你才会成功

0. 写在最前面

之前实习天天在写业务,其中有一个业务是非常的复杂,涉及到了特别多的表。最后测下来,一个接口的时间,竟然要5s多。

当时想写一个AOP,来计算处理接口花费多长时间,也就是在业务逻辑的前面计算开始的时间,业务逻辑后面计算结束的时间,一相减即可。

但我发觉我竟然忘记怎么写了,哎,没办法,在此纪录,重新捡回吧。

1. 什么AOP

简单来说,AOP就是在不影响现有的业务逻辑下面,在业务前面后面织入一些其他逻辑。比如,日志,验证等等

2. SpringAOP有哪几种

  • @Before: 前置通知, 在方法执行之前执行

  • @After: 后置通知, 在方法执行之后执行

  • @AfterRunning: 返回通知, 在方法返回结果之后执行

  • @AfterThrowing: 异常通知, 在方法抛出异常之后

  • @Around: 环绕通知, 围绕着方法执行

假设我们现在有一个接口如下:

1 @RequestMapping("/aa")
2 public String a() {
3     Person person = new Person("zhangsan", 18);
4     redisService.put("person", person);
5     Person ps = redisService.get("person");
6     return ps.toString();
7 }

现在产品提了一个需求,我想在这段业务执行前,打印一句话,结束后在打印一句话。

很简单,我们直接改业务代码就行了,一个可以两个可以,但是多了呢,很严重影响业务逻辑,此时就可以用到了前置通知和后置通知。

 1 @Pointcut(value = "execution (public * com.test.mybatis.demo.web.DepartmentController.*(..))")
 2 public void pointCut() { }
 3
 4 @Before(value = "pointCut()")
 5 public void beforeMethod(JoinPoint joinPoint) {
 6     String methodName = joinPoint.getSignature().getName();
 7     List<Object> args = Lists.newArrayList(joinPoint.getArgs());
 8     log.info("The method [" + methodName + "] begins with " + args);
 9 }
10
11 @After(value = "pointCut()")
12 public void afterMethod(JoinPoint joinPoint) {
13     String methodName = joinPoint.getSignature().getName();
14     log.info("The method [" + methodName + "] ends");
15 }

解释下这段代码。

PointCut 简称切点,也就是一个表达式,我要在哪些接口上进行拦截,进行一个配置。他有他自己的一套规范,我们按照他的规范来就好了。

JoinPoint 简称连接点。程序执行的某个特定位置:如类某个方法调用前、调用后、方法抛出异常后等。JoinPoint 我可以获取到方法名,参数等等。

@Before,@After 一个是前置通知,一个是后置通知

 此时我再访问这个接口的时候,他的执行流程如下:

 beforeMethod  ==>  业务逻辑  ==>  afterMethod

是不是非常的神奇,AOP的实现方式可以看我这边博文:动态代理两种实现方式

 3. 回到我们的最初

如何计算一个接口耗时多少呢?

起初我想到可以用前置 + 后置 来做,但最后相减,变量怎么传递不好搞。想过用全局变量,但并发会出现问题。

此时我想到了很少用的环绕通知,最后代码如下:

 1 @Around("pointCut()")
 2 public Object aroundMethod(ProceedingJoinPoint joinPoint) {
 3     Object res = null;
 4     String methodName = joinPoint.getSignature().getName();
 5     try {
 6         // 前置通知
 7         Stopwatch stopwatch = Stopwatch.createStarted();
 8         // 执行目标方法
 9         res = joinPoint.proceed();
10         // 后置通知
11         long duration = stopwatch.elapsed(TimeUnit.MILLISECONDS);
12         log.info("{} 执行时长: {}", methodName, duration);
13     } catch (Throwable throwable) {
14         throwable.printStackTrace();
15     }
16     return res;
17 }

每次执行一个方法,他都会将你的执行时间打印出来。结果如下:

1 // 前置通知
2 2019-01-24 21:17:52.802  INFO 224 --- [nio-8080-exec-5] com.test.mybatis.demo.AOP.TestAOP        : The method [testAOP] begins
3 // 业务逻辑
4 这里是业务逻辑
5 // 环绕通知
6 2019-01-24 21:17:53.303  INFO 224 --- [nio-8080-exec-5] com.test.mybatis.demo.AOP.TestAOP        : testAOP 执行时长: 500
7 // 后置通知
8 2019-01-24 21:17:53.303  INFO 224 --- [nio-8080-exec-5] com.test.mybatis.demo.AOP.TestAOP        : The method [testAOP] ends

 

4. 写在最后

最后我想将这个计算接口时间的AOP定义成一个注解,只要我在接口上加这个注解,他就会打印时间,否则就不打印。

这是后期的一个目标。共勉

01-25 05:31