同一份代碼俯树,虛機(jī)和Docker耗時差8倍速,什么原因?

一榛泛、背景

公司有一個使用golang開發(fā)的采集模塊,負(fù)責(zé)調(diào)用多個外部系統(tǒng)采集數(shù)據(jù)蓖墅;最近做了一次架構(gòu)上的調(diào)整库倘,將采集模塊分成api、job兩個子模塊论矾,并部署到容器中教翩,拆分前部署在虛機(jī)上。

二贪壳、現(xiàn)象

部分采集任務(wù)在容器中的執(zhí)行時間比虛機(jī)中執(zhí)行時間要長饱亿,8倍左右,本地測試無異常

三、排查思路

1. 調(diào)用外部接口耗時過長彪笼?

只有部分任務(wù)執(zhí)行時間長钻注,懷疑容器調(diào)用那部分系統(tǒng)接口比較慢,于是在容器中curl外部接口接口杰扫,發(fā)現(xiàn)并不慢队寇,排除這個可能。

2. 程序問題章姓?

將現(xiàn)有部署在虛機(jī)中的正常運行的應(yīng)用佳遣,部署到容器中發(fā)現(xiàn)部分任務(wù)也會慢; 將部署在容器中的應(yīng)用部署到虛機(jī)后恢復(fù)了正常凡伊;懷疑是容器本身或容器網(wǎng)絡(luò)的問題零渐,一時想不到是什么原因,于是開始了慢長的定位

3. pprof

pprof是golang提供的性能分析工具之一系忙,采集模塊已經(jīng)引入pprof诵盼,首先使用它進(jìn)行排查;

(1). 在容器中安裝pprof/flamegraph1

(2). 在容器中執(zhí)行如下命令,開啟pprof的http服務(wù)


pprof-4.png

(3).輸入上述http地址

  • 查看cpu profiler


    pprof-1.png
> 沒有什么太大異常,只有少許執(zhí)行邏輯消耗一秒多
  • 查看了top/flame graph都沒有查看到什么異常


    pprof-3.png
pprof-2.png

pprof中可以查看以下幾類信息

  • cpu(CPU Profiling): $HOST/debug/pprof/profile银还,默認(rèn)進(jìn)行 30s 的 CPU Profiling风宁,得到一個分析用的 profile 文件
  • block(Block Profiling):$HOST/debug/pprof/block,查看導(dǎo)致阻塞同步的堆棧跟蹤
  • goroutine:$HOST/debug/pprof/goroutine蛹疯,查看當(dāng)前所有運行的 goroutines 堆棧跟蹤
  • heap(Memory Profiling): $HOST/debug/pprof/heap戒财,查看活動對象的內(nèi)存分配情況
  • mutex(Mutex Profiling):$HOST/debug/pprof/mutex,查看導(dǎo)致互斥鎖的競爭持有者的堆棧跟蹤
  • threadcreate:$HOST/debug/pprof/threadcreate捺弦,查看創(chuàng)建新OS線程的堆棧跟蹤

由于跟網(wǎng)絡(luò)有關(guān)系饮寞,所以想查看下io耗時,pprof無法實現(xiàn)我的需求列吼,想到可以使用trace觀察

期間又使用go-torch采集火焰圖數(shù)據(jù)并查看幽崩,與pprof類似,感興趣的同學(xué)可自行嘗試

4. trace

trace也是go tool性能問題分析工具之一

(1) 打開trace

主要有以下幾塊:Goroutine寞钥、網(wǎng)絡(luò)阻塞慌申、同步鎖、同步阻塞等


(2) 觀察IO

一下子看到了60多秒理郑,心里一陣竊喜蹄溉,但從第一個節(jié)點開始已經(jīng)是50多秒了,仍然不知道是什么原因造成的香浩。又看了gorouting部分


看到network wait那一列耗時占比非常大类缤,心里又是一陣竊喜臼勉,基本確定是網(wǎng)絡(luò)的問題了邻吭,點擊某一個gorouting進(jìn)入grouting頁面,再根據(jù)慢的任務(wù)名稱找到相應(yīng)gorouting宴霸,點擊進(jìn)入到trace頁面



由于network占用大多數(shù)時間囱晴,連續(xù)點了靠后的幾個綠條膏蚓,發(fā)現(xiàn)最后一條語句一樣,到代碼中查看畸写,發(fā)現(xiàn)是調(diào)用redis的代碼驮瞧,于是在容器中ping redis服務(wù)器,又在虛機(jī)中ping,發(fā)現(xiàn)容器ping的響應(yīng)時間是虛機(jī)的26倍左右枯芬;想到公司的服務(wù)器分多地部署论笔,于是又查虛機(jī)、REDIS千所、容器的部署地域狂魔,發(fā)現(xiàn)虛機(jī)和REDIS在同一地域,而容器和REDIS服務(wù)器不在同一地域淫痰,這時才恍然大悟最楷,后面的解決辦法就簡單了,不在此贅述了待错;

四籽孙、總結(jié)

分析問題要從大到小,逐漸縮小范圍火俄,不能一上來就進(jìn)入細(xì)節(jié)犯建,這樣會耗時較長。開始我懷疑是虛機(jī)網(wǎng)絡(luò)問題烛占,排查了外部系統(tǒng)接口胎挎,但遺漏了REDIS,造成后面花了幾個小時仔細(xì)排查忆家。其實也是情有可原吧犹菇,這個采集模塊代碼細(xì)節(jié)我并不熟悉,對golang語言也不熟悉芽卿,只因負(fù)責(zé)這個模塊開發(fā)的同學(xué)束手無策揭芍,我是這個項目的負(fù)責(zé)人,只能趕鴨子上架了??卸例。一遇到問題称杨,我就有一種莫名的小激動,因為遇到了我未知的領(lǐng)域筷转,又有機(jī)會對技術(shù)有更深入的了解了姑原。

