2791 spamdが非常に遅いU

<<トップページへ

spamdが非常に遅いU
日時: 2007/01/23 00:44
名前: かつかつ
以前、2469で質問させていただきましたが、メール送信が日に日に遅くなり今では1分程度かかるようになってしまいました。(本文無しの件名だけのメール送信で1分程度)
原因追求方法・解決方法をご指導願います。

==============<2469 質問内容>==============
外部から、構築したSMTPで送信を行うとすごく遅いです。
バラツキがありますが、添付ファイル無しのメール送信で、
5〜10秒ぐらいかかります。
maillog見ましたが、spamdのログ開始まで3Sec spamdが4.4Sec
なぜ遅いか、初心者の私にはさっぱりです。
----原因追求方法・解決方法をご指導願います。

マシンは
 PenU 350MHz メモリ 384MB HDD 40GB
回線は
 ADSL 1.5M
OSは
 Fedora Core4
ドメインは
 フリーのdyndsn.org

メール関係でインストールした主なものは、下記です。

独自のメールアドレスをつくる(qmail編)
1.メールサーバー構築(qmail+Courier-IMAP) FC3/FC4/FC5
2.メールサーバー間通信内容暗号化(ucspi-tcp-ssl) FC3/FC4/FC5
3.メールサーバーでウィルス&スパムチェック(Qmail-Scanner+Clam AntiVirus+SpamAssassin+maildrop) FC3/FC4
4.バーチャルドメイン設定(vpopmail) FC3/FC4
5.vpopmail用メールアカウント&メーリングリスト管理システム導入(qmailadmin) FC3/FC4
6.qmailログ解析ツール導入(qmailanalog) FC4/FC5

HotmailやYahoo!メールのようにWebブラウザ上でメールできるようにする
1.Webmailシステム構築(SquirrelMail) FC1/FC2/FC3/FC4/FC5
2.バーチャルホスト設定(Virtual Host Domain Name Management) FC1/FC2/FC3/FC4/FC5


==============<現状の/var/log/maillog>==============
Jan 23 00:14:32 ms smtps: 1169478872.736702 tcpserver: status: 1/40
Jan 23 00:14:32 ms smtps: 1169478872.737909 tcpserver: pid 8410 from 221.113.53.xx
Jan 23 00:14:32 ms smtps: 1169478872.738687 tcpserver: ok 8410 0:192.168.xx.xx:465 :221.113.53.xx::1166
Jan 23 00:15:15 ms spamd[1537]: connection from ms.yyy.selfip.net [127.0.0.1] at port 39308
Jan 23 00:15:15 ms spamd[1537]: processing message <001801c73e38$1ac9c530$0201a8c0@p426> for test@yyy.selfip.net:89.
Jan 23 00:15:16 ms spamd[1537]: clean message (0.9/13.0) for test@yyy.selfip.net:89 in 1.9 seconds, 663 bytes.
Jan 23 00:15:16 ms spamd[1537]: result: . 0 - AWL,CONTENT_TYPE_PRESENT,FROM_ENDS_IN_NUMS,ISO2022JP_CHARSET,RCVD_IN_SORBS_DUL,X_MAILER_PRESENT scantime=1.9,size=663,mid=<001801c73e38$1ac9c530$0201a8c0@p426>,autolearn=no
Jan 23 00:15:17 ms qmail: 1169478917.315407 new msg 6293095
Jan 23 00:15:17 ms qmail: 1169478917.315862 info msg 6293095: bytes 1291 from <test@yyy.selfip.net> qp 8426 uid 512
Jan 23 00:15:17 ms qmail-scanner[8416]: Clear:RC:0(221.113.53.xx):SA:0(0.9/13.0): 2.087784 614 test@yyy.selfip.net test@yyy.selfip.net TEST02 <001801c73e38$1ac9c530$0201a8c0@p426> orig-ms.yyy.selfip.net11694789144938416:614 1169478915.8418-0.ms.yyy.selfip.net:1
Jan 23 00:15:17 ms qmail: 1169478917.359459 starting delivery 173: msg 6293095 to local yyy.selfip.net-test@yyy.selfip.net
Jan 23 00:15:17 ms qmail: 1169478917.359872 status: local 1/10 remote 0/20
Jan 23 00:15:17 ms qmail: 1169478917.426704 delivery 173: success: did_0+0+3/
Jan 23 00:15:17 ms qmail: 1169478917.427117 status: local 0/10 remote 0/20
Jan 23 00:15:17 ms qmail: 1169478917.427419 end msg 6293095
Jan 23 00:15:17 ms smtps: 1169478917.505756 tcpserver: end 8410 status 0
Jan 23 00:15:17 ms smtps: 1169478917.506127 tcpserver: status: 0/40
Jan 23 00:15:17 ms pop3s: 1169478917.727493 tcpserver: status: 1/40
Jan 23 00:15:17 ms pop3s: 1169478917.727865 tcpserver: pid 8434 from 221.113.53.xx
Jan 23 00:15:17 ms pop3s: 1169478917.789011 tcpserver: ok 8434 :192.168.xx.xx:995 :221.113.53.xx::1167
Jan 23 00:15:19 ms pop3s: 1169478919.625112 tcpserver: end 8434 status 0
Jan 23 00:15:19 ms pop3s: 1169478919.625542 tcpserver: status: 0/40
Jan 23 00:15:23 ms pop3s: 1169478923.224818 tcpserver: status: 1/40
Jan 23 00:15:23 ms pop3s: 1169478923.225294 tcpserver: pid 8438 from 221.113.53.xx
Jan 23 00:15:23 ms pop3s: 1169478923.287570 tcpserver: ok 8438 :192.168.xx.xx:995 :221.113.53.xx::1168
Jan 23 00:15:25 ms pop3s: 1169478925.767606 tcpserver: end 8438 status 0
Jan 23 00:15:25 ms pop3s: 1169478925.768049 tcpserver: status: 0/40


