NMI 跟踪事件¶
这些事件通常显示在此处
/sys/kernel/tracing/events/nmi
nmi_handler¶
如果你怀疑 NMI 处理程序占用了大量 CPU 时间,你可能需要使用这个跟踪点。如果内核发现处理程序运行时间过长,它会发出警告
INFO: NMI handler took too long to run: 9.207 msecs
而这个跟踪点将允许你深入分析并获取更多细节。
假设你怀疑 perf_event_nmi_handler() 导致了一些问题,并且你只想专门跟踪该处理程序。你需要找到它的地址
$ grep perf_event_nmi_handler /proc/kallsyms
ffffffff81625600 t perf_event_nmi_handler
再假设你只对该函数确实占用了大量 CPU 时间(比如每次一毫秒)的情况感兴趣。请注意,内核的输出单位是毫秒,但过滤器的输入单位是纳秒!你可以使用 ‘delta_ns’ 进行过滤
cd /sys/kernel/tracing/events/nmi/nmi_handler
echo 'handler==0xffffffff81625600 && delta_ns>1000000' > filter
echo 1 > enable
那么你的输出看起来会是这样
$ cat /sys/kernel/tracing/trace_pipe
<idle>-0 [000] d.h3 505.397558: nmi_handler: perf_event_nmi_handler() delta_ns: 3236765 handled: 1
<idle>-0 [000] d.h3 505.805893: nmi_handler: perf_event_nmi_handler() delta_ns: 3174234 handled: 1
<idle>-0 [000] d.h3 506.158206: nmi_handler: perf_event_nmi_handler() delta_ns: 3084642 handled: 1
<idle>-0 [000] d.h3 506.334346: nmi_handler: perf_event_nmi_handler() delta_ns: 3080351 handled: 1