On Mon, Mar 17, 2008 at 03:28:51PM +0000, Tony Finch wrote:
> On Fri, 14 Mar 2008, Vincent Stemen wrote:
> >
> > Thanks for the suggestion. No, there is no further debug output when it
> > attempts delivery. Here is everything it output.
>
> You aren't injecting the message using SMTP, which is why your debug
> output is useless. Get whatever is injecting the message to pass in
> debugging flags. If you can't do that, set queue_only=true and
> queue_only_override=false in your Exim configuration, and use exim -d -M
> ... to trigger a debugging delivery of the relevant message. That should
> show you what the problem is.
>
> Tony.
Ah. Thank you Tony. I did not think of that. OK. I finally got
a chance to get back on this. I found I could pass the -d option as the
last argument to *mail* to test from the command line and it gets passed
to sendmail (exim).
Below is the debug output up to the delivery attempt.
It shows it is using the remote_smtp transport, but I see no indication
that it sees the headers_rewrite line. It is as if it is not even
there.
As a reminder, Here is my transport configuration.
remote_smtp:
driver = smtp
headers_rewrite = *@*.mydomain.org $1@??? fs
Debug output
============
Exim version 4.67 uid=0 gid=0 pid=47381 D=fbb95cfd
Probably Berkeley DB version 1.8x (native mode)
Support for: crypteq IPv6 TCPwrappers OpenSSL Content_Scanning Old_Demime
Lookups: lsearch wildlsearch nwildlsearch iplsearch dbm dbmnz dsearch
Authenticators: cram_md5 plaintext spa
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply pipe smtp
Fixed never_users: 0
Size of off_t: 8
changed uid/gid: forcing real = effective
uid=0 gid=0 pid=47381
auxiliary group list: 0
configuration file is /usr/pkg/etc/exim/configure
log selectors = 00000ffc 00212001
cwd=/usr/pkg/etc/exim 4 args: send-mail -i -d zzz@???
trusted user
admin user
changed uid/gid: privilege not needed
uid=1004 gid=6 pid=47381
auxiliary group list: 6 6
originator: uid=0 gid=0 login=root name=Charlie Root
sender address = root@???
set_process_info: 47381 accepting a local non-SMTP message from <root@???>
Sender: root@???
Recipients:
zzz@???
search_tidyup called
>>Headers received:
To: zzz@???
Subject: test
rewrite_one_header: type=T:
To: zzz@???
rewrite_one_header: type=F:
From: Charlie Root <root@???>
search_tidyup called
>>Headers after rewriting and local additions:
T To: zzz@???
Subject: test
I Message-Id: <E1Je3Qh-000CKD-Cn@???>
F From: Charlie Root <root@???>
Date: Tue, 25 Mar 2008 02:18:43 -0500
Data file written for message 1Je3Qh-000CKD-Cn
>>Generated Received: header line
P Received: from root by quark.mydomain.org with local (Exim 4.67)
(envelope-from <root@???>)
id 1Je3Qh-000CKD-Cn
for zzz@???; Tue, 25 Mar 2008 02:18:43 -0500
calling local_scan(); timeout=300
local_scan() returned 0 NULL
Writing spool header file
Size of headers = 339
LOG: MAIN
<= root@??? U=root P=local S=349
search_tidyup called
search_tidyup called
>>>>>>>>>>>>>>>> Exim pid=47381 terminating with rc=0 >>>>>>>>>>>>>>>>
exec /usr/pkg/sbin/exim -d=0xfbb95cfd -Mc 1Je3Qh-000CKD-Cn
Exim version 4.67 uid=1004 gid=6 pid=47382 D=fbb95cfd
Probably Berkeley DB version 1.8x (native mode)
Support for: crypteq IPv6 TCPwrappers OpenSSL Content_Scanning Old_Demime
Lookups: lsearch wildlsearch nwildlsearch iplsearch dbm dbmnz dsearch
Authenticators: cram_md5 plaintext spa
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply pipe smtp
Fixed never_users: 0
Size of off_t: 8
changed uid/gid: forcing real = effective
uid=0 gid=6 pid=47382
auxiliary group list: 6
configuration file is /usr/pkg/etc/exim/configure
log selectors = 00000ffc 00212001
cwd=/var/spool/exim 4 args: /usr/pkg/sbin/exim -d=0xfbb95cfd -Mc 1Je3Qh-000CKD-Cn
trusted user
admin user
skipping ACL configuration - not needed
set_process_info: 47382 delivering specified messages
set_process_info: 47382 delivering 1Je3Qh-000CKD-Cn
reading spool file 1Je3Qh-000CKD-Cn-H
user=root uid=0 gid=0 sender=root@???
sender_local=1 ident=root
Non-recipients:
Empty Tree
---- End of tree ----
recipients_count=1
body_linecount=1 message_linecount=9
Delivery address list:
zzz@???
locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
EXIM_DBOPEN(/var/spool/exim/db/retry)
returned from EXIM_DBOPEN
no retry data available
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Considering: zzz@???
unique = zzz@???
no domain retry record
no address retry record
zzz@???: queued for routing
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
routing zzz@???
--------> mail_relay router <--------
local_part=zzz domain=my-other-domain.us
checking domains
my-other-domain.us in "@ : localhost"? no (end of list)
my-other-domain.us in "!+local_domains"? yes (end of list)
calling mail_relay router
mail_relay router called for zzz@???
domain = my-other-domain.us
route_item = * mail.my-other-domain.us::24
my-other-domain.us in "*"? yes (matched "*")
original list of hosts = "mail.my-other-domain.us::24" options =
expanded list of hosts = "mail.my-other-domain.us::24" options =
set transport remote_smtp
finding IP address for mail.my-other-domain.us:24
host=mail.my-other-domain.us port=24
doing DNS lookup
DNS lookup of mail.my-other-domain.us (AAAA) gave NO_DATA
returning DNS_NODATA
DNS lookup of mail.my-other-domain.us (A) succeeded
fully qualified name = mail.my-other-domain.us
mail.my-other-domain.us 82.146.52.239 mx=-1 sort=-126
queued for remote_smtp transport: local_part = zzz
domain = my-other-domain.us
errors_to=NULL
domain_data=NULL localpart_data=NULL
routed by mail_relay router
envelope to: zzz@???
transport: remote_smtp
host mail.my-other-domain.us [82.146.52.239] port=24
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
After routing:
Local deliveries:
Remote deliveries:
zzz@???
Failed addresses:
Deferred addresses:
search_tidyup called
>>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
--------> zzz@??? <--------
search_tidyup called
set_process_info: 47382 delivering 1Je3Qh-000CKD-Cn: waiting for a remote delivery subprocess to finish
selecting on subprocess pipes
changed uid/gid: remote delivery to zzz@??? with transport=remote_smtp
uid=1004 gid=6 pid=47383
auxiliary group list: 6
set_process_info: 47383 delivering 1Je3Qh-000CKD-Cn using remote_smtp
remote_smtp transport entered
zzz@???
my-other-domain.us in queue_smtp_domains? no (option unset)
checking status of mail.my-other-domain.us
locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
EXIM_DBOPEN(/var/spool/exim/db/retry)
returned from EXIM_DBOPEN
no retry data available
mail.my-other-domain.us [82.146.52.239]:24 status = usable
82.146.52.239 in serialize_hosts? no (option unset)
delivering 1Je3Qh-000CKD-Cn to mail.my-other-domain.us [82.146.52.239] (zzz@???)
set_process_info: 47383 delivering 1Je3Qh-000CKD-Cn to mail.my-other-domain.us [82.146.52.239] (zzz@???)
Transport port=25 replaced by host-specific port=24
Connecting to mail.my-other-domain.us [82.146.52.239]:24 ... connected
waiting for data on socket
read response data: size=66
SMTP<< 220 mail.my-other-domain.us ESMTP Exim 4.67 Tue, 25 Mar 2008 02:18:53 -0500
82.146.52.239 in hosts_avoid_esmtp? no (option unset)
SMTP>> EHLO quark.mydomain.org
waiting for data on socket
read response data: size=113
SMTP<< 250-mail.my-other-domain.us Hello ip68-12-66-144.ok.ok.cox.net [68.12.66.144]
250-SIZE 52428800
250-PIPELINING
250 HELP
82.146.52.239 in hosts_require_tls? no (option unset)
82.146.52.239 in hosts_avoid_pipelining? no (option unset)
using PIPELINING
82.146.52.239 in hosts_require_auth? no (option unset)
SMTP>> MAIL FROM:<root@???> SIZE=1383
SMTP>> RCPT TO:<zzz@???>
SMTP>> DATA
waiting for data on socket
...
...
