bugGluster - Bugs: bug #25506, Client side AFR writes cause...

 
 

bug #25506: Client side AFR writes cause server crash

Submitted by:  Cory Meyer <yrock>
Submitted on:  Fri 06 Feb 2009 06:09:58 PM UTC  
 
Category: GlusterFSSeverity: 3 - Normal
Priority: 5 - NormalItem Group: Improper behaviour
Status: FixedPrivacy: Public
Assigned to: Vikas Gorur <vikasgp>Originator Name: cory
Open/Closed: ClosedRelease: glusterfs--mainline--3.0--patch-912
Operating System: GNU/LinuxReproducibility: Intermittent

Add a New Comment(Rich Markup)
   

You are not logged in

Please log in, so followups can be emailed to you.

 

(Jump to the original submission Jump to the original submission)

Wed 24 Jun 2009 05:00:18 AM UTC, comment #6:

Closing the bug, as the discussions point out that the original issue is solved.

Please open a new bug, if an independent issue is seen.

--
Gowda

Basavanagowda Kanur <gowda>
Project Member
Fri 13 Feb 2009 01:36:44 AM UTC, comment #5:

There is no more crash while using AFR, but there seems to be some EIO error coming when file is TRUCATED and opened again.

Amar Tumballi <amarts>
Project Member
Mon 09 Feb 2009 07:12:45 PM UTC, comment #4:

this is a problem with new entry of 'inode_ctx_get' and is seen only on 32bit systems. Will have a fix for this soon.

Cory,
Thanks for reporting.

Regards,
Amar

Amar Tumballi <amarts>
Project Member
Mon 09 Feb 2009 05:19:39 PM UTC, comment #3:

Still seeing this issue under glusterfs--mainline--3.0--patch-906. The problem can be consistantly reproduced either via touch or rm from the cli with the same client configuration reported earlier.

2009-02-09 11:15:03 D [glusterfsd.c:329:_get_specfp] glusterfs: loading volume file /etc/glusterfs/glusterfs-server-test.vol
================================================================================
Version : glusterfs 2.0.0tla built on Feb 9 2009 09:22:39
TLA Revision : glusterfs--mainline--3.0--patch-906
Starting Time: 2009-02-09 11:15:03
Command line : /usr/local/glusterfs-mainline-3.0-906/sbin/glusterfsd -f /etc/glusterfs/glusterfs-server-test.vol -L DEBUG --log-file=/tmp/glusterfsd-906
PID : 22062
System name : Linux
Nodename : nwtnfarm02
Kernel Release : 2.6.18-6-686-bigmem
Hardware Identifier: i686

Given volfile:
+------------------------------------------------------------------------------+
1: volume bricktest-posix
2: type storage/posix
3: option directory /media/sda6/bricktest
4: end-volume
5:
6: volume bricktest-posix-locks
7: type features/posix-locks
8: subvolumes bricktest-posix
9: end-volume
10:
11: volume bricktest
12: type performance/io-threads
13: option thread-count 4
14: subvolumes bricktest-posix-locks
15: # subvolumes bricktest-posix
16: end-volume
17:
18: ### Add network serving capability to above brick.
19: volume server
20: type protocol/server
21: option listen-port 6997
22: option transport-type tcp/server # For TCP/IP transport
23: option auth.ip.bricktest.allow 127.0.0.1,192.168.*
24: subvolumes bricktest
25: end-volume