參考

最后編輯于
?著作權(quán)歸作者所有,轉(zhuǎn)載或內(nèi)容合作請聯(lián)系作者
  • 序言:七十年代末,一起剝皮案震驚了整個濱河市呜舒,隨后出現(xiàn)的幾起案子锭汛,更是在濱河造成了極大的恐慌,老刑警劉巖,帶你破解...
    沈念sama閱讀 212,383評論 6 493
  • 序言:濱河連續(xù)發(fā)生了三起死亡事件唤殴,死亡現(xiàn)場離奇詭異般婆,居然都是意外死亡,警方通過查閱死者的電腦和手機(jī)朵逝,發(fā)現(xiàn)死者居然都...
    沈念sama閱讀 90,522評論 3 385
  • 文/潘曉璐 我一進(jìn)店門蔚袍,熙熙樓的掌柜王于貴愁眉苦臉地迎上來,“玉大人配名,你說我怎么就攤上這事啤咽。” “怎么了渠脉?”我有些...
    開封第一講書人閱讀 157,852評論 0 348
  • 文/不壞的土叔 我叫張陵闰蚕,是天一觀的道長。 經(jīng)常有香客問我连舍,道長没陡,這世上最難降的妖魔是什么? 我笑而不...
    開封第一講書人閱讀 56,621評論 1 284
  • 正文 為了忘掉前任索赏,我火速辦了婚禮盼玄,結(jié)果婚禮上,老公的妹妹穿的比我還像新娘潜腻。我一直安慰自己埃儿,他們只是感情好,可當(dāng)我...
    茶點故事閱讀 65,741評論 6 386
  • 文/花漫 我一把揭開白布融涣。 她就那樣靜靜地躺著童番,像睡著了一般。 火紅的嫁衣襯著肌膚如雪威鹿。 梳的紋絲不亂的頭發(fā)上剃斧,一...
    開封第一講書人閱讀 49,929評論 1 290
  • 那天,我揣著相機(jī)與錄音忽你,去河邊找鬼幼东。 笑死,一個胖子當(dāng)著我的面吹牛科雳,可吹牛的內(nèi)容都是我干的根蟹。 我是一名探鬼主播,決...
    沈念sama閱讀 39,076評論 3 410
  • 文/蒼蘭香墨 我猛地睜開眼糟秘,長吁一口氣:“原來是場噩夢啊……” “哼简逮!你這毒婦竟也來了?” 一聲冷哼從身側(cè)響起尿赚,我...
    開封第一講書人閱讀 37,803評論 0 268
  • 序言:老撾萬榮一對情侶失蹤散庶,失蹤者是張志新(化名)和其女友劉穎沛婴,沒想到半個月后,有當(dāng)?shù)厝嗽跇淞掷锇l(fā)現(xiàn)了一具尸體督赤,經(jīng)...
    沈念sama閱讀 44,265評論 1 303
  • 正文 獨居荒郊野嶺守林人離奇死亡,尸身上長有42處帶血的膿包…… 初始之章·張勛 以下內(nèi)容為張勛視角 年9月15日...
    茶點故事閱讀 36,582評論 2 327
  • 正文 我和宋清朗相戀三年泻蚊,在試婚紗的時候發(fā)現(xiàn)自己被綠了躲舌。 大學(xué)時的朋友給我發(fā)了我未婚夫和他白月光在一起吃飯的照片。...
    茶點故事閱讀 38,716評論 1 341
  • 序言:一個原本活蹦亂跳的男人離奇死亡性雄,死狀恐怖没卸,靈堂內(nèi)的尸體忽然破棺而出,到底是詐尸還是另有隱情秒旋,我是刑警寧澤约计,帶...
    沈念sama閱讀 34,395評論 4 333
  • 正文 年R本政府宣布,位于F島的核電站迁筛,受9級特大地震影響煤蚌,放射性物質(zhì)發(fā)生泄漏。R本人自食惡果不足惜细卧,卻給世界環(huán)境...
    茶點故事閱讀 40,039評論 3 316
  • 文/蒙蒙 一尉桩、第九天 我趴在偏房一處隱蔽的房頂上張望。 院中可真熱鬧贪庙,春花似錦蜘犁、人聲如沸。這莊子的主人今日做“春日...
    開封第一講書人閱讀 30,798評論 0 21
  • 文/蒼蘭香墨 我抬頭看了看天上的太陽。三九已至导披,卻和暖如春屈扎,著一層夾襖步出監(jiān)牢的瞬間,已是汗流浹背撩匕。 一陣腳步聲響...
    開封第一講書人閱讀 32,027評論 1 266
  • 我被黑心中介騙來泰國打工助隧, 沒想到剛下飛機(jī)就差點兒被人妖公主榨干…… 1. 我叫王不留,地道東北人滑沧。 一個月前我還...
    沈念sama閱讀 46,488評論 2 361
  • 正文 我出身青樓并村,卻偏偏與公主長得像,于是被迫代替她去往敵國和親滓技。 傳聞我的和親對象是個殘疾皇子哩牍,可洞房花燭夜當(dāng)晚...
    茶點故事閱讀 43,612評論 2 350

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