Roy Bonser
2006-Oct-12 18:43 UTC
[Pkg-exim4-users] weird rewrite problem - address rewritten to alias then sent as original address
Here is the situation, I''m trying to get system messages forwarded off
a debian testing box with a stock exim4 setup. I have not made changes
to the files in /etc/exim4/conf.d at all.
The network here, let''s call it local.domain, has several subdomains in
it. The box is in one I''m calling my.local.domain and the smarthost is
in another, mail.local.domain.
I have the system accounts aliased to root and root is aliased to
myname@my.isp.domain.
What happens is the mail to root is being sent as root@my.local.domain
even though the name is being changed to myname@my.isp.domain in the
debug output. I can''t find where it is being switched back to the
original To: address. The log shows the address as => alias address
<original address> being sent to the smarthost.
Here is a test mail with debugging then the config files and log
snippet follow. (names replaced with generics as mentioned above) I did
not attach the /var/lib/exim4/config.autogenerated because it is stock
config but I can if it would help.
I would appreciate any insight into the problem.
Thanks,
--Roy
Script started on Thu 12 Oct 2006 12:41:09 PM EDT
mail-host:~# mailx -s "root mail" root -- -d+all
test mail to root on mail-host
Cc:
12:41:30 30632 Exim version 4.63 uid=0 gid=0 pid=30632 D=fffdffff
Berkeley DB: Sleepycat Software: Berkeley DB 4.3.29: (September 6,
2005)
Support for: crypteq iconv() IPv6 GnuTLS move_frozen_messages
Lookups: lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmnz
dsearch nis nis0 passwd
Authenticators: cram_md5 plaintext
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore autoreply lmtp pipe smtp
Fixed never_users: 0
Size of off_t: 8
12:41:30 30632 changed uid/gid: forcing real = effective
12:41:30 30632 uid=0 gid=0 pid=30632
12:41:30 30632 auxiliary group list: <none>
12:41:30 30632 seeking password data for user "uucp": cache not
available
12:41:30 30632 getpwnam() succeeded uid=10 gid=10
12:41:30 30632 configuration file is /var/lib/exim4/config.autogenerated
12:41:30 30632 log selectors = 00000ffc 00089001
12:41:30 30632 cwd=~ 5 args: send-mail -i -d+all -- root
12:41:30 30632 trusted user
12:41:30 30632 admin user
12:41:30 30632 changed uid/gid: privilege not needed
12:41:30 30632 uid=102 gid=102 pid=30632
12:41:30 30632 auxiliary group list: 102
12:41:30 30632 seeking password data for user "mail": cache not
available
12:41:30 30632 getpwnam() succeeded uid=8 gid=8
12:41:30 30632 expanding: $1
12:41:30 30632 result: root
12:41:30 30632 user name "root" extracted from gecos field
"root"
12:41:30 30632 originator: uid=0 gid=0 login=root name=root
12:41:30 30632 sender address = root@my.local.domain
12:41:30 30632 set_process_info: 30632 accepting a local non-SMTP
message from <root@my.local.domain>
12:41:30 30632 Sender: root@my.local.domain
12:41:30 30632 Recipients:
12:41:30 30632 root
12:41:30 30632 search_tidyup called
12:41:30 30632 >>Headers received:
12:41:30 30632 To: root
12:41:30 30632 Subject: root mail
12:41:30 30632
12:41:30 30632 address match: subject=root@my.local.domain
pattern=*@+local_domains
12:41:30 30632 my.local.domain in "@:localhost:my.local.domain"? yes
(matched "my.local.domain")
12:41:30 30632 my.local.domain in "+local_domains"? yes (matched
"+local_domains")
12:41:30 30632 root@my.local.domain in "*@+local_domains"? yes
(matched
"*@+local_domains")
12:41:30 30632 expanding: ${local_part}
12:41:30 30632 result: root
12:41:30 30632 expanding: /etc/email-addresses
12:41:30 30632 result: /etc/email-addresses
12:41:30 30632 search_open: lsearch "/etc/email-addresses"
12:41:30 30632 search_find: file="/etc/email-addresses"
12:41:30 30632 key="root" partial=-1 affix=NULL starflags=0
12:41:30 30632 LRU list:
12:41:30 30632 :/etc/email-addresses
12:41:30 30632 End
12:41:30 30632 internal_search_find: file="/etc/email-addresses"
12:41:30 30632 type=lsearch key="root"
12:41:30 30632 file lookup required for root
12:41:30 30632 in /etc/email-addresses
12:41:30 30632 lookup failed
12:41:30 30632 expanding: $value
12:41:30 30632 result:
12:41:30 30632 skipping: result is not used
12:41:30 30632 failed to expand:
${lookup{${local_part}}lsearch{/etc/email-addresses}{$value}fail}
12:41:30 30632 error message: "lookup" failed and "fail"
requested
12:41:30 30632 failure was forced
12:41:30 30632 address match: subject=root@my.local.domain
pattern=*@my.local.domain
12:41:30 30632 my.local.domain in "my.local.domain"? yes (matched
"my.local.domain")
12:41:30 30632 root@my.local.domain in "*@my.local.domain"? yes
(matched "*@my.local.domain")
12:41:30 30632 expanding: ${local_part}
12:41:30 30632 result: root
12:41:30 30632 expanding: /etc/email-addresses
12:41:30 30632 result: /etc/email-addresses
12:41:30 30632 search_open: lsearch "/etc/email-addresses"
12:41:30 30632 cached open
12:41:30 30632 search_find: file="/etc/email-addresses"
12:41:30 30632 key="root" partial=-1 affix=NULL starflags=0
12:41:30 30632 LRU list:
12:41:30 30632 :/etc/email-addresses
12:41:30 30632 End
12:41:30 30632 internal_search_find: file="/etc/email-addresses"
12:41:30 30632 type=lsearch key="root"
12:41:30 30632 cached data used for lookup of root
12:41:30 30632 in /etc/email-addresses
12:41:30 30632 lookup failed
12:41:30 30632 expanding: $value
12:41:30 30632 result:
12:41:30 30632 skipping: result is not used
12:41:30 30632 failed to expand: ${lookup {${local_part}} lsearch
{/etc/email-addresses} {$value} fail }
12:41:30 30632 error message: "lookup" failed and "fail"
requested
12:41:30 30632 failure was forced
12:41:30 30632 rewritten sender = root@my.local.domain
12:41:30 30632 rewrite_one_header: type=T:
12:41:30 30632 To: root
12:41:30 30632 newlen=28 newtype=T newtext:
12:41:30 30632 To: root@my.local.domain
12:41:30 30632 remainder:
12:41:30 30632 rewrite_one_header: type=F:
12:41:30 30632 From: root <root@my.local.domain>
12:41:30 30632 address match: subject=root@my.local.domain
pattern=*@+local_domains
12:41:30 30632 my.local.domain in "@:localhost:my.local.domain"? yes
(matched "my.local.domain")
12:41:30 30632 my.local.domain in "+local_domains"? yes (matched
"+local_domains")
12:41:30 30632 root@my.local.domain in "*@+local_domains"? yes
(matched
"*@+local_domains")
12:41:30 30632 expanding: ${local_part}
12:41:30 30632 result: root
12:41:30 30632 expanding: /etc/email-addresses
12:41:30 30632 result: /etc/email-addresses
12:41:30 30632 search_open: lsearch "/etc/email-addresses"
12:41:30 30632 cached open
12:41:30 30632 search_find: file="/etc/email-addresses"
12:41:30 30632 key="root" partial=-1 affix=NULL starflags=0
12:41:30 30632 LRU list:
12:41:30 30632 :/etc/email-addresses
12:41:30 30632 End
12:41:30 30632 internal_search_find: file="/etc/email-addresses"
12:41:30 30632 type=lsearch key="root"
12:41:30 30632 cached data used for lookup of root
12:41:30 30632 in /etc/email-addresses
12:41:30 30632 lookup failed
12:41:30 30632 expanding: $value
12:41:30 30632 result:
12:41:30 30632 skipping: result is not used
12:41:30 30632 failed to expand:
${lookup{${local_part}}lsearch{/etc/email-addresses}{$value}fail}
12:41:30 30632 error message: "lookup" failed and "fail"
requested
12:41:30 30632 failure was forced
12:41:30 30632 address match: subject=root@my.local.domain
pattern=*@my.local.domain
12:41:30 30632 my.local.domain in "my.local.domain"? yes (matched
"my.local.domain")
12:41:30 30632 root@my.local.domain in "*@my.local.domain"? yes
(matched "*@my.local.domain")
12:41:30 30632 expanding: ${local_part}
12:41:30 30632 result: root
12:41:30 30632 expanding: /etc/email-addresses
12:41:30 30632 result: /etc/email-addresses
12:41:30 30632 search_open: lsearch "/etc/email-addresses"
12:41:30 30632 cached open
12:41:30 30632 search_find: file="/etc/email-addresses"
12:41:30 30632 key="root" partial=-1 affix=NULL starflags=0
12:41:30 30632 LRU list:
12:41:30 30632 :/etc/email-addresses
12:41:30 30632 End
12:41:30 30632 internal_search_find: file="/etc/email-addresses"
12:41:30 30632 type=lsearch key="root"
12:41:30 30632 cached data used for lookup of root
12:41:30 30632 in /etc/email-addresses
12:41:30 30632 lookup failed
12:41:30 30632 expanding: $value
12:41:30 30632 result:
12:41:30 30632 skipping: result is not used
12:41:30 30632 failed to expand: ${lookup {${local_part}} lsearch
{/etc/email-addresses} {$value} fail }
12:41:30 30632 error message: "lookup" failed and "fail"
requested
12:41:30 30632 failure was forced
12:41:30 30632 search_tidyup called
12:41:30 30632 >>Headers after rewriting and local additions:
12:41:30 30632 * To: root
12:41:30 30632 T To: root@my.local.domain
12:41:30 30632 Subject: root mail
12:41:30 30632 I Message-Id:
<E1GY3cg-0007y4-Kt@mail-host.my.local.domain>
12:41:30 30632 F From: root <root@my.local.domain>
12:41:30 30632 Date: Thu, 12 Oct 2006 12:41:30 -0400
12:41:30 30632
12:41:30 30632 Data file written for message 1GY3cg-0007y4-Kt
12:41:30 30632 expanding: ${tod_full}
12:41:30 30632 result: Thu, 12 Oct 2006 12:41:30 -0400
12:41:30 30632 condition: def:sender_rcvhost
12:41:30 30632 result: false
12:41:30 30632 expanding: from $sender_rcvhost
12:41:30 30632
12:41:30 30632 result: from
12:41:30 30632
12:41:30 30632 skipping: result is not used
12:41:30 30632 condition: def:sender_ident
12:41:30 30632 result: true
12:41:30 30632 expanding: $sender_ident
12:41:30 30632 result: root
12:41:30 30632 expanding: from ${quote_local_part:$sender_ident}
12:41:30 30632 result: from root
12:41:30 30632 condition: def:sender_helo_name
12:41:30 30632 result: false
12:41:30 30632 expanding: (helo=$sender_helo_name)
12:41:30 30632
12:41:30 30632 result: (helo=)
12:41:30 30632
12:41:30 30632 skipping: result is not used
12:41:30 30632 expanding: ${if def:sender_ident {from
${quote_local_part:$sender_ident} }}${if def:sender_helo_name
{(helo=$sender_helo_name)
12:41:30 30632 }}
12:41:30 30632 result: from root
12:41:30 30632 condition: def:received_protocol
12:41:30 30632 result: true
12:41:30 30632 expanding: with $received_protocol
12:41:30 30632 result: with local
12:41:30 30632 condition: def:tls_cipher
12:41:30 30632 result: false
12:41:30 30632 expanding: ($tls_cipher)
12:41:30 30632
12:41:30 30632 result: ()
12:41:30 30632
12:41:30 30632 skipping: result is not used
12:41:30 30632 condition: def:sender_address
12:41:30 30632 result: true
12:41:30 30632 expanding: (envelope-from <$sender_address>)
12:41:30 30632
12:41:30 30632 result: (envelope-from <root@my.local.domain>)
12:41:30 30632
12:41:30 30632 condition: def:received_for
12:41:30 30632 result: true
12:41:30 30632 expanding:
12:41:30 30632 for $received_for
12:41:30 30632 result:
12:41:30 30632 for root@my.local.domain
12:41:30 30632 expanding: Received: ${if def:sender_rcvhost {from
$sender_rcvhost
12:41:30 30632 }{${if def:sender_ident {from
${quote_local_part:$sender_ident} }}${if def:sender_helo_name
{(helo=$sender_helo_name)
12:41:30 30632 }}}}by $primary_hostname ${if def:received_protocol
{with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
12:41:30 30632 }}(Exim $version_number)
12:41:30 30632 ${if def:sender_address {(envelope-from
<$sender_address>)
12:41:30 30632 }}id $message_exim_id${if def:received_for {
12:41:30 30632 for $received_for}}
12:41:30 30632 result: Received: from root by
mail-host.my.local.domain with local (Exim 4.63)
12:41:30 30632 (envelope-from <root@my.local.domain>)
12:41:30 30632 id 1GY3cg-0007y4-Kt
12:41:30 30632 for root@my.local.domain
12:41:30 30632 >>Generated Received: header line
12:41:30 30632 P Received: from root by mail-host.my.local.domain with
local (Exim 4.63)
12:41:30 30632 (envelope-from <root@my.local.domain>)
12:41:30 30632 id 1GY3cg-0007y4-Kt
12:41:30 30632 for root@my.local.domain; Thu, 12 Oct 2006 12:41:30
-0400
12:41:30 30632 calling local_scan(); timeout=300
12:41:30 30632 local_scan() returned 0 NULL
12:41:30 30632 expanding: ${tod_full}
12:41:30 30632 result: Thu, 12 Oct 2006 12:41:30 -0400
12:41:30 30632 Writing spool header file
12:41:30 30632 Size of headers = 372
12:41:30 30632 LOG: MAIN
12:41:30 30632 <= root@my.local.domain U=root P=local S=390
12:41:30 30632 search_tidyup called
12:41:30 30633 exec /usr/sbin/exim4 -d=0xfffdffff -Mc 1GY3cg-0007y4-Kt
12:41:30 30632 search_tidyup called
12:41:30 30632 >>>>>>>>>>>>>>>>
Exim pid=30632 terminating with rc=0
>>>>>>>>>>>>>>>>
12:41:30 30633 Exim version 4.63 uid=102 gid=102 pid=30633 D=fffdffff
Berkeley DB: Sleepycat Software: Berkeley DB 4.3.29: (September 6,
2005)
Support for: crypteq iconv() IPv6 GnuTLS move_frozen_messages
Lookups: lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmnz
dsearch nis nis0 passwd
Authenticators: cram_md5 plaintext
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore autoreply lmtp pipe smtp
Fixed never_users: 0
Size of off_t: 8
12:41:30 30633 changed uid/gid: forcing real = effective
12:41:30 30633 uid=0 gid=102 pid=30633
12:41:30 30633 auxiliary group list: <none>
12:41:30 30633 seeking password data for user "uucp": cache not
available
12:41:30 30633 getpwnam() succeeded uid=10 gid=10
12:41:30 30633 configuration file is /var/lib/exim4/config.autogenerated
12:41:30 30633 log selectors = 00000ffc 00089001
12:41:30 30633 cwd=/var/spool/exim4 4 args: /usr/sbin/exim4
-d=0xfffdffff -Mc 1GY3cg-0007y4-Kt
12:41:30 30633 trusted user
12:41:30 30633 admin user
12:41:30 30633 skipping ACL configuration - not needed
12:41:30 30633 seeking password data for user "mail": cache not
available
12:41:30 30633 getpwnam() succeeded uid=8 gid=8
12:41:30 30633 set_process_info: 30633 delivering specified messages
12:41:30 30633 set_process_info: 30633 delivering 1GY3cg-0007y4-Kt
12:41:30 30633 reading spool file 1GY3cg-0007y4-Kt-H
12:41:30 30633 user=root uid=0 gid=0 sender=root@my.local.domain
12:41:30 30633 sender_local=1 ident=root
12:41:30 30633 Non-recipients:
12:41:30 30633 Empty Tree
12:41:30 30633 ---- End of tree ----
12:41:30 30633 recipients_count=1
12:41:30 30633 body_linecount=1 message_linecount=9
12:41:30 30633 Delivery address list:
12:41:30 30633 root@my.local.domain
12:41:30 30633 locking /var/spool/exim4/db/retry.lockfile
12:41:30 30633 locked /var/spool/exim4/db/retry.lockfile
12:41:30 30633 EXIM_DBOPEN(/var/spool/exim4/db/retry)
12:41:30 30633 returned from EXIM_DBOPEN
12:41:30 30633 opened hints database /var/spool/exim4/db/retry:
flags=O_RDONLY
12:41:30 30633
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:41:30 30633 Considering: root@my.local.domain
12:41:30 30633 unique = root@my.local.domain
12:41:30 30633 dbfn_read: key=R:my.local.domain
12:41:30 30633 dbfn_read: key=R:root@my.local.domain
12:41:30 30633 no domain retry record
12:41:30 30633 no address retry record
12:41:30 30633 root@my.local.domain: queued for routing
12:41:30 30633
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:41:30 30633 routing root@my.local.domain
12:41:30 30633 --------> hubbed_hosts router <--------
12:41:30 30633 local_part=root domain=my.local.domain
12:41:30 30633 checking domains
12:41:30 30633 expanding: /etc/exim4/hubbed_hosts
12:41:30 30633 result: /etc/exim4/hubbed_hosts
12:41:30 30633 condition: exists{/etc/exim4/hubbed_hosts}
12:41:30 30633 result: false
12:41:30 30633 expanding: partial-lsearch;/etc/exim4/hubbed_hosts
12:41:30 30633 result: partial-lsearch;/etc/exim4/hubbed_hosts
12:41:30 30633 skipping: result is not used
12:41:30 30633 failed to expand: ${if
exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/
hubbed_hosts}fail}
12:41:30 30633 error message: "if" failed and "fail"
requested
12:41:30 30633 failure was forced
12:41:30 30633 expansion of "${if
exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/
hubbed_hosts}fail}" forced failure: assume not in this list
12:41:30 30633 hubbed_hosts router skipped: domains mismatch
12:41:30 30633 --------> smarthost router <--------
12:41:30 30633 local_part=root domain=my.local.domain
12:41:30 30633 checking domains
12:41:30 30633 my.local.domain in "@:localhost:my.local.domain"? yes
(matched "my.local.domain")
12:41:30 30633 my.local.domain in "! +local_domains"? no (matched
"!
+local_domains")
12:41:30 30633 smarthost router skipped: domains mismatch
12:41:30 30633 --------> real_local router <--------
12:41:30 30633 local_part=root domain=my.local.domain
12:41:30 30633 real_local router skipped: prefix mismatch
12:41:30 30633 --------> system_aliases router <--------
12:41:30 30633 local_part=root domain=my.local.domain
12:41:30 30633 checking domains
12:41:30 30633 cached yes match for +local_domains
12:41:30 30633 cached lookup data = NULL
12:41:30 30633 my.local.domain in "+local_domains"? yes (matched
"+local_domains" - cached)
12:41:30 30633 expanding: R: system_aliases for $local_part@$domain
12:41:30 30633 result: R: system_aliases for root@my.local.domain
12:41:30 30633 R: system_aliases for root@my.local.domain
12:41:30 30633 calling system_aliases router
12:41:30 30633 rda_interpret (string):
${lookup{$local_part}lsearch{/etc/aliases}}
12:41:30 30633 expanding: $local_part
12:41:30 30633 result: root
12:41:30 30633 expanding: /etc/aliases
12:41:30 30633 result: /etc/aliases
12:41:30 30633 search_open: lsearch "/etc/aliases"
12:41:30 30633 search_find: file="/etc/aliases"
12:41:30 30633 key="root" partial=-1 affix=NULL starflags=0
12:41:30 30633 LRU list:
12:41:30 30633 :/etc/aliases
12:41:30 30633 End
12:41:30 30633 internal_search_find: file="/etc/aliases"
12:41:30 30633 type=lsearch key="root"
12:41:30 30633 file lookup required for root
12:41:30 30633 in /etc/aliases
12:41:30 30633 lookup yielded: myname@my.isp.domain
12:41:30 30633 expanding: ${lookup{$local_part}lsearch{/etc/aliases}}
12:41:30 30633 result: myname@my.isp.domain
12:41:30 30633 expanded: myname@my.isp.domain
12:41:30 30633 file is not a filter file
12:41:30 30633 parse_forward_list: myname@my.isp.domain
12:41:30 30633 extract item: myname@my.isp.domain
12:41:30 30633 system_aliases router generated myname@my.isp.domain
12:41:30 30633 errors_to=NULL transport=NULL
12:41:30 30633 uid=unset gid=unset home=NULL
12:41:30 30633 routed by system_aliases router
12:41:30 30633 envelope to: root@my.local.domain
12:41:30 30633 transport: <none>
12:41:30 30633 locking /var/spool/exim4/db/retry.lockfile
12:41:30 30633 locked /var/spool/exim4/db/retry.lockfile
12:41:30 30633 EXIM_DBOPEN(/var/spool/exim4/db/retry)
12:41:30 30633 returned from EXIM_DBOPEN
12:41:30 30633 opened hints database /var/spool/exim4/db/retry:
flags=O_RDONLY
12:41:30 30633
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:41:30 30633 Considering: myname@my.isp.domain
12:41:30 30633 unique = myname@my.isp.domain
12:41:30 30633 dbfn_read: key=R:my.isp.domain
12:41:30 30633 dbfn_read: key=R:myname@my.isp.domain
12:41:30 30633 no domain retry record
12:41:30 30633 no address retry record
12:41:30 30633 myname@my.isp.domain: queued for routing
12:41:30 30633
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:41:30 30633 routing myname@my.isp.domain
12:41:30 30633 --------> hubbed_hosts router <--------
12:41:30 30633 local_part=myname domain=my.isp.domain
12:41:30 30633 checking domains
12:41:30 30633 expanding: /etc/exim4/hubbed_hosts
12:41:30 30633 result: /etc/exim4/hubbed_hosts
12:41:30 30633 condition: exists{/etc/exim4/hubbed_hosts}
12:41:30 30633 result: false
12:41:30 30633 expanding: partial-lsearch;/etc/exim4/hubbed_hosts
12:41:30 30633 result: partial-lsearch;/etc/exim4/hubbed_hosts
12:41:30 30633 skipping: result is not used
12:41:30 30633 failed to expand: ${if
exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/
hubbed_hosts}fail}
12:41:30 30633 error message: "if" failed and "fail"
requested
12:41:30 30633 failure was forced
12:41:30 30633 expansion of "${if
exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/
hubbed_hosts}fail}" forced failure: assume not in this list
12:41:30 30633 hubbed_hosts router skipped: domains mismatch
12:41:30 30633 --------> smarthost router <--------
12:41:30 30633 local_part=myname domain=my.isp.domain
12:41:30 30633 checking domains
12:41:30 30633 my.isp.domain in "@:localhost:my.local.domain"? no (end
of list)
12:41:30 30633 my.isp.domain in "! +local_domains"? yes (end of list)
12:41:30 30633 expanding: R: smarthost for $local_part@$domain
12:41:30 30633 result: R: smarthost for myname@my.isp.domain
12:41:30 30633 R: smarthost for myname@my.isp.domain
12:41:30 30633 calling smarthost router
12:41:30 30633 smarthost router called for myname@my.isp.domain
12:41:30 30633 domain = my.isp.domain
12:41:30 30633 route_item = * mail-relay.mail.local.domain byname
12:41:30 30633 my.isp.domain in "*"? yes (matched "*")
12:41:30 30633 original list of hosts = "mail-relay.mail.local.domain"
options = byname
12:41:30 30633 expanded list of hosts = "mail-relay.mail.local.domain"
options = byname
12:41:30 30633 set transport remote_smtp_smarthost
12:41:30 30633 finding IP address for mail-relay.mail.local.domain
12:41:30 30633 calling host_find_byname
12:41:30 30633 gethostbyname2(af=inet6) returned 4 (NO_DATA)
12:41:30 30633 Configured local interface: address=127.0.0.1
12:41:30 30633 fully qualified name = mail-relay.mail.local.domain
12:41:30 30633 gethostbyname2 looked up these IP addresses:
12:41:30 30633 name=mail-relay.mail.local.domain
address=ddd.ddd.ddd.dd1
12:41:30 30633 name=mail-relay.mail.local.domain
address=ddd.ddd.ddd.dd2
12:41:30 30633 queued for remote_smtp_smarthost transport: local_part =
myname
12:41:30 30633 domain = my.isp.domain
12:41:30 30633 errors_to=NULL
12:41:30 30633 domain_data=NULL localpart_data=NULL
12:41:30 30633 routed by smarthost router
12:41:30 30633 envelope to: myname@my.isp.domain
12:41:30 30633 transport: remote_smtp_smarthost
12:41:30 30633 host mail-relay.mail.local.domain [ddd.ddd.ddd.dd1]
12:41:30 30633 host mail-relay.mail.local.domain [ddd.ddd.ddd.dd2]
12:41:30 30633
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:41:30 30633 After routing:
12:41:30 30633 Local deliveries:
12:41:30 30633 Remote deliveries:
12:41:30 30633 myname@my.isp.domain
12:41:30 30633 Failed addresses:
12:41:30 30633 Deferred addresses:
12:41:30 30633 search_tidyup called
12:41:30 30633 >>>>>>>>>>>>>>>>
Remote deliveries
>>>>>>>>>>>>>>>>
12:41:30 30633 --------> myname@my.isp.domain <--------
12:41:30 30633 expanding: $sender_address_domain
12:41:30 30633 result: my.local.domain
12:41:30 30633 expanding: +local_domains
12:41:30 30633 result: +local_domains
12:41:30 30633 my.local.domain in "@:localhost:my.local.domain"? yes
(matched "my.local.domain")
12:41:30 30633 my.local.domain in "+local_domains"? yes (matched
"+local_domains")
12:41:30 30633 condition:
match_domain{$sender_address_domain}{+local_domains}
12:41:30 30633 result: true
12:41:30 30633 expanding: ${sender_address_local_part}@my.local.domain
12:41:30 30633 result: root@my.local.domain
12:41:30 30633 expanding: $sender_address_domain
12:41:30 30633 result:
12:41:30 30633 skipping: result is not used
12:41:30 30633 expanding: my.local.domain
12:41:30 30633 result: my.local.domain
12:41:30 30633 skipping: result is not used
12:41:30 30633 condition:
match_domain{$sender_address_domain}{my.local.domain}
12:41:30 30633 result: false
12:41:30 30633 expanding: ${sender_address_local_part}@my.local.domain
12:41:30 30633 result: @my.local.domain
12:41:30 30633 skipping: result is not used
12:41:30 30633 expanding: ${if
match_domain{$sender_address_domain}{my.local.domain}{${sender_address_l
ocal_part}@my.local.domain}fail}
12:41:30 30633 result:
12:41:30 30633 skipping: result is not used
12:41:30 30633 expanding: ${if
match_domain{$sender_address_domain}{+local_domains}{${sender_address_lo
cal_part}@my.local.domain}{${if
match_domain{$sender_address_domain}{my.local.domain}{${sender_address_l
ocal_part}@my.local.domain}fail}}}
12:41:30 30633 result: root@my.local.domain
12:41:30 30633 search_tidyup called
12:41:30 30634 changed uid/gid: remote delivery to myname@my.isp.domain
with transport=remote_smtp_smarthost
12:41:30 30634 uid=102 gid=102 pid=30634
12:41:30 30634 auxiliary group list: <none>
12:41:30 30634 set_process_info: 30634 delivering 1GY3cg-0007y4-Kt
using remote_smtp_smarthost
12:41:30 30634 expanding: T: remote_smtp_smarthost for
$local_part@$domain
12:41:30 30634 result: T: remote_smtp_smarthost for
myname@my.isp.domain
12:41:30 30634 T: remote_smtp_smarthost for myname@my.isp.domain
12:41:30 30634 remote_smtp_smarthost transport entered
12:41:30 30634 myname@my.isp.domain
12:41:30 30634 my.isp.domain in queue_smtp_domains? no (option unset)
12:41:30 30634 checking status of mail-relay.mail.local.domain
12:41:30 30634 locking /var/spool/exim4/db/retry.lockfile
12:41:30 30634 locked /var/spool/exim4/db/retry.lockfile
12:41:30 30634 EXIM_DBOPEN(/var/spool/exim4/db/retry)
12:41:30 30634 returned from EXIM_DBOPEN
12:41:30 30633 set_process_info: 30633 delivering 1GY3cg-0007y4-Kt:
waiting for a remote delivery subprocess to finish
12:41:30 30634 opened hints database /var/spool/exim4/db/retry:
flags=O_RDONLY
12:41:30 30634 dbfn_read:
key=T:mail-relay.mail.local.domain:ddd.ddd.ddd.dd1
12:41:30 30633 selecting on subprocess pipes
12:41:30 30634 dbfn_read:
key=T:mail-relay.mail.local.domain:ddd.ddd.ddd.dd1:1GY3cg-0007y4-Kt
12:41:30 30634 no host retry record
12:41:30 30634 no message retry record
12:41:30 30634 mail-relay.mail.local.domain [ddd.ddd.ddd.dd1] status =
usable
12:41:30 30634 ddd.ddd.ddd.dd1 in serialize_hosts? no (option unset)
12:41:30 30634 delivering 1GY3cg-0007y4-Kt to
mail-relay.mail.local.domain [ddd.ddd.ddd.dd1] (myname@my.isp.domain)
12:41:30 30634 set_process_info: 30634 delivering 1GY3cg-0007y4-Kt to
mail-relay.mail.local.domain [ddd.ddd.ddd.dd1] (myname@my.isp.domain)
12:41:30 30634 expanding: $primary_hostname
12:41:30 30634 result: mail-host.my.local.domain
12:41:30 30634 Connecting to mail-relay.mail.local.domain
[ddd.ddd.ddd.dd1]:25 ... connected
12:41:30 30634 waiting for data on socket
12:41:30 30634 read response data: size=83
12:41:30 30634 SMTP<< 220 mail-relay.mail.local.domain Simple
Internet Message Transfer Agent ready
12:41:30 30634 ddd.ddd.ddd.dd1 in hosts_avoid_esmtp? no (option unset)
12:41:30 30634 SMTP>> EHLO mail-host.my.local.domain
12:41:30 30634 waiting for data on socket
12:41:30 30634 read response data: size=67
12:41:30 30634 SMTP<< 250-mail-relay.mail.local.domain Hello
mail-host.my.local.domain
12:41:30 30634 waiting for data on socket
12:41:30 30634 read response data: size=20
12:41:30 30634 250 SIZE=104857600
12:41:30 30634 ddd.ddd.ddd.dd1 in hosts_require_tls? no (option unset)
12:41:30 30634 not using PIPELINING
12:41:30 30634 ddd.ddd.ddd.dd1 in hosts_require_auth? no (option unset)
12:41:30 30634 SMTP>> MAIL FROM:<root@my.local.domain>
12:41:30 30634 waiting for data on socket
12:41:30 30634 read response data: size=8
12:41:30 30634 SMTP<< 250 OK
12:41:30 30634 SMTP>> RCPT TO:<myname@my.isp.domain>
12:41:30 30634 waiting for data on socket
12:41:30 30634 read response data: size=8
12:41:30 30634 SMTP<< 250 OK
12:41:30 30634 SMTP>> DATA
12:41:30 30634 waiting for data on socket
12:41:30 30634 read response data: size=46
12:41:30 30634 SMTP<< 354 Start mail input; end with
<CRLF>.<CRLF>
12:41:30 30634 SMTP>> writing message and terminating "."
12:41:30 30634 rewrite_one_header: type=T:
12:41:30 30634 To: root@my.local.domain
12:41:30 30634 rewrite_one_header: type=F:
12:41:30 30634 From: root <root@my.local.domain>
12:41:30 30634 address match: subject=root@my.local.domain
pattern=*@+local_domains
12:41:30 30634 my.local.domain in "@:localhost:my.local.domain"? yes
(matched "my.local.domain")
12:41:30 30634 my.local.domain in "+local_domains"? yes (matched
"+local_domains")
12:41:30 30634 root@my.local.domain in "*@+local_domains"? yes
(matched
"*@+local_domains")
12:41:30 30634 expanding: $1@my.local.domain
12:41:30 30634 result: root@my.local.domain
12:41:30 30634 LOG: address_rewrite MAIN
12:41:30 30634 "root@my.local.domain" from from: rewritten as
"root@my.local.domain" by rule 1
12:41:30 30634 address match: subject=root@my.local.domain
pattern=*@my.local.domain
12:41:30 30634 my.local.domain in "my.local.domain"? yes (matched
"my.local.domain")
12:41:30 30634 root@my.local.domain in "*@my.local.domain"? yes
(matched "*@my.local.domain")
12:41:30 30634 expanding: $1@my.local.domain
12:41:30 30634 result: root@my.local.domain
12:41:30 30634 LOG: address_rewrite MAIN
12:41:30 30634 "root@my.local.domain" from from: rewritten as
"root@my.local.domain" by rule 2
12:41:30 30634 newlen=37 newtype=F newtext:
12:41:30 30634 From: root <root@my.local.domain>
12:41:30 30634 remainder:
12:41:30 30634 writing data block fd=6 size=404 timeout=300
12:41:30 30634 waiting for data on socket
12:41:31 30634 read response data: size=37
12:41:31 30634 SMTP<< 250 (452E703A.BDAB7.2642): accepted
12:41:31 30634 journalling myname@my.isp.domain
12:41:31 30634 ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0
first_address is NULL
12:41:31 30634 transport_check_waiting entered
12:41:31 30634 sequence=1 local_max=500 global_max=-1
12:41:31 30634 locking
/var/spool/exim4/db/wait-remote_smtp_smarthost.lockfile
12:41:31 30634 locked
/var/spool/exim4/db/wait-remote_smtp_smarthost.lockfile
12:41:31 30634
EXIM_DBOPEN(/var/spool/exim4/db/wait-remote_smtp_smarthost)
12:41:31 30634 returned from EXIM_DBOPEN
12:41:31 30634 opened hints database
/var/spool/exim4/db/wait-remote_smtp_smarthost: flags=O_RDWR
12:41:31 30634 dbfn_read: key=mail-relay.mail.local.domain
12:41:31 30634 no messages waiting for mail-relay.mail.local.domain
12:41:31 30634 SMTP>> QUIT
12:41:31 30634 set_process_info: 30634 delivering 1GY3cg-0007y4-Kt:
just tried mail-relay.mail.local.domain [ddd.ddd.ddd.dd1] for
myname@my.isp.domain: result OK
12:41:31 30634 Leaving remote_smtp_smarthost transport
12:41:31 30634 set_process_info: 30634 delivering 1GY3cg-0007y4-Kt
(just run remote_smtp_smarthost for myname@my.isp.domain in subprocess)
12:41:31 30634 search_tidyup called
12:41:31 30633 reading pipe for subprocess 30634 (not ended)
12:41:31 30633 read() yielded 65
12:41:31 30633 Z0 item read
12:41:31 30633 remote delivery process 30634 ended
12:41:31 30633 set_process_info: 30633 delivering 1GY3cg-0007y4-Kt
12:41:31 30633 post-process myname@my.isp.domain (0)
12:41:31 30633 myname@my.isp.domain delivered
12:41:31 30633 root@my.local.domain: children all complete
12:41:31 30633 LOG: MAIN
12:41:31 30633 => myname@my.isp.domain <root@my.local.domain>
R=smarthost T=remote_smtp_smarthost H=mail-relay.mail.local.domain
[ddd.ddd.ddd.dd1]
12:41:31 30633 >>>>>>>>>>>>>>>>
deliveries are done
>>>>>>>>>>>>>>>>
12:41:31 30633 changed uid/gid: post-delivery tidying
12:41:31 30633 uid=102 gid=102 pid=30633
12:41:31 30633 auxiliary group list: <none>
12:41:31 30633 set_process_info: 30633 tidying up after delivering
1GY3cg-0007y4-Kt
12:41:31 30633 Processing retry items
12:41:31 30633 Succeeded addresses:
12:41:31 30633 myname@my.isp.domain: no retry items
12:41:31 30633 root@my.local.domain: no retry items
12:41:31 30633 root@my.local.domain: no retry items
12:41:31 30633 Failed addresses:
12:41:31 30633 Deferred addresses:
12:41:31 30633 end of retry processing
12:41:31 30633 LOG: MAIN
12:41:31 30633 Completed
12:41:31 30633 end delivery of 1GY3cg-0007y4-Kt
12:41:31 30633 search_tidyup called
12:41:31 30633 search_tidyup called
12:41:31 30633 >>>>>>>>>>>>>>>>
Exim pid=30633 terminating with rc=0
>>>>>>>>>>>>>>>>
exit
Script done on Thu 12 Oct 2006 12:41:39 PM EDT
::::::::::::::
log snippet
::::::::::::::
2006-10-12 12:41:30 1GY3cg-0007y4-Kt <= root@my.local.domain U=root
P=local S=390
2006-10-12 12:41:31 1GY3cg-0007y4-Kt => myname@my.isp.domain
<root@my.local.domain> R=smarthost T=remote_smtp_smarthost
H=mail-relay.mail.local.domain [ddd.ddd.ddd.dd1]
2006-10-12 12:41:31 1GY3cg-0007y4-Kt Completed
::::::::::::::
/etc/mailname
::::::::::::::
my.local.domain
::::::::::::::
/etc/email-addresses
::::::::::::::
# This is /etc/email-addresses. It is part of the exim package
#
# This file contains email addresses to use for outgoing mail. Any local
# part not in here will be qualified by the system domain as normal.
#
# It should contain lines of the form:
#
#user: someone@isp.com
#otheruser: someoneelse@anotherisp.com
::::::::::::::
/etc/aliases
::::::::::::::
mailer-daemon: postmaster
postmaster: root
nobody: root
hostmaster: root
usenet: root
news: root
webmaster: root
www: root
ftp: root
abuse: root
noc: root
security: root
root: myname@my.isp.domain
::::::::::::::
/etc/exim4/update-exim4.conf.conf
::::::::::::::
dc_eximconfig_configtype=''satellite''
dc_other_hostnames=''my.local.domain''
dc_local_interfaces=''127.0.0.1''
dc_readhost=''my.local.domain''
dc_relay_domains=''''
dc_minimaldns=''false''
dc_relay_nets=''''
dc_smarthost=''mail-relay.mail.local.domain''
CFILEMODE=''644''
dc_use_split_config=''true''
dc_hide_mailname=''true''
dc_mailname_in_oh=''true''
Jens Schüßler
2006-Oct-13 17:53 UTC
[Pkg-exim4-users] weird rewrite problem - address rewritten to alias then sent as original address
* Roy Bonser <rbonser@umich.edu> wrote:> Here is the situation, I''m trying to get system messages forwarded off > a debian testing box with a stock exim4 setup. I have not made changes > to the files in /etc/exim4/conf.d at all. > > The network here, let''s call it local.domain, has several subdomains in > it. The box is in one I''m calling my.local.domain and the smarthost is > in another, mail.local.domain. > I have the system accounts aliased to root and root is aliased to > myname@my.isp.domain. > > What happens is the mail to root is being sent as root@my.local.domain > even though the name is being changed to myname@my.isp.domain in the > debug output. I can''t find where it is being switched back to the > original To: address. The log shows the address as => alias address > <original address> being sent to the smarthost.Search for rewrit in your log and you can see that theres no change. The name is only changed for the receiver of the mail. If you want to rewrite the senders adress to myname@my.isp.domain, you have to put it in /etc/email-adresses ,---- | root: myname@my.isp.domain | `---- Thats what I get here, when I put root in /etc/email-adresses (only log snippets) 19:22:37 19796 expanding: ${lookup{$1}lsearch{/etc/email-addresses}{$value}fail} 19:22:37 19796 result: someone@somewhere.com 19:22:37 19796 LOG: address_rewrite MAIN 19:22:37 19796 "root@home.sge.kicks-ass.org" from env-from rewritten as "someone@somewhere.com" by rule 4 19:22:37 19796 rewritten sender = someone@somewhere.com HTH Jens
Roy Bonser
2006-Oct-13 20:38 UTC
[Pkg-exim4-users] weird rewrite problem - address rewritten to alias then sent as original address
I am not trying to change the from. I want the email to be from: root@my.local.domain and forwarded to: myname@my.isp.domain. What is happening now is that the smarthost is getting a message from: root@my.local.domain to root@my.local.domain even though, according to the debug output, the /etc/aliases file is being consulted. Thanks, --Roy On Oct 13, 2006, at 1:36 PM, Jens Sch??ler wrote:> * Roy Bonser <rbonser@umich.edu> wrote: >> Here is the situation, I''m trying to get system messages forwarded off >> a debian testing box with a stock exim4 setup. I have not made changes >> to the files in /etc/exim4/conf.d at all. >> >> The network here, let''s call it local.domain, has several subdomains >> in >> it. The box is in one I''m calling my.local.domain and the smarthost is >> in another, mail.local.domain. >> I have the system accounts aliased to root and root is aliased to >> myname@my.isp.domain. >> >> What happens is the mail to root is being sent as root@my.local.domain >> even though the name is being changed to myname@my.isp.domain in the >> debug output. I can''t find where it is being switched back to the >> original To: address. The log shows the address as => alias address >> <original address> being sent to the smarthost. > > Search for rewrit in your log and you can see that theres no change. > The name is only changed for the receiver of the mail. If you want to > rewrite the senders adress to myname@my.isp.domain, you have to put it > in /etc/email-adresses > > ,---- > | root: myname@my.isp.domain > | > `---- > > Thats what I get here, when I put root in /etc/email-adresses (only log > snippets) > > 19:22:37 19796 expanding: > ${lookup{$1}lsearch{/etc/email-addresses}{$value}fail} > 19:22:37 19796 result: someone@somewhere.com > 19:22:37 19796 LOG: address_rewrite MAIN > 19:22:37 19796 "root@home.sge.kicks-ass.org" from env-from rewritten > as "someone@somewhere.com" by rule 4 > 19:22:37 19796 rewritten sender = someone@somewhere.com > > HTH > Jens > > _______________________________________________ > Pkg-exim4-users mailing list > Pkg-exim4-users@lists.alioth.debian.org > http://lists.alioth.debian.org/mailman/listinfo/pkg-exim4-users > >