> On Tue, 22 Jul 2003, Tom Davidson wrote:
>
> > Argh! Typical...
> > The solution did have an internal DNS server to test a concept for a
while,
> > and when it was removed, resolv.conf must have been emptied rather than
> > deleted. Will schedule another test and hopefully will be able to
complete
> > this time...
> >
> > I assume this behaviour is a Solaris resolver thing rather than an Exim
one?
>
> Exim just calls the resolver. Configuring the resolver is an OS thing,
> though I think most use /etc/resolv.conf.
Unfortuantely I'm still getting the same problem having removed resolv.conf!
I've included the -d+all-memory debugging output below.
Tom
=====
Exim version 4.10 uid=0 gid=1 pid=21080 L=834cd8 D=ffff7fff
probably ndbm
changed uid/gid: forcing real = effective
uid=0 gid=1
auxiliary group list: <none>
trusted user
admin user
originator: uid=0 gid=1 login=root name=Root vmmsl-sun-01
listening on all interfaces (IPv4) port 25
pid written to /var/spool/exim/exim-daemon.pid
changed uid/gid: running as a daemon
uid=50 gid=50
auxiliary group list: <none>
LOG: MAIN
exim 4.10 daemon started: pid=21080, -q20m, listening for SMTP on port 25
(IPv4)
set_process_info: 21080 daemon: -q20m, listening for SMTP
daemon running with uid=50 gid=50 euid=50 egid=50
SIGALRM received
1 queue-runner process running
Starting queue-runner: pid 21081
Listening...
exec /usr/local/bin/exim -q
child 21081 ended: status=0x0
0 queue-runner processes now running
Listening...
Connection request from 10.97.227.173 port 40931
1 SMTP accept process running
Listening...
interface address=10.97.227.163 port=25
sender_fullhost = [10.97.227.173]
sender_rcvhost = [10.97.227.173]
Process 21085 is handling incoming connection from [10.97.227.173]
checking for IP options
no IP options found
host in host_lookup? no (option unset)
set_process_info: 21085 handling incoming connection from [10.97.227.173]
host in host_reject_connection? no (option unset)
host in sender_unqualified_hosts? no (option unset)
host in recipient_unqualified_hosts? no (option unset)
host in helo_verify_hosts? no (option unset)
host in helo_try_verify_hosts? no (option unset)
host in helo_accept_junk_hosts? no (option unset)
LOG: smtp_connection MAIN
SMTP connection from [10.97.227.173] (TCP/IP connection count = 1)
SMTP>> 220 vmmsl-sun-01 ESMTP Exim 4.10 Tue, 29 Jul 2003 07:44:40 +0100
Process 21085 is ready for new message
smtp_setup_msg entered
SMTP<< EHLO vmmsl-sun-04
vmmsl-sun-04 in helo_lookup_domains? no (end of list)
sender_fullhost = (vmmsl-sun-04) [10.97.227.173]
sender_rcvhost = [10.97.227.173] (helo=vmmsl-sun-04)
set_process_info: 21085 handling incoming connection from (vmmsl-sun-04)
[10.97.227.173]
host in tls_advertise_hosts? no (option unset)
SMTP>> 250-vmmsl-sun-01 Hello vmmsl-sun-04 [10.97.227.173]
250-SIZE 52428800
250-PIPELINING
250 HELP
SMTP<< MAIL FROM:<tomd@???> SIZE=1335
spool directory /var/spool/exim space = 2057632 blocks; inodes = 288955;
check_space = 0 (0 blocks); inodes = 0; msg_size = 6335 (6 blocks)
SMTP>> 250 OK
SMTP<< RCPT TO:<test@???>
active address test@???
local_part=test domain=nashwan.org
using ACL "acl_check_rcpt"
processing "accept"
check hosts = :
host in ":"? no (end of list)
accept: condition test failed
processing "deny"
check local_parts = ^.*[@%!/|]
test in "^.*[@%!/|]"? no (end of list)
deny: condition test failed
processing "accept"
check domains = +relay_to_domains
nashwan.org in "virginmoney.com : *.virginmoney.com : relmon.com :
*.relmon.com"? no (end of list)
nashwan.org in "+relay_to_domains"? no (end of list)
cached lookup data = NULL
accept: condition test failed
processing "accept"
check local_parts = postmaster
test in "postmaster"? no (end of list)
accept: condition test failed
processing "accept"
check domains = +local_domains
nashwan.org in "@ : localhost"? no (end of list)
nashwan.org in "+local_domains"? no (end of list)
cached lookup data = NULL
accept: condition test failed
processing "accept"
check domains = +relay_to_domains
cached no match for +relay_to_domains
nashwan.org in "+relay_to_domains"? no (end of list)
cached lookup data = NULL
accept: condition test failed
processing "accept"
check hosts = +relay_from_hosts
host in "127.0.0.1 : 10.93.227.0/24 : 10.93.246.0/24 : 10.96.227.0/24 :
10.97.227.0/24 : 192.168.210.35 : 192.168.210.36 : 192.168.210.41 :
192.168.210.42"? yes (matched "10.97.227.0/24")
host in "+relay_from_hosts"? yes (matched "+relay_from_hosts")
accept: condition test succeeded
SMTP>> 250 Accepted
SMTP<< DATA
SMTP>> 354 Enter message, ending with "." on a line by itself
search_tidyup called
host in ignore_fromline_hosts? no (option unset)
>>Headers received:
Received: from tomd by vmmsl-sun-04 with local (Exim 4.10)
id 19hODw-0003kd-00
for test@???; Tue, 29 Jul 2003 07:44:40 +0100
To: test@???
Subject: test
Content-Length: 4
Message-Id: <E19hODw-0003kd-00@vmmsl-sun-04>
From: tomd@???
Date: Tue, 29 Jul 2003 07:44:40 +0100
address match: subject=test@??? pattern=*@virginmoney.co.uk
nashwan.org in "virginmoney.co.uk"? no (end of list)
test@??? in "*@virginmoney.co.uk"? no (end of list)
address match: subject=tomd@??? pattern=*@localhost
virginmoney.com in "localhost"? no (end of list)
tomd@??? in "*@localhost"? no (end of list)
rewritten sender = tomd@???
rewrite_one_header: type=T:
To: test@???
address match: subject=test@??? pattern=*@virginmoney.co.uk
nashwan.org in "virginmoney.co.uk"? no (end of list)
test@??? in "*@virginmoney.co.uk"? no (end of list)
rewrite_one_header: type=F:
From: tomd@???
address match: subject=tomd@??? pattern=*@localhost
virginmoney.com in "localhost"? no (end of list)
tomd@??? in "*@localhost"? no (end of list)
search_tidyup called
>>Headers after local additions:
P Received: from [10.97.227.173] (helo=vmmsl-sun-04)
by vmmsl-sun-01 with esmtp (Exim 4.10)
id 19hODw-0005U5-00
for test@???; Tue, 29 Jul 2003 07:44:40 +0100
P Received: from tomd by vmmsl-sun-04 with local (Exim 4.10)
id 19hODw-0003kd-00
for test@???; Tue, 29 Jul 2003 07:44:40 +0100
T To: test@???
Subject: test
Content-Length: 4
I Message-Id: <E19hODw-0003kd-00@vmmsl-sun-04>
F From: tomd@???
Date: Tue, 29 Jul 2003 07:44:40 +0100
Data file written for message 19hODw-0005U5-00
calling local_scan(); timeout=300
local_scan() returned 0 NULL
Writing spool header file
Size of headers = 462
LOG: MAIN
<= tomd@??? H=(vmmsl-sun-04) [10.97.227.173] P=esmtp S=467
id=E19hODw-0003kd-00@vmmsl-sun-04
SMTP>> 250 OK id=19hODw-0005U5-00
search_tidyup called
Sender: tomd@???
Recipients:
test@???
forked delivery process 21086
Process 21085 is ready for new message
smtp_setup_msg entered
exec /usr/local/bin/exim -d=0xffff7fff -Mc 19hODw-0005U5-00
SMTP<< QUIT
SMTP>> 221 vmmsl-sun-01 closing connection
LOG: smtp_connection MAIN
SMTP connection from (vmmsl-sun-04) [10.97.227.173] closed by QUIT
search_tidyup called
child 21085 ended: status=0x0
0 SMTP accept processes now running
Listening...
Exim version 4.10 uid=50 gid=50 pid=21086 L=834cd8 D=ffff7fff
probably ndbm
changed uid/gid: forcing real = effective
uid=0 gid=50
auxiliary group list: <none>
trusted user
admin user
skipping ACL configuration - not needed
set_process_info: 21086 delivering specified messages
set_process_info: 21086 delivering 19hODw-0005U5-00
reading spool file 19hODw-0005U5-00-H
user=root uid=0 gid=1 sender=tomd@???
sender_fullhost = (vmmsl-sun-04) [10.97.227.173]
sender_rcvhost = [10.97.227.173] (helo=vmmsl-sun-04)
sender_local=0 ident=unset
Non-recipients:
Empty Tree
---- End of tree ----
recipients_count=1
body_linecount=1 message_linecount=13
Delivery address list:
test@???
locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
opened hints database /var/spool/exim/db/retry: flags=0
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Considering: test@???
active address test@???
local_part=test domain=nashwan.org
unique = test@???
dbfn_read: key=R:nashwan.org
dbfn_read: key=R:test@???
no domain retry record
no address retry record
test@???: queued for routing
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
routing test@???
--------> domain_aliases router <--------
local_part=test domain=nashwan.org
checking domains
nashwan.org in "virginmoney.com : relmon.com"? no (end of list)
domain_aliases router skipped: domains mismatch
--------> to_notes_norwich router <--------
local_part=test domain=nashwan.org
checking domains
nashwan.org in "virginmoney.com : wrl.virginmoney.com"? no (end of list)
to_notes_norwich router skipped: domains mismatch
--------> to_eit_norwich router <--------
local_part=test domain=nashwan.org
checking domains
nashwan.org in "eit.wrl.virginmoney.com : *.eit.wrl.virginmoney.com"? no
(end of list)
to_eit_norwich router skipped: domains mismatch
--------> fail_other_mail router <--------
local_part=test domain=nashwan.org
checking domains
nashwan.org in "relmon.com : *.relmon.com"? no (end of list)
fail_other_mail router skipped: domains mismatch
--------> to_internet router <--------
local_part=test domain=nashwan.org
checking domains
nashwan.org in "@ : localhost"? no (end of list)
nashwan.org in "! +local_domains"? yes (end of list)
cached lookup data = NULL
calling to_internet router
to_internet router called for test@???
domain = nashwan.org
route_item = *
"${extract{${substr_2_3:$primary_hostname}}{msl=mailrelay1:mailrelay2
grl=mailrelay3:mailrelay4}}"
nashwan.org in "*"? yes (matched "*")
original
hostlist=${extract{${substr_2_3:$primary_hostname}}{msl=mailrelay1:mailrelay
2 grl=mailrelay3:mailrelay4}} options=
expanded hostlist="mailrelay1:mailrelay2" options=
set transport remote_smtp_to_internet
Actual local interface address is 127.0.0.1 (lo0)
Actual local interface address is 10.96.227.100 (hme0)
Actual local interface address is 10.96.227.163 (hme0:1)
Actual local interface address is 10.96.227.202 (hme0:2)
Actual local interface address is 10.96.227.203 (hme0:3)
Actual local interface address is 10.97.227.163 (qfe1)
Actual local interface address is 10.97.227.202 (qfe1:1)
Actual local interface address is 10.97.227.203 (qfe1:2)
Actual local interface address is 10.96.227.101 (qfe3)
fully qualified name = mailrelay1
mailrelay1 10.93.227.166
fully qualified name = mailrelay2
mailrelay2 10.93.227.167
queued for remote_smtp_to_internet transport: local_part = test
domain = nashwan.org
errors_to=NULL
domain_data=NULL localpart_data=NULL
routed by to_internet router
envelope to: test@???
transport: remote_smtp_to_internet
host mailrelay1 [10.93.227.166]
host mailrelay2 [10.93.227.167]
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
After routing:
Local deliveries:
Remote deliveries:
test@???
Failed addresses:
Deferred addresses:
search_tidyup called
>>>>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>>>
--------> test@??? <--------
search_tidyup called
set_process_info: 21086 delivering 19hODw-0005U5-00: waiting for a remote
delivery subprocess to finish
selecting on subprocess pipes
changed uid/gid: remote delivery to test@??? with
transport=remote_smtp_to_internet
uid=50 gid=50
auxiliary group list: <none>
set_process_info: 21087 delivering 19hODw-0005U5-00 using
remote_smtp_to_internet
remote_smtp_to_internet transport entered
test@???
nashwan.org in queue_smtp_domains? no (option unset)
checking status of mailrelay1
locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
opened hints database /var/spool/exim/db/retry: flags=0
dbfn_read: key=T:mailrelay1:10.93.227.166
dbfn_read: key=T:mailrelay1:10.93.227.166:19hODw-0005U5-00
no host retry record
no message retry record
mailrelay1 [10.93.227.166] status = usable
10.93.227.166 in serialize_hosts? no (option unset)
delivering 19hODw-0005U5-00 to mailrelay1 [10.93.227.166] (test@???)
set_process_info: 21087 delivering 19hODw-0005U5-00 to mailrelay1
[10.93.227.166] (test@???)
Connecting to mailrelay1 [10.93.227.166]:25 ... failed
LOG: MAIN
mailrelay1 [10.93.227.166]: Connection refused
set_process_info: 21087 delivering 19hODw-0005U5-00: just tried mailrelay1
[10.93.227.166] for test@???: result DEFER
added retry item for T:mailrelay1:10.93.227.166: errno=146 65 flags=2
nashwan.org in queue_smtp_domains? no (option unset)
checking status of mailrelay2
locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
opened hints database /var/spool/exim/db/retry: flags=0
dbfn_read: key=T:mailrelay2:10.93.227.167
dbfn_read: key=T:mailrelay2:10.93.227.167:19hODw-0005U5-00
no message retry record
mailrelay2 [10.93.227.167] status = usable
10.93.227.167 in serialize_hosts? no (option unset)
delivering 19hODw-0005U5-00 to mailrelay2 [10.93.227.167] (test@???)
set_process_info: 21087 delivering 19hODw-0005U5-00 to mailrelay2
[10.93.227.167] (test@???)
Connecting to mailrelay2 [10.93.227.167]:25 ... failed
LOG: MAIN
mailrelay2 [10.93.227.167]: Connection refused
set_process_info: 21087 delivering 19hODw-0005U5-00: just tried mailrelay2
[10.93.227.167] for test@???: result DEFER
added retry item for T:mailrelay2:10.93.227.167: errno=146 65 flags=2
all IP addresses skipped or deferred at least one address
locking /var/spool/exim/db/wait-remote_smtp_to_internet.lockfile
locked /var/spool/exim/db/wait-remote_smtp_to_internet.lockfile
opened hints database /var/spool/exim/db/wait-remote_smtp_to_internet:
flags=102
dbfn_read: key=mailrelay1
dbfn_write: key=mailrelay1
dbfn_read: key=mailrelay2
dbfn_write: key=mailrelay2
Leaving remote_smtp_to_internet transport
set_process_info: 21087 delivering 19hODw-0005U5-00 (just run
remote_smtp_to_internet for test@??? in subprocess)
reading pipe for subprocess 21087 (not ended)
read() yielded 129
search_tidyup called
reading retry information for T:mailrelay2:10.93.227.167 from subprocess
added retry item
reading retry information for T:mailrelay1:10.93.227.166 from subprocess
added retry item
Z0 item read
remote delivery process 21087 ended
set_process_info: 21086 delivering 19hODw-0005U5-00
test@??? queued for fallback host(s)
Delivering to fallback hosts
--------> test@??? <--------
search_tidyup called
set_process_info: 21086 delivering 19hODw-0005U5-00: waiting for a remote
delivery subprocess to finish
selecting on subprocess pipes
changed uid/gid: remote delivery to test@??? with
transport=remote_smtp_to_internet
uid=50 gid=50
auxiliary group list: <none>
set_process_info: 21088 delivering 19hODw-0005U5-00 using
remote_smtp_to_internet
remote_smtp_to_internet transport entered
test@???
getting address for mailrelay1
DNS lookup of mailrelay1 (A) gave TRY_AGAIN
mailrelay1 in dns_again_means_nonexist? no (option unset)
returning DNS_AGAIN
added retry item for R:mailrelay1: errno=146 9568256 flags=0
rc = HOST_FIND_AGAIN for mailrelay1
getting address for mailrelay4
DNS lookup of mailrelay4 (A) gave TRY_AGAIN
mailrelay4 in dns_again_means_nonexist? no (option unset)
returning DNS_AGAIN
added retry item for R:mailrelay4: errno=-32 9568256 flags=0
rc = HOST_FIND_AGAIN for mailrelay4
getting address for mailrelay2
DNS lookup of mailrelay2 (A) gave TRY_AGAIN
mailrelay2 in dns_again_means_nonexist? no (option unset)
returning DNS_AGAIN
added retry item for R:mailrelay2: errno=-32 9568256 flags=0
rc = HOST_FIND_AGAIN for mailrelay2
getting address for mailrelay3
DNS lookup of mailrelay3 (A) gave TRY_AGAIN
mailrelay3 in dns_again_means_nonexist? no (option unset)
returning DNS_AGAIN
added retry item for R:mailrelay3: errno=-32 9568256 flags=0
rc = HOST_FIND_AGAIN for mailrelay3
all IP addresses skipped or deferred at least one address
locking /var/spool/exim/db/wait-remote_smtp_to_internet.lockfile
locked /var/spool/exim/db/wait-remote_smtp_to_internet.lockfile
opened hints database /var/spool/exim/db/wait-remote_smtp_to_internet:
flags=102
dbfn_read: key=mailrelay1
dbfn_read: key=mailrelay4
dbfn_read: key=mailrelay4:1
dbfn_read: key=mailrelay4:0
dbfn_write: key=mailrelay4
dbfn_read: key=mailrelay2
dbfn_read: key=mailrelay3
dbfn_read: key=mailrelay3:1
dbfn_read: key=mailrelay3:0
dbfn_write: key=mailrelay3
Leaving remote_smtp_to_internet transport
set_process_info: 21088 delivering 19hODw-0005U5-00 (just run
remote_smtp_to_internet for test@??? in subprocess)
reading pipe for subprocess 21088 (not ended)
read() yielded 227
reading retry information for R:mailrelay3 from subprocess
search_tidyup called
added retry item
reading retry information for R:mailrelay2 from subprocess
added retry item
reading retry information for R:mailrelay4 from subprocess
added retry item
reading retry information for R:mailrelay1 from subprocess
added retry item
selecting on subprocess pipes
reading pipe for subprocess 21088 (not ended)
read() yielded 132
reading retry information for T:mailrelay1:10.93.227.166 from subprocess
added retry item
reading retry information for T:mailrelay2:10.93.227.167 from subprocess
added retry item
Z0 item read
remote delivery process 21088 ended
set_process_info: 21086 delivering 19hODw-0005U5-00
post-process test@??? (1)
LOG: MAIN
== test@??? R=to_internet T=remote_smtp_to_internet defer (-32):
failed to lookup IP address for mailrelay3
>>>>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>>>
changed uid/gid: post-delivery tidying
uid=50 gid=50
auxiliary group list: <none>
set_process_info: 21086 tidying up after delivering 19hODw-0005U5-00
Processing retry items
Succeeded addresses:
Failed addresses:
Deferred addresses:
test@???
locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
opened hints database /var/spool/exim/db/retry: flags=102
address match: subject=*@mailrelay2:10.93.227.167 pattern=*
mailrelay2:10.93.227.167 in "*"? yes (matched "*")
*@mailrelay2:10.93.227.167 in "*"? yes (matched "*")
retry for T:mailrelay2:10.93.227.167 (nashwan.org) = *
dbfn_read: key=T:mailrelay2:10.93.227.167
Writing retry data for T:mailrelay2:10.93.227.167
first failed=1059458974 last try=1059461080 next try=1059461980 expired=0
error 146 65: Connection refused
dbfn_write: key=T:mailrelay2:10.93.227.167
address match: subject=*@mailrelay1:10.93.227.166 pattern=*
mailrelay1:10.93.227.166 in "*"? yes (matched "*")
*@mailrelay1:10.93.227.166 in "*"? yes (matched "*")
retry for T:mailrelay1:10.93.227.166 (nashwan.org) = *
dbfn_read: key=T:mailrelay1:10.93.227.166
Writing retry data for T:mailrelay1:10.93.227.166
first failed=1059461080 last try=1059461080 next try=1059461980 expired=0
error 146 65: Connection refused
dbfn_write: key=T:mailrelay1:10.93.227.166
address match: subject=*@mailrelay1 pattern=*
mailrelay1 in "*"? yes (matched "*")
*@mailrelay1 in "*"? yes (matched "*")
retry for R:mailrelay1 = *
dbfn_read: key=R:mailrelay1
Writing retry data for R:mailrelay1
first failed=1058508676 last try=1059461080 next try=1059489880 expired=1
error 146 9568256: Connection refused
dbfn_write: key=R:mailrelay1
address match: subject=*@mailrelay4 pattern=*
mailrelay4 in "*"? yes (matched "*")
*@mailrelay4 in "*"? yes (matched "*")
retry for R:mailrelay4 = *
dbfn_read: key=R:mailrelay4
Writing retry data for R:mailrelay4
first failed=1058508676 last try=1059461080 next try=1059489880 expired=1
error -32 9568256: failed to lookup IP address for mailrelay1
dbfn_write: key=R:mailrelay4
address match: subject=*@mailrelay2 pattern=*
mailrelay2 in "*"? yes (matched "*")
*@mailrelay2 in "*"? yes (matched "*")
retry for R:mailrelay2 = *
dbfn_read: key=R:mailrelay2
Writing retry data for R:mailrelay2
first failed=1058508676 last try=1059461080 next try=1059489880 expired=1
error -32 9568256: failed to lookup IP address for mailrelay4
dbfn_write: key=R:mailrelay2
address match: subject=*@mailrelay3 pattern=*
mailrelay3 in "*"? yes (matched "*")
*@mailrelay3 in "*"? yes (matched "*")
retry for R:mailrelay3 = *
dbfn_read: key=R:mailrelay3
Writing retry data for R:mailrelay3
first failed=1058508676 last try=1059461080 next try=1059489880 expired=1
error -32 9568256: failed to lookup IP address for mailrelay2
dbfn_write: key=R:mailrelay3
address match: subject=*@mailrelay1:10.93.227.166 pattern=*
mailrelay1:10.93.227.166 in "*"? yes (matched "*")
*@mailrelay1:10.93.227.166 in "*"? yes (matched "*")
retry for T:mailrelay1:10.93.227.166 (nashwan.org) = *
dbfn_read: key=T:mailrelay1:10.93.227.166
Writing retry data for T:mailrelay1:10.93.227.166
first failed=1059461080 last try=1059461080 next try=1059461980 expired=0
error 146 65: Connection refused
dbfn_write: key=T:mailrelay1:10.93.227.166
address match: subject=*@mailrelay2:10.93.227.167 pattern=*
mailrelay2:10.93.227.167 in "*"? yes (matched "*")
*@mailrelay2:10.93.227.167 in "*"? yes (matched "*")
retry for T:mailrelay2:10.93.227.167 (nashwan.org) = *
dbfn_read: key=T:mailrelay2:10.93.227.167
Writing retry data for T:mailrelay2:10.93.227.167
first failed=1059458974 last try=1059461080 next try=1059461980 expired=0
error 146 65: Connection refused
dbfn_write: key=T:mailrelay2:10.93.227.167
end of retry processing
time on queue = 0s
warning counts: required 0 done 0
delivery deferred: update_spool=1 header_rewritten=0
Writing spool header file
Size of headers = 462
end delivery of 19hODw-0005U5-00
search_tidyup called
search_tidyup called
>>>>>>>>>>>>>>>>>> Exim pid=21086 terminating with rc=0 >>>>>>>>>>>>>>>>>>
