Re: [Exim] best MX choice

Top Page
Delete this message
Reply to this message
Author: Dmitry Sergienko
Date:  
To: exim-users
Old-Topics: Re: [Exim] best MX choice
Subject: Re: [Exim] best MX choice
Philip Hazel wrote:
>>I'm running Exim 4.12. One day I noticed that exim routes messages to MX
>>with higher value than it is set for this machine. For example:
>>
>>I have domain example.net:
>>example.net mail is handled (pri=10) by relay1.example.net
>>example.net mail is handled (pri=25) by relay2.example.net
>>example.net mail is handled (pri=150) by relay3.example.net
>>
>>relay2.example.net is machine where all happens.
>>If relay1.example.net is in retry database, exim routes all messages to
>>relay3.example.net, but it shouldn't do this, because relay2.example.net
>>have higher priority (lower MX value) than relay3.example.net.
>
>
> Please post more evidence of an actual case of this, such as the output
> of a delivery run with debugging (-d) turned on. Are you sure that
> relay2 is not in the retry database? Are you sure that relay2 has an MX
> record that points to an accessible host?


Sorry for such long delay, just missed your letter.

relay2 is machine where delivery is being done, so I don't understand
how it can be in retry database or inaccessible host. Maybe you meant
relay1? If so, it is in retry database, because it is inaccessible.
But the main problem is that I don't want exim to try any other MX'es in
this case. Otherwise I have a ping-pong beetween relay2 and relay3.

That's a log of such delivery:

Exim version 4.14 uid=0 gid=0 pid=78263 D=fbb95cfd
Probably Berkeley DB version 1.8x (native mode)
Support for: IPv6 PAM Perl OpenSSL
Authenticators: cram_md5 plaintext
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
changed uid/gid: forcing real = effective
   uid=0 gid=0 pid=78263
   auxiliary group list: 0
