Spring boot实现AOP记录操作日志

在实际的项目中,特别是管理系统中,对于那些重要的操作我们通常都会记录操作日志。比如对数据库的CRUD操作,我们都会对每一次重要的操作进行记录,通常的做法是向数据库指定的日志表中插入一条记录。这里就产生了一个问题,难道要我们每次在CRUD的时候都手动的插入日志记录吗?这肯定是不合适的,这样的操作无疑是加大了开发量,而且不易维护,所以实际项目中总是利用AOP(Aspect Oriented Programming)即面向切面编程这一技术来记录系统中的操作日志。

日志分类

这里我把日志按照面向的对象不同分为两类:

面向用户的日志:用户是指使用系统的人,这一类日志通常记录在数据库里边,并且通常是记录对数据库的一些CRUD操作。

面向开发者的日志:查看这一类日志的一般都是开发人员,这类日志通常保存在文件或者在控制台打印(开发的时候在控制台,项目上线之后之后保存在文件中),这一类日志主要用于开发者开发时期和后期维护时期定位错误。

面向不同对象的日志,我们采用不同的策略去记录。很容易看出,对于面向用户的日志具有很强的灵活性,需要开发者控制用户的哪些操作需要向数据库记录日志,所以这一类保存在数据库的日志我们在使用AOP记录时用自定义注解的方式去匹配;而面向开发者的日志我们则使用表达式去匹配就可以了(这里有可能叙述的有点模糊,看了下面去案例将会很清晰),下面分别介绍两种日志的实现。

实现AOP记录面向用户的日志

接下来分步骤介绍Spring boot中怎样实现通过AOP记录操作日志。

添加依赖

在pom.xml文件中添加如下依赖:

<!-- aop依赖 -->org.springframework.bootspring-boot-starter-aop

修改配置文件

在项目的application.properties文件中添加下面一句配置:

spring.aop.auto=true

这里特别说明下,这句话不加其实也可以,因为默认就是true,只要我们在pom.xml中添加了依赖就可以了,这里提出来是让大家知道有这个有这个配置。

自定义注解

上边介绍过了了,因为这类日志比较灵活,所以我们需要自定义一个注解,使用的时候在需要记录日志的方法上添加这个注解就可以了,首先在启动类的同级包下边新建一个config包,在这个报下边新建new一个名为Log的Annotation文件,文件内容如下:

packagecom.web.springbootaoplog.config;importjava.lang.annotation.ElementType;importjava.lang.annotation.Retention;importjava.lang.annotation.RetentionPolicy;importjava.lang.annotation.Target;/***@authorPromise*@createTime2018年12月18日 下午9:26:25*@description定义一个方法级别的@log注解*/@Target(ElementType.METHOD)@Retention(RetentionPolicy.RUNTIME)public@interfaceLog {Stringvalue()default"";}

准备数据库日志表以及实体类,sql接口,xml文件

既然是向数据库中插入记录,那么前提是需要创建一张记录日志的表,下面给出我的表sql,由于是写样例,我这里这张表设计的很简单,大家可以自行设计。

CREATE TABLE `sys_log` (  `id` int(11) NOT NULL AUTO_INCREMENT COMMENT'主键',  `user_id` int(11) NOT NULL COMMENT'操作员id',  `user_action` varchar(255) NOT NULL COMMENT'用户操作',  `create_time` datetime DEFAULT NULL ON UPDATE CURRENT_TIMESTAMP COMMENT'创建时间',  PRIMARY KEY (`id`)) ENGINE=InnoDB AUTO_INCREMENT=12 DEFAULT CHARSET=utf8 COMMENT='日志记录表';

通过上篇博客介绍的MBG生成相应的实体类,sql接口文件,以及xml文件,这里不再概述,

当然还需要创建service接口文件以及接口实现类,这里直接给出代码:

ISysLogServcie.java

packagecom.web.springbootaoplog.service;importcom.web.springbootaoplog.entity.SysLog;/***@authorPromise*@createTime2018年12月18日 下午9:29:48*@description日志接口*/publicinterfaceISysLogService{/** * 插入日志 *@paramentity *@return*/intinsertLog(SysLog entity);}

SysLogServiceImpl.java

