go性能優(yōu)化

程序各種指標(biāo)

是指程序中己動態(tài)分配的堆內(nèi)存由于某種原因程序未釋放或無法釋放,造成系統(tǒng)內(nèi)存的浪費剑令,導(dǎo)致程序運行速度減慢甚至系統(tǒng)崩潰等嚴重后果。在程序中一個不小心的操作可能會導(dǎo)致內(nèi)存泄漏,但是寫程序的人可能根本沒有意識到幽污,所以我們要對我們的項目做測試,檢查程序那些地方的內(nèi)存沒有被回收導(dǎo)致了內(nèi)存的泄漏簿姨。
好在golang為我們提供了pprof包距误,通過它的HTTP服務(wù)端提供pprof可視化工具期望格式的運行時剖面文件數(shù)據(jù)服務(wù)。關(guān)于pprof的更多信息,參見http://code.google.com/p/google-perftools/准潭。

  1. 如果你的程序是web程序
  • 在沒有使用任何框架的前提下么夫,在程序中導(dǎo)入import _ "net/http/pprof"奔脐,然后同樣監(jiān)聽本地的一個端口http.ListenAndServe("localhost:6060", nil),即可,啟動程序浇坐,你可以訪問localhost:6060/debug/pprof監(jiān)控頁面,大致樣子是:
/debug/pprof/

profiles:
    0block
    7goroutine
   86heap
    0mutex
   13threadcreate

full goroutine stack dump
  • 如果你使用了其他的go-web框架桨螺,那么也可以自己添加路由"/debug/pprof/profile科汗,handler方法即使用net/http/pprof下的方法即可。

gin-web框架的/debug/pprof可以參考:github.com/DeanThompson/ginpprof

net/http/pprof下的方法有很多個武鲁,都是為我們提供程序運行的一些參數(shù)的爽雄,你可以在$GOROOT/src/net/http/pprof下查看。/net/http/pprof其實也只是對/runtime/pprof的一層封裝而已

  1. 如果你的程序不是web程序
  • 同時也不想開一個端口來獲得程序運行時的cpu沐鼠,內(nèi)存和其他的一些參數(shù)挚瘟。那么可以直接使用/runtime/下的一些包
import  (
    "runtime/pprof"
    "log"
)
func main() {
    f, err := os.OpenFile("cpu.prof", os.O_RDWR|os.O_CREATE, 0644)
    if err != nil {
        log.Fatal(err)
    }
    defer f.Close()
    /**
      省略操作
    */
    pprof.StartCPUProfile(f)
    defer pprof.StopCPUProfile()
}

os.O_CREATE表示該文件不存在則創(chuàng)建,運行這個程序后就會在該目錄下生成一個cpu.prof文件
現(xiàn)在使用go tool pprof來分析這個prof文件饲梭。

pprof分析.prof文件命令為:go tool pprof <程序名稱> <.prof文件路徑>

然后進入pprof的控制臺乘盖,輸入help會得到一些常用命令,如top 10憔涉。
更多命令以及其中的含義可以參見:go tool pprof

進一步分析(svg)

安裝FlameGraph

git clone https://github.com/brendangregg/FlameGraph.git
cp FlameGraph/flamegraph.pl /usr/local/bin
然后執(zhí)行命令flamegraph.pl -h查看是否有help信息表明是否安裝成功

web瀏覽

假設(shè)現(xiàn)在已經(jīng)啟動了一個web程序订框,然后我們開一個終端用命令go tool pprof --seconds 25 http://localhost:8080/debug/pprof/profile設(shè)置采樣時間和路徑,再開一個終端用wrk壓測工具:壓測30s兜叨,其他參數(shù)自定義穿扳。等到時間結(jié)束后,在第一個終端那里會出現(xiàn)(pprof)国旷,這和之前分析.prof文件效果是一樣的矛物,不同的是這里沒有生成文件。然后我們輸入命令web——表示用web瀏覽器打開跪但。如果出現(xiàn)如下提示

