說明背景

文檔作為會(huì)議的記錄和補(bǔ)充，會(huì)議主題是《使用Ftrace研究Linux內(nèi)核》，主講人謝歡。回放鏈接

基本內(nèi)容

1、Ftrace整體框架

根據(jù)官方文檔的定義，F(xiàn)trace是一個(gè)內(nèi)部跟蹤器，旨在幫助系統(tǒng)的開發(fā)者和設(shè)計(jì)者去觀測(cè)內(nèi)核的運(yùn)行。它可以被用于調(diào)試或分析發(fā)生在用戶空間之外的延遲和性能問題。隨著發(fā)展，目前已經(jīng)演變成為一個(gè)基礎(chǔ)的調(diào)試框架（支持多個(gè)不同類型的trace功能）。 直觀理解有兩層含義：一是提供函數(shù)鉤子的基礎(chǔ)設(shè)施，二是基于tracefs文件系統(tǒng)的trace框架。

• function tracer：在函數(shù)頭掛鉤子函數(shù)

• function graph tracer：可以帶時(shí)間戳函數(shù)執(zhí)行流打印

• kprobe：一般是掛在函數(shù)入口點(diǎn)，用于獲取參數(shù)

• trace event：函數(shù)執(zhí)行時(shí)調(diào)用靜態(tài)的鉤子函數(shù)

• kretprobe：通常是函數(shù)出口點(diǎn)，執(zhí)行鉤子函數(shù)

2、使用方式

Ftrace通過tracefs文件系統(tǒng)的控制文件來進(jìn)行調(diào)試。如果內(nèi)核構(gòu)建階段配置ftrace，默認(rèn)會(huì)掛載tracefs到/sys/kernel/tracing，也可以在運(yùn)行環(huán)境手動(dòng)掛載

接下來的內(nèi)容我會(huì)根據(jù)課程介紹，整理出ftrace不同功能的使用案例，一些問答和和觀點(diǎn)以及個(gè)人對(duì)課程總結(jié)。

function tracer使用

case01: 過濾"vfs_open"函數(shù)

觀察結(jié)果：圖示能看到所有執(zhí)行vfs_open的跟蹤信息。

function graph tracer使用

case01: 函數(shù)"vfs_open"的執(zhí)行時(shí)間

echo vfs_open > ./set_ftrace_filter # 過濾要跟蹤的函數(shù)

echo function_graph > ./current_tracer # 設(shè)置當(dāng)前使用的tracerecho 1 > ./options/funcgraph-proc # 啟用進(jìn)程TASK/PID打印cp trace /test.txt && cat /test.txt

觀察結(jié)果：查看到vfs_open被執(zhí)行的調(diào)試信息包括TASK/PID，函數(shù)的執(zhí)行時(shí)間在，接口名。原理上是通過在函數(shù)的入口點(diǎn)和出口點(diǎn)（kprobe/kretprobe）掛鉤子來實(shí)現(xiàn)的。

case02: 函數(shù)"vfs_open"向下執(zhí)行流

echo > ./set_ftrace_filter # 不使用過濾!!!echo vfs_open > ./set_graph_function #  使用函數(shù)圖表echo function_graph > ./current_tracer # 過濾要跟蹤的函數(shù)echo 1 > ./options/funcgraph-proc # 打印進(jìn)程TASK/PIDecho 1 > ./options/funcgraph-tail # 尾部注釋(方便觀察)cp trace /test.txt && cat /test.txt

觀察結(jié)果：vfs_open被執(zhí)行時(shí)，能看到向下的執(zhí)行流程，其中涉及到的函數(shù)調(diào)用和相關(guān)信息會(huì)打印出來。

kprobe event

case01: 查看"vfs_open"當(dāng)前打開文件名

