I've got an assp --> Exim setup which runs OK.
However there are some messages that never get delivered until I whitelist the IP or the sender (so they are NoProcessing).
The problem is that assp reports no problem at all!
Exim has a timeout (received not date) and then assp quits on that email.
Adding emailaddres or IP-address of the sending server in assp does fix the problem, so it's assp that is stop sending data.
I changed MsgScoreOnEnd to on, but this didn't help.
What's the underlying problem here?
Here are the logs of 2 such emails (I have one of these about every 5 minutes)
** Example-1 Part 1 (assp) **
Nov-23-16 00:23:11 [Worker_1] Connected: session:7FA6DF7766E8 87.233.197.18:56293 > 85.17.135.232:25 > 85.17.135.232:125
Nov-23-16 00:23:11 [Worker_1] 87.233.197.18 info: got STARTTLS request from 87.233.197.18
Nov-23-16 00:23:11 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] 87.233.197.18 bounces@avatar.hosts.bc.nl info: found message size announcement: 28.65 kByte
Nov-23-16 00:23:11 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] 87.233.197.18 bounces@avatar.hosts.bc.nl Message-Score: added -10 (tlsValencePB) for SSL-TLS-connection-OK, total score for this message is now -10
Nov-23-16 00:23:11 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] [MsgID] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ [scoring] (Message-ID not valid: '20161122055226.17009.883774938.swift@avatar')
Nov-23-16 00:23:11 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ Message-Score: added 10 (midiValencePB) for Message-ID not valid: '20161122055226.17009.883774938.swift@avatar', total score for this message is now 0
Nov-23-16 00:23:11 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ info: remove IP-score from 87.233.197.18 - this mail passed the SPF check
Nov-23-16 00:23:11 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ Message-Score: added -10 (spfpValencePB) for SPF pass, total score for this message is now -10
Nov-23-16 00:23:12 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ Message-Score: added 10 for Foreign IP-Country NL (TRUESERVER BV), total score for this message is now 0
Nov-23-16 00:23:12 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] [MissingMX] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ [[scoring]] MX missing (cache): avatar.hosts.bc.nl (Mail From:)
Nov-23-16 00:23:12 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ Message-Score: added 10 (mxValencePB) for MX missing (cache): avatar.hosts.bc.nl (Mail From:), total score for this message is now 10
Nov-23-16 00:23:12 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] [MessageOK] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ message ok [Tips .... smartphone]
** Example-1 Part 2 (Exim) **
2016-11-23 00:23:11 SMTP connection from [85.17.135.232]:37718 (TCP/IP connection count = 2)
2016-11-23 00:23:11 SMTP connection identification H=localhost A=85.17.135.232 P=37718 U=root ID=0 S=root B=identify_local_connection
** Example-1 Part 3 (Exim) **
2016-11-23 00:25:57 1c9KP9-000EPj-OZ SMTP data timeout (message abandoned) on connection from srv120.peweb.com [85.17.135.232]:37718 F=bounces@avatar.hosts.bc.nl
** Example-1 Part 4 (assp) **
Nov-23-16 00:25:57 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] [MessageOK] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ info: got reply '421 srv120.peweb.com SMTP incoming data timeout - closing connection.' - message is rejected by the server host 85.17.135.232
Nov-23-16 00:25:57 m1-56991-11742 [Worker_1] [TLS-in] [TLS-out] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ [SMTP Status] 421 srv120.peweb.com SMTP incoming data timeout - closing connection.
Nov-23-16 00:25:57 m1-56991-11742 [Worker_1] [TLS-in] [SSL-out] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ finished message - received DATA size: 28.76 kByte - sent DATA size: 29.75 kByte
Nov-23-16 00:25:57 m1-56991-11742 [Worker_1] [TLS-in] [SSL-out] 87.233.197.18 bounces@avatar.hosts.bc.nl to: @ disconnected: session:7FA6DF7766E8 87.233.197.18 - processing time 166 seconds
** Example-2 Part 1 (assp) **
Nov-23-16 00:32:57 [Worker_1] Connected: session:B811E00 192.115.0.11:48585 > 85.17.135.232:25 > 85.17.135.232:125
Nov-23-16 00:32:57 [Worker_1] 192.115.0.11 info: injected STARTTLS request to 85.17.135.232
Nov-23-16 00:32:58 m1-57577-12551 [Worker_1] [TLS-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ info: domain isoc.org.il has published a DMARC record
Nov-23-16 00:32:58 m1-57577-12551 [Worker_1] [TLS-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ [scoring] SPF: none (cache) ip=192.115.0.11 mailfrom=renew-bounced@register.isoc.org.il helo=register2.isoc.org.il
Nov-23-16 00:32:58 m1-57577-12551 [Worker_1] [TLS-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ DMARC: this mail breakes the DKIM policies defined in the DMARC record for domain isoc.org.il - there is no DKIM-signature found in this mail for domain isoc.org.il
Nov-23-16 00:32:58 m1-57577-12551 [Worker_1] [TLS-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ whiteHost Regex: whiteSenderBaseRE 'isoc.org'
Nov-23-16 00:32:58 m1-57577-12551 [Worker_1] [TLS-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ Message-Score: added -25 for White Host 'isoc.org', total score for this message is now -25
Nov-23-16 00:32:58 m1-57577-12551 [Worker_1] [TLS-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ SenderBase -- White Host 'isoc.org'
Nov-23-16 00:32:58 m1-57577-12551 [Worker_1] [TLS-out] [MessageOK] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ message ok [IMPORTANT: Domain Name ....co.il is up for renewal ]
** Example-2 Part 2 (Exim) **
2016-11-23 00:32:57 SMTP connection from [85.17.135.232]:37861 (TCP/IP connection count = 1)
2016-11-23 00:32:57 SMTP connection identification H=localhost A=85.17.135.232 P=37861 U=root ID=0 S=root B=identify_local_connection
** Example-2 Part 3 (Exim) **
2016-11-23 00:35:43 1c9KYb-000Ev1-Ir SMTP data timeout (message abandoned) on connection from srv120.peweb.com [85.17.135.232]:37861 F=renew-bounced@register.isoc.org.il
** Example-2 Part 4 (assp) **
Nov-23-16 00:35:43 m1-57577-12551 [Worker_1] [TLS-out] [MessageOK] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ info: got reply '421 srv120.peweb.com SMTP incoming data timeout - closing connection.' - message is rejected by the server host 85.17.135.232
Nov-23-16 00:35:43 m1-57577-12551 [Worker_1] [TLS-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ [SMTP Status] 421 srv120.peweb.com SMTP incoming data timeout - closing connection.
Nov-23-16 00:35:43 m1-57577-12551 [Worker_1] [SSL-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ info: PB-IP-Score for '192.115.0.0' is 0, added -49 in this session
Nov-23-16 00:35:43 m1-57577-12551 [Worker_1] [SSL-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ finished message - received DATA size: 2.83 kByte - sent DATA size: 3.42 kByte
Nov-23-16 00:35:43 m1-57577-12551 [Worker_1] [SSL-out] 192.115.0.11 renew-bounced@register.isoc.org.il to: @ disconnected: session:B811E00 192.115.0.11 - processing time 166 seconds
Log in to post a comment.