packagecom.web.springbootaoplog.service.impl;importorg.springframework.beans.factory.annotation.Autowired;importorg.springframework.stereotype.Service;importcom.web.springbootaoplog.config.Log;importcom.web.springbootaoplog.dao.SysLogMapper;importcom.web.springbootaoplog.entity.SysLog;importcom.web.springbootaoplog.service.ISysLogService;/***@authorPromise*@createTime2018年12月18日 下午9:30:57*@description*/@Service("sysLogService")publicclassSysLogServiceImplimplementsISysLogService{@AutowiredprivateSysLogMapper sysLogMapper;@OverridepublicintinsertLog(SysLog entity){// TODO Auto-generated method stubreturnsysLogMapper.insert(entity);}}

AOP的切面和切点

准备上边的相关文件后,下面来介绍重点--创建AOP切面实现类,同样我们这里将该类放在config包下,命名为LogAsPect.java,内容如下:

packagecom.web.springbootaoplog.config;importjava.lang.reflect.Method;importjava.util.Arrays;importjava.util.Date;importorg.aspectj.lang.JoinPoint;importorg.aspectj.lang.ProceedingJoinPoint;importorg.aspectj.lang.annotation.Around;importorg.aspectj.lang.annotation.Aspect;importorg.aspectj.lang.annotation.Before;importorg.aspectj.lang.annotation.Pointcut;importorg.aspectj.lang.reflect.MethodSignature;importorg.hibernate.validator.internal.util.logging.LoggerFactory;importorg.slf4j.Logger;importorg.springframework.beans.factory.annotation.Autowired;importorg.springframework.core.LocalVariableTableParameterNameDiscoverer;importorg.springframework.stereotype.Component;importcom.web.springbootaoplog.entity.SysLog;importcom.web.springbootaoplog.service.ISysLogService;/***@authorPromise*@createTime2018年12月18日 下午9:33:28*@description切面日志配置*/@Aspect@ComponentpublicclassLogAsPect{privatefinalstaticLogger log = org.slf4j.LoggerFactory.getLogger(LogAsPect.class);@AutowiredprivateISysLogService sysLogService;//表示匹配带有自定义注解的方法@Pointcut("@annotation(com.web.springbootaoplog.config.Log)")publicvoidpointcut(){}@Around("pointcut()")publicObjectaround(ProceedingJoinPoint point){Object result =null;longbeginTime = System.currentTimeMillis();try{    log.info("我在目标方法之前执行!");result = point.proceed();longendTime = System.currentTimeMillis();insertLog(point,endTime-beginTime);}catch(Throwable e) {// TODO Auto-generated catch block}returnresult;}privatevoidinsertLog(ProceedingJoinPoint point ,longtime){MethodSignature signature = (MethodSignature)point.getSignature();Method method = signature.getMethod();SysLog sys_log =newSysLog();Log userAction = method.getAnnotation(Log.class);if(userAction !=null) {// 注解上的描述sys_log.setUserAction(userAction.value());}// 请求的类名String className = point.getTarget().getClass().getName();// 请求的方法名String methodName = signature.getName();// 请求的方法参数值String args = Arrays.toString(point.getArgs());//从session中获取当前登陆人id// Long useride = (Long)SecurityUtils.getSubject().getSession().getAttribute("userid");Long userid =1L;//应该从session中获取当前登录人的id,这里简单模拟下sys_log.setUserId(userid);sys_log.setCreateTime(newjava.sql.Timestamp(newDate().getTime()));log.info("当前登陆人:{},类名:{},方法名:{},参数:{},执行时间:{}",userid, className, methodName, args, time);sysLogService.insertLog(sys_log);}}

这里简单介绍下关于AOP的几个重要注解:

@Aspect:这个注解表示将当前类视为一个切面类

@Component:表示将当前类交由Spring管理。

@Pointcut:切点表达式,定义我们的匹配规则,上边我们使用@Pointcut("@annotation(com.web.springbootaoplog.config.Log)")表示匹配带有我们自定义注解的方法。

@Around:环绕通知,可以在目标方法执行前后执行一些操作,以及目标方法抛出异常时执行的操作。

下面看一段关键的代码:

log.info("我在目标方法之前执行!");result = point.proceed();longendTime = System.currentTimeMillis();insertLog(point,endTime-beginTime);

其中result = point.proceed();这句话表示执行目标方法,可以看出我们在这段代码执行之前打印了一句日志,并在执行之后调用了insertLog()插入日志的方法,并且在方法中我们可以拿到目标方法所在的类名,方法名,参数等重要的信息。

测试控制器

在controller包下新建一个HomeCOntroller.java(名字大家随意),内容如下:

packagecom.web.springbootaoplog.controller;importjava.util.HashMap;importjava.util.Map;importorg.springframework.beans.factory.annotation.Autowired;importorg.springframework.stereotype.Controller;importorg.springframework.web.bind.annotation.RequestBody;importorg.springframework.web.bind.annotation.RequestMapping;importorg.springframework.web.bind.annotation.RequestMethod;importorg.springframework.web.bind.annotation.ResponseBody;importcom.web.springbootaoplog.config.Log;importcom.web.springbootaoplog.entity.SysLog;importcom.web.springbootaoplog.service.ISysLogService;/***@authorPromise*@createTime2019年1月2日 下午10:35:30*@description测试controller*/@ControllerpublicclassHomeController{privatefinalstaticLogger log = org.slf4j.LoggerFactory.getLogger(HomeController.class);@AutowiredprivateISysLogService logService;@RequestMapping("/aop")@ResponseBody@Log("测试aoplog")publicObjectaop(String name, String nick){Map map =newHashMap<>();log.info("我被执行了!");map.put("res","ok");returnmap;}}

定义一个测试方法,带有两个参数,并且为该方法添加了我们自定义的@Log注解,启动项目,浏览器访问localhost:8080/aop?name=xfr&nick=eran,这时候查看eclipse控制台的部分输出信息如下:

2019-01-24 22:02:17.682  INFO 3832 --- [nio-8080-exec-1] c.web.springbootaoplog.config.LogAsPect  : 我在目标方法之前执行!2019-01-24 22:02:17.688  INFO 3832 --- [nio-8080-exec-1] c.w.s.controller.HomeController          : 我被执行了!2019-01-24 22:02:17.689  INFO 3832 --- [nio-8080-exec-1] c.web.springbootaoplog.config.LogAsPect  : 当前登陆人:1,类名:com.web.springbootaoplog.controller.HomeController,方法名:aop,参数:[xfr, eran],执行时间:6

可以看到我们成功在目标方法执行前后插入了一些逻辑代码,现在再看数据库里边的数据

成功记录了一条数据。

实现AOP记录面向开发者的日志

首先这里我列举一个使用该方式的应用场景,在项目中出现了bug,我们想要知道前台的请求是否进入了我们控制器中,以及参数的获取情况,下面开始介绍实现步骤。

其实原理跟上边是一样的,只是切点的匹配规则变了而已,而且不用将日志记录到数据库,打印出来即可。

首先在LogAsPect.java中定义一个新的切点表达式,如下:

@Pointcut("execution(public * com.web.springbootaoplog.controller..*.*(..))")publicvoidpointcutController(){}

@Pointcut("execution(public * com.web.springbootaoplog.controller..*.*(..))")表示匹配com.web.springbootaoplog.controller包及其子包下的所有公有方法。

再添加匹配到方法时我们要做的操作:

@Before("pointcutController()")publicvoidaround2(JoinPoint point){//获取目标方法String methodNam = point.getSignature().getDeclaringTypeName() +"."+ point.getSignature().getName();//获取方法参数String params = Arrays.toString(point.getArgs());log.info("get in {} params :{}",methodNam,params);}

@Before:表示目标方法执行之前执行以下方法体的内容。

再在控制器中添加一个测试方法:

@RequestMapping("/testaop3")@ResponseBodypublicObjecttestAop3(String name, String nick){Map map =newHashMap<>();map.put("res","ok");returnmap;}

可以看到这个方法我们并没有加上@Log注解,重启项目,浏览器访问localhost:8080/testaop3?name=xfr&nick=eran,这时候查看eclipse控制台的部分输出信息如下:

2019-01-24 23:19:49.108  INFO 884 --- [nio-8080-exec-1] c.web.springbootaoplog.config.LogAsPect  : getincom.web.springbootaoplog.controller.HomeController.testAop3 params :[xfr, eran]

打印出了关键日志,这样我们就能知道是不是进入了该方法,参数获取是否正确等关键信息。

这里有的朋友或许会有疑问这样会不会与添加了@Log的方法重复了呢,的确会,所以在项目中我通常都将@Log注解用在了Service层的方法上,这样也更加合理。

结语

好了,关于Aop记录日志的内容就介绍这么多了在此我向大家推荐一个架构学习交流群。交流学习群号:938837867 暗号:555 里面会分享一些资深架构师录制的视频录像:有Spring,MyBatis,Netty源码分析,高并发、高性能、分布式、微服务架构的原理,JVM性能优化、分布式架构等这些成为架构师必备

©著作权归作者所有,转载或内容合作请联系作者
  • 序言:七十年代末,一起剥皮案震惊了整个滨河市,随后出现的几起案子,更是在滨河造成了极大的恐慌,老刑警刘岩,带你破解...
    沈念sama阅读 212,080评论 6 493
  • 序言:滨河连续发生了三起死亡事件,死亡现场离奇诡异,居然都是意外死亡,警方通过查阅死者的电脑和手机,发现死者居然都...
    沈念sama阅读 90,422评论 3 385
  • 文/潘晓璐 我一进店门,熙熙楼的掌柜王于贵愁眉苦脸地迎上来,“玉大人,你说我怎么就摊上这事。” “怎么了?”我有些...
    开封第一讲书人阅读 157,630评论 0 348
  • 文/不坏的土叔 我叫张陵,是天一观的道长。 经常有香客问我,道长,这世上最难降的妖魔是什么? 我笑而不...
    开封第一讲书人阅读 56,554评论 1 284
  • 正文 为了忘掉前任,我火速办了婚礼,结果婚礼上,老公的妹妹穿的比我还像新娘。我一直安慰自己,他们只是感情好,可当我...
    茶点故事阅读 65,662评论 6 386
  • 文/花漫 我一把揭开白布。 她就那样静静地躺着,像睡着了一般。 火红的嫁衣衬着肌肤如雪。 梳的纹丝不乱的头发上,一...
    开封第一讲书人阅读 49,856评论 1 290
  • 那天,我揣着相机与录音,去河边找鬼。 笑死,一个胖子当着我的面吹牛,可吹牛的内容都是我干的。 我是一名探鬼主播,决...
    沈念sama阅读 39,014评论 3 408
  • 文/苍兰香墨 我猛地睁开眼,长吁一口气:“原来是场噩梦啊……” “哼!你这毒妇竟也来了?” 一声冷哼从身侧响起,我...
    开封第一讲书人阅读 37,752评论 0 268
  • 序言:老挝万荣一对情侣失踪,失踪者是张志新(化名)和其女友刘颖,没想到半个月后,有当地人在树林里发现了一具尸体,经...
    沈念sama阅读 44,212评论 1 303
  • 正文 独居荒郊野岭守林人离奇死亡,尸身上长有42处带血的脓包…… 初始之章·张勋 以下内容为张勋视角 年9月15日...
    茶点故事阅读 36,541评论 2 327
  • 正文 我和宋清朗相恋三年,在试婚纱的时候发现自己被绿了。 大学时的朋友给我发了我未婚夫和他白月光在一起吃饭的照片。...
    茶点故事阅读 38,687评论 1 341
  • 序言:一个原本活蹦乱跳的男人离奇死亡,死状恐怖,灵堂内的尸体忽然破棺而出,到底是诈尸还是另有隐情,我是刑警宁泽,带...
    沈念sama阅读 34,347评论 4 331
  • 正文 年R本政府宣布,位于F岛的核电站,受9级特大地震影响,放射性物质发生泄漏。R本人自食恶果不足惜,却给世界环境...
    茶点故事阅读 39,973评论 3 315
  • 文/蒙蒙 一、第九天 我趴在偏房一处隐蔽的房顶上张望。 院中可真热闹,春花似锦、人声如沸。这庄子的主人今日做“春日...
    开封第一讲书人阅读 30,777评论 0 21
  • 文/苍兰香墨 我抬头看了看天上的太阳。三九已至,却和暖如春,着一层夹袄步出监牢的瞬间,已是汗流浃背。 一阵脚步声响...
    开封第一讲书人阅读 32,006评论 1 266
  • 我被黑心中介骗来泰国打工, 没想到刚下飞机就差点儿被人妖公主榨干…… 1. 我叫王不留,地道东北人。 一个月前我还...
    沈念sama阅读 46,406评论 2 360
  • 正文 我出身青楼,却偏偏与公主长得像,于是被迫代替她去往敌国和亲。 传闻我的和亲对象是个残疾皇子,可洞房花烛夜当晚...
    茶点故事阅读 43,576评论 2 349

推荐阅读更多精彩内容