恒宇少年 · 2019年12月18日

ApiBoot接口服务框架的又一新特性GlobalLog全局日志的使用详解

全局日志是一个什么概念呢?

其实理解起来比较简单,类似于我们平时一直在使用的logbacklog4j这种的日志框架的其中一个功能部分,minbox-logging分布式日志框架目前独立于api-boot-plugins,已经加入了minbox-projects开源组织,之前博客有一系列的文章来讲解了ApiBoot Logging(内部是集成的minbox-logging)日志组件的使用以及极简的配置方式,可以访问ApiBoot 组件系列文章使用汇总了解日志组件的使用详情。

<hr/>

什么是全局日志?

在之前ApiBoot Logging分布式日志组件可以实现日志采集日志上报日志统一存储集成Spring Security集成Openfeign等功能,随着ApiBoot Logging 2.2.1.RELEASE版本的发布引入了一个新的概念,那就是GlobalLog

用过ApiBoot Logging日志组件的同学应该都有了解,它只会记录每一次发送请求相关的一些信息,如:请求参数、请求地址、请求头信息、响应内容等,并没有提供业务代码中的debuginfoerror等级日志的采集方式,就不要提上报这种日志到Logging Admin了。

新版本的发布给我们带来了春天,ApiBoot Logging为了方便代码的调试,执行时业务数据的监控,支持了采集业务代码内的不同等级的日志,而且还支持采集Exception的堆栈信息,方便定位错误,及时纠正。

了解GlobalLogging接口

为了支持业务全局日志,新版本中引入了GlobalLogging接口,我们先来看看这个接口的源码,如下所示:


/**
 * Global log collection interface
 * Provide debug, info, and error log collection
 *
 * @author 恒宇少年
 */
public interface GlobalLogging {
    /**
     * Collect Debug Level Logs
     *
     * @param msg log content
     */
    void debug(String msg);

    /**
     * Collect Debug Level Logs
     *
     * @param format    Unformatted log content
     * @param arguments List of parameters corresponding to log content
     */
    void debug(String format, Object... arguments);

    /**
     * Collect Info Level Logs
     *
     * @param msg log content
     */
    void info(String msg);

    /**
     * Collect Info Level Logs
     *
     * @param format    Unformatted log content
     * @param arguments List of parameters corresponding to log content
     */
    void info(String format, Object... arguments);

    /**
     * Collect Error Level Logs
     *
     * @param msg log content
     */
    void error(String msg);

    /**
     * Collect Error Level Logs
     *
     * @param msg       log content
     * @param throwable Exception object instance
     */
    void error(String msg, Throwable throwable);

    /**
     * Collect Error Level Logs
     *
     * @param format    Unformatted log content
     * @param arguments List of parameters corresponding to log content
     */
    void error(String format, Object... arguments);
}

GlobalLogging接口内提供了三种类型的日志采集方法,分别是:debuginfoerror,这个版本只是对日志的等级进行了划分,并没有添加限制或者过滤机制。

GlobalLogging当前版本有一个实现类org.minbox.framework.logging.client.global.support.GlobalLoggingMemoryStorage,该类实现了GlobalLogging内的全部方法,并将采集到的日志保存到了GlobalLoggingThreadLocal,方便统一上报到Logging Admin

为了方便后期修改Global Log的存储方式,ApiBoot Logging提供了一个配置参数api.boot.logging.global-logging-storage-away,该配置的默认值为memory,对应GlobalLoggingMemoryStorage实现类。

GlobalLogging自动化配置

ApiBoot Logging根据api.boot.logging.global-logging-storage-away配置参数,条件判断自动化配置了GlobalLogging接口的实现类,如下所示:

package org.minbox.framework.api.boot.autoconfigure.logging;
import ...
/**
 * the "minbox-logging" global log storage configuration
 *
 * @author 恒宇少年
 */
@Configuration
@ConditionalOnClass(GlobalLogging.class)
public class ApiBootLoggingGlobalLogStorageAutoConfiguration {
    /**
     * Instance global log memory mode storage
     *
     * @return {@link GlobalLoggingMemoryStorage}
     */
    @Bean
    @ConditionalOnProperty(prefix = API_BOOT_LOGGING_PREFIX,
        name = "global-logging-storage-away", havingValue = "memory", matchIfMissing = true)
    public GlobalLogging globalLogging() {
        return new GlobalLoggingMemoryStorage();
    }
}