$ free
total used free shared buffers cached
Mem: 385392 379064 6328 0 31528 134524
-/+ buffers/cache: 213012 172380
Swap: 393208 88 393120

Re: spamdが非常に遅いU(1)
日時: 2007/01/24 02:39
名前: val99
こんばんは

下が参考になるかもしれません。
http://fedorasrv.com/bbshtml/webpatio/1173.shtml

私のメインのサーバーはメモリは512M積んでいますが
他にもメモリを食う設定を多くしているので
SPAMDOPTIONSは-m2に設定しています。

Re: spamdが非常に遅いU(2)
日時: 2007/01/25 00:21
名前: かつかつ
val99さん ありがとうございます。

先ほど試しましたが、変りませんでした。


クライアントのメーラはMSのOutlook Expressですが、送信のときに
+------------------------------------
| "xxx"に接続中
|
| 接続済み
| ---------------------------
| | |
| ---------------------------
|
+------------------------------------
のダイヤログで、45秒ぐらいしてようやくプログレスバーがあがり始めます。

受信はすぐにプログレスバーがあがります。
WebブラウザからSquirrelMailで送信するときは、すぐに送信できるのですが・・・


Re: spamdが非常に遅いU(3)
日時: 2007/01/26 14:22
名前: val99
SSLでのアクセスはサーバ側に負荷がかかるので、メールサーバーのSSLの設定を
一度止めてみたらどうなりますか?

Re: spamdが非常に遅いU(4)
日時: 2007/01/27 22:40
名前: かつかつ
メールサーバーのSSLの設定の止め方が解らなかったので、qmail起動スクリプトを下記で試しました。
結果は変らず送信で50秒程度かかりました。


ログで気になったのは3行目の
 tcpserver: ok 29426 0:192.168.xx.xx:25 :221.113.53.xx::1521
送信先は、自サーバなのに、グローバルアドレス(221.113.53.xx)が取得されていますが、正常なのでしょうか?


(メールサーバのIPアドレスは192.168.xx.xxで、ルータ(221.113.53.xx)で25、110、465、995ポートへのアクセスは192.168.xx.xxへフォワードさせています)

====================================================================
qmail起動スクリプト
# SMTP
tcpserver -qv -l0 -HR -u `id -u vpopmail` -g `id -g vpopmail` \
-x /home/vpopmail/etc/tcp.smtp.cdb 0 smtp rblsmtpd -r relays.ordb.org \
qmail-smtpd `hostname` /home/vpopmail/bin/vchkpw /bin/true 2>&1|\
splogger smtp &

# POP3
tcpserver -qvRH -u `id -u vpopmail` -g `id -g vpopmail` \
0 pop3 qmail-popup `hostname` /home/vpopmail/bin/vchkpw \
qmail-pop3d Maildir 2>&1 | splogger pop3 &

====================================================================

