Vine Linux バグトラッキングシステム - Vine Linux
課題の詳細を表示
0002519Vine Linux1 バグ公開2013-01-09 20:172015-12-19 22:21
kawamura 
 
毎回 
完了不明 
6.1 
 
x86
0002519: rpc.statd: Could not bind socket: (13) Permission denied
ID:0001341 で報告した、NFSの不具合の件

カーネル、nfs-utilsなど最新の状態にして、NFSの設定をやり直しているのですが、
再起動時に、20分程度かかります。
/var/log/messages を見ると、rpc.statd でソケットに接続できないと出ています。
-----
Jan 9 19:21:12 hamilton kernel: igb: eth1 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX
Jan 9 19:21:12 hamilton kernel: ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
Jan 9 19:21:13 hamilton kernel: RPC: Registered named UNIX socket transport module.
Jan 9 19:21:13 hamilton kernel: RPC: Registered udp transport module.
Jan 9 19:21:13 hamilton kernel: RPC: Registered tcp transport module.
Jan 9 19:21:13 hamilton kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan 9 19:21:13 hamilton rpc.statd[2162]: Version 1.2.6 starting
Jan 9 19:21:13 hamilton sm-notify[2163]: Version 1.2.6 starting
Jan 9 19:21:13 hamilton sm-notify[2163]: Backgrounding to notify hosts...
Jan 9 19:21:13 hamilton rpc.statd[2162]: Could not bind socket: (13) Permission denied
Jan 9 19:21:13 hamilton last message repeated 3 times
Jan 9 19:21:13 hamilton rpc.statd[2162]: failed to create RPC listeners, exiting
Jan 9 19:37:20 hamilton avahi-daemon[2242]: Found user 'avahi' (UID 70) and group 'avahi' (GID 494).
Jan 9 19:37:20 hamilton avahi-daemon[2242]: Successfully dropped root privileges.
Jan 9 19:37:20 hamilton avahi-daemon[2242]: avahi-daemon 0.6.30 starting up.
-----

そのため、rpcinfoをみても、statdのエントリがありあせん。
# rpcinfo -p | grep stat
#

設定ファイルは以下のとおりです。iptablesでファイアウォールを設定する
ために、ポートを指定しています。ただ、iptablesを止めて、実行しても同じです。
# grep -v "^#" /etc/sysconfig/nfs
LOCKD_TCPPORT=32803
LOCKD_UDPPORT=32769
RPCNFSDARGS="-N 4"
RPCNFSDCOUNT=12
MOUNTD_PORT=892
STATD_PORT=662
STATD_OUTGOING_PORT=2020

いずれにしても、NFSクライアントで、マウントできてもものすごく時間がかかり
フリーズした状態に見えるようです。
ID:0001341 で報告したNFSの不具合も、同様の現象のような気がします。

GNOMEを使わずに、リモートでログインした場合は、各種サービスを利用しないので、
マウントが正常にできてるように見えて、おかしな挙動はありません。
一方、デスクトップでログインした場合、
pulseaudioや、firefoxなど、lockを使うサービスを起動すると、フリーズしたような
状態になるようです。

statdとlockdの不具合だと思うのですが、どうでしょうか?

環境
# uname -a

Linux hamilton.is.sci.yamaguchi-u.ac.jp 3.0.50-1vl6 0000001 SMP Thu Nov 1 09:39:28 JST 2012 i686 i686 i386 GNU/Linux
# rpm -q nfs-utils
nfs-utils-1.2.6-1vl6.i686

nfs
課題の履歴
2013-01-09 20:17kawamura新規課題
2013-01-09 20:18kawamuraタグ設定: nfs
2013-01-09 20:48kawamuraコメント追加: 0007656
2013-01-09 20:49kawamuraコメント編集: 0007656bug_revision_view_page.php?bugnote_id=7656#r225
2013-01-09 21:22kawamuraコメント追加: 0007657
2013-01-18 13:19iwamotoコメント追加: 0007674
2015-12-19 22:21tomopコメント追加: 0009640
2015-12-19 22:21tomop状態新規 => 完了

コメント
(0007656)
kawamura   
2013-01-09 20:48   
(更新日時: 2013-01-09 20:49)
/var/lib/nfs/statd/sm*
のオーナーが rpcuserになっているのが、Permission denied の原因のようです。

# ll /var/lib/nfs/statd/
合計 20
drwx------ 4 rpcuser rpcuser 4096 1月 9 20:43 ./
drwxr-xr-x 5 root root 4096 1月 9 19:37 ../
drwx------ 2 rpcuser rpcuser 4096 10月 20 23:21 sm/
drwx------ 2 rpcuser rpcuser 4096 10月 20 23:21 sm.bak/
-rw-r--r-- 1 root root 4 1月 9 20:43 state

