[samba-jp:19553] Re: smb_add_request: timed out!

[mizuno]

水野です。

On Sat, 30 Jun 2007 04:12:46 +0900
Takashi SHIRAI <shirai ＠ unixusers.net> wrote:

> 	smbclient -N -L 192.168.1.1
> 　IP address のところは server に応じて適宜書換えて下さい。
> あと、ゲストアクセスを許していない場合は -N の代わりに -U で
> user を指定する必要があります。

このような技は知りませんでした参考になります。

On Sat, 30 Jun 2007 04:04:16 +0900
Takashi SHIRAI <shirai ＠ unixusers.net> wrote:

> 　TeraStation が不安定なのは Samba のせいじゃなくて RAID の
> 実装が甘いせいみたいですよ。消えちゃまずい重要なデータを置く
> のには適していないかも。

ちと気になりますが、これはメルコにも報告しておいた方が良いのでしょうか？ 
不安定要素がファームウェアの更新レベルで改善されるのなら良いのですが・・


そして、その後のご報告です。

外見上は一見問題無く動いているように見えるのですがログを確認するとエラー
が沢山出力されています。

どうもコネクションが切れて再接続が継続的に行われているようです。
(これは通常の事だと思いますが、少し事情が違うようです)

委託されたものなので外見上上手く動いていれば取りあえずは良しといったレベ
ルではありますが、今後のメンテで問題が起こっても困るので現状を把握してお
きたいものの、ログを確認する以外の手立てを知りません。
何か現状を調べる良い方法など無いでしょうか？

取りあえず次のようなログが出力されています。
(192.168.1.151 は 以前のメールより問題の WEB2 のアドレス、192.168.1.46 
は WEB1 です)

TraTerm - /var/log/log.smbd
[2007/06/30 10:05:07, 0] lib/util_sock.c:read_data(529)
  read_data: read failure for 4 bytes to client 192.168.1.151. Error = Connection reset by peer
[2007/06/30 10:05:07, 1] smbd/service.c:close_cnum(885)
  192.168.1.151 (192.168.1.151) closed connection to service htdocs
[2007/06/30 10:09:43, 1] smbd/service.c:close_cnum(885)
  192.168.1.46 (192.168.1.46) closed connection to service htdocs
[2007/06/30 10:27:11, 1] smbd/service.c:make_connection_snum(693)
  192.168.1.151 (192.168.1.151) connect to service htdocs initially as user xxx (uid=xxx, gid=xxx) (pid 26789)

これを見ると WEB1 の方でも再接続を行っていますが 'Connection reset by
peer' は発生していません。

WEB2 (cifs) /var/log/messages 
Jun 30 09:37:48 backweb kernel:  CIFS VFS: No response buffer
Jun 30 09:52:05 backweb kernel:  CIFS VFS: No response buffer
Jun 30 10:26:17 backweb kernel:  CIFS VFS: No response buffer
Jun 30 10:41:32 backweb kernel:  CIFS VFS: No response buffer
Jun 30 10:57:28 backweb kernel:  CIFS VFS: No response buffer

指摘されたエラーと関連するものかは分かりませんが cifs で問題が起こってい
るみたいです。

WEB1 (smbfs) /var/log/messages
Jun 30 03:43:47 xxxxx kernel: smb_trans2_request: result=-5, setting invalid
Jun 30 03:43:47 xxxxx kernel: smb_retry: successful, new pid=4123, generation=280
Jun 30 04:02:17 xxxxx nmbd[4344]: [2007/06/30 04:02:17, 0] nmbd/nmbd.c:process(542)
Jun 30 04:02:17 xxxxx nmbd[4344]:   Got SIGHUP dumping debug info.
Jun 30 04:02:17 xxxxx nmbd[4344]: [2007/06/30 04:02:17, 0] nmbd/nmbd_workgroupdb.c:dump_workgroups(284)
Jun 30 04:02:17 xxxxx nmbd[4344]:   dump_workgroups()
Jun 30 04:02:17 xxxxx nmbd[4344]:    dump workgroup on subnet    192.168.1.46: netmask=  255.255.255.0:
Jun 30 04:02:17 xxxxx nmbd[4344]:         WORKGROUP(2) current master browser = FXSERVER
Jun 30 04:02:17 xxxxx nmbd[4344]:         AANDA(1) current master browser = MAGARALINUX
Jun 30 04:02:17 xxxxx nmbd[4344]:                 MAGARALINUX 40049a03 (xxxxx)
Jun 30 04:02:17 xxxxx nmbd[4344]:                 TS-HTGL9E9 40019a03 (TeraStation)
Jun 30 04:02:17 xxxxx nmbd[4344]:                 WORKS 40019a03 (Mac OS X)
Jun 30 04:52:35 xxxxx kernel: smb_get_length: recv error = 5
Jun 30 04:52:35 xxxxx kernel: smb_trans2_request: result=-5, setting invalid
Jun 30 04:52:35 xxxxx kernel: smb_retry: successful, new pid=4123, generation=281
...(略)
Jun 30 10:29:37 xxxxx kernel: smb_get_length: recv error = 5
Jun 30 10:29:37 xxxxx kernel: smb_trans2_request: result=-5, setting invalid
Jun 30 10:29:37 xxxxx kernel: smb_retry: successful, new pid=4123, generation=290

問題は起こっていない思っていた WEB1 の方でも何か起こっているようです。
気にするレベルのものでは無いかもしれませんが・・・

FRONTEND (pound) /var/log/messages
Jun 30 07:12:21 xxxxx pound: response error read from 192.168.1.151:80: Connection timed out
Jun 30 07:33:23 xxxxx pound: response error read from 192.168.1.151:80: Connection timed out
Jun 30 08:25:57 xxxxx pound: response error read from 192.168.1.151:80: Connection timed out
Jun 30 08:52:44 xxxxx pound: response error read from 192.168.1.151:80: Connection timed out
Jun 30 10:13:06 xxxxx pound: response error read from 192.168.1.151:80: Connection timed out

まだ、時々 WEB2 が無反応になっている時があるようです。