+------------------------------------------------------------------------------+
2009-02-09 11:15:03 D [spec.y:187:new_section] parser: New node for 'bricktest-posix'
2009-02-09 11:15:03 D [xlator.c:430:xlator_set_type] xlator: attempt to load file /usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/storage/posix.so
2009-02-09 11:15:03 D [spec.y:213:section_type] parser: Type:bricktest-posix:storage/posix
2009-02-09 11:15:03 D [spec.y:242:section_option] parser: Option:bricktest-posix:directory:/media/sda6/bricktest
2009-02-09 11:15:03 D [spec.y:326:section_end] parser: end:bricktest-posix
2009-02-09 11:15:03 D [spec.y:187:new_section] parser: New node for 'bricktest-posix-locks'
2009-02-09 11:15:03 D [xlator.c:430:xlator_set_type] xlator: attempt to load file /usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/features/posix-locks.so
2009-02-09 11:15:03 D [xlator.c:470:xlator_set_type] xlator: dlsym(notify) on /usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/features/posix-locks.so: undefined symbol: notify -- neglecting
2009-02-09 11:15:03 D [spec.y:213:section_type] parser: Type:bricktest-posix-locks:features/posix-locks
2009-02-09 11:15:03 D [spec.y:311:section_sub] parser: child:bricktest-posix-locks->bricktest-posix
2009-02-09 11:15:03 D [spec.y:326:section_end] parser: end:bricktest-posix-locks
2009-02-09 11:15:03 D [spec.y:187:new_section] parser: New node for 'bricktest'
2009-02-09 11:15:03 D [xlator.c:430:xlator_set_type] xlator: attempt to load file /usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/performance/io-threads.so
2009-02-09 11:15:03 D [xlator.c:470:xlator_set_type] xlator: dlsym(notify) on /usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/performance/io-threads.so: undefined symbol: notify -- neglecting
2009-02-09 11:15:03 D [spec.y:213:section_type] parser: Type:bricktest:performance/io-threads
2009-02-09 11:15:03 D [spec.y:242:section_option] parser: Option:bricktest:thread-count:4
2009-02-09 11:15:03 D [spec.y:311:section_sub] parser: child:bricktest->bricktest-posix-locks
2009-02-09 11:15:03 D [spec.y:326:section_end] parser: end:bricktest
2009-02-09 11:15:03 D [spec.y:187:new_section] parser: New node for 'server'
2009-02-09 11:15:03 D [xlator.c:430:xlator_set_type] xlator: attempt to load file /usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/protocol/server.so
2009-02-09 11:15:03 D [spec.y:213:section_type] parser: Type:server:protocol/server
2009-02-09 11:15:03 D [spec.y:242:section_option] parser: Option:server:listen-port:6997
2009-02-09 11:15:03 D [spec.y:242:section_option] parser: Option:server:transport-type:tcp/server
2009-02-09 11:15:03 D [spec.y:242:section_option] parser: Option:server:auth.ip.bricktest.allow:127.0.0.1,192.168.*
2009-02-09 11:15:03 D [spec.y:311:section_sub] parser: child:server->bricktest
2009-02-09 11:15:03 D [spec.y:326:section_end] parser: end:server
2009-02-09 11:15:03 D [glusterfsd.c:1094:main] glusterfs: running in pid 22063
2009-02-09 11:15:03 D [xlator.c:560:xlator_init_rec] bricktest-posix: Initialization done
2009-02-09 11:15:03 D [xlator.c:560:xlator_init_rec] bricktest-posix-locks: Initialization done
2009-02-09 11:15:03 D [io-threads.c:1179:init] io-threads: Using conf->thread_count = 4
2009-02-09 11:15:03 D [xlator.c:560:xlator_init_rec] bricktest: Initialization done
2009-02-09 11:15:03 D [transport.c:141:transport_load] transport: attempt to load file /usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/transport/socket.so
2009-02-09 11:15:03 W [xlator.c:391:validate_xlator_volume_options] server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
2009-02-09 11:15:03 D [xlator.c:152:_volume_option_value_validate] server: no range check required for 'option transport.socket.listen-port 6997'
2009-02-09 11:15:03 W [server-protocol.c:7785:get_auth_types] server: assuming 'auth.ip' to be 'auth.addr'
2009-02-09 11:15:03 D [server-protocol.c:7915:init] server: defaulting limits.transaction-size to 4194304
2009-02-09 11:15:03 N [glusterfsd.c:1113:main] glusterfs: Successfully started
2009-02-09 11:15:06 D [addr.c:174:gf_auth] bricktest: allowed = "127.0.0.1", received addr = "192.168.201.101"
2009-02-09 11:15:06 D [addr.c:174:gf_auth] bricktest: allowed = "192.168.*", received addr = "192.168.201.101"
2009-02-09 11:15:06 N [server-protocol.c:7133:mop_setvolume] server: accepted client from 192.168.201.101:1017
2009-02-09 11:15:06 D [server-protocol.c:7179:mop_setvolume] server: creating inode table with lru_limit=1024, xlator=bricktest
2009-02-09 11:15:06 D [inode.c:1006:inode_table_new] bricktest: creating new inode table with lru_limit=1024
2009-02-09 11:15:06 D [inode.c:471:__inode_create] bricktest/inode: create inode(0)
2009-02-09 11:15:15 D [inode.c:293:__inode_activate] bricktest/inode: activating inode(1), lru=0/1024 active=1 purge=0
2009-02-09 11:15:15 D [inode.c:471:__inode_create] bricktest/inode: create inode(0)
2009-02-09 11:15:15 D [inode.c:293:__inode_activate] bricktest/inode: activating inode(0), lru=0/1024 active=2 purge=0
2009-02-09 11:15:15 D [server-protocol.c:3537:server_lookup_resume] bricktest: 45: LOOKUP '1/bla'
2009-02-09 11:15:15 D [inode.c:94:__dentry_hash] bricktest/inode: dentry hashed bla (12238852)
2009-02-09 11:15:15 D [inode.c:312:__inode_passivate] bricktest/inode: passivating inode(12238852) lru=1/1024 active=1 purge=0
2009-02-09 11:15:24 D [inode.c:293:__inode_activate] bricktest/inode: activating inode(12238852), lru=0/1024 active=2 purge=0
2009-02-09 11:15:24 D [server-protocol.c:3537:server_lookup_resume] bricktest: 47: LOOKUP '1/bla'
2009-02-09 11:15:24 D [inode.c:312:__inode_passivate] bricktest/inode: passivating inode(12238852) lru=1/1024 active=1 purge=0
2009-02-09 11:15:24 D [server-protocol.c:5984:server_entrylk_resume] bricktest: 48: ENTRYLK '/ (1) '
2009-02-09 11:15:24 D [server-protocol.c:4759:server_xattrop_resume] bricktest: 49: XATTROP '/ (1)'
2009-02-09 11:15:24 D [inode.c:293:__inode_activate] bricktest/inode: activating inode(12238852), lru=0/1024 active=2 purge=0
2009-02-09 11:15:24 D [server-protocol.c:4495:server_unlink_resume] bricktest: 50: UNLINK '1//bla (12238852)'
2009-02-09 11:15:24 D [server-protocol.c:1474:server_unlink_cbk] bricktest: 50: UNLINK_CBK 1/bla (12238852)
2009-02-09 11:15:24 D [inode.c:112:__dentry_unhash] bricktest/inode: dentry unhashed bla (12238852)
2009-02-09 11:15:24 D [inode.c:125:__dentry_unset] bricktest/inode: unset dentry bla (12238852)
2009-02-09 11:15:24 D [inode.c:312:__inode_passivate] bricktest/inode: passivating inode(12238852) lru=1/1024 active=1 purge=0
2009-02-09 11:15:24 D [server-protocol.c:4759:server_xattrop_resume] bricktest: 51: XATTROP '/ (1)'
pending frames:
frame : type(1) op(XATTROP)

