天天看點

系統級性能分析工具 — Perf詳解講解

從2.6.31核心開始,Linux核心自帶了一個性能分析工具perf,能夠進行函數級與指令級的熱點查找。通過它,應用程式可以利用 PMU,tracepoint 和核心中的特殊計數器來進行性能統計。它不但可以分析指定應用程式的性能問題 (per thread),也可以用來分析核心的性能問題,當然也可以同時分析應用代碼和核心,進而全面了解應用程式中的性能瓶頸。

Perf是内置于Linux核心源碼樹中的性能剖析(profiling)工具。

它基于事件采樣原理,以性能事件為基礎,支援針對處理器相關性能名額與作業系統相關性能名額的性能剖析。

常用于性能瓶頸的查找與熱點代碼的定位。

CPU周期(cpu-cycles)是預設的性能事件,所謂的CPU周期是指CPU所能識别的最小時間單元,通常為億分之幾秒,

是CPU執行最簡單的指令時所需要的時間,例如讀取寄存器中的内容,也叫做clock tick。

Perf是一個包含22種子工具的工具集,以下是最常用的5種:

perf-list

perf-stat

perf-top

perf-record

perf-report

perf-list

 Perf-list用來檢視perf所支援的性能事件,有軟體的也有硬體的。

List all symbolic event types.

perf list [hw | sw | cache | tracepoint | event_glob]

(1) 性能事件的分布

hw:Hardware event,9個

sw:Software event,9個

cache:Hardware cache event,26個

tracepoint:Tracepoint event,775個

sw實際上是核心的計數器,與硬體無關。

hw和cache是CPU架構相關的,依賴于具體硬體。

tracepoint是基于核心的ftrace,主線2.6.3x以上的核心版本才支援。

(2) 指定性能事件(以它的屬性)

-e <event> : u // userspace

-e <event> : k // kernel

-e <event> : h // hypervisor

-e <event> : G // guest counting (in KVM guests)

-e <event> : H // host counting (not in KVM guests)

(3) 使用例子

顯示核心和子產品中,消耗最多CPU周期的函數:

# perf top -e cycles:k

顯示配置設定高速緩存最多的函數:

# perf top -e kmem:kmem_cache_alloc

perf-top

對于一個指定的性能事件(預設是CPU周期),顯示消耗最多的函數或指令。

System profiling tool.

Generates and displays a performance counter profile in real time.

perf top [-e <EVENT> | --event=EVENT] [<options>]

perf top主要用于實時分析各個函數在某個性能事件上的熱度,能夠快速的定位熱點函數,包括應用程式函數、

子產品函數與核心函數,甚至能夠定位到熱點指令。預設的性能事件為cpu cycles。

(1) 輸出格式

# perf top

[plain] view plain copy  

系統級性能分析工具 — Perf詳解講解
系統級性能分析工具 — Perf詳解講解
  1. Samples: 1M of event 'cycles', Event count (approx.): 73891391490  
  2.      5.44%  perf              [.] 0x0000000000023256        
  3.      4.86%  [kernel]          [k] _spin_lock                
  4.      2.43%  [kernel]          [k] _spin_lock_bh             
  5.      2.29%  [kernel]          [k] _spin_lock_irqsave        
  6.      1.77%  [kernel]          [k] __d_lookup                
  7.      1.55%  libc-2.12.so      [.] __strcmp_sse42            
  8.      1.43%  nginx             [.] ngx_vslprintf             
  9.      1.37%  [kernel]          [k] tcp_poll            

第一列:符号引發的性能事件的比例,預設指占用的cpu周期比例。

第二列:符号所在的DSO(Dynamic Shared Object),可以是應用程式、核心、動态連結庫、子產品。

第三列:DSO的類型。[.]表示此符号屬于使用者态的ELF檔案,包括可執行檔案與動态連結庫,[k]表述此符号屬于核心或子產品。

第四列:符号名。有些符号不能解析為函數名,隻能用位址表示。

(2) 常用互動指令

h:顯示幫助

UP/DOWN/PGUP/PGDN/SPACE:上下和翻頁。

a:annotate current symbol,注解目前符号。能夠給出彙編語言的注解,給出各條指令的采樣率。

d:過濾掉所有不屬于此DSO的符号。非常友善檢視同一類别的符号。

P:将目前資訊儲存到perf.hist.N中。

(3) 常用指令行參數

-e <event>:指明要分析的性能事件。

