如何处理syslog时间戳异常？

Question

当我看到这个的时候，我正在浏览我的syslog：

Jul  7 21:13:34 <Computer-Name> kernel: [14361.093581] CPU1: Package temperature/speed normal
Jul  7 21:09:27 <Computer-Name> thermald[843]: sysfs write failed /no_turbo
Jul  7 21:14:03 <Computer-Name> NetworkManager[1095]: <info>  [1467922443.6944] device (enp3s0): link disconnected (deferring action for 4 seconds)

正如您将看到的，有一个异常与第二项。这有什么好担心的吗？这是由什么引起的呢？关于这件事我应该做些什么(例如，有什么地方我应该报告这件事？)

我使用GNOME 3.20运行Ubuntu 16.04。

Answer 1

明显的日志文件时间戳异常确实会发生，尽管很少发生。日志条目的时间戳部分是从启动相关操作时开始的，但如果需要，则将实际行写入日志，或者在操作完成时或超时或其他任何情况下写入日志。

对于您的示例，我假设thermald写入超时需要几分钟时间，同时CPU1消息已经输入到日志中。

下面是我的服务器计算机中的一个示例，其中文件bot_trap.html大约需要50分钟才能传递到客户端：

$ tail -4 /var/log/apache2/access.log
192.168.111.101 - - [07/Jul/2016:20:41:06 -0700] "GET /about_smythies.html HTTP/1.1" 200 1515 "http://www.smythies.com/" "Mozilla/5.0 (Windows NT 10.0; WOW64; rv:47.0) Gecko/20100101 Firefox/47.0"
192.168.111.101 - - [07/Jul/2016:20:41:57 -0700] "GET /about_smythies.html HTTP/1.1" 200 1515 "http://www.smythies.com/" "Mozilla/5.0 (Windows NT 10.0; WOW64; rv:47.0) Gecko/20100101 Firefox/47.0"
192.168.111.101 - - [07/Jul/2016:19:52:55 -0700] "GET /bot_trap.html HTTP/1.1" 200 17542 "http://www.smythies.com/" "Mozilla/5.0 (Windows NT 10.0; WOW64; rv:47.0) Gecko/20100101 Firefox/47.0"
192.168.111.101 - - [07/Jul/2016:20:43:04 -0700] "GET /about_smythies.html HTTP/1.1" 200 1515 "http://www.smythies.com/" "Mozilla/5.0 (Windows NT 10.0; WOW64; rv:47.0) Gecko/20100101 Firefox/47.0"