patchset: glusterfs--mainline--3.0--patch-906
signal received: 11
configuration details:argp 1
backtrace 1
dlfcn 1
fdatasync 1
libpthread 1
llistxattr 1
setfsid 1
spinlock 1
epoll.h 1
xattr.h 1
st_atim.tv_nsec 1
package-string: glusterfs 2.0.0tla
[0xb7f23420]
/usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/storage/posix.so(posix_xattrop+0x3f)[0xb7d5061f]
/usr/local/glusterfs-mainline-3.0-906/lib/libglusterfs.so.0(default_xattrop+0xb0)[0xb7f052e0]
/usr/local/glusterfs-mainline-3.0-906/lib/libglusterfs.so.0(default_xattrop+0xb0)[0xb7f052e0]
/usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/protocol/server.so(server_xattrop_resume+0xc2)[0xb7d2c7a2]
/usr/local/glusterfs-mainline-3.0-906/lib/libglusterfs.so.0(call_resume+0x23b)[0xb7f0d20b]
/usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/protocol/server.so(server_xattrop+0x188)[0xb7d33b88]
/usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/protocol/server.so(protocol_server_interpret+0x150)[0xb7d2d220]
/usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/protocol/server.so(protocol_server_pollin+0xb3)[0xb7d2d463]
/usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/xlator/protocol/server.so(notify+0x92)[0xb7d30982]
/usr/local/glusterfs-mainline-3.0-906/lib/glusterfs/2.0.0tla/transport/socket.so[0xb551ceff]
/usr/local/glusterfs-mainline-3.0-906/lib/libglusterfs.so.0[0xb7f176e9]
/usr/local/glusterfs-mainline-3.0-906/lib/libglusterfs.so.0(event_dispatch+0x21)[0xb7f16541]
/usr/local/glusterfs-mainline-3.0-906/sbin/glusterfsd(main+0xcd6)[0x804b176]
/lib/tls/i686/cmov/libc.so.6(__libc_start_main+0xc8)[0xb7dbbea8]
/usr/local/glusterfs-mainline-3.0-906/sbin/glusterfsd[0x8049a61]

Cory Meyer <yrock>
Fri 06 Feb 2009 08:03:05 PM UTC, comment #2:

The following patch fixes the problem: committed in 'glusterfs--mainlin--3.0--patch-899'

