linux dmesg带时间戳,[20191226]dmesg与时间戳.txt

[20191226]dmesg与时间戳.txt

--//昨天例行检查时,我发现rh7的服务器执行dmesg时前面有一串数字.

# cat /etc/redhat-release

Red Hat Enterprise Linux Server release 7.7 (Maipo)

# dmesg | head -3

[    0.000000] Initializing cgroup subsys cpuset

[    0.000000] Initializing cgroup subsys cpu

[    0.000000] Initializing cgroup subsys cpuacct

# dmesg | tail -4

[   66.621051] fuse init (API version 7.23)

[825806.735240] FS-Cache: Loaded

[825806.797058] FS-Cache: Netfs 'nfs' registered for caching

[1294335.827275] Adjusting tsc more than 11% (3895849 vs 4906388)

--//可以猜测中括号里面的数字一定与时间相关.dmesg输出开头都是0,也就是这个时间应该表示某种偏移量,单位猜测应该是秒.

--//看了man demsg文档,发现rh7.7版本对dmesg做了许多改进,增加许多功能.

-T, --ctime

Print human readable timestamps.  The timestamp could be inaccurate!

# dmesg -L -T | head -3 ; dmesg -L -T | tail -3

[Thu Dec  5 12:07:43 2019] Initializing cgroup subsys cpuset

[Thu Dec  5 12:07:43 2019] Initializing cgroup subsys cpu

[Thu Dec  5 12:07:43 2019] Initializing cgroup subsys cpuacct

--//head

[Sun Dec 15 01:31:09 2019] FS-Cache: Loaded

[Sun Dec 15 01:31:09 2019] FS-Cache: Netfs 'nfs' registered for caching

[Fri Dec 20 11:39:58 2019] Adjusting tsc more than 11% (3895849 vs 4906388)

--//tail

# last | grep reboot | head -1

reboot   system boot  4.1.12-124.33.4. Thu Dec  5 12:07 - 08:34 (20+20:26)

# uptime

08:34:25 up 20 days, 20:26,  2 users,  load average: 1.00, 1.03, 1.05

--//结合这两个输出,可以判断时间就是Thu Dec  5 12:07:43 2019 加上 1294335.827275秒.验证看看.

# date -d "Thu Dec  5 12:07:43 2019 UTC  1294335.827275 seconds" +"%Y-%m-%d %T"

2019-12-20 19:39:58

--//不要考虑时区.取消UTC.

# date -d "Thu Dec  5 12:07:43 2019   1294335.827275 seconds" +"%Y-%m-%d %T"

2019-12-20 11:39:58

--//正好与[Fri Dec 20 11:39:58 2019] Adjusting tsc more than 11% (3895849 vs 4906388)的输出时间一致.

--//当时当我看我的测试环境:

# cat /etc/issue | head -1

Oracle Linux Server release 5.9

# dmesg | tail -2

warning: `avahi-daemon' uses 32-bit capabilities (legacy support in use)

eth0: no IPv6 routers present

--//并没有时间戳信息.也就是rh7.7版本内核做了某些改进,增加显示时间戳.我看了一些文档:

--//实际上就是设置/sys/module/printk/parameters/time等于Y就ok了.

# cat /sys/module/printk/parameters/time

N

# echo Y >| /sys/module/printk/parameters/time

--//尝试加载ip_tables模块.也就是尝试写入一些信息.

# modprobe ip_tables

# dmesg | tail -4

warning: `avahi-daemon' uses 32-bit capabilities (legacy support in use)

eth0: no IPv6 routers present

ip_tables: (C) 2000-2006 Netfilter Core Team

[231838.112752] ip_tables: (C) 2000-2006 Netfilter Core Team

--//也就是出现时间戳.可以这个要过来计算日期比较麻烦.

# modprobe xfs;zdate

2019/12/26 09:14:58

# dmesg | tail -1

[233458.384254] SGI XFS Quota Management subsystem

# cat /proc/uptime ;zdate

233980.52 5611536.56

2019/12/26 09:15:45

# date -d "$(zdate) -$(cat /proc/uptime|cut -d' ' -f1) seconds" +"%Y-%m-%d %T"

2019-12-23 16:16:04

# date -d "2019/12/26 09:15:45 -233980.52 seconds" +"%Y-%m-%d %T"

2019-12-23 16:16:04

# date -d "2019-12-23 16:16:04 233458.384254 seconds" +"%Y-%m-%d %T"

2019-12-26 09:07:02

--//有接近8分钟误差,不知道那个计算环节出了问题.放弃!!

--//补充:我重新在rh7服务器测试:

# date -d "$(zdate) -$(cat /proc/uptime|cut -d' ' -f1) seconds" +"%Y-%m-%d %T"

2019-12-05 12:07:43

--//这个时间与dmesg -T看到的时间一致.使用它计算应该是对的.不知道在测试环境问题出在哪里.