Am Mittwoch, 27. September 2006 16:40 schrieb Herbert Poetzl:
> > H242-meier vserver.nfs # sysctl -a | grep sun
> > error: "Operation not permitted" reading key "net.ipv4.route.flush"
> > sunrpc.tcp_slot_table_entries = 16
> > sunrpc.udp_slot_table_entries = 16
> > sunrpc.nlm_debug = 0
> > sunrpc.nfsd_debug = 1
> > sunrpc.nfs_debug = 0
> > sunrpc.rpc_debug = 1
>
> different values here will enable different debug
> output, I would prefer something like 65535 there
> (which will enable full output)
The setting on the nfs-server:
H242-meier ~ # sysctl -a | grep sun
error: "Operation not permitted" reading key "net.ipv4.route.flush"
sunrpc.tcp_slot_table_entries = 16
sunrpc.udp_slot_table_entries = 16
sunrpc.nlm_debug = 0
sunrpc.nfsd_debug = 65535
sunrpc.nfs_debug = 0
sunrpc.rpc_debug = 65535
H242-meier ~ #
The log on the nfs-server:
Sep 28 07:55:31 H242-meier device vmnet1 entered promiscuous mode
Sep 28 07:55:49 H242-meier rpc.mountd: MNT3(/home) called
Sep 28 07:55:49 H242-meier rpc.mountd: authenticated mount request from
vs01:1009 for /home ( /home)
Sep 28 07:55:50 H242-meier nfsd: exp_rootfh(/home [f235c628] *:hda2/2277377)
Sep 28 07:55:50 H242-meier nfsd: fh_compose(exp 03:02/2277377 //home,
ino=2277377)
Sep 28 07:56:09 H242-meier device vmnet1 left promiscuous mode
The settings on the vserver-host:
gs ~ # sysctl -a | grep sun
error: "Success" reading key "dev.parport.parport0.autoprobe3"
error: "Success" reading key "dev.parport.parport0.autoprobe2"
error: "Success" reading key "dev.parport.parport0.autoprobe1"
error: "Success" reading key "dev.parport.parport0.autoprobe0"
error: "Success" reading key "dev.parport.parport0.autoprobe"
error: "Operation not permitted" reading key "net.ipv4.route.flush"
sunrpc.max_resvport = 1023
sunrpc.min_resvport = 650
sunrpc.tcp_slot_table_entries = 16
sunrpc.udp_slot_table_entries = 16
sunrpc.nlm_debug = 0
sunrpc.nfsd_debug = 0
sunrpc.nfs_debug = 65535
sunrpc.rpc_debug = 65535
gs ~ #
The log on the vserver-host:
Sep 27 22:13:18 gs rpciod_up: users 0
Sep 27 22:13:18 gs RPC: setting up tcp-ipv4 transport...
Sep 27 22:13:18 gs RPC: created transport cf91b400 with 16 slots
Sep 27 22:13:18 gs RPC: xprt_create_proto created xprt cf91b400
Sep 27 22:13:18 gs RPC: creating nfs client for 192.168.39.1 (xprt cf91b400)
Sep 27 22:13:18 gs RPC: destroying transport cf91b400
Sep 27 22:13:18 gs RPC: xs_destroy xprt cf91b400
Sep 27 22:13:18 gs RPC: disconnected transport cf91b400
Sep 27 22:13:18 gs nfs_create_client: cannot create RPC client. Error
= -812534784
Sep 27 22:13:18 gs rpciod_down sema 1
Sep 27 22:13:18 gs nfs_get_sb: bad mount version
( ^^^^^^^^^^^^^^^^)
This doesn't semm to look good?
Attached the tcpdump.
>
> could you try with a v3,tcp mount too?
The trace of the mount inside the vs:
vs01 / # strace mount 192.168.39.1:/home /home -o nfsvers=3,nolock,tcp
execve("/bin/mount",
["mount", "192.168.39.1:/home", "/home", "-o", "nfsvers=3,nolock,tcp"], [/*
26 vars */]) = 0
uname({sys="Linux", node="vs01", ...}) = 0
brk(0) = 0x8063000
access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or
directory)
open("/etc/ld.so.cache", O_RDONLY) = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=12117, ...}) = 0
mmap2(NULL, 12117, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7f4e000
close(3) = 0
open("/lib/libblkid.so.1", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\0\35\0"..., 512) =
512
fstat64(3, {st_mode=S_IFREG|0755, st_size=28764, ...}) = 0
mmap2(NULL, 30740, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) =
0xb7f46000
mmap2(0xb7f4d000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_DENYWRITE, 3, 0x6) = 0xb7f4d000
close(3) = 0
open("/lib/libuuid.so.1", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\320\n\0"..., 512) =
512
fstat64(3, {st_mode=S_IFREG|0755, st_size=9600, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0xb7f45000
mmap2(NULL, 11544, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) =
0xb7f42000
mmap2(0xb7f44000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_DENYWRITE, 3, 0x1) = 0xb7f44000
close(3) = 0
open("/lib/libc.so.6", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\240T\1"..., 512) =
512
fstat64(3, {st_mode=S_IFREG|0755, st_size=1220000, ...}) = 0
mmap2(NULL, 1158452, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) =
0xb7e27000
mmap2(0xb7f3c000, 16384, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_DENYWRITE, 3, 0x115) = 0xb7f3c000
mmap2(0xb7f40000, 7476, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|
MAP_ANONYMOUS, -1, 0) = 0xb7f40000
close(3) = 0
mprotect(0xb7f3c000, 4096, PROT_READ) = 0
mprotect(0xb7f64000, 4096, PROT_READ) = 0
munmap(0xb7f4e000, 12117) = 0
open("/dev/urandom", O_RDONLY) = 3
read(3, "\272\322(\335", 4) = 4
close(3) = 0
brk(0) = 0x8063000
brk(0x8084000) = 0x8084000
open("/dev/null", O_RDWR|O_LARGEFILE) = 3
close(3) = 0
getuid32() = 0
geteuid32() = 0
getgid32() = 0
getegid32() = 0
prctl(0x3, 0x20, 0xbfad7468, 0x5, 0xbfad7624) = 1
open("/etc/blkid.tab", O_RDONLY) = -1 ENOENT (No such file or
directory)
getuid32() = 0
geteuid32() = 0
lstat64("/etc/mtab", {st_mode=S_IFREG|0644, st_size=298, ...}) = 0
stat64("192.168.39.1:/home", 0xbfad73c0) = -1 ENOENT (No such file or
directory)
stat64("/sbin/mount.nfs", 0xbfad72b0) = -1 ENOENT (No such file or
directory)
uname({sys="Linux", node="vs01", ...}) = 0
time(NULL) = 1159387997
socket(PF_INET, SOCK_STREAM, IPPROTO_TCP) = 3
getpid() = 13128
bind(3, {sa_family=AF_INET, sin_port=htons(1008),
sin_addr=inet_addr("0.0.0.0")}, 16) = 0
connect(3, {sa_family=AF_INET, sin_port=htons(111),
sin_addr=inet_addr("192.168.39.1")}, 16) = 0
gettimeofday({1159387997, 896879}, NULL) = 0
write(3, "\200\0\0(\20\232d\23\0\0\0\0\0\0\0\2\0\1\206\240\0\0\0"..., 44) = 44
poll([{fd=3, events=POLLIN, revents=POLLIN}], 1, 60000) = 1
read(3, "\0\0\1\214\20\232d\23\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 500) =
500
poll([{fd=3, events=POLLIN, revents=POLLIN}], 1, 60000) = 1
read(3, "\0\0\0\3\0\0\0\6\0\0\2\371\0\0\0\0", 500) = 16
close(3) = 0
socket(PF_INET, SOCK_STREAM, IPPROTO_TCP) = 3
bind(3, {sa_family=AF_INET, sin_port=htons(1009),
sin_addr=inet_addr("0.0.0.0")}, 16) = 0
connect(3, {sa_family=AF_INET, sin_port=htons(761),
sin_addr=inet_addr("192.168.39.1")}, 16) = 0
uname({sys="Linux", node="vs01", ...}) = 0
geteuid32() = 0
getegid32() = 0
getgroups32(0, NULL) = 11
getgroups32(11, [0, 1, 2, 3, 4, 6, 10, 11, 20, 26, 27]) = 11
gettimeofday({1159387997, 908258}, NULL) = 0
write(3, "\200\0\0x\\\361\30\1\0\0\0\0\0\0\0\2\0\1\206\245\0\0\0"..., 124) =
124
poll([{fd=3, events=POLLIN, revents=POLLIN}], 1, 20000) = 1
read(3, "\200\0\0008\\\361\30\1\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0\0"..., 4000) =
60
socket(PF_INET, SOCK_STREAM, IPPROTO_TCP) = 4
bind(4, {sa_family=AF_INET, sin_port=htons(1010),
sin_addr=inet_addr("0.0.0.0")}, 16) = 0
socket(PF_INET, SOCK_STREAM, IPPROTO_TCP) = 5
bind(5, {sa_family=AF_INET, sin_port=htons(1011),
sin_addr=inet_addr("0.0.0.0")}, 16) = 0
connect(5, {sa_family=AF_INET, sin_port=htons(111),
sin_addr=inet_addr("192.168.39.1")}, 16) = 0
write(5, "\200\0\0008,\225\237\267\0\0\0\0\0\0\0\2\0\1\206\240\0"..., 60) = 60
poll([{fd=5, events=POLLIN, revents=POLLIN}], 1, 60000) = 1
read(5, "\200\0\0\34,\225\237\267\0\0\0\1\0\0\0\0\0\0\0\0\0\0\0"..., 400) = 32
close(5) = 0
uname({sys="Linux", node="vs01", ...}) = 0
close(3) = 0
close(3) = -1 EBADF (Bad file descriptor)
rt_sigprocmask(SIG_BLOCK, ~[TRAP SEGV], NULL, 8) = 0
mount("192.168.39.1:/home", "/home", "nfs", MS_MGC_VAL, "\4") = -1 EPERM
(Operation not permitted)
rt_sigprocmask(SIG_UNBLOCK, ~[TRAP SEGV], NULL, 8) = 0
write(2, "NFSv3 not supported!\n", 21NFSv3 not supported!
) = 21
rt_sigprocmask(SIG_BLOCK, ~[TRAP SEGV], NULL, 8) = 0
mount("192.168.39.1:/home", "/home", "nfs", MS_MGC_VAL, "") = -1 EINVAL
(Invalid argument)
rt_sigprocmask(SIG_UNBLOCK, ~[TRAP SEGV], NULL, 8) = 0
write(2, "mount: wrong fs type, bad option"..., 111mount: wrong fs type, bad
option, bad superblock on 192.168.39.1:/home,
missing codepage or other error
) = 111
stat64("192.168.39.1:/home", 0xbfad7310) = -1 ENOENT (No such file or
directory)
write(2, " In some cases useful info"..., 86 In some cases useful
info is found in syslog - try
dmesg | tail or so
) = 86
exit_group(32) = ?
Process 13128 detached
vs01 / #
HTH,
Wilhelm
07:55:49.937932 IP vs01.1008 > h242-meier-1.sunrpc: S 638026099:638026099(0)
win 5840 <mss 1460,sackOK,timestamp 1782618[|tcp]>
07:55:49.955931 IP h242-meier-1.sunrpc > vs01.1008: S 1737240269:1737240269(0)
ack 638026100 win 5792 <mss 1460,sackOK,timestamp 4375398[|tcp]>
07:55:49.955955 IP vs01.1008 > h242-meier-1.sunrpc: . ack 1 win 730
<nop,nop,timestamp 1782618 4375398>
07:55:49.955965 IP vs01.1008 > h242-meier-1.sunrpc: P 1:45(44) ack 1 win 730
<nop,nop,timestamp 1782618 4375398>
07:55:49.955976 IP h242-meier-1.sunrpc > vs01.1008: . ack 45 win 1448
<nop,nop,timestamp 4375398 1782618>
07:55:49.938151 IP h242-meier-1.sunrpc > vs01.1008: P 1:401(400) ack 45 win
1448 <nop,nop,timestamp 4375398 1782618>
07:55:49.938896 IP vs01.1008 > h242-meier-1.sunrpc: . ack 401 win 864
<nop,nop,timestamp 1782619 4375398>
07:55:49.938908 IP h242-meier-1.sunrpc > vs01.1008: P 401:517(116) ack 45 win
1448 <nop,nop,timestamp 4375398 1782619>
07:55:49.938975 IP vs01.1008 > h242-meier-1.sunrpc: . ack 517 win 864
<nop,nop,timestamp 1782619 4375398>
07:55:49.943725 IP vs01.1008 > h242-meier-1.sunrpc: F 45:45(0) ack 517 win 864
<nop,nop,timestamp 1782620 4375398>
07:55:49.945060 IP vs01.1009 > h242-meier-1.761: S 636815029:636815029(0) win
5840 <mss 1460,sackOK,timestamp 1782621[|tcp]>
07:55:49.945079 IP h242-meier-1.761 > vs01.1009: S 1745412483:1745412483(0) ack
636815030 win 5792 <mss 1460,sackOK,timestamp 4375399[|tcp]>
07:55:49.945144 IP vs01.1009 > h242-meier-1.761: . ack 1 win 730
<nop,nop,timestamp 1782621 4375399>
07:55:49.947434 IP vs01.1009 > h242-meier-1.761: P 1:125(124) ack 1 win 730
<nop,nop,timestamp 1782621 4375399>
07:55:49.947444 IP h242-meier-1.761 > vs01.1009: . ack 125 win 1448
<nop,nop,timestamp 4375399 1782621>
07:55:49.951286 IP h242-meier-1.sunrpc > vs01.1008: F 517:517(0) ack 46 win
1448 <nop,nop,timestamp 4375400 1782620>
07:55:49.951410 IP vs01.1008 > h242-meier-1.sunrpc: . ack 518 win 864
<nop,nop,timestamp 1782622 4375400>
07:55:50.072653 IP h242-meier-1.761 > vs01.1009: P 1:61(60) ack 125 win 1448
<nop,nop,timestamp 4375412 1782621>
07:55:50.072931 IP vs01.1009 > h242-meier-1.761: . ack 61 win 730
<nop,nop,timestamp 1782643 4375412>
07:55:50.075634 IP vs01.1011 > h242-meier-1.sunrpc: S 640167369:640167369(0)
win 5840 <mss 1460,sackOK,timestamp 1782643[|tcp]>
07:55:50.075653 IP h242-meier-1.sunrpc > vs01.1011: S 1745740107:1745740107(0)
ack 640167370 win 5792 <mss 1460,sackOK,timestamp 4375412[|tcp]>
07:55:50.075729 IP vs01.1011 > h242-meier-1.sunrpc: . ack 1 win 730
<nop,nop,timestamp 1782643 4375412>
07:55:50.076153 IP vs01.1011 > h242-meier-1.sunrpc: P 1:61(60) ack 1 win 730
<nop,nop,timestamp 1782643 4375412>
07:55:50.076163 IP h242-meier-1.sunrpc > vs01.1011: . ack 61 win 1448
<nop,nop,timestamp 4375412 1782643>
07:55:50.076855 IP h242-meier-1.sunrpc > vs01.1011: P 1:33(32) ack 61 win 1448
<nop,nop,timestamp 4375412 1782643>
07:55:50.077703 IP vs01.1011 > h242-meier-1.sunrpc: . ack 33 win 730
<nop,nop,timestamp 1782644 4375412>
07:55:50.078749 IP vs01.1011 > h242-meier-1.sunrpc: F 61:61(0) ack 33 win 730
<nop,nop,timestamp 1782644 4375412>
07:55:50.080544 IP vs01.1009 > h242-meier-1.761: F 125:125(0) ack 61 win 730
<nop,nop,timestamp 1782644 4375412>
07:55:50.081799 IP h242-meier-1.sunrpc > vs01.1011: F 33:33(0) ack 62 win 1448
<nop,nop,timestamp 4375413 1782644>
07:55:50.081958 IP vs01.1011 > h242-meier-1.sunrpc: . ack 34 win 730
<nop,nop,timestamp 1782644 4375413>
07:55:50.092418 IP h242-meier-1.761 > vs01.1009: F 61:61(0) ack 126 win 1448
<nop,nop,timestamp 4375414 1782644>
07:55:50.092843 IP vs01.1009 > h242-meier-1.761: . ack 62 win 730
<nop,nop,timestamp 1782647 4375414>
_______________________________________________
Vserver mailing list
Vserver@list.linux-vserver.org
http://list.linux-vserver.org/mailman/listinfo/vserver
