4. Go 性能调优之 —— 跟踪

sxssxs · · 677 次点击 · · 开始浏览    
这是一个创建于 的文章,其中的信息可能已经有所发展或是发生改变。

原文链接:https://github.com/sxs2473/go...
本文使用 Creative Commons Attribution-ShareAlike 4.0 International 协议进行授权许可。

Tracing Go programs

在 Go 1.5 中,添加了一个新的工具:执行跟踪器。在本章中,我们将了解跟踪器的作用以及它如何帮助我们在程序中指出性能问题。

pprof不同的是,正如我们在检查 Go 程序当前执行的内容之前看到的,执行跟踪器使 Go 运行时在每次事件发生时主动报告。这些事件可以是 goroutine 的创建、系统调用、堆大小的更改等等。每次发生这些事件中的一个时,都会报告其时间戳和大多数事件的堆栈跟踪。

在启用Go执行跟踪器的情况下执行程序的结果是一个相当大的二进制文件,可以用 go tool trace进行分析。

第一个例子

关于Go执行跟踪器的一个很棒的事情是它不需要运行很长时间,因此我们可以通过简单地加上对trace.Starttrace.Stop的调用来了解程序的功能。

package main

import (
    "log"
    "os"
    "runtime/trace"
)

func main() {
    _ = trace.Start(os.Stdout)
    defer trace.Stop()

    const n = 3

    leftmost := make(chan int)
    right := leftmost
    left := leftmost

    for i := 0; i < n; i++ {
        right = make(chan int)
        go pass(left, right)
        left = right
    }

    go sendFirst(right)
    log.Println(<-leftmost)
}

func pass(left, right chan int) {
    v := 1 + <-right
    left <- v
}

func sendFirst(ch chan int) { ch <- 0 }

因此,在不读取代码中任何其他内容的情况下,让我们只运行代码并存储跟踪输出。

$ go run daisy/main.go > trace.out
3
$ go tool trace trace.out
2017/07/10 17:47:47 Parsing trace...
2017/07/10 17:47:47 Serializing trace...
2017/07/10 17:47:47 Splitting trace...
2017/07/10 17:47:47 Opening browser

这将打开一个带有一系列链接的浏览器,让我们点击 Goroutine analysis,你会看到这样的东西:

Goroutines: 
runtime.main N=1 
main.pass N=3 
runtime/trace.Start.func1 N=1 
main.sendFirst N=1 
N=3 

好的,所以我们总共有5个 goroutines,一个正在运行main,一个正在运行pass,一个正在运行sendFirst。 还有一个运行跟踪器。

当我们点击 Synchronization blocking profile 你会看到一个有趣的图表。

图片描述

看起来mainpass都花了相当多的时间尝试从一个 channel 接收。

现在让我们点击 View trace, 你会看到这样的东西:

图片描述

好的,我们已经可以在这里看到很多信息了!让我们从线程的数量开始。在图形的Threads上单击任意位置,你将看到当时运行了多少个线程。

图片描述

在本例中,我们看到有四个线程,其中一个用于系统调用。

类似地,你可以单击Goroutines行,并了解在程序的每个点上有多少个Goroutines。

图片描述

看起来我们有4个,其中2个正在运行,并且没有一个被垃圾收集器阻塞。

Wow! 甚至在我们 一行代码都没读之前,我们就可以从程序中理解很多东西! 但现在是时候阅读代码了,以便更好地解释发生了什么。

package main

import (
    "log"
    "os"
    "runtime/trace"
)

func main() {
    _ = trace.Start(os.Stdout)
    defer trace.Stop()

    const n = 3

    leftmost := make(chan int)
    right := leftmost
    left := leftmost

    for i := 0; i < n; i++ {
        right = make(chan int)
        go pass(left, right)
        left = right
    }

    go sendFirst(right)
    log.Println(<-leftmost)
}

func pass(left, right chan int) {
    v := 1 + <-right
    left <- v
}

func sendFirst(ch chan int) { ch <- 0 }

上述代码创建了一个通过 channel 连接的 goroutines 链,然后在一端发送值并等待在另一端接收该值。

图片描述

现在我们知道了这一点,让我们回到跟踪查看器并分析依赖关系。

点击 View Options展开,选中Flow Events开启可视化。

图片描述

花些时间浏览依赖关系图并尝试查看每个 goroutine 如何通过 channel 与其他 goroutine 同步。

图片描述


有疑问加站长微信联系(非本文作者)

本文来自:Segmentfault

感谢作者:sxssxs

查看原文:4. Go 性能调优之 —— 跟踪

入群交流(和以上内容无关):加入Go大咖交流群,或添加微信:liuxiaoyan-s 备注:入群;或加QQ群:692541889

677 次点击  
加入收藏 微博
暂无回复
添加一条新回复 (您需要 登录 后才能回复 没有账号 ?)
  • 请尽量让自己的回复能够对别人有帮助
  • 支持 Markdown 格式, **粗体**、~~删除线~~、`单行代码`
  • 支持 @ 本站用户;支持表情(输入 : 提示),见 Emoji cheat sheet
  • 图片支持拖拽、截图粘贴等方式上传