On Tue, June 26, 2018 16:47, Wietse Venema wrote:
> James B. Byrne:
>> I am configuring a new Postfix-3.3.0 service to act as one of our
>> public MX providers. The address of this new MX service has been
>> published in our DNS but with a lower precedence (higher priority
>> number) than our active MX service.
>>
>> Naturally enough there are countless spam bots regularly hitting the
>> low priority MX services and so when I activate Postfix for testing
>> we
>> get numerous opportunistic connections. When we do we frequently
>> (always?) get messages like this in the mail queue:
>>
>> Received by mx32.hll.ca (Postfix) id 002F8E7E3; Mon, 25 Jun 2018
>> 22:13:17 -0400 (EDT)
>> Date Mon, 25 Jun 2018 22:13:17 -0400 (EDT)
>> >From mailer-dae...@mx32.hll.ca (Mail Delivery System)
>> To postmas...@mx32.hll.ca (Postmaster)
>> Subject Postfix SMTP server: errors from
>> smtp1.e2mailb2b.info[208.234.16.120]
>> Message-Id <20180626021317.002f8e...@mx32.harte-lyne.ca>
>> Message text
>>
>> Transcript of session follows.
>>
>> Out: 220 mx32.hll.ca ESMTP Postfix
>> In: EHLO smtp1.e2mailb2b.info
>> Out: 250-mx32.hll.ca
>> Out: 250-PIPELINING
>> Out: 250-SIZE 20480000
>> Out: 250-ETRN
>> Out: 250-STARTTLS
>> Out: 250-ENHANCEDSTATUSCODES
>> Out: 250-8BITMIME
>> Out: 250-DSN
>> Out: 250 SMTPUTF8
>> In: MAIL FROM:<upd...@e2mailb2b.info> BODY=8BITMIME
>> Out: 250 2.1.0 Ok
>> In: RCPT TO:<scott.kak...@hll.ca>
>> Out: 250 2.1.5 Ok
>> In: DATA
>> Out: 354 End data with <CR><LF>.<CR><LF>
>> Out: 451 4.3.0 Error: queue file write error
>> In: QUIT
>> Out: 221 2.0.0 Bye
>>
>> Note that 'In: RCPT TO:<scott.kak...@hll.ca>' refers to a
>> non-existent mailbox address.
>>
>> For other details, see the local mail logfile
>
> And, what is in the local mail logfile around the time that this
> message was received on Mon, 25 Jun 2018 22:13:17 -0400 (EDT)?
>
>> # postconf -f | grep notify
>> notify_classes = resource, software
>> Since I do not set notify_classes in main.cf these are the defaults.
>
> You have "notify_classes = ... bounce ..." somewhere, otherwise
> you would not receive the above SMTP session recording.
>
> Try: postconf -P | grep notify_classes
>
> Wietse
>
[root@mx32 ~]# postconf | grep notify
notify_classes = resource, software
[root@mx32 ~]#
[root@mx32 ~]# postconf -P | grep notify
[root@mx32 ~]#
I looked for that before I called upon the list for help.
This is what I found in the maillog file on mx32, which appears to me
passing strange for what is not there:
[root@mx32 ~]# grep 'Jun 25' /var/log/maillog*
/var/log/maillog:Jun 26 00:03:35 mx32 postfix/anvil[85166]:
statistics: max connection rate 1/60s for (smtpd:189.52.165.134) at
Jun 25 23:58:34
/var/log/maillog:Jun 26 00:03:35 mx32 postfix/anvil[85166]:
statistics: max connection count 1 for (smtpd:189.52.165.134) at Jun
25 23:58:34
/var/log/maillog:Jun 26 00:03:35 mx32 postfix/anvil[85166]:
statistics: max cache size 1 at Jun 25 23:58:34
On our IMAP server this is what is in its maillog:
[root@inet07 ~ (master #)]# grep 'Jun 25 22:13' /var/log/maillog
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: connect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: disconnect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: connect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: disconnect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: connect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: disconnect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: connect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: disconnect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: connect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 25 22:13:16 inet07 postfix/smtpd[18442]: disconnect from
mx32.harte-lyne.ca[216.185.71.32]
It seemed that the new server simply connects and disconnects without
ever trying establish a session.
Today on the IMAP service host I set the debug level to 2 and the
debug host to mx32 and this is what I see now:
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: connect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 127.0.0.0/8
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 127.0.0.0/8
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.17
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 209.47.176.17
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostname:
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.27
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.27
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.28
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.28
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.31
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.31
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.32
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.32
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 220 inet07.hamilton.harte-lyne.ca
ESMTP Postfix
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: watchdog_pat: 0x7f5fb7f23a40
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: <
mx32.harte-lyne.ca[216.185.71.32]: EHLO mx32.harte-lyne.ca
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-inet07.hamilton.harte-lyne.ca
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-PIPELINING
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-SIZE 20480000
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-ETRN
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_list_match:
mx32.harte-lyne.ca: no match
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: match_list_match:
216.185.71.32: no match
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-STARTTLS
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-ENHANCEDSTATUSCODES
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-8BITMIME
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250 DSN
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: watchdog_pat: 0x7f5fb7f23a40
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: <
mx32.harte-lyne.ca[216.185.71.32]: STARTTLS
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 220 2.0.0 Ready to start TLS
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: auto_clnt_open: connected
to private/tlsmgr
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: send attr request = seed
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: send attr size = 32
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: private/tlsmgr: wanted
attribute: status
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: input attribute name: status
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: input attribute value: 0
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: private/tlsmgr: wanted
attribute: seed
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: input attribute name: seed
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: input attribute value:
vIw+layYxd6iwt6xUIfAiSpM/KKk0VpVa1OELVOjs6M=
Jun 26 18:11:00 inet07 postfix/smtpd[26275]: private/tlsmgr: wa
9.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.27
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 209.47.176.27
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.28
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 209.47.176.28
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.17
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 216.185.71.17
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-inet07.hamilton.harte-lyne.ca
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-PIPELINING
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-SIZE 20480000
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-ETRN
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_list_match:
mx32.harte-lyne.ca: no match
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_list_match:
216.185.71.32: no match
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-STARTTLS
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-ENHANCEDSTATUSCODES
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-8BITMIME
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: >
mx32.harte-lyne.ca[216.185.71.32]: 250 DSN
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: watchdog_pat: 0x7fa84ac45a40
Jun 26 18:11:01 ine
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: private/tlsmgr: wanted
attribute: (list terminator)
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: input attribute name: (end)
Jun 26 18:11:01 inet07 postfix/smtpd[26480]:
xsasl_cyrus_server_create: SASL service=smtp, realm=(null)
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: name_mask: noanonymous
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: watchdog_pat: 0x7fa84ac45a40
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: connect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 209.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 209.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.27
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 209.47.176.27
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.28
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 209.47.176.28
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.17
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 216.185.71.17
Jun 26 18:11:01 inet07 postfix/smtp
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: >
mx32.harte-lyne.ca[216.185.71.32]: 220 inet07.hamilton.harte-lyne.ca
ESMTP Postfix
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: watchdog_pat: 0x7f7353e21a40
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: <
mx32.harte-lyne.ca[216.185.71.32]: EHLO mx32.harte-lyne.ca
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-inet07.hamilton.harte-lyne.ca
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-PIPELINING
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-SIZE 20480000
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-ETRN
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_list_match:
mx32.harte-lyne.ca: no match
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_list_match:
216.185.71.32: no match
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-STARTTLS
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: > m
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: send attr size = 32
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: private/tlsmgr: wanted
attribute: status
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: input attribute name: status
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: input attribute value: 0
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: private/tlsmgr: wanted
attribute: seed
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: input attribute name: seed
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: input attribute value:
KC7o88KtRK/XFs7ZpoEyFK53ezcN4KhnP+0LMzfuYUU=
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: private/tlsmgr: wanted
attribute: (list terminator)
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: input attribute name: (end)
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: <
mx32.harte-lyne.ca[216.185.71.32]: QUIT
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 221 2.0.0 Bye
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 127.0.0.0/8
6.185.71.17
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: disconnect f
~? 209.47.176.28
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 209.47.176.28
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.17
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.17
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_list_match:
mx32.harte-lyne.ca: no match
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_list_match:
216.185.71.32: no match
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-STARTTLS
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-ENHANCEDSTATUSCODES
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-8BITMIME
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 250 DSN
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: watchdog_pat: 0x7f5fb7f23a40
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: <
mx32.harte-lyne.ca[216.185.71.32]: STARTTLS
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 220 2.0.0 Ready to start TLS
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: send attr request = seed
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: send attr size = 32
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: private/tlsmgr: wanted
attribute: status
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: input attribute name: sta
9.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 209.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.27
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 209.47.176.27
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.28
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 209.47.176.28
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.17
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 216.185.71.17
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 216.185
: EHLO mx32.harte-lyne.ca
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-inet07.hamilton.harte-lyne.ca
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: <
mx32.harte-lyne.ca[216.185.71.32]: QUIT
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: >
mx32.harte-lyne.ca[216.185.71.32]: 221 2.0.0 Bye
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 209.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 209.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.27
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr: 216.185.
6.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: match_hostaddr:
216.185.71.32 ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26480]: disconnect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-PIPELINING
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-SIZE 20480000
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-ETRN
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_list_match:
mx32.harte-lyne.ca: no match
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_list_match:
216.185.71.32: no match
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-STARTTLS
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-ENHANCEDSTATUSCODES
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 250-8BITMIME
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 250 DSN
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: watchdog_pat: 0x7fc83160aa40
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: <
mx32.harte-lyne.ca[216.185.71.32]: STARTTLS
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 220 2.0.0 Ready to start TLS
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: send attr request = seed
vice=smtp, realm=(null)
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: name_mask: noanonymous
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: watchdog_pat: 0x7f5fb7f23a40
Jun 26 18:11:01 inet07 postfix/smtpd[26482]:
xsasl_cyrus_server_create: SASL service=smtp, realm=(null)
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: name_mask: noanonymous
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: watchdog_pat: 0x7f7353e21a40
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: <
mx32.harte-lyne.ca[216.185.71.32]: QUIT
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: >
mx32.harte-lyne.ca[216.185.71.32]: 221 2.0.0 Bye
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 209.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr: 216.
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: match_hostaddr:
216.185.71.32 ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26275]: disconnect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 26 18:11:01 inet07 postfix/smtpd[26483]:
xsasl_cyrus_server_create: SASL service=smtp, realm=(null)
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: name_mask: noanonymous
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: watchdog_pat: 0x7fc83160aa40
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: <
mx32.harte-lyne.ca[216.185.71.32]: QUIT
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: >
mx32.harte-lyne.ca[216.185.71.32]: 221 2.0.0 Bye
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 209.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 209.47.176.18
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.27
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 209.47.176.27
6.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: match_hostaddr:
216.185.71.32 ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26482]: disconnect from
mx32.harte-lyne.ca[216.185.71.32]
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: <
mx32.harte-lyne.ca[216.185.71.32]: QUIT
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: >
mx32.harte-lyne.ca[216.185.71.32]: 221 2.0.0 Bye
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 127.0.0.0/8
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 209.47.176.17
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr: 216
~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 216.185.71.18
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 216.185.71.27
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 216.185.71.28
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 216.185.71.31
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostname:
mx32.harte-lyne.ca ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: match_hostaddr:
216.185.71.32 ~? 216.185.71.32
Jun 26 18:11:01 inet07 postfix/smtpd[26483]: disconnect from
mx32.harte-lyne.ca[216.185.71.32]
On the IMAP service host /etc/postfix/main.cf has these entries:
282 mynetworks = 127.0.0.0/8,
283 209.47.176.17,
284 209.47.176.18,
285 209.47.176.27,
286 209.47.176.28,
287 216.185.71.17,
288 216.185.71.18,
289 216.185.71.27,
290 216.185.71.28,
291 216.185.71.31,
292 216.185.71.32,
293 216.185.71.43,
294 216.185.71.44,
295 216.185.71.131,
296 216.185.71.132,
297 216.185.71.150
626 # defaults: none
627 smtpd_helo_restrictions =
628 permit_mynetworks,
629 check_helo_access pcre:/etc/postfix/helo_checks.pcre,
630 reject_non_fqdn_helo_hostname,
631 reject_unknown_helo_hostname,
632 permit
633
634 # defaults: none
635 smtpd_sender_restrictions =
636 permit_mynetworks,
637 check_sender_access hash:/etc/postfix/sender_access,
638 check_sender_mx_access hash:/etc/postfix/sender_mx_access,
639 check_sender_ns_access hash:/etc/postfix/sender_ns_access,
640 permit_sasl_authenticated,
641 reject_non_fqdn_sender,
642 reject_unknown_sender_domain,
643 permit
[root@inet07 ~]# postconf -n
. . .
mynetworks = 127.0.0.0/8, 209.47.176.17,
209.47.176.18, 209.47.176.27, 209.47.176.28,
216.185.71.17, 216.185.71.18,
216.185.71.27, 216.185.71.28, 216.185.71.31,
216.185.71.32, 216.185.71.43,
216.185.71.44, 216.185.71.131,
216.185.71.132, 216.185.71.150
Now it appears to me from the IMAP server's maillog entries that as
soon as it matches the address of mx32 in mynetworks then it drops the
connection without any further processing. I cannot fathom why.
--
*** e-Mail is NOT a SECURE channel ***
Do NOT transmit sensitive data via e-Mail
Do NOT open attachments nor follow links sent by e-Mail
James B. Byrne mailto:byrn...@harte-lyne.ca
Harte & Lyne Limited http://www.harte-lyne.ca
9 Brockley Drive vox: +1 905 561 1241
Hamilton, Ontario fax: +1 905 561 0757
Canada L8E 3C3