根据globalLogging()方法上的条件注入注解@ConditionalOnProperty配置内容可以了解到,当我们在application.yml配置文件内添加api.boot.logging.global-logging-storage-away=memory时或者缺少该配置时,该方法会被调用并且创建一个GlobalLoggingMemoryStorage对象实例,并将该实例对象写入到IOC容器内,这样我们在使用GlobalLogging实例时,只需要注入就可以了,如下所示:

/**
  * {@link GlobalLogging}
  *
  * @see org.minbox.framework.logging.client.global.AbstractGlobalLogging
  * @see org.minbox.framework.logging.client.global.support.GlobalLoggingMemoryStorage
  */
@Autowired
private GlobalLogging logging;

使用GlobalLogging

采集的方式很简单,我们只需要注入GlobalLogging对象,使用该接口提供的方法即可,如下所示:

/**
 * 测试用户控制器
 *
 * @author 恒宇少年
 */
@RestController
@RequestMapping(value = "/user")
public class UserController {
    /**
     * {@link GlobalLogging}
     *
     * @see org.minbox.framework.logging.client.global.AbstractGlobalLogging
     * @see org.minbox.framework.logging.client.global.support.GlobalLoggingMemoryStorage
     */
    @Autowired
    private GlobalLogging logging;

    /**
     * 测试获取用户名
     *
     * @return
     */
    @GetMapping(value = "/name")
    public String getUserName() {
        logging.debug("这是一条debug级别的日志");
        logging.info("这是一条info级别的日志");
        return "用户名:恒宇少年";
    }
}

当我们调用GlobalLogging提供的不同日志等级的方法时,会自动将日志相关信息写入到GlobalLoggingThreadLocal的集合内,等到上报请求日志时一并提交给Logging Admin,由Logging Admin进行保存。

GlobalLogging表结构

GlobalLogging相关的全局日志采集到Logging Admin需要进行保存,所有对应添加了一个名为logging_global_logs信息表,结构如下所示:

CREATE TABLE `logging_global_logs` (
  `lgl_id` varchar(36) COLLATE utf8mb4_general_ci NOT NULL COMMENT '日志主键',
  `lgl_request_log_id` varchar(36) COLLATE utf8mb4_general_ci NOT NULL COMMENT '请求日志编号,关联logging_request_logs主键',
  `lgl_level` varchar(20) COLLATE utf8mb4_general_ci DEFAULT NULL COMMENT '日志等级',
  `lgl_content` mediumtext COLLATE utf8mb4_general_ci COMMENT '日志内容',
  `lgl_caller_class` varchar(200) COLLATE utf8mb4_general_ci DEFAULT NULL COMMENT '日志输出的类名',
  `lgl_caller_method` varchar(50) COLLATE utf8mb4_general_ci DEFAULT NULL COMMENT '日志输出的方法名称',
  `lgl_caller_code_line_number` int(11) DEFAULT NULL COMMENT '日志输出的代码行号',
  `lgl_exception_stack` mediumtext COLLATE utf8mb4_general_ci COMMENT 'error等级的日志异常堆栈信息',
  `lgl_create_time` mediumtext COLLATE utf8mb4_general_ci COMMENT '日志发生时间',
  PRIMARY KEY (`lgl_id`),
  KEY `logging_global_logs_logging_request_logs_lrl_id_fk` (`lgl_request_log_id`),
  CONSTRAINT `logging_global_logs_logging_request_logs_lrl_id_fk` FOREIGN KEY (`lgl_request_log_id`) REFERENCES `logging_request_logs` (`lrl_id`)
) ENGINE=InnoDB DEFAULT CHARSET=utf8mb4 COLLATE=utf8mb4_general_ci COMMENT='全局日志信息表';

采集Exception堆栈信息

使用GlobalLogging可以采集遇到异常的详细堆栈信息,可以让我们直接定位到问题出现的位置,在第一时间解决出现的问题,具体使用如下所示:

try {
  int a = 5 / 0;
} catch (Exception e) {
  logging.error(e.getMessage(), e);
}

运行测试

我们来运行本章的源码,看下日志采集的效果。

输出的采集日志