--- orig/xlators/storage/posix/src/posix.c
+++ mod/xlators/storage/posix/src/posix.c
@@ -2625,7 +2625,7 @@ posix_xattrop_common (call_frame_t *fram

memcpy (_ret_array, array, trav->value->len);

- ret = dict_set_bin (xattr, trav->key, array,
+ ret = dict_set_bin (xattr, trav->key, _ret_array,
trav->value->len);

if (ret != 0) {

Amar Tumballi <amarts>
Project Member
Fri 06 Feb 2009 06:39:52 PM UTC, comment #1:

Hi Cory,
Thanks for reporting.

I could reproduce the bug. Vikas, Please work on it and fix it ASAP.

(gdb trace).

Program received signal SIGSEGV, Segmentation fault.
[Switching to Thread -1210526016 (LWP 5241)]
0xb7ef2bd2 in _dict_lookup (this=0x80c6d38,
key=0x80c6c80 "trusted.glusterfs.afr.entry-pending")
at ../../../glusterfs--mainline--3.0/libglusterfs/src/dict.c:201
201 if (pair->key && !strcmp (pair->key, key))
(gdb) p *pair
Cannot access memory at address 0xffffff2e
(gdb) p *this
$1 = {is_static = 0 '\0', hash_size = 1, count = 1, refcount = 2,
members = 0x8058630, members_list = 0x8057d10, extra_free = 0x8058480 "",
lock = 0}
(gdb) p *this->members_list
$2 = {hash_next = 0x0, prev = 0x0, next = 0x0, value = 0x80c6c60,
key = 0x80c6c80 "trusted.glusterfs.afr.entry-pending"}
(gdb) p *this->members[1]
Cannot access memory at address 0xffffffff
(gdb) p *this->members[0]
Cannot access memory at address 0xffffff2e
(gdb) bt
#0 0xb7ef2bd2 in _dict_lookup (this=0x80c6d38,
key=0x80c6c80 "trusted.glusterfs.afr.entry-pending")
at ../../../glusterfs--mainline--3.0/libglusterfs/src/dict.c:201
#1 0xb7ef2cae in _dict_set (this=0x80c6d38,
key=0x80c6c80 "trusted.glusterfs.afr.entry-pending", value=0x80c6ca8)
at ../../../glusterfs--mainline--3.0/libglusterfs/src/dict.c:226
#2 0xb7ef2f4b in dict_set (this=0x80c6d38,
key=0x80c6c80 "trusted.glusterfs.afr.entry-pending", value=0x80c6ca8)
at ../../../glusterfs--mainline--3.0/libglusterfs/src/dict.c:284
#3 0xb7ef61e3 in dict_set_bin (this=0x80c6d38,
key=0x80c6c80 "trusted.glusterfs.afr.entry-pending", ptr=0x80c6ed8, size=8)
at ../../../glusterfs--mainline--3.0/libglusterfs/src/dict.c:1913
#4 0xb7f31059 in posix_xattrop_common (frame=0x8057ce0, this=0x8054f00,
handle={loc = 0x80c6f68, fd = 0x0}, optype=GF_XATTROP_ADD_ARRAY,
xattr=0x80c6d38)
at ../../../../../glusterfs--mainline--3.0/xlators/storage/posix/src/posix.c:2639
#5 0xb7f3119d in posix_xattrop (frame=0x8057ce0, this=0x8054f00,
loc=0x80c6f68, optype=GF_XATTROP_ADD_ARRAY, xattr=0x80c6d38)
at ../../../../../glusterfs--mainline--3.0/xlators/storage/posix/src/posix.c:2674
#6 0xb7eff888 in default_xattrop (frame=0x8057c98, this=0x8055538,
loc=0x80c6f68, flags=GF_XATTROP_ADD_ARRAY, dict=0x80c6d38)
at ../../../glusterfs--mainline--3.0/libglusterfs/src/defaults.c:1026
#7 0xb7d34081 in server_xattrop_resume (frame=0x80c6df0, this=0x80556b0,
loc=0x80c6f68, flags=GF_XATTROP_ADD_ARRAY, dict=0x80c6d38)
at ../../../../../glusterfs--mainline--3.0/xlators/protocol/server/src/server-protocol.c:4761
#8 0xb7f0e012 in call_resume_wind (stub=0x80c6f50)
at ../../../glusterfs--mainline--3.0/libglusterfs/src/call-stub.c:2529
#9 0xb7f10734 in call_resume (stub=0x80c6f50)
at ../../../glusterfs--mainline--3.0/libglusterfs/src/call-stub.c:3387
#10 0xb7d343cc in server_xattrop (frame=0x80c6df0, bound_xl=0x8055538,
hdr=0x80c6e40, hdrlen=106, buf=0x0, buflen=0)
at ../../../../../glusterfs--mainline--3.0/xlators/protocol/server/src/server-protocol.c:4829
#11 0xb7d3b670 in protocol_server_interpret (this=0x80556b0, trans=0x80579b8,
hdr_p=0x80c6e40 "", hdrlen=106, buf=0x0, buflen=0)
at ../../../../../glusterfs--mainline--3.0/xlators/protocol/server/src/server-protocol.c:7560
#12 0xb7d3cba7 in protocol_server_pollin (this=0x80556b0, trans=0x80579b8)
at ../../../../../glusterfs--mainline--3.0/xlators/protocol/server/src/server-protocol.c:8001
#13 0xb7d3ccd0 in notify (this=0x80556b0, event=2, data=0x80579b8)
at ../../../../../glusterfs--mainline--3.0/xlators/protocol/server/src/server-protocol.c:8053
#14 0xb751ebd4 in socket_event_poll_in (this=0x80579b8)
at ../../../../glusterfs--mainline--3.0/transport/socket/src/socket.c:678
#15 0xb751eecd in socket_event_handler (fd=11, idx=2, data=0x80579b8,
poll_in=1, poll_out=0, poll_err=0)
at ../../../../glusterfs--mainline--3.0/transport/socket/src/socket.c:778
#16 0xb7f14927 in event_dispatch_epoll_handler (event_pool=0x80500e8,
events=0x8056b18, i=1)
at ../../../glusterfs--mainline--3.0/libglusterfs/src/event.c:804
#17 0xb7f14ae6 in event_dispatch_epoll (event_pool=0x80500e8)
at ../../../glusterfs--mainline--3.0/libglusterfs/src/event.c:867
#18 0xb7f14de0 in event_dispatch (event_pool=0x80500e8)
at ../../../glusterfs--mainline--3.0/libglusterfs/src/event.c:975
#19 0x0804c793 in main (argc=6, argv=0xbfe55104)
at ../../../glusterfs--mainline--3.0/glusterfsd/src/glusterfsd.c:1123

