在檢查一Linux服務器時，發現日志裡面有大量“lvm[12446]: Another thread is handling an event. Waiting...”
Jul 4 00:01:42 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:09:36 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:13:42 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:13:43 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:13:43 localhost lvm[12446]: dm_task_run failed, errno = 9, Bad file descriptor
Jul 4 00:14:42 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:15:52 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:17:02 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:17:02 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:17:46 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:18:52 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:19:42 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:20:32 localhost lvm[12446]: Snapshot VolGroup05-LogVol00--PS--user--snapshot is now 80% full.
Jul 4 00:20:32 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:23:12 localhost lvm[12446]: Snapshot VolGroup05-LogVol00--PS--user--snapshot is now 85% full.
Jul 4 00:23:12 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:23:12 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:23:12 localhost lvm[12446]: dm_task_run failed, errno = 9, Bad file descriptor
Jul 4 00:26:09 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:26:52 localhost last message repeated 2 times
Jul 4 00:26:52 localhost lvm[12446]: Snapshot VolGroup05-LogVol00--PS--user--snapshot is now 90% full.
Jul 4 00:26:52 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:28:52 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:28:52 localhost lvm[12446]: Snapshot VolGroup05-LogVol00--PS--user--snapshot is now 95% full.
Jul 4 00:28:52 localhost lvm[12446]: Extension of snapshot VolGroup05/LogVol00-PS-user-snapshot finished successfully.
Jul 4 00:28:52 localhost lvm[12446]: dm_task_run failed, errno = 9, Bad file descriptor
Jul 4 00:31:07 localhost kernel: device-mapper: snapshots: Invalidating snapshot: Unable to allocate exception.
Jul 4 00:34:59 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:35:42 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:42:29 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:44:16 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:45:49 localhost lvm[12446]: Another thread is handling an event. Waiting...
Jul 4 00:46:59 localhost last message repeated 3 times
Jul 4 00:48:49 localhost last message repeated 2 times
在Redhat官網有看到相關資料介紹”"What does "lvm: Another thread is handling an event. Waiting..." log messages mean on Red Hat Enterprise Linux 6?" 如下所示:
/var/log/messageslvm: Another thread is handling an event, Waiting...
lvm: Another thread is handling an event, Waiting...
If the following symptoms are present on your system, then this article may apply to your issue:
Periodically, the following messages appear in /var/log/messages:
Raw lvm: Another thread is handling an event. Waiting...
lvm: Another thread is handling an event. Waiting...
根據官方文檔資料，這個消息可以忽略，這中現象出現在你的系統中，當你系統滿足下面條件：
當你的lvm2包版本是2.02.87-6.el6 或之前的版本。
當你的系統有超過一個LVM快照
對比、參考本機操作系統版本，發現lvm2的版本確實比2.02.87-6.el6 低。另外，這個系統也確實有多個LVM快照。唯一有點差別的是Linux版本Red Hat Enterprise Linux Server release 5.7 ，並不是Red Hat Enterprise Linux (RHEL) 6
[root@localhost ~]# rpm -qa | grep lvm
lvm2-2.02.84-6.0.1.el5
system-config-lvm-1.1.5-9.el5
[root@localhost ~]# cat /etc/redhat-release
Red Hat Enterprise Linux Server release 5.7 (Tikanga)
另外，查看進程12446，也確實是/sbin/dmeventd
[root@localhost ~]# ps -ef | grep 12446
root 12446 1 0 Jul02 ? 00:07:51 /sbin/dmeventd
root 26043 23106 0 11:06 pts/6 00:00:00 grep 12446
這個錯誤信息一直不停的出現在系統日志當中，很奇怪的時候，我同樣環境的其它服務器又沒有出現這個問題。應該是某些問題引起的。在做VG掃描時，發現有這樣/dev/VolGroup03/LogVol00-PS-user-snapshot: read failed after 0 of 4096 at 0: Input/output error一些錯誤信息，懷疑這個導致引起的，但是生產環境還不能亂動，需要在測試環境測試、驗證後，方能在生產環境處理。目前沒有權限和資源處理，需要系統管理員幫忙解決。
http://xxxxxx/Linuxjc/1145356.html TechArticle