-p <pid>:Profile events on existing Process ID (comma sperated list). 僅分析目标程序及其建立的線程。

-k <path>:Path to vmlinux. Required for annotation functionality. 帶符号表的核心映像所在的路徑。

-K:不顯示屬于核心或子產品的符号。

-U:不顯示屬于使用者态程式的符号。

-d <n>:界面的重新整理周期,預設為2s,因為perf top預設每2s從mmap的記憶體區域讀取一次性能資料。

-G:得到函數的調用關系圖。

perf top -G [fractal],路徑機率為相對值,加起來為100%,調用順序為從下往上。

perf top -G graph,路徑機率為絕對值,加起來為該函數的熱度。

(4) 使用例子

# perf top // 預設配置

# perf top -G // 得到調用關系圖

# perf top -e cycles // 指定性能事件

# perf top -p 23015,32476 // 檢視這兩個程序的cpu cycles使用情況

# perf top -s comm,pid,symbol // 顯示調用symbol的程序名和程序号

# perf top --comms nginx,top // 僅顯示屬于指定程序的符号

# perf top --symbols kfree // 僅顯示指定的符号

perf-stat

用于分析指定程式的性能概況。

 Run a command and gather performance counter statistics.

perf stat [-e <EVENT> | --event=EVENT] [-a] <command>

perf stat [-e <EVENT> | --event=EVENT] [-a] - <command> [<options>]

(1) 輸出格式

# perf stat ls

[plain] view plain copy  

系統級性能分析工具 — Perf詳解講解
系統級性能分析工具 — Perf詳解講解
  1. Performance counter stats for 'ls':  
  2.          0.653782 task-clock                #    0.691 CPUs utilized            
  3.                 0 context-switches          #    0.000 K/sec                    
  4.                 0 CPU-migrations            #    0.000 K/sec                    
  5.               247 page-faults               #    0.378 M/sec                    
  6.         1,625,426 cycles                    #    2.486 GHz                      
  7.         1,050,293 stalled-cycles-frontend   #   64.62% frontend cycles idle     
  8.           838,781 stalled-cycles-backend    #   51.60% backend  cycles idle     
  9.         1,055,735 instructions              #    0.65  insns per cycle          
  10.                                             #    0.99  stalled cycles per insn  
  11.           210,587 branches                  #  322.106 M/sec                    
  12.            10,809 branch-misses             #    5.13% of all branches          
  13.       0.000945883 seconds time elapsed  

輸出包括ls的執行時間,以及10個性能事件的統計。

task-clock:任務真正占用的處理器時間,機關為ms。CPUs utilized = task-clock / time elapsed,CPU的占用率。

context-switches:上下文的切換次數。

CPU-migrations:處理器遷移次數。Linux為了維持多個處理器的負載均衡,在特定條件下會将某個任務從一個CPU

遷移到另一個CPU。

page-faults:缺頁異常的次數。當應用程式請求的頁面尚未建立、請求的頁面不在記憶體中,或者請求的頁面雖然在内

存中,但實體位址和虛拟位址的映射關系尚未建立時,都會觸發一次缺頁異常。另外TLB不命中,頁面通路權限不比對

等情況也會觸發缺頁異常。

cycles:消耗的處理器周期數。如果把被ls使用的cpu cycles看成是一個處理器的,那麼它的主頻為2.486GHz。

可以用cycles / task-clock算出。

stalled-cycles-frontend:略過。

stalled-cycles-backend:略過。

instructions:執行了多少條指令。IPC為平均每個cpu cycle執行了多少條指令。

branches:遇到的分支指令數。branch-misses是預測錯誤的分支指令數。

(2) 常用參數

-p:stat events on existing process id (comma separated list). 僅分析目标程序及其建立的線程。

-a:system-wide collection from all CPUs. 從所有CPU上收集性能資料。

-r:repeat command and print average + stddev (max: 100). 重複執行指令求平均。

-C:Count only on the list of CPUs provided (comma separated list), 從指定CPU上收集性能資料。

-v:be more verbose (show counter open errors, etc), 顯示更多性能資料。

-n:null run - don't start any counters,隻顯示任務的執行時間 。

-x SEP:指定輸出列的分隔符。

-o file:指定輸出檔案,--append指定追加模式。

--pre <cmd>:執行目标程式前先執行的程式。

--post <cmd>:執行目标程式後再執行的程式。

(3) 使用例子

執行10次程式,給出标準偏差與期望的比值:

# perf stat -r 10 ls > /dev/null

顯示更詳細的資訊:

# perf stat -v ls > /dev/null

隻顯示任務執行時間,不顯示性能計數器:

# perf stat -n ls > /dev/null

單獨給出每個CPU上的資訊:

# perf stat -a -A ls > /dev/null

ls指令執行了多少次系統調用:

# perf stat -e syscalls:sys_enter ls 

perf-record

收集采樣資訊,并将其記錄在資料檔案中。

随後可以通過其它工具(perf-report)對資料檔案進行分析,結果類似于perf-top的。

Run a command and record its profile into perf.data.

This command runs a command and gathers a performance counter profile from it, into perf.data,

without displaying anything. This file can then be inspected later on, using perf report.

(1) 常用參數

-e:Select the PMU event.

-a:System-wide collection from all CPUs.

-p:Record events on existing process ID (comma separated list).

-A:Append to the output file to do incremental profiling.

 -f:Overwrite existing data file.

-o:Output file name.

-g:Do call-graph (stack chain/backtrace) recording.

-C:Collect samples only on the list of CPUs provided.

(2) 使用例子

記錄nginx程序的性能資料:

# perf record -p `pgrep -d ',' nginx`

記錄執行ls時的性能資料:

# perf record ls -g

記錄執行ls時的系統調用,可以知道哪些系統調用最頻繁:

# perf record -e syscalls:sys_enter ls

perf-report

讀取perf record建立的資料檔案,并給出熱點分析結果。

Read perf.data (created by perf record) and display the profile.

This command displays the performance counter profile information recorded via perf record.

(1) 常用參數

-i:Input file name. (default: perf.data)

(2) 使用例子

# perf report -i perf.data.2

More

除了以上5個常用工具外,還有一些适用于較特殊場景的工具, 比如核心鎖、slab配置設定器、排程器,

也支援自定義探測點。

perf-lock

核心鎖的性能分析。

Analyze lock events.

perf lock {record | report | script | info}

需要編譯選項的支援:CONFIG_LOCKDEP、CONFIG_LOCK_STAT。

CONFIG_LOCKDEP defines acquired and release events.

CONFIG_LOCK_STAT defines contended and acquired lock events.

(1) 常用選項

-i <file>:輸入檔案

-k <value>:sorting key,預設為acquired,還可以按contended、wait_total、wait_max和wait_min來排序。

(2) 使用例子

# perf lock record ls // 記錄

# perf lock report // 報告

(3) 輸出格式

[plain] view plain copy  

系統級性能分析工具 — Perf詳解講解
系統級性能分析工具 — Perf詳解講解
  1.                Name   acquired  contended total wait (ns)   max wait (ns)   min wait (ns)   
  2. &mm->page_table_...        382          0               0               0               0   
  3. &mm->page_table_...         72          0               0               0               0   
  4.           &fs->lock         64          0               0               0               0   
  5.         dcache_lock         62          0               0               0               0   
  6.       vfsmount_lock         43          0               0               0               0   
  7. &newf->file_lock...         41          0               0               0               0   

Name:核心鎖的名字。

aquired:該鎖被直接獲得的次數,因為沒有其它核心路徑占用該鎖,此時不用等待。

contended:該鎖等待後獲得的次數,此時被其它核心路徑占用,需要等待。

total wait:為了獲得該鎖,總共的等待時間。

max wait:為了獲得該鎖,最大的等待時間。

min wait:為了獲得該鎖,最小的等待時間。

最後還有一個Summary:

[plain] view plain copy  

系統級性能分析工具 — Perf詳解講解
系統級性能分析工具 — Perf詳解講解
  1. === output for debug===  
  2. bad: 10, total: 246  
  3. bad rate: 4.065041 %  
  4. histogram of events caused bad sequence  
  5.     acquire: 0  
  6.    acquired: 0  
  7.   contended: 0  
  8.     release: 10  

perf-kmem

slab配置設定器的性能分析。

Tool to trace/measure kernel memory(slab) properties.

perf kmem {record | stat} [<options>]

(1) 常用選項

--i <file>:輸入檔案

--caller:show per-callsite statistics,顯示核心中調用kmalloc和kfree的地方。

--alloc:show per-allocation statistics,顯示配置設定的記憶體位址。

-l <num>:print n lines only,隻顯示num行。

-s <key[,key2...]>:sort the output (default: frag,hit,bytes)

(2) 使用例子