Just a 'touch <filename>' is enough to cause the segfault.

Amar Tumballi <amarts>
Project Member
Fri 06 Feb 2009 06:09:58 PM UTC, original submission:

I'm seeing an issue with patch-898 where any writes to the server will crash.. Might this be something with the locking? I'm unable to reproduce removing the AFR section from my Client.
Command used to reproduce: dd if=/dev/zero of=disktest count=1000 bs=1k

Crash chances are greater when one of the servers isn't responding.

Here is the client config.

volume bricktest02
type protocol/client
option transport-type tcp/client
option remote-host 192.168.201.102
option remote-subvolume bricktest
option remote-port 6997
end-volume

volume bricktest03
type protocol/client
option transport-type tcp/client
option remote-host 192.168.201.103
option remote-subvolume bricktest
option remote-port 6997
end-volume

volume afr
type cluster/replicate
option data-self-heal on
option metadata-self-heal on
option entry-self-heal on
subvolumes bricktest02 bricktest03
end-volume

volume writebehind
type performance/write-behind
option aggregate-size 131072 # default is 0bytes
option flush-behind on
subvolumes afr
end-volume

volume io-cache
type performance/io-cache
option cache-size 512MB # default is 32MB
option page-size 1MB #128KB is default option
# option priority .h:3,.html:2,:1 # default is ':0'
option cache-timeout 10 # default is 1 second
subvolumes writebehind
end-volume

2009-02-06 11:41:43 D [glusterfsd.c:329:_get_specfp] glusterfs: loading volume file /etc/glusterfs/glusterfs-server-test.vol
================================================================================
Version : glusterfs 2.0.0tla built on Feb 6 2009 10:37:56
TLA Revision : glusterfs--mainline--3.0--patch-898
Starting Time: 2009-02-06 11:41:43
Command line : /usr/local/glusterfs-mainline-3.0-898/sbin/glusterfsd -f /etc/glusterfs/glusterfs-server-test.vol -L DEBUG
PID : 9244
System name : Linux
Nodename : farm02
Kernel Release : 2.6.18-6-686-bigmem
Hardware Identifier: i686