# 理論計(jì)算：# $arg1, 第一個(gè)參數(shù)# +0x8($arg1), 地址偏移+0x8# +0x70(+0x8($arg1)), 相當(dāng)與C語言的 *(*($arg1 + 0x8) + 0x70)
echo 'p vfs_open name=+0x70(+0x8($arg1)):string namep=+0(+0x60(+0x8($arg1))):string' > ./kprobe_eventsecho 1 > ./events/kprobes/p_vfs_open_0/enableecho > trace && cat /test.txtcp trace /test.txt && cat /test.txt

觀察結(jié)果：圖示看到一些vfs_open函數(shù)的kprobe事件，name是當(dāng)前被查看的文件名。kprobe通過參數(shù)加地址偏移計(jì)算拿到特定成員的地址

case02: 捕獲"vfs_open"查看指定文件的信息的事件

# 功能: 利用filter和trigger文件root@debian:/sys/kernel/debug/tracing# ls ./events/kprobes/p_vfs_open_0/enable filter format hist id inject trigger
# 格式: kprobe eventroot@debian:/sys/kernel/debug/tracing# cat ./events/kprobes/p_vfs_open_0/format
echo 'p vfs_open name=+0x70(+0x8($arg1)):string namep=+0(+0x60(+0x8($arg1))):string' > ./kprobe_eventsecho 1 > ./events/kprobes/p_vfs_open_0/enable # 過濾包含"test"字段的文件的事件echo 'name ~ "*test*"' > ./events/kprobes/p_vfs_open_0/filterecho > trace && cat /test.txtecho 'stacktrace if name ~ "*test*"' > ./events/kprobes/p_vfs_open_0/trigger  # 包含"test"字段的文件的事件會(huì)觸發(fā)"stacktrace"堆棧打印

trace event

cat /sys/kernel/debug/tracing/available_events # 查看當(dāng)前支持的跟蹤事件列表

case01: 打開驅(qū)動(dòng)中跟蹤節(jié)點(diǎn)

echo 1 > /sys/kernel/debug/tracing/events/gsgpu/enable && echo 0 > /sys/kernel/debug/tracing/trace && /root/run_test.sh ; cp /sys/kernel/debug/tracing/trace /test.txt && echo 0 > /sys/kernel/debug/tracing/events/gsgpu/enablecat /test.txt

case02: 通過filter過濾事件

echo 0 > /sys/kernel/debug/tracing/events/gsgpu/enable && echo 1 > /sys/kernel/debug/tracing/events/gsgpu/gsgpu_bo_move/enable && echo 0 > /sys/kernel/debug/tracing/trace && echo "bo_size >= 50000" > /sys/kernel/debug/tracing/events/gsgpu/gsgpu_bo_move/filter && /root/run_test.sh ; cp /sys/kernel/debug/tracing/trace /test.txt && echo 0 > /sys/kernel/debug/tracing/events/gsgpu/gsgpu_bo_move/filtercat /test.txt

case03: 通過trigger查看棧回溯

echo 0 > /sys/kernel/debug/tracing/events/gsgpu/enable && echo 1 > /sys/kernel/debug/tracing/events/gsgpu/gsgpu_bo_move/enable && echo 0 > /sys/kernel/debug/tracing/trace && echo 'stacktrace' > /sys/kernel/debug/tracing/events/gsgpu/gsgpu_bo_move/trigger && /root/run_test.sh ; cp /sys/kernel/debug/tracing/trace /test.txt && echo '!stacktrace' > /sys/kernel/debug/tracing/events/gsgpu/gsgpu_bo_move/trigger && cat /test.txt

objtrace

case01：觀察對(duì)象數(shù)據(jù)在函數(shù)中流動(dòng)

源碼位置：https://github.com/x-lugoo/linux/tree/objtrace-v9

