golang調(diào)試bug及性能監(jiān)控方式實(shí)踐總結(jié)
如何分析程序運(yùn)行所需時(shí)間及cpu的使用率?
使用shell內(nèi)置的time指令
最常見的方式便是linux中內(nèi)置的time指令,通過time go run '你的程序.go'
即可。
$ time go run test.go real 0m0.802s user 0m0.320s sys 0m0.345s
使用time指令后,會返回三個(gè)指標(biāo),他們的含義分別是:
- real:程序?qū)嶋H運(yùn)行的時(shí)長。
- user:程序在用戶態(tài)所消耗的時(shí)間
- sys:程序在系統(tǒng)態(tài)所消耗的時(shí)間
一般來說,real >= user + sys,這是因?yàn)橄到y(tǒng)在運(yùn)行當(dāng)前程序時(shí),可能會調(diào)用其他進(jìn)程,從而導(dǎo)致程序整體的運(yùn)行時(shí)增加。
使用/usr/bin/time指令
在linux中,還存在比time指令更為精準(zhǔn)詳細(xì)的time指令,相比于系統(tǒng)自帶的time指令,你還需要添加指令的絕對路徑以及參數(shù)-v。
$ /usr/bin/time -v go run test.go Command being timed: "go run test.go" User time (seconds): 0.12 System time (seconds): 0.06 Percent of CPU this job got: 115% Elapsed (wall clock) time (h:mm:ss or m:ss): 0:00.16 Average shared text size (kbytes): 0 Average unshared data size (kbytes): 0 Average stack size (kbytes): 0 Average total size (kbytes): 0 Maximum resident set size (kbytes): 41172 Average resident set size (kbytes): 0 Major (requiring I/O) page faults: 1 Minor (reclaiming a frame) page faults: 15880 Voluntary context switches: 897 Involuntary context switches: 183 Swaps: 0 File system inputs: 256 File system outputs: 2664 Socket messages sent: 0 Socket messages received: 0 Signals delivered: 0 Page size (bytes): 4096 Exit status: 0
可以看出,這種time指令比系統(tǒng)自帶的要擁有更多的參數(shù)。例如:CPU的占用率,內(nèi)存的使用情況等等。
如何分析go程序的內(nèi)存使用情況?
聊完了go程序的運(yùn)行時(shí)間的監(jiān)控方式,我們接下來要討論的是如何分析內(nèi)存使用情況的問題。
先貼出一段測試用代碼
package main import ( "log" "runtime" "time" ) func main(){ log.Println("start...") test() log.Println("force gc...") runtime.GC()//強(qiáng)調(diào)調(diào)用gc回收 log.Println("done...") time.Sleep(3600*time.Second) } func test(){ //由于切片可以動態(tài)擴(kuò)容,所以這里使用slice進(jìn)行測試 container := make([]int, 8) log.Println("==> loop start...") for i := 0; i < 32*1000*1000; i++ { container = append(container, i) } log.Println("==> loop end...") }
將test.go文件編譯為可執(zhí)行的二進(jìn)制文件并執(zhí)行
$go build -o test && ./test
此時(shí),我們新開一個(gè)終端窗口,并使用top命令查看進(jìn)程的內(nèi)存占用情況
$top -p $(pidof test)
結(jié)果如下:
如圖所示,可以看出我們的test進(jìn)程大概有520m的內(nèi)存占用,這顯然是不正常的,因?yàn)閠est()執(zhí)行完畢以后,container的內(nèi)存應(yīng)該被釋放了。
這時(shí),另一種內(nèi)存分析工具GODEBUG就能派上用場了。
GODEBUG與gctrace
首先,我們要開啟打印垃圾回收信息的功能:
$ GODEBUG='gctrace=1' ./test
gctrace=1可以讓垃圾回收器在每次回收垃圾時(shí)收集用時(shí)和釋放空間的大小,并將其打印到終端上。
格式及其含義
gc # @#s #%: #+#+# ms clock, #+#/#/#+# ms cpu, #->#-># MB, # MB goal, # P gc # GC次數(shù)的編號,每次GC時(shí)遞增 @#s 距離程序開始執(zhí)行時(shí)的時(shí)間 #% GC占用的執(zhí)行時(shí)間百分比 #+...+# GC使用的時(shí)間 #->#-># MB GC開始,結(jié)束,以及當(dāng)前活躍堆內(nèi)存的大小,單位M # MB goal 全局堆內(nèi)存大小 # P 使用processor的數(shù)量
如果是由runtime.GC調(diào)用觸發(fā)的,則消息會以forced結(jié)尾。
這里虛擬一條輸出作為示例:
gc 3 @0.134s 1%: 0.003+28+0.002 ms clock, 0.007+0/0.049/24+0.005 ms cpu, 178->178->100 MB, 180 MB goal, 2 P
該條輸出代表的信息如下
- gc 3:GC調(diào)試的編號為3。
- @0.134s:此時(shí)程序已經(jīng)運(yùn)行了0.134s。
- 1%:在全部的運(yùn)行時(shí)間中GC所占時(shí)間比例為1%。
以上就是golang調(diào)試bug及性能監(jiān)控方式實(shí)踐總結(jié)的詳細(xì)內(nèi)容,更多關(guān)于golang調(diào)試bug性能監(jiān)控的資料請關(guān)注腳本之家其它相關(guān)文章!
- golang?pprof?監(jiān)控goroutine?thread統(tǒng)計(jì)原理詳解
- golang?pprof監(jiān)控memory?block?mutex統(tǒng)計(jì)原理分析
- golang?pprof監(jiān)控memory?block?mutex使用指南
- golang?pprof?監(jiān)控系列?go?trace統(tǒng)計(jì)原理與使用解析
- prometheus?client_go為應(yīng)用程序自定義監(jiān)控指標(biāo)
- web項(xiàng)目中g(shù)olang性能監(jiān)控解析
- Go語言metrics應(yīng)用監(jiān)控指標(biāo)基本使用說明
- Skywalking-go自動監(jiān)控增強(qiáng)使用探究
相關(guān)文章
golang利用unsafe操作未導(dǎo)出變量-Pointer使用詳解
這篇文章主要給大家介紹了關(guān)于golang利用unsafe操作未導(dǎo)出變量-Pointer使用的相關(guān)資料,文中通過示例代碼介紹的非常詳細(xì),需要的朋友可以參考借鑒,下面隨著小編來一起學(xué)習(xí)學(xué)習(xí)吧2018-08-08深入分析golang多值返回以及閉包的實(shí)現(xiàn)
相對于C/C++,golang有很多新穎的特性,例如goroutine,channel等等,這些特性其實(shí)從golang源碼是可以理解其實(shí)現(xiàn)的原理。今天這篇文章主要來分析下golang多值返回以及閉包的實(shí)現(xiàn),因?yàn)檫@兩個(gè)實(shí)現(xiàn)golang源碼中并不存在,我們必須從匯編的角度來窺探二者的實(shí)現(xiàn)。2016-09-09Go實(shí)現(xiàn)mongodb增刪改查工具類的代碼示例
這篇文章主要給大家介紹了關(guān)于Go實(shí)現(xiàn)mongodb增刪改查工具類的相關(guān)資料,MongoDB是一個(gè)NoSQL數(shù)據(jù)庫,它提供了靈活的文檔存儲模型以及強(qiáng)大的查詢和操作功能,需要的朋友可以參考下2023-10-10golang根據(jù)生日計(jì)算星座和屬相實(shí)例
這篇文章主要為大家介紹了golang根據(jù)生日計(jì)算星座和屬相的示例代碼,有需要的朋友可以借鑒參考下,希望能夠有所幫助,祝大家多多進(jìn)步,早日升職加薪2022-07-07go-zero熔斷機(jī)制組件Breaker接口定義使用解析
這篇文章主要為大家介紹了go-zero熔斷機(jī)制組件Breaker接口定義使用解析,有需要的朋友可以借鑒參考下,希望能夠有所幫助,祝大家多多進(jìn)步,早日升職加薪2023-05-05Golang 定時(shí)器(Timer 和 Ticker),這篇文章就夠了
這篇文章主要介紹了Golang 定時(shí)器(Timer 和 Ticker),這篇文章就夠了,文中通過示例代碼介紹的非常詳細(xì),對大家的學(xué)習(xí)或者工作具有一定的參考學(xué)習(xí)價(jià)值,需要的朋友們下面隨著小編來一起學(xué)習(xí)學(xué)習(xí)吧2020-10-10