Given volfile:
+------------------------------------------------------------------------------+
1: volume bricktest-posix
2: type storage/posix
3: option directory /media/sda6/bricktest
4: end-volume
5:
6: volume bricktest-posix-locks
7: type features/posix-locks
8: subvolumes bricktest-posix
9: end-volume
10:
11: volume bricktest
12: type performance/io-threads
13: option thread-count 4
14: subvolumes bricktest-posix-locks
15: # subvolumes bricktest-posix
16: end-volume
17:
18: ### Add network serving capability to above brick.
19: volume server
20: type protocol/server
21: option listen-port 6997
22: option transport-type tcp/server # For TCP/IP transport
23: option auth.ip.bricktest.allow 127.0.0.1,192.168.*
24: subvolumes bricktest
25: end-volume

+------------------------------------------------------------------------------+
2009-02-06 11:41:43 D [spec.y:187:new_section] parser: New node for 'bricktest-posix'
2009-02-06 11:41:43 D [xlator.c:430:xlator_set_type] xlator: attempt to load file /usr/local/glusterfs-mainline-3.0-898/lib/glusterfs/2.0.0tla/xlator/storage/posix.so
2009-02-06 11:41:43 D [spec.y:213:section_type] parser: Type:bricktest-posix:storage/posix
2009-02-06 11:41:43 D [spec.y:288:section_option] parser: Option:bricktest-posix:directory:/media/sda6/bricktest
2009-02-06 11:41:43 D [spec.y:372:section_end] parser: end:bricktest-posix
2009-02-06 11:41:43 D [spec.y:187:new_section] parser: New node for 'bricktest-posix-locks'
2009-02-06 11:41:43 D [xlator.c:430:xlator_set_type] xlator: attempt to load file /usr/local/glusterfs-mainline-3.0-898/lib/glusterfs/2.0.0tla/xlator/features/posix-locks.so
2009-02-06 11:41:43 D [xlator.c:470:xlator_set_type] xlator: dlsym(notify) on /usr/local/glusterfs-mainline-3.0-898/lib/glusterfs/2.0.0tla/xlator/features/posix-locks.so: undefined symbol: notify -- neglecting
2009-02-06 11:41:43 D [spec.y:213:section_type] parser: Type:bricktest-posix-locks:features/posix-locks
2009-02-06 11:41:43 D [spec.y:357:section_sub] parser: child:bricktest-posix-locks->bricktest-posix
2009-02-06 11:41:43 D [spec.y:372:section_end] parser: end:bricktest-posix-locks
2009-02-06 11:41:43 D [spec.y:187:new_section] parser: New node for 'bricktest'
2009-02-06 11:41:43 D [xlator.c:430:xlator_set_type] xlator: attempt to load file /usr/local/glusterfs-mainline-3.0-898/lib/glusterfs/2.0.0tla/xlator/performance/io-threads.so
2009-02-06 11:41:43 D [xlator.c:470:xlator_set_type] xlator: dlsym(notify) on /usr/local/glusterfs-mainline-3.0-898/lib/glusterfs/2.0.0tla/xlator/performance/io-threads.so: undefined symbol: notify -- neglecting
2009-02-06 11:41:43 D [spec.y:213:section_type] parser: Type:bricktest:performance/io-threads
2009-02-06 11:41:43 D [spec.y:288:section_option] parser: Option:bricktest:thread-count:4
2009-02-06 11:41:43 D [spec.y:357:section_sub] parser: child:bricktest->bricktest-posix-locks
2009-02-06 11:41:43 D [spec.y:372:section_end] parser: end:bricktest
2009-02-06 11:41:43 D [spec.y:187:new_section] parser: New node for 'server'
2009-02-06 11:41:43 D [xlator.c:430:xlator_set_type] xlator: attempt to load file /usr/local/glusterfs-mainline-3.0-898/lib/glusterfs/2.0.0tla/xlator/protocol/server.so
2009-02-06 11:41:43 D [spec.y:213:section_type] parser: Type:server:protocol/server
2009-02-06 11:41:43 D [spec.y:288:section_option] parser: Option:server:listen-port:6997
2009-02-06 11:41:43 D [spec.y:288:section_option] parser: Option:server:transport-type:tcp/server
2009-02-06 11:41:43 D [spec.y:288:section_option] parser: Option:server:auth.ip.bricktest.allow:127.0.0.1,192.168.*
2009-02-06 11:41:43 D [spec.y:357:section_sub] parser: child:server->bricktest
2009-02-06 11:41:43 D [spec.y:372:section_end] parser: end:server
2009-02-06 11:41:43 D [glusterfsd.c:1100:main] glusterfs: running in pid 9245
2009-02-06 11:41:43 D [xlator.c:560:xlator_init_rec] bricktest-posix: Initialization done
2009-02-06 11:41:43 D [xlator.c:560:xlator_init_rec] bricktest-posix-locks: Initialization done
2009-02-06 11:41:43 D [io-threads.c:1179:init] io-threads: Using conf->thread_count = 4
2009-02-06 11:41:43 D [xlator.c:560:xlator_init_rec] bricktest: Initialization done
2009-02-06 11:41:43 D [io-threads.c:1179:init] io-threads: Using conf->thread_count = 4
2009-02-06 11:41:43 D [xlator.c:560:xlator_init_rec] bricktest: Initialization done
2009-02-06 11:41:43 D [transport.c:141:transport_load] transport: attempt to load file /usr/local/glusterfs-mainline-3.0-898/lib/glusterfs/2.0.0tla/transport/socket.so
2009-02-06 11:41:43 W [xlator.c:391:validate_xlator_volume_options] server: option 'listen-port' is deprecated, preferred is 'transport.socket.listen-port', continuing with correction
2009-02-06 11:41:43 D [xlator.c:152:_volume_option_value_validate] server: no range check required for 'option transport.socket.listen-port 6997'
2009-02-06 11:41:43 W [server-protocol.c:7785:get_auth_types] server: assuming 'auth.ip' to be 'auth.addr'
2009-02-06 11:41:43 D [server-protocol.c:7915:init] server: defaulting limits.transaction-size to 4194304
2009-02-06 11:41:46 D [addr.c:174:gf_auth] bricktest: allowed = "127.0.0.1", received addr = "192.168.201.101"
2009-02-06 11:41:46 D [addr.c:174:gf_auth] bricktest: allowed = "192.168.*", received addr = "192.168.201.101"
2009-02-06 11:41:46 N [server-protocol.c:7133:mop_setvolume] server: accepted client from 192.168.201.101:1017
2009-02-06 11:41:46 D [server-protocol.c:7179:mop_setvolume] server: creating inode table with lru_limit=1024, xlator=bricktest
2009-02-06 11:41:46 D [inode.c:990:inode_table_new] bricktest: creating new inode table with lru_limit=1024
2009-02-06 11:41:46 D [inode.c:455:__inode_create] bricktest/inode: create inode(0)
2009-02-06 11:41:48 D [inode.c:280:__inode_activate] bricktest/inode: activating inode(1), lru=0/1024 active=1 purge=0
2009-02-06 11:41:48 D [inode.c:455:__inode_create] bricktest/inode: create inode(0)
2009-02-06 11:41:48 D [inode.c:280:__inode_activate] bricktest/inode: activating inode(0), lru=0/1024 active=2 purge=0
2009-02-06 11:41:48 D [server-protocol.c:3537:server_lookup_resume] bricktest: 20: LOOKUP '1/disktest'
2009-02-06 11:41:48 D [inode.c:94:__dentry_hash] bricktest/inode: dentry hashed disktest (14237699)
2009-02-06 11:41:48 D [inode.c:299:__inode_passivate] bricktest/inode: passivating inode(14237699) lru=1/1024 active=1 purge=0
2009-02-06 11:41:49 D [inode.c:280:__inode_activate] bricktest/inode: activating inode(14237699), lru=0/1024 active=2 purge=0
2009-02-06 11:41:49 D [server-protocol.c:3537:server_lookup_resume] bricktest: 22: LOOKUP '1/disktest'
2009-02-06 11:41:49 D [inode.c:299:__inode_passivate] bricktest/inode: passivating inode(14237699) lru=1/1024 active=1 purge=0
2009-02-06 11:41:56 D [inode.c:280:__inode_activate] bricktest/inode: activating inode(14237699), lru=0/1024 active=2 purge=0
2009-02-06 11:41:56 D [server-protocol.c:3537:server_lookup_resume] bricktest: 23: LOOKUP '1/disktest'
2009-02-06 11:41:56 D [inode.c:299:__inode_passivate] bricktest/inode: passivating inode(14237699) lru=1/1024 active=1 purge=0
2009-02-06 11:41:56 D [inode.c:280:__inode_activate] bricktest/inode: activating inode(14237699), lru=0/1024 active=2 purge=0
2009-02-06 11:41:56 D [server-protocol.c:5812:server_inodelk_resume] bricktest: 24: INODELK '/disktest (14237699)'
2009-02-06 11:41:56 D [internal.c:191:pl_inodelk_common] bricktest-posix-locks: lock (pid=18628) 0 - 0 => OK
2009-02-06 11:41:56 D [server-protocol.c:4759:server_xattrop_resume] bricktest: 25: XATTROP '/disktest (14237699)'
2009-02-06 11:41:56 D [server-protocol.c:4413:server_truncate_resume] bricktest: 26: TRUNCATE '/disktest (14237699)'
2009-02-06 11:41:56 D [server-protocol.c:4759:server_xattrop_resume] bricktest: 27: XATTROP '/disktest (14237699)'
2009-02-06 11:41:56 D [server-protocol.c:3938:server_open_resume] bricktest: 28: OPEN '/disktest (14237699)'
2009-02-06 11:41:56 D [server-protocol.c:5812:server_inodelk_resume] bricktest: 29: INODELK '/disktest (14237699)'
2009-02-06 11:41:56 D [server-protocol.c:5955:server_finodelk] bricktest: 30: FINODELK 'fd=0 (14237699)'
2009-02-06 11:41:56 D [internal.c:191:pl_inodelk_common] bricktest-posix-locks: lock (pid=18628) 0 - 1024 => OK
2009-02-06 11:41:56 D [server-protocol.c:4725:server_fxattrop] bricktest: 31: FXATTROP 'fd=0 (14237699)'
pending frames:

