--
On Tue, Mar 25, 2003 at 05:28:11PM +0100, Nico Erfurth wrote:
> Are you sure the mail is send by your exim? And not by someone playing
> around with a script, that does not handle a rejected RCPT TO correctly?
Thanks for your reaction Nico - also to others who responded.
I have the same configuration (except for the hostnames) on two
machines and did a exim -d9 on both of them. The attached file
contains the output of diff -y of the debug-output on the two
different machines. One succeeded (archive) and the other
(webct-tyg1) was refused by the smarthost (maties3).
In short, I can not get mail successfully delivered at the smarthost
because of error 550.
I hope somebody can help me to solve this.
Regards.
Johann
--
Johann Spies Telefoon: 021-808 4036
Informasietegnologie, Universiteit van Stellenbosch
"Cast all your anxiety on him, because he cares for
you." I Peter 5:7
--
> exim -d9 jspies@??? | [root@webct-tyg1 exim]# exim -d9 jspies@???
Exim version 3.22 debug level 9 uid=0 gid=0 Exim version 3.22 debug level 9 uid=0 gid=0
Berkeley DB: Sleepycat Software: DB 2.4.14: (6/2/98) Berkeley DB: Sleepycat Software: DB 2.4.14: (6/2/98)
archive.sun.ac.za in local_domains? yes (matched archive.sun. | webct-tyg1 in local_domains? yes (matched webct-tyg1)
Actual local interface address is 127.0.0.1 (lo) Actual local interface address is 127.0.0.1 (lo)
Actual local interface address is 146.232.66.2 (eth2) | Actual local interface address is 146.232.197.237 (eth0)
Actual local interface address is 146.232.128.14 (eth0) <
Actual local interface address is 146.232.65.10 (eth1) <
Actual local interface address is 146.232.65.100 (eth1:1) <
Actual local interface address is 146.232.65.101 (eth1:2) <
Actual local interface address is 146.232.65.102 (eth1:3) <
Actual local interface address is 146.232.65.103 (eth1:4) <
Actual local interface address is 146.232.65.104 (eth1:5) <
Actual local interface address is 146.232.65.105 (eth1:6) <
Actual local interface address is 146.232.65.55 (eth1:7) <
Caller is an admin user Caller is an admin user
Caller is a trusted user Caller is a trusted user
user name "root" extracted from gecos field "root,Mike Berry, | user name "root" extracted from gecos field "root"
originator: uid=0 gid=0 login=root name=root originator: uid=0 gid=0 login=root name=root
sender address = root@??? | sender address = root@???
set_process_info: 24427 accepting a local non-SMTP message fr | set_process_info: 18320 accepting a local non-SMTP message fr
Sender: root@??? | Sender: root@???
Recipients: Recipients:
jspies@??? jspies@???
search_tidyup called search_tidyup called
toets dit | dit werk
>>Original headers (size=9): | >>Original headers (size=8):
toets dit | dit werk
search_tidyup called search_tidyup called
>>Final headers: >>Final headers:
P Received: from root by archive.sun.ac.za with local (Exim 3 | P Received: from root by webct-tyg1 with local (Exim 3.22 #1
id 18y5gd-0006Lz-00 | id 18y5sW-0004lU-00
for <jspies@???>; Wed, 26 Mar 2003 09:51:07 +02 | for <jspies@???>; Wed, 26 Mar 2003 10:03:32 +02
I Message-Id: <E18y5gd-0006Lz-00@???> | I Message-Id: <E18y5sW-0004lU-00@webct-tyg1>
F From: root <root@???> | F From: root <root@???>
T To: jspies@??? T To: jspies@???
Date: Wed, 26 Mar 2003 09:51:07 +0200 | Date: Wed, 26 Mar 2003 10:03:32 +0200
toets dit | dit werk
Data file written for message 18y5gd-0006Lz-00 | Data file written for message 18y5sW-0004lU-00
Writing spool header file Writing spool header file
Size of headers = 306 | Size of headers = 295
LOG: 0 MAIN LOG: 0 MAIN
<= root@??? U=root P=local S=317 | <= root@??? U=root P=local S=305
search_tidyup called search_tidyup called
exec /usr/sbin/exim -d9 -Mc 18y5gd-0006Lz-00 | exec /usr/sbin/exim -d9 -Mc 18y5sW-0004lU-00
| [root@webct-tyg1 exim]# Exim version 3.22 debug level 9 uid=8
[?[1mroot?[0m@?[1marchive?[0m-?[1m09:51:08?[0m]-#2 /tmp <
> Exim version 3.22 debug level 9 uid=8 gid=12 <
Berkeley DB: Sleepycat Software: DB 2.4.14: (6/2/98) Berkeley DB: Sleepycat Software: DB 2.4.14: (6/2/98)
archive.sun.ac.za in local_domains? yes (matched archive.sun. | webct-tyg1 in local_domains? yes (matched webct-tyg1)
Actual local interface address is 127.0.0.1 (lo) Actual local interface address is 127.0.0.1 (lo)
Actual local interface address is 146.232.66.2 (eth2) | Actual local interface address is 146.232.197.237 (eth0)
Actual local interface address is 146.232.128.14 (eth0) <
Actual local interface address is 146.232.65.10 (eth1) <
Actual local interface address is 146.232.65.100 (eth1:1) <
Actual local interface address is 146.232.65.101 (eth1:2) <
Actual local interface address is 146.232.65.102 (eth1:3) <
Actual local interface address is 146.232.65.103 (eth1:4) <
Actual local interface address is 146.232.65.104 (eth1:5) <
Actual local interface address is 146.232.65.105 (eth1:6) <
Actual local interface address is 146.232.65.55 (eth1:7) <
Caller is an admin user Caller is an admin user
Caller is a trusted user Caller is a trusted user
set_process_info: 24440 delivering specified messages | set_process_info: 18322 delivering specified messages
delivering message 18y5gd-0006Lz-00 | delivering message 18y5sW-0004lU-00
set_process_info: 24440 delivering 18y5gd-0006Lz-00 | set_process_info: 18322 delivering 18y5sW-0004lU-00
Opened spool file 18y5gd-0006Lz-00-H | Opened spool file 18y5sW-0004lU-00-H
user=root uid=0 gid=0 sender=root@??? | user=root uid=0 gid=0 sender=root@???
sender_local=1 resent=no ident=root sender_local=1 resent=no ident=root
Non-recipients: Non-recipients:
Empty Tree Empty Tree
---- End of tree ---- ---- End of tree ----
recipients_count=1 recipients_count=1
body_linecount=1 message_linecount=7 body_linecount=1 message_linecount=7
Delivery address list: Delivery address list:
jspies@??? jspies@???
locked /var/spool/exim/db/retry.lockfile locked /var/spool/exim/db/retry.lockfile
opened DB file /var/spool/exim/db/retry: flags=0 opened DB file /var/spool/exim/db/retry: flags=0
>>>>>>>>>>>>>>>>>>>>>>>> >>>>>>>>>>>>>>>>>>>>>>>>
Considering: jspies@??? Considering: jspies@???
sun.ac.za in local_domains? no (end of list) sun.ac.za in local_domains? no (end of list)
unique = jspies@??? unique = jspies@???
dbfn_read: key=R:sun.ac.za dbfn_read: key=R:sun.ac.za
dbfn_read: key=R:jspies@??? dbfn_read: key=R:jspies@???
jspies@???: queued for routing jspies@???: queued for routing
>>>>>>>>>>>>>>>>>>>>>>>> >>>>>>>>>>>>>>>>>>>>>>>>
After directing: After directing:
Local deliveries: Local deliveries:
Remote deliveries: Remote deliveries:
Failed addresses: Failed addresses:
Addresses to be routed: Addresses to be routed:
jspies@??? jspies@???
Deferred addresses: Deferred addresses:
>>>>>>>>>>>>>>>>>>>>>>>> >>>>>>>>>>>>>>>>>>>>>>>>
routing jspies@???, domain sun.ac.za routing jspies@???, domain sun.ac.za
smarthost router called for jspies@??? smarthost router called for jspies@???
route_domain = sun.ac.za route_domain = sun.ac.za
routelist_item = * maties3.sun.ac.za bydns_a routelist_item = * maties3.sun.ac.za bydns_a
after handling route_lists items, matched = 1 after handling route_lists items, matched = 1
original hostlist=maties3.sun.ac.za options=bydns_a original hostlist=maties3.sun.ac.za options=bydns_a
expanded hostlist="maties3.sun.ac.za" options=bydns_a expanded hostlist="maties3.sun.ac.za" options=bydns_a
DNS lookup of maties3.sun.ac.za (A) succeeded DNS lookup of maties3.sun.ac.za (A) succeeded
Actual local interface address is 127.0.0.1 (lo) Actual local interface address is 127.0.0.1 (lo)
Actual local interface address is 146.232.66.2 (eth2) | Actual local interface address is 146.232.197.237 (eth0)
Actual local interface address is 146.232.128.14 (eth0) <
Actual local interface address is 146.232.65.10 (eth1) <
Actual local interface address is 146.232.65.100 (eth1:1) <
Actual local interface address is 146.232.65.101 (eth1:2) <
Actual local interface address is 146.232.65.102 (eth1:3) <
Actual local interface address is 146.232.65.103 (eth1:4) <
Actual local interface address is 146.232.65.104 (eth1:5) <
Actual local interface address is 146.232.65.105 (eth1:6) <
Actual local interface address is 146.232.65.55 (eth1:7) <
fully qualified name = maties3.sun.ac.za fully qualified name = maties3.sun.ac.za
maties3.sun.ac.za 146.232.128.43 mx=-1 sort=-92 | maties3.sun.ac.za 146.232.128.43 mx=-1 sort=-95
routed by smarthost router: routed by smarthost router:
deliver to jspies@??? deliver to jspies@???
transport: remote_smtp transport: remote_smtp
host maties3.sun.ac.za [146.232.128.43] host maties3.sun.ac.za [146.232.128.43]
search_tidyup called search_tidyup called
>>>>>> Remote deliveries >>>>>> >>>>>> Remote deliveries >>>>>>
remote_smtp transport entered remote_smtp transport entered
jspies@??? jspies@???
sun.ac.za in queue_smtp_domains? no (end of list) sun.ac.za in queue_smtp_domains? no (end of list)
checking status of maties3.sun.ac.za checking status of maties3.sun.ac.za
locked /var/spool/exim/db/retry.lockfile locked /var/spool/exim/db/retry.lockfile
opened DB file /var/spool/exim/db/retry: flags=0 opened DB file /var/spool/exim/db/retry: flags=0
dbfn_read: key=T:maties3.sun.ac.za:146.232.128.43 dbfn_read: key=T:maties3.sun.ac.za:146.232.128.43
dbfn_read: key=T:maties3.sun.ac.za:146.232.128.43:18y5gd-0006 | dbfn_read: key=T:maties3.sun.ac.za:146.232.128.43:18y5sW-0004
no host retry record no host retry record
no message retry record no message retry record
maties3.sun.ac.za [146.232.128.43] status = usable maties3.sun.ac.za [146.232.128.43] status = usable
host in ? no (option unset) host in ? no (option unset)
delivering 18y5gd-0006Lz-00 to maties3.sun.ac.za [146.232.128 | delivering 18y5sW-0004lU-00 to maties3.sun.ac.za [146.232.128
set_process_info: 24440 delivering 18y5gd-0006Lz-00 to maties | set_process_info: 18322 delivering 18y5sW-0004lU-00 to maties
Connecting to maties3.sun.ac.za [146.232.128.43.25] ... conne Connecting to maties3.sun.ac.za [146.232.128.43.25] ... conne
read response data: size=29 read response data: size=29
SMTP<< 220 maties3.sun.ac.za ESMTP SMTP<< 220 maties3.sun.ac.za ESMTP
SMTP>> EHLO archive.sun.ac.za | SMTP>> EHLO webct-tyg1
read response data: size=109 | read response data: size=113
SMTP<< 250-maties3.sun.ac.za Hello archive.sun.ac.za [146.2 | SMTP<< 250-maties3.sun.ac.za Hello webct-tyg1.sun.ac.za [14
250-SIZE 25165824 250-SIZE 25165824
250-PIPELINING 250-PIPELINING
250 HELP 250 HELP
host in ? no (option unset) host in ? no (option unset)
SMTP>> MAIL FROM:<root@???> SIZE=1349 | SMTP>> MAIL FROM:<root@???> SIZE=1337
SMTP>> RCPT TO:<jspies@???> SMTP>> RCPT TO:<jspies@???>
SMTP>> DATA SMTP>> DATA
read response data: size=78 | read response data: size=82
SMTP<< 250 OK SMTP<< 250 OK
SMTP<< 250 Accepted | SMTP<< 550 Administrative prohibition
SMTP<< 354 Enter message, ending with "." on a line by itse | SMTP<< 503 valid RCPT command must precede DATA
SMTP>> writing message and terminating "." | ok=1 send_quit=1 send_rset=1 continue_more=0 yield=0 first_ad
writing data block fd=6 size=329 timeout=300 <
read response data: size=28 <
SMTP<< 250 OK id=18y5gj-0001K6-00 <
ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_ad <
transport_check_waiting entered transport_check_waiting entered
sequence=1 local_max=500 global_max=-1 sequence=1 local_max=500 global_max=-1
locked /var/spool/exim/db/wait-remote_smtp.lockfile locked /var/spool/exim/db/wait-remote_smtp.lockfile
opened DB file /var/spool/exim/db/wait-remote_smtp: flags=42 opened DB file /var/spool/exim/db/wait-remote_smtp: flags=42
dbfn_read: key=maties3.sun.ac.za dbfn_read: key=maties3.sun.ac.za
no messages waiting for maties3.sun.ac.za no messages waiting for maties3.sun.ac.za
SMTP>> QUIT SMTP>> QUIT
set_process_info: 24440 delivering 18y5gd-0006Lz-00: just tri | set_process_info: 18322 delivering 18y5sW-0004lU-00: just tri
Leaving remote_smtp transport Leaving remote_smtp transport
set_process_info: 24440 delivering 18y5gd-0006Lz-00 (just run | set_process_info: 18322 delivering 18y5sW-0004lU-00 (just run
post-process jspies@??? (0) | post-process jspies@??? (7)
jspies@??? succeeded: adding to nonrecipients list <
LOG: 0 MAIN LOG: 0 MAIN
=> jspies@??? R=smarthost T=remote_smtp H=maties3.sun | ** jspies@??? R=smarthost T=remote_smtp: SMTP error f
set_process_info: 24440 tidying up after delivering 18y5gd-00 | set_process_info: 18322 tidying up after delivering 18y5sW-00
Processing retry items Processing retry items
Succeeded addresses: Succeeded addresses:
> Failed addresses:
jspies@???: no retry items jspies@???: no retry items
> Deferred addresses:
> end of retry processing
> sending error message to: root@???
> writing data block fd=8 size=346 timeout=0
> Exim version 3.22 debug level 9 uid=8 gid=12
> Berkeley DB: Sleepycat Software: DB 2.4.14: (6/2/98)
> webct-tyg1 in local_domains? yes (matched webct-tyg1)
> Actual local interface address is 127.0.0.1 (lo)
> Actual local interface address is 146.232.197.237 (eth0)
> Caller is an admin user
> Caller is a trusted user
> originator: uid=8 gid=12 login=mail name=
> sender address =
> set_process_info: 18323 accepting a local non-SMTP message fr
> Sender:
> search_tidyup called
> >>Original headers (size=191):
> X-Failed-Recipients: jspies@???
> From: Mail Delivery System <Mailer-Daemon@???
> To: root@???
> Subject: Mail delivery failed: returning message to sender
>
> rewrite_one_header: type=F:
> From: Mail Delivery System <Mailer-Daemon@???
> rewrite_one_header: type=T:
> To: root@???
> search_tidyup called
> >>Final headers:
> P Received: from mail by webct-tyg1 with local (Exim 3.22 #1
> id 18y5sj-0004lX-00
> for <root@???>; Wed, 26 Mar 2003 10:
> X-Failed-Recipients: jspies@???
> F From: Mail Delivery System <Mailer-Daemon@???
> T To: root@???
> Subject: Mail delivery failed: returning message to sender
> I Message-Id: <E18y5sj-0004lX-00@webct-tyg1>
> Date: Wed, 26 Mar 2003 10:03:33 +0200
>
> Data file written for message 18y5sj-0004lX-00
> Writing spool header file
> Size of headers = 435
> LOG: 0 MAIN
> <= <> R=18y5sW-0004lU-00 U=mail P=local S=1236
> search_tidyup called
> exec /usr/sbin/exim -d9 -Mc 18y5sj-0004lX-00
> LOG: 5 MAIN
> Error message sent to root@???
> Writing spool header file
> Exim version 3.22 debug level 9 uid=8 gid=12
> Berkeley DB: Sleepycat Software: DB 2.4.14: (6/2/98)
> webct-tyg1 in local_domains? yes (matched webct-tyg1)
> Actual local interface address is 127.0.0.1 (lo)
> Actual local interface address is 146.232.197.237 (eth0)
> Caller is an admin user
> Caller is a trusted user
> set_process_info: 18324 delivering specified messages
> delivering message 18y5sj-0004lX-00
> set_process_info: 18324 delivering 18y5sj-0004lX-00
> Opened spool file 18y5sj-0004lX-00-H
> user=mail uid=8 gid=12 sender=
> sender_local=0 resent=no ident=mail
> Non-recipients:
> Empty Tree
> ---- End of tree ----
> recipients_count=1
> body_linecount=21 message_linecount=9
> Delivery address list:
> root@???
> locked /var/spool/exim/db/retry.lockfile
> opened DB file /var/spool/exim/db/retry: flags=0
> >>>>>>>>>>>>>>>>>>>>>>>>
> Considering: root@???
> webct-tyg1.sun.ac.za in local_domains? yes (matched webct-tyg
> webct-tyg1.sun.ac.za in percent_hack_domains? no (end of list
> unique = root@???
> dbfn_read: key=D:root@???
> root@???: queued for directing
> >>>>>>>>>>>>>>>>>>>>>>>>
> directing root@???
> real_local director skipped: prefix mismatch
> calling system_aliases director
> df_lookup entered: search type = lsearch
> system_aliases director: lsearch key=root
> file="/etc/aliases"
> search_open: lsearch "/etc/aliases"
> search_find: file="/etc/aliases"
> key="root" partial=-1
> LRU list:
> 7/etc/aliases
> End
> internal_search_find: file="/etc/aliases"
> type=lsearch key="root"
> file lookup required for root
> in /etc/aliases
> lookup yielded: gerhardv
> parse_extract_addresses: gerhardv
> extract item: gerhardv
> system_aliases director generated gerhardv@???.
> errors_to=NULL transport=NULL
> uid=unset gid=unset home=NULL
> system_aliases director succeeded for root
> locked /var/spool/exim/db/retry.lockfile
> opened DB file /var/spool/exim/db/retry: flags=0
> >>>>>>>>>>>>>>>>>>>>>>>>
> Considering: gerhardv@???
> webct-tyg1.sun.ac.za in local_domains? yes (matched webct-tyg
> webct-tyg1.sun.ac.za in percent_hack_domains? no (end of list
> unique = gerhardv@???
> dbfn_read: key=D:gerhardv@???
> gerhardv@???: queued for directing
> >>>>>>>>>>>>>>>>>>>>>>>>
> directing gerhardv@???
> real_local director skipped: prefix mismatch
> calling system_aliases director
> df_lookup entered: search type = lsearch
> system_aliases director: lsearch key=gerhardv
> file="/etc/aliases"
> search_open: lsearch "/etc/aliases"
> cached open
> search_find: file="/etc/aliases"
> key="gerhardv" partial=-1
> LRU list:
> 7/etc/aliases
> End
> internal_search_find: file="/etc/aliases"
> type=lsearch key="gerhardv"
> file lookup required for gerhardv
> in /etc/aliases
> lookup failed
> system_aliases director declined for gerhardv:
> calling userforward director
> userforward director: file = .forward
> set uid=0 gid=12 euid=503 egid=503
> successful stat of /home/gerhardv/.
> /home/gerhardv/.forward not found
> restored uid=0 gid=12 euid=8 egid=12
> calling localuser director
> queued for local_delivery transport: local_part=gerhardv doma
> errors_to=NULL
> domain_data=NULL local_part_data=NULL
> localuser director succeeded for gerhardv
> >>>>>>>>>>>>>>>>>>>>>>>>
> After directing:
> Local deliveries:
> gerhardv@???
> Remote deliveries:
> Failed addresses:
> Addresses to be routed:
> Deferred addresses:
> search_tidyup called
> >>>>>> Local deliveries >>>>>>
> locked /var/spool/exim/db/retry.lockfile
> opened DB file /var/spool/exim/db/retry: flags=0
> dbfn_read: key=T:gerhardv@???
> delivering gerhardv@??? as gerhardv using lo
> uid=503 gid=12 home=/home/gerhardv current=/home/gerhardv
> auxiliary group list: <none>
> set_process_info: 18325 delivering 18y5sj-0004lX-00 to gerhar
> appendfile transport entered
> appendfile: mode=660 notify_comsat=0 quota=0
> file=/var/spool/mail/gerhardv format=unix
> prefix=From ${if def:return_path{$return_path}{MAILER-DAEMO
> suffix=\n
> locking by lockfile fcntl
> lock name: /var/spool/mail/gerhardv.lock
> hitch name: /var/spool/mail/gerhardv.lock.webct-tyg1.3e815ed5
> lock file created
> mailbox /var/spool/mail/gerhardv is locked
> writing to file /var/spool/mail/gerhardv
> writing data block fd=6 size=44 timeout=0
> writing data block fd=6 size=1275 timeout=0
> writing data block fd=6 size=1 timeout=0
> Size of headers = 295
> LOG: 0 MAIN
> Completed
> end delivery of 18y5sW-0004lU-00
> search_tidyup called
> appendfile yields 0 with errno=0 more_errno=0
> journalled gerhardv@???
> local_delivery transport returned OK for gerhardv@webct-tyg1.
> post-process gerhardv@??? (0)
> gerhardv@??? succeeded: adding to nonrecipie
> root@???: children all complete
> LOG: 0 MAIN
> => gerhardv <root@???> D=localuser T=local
> search_tidyup called
> set_process_info: 18324 tidying up after delivering 18y5sj-00
> Processing retry items
> Succeeded addresses:
> gerhardv@???: no retry items
> root@???: no retry items
> root@???: no retry items
Failed addresses: Failed addresses:
Deferred addresses: Deferred addresses:
end of retry processing end of retry processing
LOG: 0 MAIN LOG: 0 MAIN
Completed Completed
end delivery of 18y5gd-0006Lz-00 | end delivery of 18y5sj-0004lX-00
search_tidyup called search_tidyup called
| [root@webct-tyg1 exim]# exit
[?[1mroot?[0m@?[1marchive?[0m-?[1m09:51:11?[0m]-#2 /tmp | exit
> exit <
<
--
