Redis的日志系统

今天中间件接口响应时间很长，经过大致排查,发现是访问Redis慢，并且Redis的cpu确实已经飙到了98%左右，现在需要定位问题.先打开

今天中间件接口响应时间很长，经过大致排查,发现是访问Redis慢，并且Redis的cpu确实已经飙到了98%左右，现在需要定位问题.先打开redis的slowlog。

什么是 SLOWLOG

Slow log 是 Redis 用来记录查询执行时间的日志系统。

查询执行时间指的是不包括像客户端响应(talking)、发送回复等 IO 操作，而单单是执行一个查询命令所耗费的时间。

另外，，slow log 保存在内存里面，读写速度非常快，因此你可以放心地使用它，不必担心因为开启 slow log 而损害 Redis 的速度。

Slow log 的行为由两个配置参数(configuration parameter)指定，可以通过改写 redis.conf 文件或者用 CONFIG 和 CONFIG 命令对它们动态地进行修改。

第一个选项是 slowlog-log-slower-than ，它决定要对执行时间大于多少微秒(microsecond，1秒 = 1,000,000 微秒)的查询进行记录。

比如执行以下命令将让 slow log 记录所有查询时间大于等于 100 微秒的查询：

CONFIG set slowlog-log-slower-than 100

而以下命令记录所有查询时间大于 1000 微秒的查询：

CONFIG set slowlog-log-slower-than 1000

另一个选项是 slowlog-max-len ，它决定 slow log 最多 能保存多少条日志， slow log 本身是一个 LIFO 队列，当队列大小超过 slowlog-max-len 时，最旧的一条日志将被删除，而最新的一条日志加入到 slow log ，以此类推。

以下命令让 slow log 最多保存 1000 条日志：

CONFIG get slowlog-max-len

使用 CONFIG 命令可以查询两个选项的当前值：

查看 slow log

要查看 slow log ，可以使用 SLOWLOG GET 或者 SLOWLOG GET number 命令，前者打印所有 slow log ，最大长度取决于 slowlog-max-len 选项的值，而 SLOWLOG number 则只打印指定数量的日志。

最新的日志会最先被打印：

日志的唯一 id 只有在 Redis 服务器重启的时候才会重置，这样可以避免对日志的重复处理(比如你可能会想在每次发现新的慢查询时发邮件通知你)。

查看当前日志的数量

使用命令 SLOWLOG 可以查看当前日志的数量。

请注意这个值和 slower-max-len 的区别，它们一个是当前日志的数量，一个是允许记录的最大日志的数量。
redis> SLOWLOG LEN
(integer) 14

清空日志

使用命令 SLOWLOG RESET 可以清空 slow log 。
redis> SLOWLOG LEN
(integer) 14

redis> SLOWLOG RESET
redis> SLOWLOG LEN
(integer) 0

通过慢日志,可以发现程序中使用了 keys message_* 命令,导致中间件响应时间长.修改代码,问题排除。

下面关于Redis的文章您也可能喜欢，不妨参考下：

Ubuntu 14.04下Redis安装及简单测试

Redis主从复制基本配置

Redis集群明细文档

Ubuntu 12.10下安装Redis（图文详解）+ Jedis连接Redis

Redis系列-安装部署维护篇

CentOS 6.3安装Redis

Redis安装部署学习笔记

Redis配置文件redis.conf 详解

Redis 的详细介绍：请点这里
Redis 的下载地址：请点这里

本文永久更新链接地址：