普段よく見るログとは違ったものが出てきたので折角だから書いておく。
最初にpostfixのmain.cfの一部を書いておこう。
|
1 2 3 4 5 6 7 8 9 |
postscreen_dnsbl_sites = zen.spamhaus.org*3 b.barracudacentral.org=127.0.0.[2..11]*2 bl.spameatingmonkey.net*2 bl.spamcop.net dnsbl.sorbs.net list.dnswl.org=127.[0..255].[0..255].0*-2, list.dnswl.org=127.[0..255].[0..255].1*-4, list.dnswl.org=127.[0..255].[0..255].[2..3]*-6 |
postscreenがチェックしていく過程が判ると思う。
そしてこの設定に引っかかってREJECTされるのがログで見て取れる。
|
1 2 3 4 5 6 7 |
Jun 29 06:30:04 mail postfix/postscreen[67482]: CONNECT from [178.16.53.109]:504 26 to [192.168.0.35]:25 Jun 29 06:30:04 mail postfix/dnsblog[67484]: addr 178.16.53.109 listed by domain zen.spamhaus.org as 127.0.0.2 Jun 29 06:30:04 mail postfix/dnsblog[67484]: addr 178.16.53.109 listed by domain zen.spamhaus.org as 127.0.0.4 Jun 29 06:30:04 mail postfix/dnsblog[67484]: addr 178.16.53.109 listed by domain zen.spamhaus.org as 127.0.0.3 Jun 29 06:30:04 mail postfix/dnsblog[67484]: addr 178.16.53.109 listed by domain zen.spamhaus.org as 127.0.0.9 Jun 29 06:30:04 mail postfix/postscreen[67482]: PREGREET 11 after 0.3 from [178.16.53.109]:50426: EHLO User\r\n Jun 29 06:30:04 mail postfix/postscreen[67482]: DISCONNECT [178.16.53.109]:50426 |
上のログはzen.spamhaus.orgのreturn code listにも似たのを書いたか。
127.0.0.2:spam ip
127.0.0.4:マルウェア感染
127.0.0.3:プロバイダの動的IP
127.0.0.9:botか汚染されたip
と言ったスペシャルなipとして、更にここでこちらの返答を待つことなくEHLOを投げて来た(BOT確定)でDISCONNECTされた。
コレは典型的な例ですね。
|
1 2 3 4 5 6 |
Jun 29 06:47:59 mail postfix/postscreen[67662]: CONNECT from [192.253.248.59]:5916 to [192.168.0.35]:25 Jun 29 06:47:59 mail postfix/dnsblog[67668]: addr 192.253.248.59 listed by domain zen.spamhaus.org as 127.0.0.9 Jun 29 06:47:59 mail postfix/dnsblog[67668]: addr 192.253.248.59 listed by domain zen.spamhaus.org as 127.0.0.2 Jun 29 06:47:59 mail postfix/dnsblog[67668]: addr 192.253.248.59 listed by domain zen.spamhaus.org as 127.0.0.3 Jun 29 06:48:05 mail postfix/postscreen[67662]: DNSBL rank 3 for [192.253.248.59]:5916 Jun 29 06:48:05 mail postfix/postscreen[67662]: DISCONNECT [192.253.248.59]:5916 |
こっちはきちんとEHLOを待っていたけれど、その前にzen.spamhaus.orgによって、spam判定されたのでDISCONNECTです。
今回のはmain.cfの個々の設定によって弾かれたもの。(初めて見たよ)
|
1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 |
smtpd_recipient_restrictions = permit_mynetworks, permit_sasl_authenticated, check_client_access hash:/opt/local/etc/postfix/access, check_client_access cidr:/opt/local/etc/postfix/access_cidr, check_client_access cidr:/opt/local/etc/postfix/reject_cidr, reject_unauth_destination, reject_non_fqdn_sender, reject_non_fqdn_recipient, reject_unknown_sender_domain, reject_invalid_hostname, reject_unknown_reverse_client_hostname, warn_if_reject reject_unknown_client_hostname, warn_if_reject reject_unknown_helo_hostname, reject_unverified_recipient, reject_non_fqdn_helo_hostname, reject_rhsbl_helo dbl.spamhaus.org, reject_rhsbl_reverse_client dbl.spamhaus.org, reject_rhsbl_sender dbl.spamhaus.org, permit |
弾かれたログはこれ。今回の本題ですね。
|
1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 |
Jun 29 06:21:11 mail postfix/postscreen[67369]: CONNECT from [210.136.111.14]:34069 to [192.168.0.35]:25 Jun 29 06:21:17 mail postfix/postscreen[67369]: PASS OLD [210.136.111.14]:34069 Jun 29 06:21:20 mail postfix/smtpd/smtpd[67375]: connect from l0001564.serverhost.jp[210.136.111.14] Jun 29 06:21:20 mail postfix/verify[67379]: cache btree:/opt/local/var/lib/postfix/verify_cache full cleanup: retained=31 dropped=1 entries Jun 29 06:21:20 mail postfix/cleanup[67380]: 82DA13438CE0: message-id=<20260628212120.82DA13438CE0@mail.k-in.co.jp> Jun 29 06:21:20 mail postfix/qmgr[94300]: 82DA13438CE0: from=<double-bounce@k-in.co.jp>, size=267, nrcpt=1 (queue active) Jun 29 06:21:20 mail postfix/cleanup[67380]: 838AB3438CE1: message-id=<20260628212120.838AB3438CE1@mail.k-in.co.jp> Jun 29 06:21:20 mail postfix/qmgr[94300]: 838AB3438CE1: from=<double-bounce@k-in.co.jp>, size=267, nrcpt=1 (queue active) Jun 29 06:21:20 mail postfix/local[67383]: 838AB3438CE1: passing <sales@k-in.co.jp> to transport=lmtp Jun 29 06:21:20 mail postfix/lmtp[67384]: 838AB3438CE1: to=<sales@k-in.co.jp>, relay=mail.k-in.co.jp[private/dovecot-lmtp], delay=0.07, delays=0/0.04/0.03/0, tls=none, dsn=5.1.1, status=undeliverable (host mail.k-in.co.jp[private/dovecot-lmtp] said: 550 5.1.1 <sales@k-in.co.jp> User doesn't exist: sales@k-in.co.jp (in reply to RCPT TO command)) Jun 29 06:21:20 mail postfix/qmgr[94300]: 838AB3438CE1: removed Jun 29 06:21:20 mail postfix/smtp[67382]: discarding EHLO keywords: PIPELINING Jun 29 06:21:20 mail postfix/smtp[67382]: discarding EHLO keywords: PIPELINING Jun 29 06:21:20 mail postfix/smtp[67382]: 82DA13438CE0: to=<info_error@fkage.com>, relay=mail.fkage.com[210.136.111.14]:25, delay=0.16, delays=0/0.01/0.13/0.01, tls=encrypt, dsn=2.1.5, status=deliverable (250 2.1.5 Ok) Jun 29 06:21:20 mail postfix/qmgr[94300]: 82DA13438CE0: removed Jun 29 06:21:24 mail postfix/smtpd/smtpd[67375]: NOQUEUE: reject: RCPT from l0001564.serverhost.jp[210.136.111.14]: 554 5.7.1 Service unavailable; Sender address [info_error@fkage.com] blocked using dbl.spamhaus.org; Listed by DBL, see https://check.spamhaus.org/query/domain/fkage.com; from=<info_error@fkage.com> to=<sales@k-in.co.jp> proto=ESMTP helo=<L0001564.serverhost.jp> Jun 29 06:21:24 mail postfix/smtpd/smtpd[67375]: disconnect from l0001564.serverhost.jp[210.136.111.14] ehlo=2 starttls=1 mail=1 rcpt=0/1 data=0/1 rset=1 quit=1 commands=6/8 |
Geminiさんの解説によると、postfixが凄いことしています。
ここからがreject_unverified_recipient辺りの設定が活きてくるところらしいです。
qmgrが
このキューで、受信者/送信者の存在確認をしています。
一方で
さらにもう一方の
次にreject_rhsbl_sender dbl.spamhaus.orgここの部分に引っかかったんでしょうねぇ。
「Sender address [info_error@fkage.com] blocked using dbl.spamhaus.org」の部分は「送信者アドレス [info_error@fkage.com] が dbl.spamhaus.org を使用してブロックされました」(Google翻訳による)
fkage.comの名前自体がブラックリストに登録されていると。だからDISCONNECTである訳で。
spamhausはipだけでなく、ドメインもリスト化されているんですねぇ。
と言うお話でした。

