NFS langsam / Timeouts

german

#1

Hallo,

wir arbeiten in der Firma gerade mit 2 UCCs unsere Testprotokolle ab.
Geplant ist ein Umstieg von 150 UCDs auf das UCC Desktop Image.

Die Imageverteilung erfolgt per PXE (ucc-1.0-rev2-desktop-image.img) über eine UCS Backup 3.1-1.
Per UCC Software-Update-Einstellungen Richtlinie werden automatisch Updates und diverse Pakete installiert, darunter auch nfs-common.

Es ist danach jedoch nicht möglich, NFS Shares zu mounten. Die Shares liegen auf einem RHEL6.4-Cluster.
Testweise wurde auch schon versucht ein Share des UCS Master zu mounten. Auch dies schlug fehl.

Von anderen Systemen (z.B. Mint 15) lässt sich die NFS Freigabe sofort mounten.

Test mit Mint 15:

mint-15 ~ # time showmount -e 10.10.10.1
Export list for 10.10.10.1:
/storage/home *
/home         *

real	0m0.004s
user	0m0.000s
sys	0m0.000s
mint-15 ~ # time mount -v -t nfs -o vers=3 10.10.10.1:/storage/home /mnt/
mount.nfs: timeout set for Mon Aug  5 14:51:21 2013
mount.nfs: trying text-based options 'vers=3,addr=10.10.10.1'
mount.nfs: prog 100003, trying vers=3, prot=6
mount.nfs: trying 10.10.10.1 prog 100003 vers 3 prot TCP port 2049
mount.nfs: prog 100005, trying vers=3, prot=17
mount.nfs: trying 10.10.10.1 prog 100005 vers 3 prot UDP port 32767

real	0m0.064s
user	0m0.004s
sys	0m0.000s

Test mit UCC:

root@ucc-2:~# time showmount -e 10.10.10.1
Export list for 10.10.10.1:
/storage/home *
/home         *

real	1m3.169s
user	0m0.004s
sys	0m0.000s
root@ucc-2:~# time mount -v -t nfs -o vers=3 10.10.10.1:/storage/home /mnt/
mount.nfs: timeout set for Mon Aug  5 17:21:21 2013
mount.nfs: trying text-based options 'vers=3,addr=10.10.10.1'
mount.nfs: prog 100003, trying vers=3, prot=6
mount.nfs: trying 10.10.10.1 prog 100003 vers 3 prot TCP port 2049
mount.nfs: prog 100005, trying vers=3, prot=17
mount.nfs: trying 10.10.10.1 prog 100005 vers 3 prot UDP port 32767
mount.nfs: mount(2): Connection timed out
mount.nfs: Connection timed out

real	4m12.481s
user	0m0.000s
sys	0m0.004s

Firewalls sind nicht aktiv.

Samba-Shares, die auch auf dem Server liegen, kann man z.B. per
root@ucc-2:~# smbclient -L \10.10.10.1 -U Administrator
auflisten lassen.

UCC strace Ausgabe:

root@-ucc-2:~# strace mount -t nfs -o vers=3 10.10.10.1:/storage/home /mnt/
execve("/bin/mount", ["mount", "-t", "nfs", "-o", "vers=3", "10.10.10.1:/storage/home", "/mnt/"], [/* 28 vars */]) = 0
brk(0)                                  = 0x8d34000
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb777e000
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=102869, ...}) = 0
mmap2(NULL, 102869, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7764000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/i386-linux-gnu/libblkid.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0P8\0\0004\0\0\0"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=162044, ...}) = 0
mmap2(NULL, 164784, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb773b000
mmap2(0xb7761000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x25) = 0xb7761000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/i386-linux-gnu/libmount.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`C\0\0004\0\0\0"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=157544, ...}) = 0
mmap2(NULL, 160260, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7713000
mmap2(0xb7739000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x25) = 0xb7739000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/i386-linux-gnu/libselinux.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0@A\0\0004\0\0\0"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=120748, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7712000
mmap2(NULL, 125852, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb76f3000
mmap2(0xb7710000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1c) = 0xb7710000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/i386-linux-gnu/libc.so.6", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0000\226\1\0004\0\0\0"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=1730024, ...}) = 0
mmap2(NULL, 1739484, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb754a000
mmap2(0xb76ed000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1a3) = 0xb76ed000
mmap2(0xb76f0000, 10972, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb76f0000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/i386-linux-gnu/libuuid.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\260\17\0\0004\0\0\0"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=18012, ...}) = 0
mmap2(NULL, 20700, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7544000
mmap2(0xb7548000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3) = 0xb7548000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/i386-linux-gnu/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`\n\0\0004\0\0\0"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=13940, ...}) = 0
mmap2(NULL, 16504, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb753f000
mmap2(0xb7542000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2) = 0xb7542000
close(3)                                = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb753e000
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb753d000
set_thread_area({entry_number:-1 -> 6, base_addr:0xb753d780, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0
mprotect(0xb76ed000, 8192, PROT_READ)   = 0
mprotect(0xb7542000, 4096, PROT_READ)   = 0
mprotect(0xb7548000, 4096, PROT_READ)   = 0
mprotect(0xb7710000, 4096, PROT_READ)   = 0
mprotect(0xb7761000, 8192, PROT_READ)   = 0
mprotect(0xb7739000, 4096, PROT_READ)   = 0
mprotect(0x805d000, 4096, PROT_READ)    = 0
mprotect(0xb77a1000, 4096, PROT_READ)   = 0
munmap(0xb7764000, 102869)              = 0
statfs64("/selinux", 84, {f_type="EXT2_SUPER_MAGIC", f_bsize=4096, f_blocks=3779938, f_bfree=2342369, f_bavail=2150357, f_files=960992, f_ffree=753196, f_fsid={634668869, 1933325416}, f_namelen=255, f_frsize=4096}) = 0
brk(0)                                  = 0x8d34000
brk(0x8d55000)                          = 0x8d55000
open("/proc/filesystems", O_RDONLY|O_LARGEFILE) = 3
fstat64(3, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb777d000
read(3, "nodev\tsysfs\nnodev\trootfs\nnodev\tb"..., 1024) = 380
read(3, "", 1024)                       = 0
close(3)                                = 0
munmap(0xb777d000, 4096)                = 0
open("/usr/lib/locale/locale-archive", O_RDONLY|O_LARGEFILE|O_CLOEXEC) = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=7052736, ...}) = 0
mmap2(NULL, 2097152, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb733d000
mmap2(NULL, 262144, PROT_READ, MAP_PRIVATE, 3, 0x2c8) = 0xb72fd000
mmap2(NULL, 1253376, PROT_READ, MAP_PRIVATE, 3, 0x30a) = 0xb71cb000
close(3)                                = 0
umask(022)                              = 022
open("/dev/null", O_RDWR|O_LARGEFILE)   = 3
close(3)                                = 0
getuid32()                              = 0
geteuid32()                             = 0
stat64("/sbin/mount.nfs", {st_mode=S_IFREG|S_ISUID|0755, st_size=96904, ...}) = 0
clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb753d7e8) = 4041
wait4(-1, mount.nfs: Connection timed out
[{WIFEXITED(s) && WEXITSTATUS(s) == 32}], 0, NULL) = 4041
--- SIGCHLD (Child exited) @ 0 (0) ---
exit_group(32)                          = ?

Jetzt ist die große Frage, warum ein showmount -e über 1 Minute dauert und der eigentliche mount in einen Timeout läuft.

Ich bin für jeden Tipp dankbar.


#2

Hallo,

wenn Sie den strace mit “-t -T” starten, könnte man vielleicht besser sehen, wo es hängt.

Viele Grüße,
Dirk Ahrnke


#3

Hallo,

hier nun strace mit Zeitangaben:

root@ucc-2:~# strace -t -T mount -t nfs -o vers=3 10.10.10.1:/storage/home /mnt/ 10:14:12 execve("/bin/mount", ["mount", "-t", "nfs", "-o", "vers=3", "10.10.10.1:/storage/home", "/mnt/"], [/* 28 vars */]) = 0 <0.000221> 10:14:12 brk(0) = 0x80aa000 <0.000016> 10:14:12 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000018> 10:14:12 mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb776f000 <0.000017> 10:14:12 access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or directory) <0.000034> 10:14:12 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 3 <0.000021> 10:14:12 fstat64(3, {st_mode=S_IFREG|0644, st_size=102869, ...}) = 0 <0.000014> 10:14:12 mmap2(NULL, 102869, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7755000 <0.000017> 10:14:12 close(3) = 0 <0.000014> 10:14:12 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000017> 10:14:12 open("/lib/i386-linux-gnu/libblkid.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000023> 10:14:12 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0P8\0\0004\0\0\0"..., 512) = 512 <0.000017> 10:14:12 fstat64(3, {st_mode=S_IFREG|0644, st_size=162044, ...}) = 0 <0.000014> 10:14:12 mmap2(NULL, 164784, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb772c000 <0.000019> 10:14:12 mmap2(0xb7752000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x25) = 0xb7752000 <0.000026> 10:14:12 close(3) = 0 <0.000030> 10:14:12 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000017> 10:14:12 open("/lib/i386-linux-gnu/libmount.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000023> 10:14:12 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`C\0\0004\0\0\0"..., 512) = 512 <0.000016> 10:14:12 fstat64(3, {st_mode=S_IFREG|0644, st_size=157544, ...}) = 0 <0.000014> 10:14:12 mmap2(NULL, 160260, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7704000 <0.000017> 10:14:12 mmap2(0xb772a000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x25) = 0xb772a000 <0.000024> 10:14:12 close(3) = 0 <0.000014> 10:14:12 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000020> 10:14:12 open("/lib/i386-linux-gnu/libselinux.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000034> 10:14:12 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0@A\0\0004\0\0\0"..., 512) = 512 <0.000017> 10:14:12 fstat64(3, {st_mode=S_IFREG|0644, st_size=120748, ...}) = 0 <0.000011> 10:14:12 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7703000 <0.000013> 10:14:12 mmap2(NULL, 125852, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb76e4000 <0.000013> 10:14:12 mmap2(0xb7701000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1c) = 0xb7701000 <0.000018> 10:14:12 close(3) = 0 <0.000010> 10:14:12 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000013> 10:14:12 open("/lib/i386-linux-gnu/libc.so.6", O_RDONLY|O_CLOEXEC) = 3 <0.000016> 10:14:12 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0000\226\1\0004\0\0\0"..., 512) = 512 <0.000012> 10:14:12 fstat64(3, {st_mode=S_IFREG|0755, st_size=1730024, ...}) = 0 <0.000016> 10:14:12 mmap2(NULL, 1739484, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb753b000 <0.000013> 10:14:12 mmap2(0xb76de000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1a3) = 0xb76de000 <0.000019> 10:14:12 mmap2(0xb76e1000, 10972, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb76e1000 <0.000016> 10:14:12 close(3) = 0 <0.000010> 10:14:12 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000013> 10:14:12 open("/lib/i386-linux-gnu/libuuid.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000017> 10:14:12 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\260\17\0\0004\0\0\0"..., 512) = 512 <0.000012> 10:14:12 fstat64(3, {st_mode=S_IFREG|0644, st_size=18012, ...}) = 0 <0.000011> 10:14:12 mmap2(NULL, 20700, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7535000 <0.000012> 10:14:12 mmap2(0xb7539000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3) = 0xb7539000 <0.000015> 10:14:12 close(3) = 0 <0.000009> 10:14:12 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000011> 10:14:12 open("/lib/i386-linux-gnu/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3 <0.000015> 10:14:12 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`\n\0\0004\0\0\0"..., 512) = 512 <0.000011> 10:14:12 fstat64(3, {st_mode=S_IFREG|0644, st_size=13940, ...}) = 0 <0.000009> 10:14:12 mmap2(NULL, 16504, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7530000 <0.000012> 10:14:12 mmap2(0xb7533000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2) = 0xb7533000 <0.000015> 10:14:12 close(3) = 0 <0.000009> 10:14:12 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb752f000 <0.000013> 10:14:12 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb752e000 <0.000011> 10:14:12 set_thread_area({entry_number:-1 -> 6, base_addr:0xb752e780, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0 <0.000009> 10:14:12 mprotect(0xb76de000, 8192, PROT_READ) = 0 <0.000014> 10:14:12 mprotect(0xb7533000, 4096, PROT_READ) = 0 <0.000012> 10:14:12 mprotect(0xb7539000, 4096, PROT_READ) = 0 <0.000012> 10:14:12 mprotect(0xb7701000, 4096, PROT_READ) = 0 <0.000012> 10:14:12 mprotect(0xb7752000, 8192, PROT_READ) = 0 <0.000012> 10:14:12 mprotect(0xb772a000, 4096, PROT_READ) = 0 <0.000012> 10:14:12 mprotect(0x805d000, 4096, PROT_READ) = 0 <0.000012> 10:14:12 mprotect(0xb7792000, 4096, PROT_READ) = 0 <0.000012> 10:14:12 munmap(0xb7755000, 102869) = 0 <0.000034> 10:14:12 statfs64("/selinux", 84, {f_type="EXT2_SUPER_MAGIC", f_bsize=4096, f_blocks=3779938, f_bfree=2308442, f_bavail=2116430, f_files=960992, f_ffree=753163, f_fsid={634668869, 1933325416}, f_namelen=255, f_frsize=4096}) = 0 <0.000013> 10:14:12 brk(0) = 0x80aa000 <0.000009> 10:14:12 brk(0x80cb000) = 0x80cb000 <0.000010> 10:14:12 open("/proc/filesystems", O_RDONLY|O_LARGEFILE) = 3 <0.000025> 10:14:12 fstat64(3, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0 <0.000009> 10:14:12 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb776e000 <0.000011> 10:14:12 read(3, "nodev\tsysfs\nnodev\trootfs\nnodev\tb"..., 1024) = 380 <0.000037> 10:14:12 read(3, "", 1024) = 0 <0.000009> 10:14:12 close(3) = 0 <0.000015> 10:14:12 munmap(0xb776e000, 4096) = 0 <0.000016> 10:14:12 open("/usr/lib/locale/locale-archive", O_RDONLY|O_LARGEFILE|O_CLOEXEC) = 3 <0.000014> 10:14:12 fstat64(3, {st_mode=S_IFREG|0644, st_size=7052736, ...}) = 0 <0.000009> 10:14:12 mmap2(NULL, 2097152, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb732e000 <0.000011> 10:14:12 mmap2(NULL, 262144, PROT_READ, MAP_PRIVATE, 3, 0x2c8) = 0xb72ee000 <0.000013> 10:14:12 mmap2(NULL, 1253376, PROT_READ, MAP_PRIVATE, 3, 0x30a) = 0xb71bc000 <0.000011> 10:14:12 close(3) = 0 <0.000008> 10:14:12 umask(022) = 022 <0.000009> 10:14:12 open("/dev/null", O_RDWR|O_LARGEFILE) = 3 <0.000016> 10:14:12 close(3) = 0 <0.000015> 10:14:12 getuid32() = 0 <0.000008> 10:14:12 geteuid32() = 0 <0.000010> 10:14:12 stat64("/sbin/mount.nfs", {st_mode=S_IFREG|S_ISUID|0755, st_size=96904, ...}) = 0 <0.000036> 10:14:12 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb752e7e8) = 2910 <0.000083> 10:14:12 wait4(-1, ^C <unfinished ...> root@plate-ucc-2:~# strace -ttT mount -t nfs -o vers=3 10.10.10.1:/storage/home /mnt/ 10:14:57.699721 execve("/bin/mount", ["mount", "-t", "nfs", "-o", "vers=3", "10.10.10.1:/storage/home", "/mnt/"], [/* 28 vars */]) = 0 <0.000209> 10:14:57.700381 brk(0) = 0x80e2000 <0.000016> 10:14:57.700544 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000035> 10:14:57.700703 mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7770000 <0.000017> 10:14:57.700824 access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or directory) <0.000017> 10:14:57.700965 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 3 <0.000021> 10:14:57.701075 fstat64(3, {st_mode=S_IFREG|0644, st_size=102869, ...}) = 0 <0.000015> 10:14:57.701259 mmap2(NULL, 102869, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb7756000 <0.000018> 10:14:57.701351 close(3) = 0 <0.000015> 10:14:57.701478 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000017> 10:14:57.701606 open("/lib/i386-linux-gnu/libblkid.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000022> 10:14:57.701727 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0P8\0\0004\0\0\0"..., 512) = 512 <0.000017> 10:14:57.701868 fstat64(3, {st_mode=S_IFREG|0644, st_size=162044, ...}) = 0 <0.000015> 10:14:57.702039 mmap2(NULL, 164784, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb772d000 <0.000017> 10:14:57.702138 mmap2(0xb7753000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x25) = 0xb7753000 <0.000026> 10:14:57.702268 close(3) = 0 <0.000014> 10:14:57.702361 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000018> 10:14:57.702487 open("/lib/i386-linux-gnu/libmount.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000022> 10:14:57.702607 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`C\0\0004\0\0\0"..., 512) = 512 <0.000017> 10:14:57.702742 fstat64(3, {st_mode=S_IFREG|0644, st_size=157544, ...}) = 0 <0.000014> 10:14:57.702912 mmap2(NULL, 160260, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7705000 <0.000017> 10:14:57.703031 mmap2(0xb772b000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x25) = 0xb772b000 <0.000023> 10:14:57.703161 close(3) = 0 <0.000013> 10:14:57.703249 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000017> 10:14:57.703392 open("/lib/i386-linux-gnu/libselinux.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000023> 10:14:57.703511 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0@A\0\0004\0\0\0"..., 512) = 512 <0.000026> 10:14:57.703643 fstat64(3, {st_mode=S_IFREG|0644, st_size=120748, ...}) = 0 <0.000015> 10:14:57.703813 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7704000 <0.000017> 10:14:57.703924 mmap2(NULL, 125852, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb76e5000 <0.000017> 10:14:57.704021 mmap2(0xb7702000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1c) = 0xb7702000 <0.000024> 10:14:57.704149 close(3) = 0 <0.000014> 10:14:57.704247 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000017> 10:14:57.704355 open("/lib/i386-linux-gnu/libc.so.6", O_RDONLY|O_CLOEXEC) = 3 <0.000021> 10:14:57.704468 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0000\226\1\0004\0\0\0"..., 512) = 512 <0.000017> 10:14:57.704596 fstat64(3, {st_mode=S_IFREG|0755, st_size=1730024, ...}) = 0 <0.000014> 10:14:57.704767 mmap2(NULL, 1739484, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb753c000 <0.000017> 10:14:57.704874 mmap2(0xb76df000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1a3) = 0xb76df000 <0.000025> 10:14:57.705011 mmap2(0xb76e2000, 10972, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb76e2000 <0.000020> 10:14:57.705123 close(3) = 0 <0.000014> 10:14:57.705222 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000015> 10:14:57.705339 open("/lib/i386-linux-gnu/libuuid.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000037> 10:14:57.705475 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\260\17\0\0004\0\0\0"..., 512) = 512 <0.000018> 10:14:57.705606 fstat64(3, {st_mode=S_IFREG|0644, st_size=18012, ...}) = 0 <0.000012> 10:14:57.705775 mmap2(NULL, 20700, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7536000 <0.000015> 10:14:57.705869 mmap2(0xb753a000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3) = 0xb753a000 <0.000021> 10:14:57.705985 close(3) = 0 <0.000012> 10:14:57.706086 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000015> 10:14:57.706190 open("/lib/i386-linux-gnu/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3 <0.000019> 10:14:57.706303 read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0`\n\0\0004\0\0\0"..., 512) = 512 <0.000014> 10:14:57.706425 fstat64(3, {st_mode=S_IFREG|0644, st_size=13940, ...}) = 0 <0.000013> 10:14:57.706591 mmap2(NULL, 16504, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb7531000 <0.000015> 10:14:57.706699 mmap2(0xb7534000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2) = 0xb7534000 <0.000022> 10:14:57.706822 close(3) = 0 <0.000011> 10:14:57.706947 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7530000 <0.000016> 10:14:57.707084 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb752f000 <0.000014> 10:14:57.707172 set_thread_area({entry_number:-1 -> 6, base_addr:0xb752f780, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}) = 0 <0.000012> 10:14:57.707436 mprotect(0xb76df000, 8192, PROT_READ) = 0 <0.000017> 10:14:57.707541 mprotect(0xb7534000, 4096, PROT_READ) = 0 <0.000016> 10:14:57.707634 mprotect(0xb753a000, 4096, PROT_READ) = 0 <0.000015> 10:14:57.707739 mprotect(0xb7702000, 4096, PROT_READ) = 0 <0.000016> 10:14:57.707849 mprotect(0xb7753000, 8192, PROT_READ) = 0 <0.000016> 10:14:57.707952 mprotect(0xb772b000, 4096, PROT_READ) = 0 <0.000016> 10:14:57.708052 mprotect(0x805d000, 4096, PROT_READ) = 0 <0.000016> 10:14:57.708155 mprotect(0xb7793000, 4096, PROT_READ) = 0 <0.000016> 10:14:57.708255 munmap(0xb7756000, 102869) = 0 <0.000028> 10:14:57.708416 statfs64("/selinux", 84, {f_type="EXT2_SUPER_MAGIC", f_bsize=4096, f_blocks=3779938, f_bfree=2308443, f_bavail=2116431, f_files=960992, f_ffree=753163, f_fsid={634668869, 1933325416}, f_namelen=255, f_frsize=4096}) = 0 <0.000016> 10:14:57.708696 brk(0) = 0x80e2000 <0.000011> 10:14:57.708780 brk(0x8103000) = 0x8103000 <0.000013> 10:14:57.708882 open("/proc/filesystems", O_RDONLY|O_LARGEFILE) = 3 <0.000030> 10:14:57.709022 fstat64(3, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0 <0.000012> 10:14:57.709176 mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb776f000 <0.000014> 10:14:57.709271 read(3, "nodev\tsysfs\nnodev\trootfs\nnodev\tb"..., 1024) = 380 <0.000045> 10:14:57.709436 read(3, "", 1024) = 0 <0.000013> 10:14:57.709531 close(3) = 0 <0.000018> 10:14:57.709617 munmap(0xb776f000, 4096) = 0 <0.000021> 10:14:57.709813 open("/usr/lib/locale/locale-archive", O_RDONLY|O_LARGEFILE|O_CLOEXEC) = 3 <0.000018> 10:14:57.709938 fstat64(3, {st_mode=S_IFREG|0644, st_size=7052736, ...}) = 0 <0.000012> 10:14:57.710091 mmap2(NULL, 2097152, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb732f000 <0.000016> 10:14:57.710206 mmap2(NULL, 262144, PROT_READ, MAP_PRIVATE, 3, 0x2c8) = 0xb72ef000 <0.000015> 10:14:57.710299 mmap2(NULL, 1253376, PROT_READ, MAP_PRIVATE, 3, 0x30a) = 0xb71bd000 <0.000028> 10:14:57.710398 close(3) = 0 <0.000012> 10:14:57.710548 umask(022) = 022 <0.000011> 10:14:57.710635 open("/dev/null", O_RDWR|O_LARGEFILE) = 3 <0.000019> 10:14:57.710748 close(3) = 0 <0.000013> 10:14:57.710883 getuid32() = 0 <0.000011> 10:14:57.710965 geteuid32() = 0 <0.000011> 10:14:57.711136 stat64("/sbin/mount.nfs", {st_mode=S_IFREG|S_ISUID|0755, st_size=96904, ...}) = 0 <0.000015> 10:14:57.711308 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb752f7e8) = 2913 <0.000120> 10:14:57.711535 wait4(-1, mount.nfs: Connection timed out [{WIFEXITED(s) && WEXITSTATUS(s) == 32}], 0, NULL) = 2913 <252.451892> 10:19:10.163504 --- SIGCHLD (Child exited) @ 0 (0) --- 10:19:10.163640 exit_group(32) = ?

Mit freundlichen Grüßen
Frank Mehrtens


#4

Hallo,
der spannende Teil wird vermutlich erst bei einem strace mit zusätzlichem “-f” sichtbar.

Ein grundsätzliches NFS-Client Problem des UCC würde ich ausschließen. Ich hab vorhin mal bei einem UCC mir Desktop-Image ein NFS-Share von eines NAS-Box ohne Auffälligkeiten gemountet.

Viele Grüße,
Dirk Ahrnke


#5

Hallo,

ich wollte hier nochmal ein Feedback geben.

Der Fehler wurde durch einen defekten Switch (HP managed 8-Port) ausgelöst.

Weitere Tests hatten ergeben, dass man NFS4 mit der Option proto=udp mounten konnte, per tcp jedoch nicht.
Da uns das alles sehr komisch vor kam und keine Firewall im Spiel war, haben wir die Hardware im Verdacht gehabt…
Damit lagen wir am Schluß auch richtig.

Vielen Dank für die Hilfe hier im Forum.