Jan 27 22:15:06 ms smtp: 1169903706.514417 tcpserver: status: 1/40
Jan 27 22:15:06 ms smtp: 1169903706.519268 tcpserver: pid 29426 from 221.113.53.xx
Jan 27 22:15:06 ms smtp: 1169903706.519657 tcpserver: ok 29426 0:192.168.xx.xx:25 :221.113.53.xx::1521
Jan 27 22:15:47 ms pop3: 1169903747.998192 tcpserver: status: 1/40
Jan 27 22:15:47 ms pop3: 1169903747.998636 tcpserver: pid 29431 from 221.113.53.xx
Jan 27 22:15:48 ms pop3: 1169903748.058654 tcpserver: ok 29431 :192.168.xx.xx:110 :221.113.53.xx::1523
Jan 27 22:15:49 ms pop3: 1169903749.538618 tcpserver: end 29431 status 256
Jan 27 22:15:49 ms pop3: 1169903749.539067 tcpserver: status: 0/40
Jan 27 22:15:50 ms spamd[23548]: connection from ms.xxxxx.selfip.net [127.0.0.1] at port 60268
Jan 27 22:15:50 ms spamd[23548]: processing message <001201c74215$3e2b4cc0$0201a8c0@p426> for xxxx@xxxxx.selfip.net:89.
Jan 27 22:15:51 ms spamd[23548]: clean message (0.9/13.0) for xxxx@xxxxx.selfip.net:89 in 1.8 seconds, 1097 bytes.
Jan 27 22:15:51 ms spamd[23548]: result: . 0 - AWL,CONTENT_TYPE_PRESENT,FROM_ENDS_IN_NUMS,ISO2022JP_CHARSET,RCVD_IN_SORBS_DUL,X_MAILER_PRESENT scantime=1.8,size=1097,mid=<001201c74215$3e2b4cc0$0201a8c0@p426>,autolearn=no
Jan 27 22:15:52 ms qmail: 1169903752.332352 new msg 6293050
Jan 27 22:15:52 ms qmail: 1169903752.332797 info msg 6293050: bytes 1726 from <xxxx@xxxxx.selfip.net> qp 29443 uid 512
Jan 27 22:15:52 ms qmail: 1169903752.345190 starting delivery 202: msg 6293050 to local xxxxx.selfip.net-xxxx@xxxxx.selfip.net
Jan 27 22:15:52 ms qmail: 1169903752.346165 status: local 1/10 remote 0/20
Jan 27 22:15:52 ms qmail-scanner[29433]: Clear:RC:0(221.113.53.xx):SA:0(0.9/13.0): 1.988497 1048 xxxx@xxxxx.selfip.net xxxx@xxxxx.selfip.net TEST02 <001201c74215$3e2b4cc0$0201a8c0@p426> orig-ms.xxxxx.selfip.net116990375049329433:1048 1169903750.29435-0.ms.xxxxx.selfip.net:2
Jan 27 22:15:52 ms qmail: 1169903752.429743 delivery 202: success: did_0+0+3/
Jan 27 22:15:52 ms qmail: 1169903752.430209 status: local 0/10 remote 0/20
Jan 27 22:15:52 ms qmail: 1169903752.430514 end msg 6293050
Jan 27 22:15:52 ms smtp: 1169903752.914427 tcpserver: end 29426 status 0
Jan 27 22:15:52 ms smtp: 1169903752.914774 tcpserver: status: 0/40

Re: spamdが非常に遅いU(5)
日時: 2007/01/28 14:54
名前: val99
ルーターの設定ですがルータ(221.113.53.xx)と書かれていますが、
ルーターのアドレスをLAN側のプライベートIPでも設定する必要があります。
ですからログの2行目以降にグローバルIPの表示がされている箇所は
本来プライベートIPで表示されるはずです。

http://www.kent-web.com/www/anhttpd/rooter.html

Re: spamdが非常に遅いU(6)
日時: 2007/01/28 22:56
名前: かつかつ
val99さん 毎度ありがとうございます。

「ルーターの設定」舌足らずですみません。
ルータ自体のLAN側IPアドレスは192.168.yy.yy WAN側が221.113.53.xxとなっています。
メールサーバの/etc/sysconfig/network は GATEWAY=192.168.yy.yy としています。


送信時の待ち時間の45秒の間のメールサーバのCPUの状況を見ましたが、忙しくしていませんでした。

「2行目以降にグローバルIPの表示がされている箇所は本来プライベートIPで表示されるはずです。」
===>なぜWAN側にいくのか調査してみます。貴重な情報ありがとうございます。

Re: spamdが非常に遅いU(7)
日時: 2007/01/29 14:51
名前: COMET
えぇっと、qmailの起動スクリプトのとこで1つ修正を試してみてください。

#SMTPの中の rblsmtpd -r relays.ordb.org の部分がありますよね?
ここを rblsmtpd -r all.rbl.jp これに修正してqmailを再起動してください。
もしこれで状況が改善するようであれば rblsmtpd -r all.rbl.jp -r bl.spamcop.net
上の様にして2箇所参照させた方が無難かもしれません。
日本版RBLはまだまだ登録数が少ないので。

