Attachment 246851 Details for Bug 364081 – this is the clvmd -d output while this cmd runs

this is the clvmd -d output while this cmd runs

clvmd (text/plain), 24.66 KB, created by Corey Marthaler on 2007-11-02 15:45:51 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Corey Marthaler

Created: 2007-11-02 15:45:51 UTC

Size: 24.66 KB

patch

obsolete

>CLVMD[9566c800]: Nov  2 10:53:15 Got new connection on fd 7
>CLVMD[9566c800]: Nov  2 10:53:15 Read on local socket 7, len = 36
>CLVMD[9566c800]: Nov  2 10:53:15 creating pipe, [8, 9]
>CLVMD[9566c800]: Nov  2 10:53:15 Creating pre&post thread
>CLVMD[9566c800]: Nov  2 10:53:15 Created pre&post thread, state = 0
>CLVMD[41e02960]: Nov  2 10:53:15 in sub thread: client = 0x581740
>CLVMD[41e02960]: Nov  2 10:53:15 Sub thread ready for work.
>CLVMD[41e02960]: Nov  2 10:53:15 doing PRE command LOCK_VG 'V_mirror_sanity' at 1 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:15 sync_lock: 'V_mirror_sanity' mode:3 flags=0
>CLVMD[41e02960]: Nov  2 10:53:15 sync_lock: returning lkid 10253
>CLVMD[41e02960]: Nov  2 10:53:15 Writing status 0 down pipe 9
>CLVMD[9566c800]: Nov  2 10:53:15 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:15 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:15 distribute command: XID = 19
>CLVMD[9566c800]: Nov  2 10:53:15 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=19
>CLVMD[41e02960]: Nov  2 10:53:15 Waiting to do post command - state = 0
>CLVMD[41401960]: Nov  2 10:53:15 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:15 process_local_command: msg=0x581970, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:15 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:15 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:15 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:15 Got post command condition...
>CLVMD[41e02960]: Nov  2 10:53:15 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:15 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:15 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:15 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:15 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:15 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:15 doing PRE command LOCK_VG 'V_mirror_sanity' at 1 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:15 sync_lock: 'V_mirror_sanity' mode:3 flags=0
>CLVMD[41e02960]: Nov  2 10:53:15 sync_lock: returning lkid 1024e
>CLVMD[41e02960]: Nov  2 10:53:15 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:15 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:15 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:15 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:15 distribute command: XID = 20
>CLVMD[9566c800]: Nov  2 10:53:15 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=20
>CLVMD[41401960]: Nov  2 10:53:15 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:15 process_local_command: msg=0x581970, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:15 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:15 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:15 CLVMD[41e02960]: Nov  2 10:53:15 Got post command condition...
>LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:15 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:15 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:15 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:15 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:15 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:15 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:15 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:15 sync_unlock: 'V_mirror_sanity' lkid:1024e
>CLVMD[41e02960]: Nov  2 10:53:15 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:15 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:15 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:15 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:15 distribute command: XID = 21
>CLVMD[9566c800]: Nov  2 10:53:15 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=21
>CLVMD[41401960]: Nov  2 10:53:15 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:15 process_local_command: msg=0x581920, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:15 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:15 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:15 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:15 Got post command condition...
>CLVMD[41e02960]: Nov  2 10:53:15 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:15 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:15 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:15 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:15 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:15 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:15 doing PRE command LOCK_VG 'V_mirror_sanity' at 1 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:15 sync_lock: 'V_mirror_sanity' mode:3 flags=0
>CLVMD[41e02960]: Nov  2 10:53:15 sync_lock: returning lkid 10291
>CLVMD[41e02960]: Nov  2 10:53:15 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:15 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:15 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:15 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:15 distribute command: XID = 22
>CLVMD[9566c800]: Nov  2 10:53:15 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=22
>CLVMD[41401960]: Nov  2 10:53:16 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:16 process_local_command: msg=0x581950, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:16 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:16 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:16 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:16 Got post command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:16 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:16 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:16 sync_unlock: 'V_mirror_sanity' lkid:10291
>CLVMD[41e02960]: Nov  2 10:53:16 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 distribute command: XID = 23
>CLVMD[9566c800]: Nov  2 10:53:16 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=23
>CLVMD[41401960]: Nov  2 10:53:16 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:16 process_local_command: msg=0x581920, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:16 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:16 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:16 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:16 Got post command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:16 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:16 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 doing PRE command LOCK_VG 'V_mirror_sanity' at 1 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:16 sync_lock: 'V_mirror_sanity' mode:3 flags=0
>CLVMD[41e02960]: Nov  2 10:53:16 sync_lock: returning lkid 10214
>CLVMD[41e02960]: Nov  2 10:53:16 Writing status 0 down pipe 9
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 distribute command: XID = 24
>CLVMD[9566c800]: Nov  2 10:53:16 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=24
>CLVMD[41401960]: Nov  2 10:53:16 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:16 process_local_command: msg=0x581950, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:16 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:16 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:16 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting to do post command - state = 1
>CLVMD[41e02960]: Nov  2 10:53:16 Got post command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:16 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:16 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:16 sync_unlock: 'V_mirror_sanity' lkid:10214
>CLVMD[41e02960]: Nov  2 10:53:16 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 distribute command: XID = 25
>CLVMD[9566c800]: Nov  2 10:53:16 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=25
>CLVMD[41401960]: Nov  2 10:53:16 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:16 process_local_command: msg=0x581920, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:16 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:16 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:16 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:16 Got post command condition...
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 Send local reply
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:16 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:16 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 doing PRE command LOCK_VG 'V_mirror_sanity' at 1 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:16 sync_lock: 'V_mirror_sanity' mode:3 flags=0
>CLVMD[41e02960]: Nov  2 10:53:16 sync_lock: returning lkid 10170
>CLVMD[41e02960]: Nov  2 10:53:16 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 distribute command: XID = 26
>CLVMD[9566c800]: Nov  2 10:53:16 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=26
>CLVMD[41401960]: Nov  2 10:53:16 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:16 process_local_command: msg=0x581950, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:16 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:16 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:16 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:16 Got post command condition...
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 Send local reply
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:16 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:16 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:16 sync_unlock: 'V_mirror_sanity' lkid:10170
>CLVMD[41e02960]: Nov  2 10:53:16 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 distribute command: XID = 27
>CLVMD[9566c800]: Nov  2 10:53:16 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=27
>CLVMD[41401960]: Nov  2 10:53:16 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:16 process_local_command: msg=0x581920, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:16 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:16 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:16 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:16 Got post command condition...
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 Send local reply
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:16 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:16 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 doing PRE command LOCK_VG 'V_mirror_sanity' at 1 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:16 sync_lock: 'V_mirror_sanity' mode:3 flags=0
>CLVMD[41e02960]: Nov  2 10:53:16 sync_lock: returning lkid 103a9
>CLVMD[41e02960]: Nov  2 10:53:16 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 distribute command: XID = 28
>CLVMD[9566c800]: Nov  2 10:53:16 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=28
>CLVMD[41401960]: Nov  2 10:53:16 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:16 process_local_command: msg=0x581950, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:16 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:16 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:16 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:16 Got post command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:16 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:16 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:16 sync_unlock: 'V_mirror_sanity' lkid:103a9
>CLVMD[41e02960]: Nov  2 10:53:16 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 distribute command: XID = 29
>CLVMD[9566c800]: Nov  2 10:53:16 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=29
>CLVMD[41401960]: Nov  2 10:53:16 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:16 process_local_command: msg=0x581920, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:16 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:16 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:16 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:16 Got post command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:16 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:16 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:16 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:16 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:16 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:16 doing PRE command LOCK_VG 'V_mirror_sanity' at 1 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 sync_lock: 'V_mirror_sanity' mode:3 flags=0
>CLVMD[41e02960]: Nov  2 10:53:17 sync_lock: returning lkid 1037d
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 distribute command: XID = 30
>CLVMD[9566c800]: Nov  2 10:53:17 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=30
>CLVMD[41401960]: Nov  2 10:53:17 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:17 process_local_command: msg=0x581950, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:17 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:17 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:17 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:17 Got post command condition...
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 Send local reply
>CLVMD[41e02960]: Nov  2 10:53:17 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:17 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:17 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 sync_unlock: 'V_mirror_sanity' lkid:1037d
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 distribute command: XID = 31
>CLVMD[9566c800]: Nov  2 10:53:17 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=31
>CLVMD[41401960]: Nov  2 10:53:17 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:17 process_local_command: msg=0x581920, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:17 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:17 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:17 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:17 Got post command condition...
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 Send local reply
>CLVMD[41e02960]: Nov  2 10:53:17 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:17 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:17 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 1 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 sync_lock: 'V_mirror_sanity' mode:3 flags=0
>CLVMD[41e02960]: Nov  2 10:53:17 sync_lock: returning lkid 10032
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 distribute command: XID = 32
>CLVMD[9566c800]: Nov  2 10:53:17 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=32
>CLVMD[41401960]: Nov  2 10:53:17 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:17 process_local_command: msg=0x581950, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:17 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:17 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:17 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:17 Got post command condition...
>CLVMD[41e02960]: Nov  2 10:53:17 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:17 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:17 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 sync_unlock: 'V_mirror_sanity' lkid:10032
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 0 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 Waiting to do post command - state = 0
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 distribute command: XID = 33
>CLVMD[9566c800]: Nov  2 10:53:17 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=0x5818a0, len=36, csid=(nil), xid=33
>CLVMD[41401960]: Nov  2 10:53:17 process_work_item: local
>CLVMD[41401960]: Nov  2 10:53:17 process_local_command: msg=0x581920, msglen =36, client=0x581740
>CLVMD[41401960]: Nov  2 10:53:17 Reply from node link-08: 0 bytes
>CLVMD[41401960]: Nov  2 10:53:17 Got 1 replies, expecting: 1
>CLVMD[41401960]: Nov  2 10:53:17 LVM thread waiting for work
>CLVMD[41e02960]: Nov  2 10:53:17 Got post command condition...
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 0
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 0, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 Send local reply
>CLVMD[41e02960]: Nov  2 10:53:17 Waiting for next pre command
>CLVMD[9566c800]: Nov  2 10:53:17 Read on local socket 7, len = 36
>CLVMD[41e02960]: Nov  2 10:53:17 Got pre command condition...
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 22 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 22 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 22 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 22 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 22 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[41e02960]: Nov  2 10:53:17 Writing status 22 down pipe 9
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 22
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[9566c800]: Nov  2 10:53:17 CLVMD[41e02960]: Nov  2 10:53:17 Writing status 22 down pipe 9
>background routine status was 22, sock_client=0x581740
>CLVMD[41e02960]: Nov  2 10:53:17 doing PRE command LOCK_VG 'V_mirror_sanity' at 6 (client=0x581740)
>CLVMD[9566c800]: Nov  2 10:53:17 Send local reply
>CLVMD[41e02960]: Nov  2 10:53:17 CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 22
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 22, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:17 read on PIPE 8: 4 bytes: status: 22
>CLVMD[9566c800]: Nov  2 10:53:17 background routine status was 22, sock_client=0x581740
>CLVMD[9566c800]: Nov  2 10:53:17 Send local reply
>CLVMD[9566c800]: Nov  2 10:53:17 Read on local socket 7, len = -1
>CLVMD[9566c800]: Nov  2 10:53:17 EOF on local socket: inprogress=0
>CLVMD[9566c800]: Nov  2 10:53:17 Waiting for child thread
>Writing status 22 down pipe 9
>CLVMD[41e02960]: Nov  2 10:53:17 Subthread finished
>CLVMD[9566c800]: Nov  2 10:53:17 Joined child thread
>CLVMD[9566c800]: Nov  2 10:53:17 ret == 0, errno = 104. removing client
>CLVMD[9566c800]: Nov  2 10:53:17 add_to_lvmqueue: cmd=0x5818d0. client=0x581740, msg=(nil), len=0, csid=(nil), xid=33
>CLVMD[41401960]: Nov  2 10:53:17 process_work_item: free fd 7
>CLVMD[41401960]: Nov  2 10:53:17 LVM thread waiting for work
>

Actions: View

Attachments on bug 364081: 246851