3. printk 与动态调试

内核日志与动态调试是 Linux 内核开发与性能调校中最基础、最常用的诊断手段。本章将深入剖析 printk 日志级别机制、dmesg 命令的使用技巧，以及动态调试（Dynamic Debug）的原理与实战方法，帮助你在不同场景下精准获取内核运行信息。

3.1 printk 日志级别

printk 是内核中最核心的日志输出函数，其行为与用户空间的 printf 类似，但增加了日志级别（Loglevel）控制。日志级别决定了消息的严重程度以及是否被输出到控制台或日志缓冲区。

3.1.1 日志级别定义

内核定义了 8 个日志级别，数值越小，优先级越高。下表列出了所有级别及其典型用途：

宏定义	数值	含义	典型场景
KERN_EMERG	0	紧急事件	系统崩溃、不可恢复错误
KERN_ALERT	1	必须立即处理	严重硬件故障、内核 panic 前兆
KERN_CRIT	2	临界条件	关键子系统失效、内存耗尽
KERN_ERR	3	错误条件	驱动错误、系统调用失败
KERN_WARNING	4	警告	资源不足、配置异常
KERN_NOTICE	5	正常但重要	模块加载、设备发现
KERN_INFO	6	信息性消息	版本信息、驱动初始化详情
KERN_DEBUG	7	调试信息	开发阶段详细日志

3.1.2 控制台日志级别与文件节点

内核通过 /proc/sys/kernel/printk 文件控制日志输出行为。该文件包含 4 个整数值：

# cat /proc/sys/kernel/printk
7       4       1       7

四个字段的含义如下：

字段	名称	说明
1	console_loglevel	只有优先级高于此值的消息才会输出到控制台
2	default_message_loglevel	未指定级别的 printk 默认使用的级别
3	minimum_console_loglevel	控制台日志级别可设置的最小值
4	default_console_loglevel	系统启动时的默认控制台日志级别

例如，将控制台日志级别设为 3，则只有 KERN_ERR 及以上级别的消息才会显示在终端上：

# echo "3 4 1 7" > /proc/sys/kernel/printk

3.2 dmesg 命令

dmesg 是读取内核环形缓冲区（Ring Buffer）的标准工具，用于查看系统启动以来的所有内核日志。其底层通过 syslog 系统调用或 /dev/kmsg 设备文件获取数据。

3.2.1 常用操作

• 查看所有日志：dmesg
• 实时监控日志：dmesg -w（类似 tail -f）
• 按级别过滤：dmesg -l err,warn（只显示错误和警告）
• 按模块过滤：dmesg | grep -i usb
• 清空缓冲区：dmesg -c（谨慎使用，会丢失历史日志）
• 显示人类可读时间戳：dmesg -T

3.2.2 日志缓冲区大小调整

内核环形缓冲区默认大小通常为 128KB，可通过内核启动参数 log_buf_len 调整：

# 在 GRUB 内核命令行中添加
log_buf_len=4M

3.3 动态调试（Dynamic Debug）原理与使用

动态调试是内核提供的一种高级日志控制机制，允许在不重新编译内核或模块的情况下，动态启用或禁用特定代码路径的调试输出。它主要针对 pr_debug() 和 dev_dbg() 这类调试宏。

3.3.1 工作原理

动态调试的核心思想是在编译时保留调试语句的元数据（文件名、行号、函数名、格式字符串），并在运行时通过 debugfs 文件系统控制其开关。其工作流程如下：

3.3.2 启用动态调试

内核需要开启以下配置选项：

CONFIG_DYNAMIC_DEBUG=y
CONFIG_DEBUG_FS=y

挂载 debugfs 后，控制接口位于：

# mount -t debugfs none /sys/kernel/debug
# ls /sys/kernel/debug/dynamic_debug/control

3.3.3 控制语法

通过向 control 文件写入规则来启用或禁用调试输出。基本语法格式为：

# 启用特定文件的调试输出
echo "file drivers/usb/core/hub.c +p" > /sys/kernel/debug/dynamic_debug/control

# 启用特定函数的调试输出
echo "func usb_hub_init +p" > /sys/kernel/debug/dynamic_debug/control

# 启用特定行的调试输出
echo "file drivers/usb/core/hub.c line 123 +p" > /sys/kernel/debug/dynamic_debug/control

# 启用模块所有调试输出
echo "module usbcore +p" > /sys/kernel/debug/dynamic_debug/control

# 禁用调试输出（将 +p 改为 -p）
echo "file drivers/usb/core/hub.c -p" > /sys/kernel/debug/dynamic_debug/control

控制标志说明：

标志	含义	说明
p	print	启用调试输出
f	function	在输出中添加函数名
l	line	在输出中添加行号
m	module	在输出中添加模块名
t	thread	在输出中添加线程 ID

3.4 pr_debug 与 dev_dbg

pr_debug() 和 dev_dbg() 是内核中最常用的调试宏，它们与动态调试机制深度集成。

3.4.1 宏定义对比

宏	所属头文件	额外参数	典型用途
pr_debug(fmt, ...)	<linux/printk.h>	无	通用内核调试
dev_dbg(dev, fmt, ...)	<linux/device.h>	struct device *dev	设备驱动调试，自动输出设备名

3.4.2 编译时控制

在没有动态调试的情况下，这些宏的行为由 DEBUG 宏控制：

#define DEBUG
#include <linux/printk.h>

// 此时 pr_debug() 等效于 printk(KERN_DEBUG ...)
pr_debug("Initializing device %s\n", name);

如果未定义 DEBUG 且未启用动态调试，这些宏会被编译为空，不产生任何代码。

3.4.3 动态调试实战示例

假设我们需要调试 USB 核心模块的 hub 初始化过程：

# 1. 查看当前所有可用的动态调试点
cat /sys/kernel/debug/dynamic_debug/control | grep usb

# 2. 启用 hub.c 中所有调试输出，并显示函数名和行号
echo "file drivers/usb/core/hub.c +pfl" > /sys/kernel/debug/dynamic_debug/control

# 3. 触发 hub 初始化（例如插拔 USB 设备）
# 4. 通过 dmesg 查看详细调试信息
dmesg -T | tail -50

# 5. 调试完成后关闭
echo "file drivers/usb/core/hub.c -p" > /sys/kernel/debug/dynamic_debug/control

3.5 日志与动态调试架构总览

下图展示了内核日志系统从产生到消费的完整链路：

3.6 常见问题与排查

• 问题：dmesg 看不到任何输出
  排查：检查 /proc/sys/kernel/printk 的第一个值是否过低；确认 dmesg -l 过滤条件是否正确。
• 问题：动态调试规则写入成功但无输出
  排查：确认内核编译时开启了 CONFIG_DYNAMIC_DEBUG；检查目标代码是否使用了 pr_debug() 而非 printk(KERN_DEBUG)。
• 问题：调试输出过多导致系统卡顿
  排查：使用 echo "module xxx -p" 批量关闭；增大环形缓冲区大小；使用 dmesg -w 实时观察而非持续写入文件。