patchset: glusterfs--mainline--3.0--patch-898
signal received: 11
configuration details:argp 1
backtrace 1
dlfcn 1
fdatasync 1
libpthread 1
llistxattr 1
setfsid 1
spinlock 1
epoll.h 1
xattr.h 1
st_atim.tv_nsec 1
package-string: glusterfs 2.0.0tla
[0xb7fa9420]
/lib/tls/i686/cmov/libc.so.6[0xb7e93d28]
/lib/tls/i686/cmov/libc.so.6(malloc+0x7f)[0xb7e959ef]
/usr/local/glusterfs-mainline-3.0-898/lib/glusterfs/2.0.0tla/transport/socket.so[0xb55a6394]
/usr/local/glusterfs-mainline-3.0-898/lib/libglusterfs.so.0[0xb7f9df29]
/usr/local/glusterfs-mainline-3.0-898/lib/libglusterfs.so.0(event_dispatch+0x21)[0xb7f9cd81]
/usr/local/glusterfs-mainline-3.0-898/sbin/glusterfsd(main+0xb47)[0x804afe7]
/lib/tls/i686/cmov/libc.so.6(__libc_start_main+0xc8)[0xb7e42ea8]
/usr/local/glusterfs-mainline-3.0-898/sbin/glusterfsd[0x8049a61]

