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]
|
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) {
|
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.
|
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]
|