configuration file is /usr/local/etc/exim/configure
log selector = 02fd99d8
trusted user
admin user
finduser used cached passwd data for mailnull
finduser used cached passwd data for nobody
finduser used cached passwd data for nobody
originator: uid=0 gid=0 login=root name=Charlie Root
78263 LOG: MAIN
78263   IPv6 socket creation failed: Protocol not supported
78263 LOG: MAIN
78263   Failed to create IPv6 socket for wildcard listening (Protocol
not supported): falling back to IPv4
78263 listening on all interfaces (IPv4) port 2026
78263 changed uid/gid: running as a daemon
78263   uid=26 gid=6 pid=78263
78263   auxiliary group list: 6
78263 LOG: MAIN
78263   exim 4.14 daemon started: pid=78263, no queue runs, listening
for SMTP on port 2026 (IPv4)
78263 set_process_info: 78263 daemon: no queue runs, listening for SMTP
78263 daemon running with uid=26 gid=6 euid=26 egid=6
78263 Listening...
78263 Connection request from 192.168.1.100 port 2868
78263 1 SMTP accept process running
78263 Listening...
78268 host in rfc1413_hosts? yes (matched "*")
78268 doing ident callback
78268 ident connection to 192.168.1.100 failed: Connection refused
78268 sender_fullhost = [192.168.1.100]
78268 sender_rcvhost = [192.168.1.100]
78268 Process 78268 is handling incoming connection from [192.168.1.100]
78268 host in host_lookup? yes (matched "*")
78268 looking up host name for 192.168.1.100
78268 IP address lookup yielded i100.example.net
78268 gethostbyname2 returned 4 (NO_DATA)
78268 gethostbyname2 looked up these IP addresses:
78268   name=i100.example.net address=192.168.1.100
78268 checking addresses for i100.example.net
78268   192.168.1.100
78268 sender_fullhost = i100.example.net [192.168.1.100]
78268 sender_rcvhost = i100.example.net ([192.168.1.100])
78268 set_process_info: 78268 handling incoming connection from
i100.example.net [192.168.1.100]
78268 host in host_reject_connection? no (option unset)
78268 host in sender_unqualified_hosts? no (option unset)
78268 host in recipient_unqualified_hosts? no (option unset)
78268 host in helo_verify_hosts? no (option unset)
78268 host in helo_try_verify_hosts? no (option unset)
78268 host in helo_accept_junk_hosts? no (option unset)
78268 LOG: smtp_connection MAIN
78268   SMTP connection from i100.example.net [192.168.1.100] (TCP/IP
connection count = 1)
78268 SMTP>> 220 apex.dp.ua ESMTP Wed, 03 Sep 2003 17:02:52 +0300
78268 Process 78268 is ready for new message
78268 smtp_setup_msg entered
78268 SMTP<< mail from:<trooper@???>
78268 using ACL "acl_check_sender"
78268 processing "accept"
78268 check senders = dbm*@;/etc/mail-exim/access/wl-senders.db
78268 address match: subject=trooper@???
pattern=dbm*@;/etc/mail-exim/access/wl-senders.db
78268 search_open: dbm "/etc/mail-exim/access/wl-senders.db"
78268 search_find: file="/etc/mail-exim/access/wl-senders.db"
78268   key="trooper@???" partial=-1 affix=NULL starflags=2
78268 LRU list:
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/access/wl-senders.db"
78268   type=dbm key="trooper@???"
78268 file lookup required for trooper@???
78268   in /etc/mail-exim/access/wl-senders.db
78268 lookup failed
78268 trying default match *@domain.com
78268 internal_search_find: file="/etc/mail-exim/access/wl-senders.db"
78268   type=dbm key="*@domain.com"
78268 file lookup required for *@domain.com
78268   in /etc/mail-exim/access/wl-senders.db
78268 lookup failed
78268 trying to match *
78268 internal_search_find: file="/etc/mail-exim/access/wl-senders.db"
78268   type=dbm key="*"
78268 file lookup required for *
78268   in /etc/mail-exim/access/wl-senders.db
78268 lookup failed
78268 trooper@??? in "dbm*@;/etc/mail-exim/access/wl-senders.db"?
no (end of list)
78268 accept: condition test failed
78268 processing "deny"
78268 check senders = dbm*@;/etc/mail-exim/access/bl-senders.db
78268 address match: subject=trooper@???
pattern=dbm*@;/etc/mail-exim/access/bl-senders.db
78268 search_open: dbm "/etc/mail-exim/access/bl-senders.db"
78268 search_find: file="/etc/mail-exim/access/bl-senders.db"
78268   key="trooper@???" partial=-1 affix=NULL starflags=2
78268 LRU list:
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/access/bl-senders.db"
78268   type=dbm key="trooper@???"
78268 file lookup required for trooper@???
78268   in /etc/mail-exim/access/bl-senders.db
78268 lookup failed
78268 trying default match *@domain.com
78268 internal_search_find: file="/etc/mail-exim/access/bl-senders.db"
78268   type=dbm key="*@domain.com"
78268 file lookup required for *@domain.com
78268   in /etc/mail-exim/access/bl-senders.db
78268 lookup failed
78268 trying to match *
78268 internal_search_find: file="/etc/mail-exim/access/bl-senders.db"
78268   type=dbm key="*"
78268 file lookup required for *
78268   in /etc/mail-exim/access/bl-senders.db
78268 lookup failed
78268 trooper@??? in "dbm*@;/etc/mail-exim/access/bl-senders.db"?
no (end of list)
78268 deny: condition test failed
78268 processing "accept"
78268 accept: condition test succeeded
78268 SMTP>> 250 OK
78268 SMTP<< rcpt to:<test@???>
78268 using ACL "acl_check_rcpt"
78268 processing "accept"
78268 check hosts = :
78268 host in ":"? no (end of list)
78268 accept: condition test failed
78268 processing "deny"
78268 check hosts = /etc/mail-exim/access.deny
78268 host in "/etc/mail-exim/access.deny"? no (end of list)
78268 deny: condition test failed
78268 processing "deny"
78268 check dnslists = bl.spamcop.net : relays.ordb.org
78268 DNS list check: bl.spamcop.net
78268 new DNS lookup for 100.1.168.192.bl.spamcop.net
78268 DNS lookup of 100.1.168.192.bl.spamcop.net (A) gave HOST_NOT_FOUND
78268 returning DNS_NOMATCH
78268 DNS lookup for 100.1.168.192.bl.spamcop.net failed
78268 => that means 192.168.1.100 is not listed at bl.spamcop.net
78268 DNS list check: relays.ordb.org
78268 new DNS lookup for 100.1.168.192.relays.ordb.org
78268 DNS lookup of 100.1.168.192.relays.ordb.org (A) gave HOST_NOT_FOUND
78268 returning DNS_NOMATCH
78268 DNS lookup for 100.1.168.192.relays.ordb.org failed
78268 => that means 192.168.1.100 is not listed at relays.ordb.org
78268 deny: condition test failed
78268 processing "deny"
78268 check local_parts = ^.*[@%!/|] : ^\\.
78268 test in "^.*[@%!/|] : ^\."? no (end of list)
78268 deny: condition test failed
78268 processing "accept"
78268 check recipients = dbm*@;/etc/mail-exim/access/wl-rcpts.db
78268 address match: subject=test@???
pattern=dbm*@;/etc/mail-exim/access/wl-rcpts.db
78268 search_open: dbm "/etc/mail-exim/access/wl-rcpts.db"
78268 search_find: file="/etc/mail-exim/access/wl-rcpts.db"
78268   key="test@???" partial=-1 affix=NULL starflags=2
78268 LRU list:
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/access/wl-rcpts.db"
78268   type=dbm key="test@???"
78268 file lookup required for test@???
78268   in /etc/mail-exim/access/wl-rcpts.db
78268 lookup failed
78268 trying default match *@relay1.example.net
78268 internal_search_find: file="/etc/mail-exim/access/wl-rcpts.db"
78268   type=dbm key="*@relay1.example.net"
78268 file lookup required for *@relay1.example.net
78268   in /etc/mail-exim/access/wl-rcpts.db
78268 lookup failed
78268 trying to match *
78268 internal_search_find: file="/etc/mail-exim/access/wl-rcpts.db"
78268   type=dbm key="*"
78268 file lookup required for *
78268   in /etc/mail-exim/access/wl-rcpts.db
78268 lookup failed
78268 test@??? in
"dbm*@;/etc/mail-exim/access/wl-rcpts.db"? no (end of list)
78268 accept: condition test failed
78268 processing "deny"
78268 check domains = partial-dbm;/etc/mail-exim/access/bl-rcpt-domains.db
78268 search_open: dbm "/etc/mail-exim/access/bl-rcpt-domains.db"
78268 search_find: file="/etc/mail-exim/access/bl-rcpt-domains.db"
78268   key="relay1.example.net" partial=2 affix=*. starflags=0
78268 LRU list:
78268   1/etc/mail-exim/access/bl-rcpt-domains.db
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/access/bl-rcpt-domains.db"
78268   type=dbm key="relay1.example.net"
78268 file lookup required for relay1.example.net
78268   in /etc/mail-exim/access/bl-rcpt-domains.db
78268 lookup failed
78268 trying partial match *.relay1.example.net
78268 internal_search_find: file="/etc/mail-exim/access/bl-rcpt-domains.db"
78268   type=dbm key="*.relay1.example.net"
78268 file lookup required for *.relay1.example.net
78268   in /etc/mail-exim/access/bl-rcpt-domains.db
78268 lookup failed
78268 trying partial match *.dp.ua
78268 internal_search_find: file="/etc/mail-exim/access/bl-rcpt-domains.db"
78268   type=dbm key="*.dp.ua"
78268 file lookup required for *.dp.ua
78268   in /etc/mail-exim/access/bl-rcpt-domains.db
78268 lookup failed
78268 relay1.example.net in
"partial-dbm;/etc/mail-exim/access/bl-rcpt-domains.db"? no (end of list)
78268 deny: condition test failed
78268 processing "deny"
78268 check recipients = dbm*@;/etc/mail-exim/access/bl-rcpts.db
78268 address match: subject=test@???
pattern=dbm*@;/etc/mail-exim/access/bl-rcpts.db
78268 search_open: dbm "/etc/mail-exim/access/bl-rcpts.db"
78268 search_find: file="/etc/mail-exim/access/bl-rcpts.db"
78268   key="test@???" partial=-1 affix=NULL starflags=2
78268 LRU list:
78268   1/etc/mail-exim/access/bl-rcpts.db
78268   1/etc/mail-exim/access/bl-rcpt-domains.db
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/access/bl-rcpts.db"
78268   type=dbm key="test@???"
78268 file lookup required for test@???
78268   in /etc/mail-exim/access/bl-rcpts.db
78268 lookup failed
78268 trying default match *@relay1.example.net
78268 internal_search_find: file="/etc/mail-exim/access/bl-rcpts.db"
78268   type=dbm key="*@relay1.example.net"
78268 file lookup required for *@relay1.example.net
78268   in /etc/mail-exim/access/bl-rcpts.db
78268 lookup failed
78268 trying to match *
78268 internal_search_find: file="/etc/mail-exim/access/bl-rcpts.db"
78268   type=dbm key="*"
78268 file lookup required for *
78268   in /etc/mail-exim/access/bl-rcpts.db
78268 lookup failed
78268 test@??? in
"dbm*@;/etc/mail-exim/access/bl-rcpts.db"? no (end of list)
78268 deny: condition test failed
78268 processing "accept"
78268 check hosts = +relay_from_hosts : /etc/mail-exim/access.allow
78268 host in "127.0.0.1"? no (end of list)
78268 host in "+relay_from_hosts : /etc/mail-exim/access.allow"? no (end
of list)
78268 accept: condition test failed
78268 processing "accept"
78268 check authenticated = *
78268 accept: condition test failed
78268 processing "accept"
78268 check local_parts = postmaster
78268 test in "postmaster"? no (end of list)
78268 accept: condition test failed
78268 processing "accept"
78268 check domains = +relay_to_domains : +cyrus_domains
78268 DNS lookup of relay1.example.net (MX) succeeded
78268 local host in host list - removed hosts:
78268   apex.dp.ua 192.168.1.4 10
78268   relay3.example.net xxx.xxx.xxx.65 25
78268   relay4.example.net xxx.xxx.xxx.119 150
78268 host_find_bydns yield = HOST_FOUND (2); returned hosts:
78268   mail.relay1.example.net xxx.xxx.xxx.242 5
78268 relay1.example.net in "@[] : @mx_any"? yes (matched "@mx_any")
78268 relay1.example.net in "+relay_to_domains : +cyrus_domains"? yes
(matched "+relay_to_domains")
78268 cached lookup data = NULL
78268 check verify = recipient
78268 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
78268 Verifying test@???
78268 address match: subject=test@??? pattern=*@home.dp.ua
78268 relay1.example.net in "home.dp.ua"? no (end of list)
78268 test@??? in "*@home.dp.ua"? no (end of list)
78268 address match: subject=test@???
pattern=*@*.dnepropetrovsk.ua
78268 relay1.example.net in "*.dnepropetrovsk.ua"? no (end of list)
78268 test@??? in "*@*.dnepropetrovsk.ua"? no (end of list)
78268 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
78268 Considering test@???
78268 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
78268 routing test@???
78268 --------> virtual router <--------
78268 local_part=test domain=relay1.example.net
78268 checking domains
78268 search_open: dsearch "/etc/mail-exim/virtual"
78268 search_find: file="/etc/mail-exim/virtual"
78268   key="relay1.example.net" partial=-1 affix=NULL starflags=0
78268 LRU list:
78268   4/etc/mail-exim/virtual
78268   1/etc/mail-exim/access/bl-rcpts.db
78268   1/etc/mail-exim/access/bl-rcpt-domains.db
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/virtual"
78268   type=dsearch key="relay1.example.net"
78268 file lookup required for relay1.example.net
78268   in /etc/mail-exim/virtual
78268 lookup failed
78268 relay1.example.net in "dsearch;/etc/mail-exim/virtual"? no (end of
list)
78268 virtual router skipped: domains mismatch
78268 --------> cyrus_lowercase router <--------
78268 local_part=test domain=relay1.example.net
78268 checking domains
78268 relay1.example.net in "domain.com : asdf.dp.ua"? no (end of list)
78268 relay1.example.net in "+cyrus_domains"? no (end of list)
78268 cached lookup data = NULL
78268 cyrus_lowercase router skipped: domains mismatch
78268 --------> cyrus router <--------
78268 local_part=test domain=relay1.example.net
78268 checking domains
78268 cached no match for +cyrus_domains
78268 relay1.example.net in "+cyrus_domains"? no (end of list)
78268 cached lookup data = NULL
78268 cyrus router skipped: domains mismatch
78268 --------> esmtp router <--------
78268 local_part=test domain=relay1.example.net
78268 calling esmtp router
78268 esmtp router called for test@???
78268   domain = relay1.example.net
78268 search_open: dbm "/etc/mail-exim/routes/esmtp.db"
78268 search_find: file="/etc/mail-exim/routes/esmtp.db"
78268   key="relay1.example.net" partial=2 affix=*. starflags=0
78268 LRU list:
78268   1/etc/mail-exim/routes/esmtp.db
78268   4/etc/mail-exim/virtual
78268   1/etc/mail-exim/access/bl-rcpts.db
78268   1/etc/mail-exim/access/bl-rcpt-domains.db
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/routes/esmtp.db"
78268   type=dbm key="relay1.example.net"
78268 file lookup required for relay1.example.net
78268   in /etc/mail-exim/routes/esmtp.db
78268 lookup failed
78268 trying partial match *.relay1.example.net
78268 internal_search_find: file="/etc/mail-exim/routes/esmtp.db"
78268   type=dbm key="*.relay1.example.net"
78268 file lookup required for *.relay1.example.net
78268   in /etc/mail-exim/routes/esmtp.db
78268 lookup failed
78268 trying partial match *.dp.ua
78268 internal_search_find: file="/etc/mail-exim/routes/esmtp.db"
78268   type=dbm key="*.dp.ua"
78268 file lookup required for *.dp.ua
78268   in /etc/mail-exim/routes/esmtp.db
78268 lookup failed
78268 esmtp router declined for test@???
78268 --------> fido router <--------
78268 local_part=test domain=relay1.example.net
78268 checking domains
78268 search_open: dbm "/etc/mail-exim/routes/fido.db"
78268 search_find: file="/etc/mail-exim/routes/fido.db"
78268   key="relay1.example.net" partial=2 affix=*. starflags=0
78268 LRU list:
78268   1/etc/mail-exim/routes/fido.db
78268   1/etc/mail-exim/routes/esmtp.db
78268   4/etc/mail-exim/virtual
78268   1/etc/mail-exim/access/bl-rcpts.db
78268   1/etc/mail-exim/access/bl-rcpt-domains.db
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/routes/fido.db"
78268   type=dbm key="relay1.example.net"
78268 file lookup required for relay1.example.net
78268   in /etc/mail-exim/routes/fido.db
78268 lookup failed
78268 trying partial match *.relay1.example.net
78268 internal_search_find: file="/etc/mail-exim/routes/fido.db"
78268   type=dbm key="*.relay1.example.net"
78268 file lookup required for *.relay1.example.net
78268   in /etc/mail-exim/routes/fido.db
78268 lookup failed
78268 trying partial match *.dp.ua
78268 internal_search_find: file="/etc/mail-exim/routes/fido.db"
78268   type=dbm key="*.dp.ua"
78268 file lookup required for *.dp.ua
78268   in /etc/mail-exim/routes/fido.db
78268 lookup failed
78268 relay1.example.net in "partial-dbm;/etc/mail-exim/routes/fido.db"?
no (end of list)
78268 fido router skipped: domains mismatch
78268 --------> uucp_batchmail router <--------
78268 local_part=test domain=relay1.example.net
78268 checking domains
78268 search_open: dbm "/etc/mail-exim/routes/uucp-batchmail.db"
78268 search_find: file="/etc/mail-exim/routes/uucp-batchmail.db"
78268   key="relay1.example.net" partial=2 affix=*. starflags=0
78268 LRU list:
78268   1/etc/mail-exim/routes/uucp-batchmail.db
78268   1/etc/mail-exim/routes/fido.db
78268   1/etc/mail-exim/routes/esmtp.db
78268   4/etc/mail-exim/virtual
78268   1/etc/mail-exim/access/bl-rcpts.db
78268   1/etc/mail-exim/access/bl-rcpt-domains.db
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/routes/uucp-batchmail.db"
78268   type=dbm key="relay1.example.net"
78268 file lookup required for relay1.example.net
78268   in /etc/mail-exim/routes/uucp-batchmail.db
78268 lookup failed
78268 trying partial match *.relay1.example.net
78268 internal_search_find: file="/etc/mail-exim/routes/uucp-batchmail.db"
78268   type=dbm key="*.relay1.example.net"
78268 file lookup required for *.relay1.example.net
78268   in /etc/mail-exim/routes/uucp-batchmail.db
78268 lookup failed
78268 trying partial match *.dp.ua
78268 internal_search_find: file="/etc/mail-exim/routes/uucp-batchmail.db"
78268   type=dbm key="*.dp.ua"
78268 file lookup required for *.dp.ua
78268   in /etc/mail-exim/routes/uucp-batchmail.db
78268 lookup failed
78268 relay1.example.net in
"partial-dbm;/etc/mail-exim/routes/uucp-batchmail.db"? no (end of list)
78268 uucp_batchmail router skipped: domains mismatch
78268 --------> uucp_dom router <--------
78268 local_part=test domain=relay1.example.net
78268 checking domains
78268 search_open: dbm "/etc/mail-exim/routes/uucp-dom.db"
78268 search_find: file="/etc/mail-exim/routes/uucp-dom.db"
78268   key="relay1.example.net" partial=-1 affix=NULL starflags=0
78268 LRU list:
78268   1/etc/mail-exim/routes/uucp-dom.db
78268   1/etc/mail-exim/routes/uucp-batchmail.db
78268   1/etc/mail-exim/routes/fido.db
78268   1/etc/mail-exim/routes/esmtp.db
78268   4/etc/mail-exim/virtual
78268   1/etc/mail-exim/access/bl-rcpts.db
78268   1/etc/mail-exim/access/bl-rcpt-domains.db
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/routes/uucp-dom.db"
78268   type=dbm key="relay1.example.net"
78268 file lookup required for relay1.example.net
78268   in /etc/mail-exim/routes/uucp-dom.db
78268 lookup failed
78268 relay1.example.net in "dbm;/etc/mail-exim/routes/uucp-dom.db"? no
(end of list)
78268 uucp_dom router skipped: domains mismatch
78268 --------> devnull_rcpts router <--------
78268 local_part=test domain=relay1.example.net
78268 checking "condition"
78268 search_open: dbm "/etc/mail-exim/routes/devnull-rcpts.db"
78268 search_find: file="/etc/mail-exim/routes/devnull-rcpts.db"
78268   key="test@???" partial=-1 affix=NULL starflags=2
78268 LRU list:
78268   1/etc/mail-exim/routes/devnull-rcpts.db
78268   1/etc/mail-exim/routes/uucp-dom.db
78268   1/etc/mail-exim/routes/uucp-batchmail.db
78268   1/etc/mail-exim/routes/fido.db
78268   1/etc/mail-exim/routes/esmtp.db
78268   4/etc/mail-exim/virtual
78268   1/etc/mail-exim/access/bl-rcpts.db
78268   1/etc/mail-exim/access/bl-rcpt-domains.db
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/routes/devnull-rcpts.db"
78268   type=dbm key="test@???"
78268 file lookup required for test@???
78268   in /etc/mail-exim/routes/devnull-rcpts.db
78268 lookup failed
78268 trying default match *@relay1.example.net
78268 internal_search_find: file="/etc/mail-exim/routes/devnull-rcpts.db"
78268   type=dbm key="*@relay1.example.net"
78268 file lookup required for *@relay1.example.net
78268   in /etc/mail-exim/routes/devnull-rcpts.db
78268 lookup failed
78268 trying to match *
78268 internal_search_find: file="/etc/mail-exim/routes/devnull-rcpts.db"
78268   type=dbm key="*"
78268 file lookup required for *
78268   in /etc/mail-exim/routes/devnull-rcpts.db
78268 lookup failed
78268 devnull_rcpts router skipped: condition failure
78268 --------> devnull_domains router <--------
78268 local_part=test domain=relay1.example.net
78268 checking "condition"
78268 search_open: dbm "/etc/mail-exim/routes/devnull-domains.db"
78268 search_find: file="/etc/mail-exim/routes/devnull-domains.db"
78268   key="relay1.example.net" partial=2 affix=*. starflags=0
78268 LRU list:
78268   1/etc/mail-exim/routes/devnull-domains.db
78268   1/etc/mail-exim/routes/devnull-rcpts.db
78268   1/etc/mail-exim/routes/uucp-dom.db
78268   1/etc/mail-exim/routes/uucp-batchmail.db
78268   1/etc/mail-exim/routes/fido.db
78268   1/etc/mail-exim/routes/esmtp.db
78268   4/etc/mail-exim/virtual
78268   1/etc/mail-exim/access/bl-rcpts.db
78268   1/etc/mail-exim/access/bl-rcpt-domains.db
78268   1/etc/mail-exim/access/wl-rcpts.db
78268   1/etc/mail-exim/access/bl-senders.db
78268   1/etc/mail-exim/access/wl-senders.db
78268   End
78268 internal_search_find: file="/etc/mail-exim/routes/devnull-domains.db"
78268   type=dbm key="relay1.example.net"
78268 file lookup required for relay1.example.net
78268   in /etc/mail-exim/routes/devnull-domains.db
78268 lookup failed
78268 trying partial match *.relay1.example.net
78268 internal_search_find: file="/etc/mail-exim/routes/devnull-domains.db"
78268   type=dbm key="*.relay1.example.net"
78268 file lookup required for *.relay1.example.net
78268   in /etc/mail-exim/routes/devnull-domains.db
78268 lookup failed
78268 trying partial match *.dp.ua
78268 internal_search_find: file="/etc/mail-exim/routes/devnull-domains.db"
78268   type=dbm key="*.dp.ua"
78268 file lookup required for *.dp.ua
78268   in /etc/mail-exim/routes/devnull-domains.db
78268 lookup failed
78268 devnull_domains router skipped: condition failure
78268 --------> dnslookup router <--------
78268 local_part=test domain=relay1.example.net
78268 checking domains
78268 relay1.example.net in "localhost :
/etc/mail-exim/local-host-names"? no (end of list)
78268 relay1.example.net in "! +local_domains"? yes (end of list)
78268 cached lookup data = NULL
78268 calling dnslookup router
78268 dnslookup router called for test@???
78268   domain = relay1.example.net
78268 DNS lookup of relay1.example.net (MX) succeeded
78268 xxx.xxx.xxx.119 in "@[]"? no (end of list)
78268 xxx.xxx.xxx.242 in "@[]"? no (end of list)
78268 192.168.1.4 in "@[]"? yes (matched "@[]")
78268 ignored host apex.dp.ua [192.168.1.4]
78268 xxx.xxx.xxx.65 in "@[]"? no (end of list)
78268 fully qualified name = relay1.example.net
78268 host_find_bydns yield = HOST_FOUND (2); returned hosts:
78268   mail.relay1.example.net xxx.xxx.xxx.242 5
78268   relay3.example.net xxx.xxx.xxx.65 25
78268   relay4.example.net xxx.xxx.xxx.119 150
78268 set transport remote_smtp
78268 queued for remote_smtp transport: local_part = test
78268 domain = relay1.example.net
78268   errors_to=NULL
78268   domain_data=NULL localpart_data=NULL
78268 routed by dnslookup router
78268   envelope to: test@???
78268   transport: remote_smtp
78268   host mail.relay1.example.net [xxx.xxx.xxx.242] MX=5
78268   host relay3.example.net [xxx.xxx.xxx.65] MX=25
78268   host relay4.example.net [xxx.xxx.xxx.119] MX=150
78268 ----------- end verify ------------
78268 accept: condition test succeeded
78268 SMTP>> 250 Accepted
78268 SMTP<< test
78268 LOG: smtp_syntax_error MAIN
78268   SMTP syntax error in "test" H=i100.example.net [192.168.1.100]
unrecognized command
78268 SMTP>> 500 unrecognized command
78268 SMTP<< .
78268 LOG: smtp_syntax_error MAIN
78268   SMTP syntax error in "." H=i100.example.net [192.168.1.100]
unrecognized command
78268 SMTP>> 500 unrecognized command
78268 SMTP<< data
78268 SMTP>> 354 Enter message, ending with "." on a line by itself
78268 search_tidyup called
78268 host in ignore_fromline_hosts? no (option unset)
78268 >>Headers received:
78268
78268 address match: subject=test@??? pattern=*@home.dp.ua
78268 relay1.example.net in "home.dp.ua"? no (end of list)
78268 test@??? in "*@home.dp.ua"? no (end of list)
78268 address match: subject=test@???
pattern=*@*.dnepropetrovsk.ua
78268 relay1.example.net in "*.dnepropetrovsk.ua"? no (end of list)
78268 test@??? in "*@*.dnepropetrovsk.ua"? no (end of list)
78268 address match: subject=trooper@???
pattern=*@*.dnepropetrovsk.ua
78268 domain.com in "*.dnepropetrovsk.ua"? no (end of list)
78268 trooper@??? in "*@*.dnepropetrovsk.ua"? no (end of list)
78268 rewritten sender = trooper@???
78268 rewrite_one_header: type=F:
78268   From: trooper@???
78268 search_tidyup called
78268 >>Headers after local additions:
78268 P Received: from i100.example.net ([192.168.1.100])
78268     by apex.dp.ua with smtp (Exim 4.14)
78268     id 19uYDt-000KMO-8E
78268     for test@???; Wed, 03 Sep 2003 17:03:01 +0300
78268 I Message-Id: <E19uYDt-000KMO-8E@???>
78268 F From: trooper@???
78268 B Bcc:
78268   Date: Wed, 03 Sep 2003 17:03:01 +0300
78268
78268 Data file written for message 19uYDt-000KMO-8E
78268 calling exiscan(); timeout=60
78268 exiscan: starting
78268 exiscan: expanding exiscan_condition: "1"
78268 exiscan: true exiscan_condition (expanded: "1")
78268 exiscan: expanding exiscan_demime_condition: "false"
78268 exiscan: untrue exiscan_demime_condition (expanded: "false")
78268 exiscan: expanding exiscan_av_condition: "1"
78268 exiscan: true exiscan_av_condition (expanded: "1")
78268 exiscan: using command line scanner. Path: /usr/local/bin/drwebdc,
Options: -n192.168.1.82 -rv -q -f|
78268 exiscan: calling scanner as '/usr/local/bin/drwebdc -n192.168.1.82
-rv -q -f/var/spool/exim/scan/19uYDt-000KMO-8E/19uYDt-000KMO-8E-complete'
78268 exiscan: scanning output file for virus match
78268 exiscan: output file contents follow
78268 exiscan:
--------------------------------------------------------------
78268 exiscan:
78268 ----- DrWeb report -----
78268
78268 ----- DrWeb report -----
78268
78268 exiscan:
--------------------------------------------------------------
78268 exiscan: unlinking
/var/spool/exim/scan/19uYDt-000KMO-8E/19uYDt-000KMO-8E-complete
78268 exiscan() returned 0 message processed ok
78268 calling local_scan(); timeout=300
78268 local_scan() returned 0 NULL
78268 Writing spool header file
78268 Size of headers = 370
78268 LOG: MAIN
78268   <= trooper@??? H=i100.example.net [192.168.1.100] P=smtp
S=376
78268 SMTP>> 250 OK id=19uYDt-000KMO-8E
78268 search_tidyup called
78268 Sender: trooper@???
78268 Recipients:
78268   test@???
78268 forked delivery process 78372
78268 Process 78268 is ready for new message
78268 smtp_setup_msg entered
78372 exec /usr/local/sbin/exim -d=0xfbbd5cfd -Mc 19uYDt-000KMO-8E
78372 Exim version 4.14 uid=26 gid=6 pid=78372 D=fbbd5cfd
Probably Berkeley DB version 1.8x (native mode)
Support for: IPv6 PAM Perl OpenSSL
Authenticators: cram_md5 plaintext
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
78372 changed uid/gid: forcing real = effective
78372   uid=0 gid=6 pid=78372
78372   auxiliary group list: 6
78372 configuration file is /usr/local/etc/exim/configure
78372 log selector = 02fd99d8
78372 trusted user
78372 admin user
78372 skipping ACL configuration - not needed
78372 finduser used cached passwd data for mailnull
78372 finduser used cached passwd data for nobody
78372 finduser used cached passwd data for nobody
78372 set_process_info: 78372 delivering specified messages
78372 set_process_info: 78372 delivering 19uYDt-000KMO-8E
78372 reading spool file 19uYDt-000KMO-8E-H
78372 user=root uid=0 gid=0 sender=trooper@???
78372 sender_fullhost = i100.example.net [192.168.1.100]
78372 sender_rcvhost = i100.example.net ([192.168.1.100])
78372 sender_local=0 ident=unset
78372 Non-recipients:
78372 Empty Tree
78372 ---- End of tree ----
78372 recipients_count=1
78372 body_linecount=1 message_linecount=9
78372 running system filter
78372 rda_interpret (file): /etc/mail-exim/filters/system-filter
78372 expanded: /etc/mail-exim/filters/system-filter
78372 9051 bytes read from /etc/mail-exim/filters/system-filter
78372 data is a filter program
78372 Filter: start of processing
78372 Filter: end of processing
78372 system filter returned 1
78372 Delivery address list:
78372   test@???
78372 locking /var/spool/exim/db/retry.lockfile
78372 locked /var/spool/exim/db/retry.lockfile
78372 opened hints database /var/spool/exim/db/retry: flags=0
78372 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
78372 Considering: test@???
78372 unique = test@???
78372 dbfn_read: key=R:relay1.example.net
78372 dbfn_read: key=R:test@???
78372 no domain retry record
78372 no address retry record
78372 test@???: queued for routing
78372 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
78372 routing test@???
78372 --------> virtual router <--------
78372 local_part=test domain=relay1.example.net
78372 checking domains
78372 search_open: dsearch "/etc/mail-exim/virtual"
78372 search_find: file="/etc/mail-exim/virtual"
78372   key="relay1.example.net" partial=-1 affix=NULL starflags=0
78372 LRU list:
78372   4/etc/mail-exim/virtual
78372   End
78372 internal_search_find: file="/etc/mail-exim/virtual"
78372   type=dsearch key="relay1.example.net"
78372 file lookup required for relay1.example.net
78372   in /etc/mail-exim/virtual
78372 lookup failed
78372 relay1.example.net in "dsearch;/etc/mail-exim/virtual"? no (end of
list)
78372 virtual router skipped: domains mismatch
78372 --------> cyrus_lowercase router <--------
78372 local_part=test domain=relay1.example.net
78372 checking domains
78372 relay1.example.net in "domain.com : asdf.dp.ua"? no (end of list)
78372 relay1.example.net in "+cyrus_domains"? no (end of list)
78372 cached lookup data = NULL
78372 cyrus_lowercase router skipped: domains mismatch
78372 --------> cyrus router <--------
78372 local_part=test domain=relay1.example.net
78372 checking domains
78372 cached no match for +cyrus_domains
78372 relay1.example.net in "+cyrus_domains"? no (end of list)
78372 cached lookup data = NULL
78372 cyrus router skipped: domains mismatch
78372 --------> esmtp router <--------
78372 local_part=test domain=relay1.example.net
78372 calling esmtp router
78372 esmtp router called for test@???
78372   domain = relay1.example.net
78372 search_open: dbm "/etc/mail-exim/routes/esmtp.db"
78372 search_find: file="/etc/mail-exim/routes/esmtp.db"
78372   key="relay1.example.net" partial=2 affix=*. starflags=0
78372 LRU list:
78372   1/etc/mail-exim/routes/esmtp.db
78372   4/etc/mail-exim/virtual
78372   End
78372 internal_search_find: file="/etc/mail-exim/routes/esmtp.db"
78372   type=dbm key="relay1.example.net"
78372 file lookup required for relay1.example.net
78372   in /etc/mail-exim/routes/esmtp.db
78372 lookup failed
78372 trying partial match *.relay1.example.net
78372 internal_search_find: file="/etc/mail-exim/routes/esmtp.db"
78372   type=dbm key="*.relay1.example.net"
78372 file lookup required for *.relay1.example.net
78372   in /etc/mail-exim/routes/esmtp.db
78372 lookup failed
78372 trying partial match *.dp.ua
78372 internal_search_find: file="/etc/mail-exim/routes/esmtp.db"
78372   type=dbm key="*.dp.ua"
78372 file lookup required for *.dp.ua
78372   in /etc/mail-exim/routes/esmtp.db
78372 lookup failed
78372 esmtp router declined for test@???
78372 --------> fido router <--------
78372 local_part=test domain=relay1.example.net
78372 checking domains
78372 search_open: dbm "/etc/mail-exim/routes/fido.db"
78372 search_find: file="/etc/mail-exim/routes/fido.db"
78372   key="relay1.example.net" partial=2 affix=*. starflags=0
78372 LRU list:
78372   1/etc/mail-exim/routes/fido.db
78372   1/etc/mail-exim/routes/esmtp.db
78372   4/etc/mail-exim/virtual
78372   End
78372 internal_search_find: file="/etc/mail-exim/routes/fido.db"
78372   type=dbm key="relay1.example.net"
78372 file lookup required for relay1.example.net
78372   in /etc/mail-exim/routes/fido.db
78372 lookup failed
78372 trying partial match *.relay1.example.net
78372 internal_search_find: file="/etc/mail-exim/routes/fido.db"
78372   type=dbm key="*.relay1.example.net"
78372 file lookup required for *.relay1.example.net
78372   in /etc/mail-exim/routes/fido.db
78372 lookup failed
78372 trying partial match *.dp.ua
78372 internal_search_find: file="/etc/mail-exim/routes/fido.db"
78372   type=dbm key="*.dp.ua"
78372 file lookup required for *.dp.ua
78372   in /etc/mail-exim/routes/fido.db
78372 lookup failed
78372 relay1.example.net in "partial-dbm;/etc/mail-exim/routes/fido.db"?
no (end of list)
78372 fido router skipped: domains mismatch
78372 --------> uucp_batchmail router <--------
78372 local_part=test domain=relay1.example.net
78372 checking domains
78372 search_open: dbm "/etc/mail-exim/routes/uucp-batchmail.db"
78372 search_find: file="/etc/mail-exim/routes/uucp-batchmail.db"
78372   key="relay1.example.net" partial=2 affix=*. starflags=0
78372 LRU list:
78372   1/etc/mail-exim/routes/uucp-batchmail.db
78372   1/etc/mail-exim/routes/fido.db
78372   1/etc/mail-exim/routes/esmtp.db
78372   4/etc/mail-exim/virtual
78372   End
78372 internal_search_find: file="/etc/mail-exim/routes/uucp-batchmail.db"
78372   type=dbm key="relay1.example.net"
78372 file lookup required for relay1.example.net
78372   in /etc/mail-exim/routes/uucp-batchmail.db
78372 lookup failed
78372 trying partial match *.relay1.example.net
78372 internal_search_find: file="/etc/mail-exim/routes/uucp-batchmail.db"
78372   type=dbm key="*.relay1.example.net"
78372 file lookup required for *.relay1.example.net
78372   in /etc/mail-exim/routes/uucp-batchmail.db
78372 lookup failed
78372 trying partial match *.dp.ua
78372 internal_search_find: file="/etc/mail-exim/routes/uucp-batchmail.db"
78372   type=dbm key="*.dp.ua"
78372 file lookup required for *.dp.ua
78372   in /etc/mail-exim/routes/uucp-batchmail.db
78372 lookup failed
78372 relay1.example.net in
"partial-dbm;/etc/mail-exim/routes/uucp-batchmail.db"? no (end of list)
78372 uucp_batchmail router skipped: domains mismatch
78372 --------> uucp_dom router <--------
78372 local_part=test domain=relay1.example.net
78372 checking domains
78372 search_open: dbm "/etc/mail-exim/routes/uucp-dom.db"
78372 search_find: file="/etc/mail-exim/routes/uucp-dom.db"
78372   key="relay1.example.net" partial=-1 affix=NULL starflags=0
78372 LRU list:
78372   1/etc/mail-exim/routes/uucp-dom.db
78372   1/etc/mail-exim/routes/uucp-batchmail.db
78372   1/etc/mail-exim/routes/fido.db
78372   1/etc/mail-exim/routes/esmtp.db
78372   4/etc/mail-exim/virtual
78372   End
78372 internal_search_find: file="/etc/mail-exim/routes/uucp-dom.db"
78372   type=dbm key="relay1.example.net"
78372 file lookup required for relay1.example.net
78372   in /etc/mail-exim/routes/uucp-dom.db
78372 lookup failed
78372 relay1.example.net in "dbm;/etc/mail-exim/routes/uucp-dom.db"? no
(end of list)
78372 uucp_dom router skipped: domains mismatch
78372 --------> devnull_rcpts router <--------
78372 local_part=test domain=relay1.example.net
78372 checking "condition"
78372 search_open: dbm "/etc/mail-exim/routes/devnull-rcpts.db"
78372 search_find: file="/etc/mail-exim/routes/devnull-rcpts.db"
78372   key="test@???" partial=-1 affix=NULL starflags=2
78372 LRU list:
78372   1/etc/mail-exim/routes/devnull-rcpts.db
78372   1/etc/mail-exim/routes/uucp-dom.db
78372   1/etc/mail-exim/routes/uucp-batchmail.db
78372   1/etc/mail-exim/routes/fido.db
78372   1/etc/mail-exim/routes/esmtp.db
78372   4/etc/mail-exim/virtual
78372   End
78372 internal_search_find: file="/etc/mail-exim/routes/devnull-rcpts.db"
78372   type=dbm key="test@???"
78372 file lookup required for test@???
78372   in /etc/mail-exim/routes/devnull-rcpts.db
78372 lookup failed
78372 trying default match *@relay1.example.net
78372 internal_search_find: file="/etc/mail-exim/routes/devnull-rcpts.db"
78372   type=dbm key="*@relay1.example.net"
78372 file lookup required for *@relay1.example.net
78372   in /etc/mail-exim/routes/devnull-rcpts.db
78372 lookup failed
78372 trying to match *
78372 internal_search_find: file="/etc/mail-exim/routes/devnull-rcpts.db"
78372   type=dbm key="*"
78372 file lookup required for *
78372   in /etc/mail-exim/routes/devnull-rcpts.db
78372 lookup failed
78372 devnull_rcpts router skipped: condition failure
78372 --------> devnull_domains router <--------
78372 local_part=test domain=relay1.example.net
78372 checking "condition"
78372 search_open: dbm "/etc/mail-exim/routes/devnull-domains.db"
78372 search_find: file="/etc/mail-exim/routes/devnull-domains.db"
78372   key="relay1.example.net" partial=2 affix=*. starflags=0
78372 LRU list:
78372   1/etc/mail-exim/routes/devnull-domains.db
78372   1/etc/mail-exim/routes/devnull-rcpts.db
78372   1/etc/mail-exim/routes/uucp-dom.db
78372   1/etc/mail-exim/routes/uucp-batchmail.db
78372   1/etc/mail-exim/routes/fido.db
78372   1/etc/mail-exim/routes/esmtp.db
78372   4/etc/mail-exim/virtual
78372   End
78372 internal_search_find: file="/etc/mail-exim/routes/devnull-domains.db"
78372   type=dbm key="relay1.example.net"
78372 file lookup required for relay1.example.net
78372   in /etc/mail-exim/routes/devnull-domains.db
78372 lookup failed
78372 trying partial match *.relay1.example.net
78372 internal_search_find: file="/etc/mail-exim/routes/devnull-domains.db"
78372   type=dbm key="*.relay1.example.net"
78372 file lookup required for *.relay1.example.net
78372   in /etc/mail-exim/routes/devnull-domains.db
78372 lookup failed
78372 trying partial match *.dp.ua
78372 internal_search_find: file="/etc/mail-exim/routes/devnull-domains.db"
78372   type=dbm key="*.dp.ua"
78372 file lookup required for *.dp.ua
78372   in /etc/mail-exim/routes/devnull-domains.db
78372 lookup failed
78372 devnull_domains router skipped: condition failure
78372 --------> dnslookup router <--------
78372 local_part=test domain=relay1.example.net
78372 checking domains
78372 relay1.example.net in "localhost :
/etc/mail-exim/local-host-names"? no (end of list)
78372 relay1.example.net in "! +local_domains"? yes (end of list)
78372 cached lookup data = NULL
78372 calling dnslookup router
78372 dnslookup router called for test@???
78372   domain = relay1.example.net
78372 DNS lookup of relay1.example.net (MX) succeeded
78372 xxx.xxx.xxx.242 in "@[]"? no (end of list)
78372 192.168.1.4 in "@[]"? yes (matched "@[]")
78372 ignored host apex.dp.ua [192.168.1.4]
78372 xxx.xxx.xxx.65 in "@[]"? no (end of list)
78372 xxx.xxx.xxx.119 in "@[]"? no (end of list)
78372 fully qualified name = relay1.example.net
78372 host_find_bydns yield = HOST_FOUND (2); returned hosts:
78372   mail.relay1.example.net xxx.xxx.xxx.242 5
78372   relay3.example.net xxx.xxx.xxx.65 25
78372   relay4.example.net xxx.xxx.xxx.119 150
78372 set transport remote_smtp
78372 queued for remote_smtp transport: local_part = test
78372 domain = relay1.example.net
78372   errors_to=NULL
78372   domain_data=NULL localpart_data=NULL
78372 routed by dnslookup router
78372   envelope to: test@???
78372   transport: remote_smtp
78372   host mail.relay1.example.net [xxx.xxx.xxx.242] MX=5
78372   host relay3.example.net [xxx.xxx.xxx.65] MX=25
78372   host relay4.example.net [xxx.xxx.xxx.119] MX=150
78372 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
78372 After routing:
78372   Local deliveries:
78372   Remote deliveries:
78372     test@???
78372   Failed addresses:
78372   Deferred addresses:
78372 search_tidyup called
78372 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
78372 --------> test@??? <--------
78372 search_tidyup called
78372 set_process_info: 78372 delivering 19uYDt-000KMO-8E: waiting for a
remote delivery subprocess to finish
78372 selecting on subprocess pipes
78373 changed uid/gid: remote delivery to test@??? with
transport=remote_smtp
78373   uid=26 gid=6 pid=78373
78373   auxiliary group list: 6
78373 set_process_info: 78373 delivering 19uYDt-000KMO-8E using remote_smtp
78373 remote_smtp transport entered
78373   test@???
78373 relay1.example.net in queue_smtp_domains? no (option unset)
78373 checking status of mail.relay1.example.net
78373 locking /var/spool/exim/db/retry.lockfile
78373 locked /var/spool/exim/db/retry.lockfile
78373 opened hints database /var/spool/exim/db/retry: flags=0
78373 dbfn_read: key=T:mail.relay1.example.net:xxx.xxx.xxx.242
78373 dbfn_read:
key=T:mail.relay1.example.net:xxx.xxx.xxx.242:19uYDt-000KMO-8E
78373 no message retry record
78373 address match: subject=*@mail.relay1.example.net pattern=*
78373 mail.relay1.example.net in "*"? yes (matched "*")
78373 *@mail.relay1.example.net in "*"? yes (matched "*")
78373 retry time not reached: checking ultimate address timeout
78373 mail.relay1.example.net [xxx.xxx.xxx.242] status = unusable
78373 relay1.example.net in queue_smtp_domains? no (option unset)
78373 checking status of relay3.example.net
78373 locking /var/spool/exim/db/retry.lockfile
78373 locked /var/spool/exim/db/retry.lockfile
78373 opened hints database /var/spool/exim/db/retry: flags=0
78373 dbfn_read: key=T:relay3.example.net:xxx.xxx.xxx.65
78373 dbfn_read: key=T:relay3.example.net:xxx.xxx.xxx.65:19uYDt-000KMO-8E
78373 no host retry record
78373 no message retry record
78373 relay3.example.net [xxx.xxx.xxx.65] status = usable
78373 xxx.xxx.xxx.65 in serialize_hosts? no (option unset)
78373 delivering 19uYDt-000KMO-8E to relay3.example.net [xxx.xxx.xxx.65]
(test@???)
78373 set_process_info: 78373 delivering 19uYDt-000KMO-8E to
relay3.example.net [xxx.xxx.xxx.65] (test@???)
78373 Connecting to relay3.example.net [xxx.xxx.xxx.65]:25 ... connected
78373 read response data: size=59
78373   SMTP<< 220 relay3.example.net ESMTP Wed, 03 Sep 2003 17:02:59 +0300
78373   SMTP>> EHLO apex.dp.ua
78373 read response data: size=134
78373   SMTP<< 250-relay3.example.net Hello bagira.example.net
[195.24.128.88]
78373          250-SIZE 30000000
78373          250-8BITMIME
78373          250-PIPELINING
78373          250-STARTTLS
78373          250 HELP
78373 xxx.xxx.xxx.65 in hosts_avoid_tls? no (option unset)
78373   SMTP>> STARTTLS
78373 read response data: size=18
78373   SMTP<< 220 TLS go ahead
78373 Initialised TLS
78373 SSL info: before/connect initialization
78373 SSL info: before/connect initialization
78373 SSL info: SSLv2/v3 write client hello A
78373 SSL info: SSLv3 read server hello A
78373 SSL info: SSLv3 read server certificate A
78373 SSL info: SSLv3 read server done A
78373 SSL info: SSLv3 write client key exchange A
78373 SSL info: SSLv3 write change cipher spec A
78373 SSL info: SSLv3 write finished A
78373 SSL info: SSLv3 flush data
78373 SSL info: SSLv3 read finished A
78373 SSL info: SSL negotiation finished successfully
78373 SSL info: SSL negotiation finished successfully
78373 Cipher: TLSv1:DES-CBC3-SHA:168
78373   SMTP>> EHLO apex.dp.ua
78373 tls_do_write(bfbfcc50, 17)
78373 SSL_write(SSL, bfbfcc50, 17)
78373 outbytes=17 error=0
78373 Calling SSL_read(80ec700, bfbfd050, 4096)
78373 read response data: size=120
78373   SMTP<< 250-relay3.example.net Hello bagira.example.net
[195.24.128.88]
78373          250-SIZE 30000000
78373          250-8BITMIME
78373          250-PIPELINING
78373          250 HELP
78373 xxx.xxx.xxx.65 in hosts_require_auth? no (option unset)
78373   SMTP>> MAIL FROM:<trooper@???> SIZE=1410
78373   SMTP>> RCPT TO:<test@???>
78373   SMTP>> DATA
78373 tls_do_write(bfbfcc50, 79)
78373 SSL_write(SSL, bfbfcc50, 79)
78373 outbytes=79 error=0
78373 Calling SSL_read(80ec700, bfbfd050, 4096)
78373 read response data: size=8
78373   SMTP<< 250 OK
78373 Calling SSL_read(80ec700, bfbfd050, 4096)
78373 read response data: size=14
78373   SMTP<< 250 Accepted
78373 Calling SSL_read(80ec700, bfbfd050, 4096)
78373 read response data: size=56
78373   SMTP<< 354 Enter message, ending with "." on a line by itself
78373   SMTP>> writing message and terminating "."
78373 writing data block fd=7 size=390 timeout=300
78373 tls_do_write(8107000, 390)
78373 SSL_write(SSL, 8107000, 390)
78373 outbytes=390 error=0
78373 Calling SSL_read(80ec700, bfbfd050, 4096)
78373 read response data: size=28
78373   SMTP<< 250 OK id=19uYDs-000Pqy-00
78373 journalling test@???
78373 ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_address=0
78373 xxx.xxx.xxx.65 in hosts_nopass_tls? no (option unset)
78373 transport_check_waiting entered
78373   sequence=1 local_max=500 global_max=-1
78373 locking /var/spool/exim/db/wait-remote_smtp.lockfile
78373 locked /var/spool/exim/db/wait-remote_smtp.lockfile
78373 opened hints database /var/spool/exim/db/wait-remote_smtp: flags=2
78373 dbfn_read: key=relay3.example.net
78373 no messages waiting for relay3.example.net
78373   SMTP>> QUIT
78373 tls_do_write(bfbfcc50, 6)
78373 SSL_write(SSL, bfbfcc50, 6)
78373 outbytes=6 error=0
78373 tls_close(): shutting down SSL
78373 SSL info: SSL negotiation finished successfully
78373 set_process_info: 78373 delivering 19uYDt-000KMO-8E: just tried
relay3.example.net [xxx.xxx.xxx.65] for test@???: result OK
78373 Leaving remote_smtp transport
78373 set_process_info: 78373 delivering 19uYDt-000KMO-8E (just run
remote_smtp for test@??? in subprocess)
78373 search_tidyup called
78372 reading pipe for subprocess 78373 (not ended)
78372 read() yielded 17
78372 selecting on subprocess pipes
78372 reading pipe for subprocess 78373 (not ended)
78372 read() yielded 5
78372 selecting on subprocess pipes
78372 reading pipe for subprocess 78373 (not ended)
78372 read() yielded 72
78372 selecting on subprocess pipes
78372 reading pipe for subprocess 78373 (not ended)
78372 read() yielded 71
78372 selecting on subprocess pipes
78372 reading pipe for subprocess 78373 (not ended)
78372 read() yielded 2
78372 Z0 item read
78372 remote delivery process 78373 ended
78372 set_process_info: 78372 delivering 19uYDt-000KMO-8E
78372 post-process test@??? (0)
78372 test@??? delivered
78372 LOG: MAIN
78372   => test@??? R=dnslookup T=remote_smtp
H=relay3.example.net [xxx.xxx.xxx.65] X=TLSv1:DES-CBC3-SHA:168 C="250 OK
id=19uYDs-000Pqy-00"
78372 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
78372 changed uid/gid: post-delivery tidying
78372   uid=26 gid=6 pid=78372
78372   auxiliary group list: 6
78372 set_process_info: 78372 tidying up after delivering 19uYDt-000KMO-8E
78372 Processing retry items
78372 Succeeded addresses:
78372 test@???: no retry items
78372 Failed addresses:
78372 Deferred addresses:
78372 end of retry processing
78372 LOG: MAIN
78372   Completed
78372 end delivery of 19uYDt-000KMO-8E
78372 search_tidyup called
78372 search_tidyup called
78372 >>>>>>>>>>>>>>>> Exim pid=78372 terminating with rc=0 >>>>>>>>>>>>>>>>
78268 SMTP<< quit
78268 SMTP>> 221 apex.dp.ua closing connection
78268 LOG: smtp_connection MAIN
78268   SMTP connection from i100.example.net [192.168.1.100] closed by QUIT
78268 search_tidyup called
78263 child 78268 ended: status=0x0
78263 0 SMTP accept processes now running
78263 Listening...



--
Best wishes,
Dmitry Sergienko
Trifle Co., Ltd.