Red Hat Bugzilla – Bug 460156
RHEL5 cmirror tracker: clogd ERROR:: Additional resume issued before suspend
Last modified: 2010-01-11 21:08:04 EST
Description of problem:
I've seen this issue every so often when doing mirror creates.
Aug 25 17:05:45 hayes-02 qarshd: Running cmdline: lvcreate -m 1 -n hayes-02.19867 -L 500M lock_stress
Aug 25 17:05:45 hayes-02 qarshd: Running cmdline: lvcreate -m 1 -n hayes-02.19884 -L 500M lock_stress
Aug 25 17:06:01 hayes-02 kernel: device-mapper: dm-log-clustered: [Ohxxqto9] Request timed out: [DM_CLOG_RESUME/2] - retrying
Aug 25 17:06:01 hayes-02 clogd: [Ohxxqto9] ERROR:: Additional resume issued before suspend
Aug 25 17:06:01 hayes-02 dmeventd: dmeventd ready for processing.
Aug 25 17:06:01 hayes-02 dmeventd: Monitoring mirror device lock_stress-hayes--03.19865 for events
Version-Release number of selected component (if applicable):
lvm2-2.02.32-4.el5 BUILT: Fri Apr 4 06:15:19 CDT 2008
lvm2-cluster-2.02.32-4.el5 BUILT: Wed Apr 2 03:56:50 CDT 2008
cmirror-1.1.22-1.el5 BUILT: Thu Jul 24 15:59:03 CDT 2008
kmod-cmirror-0.1.13-2.el5 BUILT: Thu Jul 24 16:00:48 CDT 2008
every so often
This looks like a know convert issue (bug 455670). Verify that there are no mirror to mirror converts happening. If this truly happens just by doing creates, then you will need to gather the '-vvvv' output from the lvm command. If it is due to convert, then this is a dup.
(where's the NEEDINFO state?)
No mirror to mirror converts happening, just a simple create:
Sep 30 16:57:06 taft-01 qarshd: Running cmdline: lvcreate -m 1 -n syncd_primary_2legs_1 -L 600M helter_skelter /dev/sdf1:0-1000 /dev/sde1:0-1000 /dev/sdg1:0-150
Sep 30 16:57:22 taft-01 kernel: device-mapper: dm-log-clustered: [Nj20tA2W] Request timed out: [DM_CLOG_RESUME/2] - retrying
Sep 30 16:57:22 taft-01 clogd: [Nj20tA2W] ERROR:: Additional resume issued before suspend
Sep 30 16:57:22 taft-01 dmeventd: dmeventd ready for processing.
Sep 30 16:57:22 taft-01 dmeventd: Monitoring mirror device helter_skelter-syncd_primary_2legs_1 for events
I'll try and grab that -vvv output for you.
lvm2-2.02.40-3.el5 BUILT: Thu Sep 25 14:59:07 CDT 2008
lvm2-cluster-2.02.40-3.el5 BUILT: Thu Sep 25 15:00:54 CDT 2008
device-mapper-1.02.28-2.el5 BUILT: Fri Sep 19 02:50:32 CDT 2008
cmirror-1.1.28-1.el5 BUILT: Tue Sep 30 15:48:54 CDT 2008
kmod-cmirror-0.1.18-1.el5 BUILT: Mon Sep 29 16:20:21 CDT 2008
how often does this happen on the create? Every time? If so, we have a real problem. (... and it would be an LVM/device-mapper bug)
Bumping the priority even though I don't have a reliable way to reproduce this. This may be a side effect of 464550, or at the very least, testing is blocked behind it.
An advisory has been issued which should help the problem
described in this bug report. This report is therefore being
closed with a resolution of ERRATA. For more information
on therefore solution and/or where to find the updated files,
please follow the link below. You may reopen this bug report
if the solution does not work for you.