オーナーをrootにしてみました。

# chown -R /var/lib/nfs/statd/sm*
# ll /var/lib/nfs/statd/
合計 20
drwx------ 4 rpcuser rpcuser 4096 1月 9 20:43 ./
drwxr-xr-x 5 root root 4096 1月 9 19:37 ../
drwx------ 2 root rpcuser 4096 10月 20 23:21 sm/
drwx------ 2 root rpcuser 4096 10月 20 23:21 sm.bak/
-rw-r--r-- 1 root root 4 1月 9 20:43 state

とすると、nfslock の起動で時間はかからなくなりました。しかし、まだ、起動に失敗します。

messagesの出力は以下のとおりです。
Jan 9 20:47:34 hamilton rpc.statd[4099]: Version 1.2.6 starting
Jan 9 20:47:34 hamilton sm-notify[4100]: Version 1.2.6 starting
Jan 9 20:47:34 hamilton sm-notify[4100]: Backgrounding to notify hosts...
Jan 9 20:47:34 hamilton sm-notify[4101]: Failed to bind RPC socket: Address already in use
Jan 9 20:47:34 hamilton rpc.statd[4099]: Could not bind socket: (13) Permission denied
Jan 9 20:47:34 hamilton last message repeated 3 times
Jan 9 20:47:34 hamilton rpc.statd[4099]: failed to create RPC listeners, exiting


まだ、rpcuserユーザ所有のものがあるのが原因かも知れませんが、どうでしょう?

(0007657)
kawamura   
2013-01-09 21:22   
/var/lib/nfs/statd/ のオーナーもrootにしたら、rcp.statdが起動できました。

# ll /var/lib/nfs/statd/
合計 20
drwx------ 4 root rpcuser 4096 1月 9 20:47 ./
drwxr-xr-x 5 root root 4096 1月 9 19:37 ../
drwx------ 2 root rpcuser 4096 10月 20 23:21 sm/
drwx------ 2 root rpcuser 4096 1月 9 21:10 sm.bak/
-rw-r--r-- 1 root root 4 1月 9 20:47 state

# service nfslock restart
# cat /var/log/messages
...
Jan 9 21:19:39 hamilton rpc.statd[4819]: Caught signal 15, un-registering and exiting
Jan 9 21:19:39 hamilton rpc.statd[4856]: Version 1.2.6 starting
Jan 9 21:19:39 hamilton sm-notify[4857]: Version 1.2.6 starting
Jan 9 21:19:39 hamilton rpc.statd[4856]: Running as root. chown /var/lib/nfs/statd to choose different user

messagesには、root以外で実行するように言われますが、とりあえずは、起動できているようです。
(0007674)
iwamoto   
2013-01-18 13:19   
[iwamoto@kokone ~]$ sudo ls -l /var/lib/nfs/statd/
[sudo] password for iwamoto:
合計 12
drwx------ 2 rpcuser rpcuser 4096 10月 20 23:21 sm
drwx------ 2 rpcuser rpcuser 4096 10月 20 23:21 sm.bak
-rw-r--r-- 1 root root 4 10月 21 15:11 state
[iwamoto@kokone ~]$ sudo ls -l /var/lib/nfs/
合計 16
-rw-r--r-- 1 root root 467 1月 13 18:37 etab
-rw-r--r-- 1 root root 0 10月 21 15:12 export-lock
-rw-r--r-- 1 root root 140 1月 18 12:17 rmtab
drwxr-xr-x 9 root root 0 1月 13 18:37 rpc_pipefs
drwx------ 4 rpcuser rpcuser 4096 10月 21 15:11 statd
-rw-r--r-- 1 rpcuser rpcuser 0 10月 20 23:21 state
drwxr-xr-x 2 root root 4096 1月 4 16:56 v4recovery
-rw-r--r-- 1 root root 0 10月 20 23:21 xtab
[iwamoto@kokone ~]$ rpm -qa|grep nfs
nfs-utils-1.2.6-1vl6.x86_64
libnfsidmap-0.21-2vl6.x86_64
unionfs-utils-0.2.1-3vl6.x86_64
[iwamoto@kokone ~]$ chkconfig --list|grep nfs
nfs 0:off 1:off 2:on 3:on 4:on 5:on 6:off
nfslock 0:off 1:off 2:on 3:on 4:on 5:on 6:off

上記状態で、正常起動+nfs 運用できています。
(0009640)
tomop   
2015-12-19 22:21   
最終更新日から1年以上経過したためクローズします。