[root@JeffXie tracing]# cat ./events/kprobes/p_bio_add_page_0/trigger Available triggers: traceon traceoff snapshot stacktrace enable_event disable_event hist objtrace
cd /sys/kernel/debug/tracing/echo 'p bio_add_page arg1=$arg1 arg2=$arg2' > ./kprobe_eventsecho 'objtracearg1,0x285 if comm == "cat"' > ./events/kprobes/p_bio_add_page_0/trigger# du -sh /test.txt // 12Kcat /test.txt > /dev/nullcat ./trace

觀察結(jié)果：參數(shù)arg1對(duì)應(yīng)object對(duì)象，由于有kprobe匹配到目標(biāo)參數(shù)達(dá)到觸發(fā)條件，我看到圖示中打印的調(diào)試信息。這樣就可以觀察到指定接口的參數(shù)在內(nèi)核函數(shù)中是怎樣流動(dòng)的

一些觀點(diǎn)

• 1、ftrace很多功能在國內(nèi)使用不充分，比如tracer網(wǎng)上資料少，ftrace功能很強(qiáng)大，可挖掘的潛力大。像是大家對(duì)shell的使用，如果大家能積累更多的案例，這樣能更好的普及和使用。

• 2、ftrace和正常的日志環(huán)形緩沖區(qū)不同，如果大量日志向同一個(gè)緩沖區(qū)輸入，一會(huì)導(dǎo)致信息混亂，二是容易覆蓋有效數(shù)據(jù)。使用ftrace的過濾等功能，可以更好的解決此類問題（適用更加復(fù)雜的業(yè)務(wù)場(chǎng)景）。補(bǔ)充ftrace其他功能：自動(dòng)保存結(jié)果輸出到文件；生成直方圖；觸發(fā)其他事件；等等。

• 3、ftrace對(duì)內(nèi)核的通用性還是比較強(qiáng)的，相比ebpf來說ftrace對(duì)于低版本的內(nèi)核更加友好。

• 4、ftrace的用戶群體大，但是名聲沒有ebpf的功能大。

• 5、ftrace的tracer在linux中使用shell腳本來實(shí)現(xiàn)，如果想要觀察和定位，使用這種手段方便；如果轉(zhuǎn)發(fā)類或者做業(yè)務(wù)相關(guān)的，推薦使用ebpf比較多。可以根據(jù)各自優(yōu)勢(shì)應(yīng)用到不同的場(chǎng)景，也可以兩者結(jié)合使用。

一些問答

問

perf/ftrace/ebpf關(guān)系

答

基于kprobe的ebpf通過 fd找到字節(jié)碼程序，當(dāng)perf使用相同功能的時(shí)候，可以依據(jù) fd來找到這個(gè)字節(jié)碼程序。基于kprobe的ebpf本質(zhì)上是基于ftrace， 使用ftrace框架來調(diào)用字節(jié)碼程序

#使用bpftrace工具將ebpf程 序掛載到"kprobe:do_ nanosleep"bpftrace -e 'kprobe:do_nanosleep { printf("PID %d sleeping... ", pid); }'

問

kprobe和function trace的鉤子有什么區(qū)別？

答

基本相同，kprobe的鉤子函數(shù)會(huì)做更多的解析工作，例如解析更多的 field(例如argN或stackN等)

問

什么是no trace函數(shù)？

答

如果函數(shù)本身參與ftrace功能，不能用于trace(避免遞歸) 這樣的函數(shù)一般都是no trace。

問

uprobe是用什么實(shí)現(xiàn)的？

答

uprobe在用戶層，基于斷點(diǎn)指令來實(shí)現(xiàn)。

問

ftrace對(duì)性能影響多大?

答

看如何使用？如果對(duì)所有函數(shù)使用function tracer，如果只使用一個(gè)性能事件性能消耗很小。

問

如果從學(xué)習(xí)內(nèi)核的角度來講，怎樣把ftrace作為一個(gè)輔助的工具來上手內(nèi)核？

答

在調(diào)試內(nèi)核的時(shí)候，通常使用printk/printf來使用，使用ftrace的前提要戒掉這個(gè)習(xí)慣，然后使用ftrace工具來調(diào)試。