Cory Meyer <yrock>

 

(Note: upload size limit is set to 16384 kB, after insertion of the required escape characters.)

Attach File(s):
   
   
Comment:
   

No files currently attached

 

Depends on the following items: None found

Items that depend on this one: None found

 

Carbon-Copy List
  • -unavailable- added by gowda (Posted a comment)
  • -unavailable- added by findepi
  • -unavailable- added by amarts (Posted a comment)
  • -unavailable- added by yrock (Submitted the item)
  •  

    Do you think this task is very important?
    If so, you can click here to add your encouragement to it.
    This task has 0 encouragements so far.

    Only logged-in users can vote.

     

    Please enter the title of George Orwell's famous dystopian book (it's a date):

     

     

    Follow 17 latest changes.

    Date Changed By Updated Field Previous Value => Replaced By
    Wed 24 Jun 2009 05:00:18 AM UTCgowdaOpen/ClosedOpen=>Closed
    Wed 24 Jun 2009 05:00:17 AM UTCgowdaStatusConfirmed=>Fixed
    Tue 03 Mar 2009 10:58:13 AM UTCfindepiCarbon-Copy-=>Added findepi
    Tue 03 Mar 2009 10:58:06 AM UTCfindepiCarbon-CopyRemoved -unavailable-=>-
    Tue 03 Mar 2009 10:55:14 AM UTCfindepiCarbon-Copy-=>Added -unavailable-
    Fri 13 Feb 2009 01:36:44 AM UTCamartsItem GroupCrash=>Improper behaviour
      Assigned toamarts=>vikasgp
      Releaseglusterfs--mainline--3.0--patch-902=>glusterfs--mainline--3.0--patch-912
    Mon 09 Feb 2009 07:12:45 PM UTCamartsStatusFixed=>Confirmed
      Open/ClosedClosed=>Open
      Releaseglusterfs--mainline--3.0--patch-898=>glusterfs--mainline--3.0--patch-902
    Fri 06 Feb 2009 08:03:05 PM UTCamartsStatusConfirmed=>Fixed
      Assigned tovikasgp=>amarts
      Open/ClosedOpen=>Closed
    Fri 06 Feb 2009 06:39:52 PM UTCamartsStatusNone=>Confirmed
      Assigned toNone=>vikasgp
      Originator Name=>cory

    Back to the top


    Powered by Savane 3.1-cleanup1