Hello:
Are there someone who had met some problems in using GFS with suse
xen creating image ?
Who can help me ???
The debug log on GFSclient :
2009-05-14 11:31:01 D [fuse-bridge.c:461:fuse_lookup] glusterfs-fuse: 131372:
LOOKUP /windows/disk0(93847579)
2009-05-14 11:31:01 D [fuse-bridge.c:368:fuse_entry_cbk] glusterfs-fuse:
131372: LOOKUP() /windows/disk0 => 93847579 (93847579)
2009-05-14 11:31:01 D [inode.c:112:__dentry_unhash] fuse/inode: dentry unhashed
disk0 (93847579)
2009-05-14 11:31:01 D [inode.c:94:__dentry_hash] fuse/inode: dentry hashed
disk0 (93847579)
2009-05-14 11:31:01 D [fuse-bridge.c:1515:fuse_open] glusterfs-fuse: 131373:
OPEN /windows/disk0
2009-05-14 11:31:01 D [fuse-bridge.c:652:fuse_fd_cbk] glusterfs-fuse: 131373:
OPEN() /windows/disk0 => 0x2aaaaaf00a90
2009-05-14 11:31:01 D [fuse-bridge.c:1669:fuse_flush] glusterfs-fuse: 131374:
FLUSH 0x2aaaaaf00a90
2009-05-14 11:31:01 D [fuse-bridge.c:896:fuse_err_cbk] glusterfs-fuse: 131374:
FLUSH() ERR => 0
2009-05-14 11:31:01 D [fuse-bridge.c:1689:fuse_release] glusterfs-fuse: 131375:
RELEASE 0x2aaaaaf00a90
2009-05-14 11:31:01 D [fuse-bridge.c:1669:fuse_flush] glusterfs-fuse: 131376:
FLUSH 0x2aaaaaf009e0
2009-05-14 11:31:01 D [fuse-bridge.c:896:fuse_err_cbk] glusterfs-fuse: 131376:
FLUSH() ERR => 0
2009-05-14 11:31:01 D [fuse-bridge.c:1689:fuse_release] glusterfs-fuse: 131378:
RELEASE 0x2aaaaaf009e0
2009-05-14 11:31:01 D [inode.c:328:__inode_passivate] fuse/inode: passivating
inode(93847579) lru=3/0 active=4 purge=0
2009-05-14 11:31:01 D [fuse-bridge.c:1669:fuse_flush] glusterfs-fuse: 131379:
FLUSH 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [fuse-bridge.c:896:fuse_err_cbk] glusterfs-fuse: 131379:
FLUSH() ERR => 0
2009-05-14 11:31:01 D [fuse-bridge.c:1689:fuse_release] glusterfs-fuse: 131381:
RELEASE 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [inode.c:328:__inode_passivate] fuse/inode: passivating
inode(93847567) lru=4/0 active=3 purge=0
2009-05-14 11:31:01 D [inode.c:309:__inode_activate] fuse/inode: activating
inode(95682582), lru=3/0 active=4 purge=0
2009-05-14 11:31:01 D [fuse-bridge.c:461:fuse_lookup] glusterfs-fuse: 131382:
LOOKUP /.disk-list(95682582)
2009-05-14 11:31:01 D [fuse-bridge.c:368:fuse_entry_cbk] glusterfs-fuse:
131382: LOOKUP() /.disk-list => 95682582 (95682582)
2009-05-14 11:31:01 D [inode.c:112:__dentry_unhash] fuse/inode: dentry unhashed
.disk-list (95682582)
2009-05-14 11:31:01 D [inode.c:94:__dentry_hash] fuse/inode: dentry hashed
.disk-list (95682582)
2009-05-14 11:31:01 D [inode.c:328:__inode_passivate] fuse/inode: passivating
inode(95682582) lru=4/0 active=3 purge=0
2009-05-14 11:31:01 D [inode.c:309:__inode_activate] fuse/inode: activating
inode(95682582), lru=3/0 active=4 purge=0
2009-05-14 11:31:01 D [fuse-bridge.c:1515:fuse_open] glusterfs-fuse: 131383:
OPEN /.disk-list
2009-05-14 11:31:01 D [fuse-bridge.c:652:fuse_fd_cbk] glusterfs-fuse: 131383:
OPEN() /.disk-list => 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [fuse-bridge.c:1577:fuse_readv] glusterfs-fuse: 131384:
READ (0x2aaaaaf00ba0, size=4096, offset=0)
2009-05-14 11:31:01 D [fuse-bridge.c:1542:fuse_readv_cbk] glusterfs-fuse:
131384: READ => 47/4096,0/47
2009-05-14 11:31:01 D [fuse-bridge.c:1669:fuse_flush] glusterfs-fuse: 131385:
FLUSH 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [fuse-bridge.c:896:fuse_err_cbk] glusterfs-fuse: 131385:
FLUSH() ERR => 0
2009-05-14 11:31:01 D [fuse-bridge.c:1689:fuse_release] glusterfs-fuse: 131386:
RELEASE 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [inode.c:328:__inode_passivate] fuse/inode: passivating
inode(95682582) lru=4/0 active=3 purge=0
2009-05-14 11:31:01 D [inode.c:309:__inode_activate] fuse/inode: activating
inode(95682582), lru=3/0 active=4 purge=0
2009-05-14 11:31:01 D [fuse-bridge.c:813:do_truncate] glusterfs-fuse: 131387:
TRUNCATE /.disk-list/0(95682582)
2009-05-14 11:31:01 D [fuse-bridge.c:523:fuse_attr_cbk] glusterfs-fuse: 131387:
TRUNCATE() /.disk-list => 95682582
2009-05-14 11:31:01 D [fuse-bridge.c:1515:fuse_open] glusterfs-fuse: 131388:
OPEN /.disk-list
2009-05-14 11:31:01 D [fuse-bridge.c:652:fuse_fd_cbk] glusterfs-fuse: 131388:
OPEN() /.disk-list => 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [fuse-bridge.c:1642:fuse_write] glusterfs-fuse: 131389:
WRITE (0x2aaaaaf00ba0, size=47, offset=0)
2009-05-14 11:31:01 D [fuse-bridge.c:1600:fuse_writev_cbk] glusterfs-fuse:
131389: WRITE => 47/47,0/47
2009-05-14 11:31:01 D [fuse-bridge.c:1669:fuse_flush] glusterfs-fuse: 131390:
FLUSH 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [fuse-bridge.c:896:fuse_err_cbk] glusterfs-fuse: 131390:
FLUSH() ERR => 0
2009-05-14 11:31:01 D [fuse-bridge.c:1689:fuse_release] glusterfs-fuse: 131391:
RELEASE 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [inode.c:328:__inode_passivate] fuse/inode: passivating
inode(95682582) lru=4/0 active=3 purge=0
2009-05-14 11:31:01 D [inode.c:309:__inode_activate] fuse/inode: activating
inode(95682582), lru=3/0 active=4 purge=0
2009-05-14 11:31:01 D [fuse-bridge.c:813:do_truncate] glusterfs-fuse: 131392:
TRUNCATE /.disk-list/0(95682582)
2009-05-14 11:31:01 D [fuse-bridge.c:523:fuse_attr_cbk] glusterfs-fuse: 131392:
TRUNCATE() /.disk-list => 95682582
2009-05-14 11:31:01 D [fuse-bridge.c:1515:fuse_open] glusterfs-fuse: 131393:
OPEN /.disk-list
2009-05-14 11:31:01 D [fuse-bridge.c:652:fuse_fd_cbk] glusterfs-fuse: 131393:
OPEN() /.disk-list => 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [fuse-bridge.c:1642:fuse_write] glusterfs-fuse: 131394:
WRITE (0x2aaaaaf00ba0, size=47, offset=0)
2009-05-14 11:31:01 D [fuse-bridge.c:1600:fuse_writev_cbk] glusterfs-fuse:
131394: WRITE => 47/47,0/47
2009-05-14 11:31:01 D [fuse-bridge.c:1669:fuse_flush] glusterfs-fuse: 131395:
FLUSH 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [fuse-bridge.c:896:fuse_err_cbk] glusterfs-fuse: 131395:
FLUSH() ERR => 0
2009-05-14 11:31:01 D [fuse-bridge.c:1689:fuse_release] glusterfs-fuse: 131396:
RELEASE 0x2aaaaaf00ba0
2009-05-14 11:31:01 D [inode.c:328:__inode_passivate] fuse/inode: passivating
inode(95682582) lru=4/0 active=3 purge=0
2009-05-14 11:31:01 D [inode.c:309:__inode_activate] fuse/inode: activating
inode(93847579), lru=3/0 active=4 purge=0
2009-05-14 11:31:01 D [fuse-bridge.c:1165:fuse_unlink] glusterfs-fuse: 131397:
UNLINK /windows/disk0
2009-05-14 11:31:13 E [client-protocol.c:434:client_ping_timer_expired]
client2: ping timer expired! bailing transport
2009-05-14 11:31:13 D [socket.c:175:__socket_disconnect] client2: shutdown()
returned 0. set connection state to -1
2009-05-14 11:31:13 D [socket.c:175:__socket_disconnect] client2: shutdown()
returned 0. set connection state to -1
2009-05-14 11:31:13 D [socket.c:90:__socket_rwv] client2: EOF from peer
192.168.69.3:6996
2009-05-14 11:31:13 D [socket.c:562:__socket_proto_state_machine] client2: read
(Transport endpoint is not connected) in state 1 (192.168.69.3:6996)
2009-05-14 11:31:13 D [client-protocol.c:6465:protocol_client_cleanup] client2:
cleaning up state in transport object 0x513830
2009-05-14 11:31:13 E [saved-frames.c:165:saved_frames_unwind] client2: forced
unwinding frame type(1) op(UNLINK)
2009-05-14 11:31:13 E [saved-frames.c:165:saved_frames_unwind] client2: forced
unwinding frame type(2) op((null))
2009-05-14 11:31:13 E [client-protocol.c:536:client_ping_cbk] client2: timer
must have expired
2009-05-14 11:31:13 D [client-protocol.c:6404:client_protocol_reconnect]
client2: attempting reconnect
2009-05-14 11:31:13 D [common-utils.c:85:gf_resolve_ip6] resolver: flushing DNS
cache
2009-05-14 11:31:13 D [common-utils.c:92:gf_resolve_ip6] resolver: DNS cache
not present, freshly probing hostname: 192.168.69.3
2009-05-14 11:31:13 D [common-utils.c:129:gf_resolve_ip6] resolver: returning
ip-192.168.69.3 (port-6996) for hostname: 192.168.69.3 and port: 6996
2009-05-14 11:31:13 D [socket.c:90:__socket_rwv] client2: EOF from peer
192.168.69.3:6996
2009-05-14 11:31:13 D [socket.c:562:__socket_proto_state_machine] client2: read
(Transport endpoint is not connected) in state 1 (192.168.69.3:6996)
2009-05-14 11:31:13 D [client-protocol.c:6465:protocol_client_cleanup] client2:
cleaning up state in transport object 0x513da0
2009-05-14 11:31:13 D [client-protocol.c:6404:client_protocol_reconnect]
client2: attempting reconnect
2009-05-14 11:31:13 D [common-utils.c:85:gf_resolve_ip6] resolver: flushing DNS
cache
2009-05-14 11:31:13 D [common-utils.c:92:gf_resolve_ip6] resolver: DNS cache
not present, freshly probing hostname: 192.168.69.3
2009-05-14 11:31:13 D [common-utils.c:129:gf_resolve_ip6] resolver: returning
ip-192.168.69.3 (port-6996) for hostname: 192.168.69.3 and port: 6996
2009-05-14 11:31:13 N [client-protocol.c:7014:notify] client2: disconnected
2009-05-14 11:31:13 N [afr.c:2142:notify] afr2: subvolume client2 went down
2009-05-14 11:31:13 D [client-protocol.c:7062:notify] client2: got
GF_EVENT_CHILD_UP
2009-05-14 11:31:13 D [socket.c:965:socket_connect] client2: connect () called
on transport already connected
2009-05-14 11:31:13 D [client-protocol.c:7062:notify] client2: got
GF_EVENT_CHILD_UP
2009-05-14 11:31:13 D [socket.c:965:socket_connect] client2: connect () called
on transport already connected
2009-05-14 11:31:18 D [inode.c:112:__dentry_unhash] fuse/inode: dentry unhashed
disk0 (93847579)
2009-05-14 11:31:18 D [inode.c:125:__dentry_unset] fuse/inode: unset dentry
disk0 (93847579)
2009-05-14 11:31:18 D [fuse-bridge.c:955:fuse_unlink_cbk] glusterfs-fuse:
131397: UNLINK() /windows/disk0 => 0
2009-05-14 11:31:18 D [socket.c:965:socket_connect] client2: connect () called
on transport already connected
2009-05-14 11:31:18 D [fuse-bridge.c:489:fuse_forget] glusterfs-fuse: got
forget on inode (93847579)
2009-05-14 11:31:18 D [socket.c:965:socket_connect] client2: connect () called
on transport already connected
2009-05-14 11:31:18 D [inode.c:352:__inode_retire] fuse/inode: retiring
inode(93847579) lru=3/0 active=3 purge=1
2009-05-14 11:31:18 D [socket.c:965:socket_connect] client2: connect () called
on transport already connected
2009-05-14 11:31:18 D [inode.c:292:__inode_destroy] fuse/inode: destroy
inode(93847579) [...@0x2aaaaae020b0]
2009-05-14 11:31:18 D [inode.c:328:__inode_passivate] fuse/inode: passivating
inode(95682574) lru=4/0 active=2 purge=0
2009-05-14 11:31:18 N [client-protocol.c:6327:client_setvolume_cbk] client2:
connection and handshake succeeded
2009-05-14 11:31:18 N [afr.c:2120:notify] afr2: subvolume client2 came up
2009-05-14 11:31:18 N [client-protocol.c:6327:client_setvolume_cbk] client2:
connection and handshake succeeded
2009-05-14 11:31:18 N [afr.c:2120:notify] afr2: subvolume client2 came up
2009-05-14 11:31:23 D [client-protocol.c:6413:client_protocol_reconnect]
client2: breaking reconnect chain
2009-05-14 11:31:24 D [client-protocol.c:6413:client_protocol_reconnect]
client2: breaking reconnect chain
The debug log on server :
2009-05-14 11:30:27 D [common.c:514:pl_setlk] brick1: Lock (pid=-1427108160) 0
- 0 => OK
2009-05-14 11:30:27 D [server-protocol.c:4374:server_flush] brick1: 393329:
FLUSH 'fd=1 (22003715)'
2009-05-14 11:30:27 D [server-protocol.c:6171:server_finodelk] brick1: 393330:
FINODELK 'fd=1 (22003715)'
2009-05-14 11:30:27 D [common.c:514:pl_setlk] brick1: Unlock (pid=-1427108160)
0 - 0 => OK
2009-05-14 11:30:27 D [inode.c:328:__inode_passivate] brick1/inode: passivating
inode(22003715) lru=3/1024 active=3 purge=0
2009-05-14 11:30:27 D [server-protocol.c:4284:server_release] brick1: 393331:
RELEASE 'fd=1'
2009-05-14 11:30:28 D [server-protocol.c:6200:server_entrylk_resume] brick1:
154: ENTRYLK '/windows (22003717) '
2009-05-14 11:30:28 D [server-protocol.c:4931:server_xattrop_resume] brick1:
393332: XATTROP '/windows (22003717)'
2009-05-14 11:30:28 D [inode.c:309:__inode_activate] brick1/inode: activating
inode(22003718), lru=2/1024 active=4 purge=0
2009-05-14 11:30:28 D [server-protocol.c:4595:server_unlink_resume] brick1:
393333: UNLINK '22003717//windows/disk0 (22003718)'
2009-05-14 11:30:44 D [server-protocol.c:1563:server_unlink_cbk] brick1:
393333: UNLINK_CBK 22003717/disk0 (22003718)
2009-05-14 11:30:44 D [inode.c:112:__dentry_unhash] brick1/inode: dentry
unhashed disk0 (22003718)
2009-05-14 11:30:44 D [inode.c:125:__dentry_unset] brick1/inode: unset dentry
disk0 (22003718)
2009-05-14 11:30:44 D [inode.c:328:__inode_passivate] brick1/inode: passivating
inode(22003718) lru=3/1024 active=3 purge=0
2009-05-14 11:30:44 D [socket.c:90:__socket_rwv] server: EOF from peer
192.168.69.6:1019
2009-05-14 11:30:44 D [socket.c:562:__socket_proto_state_machine] server: read
(Transport endpoint is not connected) in state 1 (192.168.69.6:1019)
2009-05-14 11:30:44 N [server-protocol.c:8272:notify] server: 192.168.69.6:1019
disconnected
2009-05-14 11:30:44 D [internal.c:721:pl_entrylk] brick1: releasing locks for
transport 0x9d63a10
2009-05-14 11:30:44 D [inode.c:328:__inode_passivate] brick1/inode: passivating
inode(22003717) lru=4/1024 active=2 purge=0
2009-05-14 11:30:44 D [socket.c:1332:fini] server: transport 0x9d2bcb0 destroyed
2009-05-14 11:30:44 E [socket.c:102:__socket_rwv] server: writev failed (Broken
pipe)
2009-05-14 11:30:44 D [addr.c:174:gf_auth] brick1: allowed = "*", received addr
= "192.168.69.6"
2009-05-14 11:30:44 N [server-protocol.c:7502:mop_setvolume] server: accepted
client from 192.168.69.6:1015
2009-05-14 11:30:44 D [socket.c:90:__socket_rwv] server: EOF from peer
192.168.69.6:1017
2009-05-14 11:30:44 D [socket.c:562:__socket_proto_state_machine] server: read
(Transport endpoint is not connected) in state 1 (192.168.69.6:1017)
2009-05-14 11:30:44 N [server-protocol.c:8272:notify] server: 192.168.69.6:1017
disconnected
2009-05-14 11:30:44 D [socket.c:1332:fini] server: transport 0x9d2bf40 destroyed
2009-05-14 11:30:44 D [addr.c:174:gf_auth] brick1: allowed = "*", received addr
= "192.168.69.6"
2009-05-14 11:30:44 N [server-protocol.c:7502:mop_setvolume] server: accepted
client from 192.168.69.6:1014
2009-05-14
eagleeyes
_______________________________________________
Gluster-users mailing list
Gluster-users@gluster.org
http://zresearch.com/cgi-bin/mailman/listinfo/gluster-users