{
    "endTime":1576561372604,
    "globalLogs":[{
        "callerClass":"org.minbox.chapter.user.service.UserController",
        "callerCodeLineNumber":33,
        "callerMethod":"getUserName",
        "content":"这是一条debug级别的日志,发生时间:{}",
        "createTime":1576561372585,
        "level":"debug"
    },{
        "callerClass":"org.minbox.chapter.user.service.UserController",
        "callerCodeLineNumber":34,
        "callerMethod":"getUserName",
        "content":"这是一条info级别的日志,发生时间:1576561372586",
        "createTime":1576561372586,
        "level":"info"
    },{
        "callerClass":"org.minbox.chapter.user.service.UserController",
        "callerCodeLineNumber":43,
        "callerMethod":"aa",
        "content":"出现了异常.",
        "createTime":1576561372586,
        "exceptionStack":"java.lang.ArithmeticException: / by zero\n\tat org.minbox.chapter.user.service.UserController.aa(UserController.java:41)\n\tat org.minbox.chapter.user.service.UserController.getUserName(UserController.java:35)\n\tat sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)\n\tat sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)\n\t....",
        "level":"error"
    }],
    "httpStatus":200,
    "requestBody":"",
    "requestHeaders":{
        "accept":"*/*",
        "host":"localhost:10000",
        "user-agent":"curl/7.64.1"
    },
    "requestIp":"0:0:0:0:0:0:0:1",
    "requestMethod":"GET",
    "requestParam":"{}",
    "requestUri":"/user/name",
    "responseBody":"用户名:恒宇少年",
    "responseHeaders":{},
    "serviceId":"user-service",
    "serviceIp":"127.0.0.1",
    "servicePort":"10000",
    "spanId":"41a0c852-812b-4a2e-aa4a-228b87ce52f6",
    "startTime":1576561372577,
    "timeConsuming":27,
    "traceId":"42ca9f5a-5977-49cf-909d-a23614a47a6b"
}
上面是控制台输出的一个请求日志的详细内容,其中globalLogs字段就是我们采集的全局日志列表。

存储的采集日志

我们来确认下采集日志上报到Logging Admin后是否保存到了logging_global_logs日志表内,如下所示:

mysql> select * from logging_global_logs order by lgl_create_time asc\G;
*************************** 1. row ***************************
                     lgl_id: 112e36ff-e781-4f11-8f21-2196823cde38
         lgl_request_log_id: f91382e2-2d79-499e-b1df-4757c1ffdbc5
                  lgl_level: info
                lgl_content: 这是一条info级别的日志,发生时间:1576561856333
           lgl_caller_class: org.minbox.chapter.user.service.UserController
          lgl_caller_method: getUserName
lgl_caller_code_line_number: 34
        lgl_exception_stack: NULL
            lgl_create_time: 1576561856333
*************************** 2. row ***************************
                     lgl_id: f1d172a6-5cce-4df0-bc29-fe27ac441089
         lgl_request_log_id: f91382e2-2d79-499e-b1df-4757c1ffdbc5
                  lgl_level: debug
                lgl_content: 这是一条debug级别的日志,发生时间:{}
           lgl_caller_class: org.minbox.chapter.user.service.UserController
          lgl_caller_method: getUserName
lgl_caller_code_line_number: 33
        lgl_exception_stack: NULL
            lgl_create_time: 1576561856333
*************************** 3. row ***************************
                     lgl_id: d95d850d-3bc9-4689-928a-32c6089ff7a2
         lgl_request_log_id: f91382e2-2d79-499e-b1df-4757c1ffdbc5
                  lgl_level: error
                lgl_content: 出现了异常.
           lgl_caller_class: org.minbox.chapter.user.service.UserController
          lgl_caller_method: getUserName
lgl_caller_code_line_number: 38
        lgl_exception_stack: java.lang.ArithmeticException: / by zero
        at org.minbox.chapter.user.service.UserController.getUserName(UserController.java:36)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
                        ...
            lgl_create_time: 1576561856334
3 rows in set (0.01 sec)
这里异常的堆栈信息比较多,做出了省略。

敲黑板,划重点

本章把GlobalLog全局日志的概念进行了详细的描述,建议将一些重要逻辑判断性质的GlobalLog进行采集上报,防止logging_global_logs表内的数据量过大。

详细的使用方式请参考本章的源码。

代码示例

如果您喜欢本篇文章请为源码仓库点个Star,谢谢!!!
本篇文章示例源码可以通过以下途径获取,目录为apiboot-logging-use-global-log

作者个人 博客
使用开源框架 ApiBoot 助你成为Api接口服务架构师
推荐阅读
关注数
0
文章数
49
博客地址:[链接]开源框架ApiBoot官网:[链接]
目录
极术微信服务号
关注极术微信号
实时接收点赞提醒和评论通知
安谋科技学堂公众号
关注安谋科技学堂
实时获取安谋科技及 Arm 教学资源
安谋科技招聘公众号
关注安谋科技招聘
实时获取安谋科技中国职位信息