Failed to execute dot. Is Graphviz installed? Error: exec: "dot": executable file not found in$PATH

此時可用如下命令安裝Graphviz

sudo apt install graphviz

然后再次輸入web履羞,那么會在web頁面看到

Screenshot from 2017-10-25 21-53-44.png

這是一個很簡單程序生成的svg圖都這么多內(nèi)容,難以想象一個復(fù)雜的程序讀這樣的圖時該從哪個地方下手特漩,找出部分函數(shù)的cpu使用超標(biāo)吧雹,內(nèi)存使用超標(biāo)來進行性能的優(yōu)化。

更加直觀的火焰圖go-torch

go-torch是Uber開發(fā)的一個工具涂身,它的github地址

go get github.com/uber/go-torch
go install github.com/uber/go-torch
即可完成go-torch的安裝

  • 現(xiàn)在打開一個終端雄卷,運行g(shù)o-torch
  • 另開一個終端,再次使用wrk壓測工具壓測30s等到時間結(jié)束之后蛤售,大致可以在go-torch的目錄下看到這樣的信息

INFO[21:37:37] Run pprof command: go tool pprof -raw -seconds 30 http://localhost:8080/debug/pprof/profile
INFO[21:38:08] Writing svg to torch.svg

對于這個torch.svg丁鹉,使用瀏覽器打開妒潭,效果如下:

Screenshot from 2017-10-25 21-47-58.png
  • 每一個小方塊都是可以點擊查看詳細信息
  • y軸表示cpu調(diào)用方法的先后
  • x軸表示在每個采樣調(diào)用時間內(nèi),方法所占的時間百分比揣钦,越寬代表占據(jù)cpu時間越多雳灾。

trace

前面講的pprof適合于跟蹤運行緩慢的函數(shù),或者找到大部分CPU時間花費在哪里冯凹,并且顯示在每個函數(shù)中花費的CPU時間的百分比谎亩;而trace則更適合于找出程序在一段時間內(nèi)正在做什么,而不是總體上的開銷宇姚。

func main() {
    f, err := os.Create("trace.out")
    if err != nil {
        panic(err)
    }
    defer f.Close()
    err = trace.Start(f)
    if err != nil {
        panic(err)
    }
    defer trace.Stop()
    //每10s執(zhí)行一次GC
    t1 := time.NewTicker(time.Second * 10)
    go func() {
        for {
            select {
            case <-t1.C:
                log.Println("runtime.gc()")
                runtime.GC()
            }
        }
    }()

    // Your logic code here
}
  1. 這是代碼的一部分匈庭,當(dāng)程序運行起來之后,每隔10s就會向trace.out中寫入gc的信息浑劳。
  • 如果你想在控制臺看到gc的信息阱持,可以運行如下命令

go build yourProgram
GODEBUG=gctrace=1 ./yourProgram

控制臺打印信息類似于

gc 1 @10.003s 0%: 0.086+1.2+0.026 ms clock, 0.25+0/1.2/0+0.078 ms cpu, 1->1->0 MB, 4 MB goal, 4 P (forced)
gc 2 @20.003s 0%: 0.061+0.44+0.016 ms clock, 0.18+0/0.42/0.41+0.050 ms cpu, 0->0->0 MB, 4 MB goal, 4 P (forced)
scvg0: inuse: 1, idle: 1, sys: 2, released: 0, consumed: 2 (MB)

控制臺打印信息的說明

  1. gc后面的數(shù)字表示第幾次執(zhí)行g(shù)c
  2. 0%表示表示垃圾回收時間占用的百分比
  3. 0.086+1.2+0.026ms clock表示垃圾回收的時間。分別為STW(stop-the-world)清掃的時間, 并發(fā)標(biāo)記和掃描的時間魔熏,STW標(biāo)記的時間
  4. 0.25+0/1.2/0+0.078 ms cpu表示垃圾回收占用cpu時間
  5. 1->1->0 MB表示堆的大小衷咽,gc后堆的大小,存活堆的大小
  6. 4 MB goal表示整體堆的大小
  7. 4 P表示處理器的數(shù)量
  8. 系統(tǒng)內(nèi)存回收信息
    scvg0: inuse: 1, idle: 1, sys: 2, released: 0, consumed: 2 (MB)
    inuse:使用多少M內(nèi)存
    idle:剩下要清除的內(nèi)存
    sys:系統(tǒng)映射的內(nèi)存
    released:釋放的系統(tǒng)內(nèi)存
    consumed:申請的系統(tǒng)內(nèi)存
  • 或者使用go tool trace分析trace.out文件蒜绽,看看gc更加詳細的情況