Re: spamdが非常に遅いU(8)
日時: 2007/01/29 22:31
名前: かつかつ
COMETさん ありがとうございました。
見事に早くなりました。

昨晩、ダメモトで内部向けDNSサーバー構築を試行しましたが変らず、いままで順調だったWebMailが使用できなくなり新たな問題を抱えていました。 本件は助かりました。ありがとうございました。


Jan 29 22:14:55 ms smtps: 1170076495.571270 tcpserver: status: 1/40
Jan 29 22:14:55 ms smtps: 1170076495.571734 tcpserver: pid 8421 from 218.45.167.90
Jan 29 22:14:55 ms smtps: 1170076495.572046 tcpserver: ok 8421 0:192.168.xx.xx:465 :218.45.167.90::1204
Jan 29 22:14:57 ms spamd[2840]: connection from ms.yyy.selfip.net [127.0.0.1] at port 59556
Jan 29 22:14:57 ms spamd[2840]: processing message <001201c743a7$75ad7590$0201a8c0@p426> for test@yyy.selfip.net:89.
Jan 29 22:14:58 ms spamd[2840]: clean message (0.3/13.0) for test@yyy.selfip.net:89 in 1.3 seconds, 4055 bytes.
Jan 29 22:14:58 ms spamd[2840]: result: . 0 - CONTENT_TYPE_PRESENT,FROM_ENDS_IN_NUMS,ISO2022JP_BODY,ISO2022JP_CHARSET,X_MAILER_PRESENT scantime=1.3,size=4055,mid=<001201c743a7$75ad7590$0201a8c0@p426>,autolearn=no
Jan 29 22:14:59 ms qmail: 1170076499.202840 new msg 6293170
Jan 29 22:14:59 ms qmail: 1170076499.203430 info msg 6293170: bytes 4676 from <test@yyy.selfip.net> qp 8434 uid 512
Jan 29 22:14:59 ms qmail: 1170076499.239551 starting delivery 3: msg 6293170 to local yyy.selfip.net-test@yyy.selfip.net
Jan 29 22:14:59 ms qmail: 1170076499.240002 status: local 1/10 remote 0/20
Jan 29 22:14:59 ms qmail-scanner[8424]: Clear:RC:0(218.45.167.90):SA:0(0.3/13.0): 1.441453 4006 test@yyy.selfip.net test@yyy.selfip.net Re:_TEST02 <001201c743a7$75ad7590$0201a8c0@p426> orig-ms.yyy.selfip.net11700764974938424:4006 1170076497.8427-0.ms.yyy.selfip.net:2842
Jan 29 22:14:59 ms smtps: 1170076499.377745 tcpserver: end 8421 status 0
Jan 29 22:14:59 ms smtps: 1170076499.378193 tcpserver: status: 0/40
Jan 29 22:14:59 ms qmail: 1170076499.392382 delivery 3: success: did_0+0+3/
Jan 29 22:14:59 ms qmail: 1170076499.392786 status: local 0/10 remote 0/20
Jan 29 22:14:59 ms qmail: 1170076499.393088 end msg 6293170
Jan 29 22:14:59 ms pop3s: 1170076499.596016 tcpserver: status: 1/40
Jan 29 22:14:59 ms pop3s: 1170076499.599542 tcpserver: pid 8442 from 218.45.167.90
Jan 29 22:14:59 ms pop3s: 1170076499.599948 tcpserver: ok 8442 yyy.selfip.net:192.168.xx.xx:995 :218.45.167.90::1205
Jan 29 22:15:01 ms pop3s: 1170076501.672604 tcpserver: end 8442 status 0
Jan 29 22:15:01 ms pop3s: 1170076501.673038 tcpserver: status: 0/40


Re: spamdが非常に遅いU(9)
日時: 2007/01/29 23:28
名前: かつかつ
解決の手段を載せるの忘れていました。
COMETさんのご指導どおり
/etc/rc.d/init.d/qmailの
「rblsmtpd -r relays.ordb.org」
   ↓
「rblsmtpd -r all.rbl.jp -r bl.spamcop.net」に変更することで解決しました。

==========================
また、「昨晩、ダメモトで内部向けDNSサーバー構築を試行しましたが変らず、いままで順調だったWebMailが使用できなくなり新たな問題を抱えていました。」
スシテム再起動で元に戻りました。

※古いスレッドには返信できない場合があります


■関連コンテンツ




▲このページのトップへ戻る

プライバシーポリシー