前情提要
11月末我司商品服务的MongoDB主库曾出现过严重抖动、频繁锁库等情况。
由于诸多业务存在插入MongoDB、然后立即查询等逻辑,因此项目并未开启读写分离。
最终定位问题是由于:服务器自身磁盘 + 大量慢查询导致
基于上述情况,运维同学后续着重增强了对MongoDB慢查询的监控和告警
幸运的一点:在出事故之前刚好完成了缓存过期时间的升级且过期时间为一个月,C端查询都落在缓存上,因此没有造成P0级事故,仅仅阻塞了部分B端逻辑
事故回放
我司的各种监控做的比较到位,当天突然收到了数据库服务器负载较高的告警通知,于是我和同事们就赶紧登录了Zabbix监控,如下图所示,截图的时候是正常状态,当时事故期间忘记留图了,可以想象当时的数据曲线反正是该高的很低,该低的很高就是了。
Zabbix 分布式监控系统官网:https://www.zabbix.com/
开始分析
我们研发是没有操控服务器权限的,因此委托运维同学帮助我们抓取了部分查询记录,如下所示:
- ---------------------------------------------------------------------------------------------------------------------------+
- Op | Duration | Query ---------------------------------------------------------------------------------------------------------------------------+
- query | 5 s | {"filter": {"orgCode": 350119, "fixedStatus": {"$in": [1, 2]}}, "sort": {"_id": -1}, "find": "sku_main"}
- query | 5 s | {"filter": {"orgCode": 350119, "fixedStatus": {"$in": [1, 2]}}, "sort": {"_id": -1}, "find": "sku_main"} query | 4 s | {"filter": {"orgCode": 346814, "fixedStatus": {"$in": [1, 2]}}, "sort": {"_id": -1}, "find": "sku_main"} query | 4 s | {"filter": {"orgCode": 346814, "fixedStatus": {"$in": [1, 2]}}, "sort": {"_id": -1}, "find": "sku_main"} query | 4 s | {"filter": {"orgCode": 346814, "fixedStatus": {"$in": [1, 2]}}, "sort": {"_id": -1}, "find": "sku_main"}
- ...
查询很慢的话所有研发应该第一时间想到的就是索引的使用问题,所以立即检查了一遍索引,如下所示:
- ### 当时的索引
-
- db.sku_main.ensureIndex({"orgCode": 1, "_id": -1},{background:true});
- db.sku_main.ensureIndex({"orgCode": 1, "upcCode": 1},{background:true});
- ....
我屏蔽了干扰项,反正能很明显的看出来,这个查询是完全可以命中索引的,所以就需要直面第一个问题:
上述查询记录中排首位的慢查询到底是不是出问题的根源?
我的判断是:它应该不是数据库整体缓慢的根源,因为第一它的查询条件足够简单暴力,完全命中索引,在索引之上有一点其他的查询条件而已,第二在查询记录中也存在相同结构不同条件的查询,耗时非常短。
在运维同学继续排查查询日志时,发现了另一个比较惊爆的查询,如下:
- ### 当时场景日志
-
- query: { $query: { shopCategories.0: { $exists: false }, orgCode: 337451, fixedStatus: { $in: [ 1, 2 ] }, _id: { $lt: 2038092587 } }, $orderby: { _id: -1 } } planSummary: IXSCAN { _id: 1 } ntoreturn:1000 ntoskip:0 keysExamined:37567133 docsExamined:37567133 cursorExhausted:1 keyUpdates:0 writeConflicts:0 numYields:293501 nreturned:659 reslen:2469894 locks:{ Global: { acquireCount: { r: 587004 } }, Database: { acquireCount: { r: 293502 } }, Collection: { acquireCount: { r: 293502 } } }
-
- # 耗时
- 179530ms
# 耗时耗时180秒且基于查询的执行计划可以看出,它走的是_id_索引,进行了全表扫描,扫描的数据总量为:37567133,不慢才怪。
迅速解决
定位到问题后,没办法立即修改,第一要务是:止损
结合当时的时间也比较晚了,因此我们发了公告,禁止了上述查询的功能并短暂暂停了部分业务,,过了一会之后进行了主从切换,再去看Zabbix监控就一切安好了。
分析根源
我们回顾一下查询的语句和我们预期的索引,如下所示:
- ### 原始Query
- db.getCollection("sku_main").find({
- "orgCode" : NumberLong(337451),
- "fixedStatus" : {
- "$in" : [
- 1.0,
- 2.0
- ]
- },
- "shopCategories" : {
- "$exists" : false
- },
- "_id" : {
- "$lt" : NumberLong(2038092587)
- }
- }
- ).sort(
- {
- "_id" : -1.0
- }
- ).skip(1000).limit(1000);
-
- ### 期望的索引
- db.sku_main.ensureIndex({"orgCode": 1, "_id": -1},{background:true});
乍一看,好像一切都很Nice啊,字段orgCode等值查询,字段_id按照创建索引的方向进行倒序排序,为啥会这么慢?
但是,关键的一点就在 $lt 上
知识点一:索引、方向及排序
在MongoDB中,排序操作可以通过从索引中按照索引的顺序获取文档的方式,来保证结果的有序性。
如果MongoDB的查询计划器没法从索引中得到排序顺序,那么它就需要在内存中对结果排序。
注意:不用索引的排序操作,会在内存超过32MB时终止,也就是说MongoDB只能支持32MB以内的非索引排序
知识点二:单列索引不在乎方向
无论是MongoDB还是MySQL都是用的树结构作为索引,如果排序方向和索引方向相反,只需要从另一头开始遍历即可,如下所示:
- # 索引
- db.records.createIndex({a:1});
-
- # 查询
- db.records.find().sort({a:-1});
-
- # 索引为升序,但是我查询要按降序,我只需要从右端开始遍历即可满足需求,反之亦然
- MIN 0 1 2 3 4 5 6 7 MAX
MongoDB的复合索引结构
官方介绍:MongoDB supports compound indexes, where a single index structure holds references to multiple fields within a collection’s documents.
复合索引结构示意图如下所示:
该索引刚好和我们讨论的是一样的,userid顺序,score倒序。
我们需要直面第二个问题:复合索引在使用时需不需要在乎方向?
假设两个查询条件:
- # 查询 一
- db.getCollection("records").find({
- "userid" : "ca2"
- }).sort({"score" : -1.0});
-
-
- # 查询 二
- db.getCollection("records").find({
- "userid" : "ca2"
- }).sort({"score" : 1.0});
上述的查询没有任何问题,因为受到score字段排序的影响,只是数据从左侧还是从右侧遍历的问题,那么下面的一个查询呢?
- # 错误示范
- db.getCollection("records").find({
- "userid" : "ca2",
- "score" : {
- "$lt" : NumberLong(2038092587)
- }
- }).sort({"score" : -1.0});
错误原因如下:
- 由于score字段按照倒序排序,因此为了使用该索引,所以需要从左侧开始遍历
- 从倒序顺序中找小于某个值的数据,势必会扫描很多无用数据,然后丢弃,当前场景下找大于某个值才是最佳方案
- 所以MongoDB为了更多场景考虑,在该种情况下,放弃了复合索引,选用其他的索引,如 score 的单列索引
针对性修改
仔细阅读了根源之后,再回顾线上的查询语句,如下:
- ### 原始Query
- db.getCollection("sku_main").find({
- "orgCode" : NumberLong(337451),
- "fixedStatus" : {
- "$in" : [
- 1.0,
- 2.0
- ]
- },
- "shopCategories" : {
- "$exists" : false
- },
- "_id" : {
- "$lt" : NumberLong(2038092587)
- }
- }
- ).sort(
- {
- "_id" : -1.0
- }
- ).skip(1000).limit(1000);
-
- ### 期望的索引
- db.sku_main.ensureIndex({"orgCode": 1, "_id": -1},{background:true});
犯的错误一模一样,所以MongoDB放弃了复合索引的使用,该为单列索引,因此进行针对性修改,把 $lt 条件改为 $gt 观察优化结果:
- # 原始查询
- [TEMP INDEX] => lt: {"limit":1000,"queryObject":{"_id":{"$lt":2039180008},"categoryId":23372,"orgCode":351414,"fixedStatus":{"$in":[1,2]}},"restrictedTypes":[],"skip":0,"sortObject":{"_id":-1}}
-
- # 原始耗时
- [TEMP LT] => 超时 (超时时间10s)
-
- # 优化后查询
- [TEMP INDEX] => gt: {"limit":1000,"queryObject":{"_id":{"$gt":2039180008},"categoryId":23372,"orgCode":351414,"fixedStatus":{"$in":[1,2]}},"restrictedTypes":[],"skip":0,"sortObject":{"_id":-1}}
-
- # 优化后耗时
- [TEMP GT] => 耗时: 383ms , List Size: 999
总结
分析了小2000字,其实改动就是两个字符而已,当然真正的改动需要考虑业务的需要,但是问题既然已经定位,修改什么的就不难了,回顾上述内容总结如下:
- 学习数据库知识的时候可以用类比的方式,但是需要额外注意其不同的地方(MySQL、MongoDB索引、索引的方向)
- MongoDB数据库单列索引可以不在乎方向,如对无索引字段排序需要控制数据量级(32M)
- MongoDB数据库复合索引在使用中一定要注意其方向,要完全理解其逻辑,避免索引失效
本文转载自微信公众号「是Kerwin啊」,可以通过以下二维码关注。转载本文请联系是Kerwin啊公众号。