所谓的慢查询日志,是指系统在命令执行前后,记录命令执行时间,当超过某个预设阈值,就将这条命令的相关信息记录下来(例如发生时间、耗时、命令详细信息),Redis执行一条命令的流程如下
- 发送命令
- 命令排队
- 执行命令
- 返回结果
慢查询只计算步骤三的时间,所以没有慢查询并不代表客户端没有超时问题
1 两个配置参数
slowlog-log-slower-than 慢查询阈值,单位微妙
slowlog-max-len 慢查询日志条数
当命令的执行时间超过slowlog-log-slower-than的配置之后,会被记录到慢查询日志中,slowlog-max-len 是配置慢查询最多存储多少条,Redis实际上是用一个列表来存储慢查询日志,存于内存中
配置方式?可以通过配置文件或者config set命令配置着两个配置参数
- 配置文件
- config set key value
config命令配置方式如下,config rewrite表示刷新到配置文件,slowlog-log-slower-than配置成0表示记录所有命令执行的日志
127.0.0.1:6379> config set slowlog-log-slower-than 0
OK
127.0.0.1:6379> config set slowlog-max-len 3
OK
127.0.0.1:6379> config rewrite
OK
2 如何获取慢查询日志
(1)可以通过slowlog get [n] 获取慢查询日志
127.0.0.1:6379> slowlog get 3
1) 1) (integer) 1033
2) (integer) 1602592752
3) (integer) 1
4) 1) "REPLCONF"
2) "ACK"
3) "338958489"
5) "127.0.0.1:53294"
6) ""
2) 1) (integer) 1032
2) (integer) 1602592752
3) (integer) 8
4) 1) "PUBLISH"
2) "__sentinel__:hello"
3) "127.0.0.1,26380,520405055abe17e4e747d207eeb29eb3aa75864a,0,mymaster,127.0.0.1,6379,0"
5) "127.0.0.1:55420"
6) "sentinel-52040505-cmd"
3) 1) (integer) 1031
2) (integer) 1602592752
3) (integer) 2
4) 1) "PING"
5) "127.0.0.1:55420"
6) "sentinel-52040505-cmd
查询日志有四部分组成,标识id、发生时间戳、命令、参数
(2)slowlog len 获取慢查询日志长度
127.0.0.1:6379> slowlog len
(integer) 3
(3)slowlog reset 慢查询重置,就是清理掉慢查询日志
127.0.0.1:6379> slowlog reset
OK
127.0.0.1:6379> slowlog len (integer) 0
3 配置建议
slowlog-max-len配置建议:线上建议调大慢查询列表,记录慢查询时Redis会对长命令做截断操作,并不会占用大量内存。增大慢查询列表可以减缓慢查询被剔除的可能,例如线上可设置为1000以上。
slowlog-log-slower-than配置建议:默认值超过10毫秒判定为慢查询,需要根据Redis并发量调整该值。由于Redis采用单线程响应命令,对于高流量的场景,如果命令执行时间在1毫秒以上,那么Redis最多可支撑OPS不到1000。因此对于高OPS场景的Redis建议设置为1毫秒,Redis采用单线程响应命令,对于高流量的场景,如果命令执行时间在1毫秒以上,那么Redis最多可支撑OPS不到1000。因此对于高OPS场景的Redis建议设置为1毫秒