端端舝

golang profiling及價渙
CA.go#1 (2017/06/21)
絁宒頗扦AbemaTV 笢屙蚥?檔

??畿賡
笢𥱊 �?檔 (反六)
磊窃
?2012/06~ Ameba旦穴奈玄白巧件PF
?2014/01~ ◇正永皿伙悊?◆
?2015/12~ ◇AbemaTV◆
Golang窃 2爛

Profiling of golang
pprof (runtime/pprof)
? Golang及Profiling毛?丹由永弗奈斥
? CPU?Memory?goroutine卅升及ロ�毛�摩
? protocol buffer倛宒匹皿伕白央奶伙毛悵湔
? `go tool pprof` 卞方曰皿伕白央奶伙毛煦昴

runtime/pprof
CPU Profiler
? 憝杅及灍?媆嶲毛皿伕白央奶伉件弘
? (UNIX) settimer毛瞳?仄10ms仍午卞
SIGPROF扑弘瓜伙冞陓
? 扔件皿仿反扑弘瓜伙毛甩件玉伉件弘仄
旦正永弁玄伊奈旦毛悵湔
f, err := os.Create(*cpuprofile)?
if err != nil {?
log.Fatal("could not create CPU profile: ", err)?
}?
if err := pprof.StartCPUProfile(f); err != nil {?
log.Fatal("could not start CPU profile: ", err)?
}?
defer pprof.StopCPUProfile()

runtime/pprof
CPU Proflier眕俋及Profiler反Lookup匹網太堤仄
f, err := os.Create("./mem.prof")
if err != nil {
log.Fatal("could not create memory profile: ", err)
}
defer func() {
pprof.Lookup("heap").WriteTo(f, 0)
f.Close()
}()

runtime/pprof
※heap§ (Heap Profiler)
? 丟乒伉及ロ�(GC午失伕弗奈扑亦件)毛皿伕白央奶伉件弘
※goroutine§ (Goroutine Profiler)
? 灍?笢及goroutine及皿伕白央奶伉件弘
heap options
(go tool pprof -inuse_space mem.prof )
-inuse_space 瞳?笢及丟乒伉薆郖
-inuse_objects 丟乒伉瞳?笢及左皮斥尼弁玄杅
-alloc_space ゴ隙及GC井日失伕弗奈玄今木凶丟乒伉薆郖

runtime/pprof
※block§ (Blocking Profiler)
↗ runtime.SetBlockProfileRate 毛 1 眕奻卞偞隅允月仇午匹衄�趙
? 肮ヽ�I燴匹waiting仄化中月goroutine毛皿伕白央奶伉件弘
※mutex§ (Mutex Profiler) ↗go1.8井日袚樓
↗ runtime.SetMutexProfileFraction 毛 1 眕奻卞偞隅允月仇午匹衄�趙
? 肮ヽ�I燴毛皮伕永弁允月 §mutex及心§ 毛皿伕白央奶伉件弘
? time.Ticker卅升由白巧奈穴件旦卞旮覦卅荌�毛迵尹卅中�?反桶?今木卅中

runtime/pprof
Custom Profilers
Profiler及灍蚾卞方曰市旦正丞皿伕白央奶仿毛釬傖褫夔
import ※runtime/pprof"
prof := pprof.New(※custom§)
prof.Add(obj, 1)
prof.Remove(1)

Relational Packages
runtime/pprof
net/http/pprof
?HTTP Server?及皿伕白央奶仿
github.com/pkg/profile
?`runtime/pprof` 毛方曰��g卞瞳?匹五月方丹卅wrapper
?啋反devecheney及 `https://github.com/davecheney/profile`

net/http/pprof
Web Server砃仃pprof由永弗奈斥
? http磊蚕匹皿伕白央奶伉件弘毛龰腕
? 2意�及田奶件玉?楊
? DefaultServeMux卞田奶件玉 (blank
import)
? ServeMux毛New仄化田奶件玉
import (
"net/http"
"net/http/pprof"
"runtime"
)
---
mux := http.NewServeMux()
mux.Handle("/debug/pprof/", http.HandlerFunc(pprof.Index))
mux.Handle("/debug/pprof/cmdline", http.HandlerFunc(pprof.Cmdline))
mux.Handle("/debug/pprof/profile", http.HandlerFunc(pprof.Profile))
mux.Handle("/debug/pprof/symbol", http.HandlerFunc(pprof.Symbol))
mux.Handle("/debug/pprof/trace", http.HandlerFunc(pprof.Trace))
---
go func() {
log.Println(http.ListenAndServe("localhost:6060", mux));
}
import _ "net/http/pprof"
go func() {
log.Println(http.ListenAndServe("localhost:6060", nil))
}()

github.com/pkg/profile
runtime/pprof毛扑件皿伙卅奶件正奈白尼奈旦匹枑鼎
? shutdown signal及甩件玉伉件弘
眕狟及皿伕白央奶仿毛瞳?褫夔
? CPU Profiler
? Heap Profiler
? Block Profiler
? Trace Profiler (runtime/trace)
package main
import (
"github.com/pkg/profile"
)
func main() {
defer profile.Start(profile.BlockProfile).Stop()
}

