Am Wed, 26 Oct 2016 10:39:58 +0000
schrieb Matthias Andree <[email protected]>:

> Am 26. Oktober 2016 12:33:48 MESZ, schrieb Julian Kippels
> <[email protected]>:
> >Hi,
> >
> >I was just wondering why my postfix was continuing to try to deliver
> >a mail to another server after getting a 554 response the first time.
> >Shouldn't the delivery stop right then and there and the sender be
> >notified? Instead postfix tried for several days to deliver the
> >message before it ultimately failed and notified the sender.
> >soft_bounce is set to "no" if that has anything to do with it.
> >
> >Thanks,
> >Julian  
> 
> [x] Show logs and postconf -n output 

Excerpt from logs:

Oct 15 23:16:19 balder postfix/smtpd[11356]: 5FDBC8002F90: 
client=unknown[192.168.25.1]
Oct 15 23:16:20 balder postfix/cleanup[10179]: 5FDBC8002F90: 
message-id=<1828752.6O79ctzo1a@thomas>
Oct 15 23:16:20 balder postfix/qmgr[9660]: 5FDBC8002F90: 
from=<[email protected]>, size=2845180, nrcpt=3 (queue active)
Oct 15 23:16:21 balder postfix/smtp[12174]: 5FDBC8002F90: host 
ppmx1.its.rochester.edu[128.151.57.241] refused to talk to me: 554 
ppmx1.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242
Oct 15 23:16:22 balder postfix/smtp[12174]: 5FDBC8002F90: host 
ppmx6.its.rochester.edu[128.151.24.34] refused to talk to me: 554 
ppmx6.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242
Oct 15 23:16:22 balder postfix/smtp[12174]: 5FDBC8002F90: host 
ppmx5.its.rochester.edu[128.151.24.33] refused to talk to me: 554 
ppmx5.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242
Oct 15 23:16:22 balder postfix/smtp[12174]: 5FDBC8002F90: host 
ppmx2.its.rochester.edu[128.151.57.242] refused to talk to me: 554 
ppmx2.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242
Oct 15 23:16:23 balder postfix/smtp[12174]: 5FDBC8002F90: 
to=<[email protected]>, relay=ppmx7.its.rochester.edu[128.151.24.35]:25, 
delay=3.8, delays=1/0/2.8/0, dsn=4.0.0, status=deferred (host 
ppmx7.its.rochester.edu[128.151.24.35] refused to talk to me: 554 
ppmx7.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242)
Oct 15 23:16:31 balder postfix/smtp[12173]: 5FDBC8002F90: host 
pony-express.cs.rit.edu[129.21.30.24] said: 451 Temporary failure, please try 
again later. (in reply to RCPT TO command)
Oct 15 23:16:42 balder postfix/smtp[12173]: 5FDBC8002F90: to=<[email protected]>, 
relay=pony-express.cs.rit.edu[129.21.30.24]:25, delay=23, delays=1/0/22/0.21, 
dsn=4.0.0, status=deferred (host pony-express.cs.rit.edu[129.21.30.24] said: 
451 Temporary failure, please try again later. (in reply to RCPT TO command))
Oct 15 23:22:14 balder postfix/qmgr[9660]: 5FDBC8002F90: 
from=<[email protected]>, size=2845180, nrcpt=3 (queue active)
Oct 15 23:22:14 balder postfix/smtp[13566]: 5FDBC8002F90: host 
ppmx3.its.rochester.edu[128.151.57.243] refused to talk to me: 554 
ppmx3.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242
Oct 15 23:22:14 balder postfix/smtp[13566]: 5FDBC8002F90: host 
ppmx7.its.rochester.edu[128.151.24.35] refused to talk to me: 554 
ppmx7.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242
Oct 15 23:22:15 balder postfix/smtp[13566]: 5FDBC8002F90: host 
ppmx2.its.rochester.edu[128.151.57.242] refused to talk to me: 554 
ppmx2.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242
Oct 15 23:22:15 balder postfix/smtp[13566]: 5FDBC8002F90: host 
ppmx5.its.rochester.edu[128.151.24.33] refused to talk to me: 554 
ppmx5.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242
Oct 15 23:22:15 balder postfix/smtp[13566]: 5FDBC8002F90: 
to=<[email protected]>, relay=ppmx8.its.rochester.edu[128.151.24.28]:25, 
delay=356, delays=355/0.06/1.5/0, dsn=4.0.0, status=deferred (host 
ppmx8.its.rochester.edu[128.151.24.28] refused to talk to me: 554 
ppmx8.its.rochester.edu ESMTP Blocked - see 
https://support.proofpoint.com/dnsbl-lookup.cgi?ip=134.99.128.242)
Oct 15 23:22:25 balder postfix/smtp[13564]: 5FDBC8002F90: host 
pony-express.cs.rit.edu[129.21.30.24] said: 451 Temporary failure, please try 
again later. (in reply to RCPT TO command)
Oct 15 23:22:35 balder postfix/smtp[13564]: 5FDBC8002F90: to=<[email protected]>, 
relay=pony-express.cs.rit.edu[129.21.30.24]:25, delay=376, 
delays=355/0.05/21/0.21, dsn=4.0.0, status=deferred (host 
pony-express.cs.rit.edu[129.21.30.24] said: 451 Temporary failure, please try 
again later. (in reply to RCPT TO command))
...

postconf -n
alias_database = hash:/etc/aliases
alias_maps = hash:/etc/aliases
broadcaster_only = check_policy_service inet:localhost:2000
broken_sasl_auth_clients = yes
command_directory = /usr/sbin
config_directory = /etc/postfix
daemon_directory = /usr/libexec/postfix
data_directory = /var/lib/postfix
debug_peer_level = 2
debugger_command = PATH=/bin:/usr/bin:/usr/local/bin:/usr/X11R6/bin ddd 
$daemon_directory/$process_name $process_id & sleep 5
html_directory = no
inet_interfaces = all
inet_protocols = all
local_recipient_maps = $virtual_mailbox_maps
mail_owner = postfix
mailbox_size_limit = 14336000000
mailq_path = /usr/bin/mailq.postfix
manpage_directory = /usr/share/man
message_size_limit = 143360000
mydestination = $myhostname, localhost.$mydomain, localhost
mynetworks = 127.0.0.0/8 cidr:/etc/postfix/mynetworks-25.cidr
mynetworks_style = host
newaliases_path = /usr/bin/newaliases.postfix
propagate_unmatched_extensions =
queue_directory = /var/spool/postfix
readme_directory = /usr/share/doc/postfix-2.10.1/README_FILES
recipient_delimiter = +
relay_domains =
relay_recipient_maps = hash:/etc/postfix/relay_recipients
sample_directory = /usr/share/doc/postfix-2.10.1/samples
sendmail_path = /usr/sbin/sendmail.postfix
setgid_group = postdrop
smtp_tls_cert_file = /etc/postfix/cert/balder-cert.pem
smtp_tls_key_file = /etc/postfix/cert/balder-key.pem
smtp_tls_security_level = may
smtpd_policy_service_timeout = 200s
smtpd_recipient_restrictions = check_recipient_access 
ldap:/etc/postfix/recipient_access.cf permit_mynetworks 
permit_sasl_authenticated reject_unauth_destination
smtpd_restriction_classes = broadcaster_only
smtpd_sasl_auth_enable = yes
smtpd_sasl_path = inet:192.168.25.210:12345
smtpd_sasl_type = dovecot
smtpd_tls_cert_file = /etc/postfix/cert/balder-cert.pem
smtpd_tls_key_file = /etc/postfix/cert/balder-key.pem
smtpd_tls_security_level = may
spamwatch_policy = check_policy_service inet:localhost:2001
transport_maps = ldap:/etc/postfix/transport_maps.cf
unknown_local_recipient_reject_code = 550
virtual_alias_expansion_limit = 50000
virtual_alias_maps = ldap:/etc/postfix/virtual_alias_maps.cf
virtual_mailbox_domains = hash:/etc/postfix/virtual_mailbox_domains
virtual_mailbox_maps = $virtual_alias_maps

One interesting thing I noticed while looking up the log excerpt: The
original mail was sent to two recipients. One server sent a 554, the other
sent a 451. Did the 451 from rit.edu trigger the retries for rochester.edu
which sent the 554?

Julian

Reply via email to