奇怪的性能低下

背景

昨晚需要跑一批數(shù)據(jù)到mongo中芝此,采用jmeter讀取數(shù)據(jù)文件向服務(wù)端發(fā)送請求的方式馒疹,將數(shù)據(jù)庫跑入數(shù)據(jù)庫橄碾。
數(shù)據(jù)量:200w
mongo與服務(wù)端均部署在同一臺機(jī)器上狡逢。

現(xiàn)象

在服務(wù)器上執(zhí)行jmeter腳本由境,但是數(shù)據(jù)慘不忍睹

測試截圖

看了服務(wù)器的cpu 和內(nèi)存的使用率棚亩,發(fā)現(xiàn)cpu(24核)只有67%,內(nèi)存只有20%(512G)虏杰。并發(fā)量只有200讥蟆,明顯對于服務(wù)端的壓力不大,排除硬件纺阔。

后來將并發(fā)量降低至50瘸彤,數(shù)據(jù)依然慘不忍睹。

猜測

懷疑是數(shù)據(jù)庫的索引沒有加州弟,但是服務(wù)端是會自動建立索引的钧栖,進(jìn)入mongo查看索引,發(fā)現(xiàn)都建立了婆翔。
決定開始mongo 慢查詢拯杠,看看是否是數(shù)據(jù)入庫時過慢造成的, 因為測試前數(shù)據(jù)庫是空的啃奴,隨著數(shù)據(jù)的進(jìn)入潭陪,伴隨著insert及query操作。

慢查詢分析流程

通過慢查詢?nèi)罩咀罾伲ㄎ幻織l語句的執(zhí)行時間依溯,比如超過了200ms的,那么就需要針對這個進(jìn)行優(yōu)化瘟则。
優(yōu)化步驟:

  1. 用慢查詢?nèi)罩荆╯ystem.profile)找到超過200ms的語句
  2. 然后再通過.explain()解析影響行數(shù)黎炉,分析為什么超過200ms
  3. 決定是不是需要添加索引

開啟慢查詢

Profiling級別說明
  • 0:關(guān)閉,不收集任何數(shù)據(jù)醋拧。
  • 1:采集慢查詢數(shù)據(jù)慷嗜,默認(rèn)是100毫秒淀弹。
  • 2:采集所有數(shù)據(jù)
開啟profiling
#查看狀態(tài):級別和時間
> db.getProfilingStatus()
{ "was" : 0, "slowms" : 100 }
#查看級別
> db.getProfilingLevel()
0
#設(shè)置級別
> db.setProfilingLevel(1)
{ "was" : 0, "slowms" : 100, "ok" : 1 }
#設(shè)置級別和時間
> db.setProfilingLevel(1,200)
{ "was" : 2, "slowms" : 100, "ok" : 1 }

需要注意的是,以上操作如果是在collection下操作庆械,只對該collection有效薇溃。如果需要對整個db有效,需要在db下執(zhí)行缭乘。每次執(zhí)行后返回的結(jié)果是修改前的狀態(tài)沐序。

慢查詢分析


{
        "op" : "insert",   #操作類型,有insert堕绩、query策幼、update、remove逛尚、getmore垄惧、command
        "ns" : "fingerprint.T_DEVICE_FP_ANDROID",   #操作集合
        "query" : {
                "insert" : "T_DEVICE_FP_ANDROID",
                "ordered" : true,
                "documents" : [
                        {
                                "_id" : ObjectId("58c143a5d8a7db667f13629b"),
                                "_class" : "*************",
                         
                        }
                ]
        },
        "ninserted" : 1,
        "keyUpdates" : 0,    #索引更新的數(shù)量刁愿,改變一個索引鍵帶有一個小的性能開銷绰寞,因為數(shù)據(jù)庫必須刪除舊的key,并插入一個新的key到B-樹索引
        "writeConflicts" : 0,
        "numYield" : 0,   #該操作為了使其他操作完成而放棄的次數(shù)铣口。通常來說滤钱,當(dāng)他們需要訪問還沒有完全讀入內(nèi)存中的數(shù)據(jù)時,操作將放棄脑题。這使得在MongoDB為了放棄操作進(jìn)行數(shù)據(jù)讀取的同時件缸,還有數(shù)據(jù)在內(nèi)存中的其他操作可以完成
        "locks" : {
                "Global" : {
                        "acquireCount" : {
                                "r" : NumberLong(1),
                                "w" : NumberLong(1)
                        }
                },
                "Database" : {
                        "acquireCount" : {
                                "w" : NumberLong(1)
                        }
                },
                "Collection" : {
                        "acquireCount" : {
                                "w" : NumberLong(1)
                        }
                }
        },
        "responseLength" : 40,
        "protocol" : "op_query",
        "millis" : 1601,   #消耗的時間(毫秒)
        "execStats" : {

        },
        "ts" : ISODate("2017-03-09T11:59:34.972Z"),
        "client" : "10.100.1.200",
        "allUsers" : [ ],
        "user" : ""
}

此處發(fā)現(xiàn)millis 數(shù)據(jù)很大,一個insert操作需要1.6s叔遂。需要進(jìn)行優(yōu)化他炊。

總結(jié)

上面的只是一個例子,實(shí)際中已艰,我當(dāng)時是在query遇到問題痊末,一個query執(zhí)行了2800ms。后來發(fā)現(xiàn)是有兩個字段沒有建索引導(dǎo)致的哩掺。但是依然沒有解決insert性能低下的問題凿叠。

