Attachment 150151 Details for Bug 217895 – clvmd -d log from link-07

clvmd -d log from link-07

clvmd.link-07 (text/plain), 61.90 KB, created by Corey Marthaler on 2007-03-15 18:36:36 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Corey Marthaler

Created: 2007-03-15 18:36:36 UTC

Size: 61.90 KB

patch

obsolete

>CLVMD[9566b800]: Mar 15 12:50:21 CLVMD started
>CLVMD[9566b800]: Mar 15 12:50:42 Cluster ready, doing some more initialisation
>CLVMD[9566b800]: Mar 15 12:50:42 starting LVM thread
>CLVMD[9566b800]: Mar 15 12:50:42 clvmd ready for work
>CLVMD[9566b800]: Mar 15 12:50:42 Using timeout of 60 seconds
>CLVMD[9566b800]: Mar 15 12:50:42 add_to_lvmqueue: cmd=0x569470. client=0x5619c0, msg=0x7fbfffe8a0, len=30, csid=0x7fbfffe884, xid=0
>CLVMD[9566b800]: Mar 15 12:50:42 add_to_lvmqueue: cmd=0x56b6b0. client=0x5619c0, msg=0x7fbfffe8a0, len=30, csid=0x7fbfffe884, xid=0
>CLVMD[9566b800]: Mar 15 12:50:42 add_to_lvmqueue: cmd=0x56b730. client=0x5619c0, msg=0x7fbfffe8a0, len=30, csid=0x7fbfffe884, xid=0
>CLVMD[41401960]: Mar 15 12:50:42 LVM thread function started
>File descriptor 4 left open
>  Skipping clustered volume group helter_skelter
>CLVMD[41401960]: Mar 15 12:50:42 lvs fclose failed: Success
>CLVMD[41401960]: Mar 15 12:50:42 LVM thread waiting for work
>CLVMD[41401960]: Mar 15 12:50:42 process_work_item: remote
>CLVMD[41401960]: Mar 15 12:50:42 process_remote_command 2 for clientid 0x0 XID 49151 on node link-04
>CLVMD[41401960]: Mar 15 12:50:42 Remote node link-04 is version 0.2.1
>CLVMD[41401960]: Mar 15 12:50:42 Added new node 2 to updown list
>CLVMD[41401960]: Mar 15 12:50:42 process_work_item: remote
>CLVMD[41401960]: Mar 15 12:50:42 process_remote_command 2 for clientid 0x0 XID 49151 on node link-02
>CLVMD[41401960]: Mar 15 12:50:42 Remote node link-02 is version 0.2.1
>CLVMD[41401960]: Mar 15 12:50:42 Added new node 1 to updown list
>CLVMD[41401960]: Mar 15 12:50:42 process_work_item: remote
>CLVMD[41401960]: Mar 15 12:50:42 process_remote_command 2 for clientid 0x0 XID 49151 on node link-08
>CLVMD[41401960]: Mar 15 12:50:42 Remote node link-08 is version 0.2.1
>CLVMD[41401960]: Mar 15 12:50:42 Added new node 3 to updown list
>CLVMD[41401960]: Mar 15 12:50:42 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:51:10 Got new connection on fd 8
>CLVMD[9566b800]: Mar 15 12:51:10 Read on local socket 8, len = 33
>CLVMD[9566b800]: Mar 15 12:51:10 creating pipe, [9, 10]
>CLVMD[9566b800]: Mar 15 12:51:10 Creating pre&post thread
>CLVMD[9566b800]: Mar 15 12:51:10 Created pre&post thread, state = 0
>CLVMD[41e02960]: Mar 15 12:51:10 in sub thread: client = 0x584170
>CLVMD[41e02960]: Mar 15 12:51:10 Sub thread ready for work.
>CLVMD[41e02960]: Mar 15 12:51:10 doing PRE command LOCK_VG 'V_VolGroup00' at 1 (client=0x584170)
>CLVMD[41e02960]: Mar 15 12:51:10 sync_lock: 'V_VolGroup00' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 12:51:10 sync_lock: returning lkid 1011e
>CLVMD[41e02960]: Mar 15 12:51:10 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:51:10 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:10 background routine status was 0, sock_client=0x584170
>CLVMD[9566b800]: Mar 15 12:51:10 distribute command: XID = 0
>CLVMD[9566b800]: Mar 15 12:51:10 add_to_lvmqueue: cmd=0x56b730. client=0x584170, msg=0x56b780, len=33, csid=(nil), xid=0
>CLVMD[41401960]: Mar 15 12:51:10 process_work_item: local
>CLVMD[41401960]: Mar 15 12:51:10 process_local_command: msg=0x56b680, msglen =33, client=0x584170
>CLVMD[41401960]: Mar 15 12:51:10 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:51:10 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:51:10 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:51:10 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 12:51:10 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:51:10 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:10 background routine status was 0, sock_client=0x584170
>CLVMD[9566b800]: Mar 15 12:51:10 Send local reply
>CLVMD[41e02960]: Mar 15 12:51:10 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:51:10 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 12:51:10 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:51:10 doing PRE command LOCK_VG 'V_VolGroup00' at 6 (client=0x584170)
>CLVMD[41e02960]: Mar 15 12:51:10 sync_unlock: 'V_VolGroup00' lkid:1011e
>CLVMD[41e02960]: Mar 15 12:51:10 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:51:10 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:10 background routine status was 0, sock_client=0x584170
>CLVMD[9566b800]: Mar 15 12:51:10 distribute command: XID = 1
>CLVMD[9566b800]: Mar 15 12:51:10 add_to_lvmqueue: cmd=0x56b730. client=0x584170, msg=0x56b780, len=33, csid=(nil), xid=1
>CLVMD[41401960]: Mar 15 12:51:10 process_work_item: local
>CLVMD[41401960]: Mar 15 12:51:10 process_local_command: msg=0x56b700, msglen =33, client=0x584170
>CLVMD[41401960]: Mar 15 12:51:10 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:51:10 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:51:10 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:51:10 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 12:51:10 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:51:10 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:10 background routine status was 0, sock_client=0x584170
>CLVMD[9566b800]: Mar 15 12:51:10 Send local reply
>CLVMD[41e02960]: Mar 15 12:51:10 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:51:10 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 12:51:10 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:51:10 doing PRE command LOCK_VG 'V_helter_skelter' at 1 (client=0x584170)
>CLVMD[41e02960]: Mar 15 12:51:10 sync_lock: 'V_helter_skelter' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 12:51:10 sync_lock: returning lkid 101b6
>CLVMD[41e02960]: Mar 15 12:51:10 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:51:10 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:10 background routine status was 0, sock_client=0x584170
>CLVMD[9566b800]: Mar 15 12:51:10 distribute command: XID = 2
>CLVMD[9566b800]: Mar 15 12:51:10 add_to_lvmqueue: cmd=0x56b730. client=0x584170, msg=0x56b780, len=37, csid=(nil), xid=2
>CLVMD[41401960]: Mar 15 12:51:10 process_work_item: local
>CLVMD[41401960]: Mar 15 12:51:10 process_local_command: msg=0x56b700, msglen =37, client=0x584170
>CLVMD[41401960]: Mar 15 12:51:10 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:51:10 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:51:10 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:51:10 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 12:51:10 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:51:10 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:10 background routine status was 0, sock_client=0x584170
>CLVMD[9566b800]: Mar 15 12:51:10 Send local reply
>CLVMD[41e02960]: Mar 15 12:51:10 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:51:10 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 12:51:10 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:51:10 doing PRE command LOCK_VG 'V_helter_skelter' at 6 (client=0x584170)
>CLVMD[41e02960]: Mar 15 12:51:10 sync_unlock: 'V_helter_skelter' lkid:101b6
>CLVMD[41e02960]: Mar 15 12:51:10 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:51:10 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:51:10 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:10 background routine status was 0, sock_client=0x584170
>CLVMD[9566b800]: Mar 15 12:51:10 distribute command: XID = 3
>CLVMD[9566b800]: Mar 15 12:51:10 add_to_lvmqueue: cmd=0x56b730. client=0x584170, msg=0x56b780, len=37, csid=(nil), xid=3
>CLVMD[41401960]: Mar 15 12:51:10 process_work_item: local
>CLVMD[41401960]: Mar 15 12:51:10 process_local_command: msg=0x56b700, msglen =37, client=0x584170
>CLVMD[41401960]: Mar 15 12:51:10 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:51:10 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:51:10 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:51:10 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:51:10 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:51:10 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:10 background routine status was 0, sock_client=0x584170
>CLVMD[9566b800]: Mar 15 12:51:10 Send local reply
>CLVMD[9566b800]: Mar 15 12:51:10 Read on local socket 8, len = 0
>CLVMD[9566b800]: Mar 15 12:51:10 EOF on local socket: inprogress=0
>CLVMD[9566b800]: Mar 15 12:51:10 Waiting for child thread
>CLVMD[41e02960]: Mar 15 12:51:10 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:51:10 Subthread finished
>CLVMD[9566b800]: Mar 15 12:51:10 Joined child thread
>CLVMD[9566b800]: Mar 15 12:51:10 ret == 0, errno = 2. removing client
>CLVMD[9566b800]: Mar 15 12:51:10 add_to_lvmqueue: cmd=0x584280. client=0x584170, msg=(nil), len=0, csid=(nil), xid=3
>CLVMD[41401960]: Mar 15 12:51:10 process_work_item: free fd 8
>CLVMD[41401960]: Mar 15 12:51:10 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:51:12 Got new connection on fd 8
>CLVMD[9566b800]: Mar 15 12:51:12 Read on local socket 8, len = 33
>CLVMD[9566b800]: Mar 15 12:51:12 creating pipe, [9, 10]
>CLVMD[9566b800]: Mar 15 12:51:12 Creating pre&post thread
>CLVMD[9566b800]: Mar 15 12:51:12 Created pre&post thread, state = 0
>CLVMD[41e02960]: Mar 15 12:51:12 in sub thread: client = 0x584150
>CLVMD[41e02960]: Mar 15 12:51:12 Sub thread ready for work.
>CLVMD[41e02960]: Mar 15 12:51:12 doing PRE command LOCK_VG 'V_VolGroup00' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:51:12 sync_lock: 'V_VolGroup00' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 12:51:12 sync_lock: returning lkid 1021b
>CLVMD[41e02960]: Mar 15 12:51:12 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:51:12 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:12 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:51:12 distribute command: XID = 4
>CLVMD[9566b800]: Mar 15 12:51:12 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x56b780, len=33, csid=(nil), xid=4
>CLVMD[41401960]: Mar 15 12:51:12 process_work_item: local
>CLVMD[41401960]: Mar 15 12:51:12 process_local_command: msg=0x584b00, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 12:51:12 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:51:12 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:51:12 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:51:12 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 12:51:12 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:51:12 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:12 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:51:12 Send local reply
>CLVMD[41e02960]: Mar 15 12:51:12 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:51:12 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 12:51:12 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:51:12 doing PRE command LOCK_VG 'V_VolGroup00' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:51:12 sync_unlock: 'V_VolGroup00' lkid:1021b
>CLVMD[41e02960]: Mar 15 12:51:12 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:51:12 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:12 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:51:12 distribute command: XID = 5
>CLVMD[9566b800]: Mar 15 12:51:12 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x56b780, len=33, csid=(nil), xid=5
>CLVMD[41401960]: Mar 15 12:51:12 process_work_item: local
>CLVMD[41401960]: Mar 15 12:51:12 process_local_command: msg=0x584ad0, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 12:51:12 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:51:12 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:51:12 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:51:12 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 12:51:12 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:51:12 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:12 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:51:12 Send local reply
>CLVMD[41e02960]: Mar 15 12:51:12 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:51:12 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 12:51:12 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:51:12 doing PRE command LOCK_VG 'V_helter_skelter' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:51:12 sync_lock: 'V_helter_skelter' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 12:51:12 sync_lock: returning lkid 1032d
>CLVMD[41e02960]: Mar 15 12:51:12 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:51:12 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:12 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:51:12 distribute command: XID = 6
>CLVMD[9566b800]: Mar 15 12:51:12 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x56b780, len=37, csid=(nil), xid=6
>CLVMD[41401960]: Mar 15 12:51:12 process_work_item: local
>CLVMD[41401960]: Mar 15 12:51:12 process_local_command: msg=0x584ad0, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 12:51:12 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:51:12 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:51:12 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:51:12 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 12:51:12 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:51:12 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:12 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:51:12 Send local reply
>CLVMD[41e02960]: Mar 15 12:51:12 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:51:12 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 12:51:12 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:51:12 doing PRE command LOCK_VG 'V_helter_skelter' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:51:12 sync_unlock: 'V_helter_skelter' lkid:1032d
>CLVMD[41e02960]: Mar 15 12:51:12 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:51:12 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:51:12 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:12 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:51:12 distribute command: XID = 7
>CLVMD[9566b800]: Mar 15 12:51:12 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x56b780, len=37, csid=(nil), xid=7
>CLVMD[41401960]: Mar 15 12:51:12 process_work_item: local
>CLVMD[41401960]: Mar 15 12:51:12 process_local_command: msg=0x584ad0, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 12:51:12 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:51:12 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:51:12 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:51:12 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:51:12 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:51:12 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:51:12 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:51:12 Send local reply
>CLVMD[9566b800]: Mar 15 12:51:12 Read on local socket 8, len = 0
>CLVMD[9566b800]: Mar 15 12:51:12 EOF on local socket: inprogress=0
>CLVMD[9566b800]: Mar 15 12:51:12 Waiting for child thread
>CLVMD[41e02960]: Mar 15 12:51:12 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:51:12 Subthread finished
>CLVMD[9566b800]: Mar 15 12:51:12 Joined child thread
>CLVMD[9566b800]: Mar 15 12:51:12 ret == 0, errno = 9. removing client
>CLVMD[9566b800]: Mar 15 12:51:12 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=(nil), len=0, csid=(nil), xid=7
>CLVMD[41401960]: Mar 15 12:51:12 process_work_item: free fd 8
>CLVMD[41401960]: Mar 15 12:51:12 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:52:38 Got new connection on fd 8
>CLVMD[9566b800]: Mar 15 12:52:38 Read on local socket 8, len = 37
>CLVMD[9566b800]: Mar 15 12:52:38 creating pipe, [9, 10]
>CLVMD[9566b800]: Mar 15 12:52:38 Creating pre&post thread
>CLVMD[9566b800]: Mar 15 12:52:38 Created pre&post thread, state = 0
>CLVMD[41e02960]: Mar 15 12:52:38 in sub thread: client = 0x5849c0
>CLVMD[41e02960]: Mar 15 12:52:38 Sub thread ready for work.
>CLVMD[41e02960]: Mar 15 12:52:38 doing PRE command LOCK_VG 'V_helter_skelter' at 4 (client=0x5849c0)
>CLVMD[41e02960]: Mar 15 12:52:38 sync_lock: 'V_helter_skelter' mode:4 flags=0
>CLVMD[41e02960]: Mar 15 12:52:38 sync_lock: returning lkid 102fb
>CLVMD[41e02960]: Mar 15 12:52:38 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:52:38 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:38 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:38 distribute command: XID = 8
>CLVMD[9566b800]: Mar 15 12:52:38 add_to_lvmqueue: cmd=0x584280. client=0x5849c0, msg=0x56b780, len=37, csid=(nil), xid=8
>CLVMD[41401960]: Mar 15 12:52:38 process_work_item: local
>CLVMD[41401960]: Mar 15 12:52:38 process_local_command: msg=0x584ad0, msglen =37, client=0x5849c0
>CLVMD[41401960]: Mar 15 12:52:38 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:52:38 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:52:38 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:52:38 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 12:52:38 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:52:38 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:38 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:38 Send local reply
>CLVMD[41e02960]: Mar 15 12:52:38 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:52:38 Read on local socket 8, len = 85
>CLVMD[9566b800]: Mar 15 12:52:38 check_all_clvmds_running
>CLVMD[41e02960]: Mar 15 12:52:38 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:52:38 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:52:38 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:52:38 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:38 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:38 distribute command: XID = 9
>CLVMD[9566b800]: Mar 15 12:52:38 add_to_lvmqueue: cmd=0x584280. client=0x5849c0, msg=0x584310, len=85, csid=(nil), xid=9
>CLVMD[9566b800]: Mar 15 12:52:38 Sending message to all cluster nodes
>CLVMD[41401960]: Mar 15 12:52:38 process_work_item: local
>CLVMD[41401960]: Mar 15 12:52:38 process_local_command: msg=0x584b00, msglen =85, client=0x5849c0
>CLVMD[41401960]: Mar 15 12:52:38 do_lock_lv: resource 'Bv2WcH05F4KQfNWCOEfUwHj3eFsT1Qk7af3XDaulx4K74iAVcjc9QxZTTKbs5wES', cmd = 0x19, flags = 84
>CLVMD[41401960]: Mar 15 12:52:38 sync_lock: 'Bv2WcH05F4KQfNWCOEfUwHj3eFsT1Qk7af3XDaulx4K74iAVcjc9QxZTTKbs5wES' mode:1 flags=1
>CLVMD[41401960]: Mar 15 12:52:38 sync_lock: returning lkid 10102
>CLVMD[9566b800]: Mar 15 12:52:38 Reply from node link-02: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:38 Got 1 replies, expecting: 4
>CLVMD[41401960]: Mar 15 12:52:38 Command return is 0
>CLVMD[41401960]: Mar 15 12:52:38 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:52:38 Got 2 replies, expecting: 4
>CLVMD[41401960]: Mar 15 12:52:38 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:52:38 Reply from node link-08: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:38 Got 3 replies, expecting: 4
>CLVMD[9566b800]: Mar 15 12:52:39 Reply from node link-04: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:39 Got 4 replies, expecting: 4
>CLVMD[41e02960]: Mar 15 12:52:39 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:52:39 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:52:39 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:39 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:39 Send local reply
>CLVMD[9566b800]: Mar 15 12:52:39 Read on local socket 8, len = 85
>CLVMD[9566b800]: Mar 15 12:52:39 check_all_clvmds_running
>CLVMD[41e02960]: Mar 15 12:52:39 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:52:39 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:52:39 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:52:39 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:39 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:39 distribute command: XID = 10
>CLVMD[9566b800]: Mar 15 12:52:39 add_to_lvmqueue: cmd=0x584280. client=0x5849c0, msg=0x584310, len=85, csid=(nil), xid=10
>CLVMD[9566b800]: Mar 15 12:52:39 Sending message to all cluster nodes
>CLVMD[41401960]: Mar 15 12:52:39 process_work_item: local
>CLVMD[41401960]: Mar 15 12:52:39 process_local_command: msg=0x58f9f0, msglen =85, client=0x5849c0
>CLVMD[41401960]: Mar 15 12:52:39 do_lock_lv: resource 'Bv2WcH05F4KQfNWCOEfUwHj3eFsT1Qk7af3XDaulx4K74iAVcjc9QxZTTKbs5wES', cmd = 0x18, flags = 84
>CLVMD[9566b800]: Mar 15 12:52:39 Reply from node link-08: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:39 Got 1 replies, expecting: 4
>CLVMD[41401960]: Mar 15 12:52:39 sync_unlock: 'Bv2WcH05F4KQfNWCOEfUwHj3eFsT1Qk7af3XDaulx4K74iAVcjc9QxZTTKbs5wES' lkid:10102
>CLVMD[41401960]: Mar 15 12:52:39 Command return is 0
>CLVMD[41401960]: Mar 15 12:52:39 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:52:39 Got 2 replies, expecting: 4
>CLVMD[41401960]: Mar 15 12:52:39 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:52:39 Reply from node link-02: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:39 Got 3 replies, expecting: 4
>CLVMD[9566b800]: Mar 15 12:52:39 Reply from node link-04: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:39 Got 4 replies, expecting: 4
>CLVMD[41e02960]: Mar 15 12:52:39 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:52:39 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:52:39 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:39 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:39 Send local reply
>CLVMD[9566b800]: Mar 15 12:52:39 Read on local socket 8, len = 85
>CLVMD[9566b800]: Mar 15 12:52:39 check_all_clvmds_running
>CLVMD[41e02960]: Mar 15 12:52:39 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:52:39 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:52:39 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:52:39 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:39 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:39 distribute command: XID = 11
>CLVMD[9566b800]: Mar 15 12:52:39 add_to_lvmqueue: cmd=0x584280. client=0x5849c0, msg=0x584310, len=85, csid=(nil), xid=11
>CLVMD[9566b800]: Mar 15 12:52:39 Sending message to all cluster nodes
>CLVMD[41401960]: Mar 15 12:52:39 process_work_item: local
>CLVMD[41401960]: Mar 15 12:52:39 process_local_command: msg=0x58f980, msglen =85, client=0x5849c0
>CLVMD[41401960]: Mar 15 12:52:39 do_lock_lv: resource 'Bv2WcH05F4KQfNWCOEfUwHj3eFsT1Qk7af3XDaulx4K74iAVcjc9QxZTTKbs5wES', cmd = 0x1e, flags = 84
>CLVMD[41401960]: Mar 15 12:52:39 do_resume_lv, lock not already held
>CLVMD[41401960]: Mar 15 12:52:39 Command return is 0
>CLVMD[41401960]: Mar 15 12:52:39 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:52:39 Got 1 replies, expecting: 4
>CLVMD[41401960]: Mar 15 12:52:39 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:52:39 Reply from node link-04: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:39 Got 2 replies, expecting: 4
>CLVMD[9566b800]: Mar 15 12:52:39 Reply from node link-08: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:39 Got 3 replies, expecting: 4
>CLVMD[9566b800]: Mar 15 12:52:39 Reply from node link-02: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:39 Got 4 replies, expecting: 4
>CLVMD[41e02960]: Mar 15 12:52:39 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:52:39 post_lock_lv: resource 'Bv2WcH05F4KQfNWCOEfUwHj3eFsT1Qk7af3XDaulx4K74iAVcjc9QxZTTKbs5wES', cmd = 0x1e, flags = 132
>CLVMD[41e02960]: Mar 15 12:52:39 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:52:39 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:39 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:39 Send local reply
>CLVMD[9566b800]: Mar 15 12:52:39 Read on local socket 8, len = 85
>CLVMD[9566b800]: Mar 15 12:52:39 check_all_clvmds_running
>CLVMD[41e02960]: Mar 15 12:52:39 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:52:39 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:52:39 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:52:39 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:39 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:39 distribute command: XID = 12
>CLVMD[9566b800]: Mar 15 12:52:39 add_to_lvmqueue: cmd=0x584280. client=0x5849c0, msg=0x584310, len=85, csid=(nil), xid=12
>CLVMD[9566b800]: Mar 15 12:52:39 Sending message to all cluster nodes
>CLVMD[41401960]: Mar 15 12:52:39 process_work_item: local
>CLVMD[41401960]: Mar 15 12:52:39 process_local_command: msg=0x58f980, msglen =85, client=0x5849c0
>CLVMD[41401960]: Mar 15 12:52:39 do_lock_lv: resource 'Bv2WcH05F4KQfNWCOEfUwHj3eFsT1Qk7wpUB0hmF0iInwVe31KJg4l2lpNSKo2g1', cmd = 0x19, flags = 84
>CLVMD[41401960]: Mar 15 12:52:39 sync_lock: 'Bv2WcH05F4KQfNWCOEfUwHj3eFsT1Qk7wpUB0hmF0iInwVe31KJg4l2lpNSKo2g1' mode:1 flags=1
>CLVMD[41401960]: Mar 15 12:52:39 sync_lock: returning lkid 1000b
>CLVMD[9566b800]: Mar 15 12:52:40 Reply from node link-08: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:40 Got 1 replies, expecting: 4
>CLVMD[9566b800]: Mar 15 12:52:45 Reply from node link-02: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:45 Got 2 replies, expecting: 4
>CLVMD[9566b800]: Mar 15 12:52:51 Reply from node link-04: 0 bytes
>CLVMD[9566b800]: Mar 15 12:52:51 Got 3 replies, expecting: 4
>CLVMD[41401960]: Mar 15 12:52:57 Command return is 0
>CLVMD[41401960]: Mar 15 12:52:57 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:52:57 Got 4 replies, expecting: 4
>CLVMD[41401960]: Mar 15 12:52:57 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:52:57 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:52:57 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:52:57 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:57 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:57 Send local reply
>CLVMD[9566b800]: Mar 15 12:52:57 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 12:52:57 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:52:57 doing PRE command LOCK_VG 'V_helter_skelter' at 6 (client=0x5849c0)
>CLVMD[41e02960]: Mar 15 12:52:57 sync_unlock: 'V_helter_skelter' lkid:102fb
>CLVMD[41e02960]: Mar 15 12:52:57 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:52:57 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:52:57 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:57 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:57 distribute command: XID = 13
>CLVMD[9566b800]: Mar 15 12:52:57 add_to_lvmqueue: cmd=0x584280. client=0x5849c0, msg=0x58f830, len=37, csid=(nil), xid=13
>CLVMD[41401960]: Mar 15 12:52:57 process_work_item: local
>CLVMD[41401960]: Mar 15 12:52:57 process_local_command: msg=0x58fb40, msglen =37, client=0x5849c0
>CLVMD[41401960]: Mar 15 12:52:57 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:52:57 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:52:57 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:52:57 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:52:57 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:52:57 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:52:57 background routine status was 0, sock_client=0x5849c0
>CLVMD[9566b800]: Mar 15 12:52:57 Send local reply
>CLVMD[9566b800]: Mar 15 12:52:57 Read on local socket 8, len = 0
>CLVMD[9566b800]: Mar 15 12:52:57 EOF on local socket: inprogress=0
>CLVMD[9566b800]: Mar 15 12:52:57 Waiting for child thread
>CLVMD[41e02960]: Mar 15 12:52:57 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:52:57 Subthread finished
>CLVMD[9566b800]: Mar 15 12:52:57 Joined child thread
>CLVMD[9566b800]: Mar 15 12:52:57 ret == 0, errno = 9. removing client
>CLVMD[9566b800]: Mar 15 12:52:57 add_to_lvmqueue: cmd=0x584280. client=0x5849c0, msg=(nil), len=0, csid=(nil), xid=13
>CLVMD[41401960]: Mar 15 12:52:57 process_work_item: free fd 8
>CLVMD[41401960]: Mar 15 12:52:57 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:53:04 Got new connection on fd 8
>CLVMD[9566b800]: Mar 15 12:53:04 Read on local socket 8, len = 33
>CLVMD[9566b800]: Mar 15 12:53:04 creating pipe, [9, 10]
>CLVMD[9566b800]: Mar 15 12:53:04 Creating pre&post thread
>CLVMD[9566b800]: Mar 15 12:53:04 Created pre&post thread, state = 0
>CLVMD[41e02960]: Mar 15 12:53:04 in sub thread: client = 0x584150
>CLVMD[41e02960]: Mar 15 12:53:04 Sub thread ready for work.
>CLVMD[41e02960]: Mar 15 12:53:04 doing PRE command LOCK_VG 'V_VolGroup00' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:53:04 sync_lock: 'V_VolGroup00' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 12:53:04 sync_lock: returning lkid 101a9
>CLVMD[41e02960]: Mar 15 12:53:04 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:53:04 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:53:04 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:04 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:04 distribute command: XID = 14
>CLVMD[9566b800]: Mar 15 12:53:04 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x58f830, len=33, csid=(nil), xid=14
>CLVMD[41401960]: Mar 15 12:53:04 process_work_item: local
>CLVMD[41401960]: Mar 15 12:53:04 process_local_command: msg=0x58fa90, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 12:53:04 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:53:04 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:53:04 CLVMD[41e02960]: Mar 15 12:53:04 Got post command condition...
>LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:53:04 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:04 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:04 Send local reply
>CLVMD[41e02960]: Mar 15 12:53:04 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:53:04 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 12:53:04 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:53:04 doing PRE command LOCK_VG 'V_VolGroup00' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:53:04 sync_unlock: 'V_VolGroup00' lkid:101a9
>CLVMD[41e02960]: Mar 15 12:53:04 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:53:04 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:53:04 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:04 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:04 distribute command: XID = 15
>CLVMD[9566b800]: Mar 15 12:53:04 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x58f830, len=33, csid=(nil), xid=15
>CLVMD[41401960]: Mar 15 12:53:04 process_work_item: local
>CLVMD[41401960]: Mar 15 12:53:04 process_local_command: msg=0x58fb40, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 12:53:04 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:53:04 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:53:04 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:53:04 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:53:04 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:53:04 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:04 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:04 Send local reply
>CLVMD[9566b800]: Mar 15 12:53:04 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 12:53:04 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:53:04 doing PRE command LOCK_VG 'V_helter_skelter' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:53:04 sync_lock: 'V_helter_skelter' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 12:53:04 sync_lock: returning lkid 10386
>CLVMD[41e02960]: Mar 15 12:53:04 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:53:04 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:53:04 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:04 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:04 distribute command: XID = 16
>CLVMD[9566b800]: Mar 15 12:53:04 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x58f830, len=37, csid=(nil), xid=16
>CLVMD[41401960]: Mar 15 12:53:04 process_work_item: local
>CLVMD[41401960]: Mar 15 12:53:04 process_local_command: msg=0x58fb40, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 12:53:04 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:53:04 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:53:04 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:53:04 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:53:04 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:53:04 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:04 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:04 Send local reply
>CLVMD[9566b800]: Mar 15 12:53:04 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 12:53:04 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:53:04 doing PRE command LOCK_VG 'V_helter_skelter' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:53:04 sync_unlock: 'V_helter_skelter' lkid:10386
>CLVMD[41e02960]: Mar 15 12:53:04 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:53:04 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:04 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:04 distribute command: XID = 17
>CLVMD[9566b800]: Mar 15 12:53:04 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x58f830, len=37, csid=(nil), xid=17
>CLVMD[41e02960]: Mar 15 12:53:04 Waiting to do post command - state = 0
>CLVMD[41401960]: Mar 15 12:53:04 process_work_item: local
>CLVMD[41401960]: Mar 15 12:53:04 process_local_command: msg=0x58fb40, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 12:53:04 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:53:04 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:53:04 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:53:04 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:53:04 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:04 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:04 Send local reply
>CLVMD[41e02960]: Mar 15 12:53:04 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:53:04 Read on local socket 8, len = 0
>CLVMD[9566b800]: Mar 15 12:53:04 EOF on local socket: inprogress=0
>CLVMD[9566b800]: Mar 15 12:53:04 Waiting for child thread
>CLVMD[41e02960]: Mar 15 12:53:04 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:53:04 Subthread finished
>CLVMD[9566b800]: Mar 15 12:53:04 Joined child thread
>CLVMD[9566b800]: Mar 15 12:53:04 ret == 0, errno = 9. removing client
>CLVMD[9566b800]: Mar 15 12:53:04 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=(nil), len=0, csid=(nil), xid=17
>CLVMD[41401960]: Mar 15 12:53:04 process_work_item: free fd 8
>CLVMD[41401960]: Mar 15 12:53:04 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:53:11 Got new connection on fd 8
>CLVMD[9566b800]: Mar 15 12:53:12 Read on local socket 8, len = 0
>CLVMD[9566b800]: Mar 15 12:53:12 EOF on local socket: inprogress=0
>CLVMD[9566b800]: Mar 15 12:53:12 ret == 0, errno = 9. removing client
>CLVMD[9566b800]: Mar 15 12:53:12 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=(nil), len=0, csid=(nil), xid=0
>CLVMD[41401960]: Mar 15 12:53:12 process_work_item: free fd 8
>CLVMD[41401960]: Mar 15 12:53:12 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:53:22 Got new connection on fd 8
>CLVMD[9566b800]: Mar 15 12:53:22 Read on local socket 8, len = 33
>CLVMD[9566b800]: Mar 15 12:53:22 creating pipe, [9, 10]
>CLVMD[9566b800]: Mar 15 12:53:22 Creating pre&post thread
>CLVMD[9566b800]: Mar 15 12:53:22 Created pre&post thread, state = 0
>CLVMD[41e02960]: Mar 15 12:53:22 in sub thread: client = 0x584150
>CLVMD[41e02960]: Mar 15 12:53:22 Sub thread ready for work.
>CLVMD[41e02960]: Mar 15 12:53:22 doing PRE command LOCK_VG 'V_VolGroup00' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:53:22 sync_lock: 'V_VolGroup00' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 12:53:22 sync_lock: returning lkid 101d8
>CLVMD[41e02960]: Mar 15 12:53:22 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:53:22 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:53:22 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:22 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:22 distribute command: XID = 18
>CLVMD[9566b800]: Mar 15 12:53:22 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x58f830, len=33, csid=(nil), xid=18
>CLVMD[41401960]: Mar 15 12:53:22 process_work_item: local
>CLVMD[41401960]: Mar 15 12:53:22 process_local_command: msg=0x58fa90, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 12:53:22 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:53:22 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:53:22 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:53:22 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:53:22 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:53:22 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:22 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:22 Send local reply
>CLVMD[9566b800]: Mar 15 12:53:22 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 12:53:22 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:53:22 doing PRE command LOCK_VG 'V_VolGroup00' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:53:22 sync_unlock: 'V_VolGroup00' lkid:101d8
>CLVMD[41e02960]: Mar 15 12:53:22 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:53:22 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:53:22 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:22 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:22 distribute command: XID = 19
>CLVMD[9566b800]: Mar 15 12:53:22 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x58f830, len=33, csid=(nil), xid=19
>CLVMD[41401960]: Mar 15 12:53:22 process_work_item: local
>CLVMD[41401960]: Mar 15 12:53:22 process_local_command: msg=0x58fb40, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 12:53:22 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:53:22 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:53:22 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:53:22 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:53:22 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:53:22 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:22 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:22 Send local reply
>CLVMD[9566b800]: Mar 15 12:53:22 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 12:53:22 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:53:22 doing PRE command LOCK_VG 'V_helter_skelter' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:53:22 sync_lock: 'V_helter_skelter' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 12:53:22 sync_lock: returning lkid 10332
>CLVMD[41e02960]: Mar 15 12:53:22 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 12:53:22 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 12:53:22 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:22 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:22 distribute command: XID = 20
>CLVMD[9566b800]: Mar 15 12:53:22 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x58f830, len=37, csid=(nil), xid=20
>CLVMD[41401960]: Mar 15 12:53:22 process_work_item: local
>CLVMD[41401960]: Mar 15 12:53:22 process_local_command: msg=0x58fb40, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 12:53:22 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:53:22 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:53:22 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:53:22 Got post command condition...
>CLVMD[41e02960]: Mar 15 12:53:22 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:53:22 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:22 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:22 Send local reply
>CLVMD[9566b800]: Mar 15 12:53:22 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 12:53:22 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:53:22 doing PRE command LOCK_VG 'V_helter_skelter' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:53:22 sync_unlock: 'V_helter_skelter' lkid:10332
>CLVMD[41e02960]: Mar 15 12:53:22 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:53:22 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:22 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:22 distribute command: XID = 21
>CLVMD[9566b800]: Mar 15 12:53:22 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=0x58f830, len=37, csid=(nil), xid=21
>CLVMD[41401960]: Mar 15 12:53:22 process_work_item: local
>CLVMD[41e02960]: Mar 15 12:53:22 Waiting to do post command - state = 0
>CLVMD[41401960]: Mar 15 12:53:22 process_local_command: msg=0x58fb40, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 12:53:22 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:53:22 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:53:22 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:53:22 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:53:22 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:53:22 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:53:22 Send local reply
>CLVMD[41e02960]: Mar 15 12:53:22 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 12:53:22 Read on local socket 8, len = 0
>CLVMD[9566b800]: Mar 15 12:53:22 EOF on local socket: inprogress=0
>CLVMD[9566b800]: Mar 15 12:53:22 Waiting for child thread
>CLVMD[41e02960]: Mar 15 12:53:22 Got pre command condition...
>CLVMD[41e02960]: Mar 15 12:53:22 Subthread finished
>CLVMD[9566b800]: Mar 15 12:53:22 Joined child thread
>CLVMD[9566b800]: Mar 15 12:53:22 ret == 0, errno = 9. removing client
>CLVMD[9566b800]: Mar 15 12:53:22 add_to_lvmqueue: cmd=0x584280. client=0x584150, msg=(nil), len=0, csid=(nil), xid=21
>CLVMD[41401960]: Mar 15 12:53:22 process_work_item: free fd 8
>CLVMD[41401960]: Mar 15 12:53:22 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 12:55:20 Got state change message, re-reading members list
>CLVMD[9566b800]: Mar 15 12:58:12 Got new connection on fd 8
>CLVMD[9566b800]: Mar 15 12:58:13 Read on local socket 8, len = 37
>CLVMD[9566b800]: Mar 15 12:58:13 creating pipe, [9, 10]
>CLVMD[9566b800]: Mar 15 12:58:13 Creating pre&post thread
>CLVMD[9566b800]: Mar 15 12:58:13 Created pre&post thread, state = 0
>CLVMD[41e02960]: Mar 15 12:58:13 in sub thread: client = 0x584150
>CLVMD[41e02960]: Mar 15 12:58:13 Sub thread ready for work.
>CLVMD[41e02960]: Mar 15 12:58:13 doing PRE command LOCK_VG 'V_helter_skelter' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 12:58:13 sync_lock: 'V_helter_skelter' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 12:58:13 sync_lock: returning lkid 10392
>CLVMD[41e02960]: Mar 15 12:58:13 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 12:58:13 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:58:13 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:58:13 distribute command: XID = 22
>CLVMD[9566b800]: Mar 15 12:58:13 add_to_lvmqueue: cmd=0x5844b0. client=0x584150, msg=0x58f830, len=37, csid=(nil), xid=22
>CLVMD[41e02960]: Mar 15 12:58:13 Waiting to do post command - state = 0
>CLVMD[41401960]: Mar 15 12:58:13 process_work_item: local
>CLVMD[41401960]: Mar 15 12:58:13 process_local_command: msg=0x58fa90, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 12:58:13 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 12:58:13 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 12:58:13 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 12:58:13 Got post command condition...
>CLVMD[9566b800]: Mar 15 12:58:13 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 12:58:13 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 12:58:13 Send local reply
>CLVMD[41e02960]: Mar 15 12:58:13 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:03:44 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 13:03:44 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:03:44 doing PRE command LOCK_VG 'V_helter_skelter' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 13:03:44 sync_unlock: 'V_helter_skelter' lkid:10392
>CLVMD[41e02960]: Mar 15 13:03:44 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 13:03:44 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:03:44 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:03:44 distribute command: XID = 23
>CLVMD[9566b800]: Mar 15 13:03:44 add_to_lvmqueue: cmd=0x58fb40. client=0x584150, msg=0x58f830, len=37, csid=(nil), xid=23
>CLVMD[41401960]: Mar 15 13:03:44 process_work_item: local
>CLVMD[41401960]: Mar 15 13:03:44 process_local_command: msg=0x58fa90, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 13:03:44 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:03:44 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:03:44 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:03:44 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 13:03:44 Got post command condition...
>CLVMD[9566b800]: Mar 15 13:03:44 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:03:44 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:03:44 Send local reply
>CLVMD[41e02960]: Mar 15 13:03:44 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:03:44 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 13:03:44 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:03:44 doing PRE command LOCK_VG 'V_VolGroup00' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 13:03:44 sync_lock: 'V_VolGroup00' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 13:03:44 sync_lock: returning lkid 10022
>CLVMD[41e02960]: Mar 15 13:03:44 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 13:03:44 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 13:03:44 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:03:44 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:03:44 distribute command: XID = 24
>CLVMD[9566b800]: Mar 15 13:03:44 add_to_lvmqueue: cmd=0x58fb40. client=0x584150, msg=0x58f830, len=33, csid=(nil), xid=24
>CLVMD[41401960]: Mar 15 13:03:44 process_work_item: local
>CLVMD[41401960]: Mar 15 13:03:44 process_local_command: msg=0x5844b0, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 13:03:44 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:03:44 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:03:44 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:03:44 Got post command condition...
>CLVMD[41e02960]: Mar 15 13:03:44 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:03:44 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:03:44 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:03:44 Send local reply
>CLVMD[9566b800]: Mar 15 13:03:44 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 13:03:44 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:03:44 doing PRE command LOCK_VG 'V_VolGroup00' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 13:03:44 sync_unlock: 'V_VolGroup00' lkid:10022
>CLVMD[41e02960]: Mar 15 13:03:44 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 13:03:44 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 13:03:44 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:03:44 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:03:44 distribute command: XID = 25
>CLVMD[9566b800]: Mar 15 13:03:44 add_to_lvmqueue: cmd=0x58fb40. client=0x584150, msg=0x58f830, len=33, csid=(nil), xid=25
>CLVMD[41401960]: Mar 15 13:03:44 process_work_item: local
>CLVMD[41401960]: Mar 15 13:03:44 process_local_command: msg=0x58fa90, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 13:03:44 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:03:44 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:03:44 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:03:44 Got post command condition...
>CLVMD[41e02960]: Mar 15 13:03:44 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:03:44 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:03:44 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:03:44 Send local reply
>CLVMD[9566b800]: Mar 15 13:03:44 Read on local socket 8, len = 0
>CLVMD[9566b800]: Mar 15 13:03:44 EOF on local socket: inprogress=0
>CLVMD[9566b800]: Mar 15 13:03:44 Waiting for child thread
>CLVMD[41e02960]: Mar 15 13:03:44 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:03:44 Subthread finished
>CLVMD[9566b800]: Mar 15 13:03:44 Joined child thread
>CLVMD[9566b800]: Mar 15 13:03:44 ret == 0, errno = 9. removing client
>CLVMD[9566b800]: Mar 15 13:03:44 add_to_lvmqueue: cmd=0x58fb40. client=0x584150, msg=(nil), len=0, csid=(nil), xid=25
>CLVMD[41401960]: Mar 15 13:03:44 process_work_item: free fd 8
>CLVMD[41401960]: Mar 15 13:03:44 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 13:08:16 Got new connection on fd 8
>CLVMD[9566b800]: Mar 15 13:08:16 Read on local socket 8, len = 37
>CLVMD[9566b800]: Mar 15 13:08:16 creating pipe, [9, 10]
>CLVMD[9566b800]: Mar 15 13:08:16 Creating pre&post thread
>CLVMD[9566b800]: Mar 15 13:08:16 Created pre&post thread, state = 0
>CLVMD[41e02960]: Mar 15 13:08:16 in sub thread: client = 0x58f980
>CLVMD[41e02960]: Mar 15 13:08:16 Sub thread ready for work.
>CLVMD[41e02960]: Mar 15 13:08:16 doing PRE command LOCK_VG 'V_helter_skelter' at 1 (client=0x58f980)
>CLVMD[41e02960]: Mar 15 13:08:16 sync_lock: 'V_helter_skelter' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 13:08:16 sync_lock: returning lkid 10265
>CLVMD[41e02960]: Mar 15 13:08:16 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 13:08:16 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:08:16 background routine status was 0, sock_client=0x58f980
>CLVMD[9566b800]: Mar 15 13:08:16 distribute command: XID = 26
>CLVMD[9566b800]: Mar 15 13:08:16 add_to_lvmqueue: cmd=0x58fb40. client=0x58f980, msg=0x58f830, len=37, csid=(nil), xid=26
>CLVMD[41401960]: Mar 15 13:08:16 process_work_item: local
>CLVMD[41401960]: Mar 15 13:08:16 process_local_command: msg=0x58fa90, msglen =37, client=0x58f980
>CLVMD[41401960]: Mar 15 13:08:16 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:08:16 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:08:16 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:08:16 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 13:08:16 Got post command condition...
>CLVMD[9566b800]: Mar 15 13:08:16 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:08:16 background routine status was 0, sock_client=0x58f980
>CLVMD[9566b800]: Mar 15 13:08:16 Send local reply
>CLVMD[41e02960]: Mar 15 13:08:16 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:08:17 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 13:08:17 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:08:17 doing PRE command LOCK_VG 'V_helter_skelter' at 6 (client=0x58f980)
>CLVMD[41e02960]: Mar 15 13:08:17 sync_unlock: 'V_helter_skelter' lkid:10265
>CLVMD[41e02960]: Mar 15 13:08:17 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 13:08:17 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:08:17 background routine status was 0, sock_client=0x58f980
>CLVMD[9566b800]: Mar 15 13:08:17 distribute command: XID = 27
>CLVMD[9566b800]: Mar 15 13:08:17 add_to_lvmqueue: cmd=0x58fb40. client=0x58f980, msg=0x58f830, len=37, csid=(nil), xid=27
>CLVMD[41401960]: Mar 15 13:08:17 process_work_item: local
>CLVMD[41401960]: Mar 15 13:08:17 process_local_command: msg=0x58fa90, msglen =37, client=0x58f980
>CLVMD[41401960]: Mar 15 13:08:17 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:08:17 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:08:17 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:08:17 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 13:08:17 Got post command condition...
>CLVMD[9566b800]: Mar 15 13:08:17 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:08:17 background routine status was 0, sock_client=0x58f980
>CLVMD[9566b800]: Mar 15 13:08:17 Send local reply
>CLVMD[41e02960]: Mar 15 13:08:17 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:08:17 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 13:08:17 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:08:17 doing PRE command LOCK_VG 'V_VolGroup00' at 1 (client=0x58f980)
>CLVMD[41e02960]: Mar 15 13:08:17 sync_lock: 'V_VolGroup00' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 13:08:17 sync_lock: returning lkid 1019a
>CLVMD[41e02960]: Mar 15 13:08:17 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 13:08:17 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 13:08:17 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:08:17 background routine status was 0, sock_client=0x58f980
>CLVMD[9566b800]: Mar 15 13:08:17 distribute command: XID = 28
>CLVMD[9566b800]: Mar 15 13:08:17 add_to_lvmqueue: cmd=0x58fb40. client=0x58f980, msg=0x58f830, len=33, csid=(nil), xid=28
>CLVMD[41401960]: Mar 15 13:08:17 process_work_item: local
>CLVMD[41401960]: Mar 15 13:08:17 process_local_command: msg=0x58fc80, msglen =33, client=0x58f980
>CLVMD[41401960]: Mar 15 13:08:17 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:08:17 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:08:17 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:08:17 Got post command condition...
>CLVMD[41e02960]: Mar 15 13:08:17 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:08:17 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:08:17 background routine status was 0, sock_client=0x58f980
>CLVMD[9566b800]: Mar 15 13:08:17 Send local reply
>CLVMD[9566b800]: Mar 15 13:08:17 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 13:08:17 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:08:17 doing PRE command LOCK_VG 'V_VolGroup00' at 6 (client=0x58f980)
>CLVMD[41e02960]: Mar 15 13:08:17 sync_unlock: 'V_VolGroup00' lkid:1019a
>CLVMD[41e02960]: Mar 15 13:08:17 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 13:08:17 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 13:08:17 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:08:17 background routine status was 0, sock_client=0x58f980
>CLVMD[9566b800]: Mar 15 13:08:17 distribute command: XID = 29
>CLVMD[9566b800]: Mar 15 13:08:17 add_to_lvmqueue: cmd=0x58fb40. client=0x58f980, msg=0x58f830, len=33, csid=(nil), xid=29
>CLVMD[41401960]: Mar 15 13:08:17 process_work_item: local
>CLVMD[41401960]: Mar 15 13:08:17 process_local_command: msg=0x58fa90, msglen =33, client=0x58f980
>CLVMD[41401960]: Mar 15 13:08:17 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:08:17 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:08:17 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:08:17 Got post command condition...
>CLVMD[41e02960]: Mar 15 13:08:17 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:08:17 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:08:17 background routine status was 0, sock_client=0x58f980
>CLVMD[9566b800]: Mar 15 13:08:17 Send local reply
>CLVMD[9566b800]: Mar 15 13:08:17 Read on local socket 8, len = 0
>CLVMD[9566b800]: Mar 15 13:08:17 EOF on local socket: inprogress=0
>CLVMD[9566b800]: Mar 15 13:08:17 Waiting for child thread
>CLVMD[41e02960]: Mar 15 13:08:17 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:08:17 Subthread finished
>CLVMD[9566b800]: Mar 15 13:08:17 Joined child thread
>CLVMD[9566b800]: Mar 15 13:08:17 ret == 0, errno = 9. removing client
>CLVMD[9566b800]: Mar 15 13:08:17 add_to_lvmqueue: cmd=0x58fb40. client=0x58f980, msg=(nil), len=0, csid=(nil), xid=29
>CLVMD[41401960]: Mar 15 13:08:17 process_work_item: free fd 8
>CLVMD[41401960]: Mar 15 13:08:17 LVM thread waiting for work
>CLVMD[9566b800]: Mar 15 13:17:30 Got new connection on fd 8
>CLVMD[9566b800]: Mar 15 13:17:30 Read on local socket 8, len = 37
>CLVMD[9566b800]: Mar 15 13:17:30 creating pipe, [9, 10]
>CLVMD[9566b800]: Mar 15 13:17:30 Creating pre&post thread
>CLVMD[9566b800]: Mar 15 13:17:30 Created pre&post thread, state = 0
>CLVMD[41e02960]: Mar 15 13:17:30 in sub thread: client = 0x584150
>CLVMD[41e02960]: Mar 15 13:17:30 Sub thread ready for work.
>CLVMD[41e02960]: Mar 15 13:17:30 doing PRE command LOCK_VG 'V_helter_skelter' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 13:17:30 sync_lock: 'V_helter_skelter' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 13:17:30 sync_lock: returning lkid 1009d
>CLVMD[41e02960]: Mar 15 13:17:30 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 13:17:30 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:17:30 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:17:30 distribute command: XID = 30
>CLVMD[9566b800]: Mar 15 13:17:30 add_to_lvmqueue: cmd=0x58fb40. client=0x584150, msg=0x58f830, len=37, csid=(nil), xid=30
>CLVMD[41401960]: Mar 15 13:17:30 process_work_item: local
>CLVMD[41401960]: Mar 15 13:17:30 process_local_command: msg=0x58fa90, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 13:17:30 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:17:30 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:17:30 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:17:30 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 13:17:30 Got post command condition...
>CLVMD[9566b800]: Mar 15 13:17:30 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:17:30 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:17:30 Send local reply
>CLVMD[41e02960]: Mar 15 13:17:30 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:17:31 Read on local socket 8, len = 37
>CLVMD[41e02960]: Mar 15 13:17:31 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:17:31 doing PRE command LOCK_VG 'V_helter_skelter' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 13:17:31 sync_unlock: 'V_helter_skelter' lkid:1009d
>CLVMD[41e02960]: Mar 15 13:17:31 Writing status 0 down pipe 10
>CLVMD[9566b800]: Mar 15 13:17:31 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:17:31 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:17:31 distribute command: XID = 31
>CLVMD[9566b800]: Mar 15 13:17:31 add_to_lvmqueue: cmd=0x58fb40. client=0x584150, msg=0x58f830, len=37, csid=(nil), xid=31
>CLVMD[41401960]: Mar 15 13:17:31 process_work_item: local
>CLVMD[41401960]: Mar 15 13:17:31 process_local_command: msg=0x58fa90, msglen =37, client=0x584150
>CLVMD[41401960]: Mar 15 13:17:31 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:17:31 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:17:31 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:17:31 Waiting to do post command - state = 1
>CLVMD[41e02960]: Mar 15 13:17:31 Got post command condition...
>CLVMD[9566b800]: Mar 15 13:17:31 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:17:31 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:17:31 Send local reply
>CLVMD[41e02960]: Mar 15 13:17:31 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:17:31 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 13:17:31 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:17:31 doing PRE command LOCK_VG 'V_VolGroup00' at 1 (client=0x584150)
>CLVMD[41e02960]: Mar 15 13:17:31 sync_lock: 'V_VolGroup00' mode:3 flags=0
>CLVMD[41e02960]: Mar 15 13:17:31 sync_lock: returning lkid 103ea
>CLVMD[41e02960]: Mar 15 13:17:31 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 13:17:31 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 13:17:31 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:17:31 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:17:31 distribute command: XID = 32
>CLVMD[9566b800]: Mar 15 13:17:31 add_to_lvmqueue: cmd=0x58fb40. client=0x584150, msg=0x58f830, len=33, csid=(nil), xid=32
>CLVMD[41401960]: Mar 15 13:17:31 process_work_item: local
>CLVMD[41401960]: Mar 15 13:17:31 process_local_command: msg=0x5844b0, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 13:17:31 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:17:31 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:17:31 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:17:31 Got post command condition...
>CLVMD[41e02960]: Mar 15 13:17:31 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:17:31 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:17:31 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:17:31 Send local reply
>CLVMD[9566b800]: Mar 15 13:17:31 Read on local socket 8, len = 33
>CLVMD[41e02960]: Mar 15 13:17:31 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:17:31 doing PRE command LOCK_VG 'V_VolGroup00' at 6 (client=0x584150)
>CLVMD[41e02960]: Mar 15 13:17:31 sync_unlock: 'V_VolGroup00' lkid:103ea
>CLVMD[41e02960]: Mar 15 13:17:31 Writing status 0 down pipe 10
>CLVMD[41e02960]: Mar 15 13:17:31 Waiting to do post command - state = 0
>CLVMD[9566b800]: Mar 15 13:17:31 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:17:31 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:17:31 distribute command: XID = 33
>CLVMD[9566b800]: Mar 15 13:17:31 add_to_lvmqueue: cmd=0x58fb40. client=0x584150, msg=0x58f830, len=33, csid=(nil), xid=33
>CLVMD[41401960]: Mar 15 13:17:31 process_work_item: local
>CLVMD[41401960]: Mar 15 13:17:31 process_local_command: msg=0x58fa90, msglen =33, client=0x584150
>CLVMD[41401960]: Mar 15 13:17:31 Reply from node link-07: 0 bytes
>CLVMD[41401960]: Mar 15 13:17:31 Got 1 replies, expecting: 1
>CLVMD[41401960]: Mar 15 13:17:31 LVM thread waiting for work
>CLVMD[41e02960]: Mar 15 13:17:31 Got post command condition...
>CLVMD[41e02960]: Mar 15 13:17:31 Waiting for next pre command
>CLVMD[9566b800]: Mar 15 13:17:31 read on PIPE 9: 4 bytes: status: 0
>CLVMD[9566b800]: Mar 15 13:17:31 background routine status was 0, sock_client=0x584150
>CLVMD[9566b800]: Mar 15 13:17:31 Send local reply
>CLVMD[9566b800]: Mar 15 13:17:31 Read on local socket 8, len = 0
>CLVMD[9566b800]: Mar 15 13:17:31 EOF on local socket: inprogress=0
>CLVMD[9566b800]: Mar 15 13:17:31 Waiting for child thread
>CLVMD[41e02960]: Mar 15 13:17:31 Got pre command condition...
>CLVMD[41e02960]: Mar 15 13:17:31 Subthread finished
>CLVMD[9566b800]: Mar 15 13:17:31 Joined child thread
>CLVMD[9566b800]: Mar 15 13:17:31 ret == 0, errno = 9. removing client
>CLVMD[9566b800]: Mar 15 13:17:31 add_to_lvmqueue: cmd=0x58fb40. client=0x584150, msg=(nil), len=0, csid=(nil), xid=33
>CLVMD[41401960]: Mar 15 13:17:31 process_work_item: free fd 8
>CLVMD[41401960]: Mar 15 13:17:31 LVM thread waiting for work

Actions: View

Attachments on bug 217895: 150149 | 150150 | 150151 | 150152