[Gluster-devel] Connect taking a loooong time on loopback

Tue Jul 17 15:28:06 UTC 2007

Hi Sabestien,

We'll get back to you, dont think anyone has clue on what might be
happening yet.

Krishna

On 7/16/07, Sebastien LELIEVRE <slelievre at tbs-internet.com> wrote:
> Hi everyone,
>
> I'm still experiencing the same problem with patch 313
>
> Does anyone have a clue on what could cause such a behaviour ?
>
> Regards,
>
> Sebastien.
>
> Sebastien LELIEVRE a écrit :
> > Hi everyone,
> >
> > I'm begining glusterfs integration on our new datacenter, and my really
> > first tests show me really odd things, just see :
> >
> > Client:
> >
> > volume brickc
> >   type protocol/client
> >   option transport-type tcp/client
> >   option remote-host 127.0.0.1
> >   option remote-port 6996
> >   option remote-subvolume brick
> > end-volume
> >
> >
> > Server:
> >
> > volume brick
> >   type storage/posix
> >   option directory /home/slelievre/gluster-test/server1
> > end-volume
> >
> > volume server
> >   type protocol/server
> >   option transport-type tcp/server
> >   option bind-address 127.0.0.1
> >   option listen-port 6996
> >   subvolumes brick
> >   option auth.ip.brick.allow *
> > end-volume
> >
> >
> > As you can see on the log below, the client took nearly 10 mins to
> > connect to the server, and connection was broken a little after.
> >
> > We are running on mainline-2.5 patch 266 with fuse 2.6.5 and kernel
> > 2.6.16 'customed' to our needs
> >
> > Is this a 'bug' ? If so, is it fixed on latest versions ?
> >
> > Cheers,
> >
> > Sebastien.
> >
> > logs are :
> >
> > Server-side :
> >
> > 2007-07-13 12:46:37 D [spec.y:116:new_section] libglusterfs/parser: New
> > node for 'brick'
> > 2007-07-13 12:46:37 D [spec.y:132:section_type] libglusterfs/parser:
> > Type:brick:storage/posix
> > 2007-07-13 12:46:37 D [xlator.c:100:xlator_set_type]
> > libglusterfs/xlator: attempt to load type storage/posix
> > 2007-07-13 12:46:37 D [xlator.c:107:xlator_set_type]
> > libglusterfs/xlator: attempt to load file
> > /usr/lib/glusterfs/1.3.0-pre5.2/xlator/storage/posix.so
> > 2007-07-13 12:46:37 D [spec.y:152:section_option] libglusterfs/parser:
> > Option:brick:directory:/home/slelievre/gluster-test/server1
> > 2007-07-13 12:46:37 D [spec.y:209:section_end] libglusterfs/parser:
> > end:brick
> > 2007-07-13 12:46:37 D [spec.y:116:new_section] libglusterfs/parser: New
> > node for 'server'
> > 2007-07-13 12:46:37 D [spec.y:132:section_type] libglusterfs/parser:
> > Type:server:protocol/server
> > 2007-07-13 12:46:37 D [xlator.c:100:xlator_set_type]
> > libglusterfs/xlator: attempt to load type protocol/server
> > 2007-07-13 12:46:37 D [xlator.c:107:xlator_set_type]
> > libglusterfs/xlator: attempt to load file
> > /usr/lib/glusterfs/1.3.0-pre5.2/xlator/protocol/server.so
> > 2007-07-13 12:46:37 D [spec.y:152:section_option] libglusterfs/parser:
> > Option:server:transport-type:tcp/server
> > 2007-07-13 12:46:37 D [spec.y:152:section_option] libglusterfs/parser:
> > Option:server:bind-address:127.0.0.1
> > 2007-07-13 12:46:37 D [spec.y:152:section_option] libglusterfs/parser:
> > Option:server:listen-port:6996
> > 2007-07-13 12:46:37 D [spec.y:194:section_sub] liglusterfs/parser:
> > child:server->brick
> > 2007-07-13 12:46:37 D [spec.y:152:section_option] libglusterfs/parser:
> > Option:server:auth.ip.brick.allow:*
> > 2007-07-13 12:46:37 D [spec.y:209:section_end] libglusterfs/parser:
> > end:server
> > 2007-07-13 12:46:37 D [posix.c:1776:init] brick: missing
> > 'inode-lru-limit'. defaulting to 1000
> > 2007-07-13 12:46:37 D [inode.c:481:__create_inode] brick/inode: create
> > inode(1)
> > 2007-07-13 12:46:37 D [inode.c:279:__active_inode] brick/inode:
> > activating inode(1), lru=0/1000
> > 2007-07-13 12:46:37 D [server-protocol.c:5670:init] protocol/server:
> > protocol/server xlator loaded
> > 2007-07-13 12:46:37 D [transport.c:81:transport_load]
> > libglusterfs/transport: attempt to load type tcp/server
> > 2007-07-13 12:46:37 D [transport.c:86:transport_load]
> > libglusterfs/transport: attempt to load file
> > /usr/lib/glusterfs/1.3.0-pre5.2/transport/tcp/server.so
> > 2007-07-13 12:46:50 D [tcp-server.c:136:tcp_server_notify] server:
> > Registering socket (8) for new transport object of 127.0.0.1
> > 2007-07-13 12:46:50 D [server-protocol.c:5024:mop_setvolume]
> > server-protocol: mop_setvolume: received port = 1023
> > 2007-07-13 12:46:50 D [server-protocol.c:5040:mop_setvolume]
> > server-protocol: mop_setvolume: IP addr = *, received ip addr = 127.0.0.1
> > 2007-07-13 12:46:50 D [server-protocol.c:5051:mop_setvolume]
> > server-protocol: mop_setvolume: accepted client from 127.0.0.1
> > 2007-07-13 12:49:07 D [server-protocol.c:5649:server_protocol_cleanup]
> > protocol/server: cleaned up xl_private of 0x8054330
> > 2007-07-13 12:49:07 C [tcp.c:81:tcp_disconnect] server: connection
> > disconnected
> > 2007-07-13 12:49:07 D [tcp-server.c:230:gf_transport_fini] server:
> > destroying transport object for 127.0.0.1:1023 (fd=8)
> > 2007-07-13 12:52:15 D [tcp-server.c:136:tcp_server_notify] server:
> > Registering socket (5) for new transport object of 127.0.0.1
> > 2007-07-13 12:52:15 D [server-protocol.c:5024:mop_setvolume]
> > server-protocol: mop_setvolume: received port = 1023
> > 2007-07-13 12:52:15 D [server-protocol.c:5040:mop_setvolume]
> > server-protocol: mop_setvolume: IP addr = *, received ip addr = 127.0.0.1
> > 2007-07-13 12:52:15 D [server-protocol.c:5051:mop_setvolume]
> > server-protocol: mop_setvolume: accepted client from 127.0.0.1
> >
> > Client-side:
> >
> > 2007-07-13 12:52:15 D [glusterfs.c:118:get_spec_fp] glusterfs: loading
> > spec from /etc/glusterfs/glusterfs-basic.vol
> > 2007-07-13 12:52:15 W [fuse-bridge.c:1887:fuse_transport_notify]
> > glusterfs-fuse: Ignoring notify event 4
> > 2007-07-13 12:52:15 D [spec.y:116:new_section] libglusterfs/parser: New
> > node for 'brickc'
> > 2007-07-13 12:52:15 D [spec.y:132:section_type] libglusterfs/parser:
> > Type:brickc:protocol/client
> > 2007-07-13 12:52:15 D [xlator.c:100:xlator_set_type]
> > libglusterfs/xlator: attempt to load type protocol/client
> > 2007-07-13 12:52:15 D [xlator.c:107:xlator_set_type]
> > libglusterfs/xlator: attempt to load file
> > /usr/lib/glusterfs/1.3.0-pre5.2/xlator/protocol/client.so
> > 2007-07-13 12:52:15 D [spec.y:152:section_option] libglusterfs/parser:
> > Option:brickc:transport-type:tcp/client
> > 2007-07-13 12:52:15 D [spec.y:152:section_option] libglusterfs/parser:
> > Option:brickc:remote-host:127.0.0.1
> > 2007-07-13 12:52:15 D [spec.y:152:section_option] libglusterfs/parser:
> > Option:brickc:remote-port:6996
> > 2007-07-13 12:52:15 D [spec.y:152:section_option] libglusterfs/parser:
> > Option:brickc:remote-subvolume:brick
> > 2007-07-13 12:52:15 D [spec.y:209:section_end] libglusterfs/parser:
> > end:brickc
> > 2007-07-13 12:52:15 D [inode.c:481:__create_inode] fuse/inode: create
> > inode(1)
> > 2007-07-13 12:52:15 D [inode.c:279:__active_inode] fuse/inode:
> > activating inode(1), lru=0/0
> > 2007-07-13 12:52:15 D [client-protocol.c:4255:init] brickc: missing
> > 'inode-lru-limit'. defaulting to 1000
> > 2007-07-13 12:52:15 D [client-protocol.c:4272:init] brickc: defaulting
> > transport-timeout to 120
> > 2007-07-13 12:52:15 D [transport.c:81:transport_load]
> > libglusterfs/transport: attempt to load type tcp/client
> > 2007-07-13 12:52:15 D [transport.c:86:transport_load]
> > libglusterfs/transport: attempt to load file
> > /usr/lib/glusterfs/1.3.0-pre5.2/transport/tcp/client.so
> > 2007-07-13 12:52:15 D [inode.c:481:__create_inode] brickc/inode: create
> > inode(1)
> > 2007-07-13 12:52:15 D [inode.c:279:__active_inode] brickc/inode:
> > activating inode(1), lru=0/1000
> > 2007-07-13 12:52:15 D [client-protocol.c:4550:notify] brickc: got
> > GF_EVENT_PARENT_UP, attempting connect on transport
> > 2007-07-13 12:52:15 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:52:15 D [tcp-client.c:71:tcp_connect] brickc: socket fd = 4
> > 2007-07-13 12:52:15 D [tcp-client.c:89:tcp_connect] brickc: finalized on
> > port `1023'
> > 2007-07-13 12:52:15 D [tcp-client.c:142:tcp_connect] brickc: connect on
> > 4 in progress (non-blocking)
> > 2007-07-13 12:52:15 D [tcp-client.c:186:tcp_connect] brickc: connection
> > on 4 success
> > 2007-07-13 12:52:15 D [client-protocol.c:4571:notify] brickc: got
> > GF_EVENT_CHILD_UP
> > 2007-07-13 12:52:16 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:52:18 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:52:21 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:52:26 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:52:34 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:52:47 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:53:08 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:53:42 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:54:37 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:56:06 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 12:58:30 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 13:02:24 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 13:08:41 W [client-protocol.c:4008:client_protocol_reconnect]
> > brickc: attempting reconnect
> > 2007-07-13 13:11:01 D
> > [client-protocol.c:4335:client_protocol_handshake_reply] brickc: reply
> > frame has callid: 424242
> > 2007-07-13 13:11:01 D
> > [client-protocol.c:4369:client_protocol_handshake_reply] brickc:
> > SETVOLUME on remote-host succeeded
> > 2007-07-13 13:18:51 W [client-protocol.c:4016:client_protocol_reconnect]
> > brickc: breaking reconnect chain
> >
> >
> > ------------------------------------------------------------------------
> >
> > _______________________________________________
> > Gluster-devel mailing list
> > Gluster-devel at nongnu.org
> > http://lists.nongnu.org/mailman/listinfo/gluster-devel
>
>
>
> _______________________________________________
> Gluster-devel mailing list
> Gluster-devel at nongnu.org
> http://lists.nongnu.org/mailman/listinfo/gluster-devel
>
>