后續(xù)有待繼續(xù)研究。

最后編輯于
?著作權(quán)歸作者所有,轉(zhuǎn)載或內(nèi)容合作請聯(lián)系作者
  • 序言:七十年代末嚼吞,一起剝皮案震驚了整個濱河市盒件,隨后出現(xiàn)的幾起案子,更是在濱河造成了極大的恐慌舱禽,老刑警劉巖炒刁,帶你破解...
    沈念sama閱讀 217,277評論 6 503
  • 序言:濱河連續(xù)發(fā)生了三起死亡事件,死亡現(xiàn)場離奇詭異誊稚,居然都是意外死亡翔始,警方通過查閱死者的電腦和手機(jī)飒筑,發(fā)現(xiàn)死者居然都...
    沈念sama閱讀 92,689評論 3 393
  • 文/潘曉璐 我一進(jìn)店門,熙熙樓的掌柜王于貴愁眉苦臉地迎上來绽昏,“玉大人协屡,你說我怎么就攤上這事∪” “怎么了肤晓?”我有些...
    開封第一講書人閱讀 163,624評論 0 353
  • 文/不壞的土叔 我叫張陵,是天一觀的道長认然。 經(jīng)常有香客問我补憾,道長,這世上最難降的妖魔是什么卷员? 我笑而不...
    開封第一講書人閱讀 58,356評論 1 293
  • 正文 為了忘掉前任盈匾,我火速辦了婚禮,結(jié)果婚禮上毕骡,老公的妹妹穿的比我還像新娘削饵。我一直安慰自己,他們只是感情好未巫,可當(dāng)我...
    茶點(diǎn)故事閱讀 67,402評論 6 392
  • 文/花漫 我一把揭開白布窿撬。 她就那樣靜靜地躺著,像睡著了一般叙凡。 火紅的嫁衣襯著肌膚如雪劈伴。 梳的紋絲不亂的頭發(fā)上,一...
    開封第一講書人閱讀 51,292評論 1 301
  • 那天握爷,我揣著相機(jī)與錄音跛璧,去河邊找鬼。 笑死新啼,一個胖子當(dāng)著我的面吹牛追城,可吹牛的內(nèi)容都是我干的。 我是一名探鬼主播师抄,決...
    沈念sama閱讀 40,135評論 3 418
  • 文/蒼蘭香墨 我猛地睜開眼漓柑,長吁一口氣:“原來是場噩夢啊……” “哼!你這毒婦竟也來了叨吮?” 一聲冷哼從身側(cè)響起辆布,我...
    開封第一講書人閱讀 38,992評論 0 275
  • 序言:老撾萬榮一對情侶失蹤,失蹤者是張志新(化名)和其女友劉穎茶鉴,沒想到半個月后锋玲,有當(dāng)?shù)厝嗽跇淞掷锇l(fā)現(xiàn)了一具尸體,經(jīng)...
    沈念sama閱讀 45,429評論 1 314
  • 正文 獨(dú)居荒郊野嶺守林人離奇死亡涵叮,尸身上長有42處帶血的膿包…… 初始之章·張勛 以下內(nèi)容為張勛視角 年9月15日...
    茶點(diǎn)故事閱讀 37,636評論 3 334
  • 正文 我和宋清朗相戀三年惭蹂,在試婚紗的時候發(fā)現(xiàn)自己被綠了伞插。 大學(xué)時的朋友給我發(fā)了我未婚夫和他白月光在一起吃飯的照片。...
    茶點(diǎn)故事閱讀 39,785評論 1 348
  • 序言:一個原本活蹦亂跳的男人離奇死亡盾碗,死狀恐怖媚污,靈堂內(nèi)的尸體忽然破棺而出,到底是詐尸還是另有隱情廷雅,我是刑警寧澤耗美,帶...
    沈念sama閱讀 35,492評論 5 345
  • 正文 年R本政府宣布,位于F島的核電站航缀,受9級特大地震影響商架,放射性物質(zhì)發(fā)生泄漏。R本人自食惡果不足惜蛇摸,卻給世界環(huán)境...
    茶點(diǎn)故事閱讀 41,092評論 3 328
  • 文/蒙蒙 一、第九天 我趴在偏房一處隱蔽的房頂上張望弃鸦。 院中可真熱鬧家破,春花似錦汰聋、人聲如沸烹困。這莊子的主人今日做“春日...
    開封第一講書人閱讀 31,723評論 0 22
  • 文/蒼蘭香墨 我抬頭看了看天上的太陽搔扁。三九已至稿蹲,卻和暖如春苛聘,著一層夾襖步出監(jiān)牢的瞬間焰盗,已是汗流浹背熬拒。 一陣腳步聲響...
    開封第一講書人閱讀 32,858評論 1 269
  • 我被黑心中介騙來泰國打工, 沒想到剛下飛機(jī)就差點(diǎn)兒被人妖公主榨干…… 1. 我叫王不留徐裸,地道東北人重贺。 一個月前我還...
    沈念sama閱讀 47,891評論 2 370
  • 正文 我出身青樓怯晕,卻偏偏與公主長得像谭期,于是被迫代替她去往敵國和親隧出。 傳聞我的和親對象是個殘疾皇子,可洞房花燭夜當(dāng)晚...
    茶點(diǎn)故事閱讀 44,713評論 2 354

推薦閱讀更多精彩內(nèi)容