go tool trace -http="localhost:8888" <yourProgramName> trace.out

該命令在go1.6以下的版本中需要<yourProgramName>參數(shù)镶骗,即可運行的二進制文件,在go1.6之后的版本則不再需要這個參數(shù)滓窍。
現(xiàn)在你可以訪問localhost:8888看看trace文件中都記錄了什么內(nèi)容卖词,訪問localhost:8888/trace即可看到更詳細的信息。

  1. 上述代碼是直接在程序中生成trace.out二進制文件吏夯,如果你為trace開通了http服務(wù),那么直接運行如下命令可進行10s的采樣數(shù)據(jù)
    curl 127.0.0.1:port/debug/pprof/trace?seconds=10 trace.data
    如果提示curl(6)錯誤即横,那么你可以直接在瀏覽器訪問localhost:port/debug/pprof/trace?seconds=10也會得到相應(yīng)的采樣數(shù)據(jù)噪生,獲得采樣數(shù)據(jù)之后可以利用上述步驟分析trace文件
最后編輯于
?著作權(quán)歸作者所有,轉(zhuǎn)載或內(nèi)容合作請聯(lián)系作者
  • 序言:七十年代末,一起剝皮案震驚了整個濱河市东囚,隨后出現(xiàn)的幾起案子跺嗽,更是在濱河造成了極大的恐慌,老刑警劉巖页藻,帶你破解...
    沈念sama閱讀 218,755評論 6 507
  • 序言:濱河連續(xù)發(fā)生了三起死亡事件桨嫁,死亡現(xiàn)場離奇詭異,居然都是意外死亡份帐,警方通過查閱死者的電腦和手機璃吧,發(fā)現(xiàn)死者居然都...
    沈念sama閱讀 93,305評論 3 395
  • 文/潘曉璐 我一進店門,熙熙樓的掌柜王于貴愁眉苦臉地迎上來废境,“玉大人畜挨,你說我怎么就攤上這事筒繁。” “怎么了巴元?”我有些...
    開封第一講書人閱讀 165,138評論 0 355
  • 文/不壞的土叔 我叫張陵毡咏,是天一觀的道長。 經(jīng)常有香客問我逮刨,道長呕缭,這世上最難降的妖魔是什么? 我笑而不...
    開封第一講書人閱讀 58,791評論 1 295
  • 正文 為了忘掉前任修己,我火速辦了婚禮恢总,結(jié)果婚禮上,老公的妹妹穿的比我還像新娘箩退。我一直安慰自己离熏,他們只是感情好,可當(dāng)我...
    茶點故事閱讀 67,794評論 6 392
  • 文/花漫 我一把揭開白布戴涝。 她就那樣靜靜地躺著滋戳,像睡著了一般。 火紅的嫁衣襯著肌膚如雪啥刻。 梳的紋絲不亂的頭發(fā)上奸鸯,一...
    開封第一講書人閱讀 51,631評論 1 305
  • 那天,我揣著相機與錄音可帽,去河邊找鬼娄涩。 笑死,一個胖子當(dāng)著我的面吹牛映跟,可吹牛的內(nèi)容都是我干的蓄拣。 我是一名探鬼主播,決...
    沈念sama閱讀 40,362評論 3 418
  • 文/蒼蘭香墨 我猛地睜開眼努隙,長吁一口氣:“原來是場噩夢啊……” “哼球恤!你這毒婦竟也來了?” 一聲冷哼從身側(cè)響起荸镊,我...
    開封第一講書人閱讀 39,264評論 0 276
  • 序言:老撾萬榮一對情侶失蹤咽斧,失蹤者是張志新(化名)和其女友劉穎,沒想到半個月后躬存,有當(dāng)?shù)厝嗽跇淞掷锇l(fā)現(xiàn)了一具尸體张惹,經(jīng)...
    沈念sama閱讀 45,724評論 1 315
  • 正文 獨居荒郊野嶺守林人離奇死亡,尸身上長有42處帶血的膿包…… 初始之章·張勛 以下內(nèi)容為張勛視角 年9月15日...
    茶點故事閱讀 37,900評論 3 336
  • 正文 我和宋清朗相戀三年岭洲,在試婚紗的時候發(fā)現(xiàn)自己被綠了宛逗。 大學(xué)時的朋友給我發(fā)了我未婚夫和他白月光在一起吃飯的照片。...
    茶點故事閱讀 40,040評論 1 350
  • 序言:一個原本活蹦亂跳的男人離奇死亡钦椭,死狀恐怖拧额,靈堂內(nèi)的尸體忽然破棺而出碑诉,到底是詐尸還是另有隱情,我是刑警寧澤侥锦,帶...
    沈念sama閱讀 35,742評論 5 346
  • 正文 年R本政府宣布进栽,位于F島的核電站,受9級特大地震影響恭垦,放射性物質(zhì)發(fā)生泄漏快毛。R本人自食惡果不足惜,卻給世界環(huán)境...
    茶點故事閱讀 41,364評論 3 330
  • 文/蒙蒙 一番挺、第九天 我趴在偏房一處隱蔽的房頂上張望唠帝。 院中可真熱鬧,春花似錦玄柏、人聲如沸襟衰。這莊子的主人今日做“春日...
    開封第一講書人閱讀 31,944評論 0 22
  • 文/蒼蘭香墨 我抬頭看了看天上的太陽瀑晒。三九已至,卻和暖如春徘意,著一層夾襖步出監(jiān)牢的瞬間苔悦,已是汗流浹背。 一陣腳步聲響...
    開封第一講書人閱讀 33,060評論 1 270
  • 我被黑心中介騙來泰國打工椎咧, 沒想到剛下飛機就差點兒被人妖公主榨干…… 1. 我叫王不留玖详,地道東北人。 一個月前我還...
    沈念sama閱讀 48,247評論 3 371
  • 正文 我出身青樓勤讽,卻偏偏與公主長得像蟋座,于是被迫代替她去往敵國和親。 傳聞我的和親對象是個殘疾皇子脚牍,可洞房花燭夜當(dāng)晚...
    茶點故事閱讀 44,979評論 2 355

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

  • 轉(zhuǎn)自:http://lihaoquan.me/2017/1/1/Profiling-and-Optimizing-...
    鯨息_Leon閱讀 7,693評論 0 11
  • Spring Cloud為開發(fā)人員提供了快速構(gòu)建分布式系統(tǒng)中一些常見模式的工具(例如配置管理蜈七,服務(wù)發(fā)現(xiàn),斷路器莫矗,智...
    卡卡羅2017閱讀 134,659評論 18 139
  • 對于一些初學(xué)者,自知道 Go 里面的 array 以 pass-by-value 方式傳遞后砂缩,就莫名地引起 “恐慌...
    qyuhen閱讀 1,038評論 0 2
  • 閉包(closure)也是很常見的編碼模式作谚,因它隱式攜帶上下文環(huán)境變量,因此可讓算法代碼變得更加簡潔庵芭。 但任何 “...
    qyuhen閱讀 616評論 0 4
  • 酸味是童年的回憶妹懒, 辣味意味人生不可處處盡人意, 苦味將有甘甜的來遇双吆, 咸味似血汗淚的匯聚眨唬, 甜味是酸辣苦咸的回報...
    李丕潤小星星閱讀 349評論 0 0