go test profiling
氾旦玄戊奈玉及皿伕白央奶伉件弘
氾旦玄左皿扑亦件卞硌隅允月仇午卞方曰皿伕白央奶伉件弘褫夔
-blockprofile block.out : Block Profile及龰腕
-cpuprofile cpu.out : CPU Profile及龰腕
-memprofile mem.out : Heap Profile及龰腕
-mutexprofile mutex.out : Mutex Profile及龰腕

Go tool pprof
$ go tool pprof --text mpeg-probe sample.prof/cpu.pprof
108.45s of 112.28s total (96.59%)
Dropped 148 nodes (cum <= 0.56s)
flat flat% sum% cum cum%
78.03s 69.50% 69.50% 78.18s 69.63% syscall.Syscall
8.47s 7.54% 77.04% 8.47s 7.54% runtime.mach_semaphore_wait
7.19s 6.40% 83.44% 7.19s 6.40% runtime.mach_semaphore_signal
3.43s 3.05% 86.50% 3.43s 3.05% runtime.mach_semaphore_timedwait
3.02s 2.69% 89.19% 3.02s 2.69% runtime.memclrNoHeapPointers
皿伕白央奶伉件弘及摩�?褫�趙
? `go tool pprof` 毛瞳?仄化
? 戊穴件玉仿奶件匹及灍?午﹜奶件正仿弁氾奴皮扑尼伙毛枑鼎

Go tool pprof
(pprof) web
? svg倛宒匹苂五堤今木凶皿伕白央奶伙毛web皮仿它扒匹桶?
? function靡及硌隅匹篇曰煋心
? graphviz及奶件旦玄奈伙互斛猁
$ go tool pprof mpeg-probe sample.prof/cpu.pprof
Entering interactive mode (type "help" for commands)
(pprof) web main

Go tool pprof
(pprof) top
? 龰腕仄凶皿伕白央奶伙及奻弇N璃及桶?
? `-FIELD` 硌隅卞方曰末奈玄
(pprof) top 5 -flat
100.14s of 112.28s total (89.19%)
Dropped 148 nodes (cum <= 0.56s)
Showing top 5 nodes out of 92 (cum >= 3.02s)
flat flat% sum% cum cum%
78.03s 69.50% 69.50% 78.18s 69.63% syscall.Syscall
8.47s 7.54% 77.04% 8.47s 7.54% runtime.mach_semaphore_wait
7.19s 6.40% 83.44% 7.19s 6.40% runtime.mach_semaphore_signal
3.43s 3.05% 86.50% 3.43s 3.05% runtime.mach_semaphore_timedwait
3.02s 2.69% 89.19% 3.02s 2.69% runtime.memclrNoHeapPointers
flat : 憝杅及妏?仄凶�
flat% : flat�及�极及梩戶月賃磁
sum% : 政婓及末奈玄�匹及flat�及濛��
cum : 憝杅及坻及憝杅及網太堤仄手漪戶凶�
cum% : cum�及�极卞梩戶月賃磁

Go tool pprof
(pprof) list
? go tool灍?媆卞田奶瓜伉白央奶伙及硌隅互斛猁
? 末奈旦戊奈玉奻匹及flat,cum�毛桶?
(pprof) list io.Copy
Total: 1.87mins
ROUTINE ======================== io.Copy in /usr/local/Cellar/go/1.8.1/libexec/src/io/io.go
0 1.09mins (flat, cum) 58.15% of Total
. . 355:// If src implements the WriterTo interface,
. . 356:// the copy is implemented by calling src.WriteTo(dst).
. . 357:// Otherwise, if dst implements the ReaderFrom interface,
. . 358:// the copy is implemented by calling dst.ReadFrom(src).
. . 359:func Copy(dst Writer, src Reader) (written int64, err error) {
. 1.09mins 360: return copyBuffer(dst, src, nil)
. . 361:}
. . 362:
. . 363:// CopyBuffer is identical to Copy except that it stages through the
. . 364:// provided buffer (if one is required) rather than allocating a

Check Point
runtime.mallocgc
? 丟乒伉失伕弗奈扑亦件互嗣仁逃?仄化中月
runtime.chanrecv, sync.Mutex
? 伕永弁�I燴卞方曰嗣仁及渾切互逃?仄化中月
syscall Read / Write
? io及掂心𤩸五互?講卞逃?仄化中月
GC戊件禾奈生件玄
? 甲奈皿扔奶朮及?今今卞方曰﹜GC及逃?互螿楛卞逃?仄化中月

Go Debug Options
Memory Allocator Trace
- GODEBUG=allocfreetrace=1
Garbage Collector Trace
- GODEBUG=gctrace=1 .
Scheduler Trace
- GODEBUG=schedtrace=1000 ./

端端舝

golang profiling 及價渙

Recommended

More Related Content

What's hot (20)

Similar to golang profiling 及價渙 (20)

golang profiling 及價渙