回答編集履歴
2
ログの確認内容を追記
test
CHANGED
@@ -29,3 +29,105 @@
|
|
29
29
|
|
30
30
|
|
31
31
|
> postfix/smtpd[14621]: > mrsts405p01c.softbank.ne.jp[123.108.236.71]: 220 【自メールサーバー】 ESMTP smtpd_client_restrictions = permit_mynetworks, reject_rbl_client spamcop.net, reject_rbl_client dynablock.wirehub.net, reject_rbl_client opm.blitzed.org, reject_rbl_client relays.visi.com, reject_rbl_client sbl.spamhaus.org, check_client_access hash:/etc/postfix/reject_client, permit
|
32
|
+
|
33
|
+
|
34
|
+
|
35
|
+
----
|
36
|
+
|
37
|
+
追記(2018-01-17 17:00)
|
38
|
+
|
39
|
+
|
40
|
+
|
41
|
+
追記いただいたログから 主要部分を抜き出すと、以下になるのですが、データをやり取りするコネクションが、全部記録されていませんね。
|
42
|
+
|
43
|
+
|
44
|
+
|
45
|
+
```
|
46
|
+
|
47
|
+
postfix/smtpd[14621]: send attr request = connect
|
48
|
+
|
49
|
+
postfix/smtpd[14621]: > mrsts405p01c.softbank.ne.jp[123.108.236.71]: 220 【自メールサーバー】 ESMTP
|
50
|
+
|
51
|
+
postfix/smtpd[14621]: send attr request = disconnect
|
52
|
+
|
53
|
+
```
|
54
|
+
|
55
|
+
|
56
|
+
|
57
|
+
|
58
|
+
|
59
|
+
おそらく、このログだけだとわかりにくいと思うので、比較するために softbank のメールアドレスから、うちのサーバーに実際にメールを送って実際にログを取ってみました。
|
60
|
+
|
61
|
+
その際のログから主要部分を抜き出すと以下のような記録になります。 (1)〜(13) の数字は、説明のために追加しています。(なお、中央付近の「>」 は、 postfix が送信 / 「<」 は、受信です。)
|
62
|
+
|
63
|
+
|
64
|
+
|
65
|
+
```
|
66
|
+
|
67
|
+
(1) postfix/smtpd[14621]: send attr request = connect
|
68
|
+
|
69
|
+
|
70
|
+
|
71
|
+
(2) postfix/smtpd[6471]: > softbank.ne.jp[117.46.14.xxx]: 220 mail.example.com ESMTP Postfix
|
72
|
+
|
73
|
+
|
74
|
+
|
75
|
+
(3) postfix/smtpd[6471]: < softbank.ne.jp[117.46.14.xxx]: HELO softbank.ne.jp
|
76
|
+
|
77
|
+
|
78
|
+
|
79
|
+
(4) postfix/smtpd[6471]: < softbank.ne.jp[117.46.14.xxx]: MAIL FROM:<...example-user...@softbank.ne.jp>
|
80
|
+
|
81
|
+
|
82
|
+
|
83
|
+
(5) postfix/smtpd[6471]: > softbank.ne.jp[117.46.14.xxx]: 250 2.1.0 Ok
|
84
|
+
|
85
|
+
|
86
|
+
|
87
|
+
(6) postfix/smtpd[6471]: < softbank.ne.jp[117.46.14.xxx]: RCPT TO:<user@example.com>
|
88
|
+
|
89
|
+
|
90
|
+
|
91
|
+
(7) postfix/smtpd[6471]: > softbank.ne.jp[117.46.14.xxx]: 250 2.1.5 Ok
|
92
|
+
|
93
|
+
|
94
|
+
|
95
|
+
(8) postfix/smtpd[6471]: < softbank.ne.jp[117.46.14.xxx]: DATA
|
96
|
+
|
97
|
+
|
98
|
+
|
99
|
+
(9) postfix/smtpd[6471]: > softbank.ne.jp[117.46.14.xxx]: 354 End data with <CR><LF>.<CR><LF>
|
100
|
+
|
101
|
+
|
102
|
+
|
103
|
+
(10) postfix/smtpd[6471]: > softbank.ne.jp[117.46.14.xxx]: 250 2.0.0 Ok: queued as 073FA48031E40
|
104
|
+
|
105
|
+
|
106
|
+
|
107
|
+
(11) postfix/smtpd[6471]: < softbank.ne.jp[117.46.14.xxx]: QUIT
|
108
|
+
|
109
|
+
|
110
|
+
|
111
|
+
(12) postfix/smtpd[6471]: > softbank.ne.jp[117.46.14.xxx]: 221 2.0.0 Bye
|
112
|
+
|
113
|
+
|
114
|
+
|
115
|
+
(13) postfix/smtpd[6471]: send attr request = disconnect
|
116
|
+
|
117
|
+
```
|
118
|
+
|
119
|
+
|
120
|
+
|
121
|
+
質問に記載されているログから抜き出した分と比較してみるとわかると思うのですが、データをやり取りする通信部分( (3) 〜 (12) )のログが、質問のログには、記録されていません。
|
122
|
+
|
123
|
+
|
124
|
+
|
125
|
+
|
126
|
+
|
127
|
+
どのような状況なのか詳細は断言できませんが、「lost connection after CONNECT」というメッセージと「データをやり取りする通信部分( (3) 〜 (12) )」が欠落していることから Postfix が smtp 接続してきたコネクションに対して、応答メッセージを返す前に コネクションが切断されているのではないかと思われます。
|
128
|
+
|
129
|
+
|
130
|
+
|
131
|
+
Postfix のサーバとインターネットの間にあるルータやファイアウォール等ネットワーク機器のログを確認したら何か記録されていないでしょうか?
|
132
|
+
|
133
|
+
(例: メールのエラー時刻前後にエラーが出ている等)
|
1
追記
test
CHANGED
@@ -9,3 +9,23 @@
|
|
9
9
|
|
10
10
|
|
11
11
|
ログを見てもよくわからない場合は、質問を編集して、詳細ログの追加をお願いします。
|
12
|
+
|
13
|
+
|
14
|
+
|
15
|
+
----
|
16
|
+
|
17
|
+
|
18
|
+
|
19
|
+
追記(2018-01-17 16:50)
|
20
|
+
|
21
|
+
|
22
|
+
|
23
|
+
まず、確認ですが...
|
24
|
+
|
25
|
+
ログで、以下の行がありますが、整形・編集前もこのような状態だったのしょうか?
|
26
|
+
|
27
|
+
それとも ログを整形・編集した際に繋がってしまったのでしょうか?
|
28
|
+
|
29
|
+
|
30
|
+
|
31
|
+
> postfix/smtpd[14621]: > mrsts405p01c.softbank.ne.jp[123.108.236.71]: 220 【自メールサーバー】 ESMTP smtpd_client_restrictions = permit_mynetworks, reject_rbl_client spamcop.net, reject_rbl_client dynablock.wirehub.net, reject_rbl_client opm.blitzed.org, reject_rbl_client relays.visi.com, reject_rbl_client sbl.spamhaus.org, check_client_access hash:/etc/postfix/reject_client, permit
|