問

對(duì)于可靠性和安全性比較高的領(lǐng)域，對(duì)于ftrace是不是要慎用一些？

答

是的，對(duì)原理理解要求比較高一些。對(duì)原理比較清楚的話，能很好的縮小ftrace的使用范圍，來進(jìn)一步降低對(duì)系統(tǒng)的性能消耗。

問

如何評(píng)估這些調(diào)試工具的開銷?

答

正確對(duì)待ftrace是一個(gè)輔助工具，前提還是要對(duì)代碼比較熟悉，ftrace輔助對(duì)代碼的觀察。

問

ftrace這樣的工具好處？

答

使用在不破壞內(nèi)核的情況下，提供一個(gè)對(duì)內(nèi)核可觀測(cè)手段；提供基礎(chǔ)的tracer功能，靈活運(yùn)用好tracer功能對(duì)分析問題幫助；perf工具將各種類型的掛載點(diǎn)收入囊中，一統(tǒng)江湖。

問

linux內(nèi)核中有這么多鉤子？都有什么局限，如何選擇

答

看具體想使用哪些功能，比如查看函數(shù)怎么執(zhí)行，選擇function tracer；比如查看某一個(gè)函數(shù)的參數(shù)，使用kprobe掛載點(diǎn)對(duì)應(yīng)的鉤子函數(shù)不一樣的。

問

ftrace的tracer在linux中使用shell腳本來實(shí)現(xiàn)，如果想要觀察和定位，使用這種手段方便；如果轉(zhuǎn)發(fā)類或者做業(yè)務(wù)相關(guān)的，推薦使用ebpf比較多

答

各有優(yōu)勢(shì)，應(yīng)用到不同的場(chǎng)景，也可以兩者結(jié)合使用。

問

在嵌入式場(chǎng)景，內(nèi)存資源比較緊張的時(shí)候適用么？

答

內(nèi)存消耗比較小。也可以設(shè)置，buffer可以調(diào)小一些。

問

ftrace在性能消耗比ebpf更小么？

答

也不一定，看使用那部分功能。

問

有沒有推薦的日志化性能分析的圖形工具？

答

tracecmd和KernelShark。

個(gè)人總結(jié)

內(nèi)核源碼中放置很多靜態(tài)跟蹤節(jié)點(diǎn)，這些節(jié)點(diǎn)可以被關(guān)聯(lián)到對(duì)應(yīng)的回調(diào)函數(shù)。當(dāng)我想要調(diào)試某個(gè)子系統(tǒng)/模塊時(shí)，通過debug系統(tǒng)將對(duì)應(yīng)的節(jié)點(diǎn)開啟（將回調(diào)函數(shù)掛鉤子到靜態(tài)跟蹤點(diǎn)上，與之關(guān)聯(lián)），這樣內(nèi)核在執(zhí)行到跟蹤點(diǎn)位置的時(shí)候會(huì)調(diào)用鉤子函數(shù)，最終執(zhí)行結(jié)果將被輸出寫到一個(gè)環(huán)形日志緩存區(qū)里，通過debug系統(tǒng)查看信息。

作為一種內(nèi)核層面的調(diào)試手段，trace event利用了ftrace框架，算是ftrace的一個(gè)應(yīng)用吧。當(dāng)我想要調(diào)試某一個(gè)模塊，開啟對(duì)應(yīng)的節(jié)點(diǎn)就好了，trace event基于現(xiàn)有的跟蹤節(jié)點(diǎn)（一般是寫代碼的添加好的）效率高些，或者解決新的bug時(shí)將關(guān)鍵調(diào)試信息固化到調(diào)試系統(tǒng)里。

從做工作的角度，我能體會(huì)到的是trace event工具能帶來工作效率的提升。從學(xué)習(xí)的角度，我相信使用ftrace工具能更加方便觀測(cè)內(nèi)核。

審核編輯 ：李倩