# perf kmem record ls // 記錄

# perf kmem stat --caller --alloc -l 20 // 報告

(3) 輸出格式

[plain] view plain copy  

系統級性能分析工具 — Perf詳解講解
系統級性能分析工具 — Perf詳解講解
  1. ------------------------------------------------------------------------------------------------------  
  2.  Callsite                           | Total_alloc/Per | Total_req/Per   | Hit      | Ping-pong | Frag  
  3. ------------------------------------------------------------------------------------------------------  
  4.  perf_event_mmap+ec                 |    311296/8192  |    155952/4104  |       38 |        0 | 49.902%  
  5.  proc_reg_open+41                   |        64/64    |        40/40    |        1 |        0 | 37.500%  
  6.  __kmalloc_node+4d                  |      1024/1024  |       664/664   |        1 |        0 | 35.156%  
  7.  ext3_readdir+5bd                   |        64/64    |        48/48    |        1 |        0 | 25.000%  
  8.  load_elf_binary+8ec                |       512/512   |       392/392   |        1 |        0 | 23.438%  

Callsite:核心代碼中調用kmalloc和kfree的地方。

Total_alloc/Per:總共配置設定的記憶體大小,平均每次配置設定的記憶體大小。

Total_req/Per:總共請求的記憶體大小,平均每次請求的記憶體大小。

Hit:調用的次數。

Ping-pong:kmalloc和kfree不被同一個CPU執行時的次數,這會導緻cache效率降低。

Frag:碎片所占的百分比,碎片 = 配置設定的記憶體 - 請求的記憶體,這部分是浪費的。

有使用--alloc選項,還會看到Alloc Ptr,即所配置設定記憶體的位址。

最後還有一個Summary:

[plain] view plain copy  

系統級性能分析工具 — Perf詳解講解
系統級性能分析工具 — Perf詳解講解
  1. SUMMARY  
  2. =======  
  3. Total bytes requested: 290544  
  4. Total bytes allocated: 447016  
  5. Total bytes wasted on internal fragmentation: 156472  
  6. Internal fragmentation: 35.003669%  
  7. Cross CPU allocations: 2/509  

probe-sched

 排程子產品分析。

trace/measure scheduler properties (latencies)

perf sched {record | latency | map | replay | script}

(1) 使用例子 

# perf sched record sleep 10 // perf sched record <command>

# perf report latency --sort max

(2) 輸出格式

[plain] view plain copy  

系統級性能分析工具 — Perf詳解講解
系統級性能分析工具 — Perf詳解講解
  1. ---------------------------------------------------------------------------------------------------------------  
  2.  Task                  |   Runtime ms  | Switches | Average delay ms | Maximum delay ms | Maximum delay at     |  
  3. ---------------------------------------------------------------------------------------------------------------  
  4.  events/10:61          |      0.655 ms |       10 | avg:    0.045 ms | max:    0.161 ms | max at: 9804.958730 s  
  5.  sleep:11156           |      2.263 ms |        4 | avg:    0.052 ms | max:    0.118 ms | max at: 9804.865552 s  
  6.  edac-poller:1125      |      0.598 ms |       10 | avg:    0.042 ms | max:    0.113 ms | max at: 9804.958698 s  
  7.  events/2:53           |      0.676 ms |       10 | avg:    0.037 ms | max:    0.102 ms | max at: 9814.751605 s  
  8.  perf:11155            |      2.109 ms |        1 | avg:    0.068 ms | max:    0.068 ms | max at: 9814.867918 s  

TASK:程序名和pid。

Runtime:實際的運作時間。

Switches:程序切換的次數。

Average delay:平均的排程延遲。

Maximum delay:最大的排程延遲。

Maximum delay at:最大排程延遲發生的時刻。

perf-probe

可以自定義探測點。

Define new dynamic tracepoints.

使用例子

(1) Display which lines in schedule() can be probed

# perf probe --line schedule

前面有行号的可以探測,沒有行号的就不行了。

(2) Add a probe on schedule() function 12th line.

# perf probe -a schedule:12

在schedule函數的12處增加一個探測點。

Reference

[1]. Linux的系統級性能剖析工具系列,by 承剛

[2]. http://www.ibm.com/developerworks/cn/linux/l-cn-perf1/

[3]. http://www.ibm.com/developerworks/cn/linux/l-cn-perf2/

[4]. https://perf.wiki.kernel.org/index.php/Tutorial

繼續閱讀