Marc Sherman wrote:
> Can you please resend with a clear explanation of what
> you are trying to achieve,
I would like to take advantage of the VERP system of addressing to identify
unavialable mailboxes, and capture any failure notifications in a local
mailbox which, to be read by a different process (web-app). The premise is
that a club manager can send an invitation email to his players, who can
then use the autogenerated login details to use the site.
There are two points to consider, though. Firstly, I do not want to have the
emails appear to originate at a "real" mailbox to which addressees can
reply. Support is available at other, monitored email addresses. However, I
do need to know which invites simply failed to arrive.
Marc suggested using VERP for this.
> what message you're sending to attempt it and how you're sending it
To test the set-up, I send an email to a non-existent mailbox at my
webhosting domain which I know will be bounced. The test email originates on
my laptop which authenticates and delivers to the (remote) Exim daemon.
> (including any exim config you created in order to send it)
begin routers
#
# relevant routers
#
verp_outbound_router:
driver = dnslookup
condition = ${if
match{$return_path}{\N^rewrite-.*?@???$\N}{yes}{no}}
domains = !+local_domains
ignore_target_hosts = <; 0.0.0.0; 127.0.0.0/8; 80.82.141.27/32
transport = verp_smtp
dnslookup:
driver = dnslookup
condition = ${if
match{$return_path}{\N^rewrite-.*?@???$\N}{no}{yes}}
domains = ! +local_domains
transport = remote_smtp
ignore_target_hosts = 0.0.0.0 : 127.0.0.0/8
no_more
verp_inbound_router:
driver = redirect
domains = +cyrus_domains
condition = ${if match {$local_part}{\N^noreply-.*?$\N} {yes}{no}}
data = cyrus.nospam.mailbox@???
file_transport = address_file
pipe_transport = address_pipe
cyrus_vdom:
driver = accept
domains = +cyrus_domains
transport = cyrus_ltcp
cannot_route_message = Unknown mailbox
no_more
#
# Relevant transports
#
begin transports
remote_smtp:
driver = smtp
verp_smtp:
driver = smtp
max_rcpt = 1
return_path = ${if match
{$return_path}{\N^rewrite-.*?@???$\N}\
{noreply-$local_part=$domain@???}fail}
> debug output and unmangled logs from exim while you send it?
I've attached some comprehensive debugging information which includes the
log lines. The interesting bit appears to be around line 211 and at 265. I
assumed from what I'd read about VERP that the failure notification would
take the form of a separate email, which could then be routed according to
its VERP address (eg: noreply-kenevel=hotmail.com@???).
However, it appears that the error notification is a synchronous reply to
the original delivery attempt. Exim then tries to deliver the error notice
as a local non-SMTP message, which is not aware of the rewritten envelope
path. Exim tries to deliver this to the original sender, using the
from-address (rewrite-noreply@???), which of course fails.
So I guess my question is how to intercept that failure message and route it
to the failure-inbox, including the all-important information about it's
original intended addressee?
> And while you're at it, please don't top-post.
> http://www.exim.org/eximwiki/MailingListEtiquette
Got it.
=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2006.02.02 15:56:29 =~=~=~=~=~=~=~=~=~=~=~=
[root@kifaru someuser]# /etc/init.d/exim start > /var/log/exim/debug_log
Starting exim: 17:02:17 22420 Exim version 4.54 uid=0 gid=0 pid=22420 D=fffdffff
Berkeley DB: Sleepycat Software: Berkeley DB 4.3.27: (April 25, 2005)
Support for: crypteq iconv() OpenSSL Content_Scanning
Lookups: lsearch wildlsearch nwildlsearch iplsearch dbm dbmnz
Authenticators: cram_md5 cyrus_sasl plaintext spa
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply pipe smtp
Fixed never_users: 0:500:100:48
17:02:17 22420 changed uid/gid: forcing real = effective
17:02:17 22420 uid=0 gid=0 pid=22420
17:02:17 22420 auxiliary group list: <none>
17:02:17 22420 configuration file is /etc/exim/exim.conf
17:02:17 22420 log selectors = ffffffff 7fffffff
17:02:17 22420 LOG: MAIN
17:02:17 22420 cwd=/home/someuser 4 args: /usr/local/exim/bin/exim -bd -d+all -q10m
17:02:17 22420 trusted user
17:02:17 22420 admin user
17:02:17 22420 originator: uid=0 gid=0 login=root name=root
17:02:17 22420 listening on all interfaces (IPv4) port 25
17:02:17 22420 pid written to /var/spool/exim/exim-daemon.pid
17:02:17 22420 changed uid/gid: running as a daemon
17:02:17 22420 uid=101 gid=101 pid=22420
17:02:17 22420 auxiliary group list: 101
17:02:17 22420 LOG: MAIN
17:02:17 22420 exim 4.54 daemon started: pid=22420, -q10m, listening for SMTP on port 25 (IPv4)
17:02:17 22420 set_process_info: 22420 daemon: -q10m, listening for SMTP on port 25 (IPv4)
17:02:17 22420 daemon running with uid=101 gid=101 euid=101 egid=101
17:02:17 22420 SIGALRM received
17:02:17 22421 Starting queue-runner: pid 22421
17:02:17 22421 exec /usr/local/exim/bin/exim -q
17:02:17 22420 1 queue-runner process running
17:02:17 22420 Listening...
..
17:03:11 22420 SMTP connection from [83.67.4.209]:3064 I=[80.82.141.27]:25 (TCP/IP connection count = 1)
17:03:11 22431 SMTP>> 220 kifaru.socialrugby.com ESMTP Exim 4.54 Thu, 02 Feb 2006 17:03:11 +0000
17:03:11 22431 SMTP<< EHLO [192.168.1.70]
17:03:11 22431 SMTP>> 250-kifaru.socialrugby.com Hello i-83-67-4-209.freedom2surf.net [83.67.4.209]
17:03:11 22431 250-SIZE 52428800
17:03:11 22431 250-PIPELINING
17:03:11 22431 250-STARTTLS
17:03:11 22431 250 HELP
17:03:12 22431 SMTP<< STARTTLS
17:03:12 22431 SMTP>> 220 TLS go ahead
17:03:12 22431 SMTP<< EHLO [192.168.1.70]
17:03:12 22431 SMTP>> 250-kifaru.socialrugby.com Hello i-83-67-4-209.freedom2surf.net [83.67.4.209]
17:03:12 22431 250-SIZE 52428800
17:03:12 22431 250-PIPELINING
17:03:12 22431 250-AUTH PLAIN LOGIN
17:03:12 22431 250 HELP
17:03:12 22431 SMTP<< AUTH LOGIN
17:03:12 22431 SMTP>> 334 xxx
17:03:12 22431 SMTP>> 334 xxx
17:03:12 22431 SMTP>> 235 Authentication succeeded
17:03:12 22431 SMTP<< MAIL FROM:<rewrite-noreply@???> SIZE=408
17:03:12 22431 SMTP>> 250 OK
17:03:12 22431 SMTP<< RCPT TO:<bounce_me@???>
17:03:12 22431 SMTP>> 250 Accepted
17:03:13 22431 SMTP<< DATA
17:03:13 22431 SMTP>> 354 Enter message, ending with "." on a line by itself
17:03:13 22431 >>Headers received:
17:03:13 22431 Message-ID: <43E22BF4.60901@???>
17:03:13 22431 Date: Thu, 02 Feb 2006 15:57:40 +0000
17:03:13 22431 From: Admin <rewrite-noreply@???>
17:03:13 22431 User-Agent: Mozilla Thunderbird 1.0.2 (Windows/20050317)
17:03:13 22431 X-Accept-Language: en-us, en
17:03:13 22431 MIME-Version: 1.0
17:03:13 22431 To: bounce_me@???
17:03:13 22431 Subject: test-failure
17:03:13 22431 Content-Type: text/plain; charset=ISO-8859-1; format=flowed
17:03:13 22431 Content-Transfer-Encoding: 7bit
17:03:13 22431
17:03:13 22431 rewrite_one_header: type=F:
17:03:13 22431 From: Admin <rewrite-noreply@???>
17:03:13 22431 rewrite_one_header: type=T:
17:03:13 22431 To: bounce_me@???
17:03:13 22431 search_tidyup called
17:03:13 22431 >>Headers after rewriting and local additions:
17:03:13 22431 I Message-ID: <43E22BF4.60901@???>
17:03:13 22431 Date: Thu, 02 Feb 2006 15:57:40 +0000
17:03:13 22431 F From: Admin <rewrite-noreply@???>
17:03:13 22431 User-Agent: Mozilla Thunderbird 1.0.2 (Windows/20050317)
17:03:13 22431 X-Accept-Language: en-us, en
17:03:13 22431 MIME-Version: 1.0
17:03:13 22431 T To: bounce_me@???
17:03:13 22431 Subject: test-failure
17:03:13 22431 Content-Type: text/plain; charset=ISO-8859-1; format=flowed
17:03:13 22431 Content-Transfer-Encoding: 7bit
17:03:13 22431 LOG: MAIN
17:03:13 22431 <= rewrite-noreply@??? H=i-83-67-4-209.freedom2surf.net ([192.168.1.70]) [83.67.4.209]:3064 I=[80.82.141.27]:25 P=esmtpsa X=TLSv1:AES256-SHA:256 CV=no A=lookup_login:someuser S=644 id=43E22BF4.60901@??? T="test-failure"
17:03:13 22431 SMTP>> 250 OK id=1F4hrV-0005pn-0L
17:03:13 22432 routing bounce_me@???
17:03:13 22432 --------> verp_outbound_router router <--------
17:03:13 22432 local_part=bounce_me domain=mindfruit.co.uk
17:03:13 22432 checking domains
17:03:13 22432 mindfruit.co.uk in "kifaru.socialrugby.com : socialrugby.com"? no (end of list)
17:03:13 22432 mindfruit.co.uk in "!+local_domains"? yes (end of list)
17:03:13 22432 checking "condition"
17:03:13 22432 expanding: $return_path
17:03:13 22432 result: rewrite-noreply@???
17:03:13 22432 expanding: \N^rewrite-.*?@???$\N
17:03:13 22432 result: ^rewrite-.*?@???$
17:03:13 22432 condition: match{$return_path}{\N^rewrite-.*?@???$\N}
17:03:13 22432 result: true
17:03:13 22432 expanding: yes
17:03:13 22432 result: yes
17:03:13 22432 expanding: no
17:03:13 22432 result: no
17:03:13 22432 skipping: result is not used
17:03:13 22432 expanding: ${if match{$return_path}{\N^rewrite-.*?@???$\N}{yes}{no}}
17:03:13 22432 result: yes
17:03:13 22432 calling verp_outbound_router router
17:03:13 22432 verp_outbound_router router called for bounce_me@???
17:03:13 22432 domain = mindfruit.co.uk
17:03:13 22432 DNS lookup of mindfruit.co.uk (MX) succeeded
17:03:13 22432 213.171.216.65 in "<; 0.0.0.0; 127.0.0.0/8; 80.82.141.27/32"? no (end of list)
17:03:13 22432 Actual local interface address is 127.0.0.1 (lo)
17:03:13 22432 Actual local interface address is 80.82.141.27 (eth0)
17:03:13 22432 fully qualified name = mindfruit.co.uk
17:03:13 22432 host_find_bydns yield = HOST_FOUND (2); returned hosts:
17:03:13 22432 mailserver.mindfruit.co.uk 213.171.216.65 MX=5
17:03:13 22432 set transport verp_smtp
17:03:13 22432 queued for verp_smtp transport: local_part = bounce_me
17:03:13 22432 domain = mindfruit.co.uk
17:03:13 22432 errors_to=NULL
17:03:13 22432 domain_data=NULL localpart_data=NULL
17:03:13 22432 routed by verp_outbound_router router
17:03:13 22432 envelope to: bounce_me@???
17:03:13 22432 transport: verp_smtp
17:03:13 22432 host mailserver.mindfruit.co.uk [213.171.216.65] MX=5
17:03:13 22432 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
17:03:13 22432 After routing:
17:03:13 22432 Local deliveries:
17:03:13 22432 Remote deliveries:
17:03:13 22432 bounce_me@???
17:03:13 22432 Failed addresses:
17:03:13 22432 Deferred addresses:
17:03:13 22432 search_tidyup called
17:03:13 22432 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
17:03:13 22432 --------> bounce_me@??? <--------
17:03:13 22432 expanding: $return_path
17:03:13 22432 result: rewrite-noreply@???
17:03:13 22432 expanding: \N^rewrite-.*?@???$\N
17:03:13 22432 result: ^rewrite-.*?@???$
17:03:13 22432 condition: match {$return_path}{\N^rewrite-.*?@???$\N}
17:03:13 22432 result: true
17:03:13 22432 expanding: noreply-$local_part=$domain@???
17:03:13 22432 result: noreply-bounce_me=mindfruit.co.uk@???
17:03:13 22432 expanding: ${if match {$return_path}{\N^rewrite-.*?@???$\N}{noreply-$local_part=$domain@???}fail}
17:03:13 22432 result: noreply-bounce_me=mindfruit.co.uk@???
17:03:13 22432 search_tidyup called
17:03:13 22434 changed uid/gid: remote delivery to bounce_me@??? with transport=verp_smtp
17:03:13 22434 uid=101 gid=101 pid=22434
17:03:13 22434 auxiliary group list: <none>
17:03:13 22434 set_process_info: 22434 delivering 1F4hrV-0005pn-0L using verp_smtp
17:03:13 22434 verp_smtp transport entered
17:03:13 22434 bounce_me@???
17:03:13 22434 mindfruit.co.uk in queue_smtp_domains? no (option unset)
17:03:13 22434 checking status of mailserver.mindfruit.co.uk
17:03:13 22434 locking /var/spool/exim/db/retry.lockfile
17:03:13 22432 set_process_info: 22432 delivering 1F4hrV-0005pn-0L: waiting for a remote delivery subprocess to finish
17:03:13 22432 selecting on subprocess pipes
17:03:13 22434 locked /var/spool/exim/db/retry.lockfile
17:03:13 22434 EXIM_DBOPEN(/var/spool/exim/db/retry)
17:03:13 22434 returned from EXIM_DBOPEN
17:03:13 22434 opened hints database /var/spool/exim/db/retry: flags=0
17:03:13 22434 dbfn_read: key=T:mailserver.mindfruit.co.uk:213.171.216.65
17:03:13 22434 dbfn_read: key=T:mailserver.mindfruit.co.uk:213.171.216.65:1F4hrV-0005pn-0L
17:03:13 22434 no host retry record
17:03:13 22434 no message retry record
17:03:13 22434 mailserver.mindfruit.co.uk [213.171.216.65] status = usable
17:03:13 22434 213.171.216.65 in serialize_hosts? no (option unset)
17:03:13 22434 delivering 1F4hrV-0005pn-0L to mailserver.mindfruit.co.uk [213.171.216.65] (bounce_me@???)
17:03:13 22434 set_process_info: 22434 delivering 1F4hrV-0005pn-0L to mailserver.mindfruit.co.uk [213.171.216.65] (bounce_me@???)
17:03:13 22434 expanding: $primary_hostname
17:03:13 22434 result: kifaru.socialrugby.com
17:03:13 22434 Connecting to mailserver.mindfruit.co.uk [213.171.216.65]:25 ... connected
17:03:13 22434 waiting for data on socket
17:03:13 22431 SMTP<< QUIT
17:03:13 22431 SMTP>> 221 kifaru.socialrugby.com closing connection
17:03:13 22431 LOG: smtp_connection MAIN
17:03:13 22431 SMTP connection from i-83-67-4-209.freedom2surf.net ([192.168.1.70]) [83.67.4.209]:3064 I=[80.82.141.27]:25 closed by QUIT
17:03:13 22431 search_tidyup called
17:03:13 22420 child 22431 ended: status=0x0
17:03:13 22420 0 SMTP accept processes now running
17:03:13 22420 Listening...
17:03:13 22434 read response data: size=43
17:03:13 22434 SMTP<< 220 smtpin72.livemail.co.uk ESMTP Postfix
17:03:13 22434 213.171.216.65 in hosts_avoid_esmtp? no (option unset)
17:03:13 22434 SMTP>> EHLO kifaru.socialrugby.com
17:03:13 22434 waiting for data on socket
17:03:13 22434 read response data: size=98
17:03:13 22434 SMTP<< 250-smtpin72.livemail.co.uk
17:03:13 22434 250-PIPELINING
17:03:13 22434 250-SIZE 31457280
17:03:13 22434 250-VRFY
17:03:13 22434 250-ETRN
17:03:13 22434 250 8BITMIME
17:03:13 22434 213.171.216.65 in hosts_require_tls? no (option unset)
17:03:13 22434 using PIPELINING
17:03:13 22434 213.171.216.65 in hosts_require_auth? no (option unset)
17:03:13 22434 SMTP>> MAIL FROM:<noreply-bounce_me=mindfruit.co.uk@???> SIZE=1684
17:03:13 22434 SMTP>> RCPT TO:<bounce_me@???>
17:03:13 22434 SMTP>> DATA
17:03:13 22434 waiting for data on socket
17:03:14 22434 read response data: size=108
17:03:14 22434 SMTP<< 250 Ok
17:03:14 22434 SMTP<< 550 <bounce_me@???>: Recipient address rejected: User unknown in virtual mailbox table
17:03:14 22434 waiting for data on socket
17:03:15 22434 read response data: size=32
17:03:15 22434 SMTP<< 554 Error: no valid recipients
17:03:15 22434 SMTP error from remote mail server after pipelined DATA: host mailserver.mindfruit.co.uk [213.171.216.65]: 554 Error: no valid recipients
17:03:15 22434 error for DATA ignored: pipelining is in use and there were no good recipients
17:03:15 22434 ok=1 send_quit=1 send_rset=1 continue_more=0 yield=0 first_address is NULL
17:03:15 22434 transport_check_waiting entered
17:03:15 22434 sequence=1 local_max=500 global_max=-1
17:03:15 22434 SMTP>> QUIT
17:03:15 22434 set_process_info: 22434 delivering 1F4hrV-0005pn-0L: just tried mailserver.mindfruit.co.uk [213.171.216.65] for bounce_me@???: result OK
17:03:15 22434 Leaving verp_smtp transport
17:03:15 22434 set_process_info: 22434 delivering 1F4hrV-0005pn-0L (just run verp_smtp for bounce_me@??? in subprocess)
17:03:15 22434 search_tidyup called
17:03:15 22432 reading pipe for subprocess 22434 (not ended)
17:03:15 22432 read() yielded 249
17:03:15 22432 Z0 item read
17:03:15 22432 remote delivery process 22434 ended
17:03:15 22432 set_process_info: 22432 delivering 1F4hrV-0005pn-0L
17:03:15 22432 post-process bounce_me@??? (2)
17:03:15 22432 LOG: MAIN
17:03:15 22432 ** bounce_me@??? F=<rewrite-noreply@???> P=<noreply-bounce_me=mindfruit.co.uk@???> R=verp_outbound_router T=verp_smtp: SMTP error from remote mail server after RCPT TO:<bounce_me@???>: host mailserver.mindfruit.co.uk [213.171.216.65]: 550 <bounce_me@???>: Recipient address rejected: User unknown in virtual mailbox table
17:03:15 22432 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
17:03:15 22432 changed uid/gid: post-delivery tidying
17:03:15 22432 uid=101 gid=101 pid=22432
17:03:15 22432 auxiliary group list: <none>
17:03:15 22432 set_process_info: 22432 tidying up after delivering 1F4hrV-0005pn-0L
17:03:15 22432 Processing retry items
17:03:15 22432 Succeeded addresses:
17:03:15 22432 Failed addresses:
17:03:15 22432 bounce_me@???: no retry items
17:03:15 22432 Deferred addresses:
17:03:15 22432 end of retry processing
17:03:15 22432 processing failed address bounce_me@???
17:03:15 22437 exec /usr/local/exim/bin/exim -d=0xfffdffff -t -oem -oi -f <> -E1F4hrV-0005pn-0L
17:03:15 22432 sending error message to: rewrite-noreply@???
17:03:15 22432 writing data block fd=8 size=698 timeout=0
17:03:15 22437 Exim version 4.54 uid=101 gid=101 pid=22437 D=fffdffff
17:03:15 22437 log selectors = ffffffff 7fffffff
17:03:15 22437 LOG: MAIN
17:03:15 22437 cwd=/var/spool/exim 8 args: /usr/local/exim/bin/exim -d=0xfffdffff -t -oem -oi -f <> -E1F4hrV-0005pn-0L
17:03:15 22437 sender address =
17:03:15 22437 set_process_info: 22437 accepting a local non-SMTP message from <>
17:03:15 22437 Sender:
17:03:15 22437 search_tidyup called
17:03:15 22437 >>Headers received:
17:03:15 22437 X-Failed-Recipients: bounce_me@???
17:03:15 22437 Auto-Submitted: auto-generated
17:03:15 22437 From: Mail Delivery System <Mailer-Daemon@???>
17:03:15 22437 To: rewrite-noreply@???
17:03:15 22437 Subject: Mail delivery failed: returning message to sender
17:03:15 22437
17:03:15 22437 rewrite_one_header: type=F:
17:03:15 22437 From: Mail Delivery System <Mailer-Daemon@???>
17:03:15 22437 rewrite_one_header: type=T:
17:03:15 22437 To: rewrite-noreply@???
17:03:15 22437 search_tidyup called
17:03:15 22437 >>Headers after rewriting and local additions:
17:03:15 22437 X-Failed-Recipients: bounce_me@???
17:03:15 22437 Auto-Submitted: auto-generated
17:03:15 22437 F From: Mail Delivery System <Mailer-Daemon@???>
17:03:15 22437 T To: rewrite-noreply@???
17:03:15 22437 Subject: Mail delivery failed: returning message to sender
17:03:15 22437 I Message-Id: <E1F4hrX-0005pt-6j@???>
17:03:15 22437 Date: Thu, 02 Feb 2006 17:03:15 +0000
17:03:15 22437
17:03:15 22437 Data file written for message 1F4hrX-0005pt-6j
17:03:15 22437 expanding: ${tod_full}
17:03:15 22437 result: Thu, 02 Feb 2006 17:03:15 +0000
17:03:15 22437 condition: def:sender_rcvhost
17:03:15 22437 result: false
17:03:15 22437 expanding: from $sender_rcvhost
17:03:15 22437
17:03:15 22437 result: from
17:03:15 22437
17:03:15 22437 skipping: result is not used
17:03:15 22437 condition: def:sender_ident
17:03:15 22437 result: true
17:03:15 22437 expanding: $sender_ident
17:03:15 22437 result: exim
17:03:15 22437 expanding: from ${quote_local_part:$sender_ident}
17:03:15 22437 result: from exim
17:03:15 22437 condition: def:sender_helo_name
17:03:15 22437 result: false
17:03:15 22437 expanding: (helo=$sender_helo_name)
17:03:15 22437
17:03:15 22437 result: (helo=)
17:03:15 22437
17:03:15 22437 skipping: result is not used
17:03:15 22437 expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
17:03:15 22437 }}
17:03:15 22437 result: from exim
17:03:15 22437 condition: def:received_protocol
17:03:15 22437 result: true
17:03:15 22437 expanding: with $received_protocol
17:03:15 22437 result: with local
17:03:15 22437 condition: def:tls_cipher
17:03:15 22437 result: false
17:03:15 22437 expanding: ($tls_cipher)
17:03:15 22437
17:03:15 22437 result: ()
17:03:15 22437
17:03:15 22437 skipping: result is not used
17:03:15 22437 condition: def:received_for
17:03:15 22437 result: true
17:03:15 22437 expanding:
17:03:15 22437 for $received_for
17:03:15 22437 result:
17:03:15 22437 for rewrite-noreply@???
17:03:15 22437 expanding: Received: ${if def:sender_rcvhost {from $sender_rcvhost
17:03:15 22437 }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
17:03:15 22437 }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
17:03:15 22437 }}(Exim $version_number)
17:03:15 22437 id $message_exim_id${if def:received_for {
17:03:15 22437 for $received_for}}
17:03:15 22437 result: Received: from exim by kifaru.socialrugby.com with local (Exim 4.54)
17:03:15 22437 id 1F4hrX-0005pt-6j
17:03:15 22437 for rewrite-noreply@???
17:03:15 22437 >>Generated Received: header line
17:03:15 22437 P Received: from exim by kifaru.socialrugby.com with local (Exim 4.54)
17:03:15 22437 id 1F4hrX-0005pt-6j
17:03:15 22437 for rewrite-noreply@???; Thu, 02 Feb 2006 17:03:15 +0000
17:03:15 22437 calling local_scan(); timeout=300
17:03:15 22437 local_scan() returned 0 NULL
17:03:15 22437 expanding: ${tod_full}
17:03:15 22437 result: Thu, 02 Feb 2006 17:03:15 +0000
17:03:15 22437 Writing spool header file
17:03:15 22437 Size of headers = 506
17:03:15 22437 expanding: $h_subject:
17:03:15 22437 result: Mail delivery failed: returning message to sender
17:03:15 22437 LOG: MAIN
17:03:15 22437 <= <> R=1F4hrV-0005pn-0L U=exim P=local S=1760 T="Mail delivery failed: returning message to sender"
17:03:15 22437 search_tidyup called
17:03:15 22438 exec /usr/local/exim/bin/exim -d=0xfffdffff -Mc 1F4hrX-0005pt-6j
17:03:15 22437 search_tidyup called
17:03:15 22437 >>>>>>>>>>>>>>>> Exim pid=22437 terminating with rc=0 >>>>>>>>>>>>>>>>
17:03:15 22432 Writing spool header file
17:03:15 22438 LOG: MAIN
17:03:15 22438 cwd=/var/spool/exim 4 args: /usr/local/exim/bin/exim -d=0xfffdffff -Mc 1F4hrX-0005pt-6j
17:03:15 22438 skipping ACL configuration - not needed
17:03:15 22438 set_process_info: 22438 delivering specified messages
17:03:15 22438 set_process_info: 22438 delivering 1F4hrX-0005pt-6j
17:03:15 22438 reading spool file 1F4hrX-0005pt-6j-H
17:03:15 22438 user=exim uid=101 gid=101 sender=
17:03:15 22438 sender_local=0 ident=exim
17:03:15 22438 Non-recipients:
17:03:15 22438 Empty Tree
17:03:15 22438 ---- End of tree ----
17:03:15 22438 recipients_count=1
17:03:15 22438 body_linecount=31 message_linecount=10
17:03:15 22432 Size of headers = 642
17:03:15 22438 running system filter
17:03:15 22432 LOG: MAIN
17:03:15 22432 Completed QT=2s
17:03:15 22438 rda_interpret (file): /etc/exim/exim.filter
17:03:15 22438 expanded: /etc/exim/exim.filter
17:03:15 22432 end delivery of 1F4hrV-0005pn-0L
17:03:15 22432 search_tidyup called
17:03:15 22432 search_tidyup called
17:03:15 22432 >>>>>>>>>>>>>>>> Exim pid=22432 terminating with rc=0 >>>>>>>>>>>>>>>>
17:03:15 22438 search_tidyup called
17:03:15 22439 changed uid/gid: system filter
17:03:15 22439 uid=101 gid=101 pid=22439
17:03:15 22439 auxiliary group list: <none>
17:03:15 22439 13 bytes read from /etc/exim/exim.filter
17:03:15 22439 data is an Exim filter program
17:03:15 22439 Filter: start of processing
17:03:15 22439 Filtering did not set up a significant delivery.
17:03:15 22439 Normal delivery will occur.
17:03:15 22439 Filter: end of processing
17:03:15 22439 search_tidyup called
17:03:15 22438 rda_interpret: subprocess yield=1 error=NULL
17:03:15 22438 system filter returned 1
17:03:15 22438 Delivery address list:
17:03:15 22438 rewrite-noreply@???
17:03:15 22438 locking /var/spool/exim/db/retry.lockfile
17:03:15 22438 locked /var/spool/exim/db/retry.lockfile
17:03:15 22438 EXIM_DBOPEN(/var/spool/exim/db/retry)
17:03:15 22438 returned from EXIM_DBOPEN
17:03:15 22438 opened hints database /var/spool/exim/db/retry: flags=0
17:03:15 22438 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
17:03:15 22438 Considering: rewrite-noreply@???
17:03:15 22438 unique = rewrite-noreply@???
17:03:15 22438 dbfn_read: key=R:socialrugby.com
17:03:15 22438 dbfn_read: key=R:rewrite-noreply@???
17:03:15 22438 no domain retry record
17:03:15 22438 no address retry record
17:03:15 22438 rewrite-noreply@???: queued for routing
17:03:15 22438 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
17:03:15 22438 routing rewrite-noreply@???
17:03:15 22438 --------> verp_outbound_router router <--------
17:03:15 22438 local_part=rewrite-noreply domain=socialrugby.com
17:03:15 22438 checking domains
17:03:15 22438 socialrugby.com in "kifaru.socialrugby.com : socialrugby.com"? yes (matched "socialrugby.com")
17:03:15 22438 socialrugby.com in "!+local_domains"? no (matched "!+local_domains")
17:03:15 22438 verp_outbound_router router skipped: domains mismatch
17:03:15 22438 --------> dnslookup router <--------
17:03:15 22438 local_part=rewrite-noreply domain=socialrugby.com
17:03:15 22438 checking domains
17:03:15 22438 cached yes match for +local_domains
17:03:15 22438 cached lookup data = NULL
17:03:15 22438 socialrugby.com in "! +local_domains"? no (matched "! +local_domains" - cached)
17:03:15 22438 dnslookup router skipped: domains mismatch
17:03:15 22438 --------> system_aliases router <--------
17:03:15 22438 local_part=rewrite-noreply domain=socialrugby.com
17:03:15 22438 calling system_aliases router
17:03:15 22438 rda_interpret (string): ${lookup{$local_part}lsearch{/etc/aliases}}
17:03:15 22438 expanding: $local_part
17:03:15 22438 result: rewrite-noreply
17:03:15 22438 expanding: /etc/aliases
17:03:15 22438 result: /etc/aliases
17:03:15 22438 search_open: lsearch "/etc/aliases"
17:03:15 22438 search_find: file="/etc/aliases"
17:03:15 22438 key="rewrite-noreply" partial=-1 affix=NULL starflags=0
17:03:15 22438 LRU list:
17:03:15 22438 :/etc/aliases
17:03:15 22438 End
17:03:15 22438 internal_search_find: file="/etc/aliases"
17:03:15 22438 type=lsearch key="rewrite-noreply"
17:03:15 22438 file lookup required for rewrite-noreply
17:03:15 22438 in /etc/aliases
17:03:15 22438 lookup failed
17:03:15 22438 expanding: ${lookup{$local_part}lsearch{/etc/aliases}}
17:03:15 22438 result:
17:03:15 22438 expanded:
17:03:15 22438 file is not a filter file
17:03:15 22438 parse_forward_list:
17:03:15 22438 system_aliases router declined for rewrite-noreply@???
17:03:15 22438 --------> verp_inbound_router router <--------
17:03:15 22438 local_part=rewrite-noreply domain=socialrugby.com
17:03:15 22438 checking domains
17:03:15 22438 socialrugby.com in "socialrugby.com"? yes (matched "socialrugby.com")
17:03:15 22438 socialrugby.com in "+cyrus_domains"? yes (matched "+cyrus_domains")
17:03:15 22438 checking "condition"
17:03:15 22438 expanding: $local_part
17:03:15 22438 result: rewrite-noreply
17:03:15 22438 expanding: \N^noreply-.*?$\N
17:03:15 22438 result: ^noreply-.*?$
17:03:15 22438 condition: match {$local_part}{\N^noreply-.*?$\N}
17:03:15 22438 result: false
17:03:15 22438 expanding: yes
17:03:15 22438 result: yes
17:03:15 22438 skipping: result is not used
17:03:15 22438 expanding: no
17:03:15 22438 result: no
17:03:15 22438 expanding: ${if match {$local_part}{\N^noreply-.*?$\N} {yes}{no}}
17:03:15 22438 result: no
17:03:15 22438 verp_inbound_router router skipped: condition failure
17:03:15 22438 --------> cyrus_vdom router <--------
17:03:15 22438 local_part=rewrite-noreply domain=socialrugby.com
17:03:15 22438 checking domains
17:03:15 22438 cached yes match for +cyrus_domains
17:03:15 22438 cached lookup data = NULL
17:03:15 22438 socialrugby.com in "+cyrus_domains"? yes (matched "+cyrus_domains" - cached)
17:03:15 22438 calling cyrus_vdom router
17:03:15 22438 cyrus_vdom router called for rewrite-noreply@???
17:03:15 22438 domain = socialrugby.com
17:03:15 22438 set transport cyrus_ltcp
17:03:15 22438 queued for cyrus_ltcp transport: local_part = rewrite-noreply
17:03:15 22438 domain = socialrugby.com
17:03:15 22438 errors_to=NULL
17:03:15 22438 domain_data=NULL localpart_data=NULL
17:03:15 22438 routed by cyrus_vdom router
17:03:15 22438 envelope to: rewrite-noreply@???
17:03:15 22438 transport: cyrus_ltcp
17:03:15 22438 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
17:03:15 22438 After routing:
17:03:15 22438 Local deliveries:
17:03:15 22438 Remote deliveries:
17:03:15 22438 rewrite-noreply@???
17:03:15 22438 Failed addresses:
17:03:15 22438 Deferred addresses:
17:03:15 22438 search_tidyup called
17:03:15 22438 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
17:03:15 22438 --------> rewrite-noreply@??? <--------
17:03:15 22438 search_tidyup called
17:03:15 22440 changed uid/gid: remote delivery to rewrite-noreply@??? with transport=cyrus_ltcp
17:03:15 22440 uid=101 gid=101 pid=22440
17:03:15 22440 auxiliary group list: <none>
17:03:15 22440 set_process_info: 22440 delivering 1F4hrX-0005pt-6j using cyrus_ltcp
17:03:15 22440 cyrus_ltcp transport entered
17:03:15 22440 rewrite-noreply@???
17:03:15 22440 using the transport's hosts: 127.0.0.1
17:03:15 22440 getting address for 127.0.0.1
17:03:15 22438 set_process_info: 22438 delivering 1F4hrX-0005pt-6j: waiting for a remote delivery subprocess to finish
17:03:15 22438 selecting on subprocess pipes
17:03:15 22440 Actual local interface address is 127.0.0.1 (lo)
17:03:15 22440 Actual local interface address is 80.82.141.27 (eth0)
17:03:15 22440 local host found for non-MX address
17:03:15 22440 fully qualified name = 127.0.0.1
17:03:15 22440 gethostbyname looked up these IP addresses:
17:03:15 22440 name=127.0.0.1 address=127.0.0.1
17:03:15 22440 socialrugby.com in queue_smtp_domains? no (option unset)
17:03:15 22440 checking status of 127.0.0.1
17:03:15 22440 locking /var/spool/exim/db/retry.lockfile
17:03:15 22440 locked /var/spool/exim/db/retry.lockfile
17:03:15 22440 EXIM_DBOPEN(/var/spool/exim/db/retry)
17:03:15 22440 returned from EXIM_DBOPEN
17:03:15 22440 opened hints database /var/spool/exim/db/retry: flags=0
17:03:15 22440 dbfn_read: key=T:127.0.0.1:127.0.0.1:24
17:03:15 22440 dbfn_read: key=T:127.0.0.1:127.0.0.1:24:1F4hrX-0005pt-6j
17:03:15 22440 no host retry record
17:03:15 22440 no message retry record
17:03:15 22440 127.0.0.1 [127.0.0.1]:24 status = usable
17:03:15 22440 127.0.0.1 in serialize_hosts? no (option unset)
17:03:15 22440 delivering 1F4hrX-0005pt-6j to 127.0.0.1 [127.0.0.1] (rewrite-noreply@???)
17:03:15 22440 set_process_info: 22440 delivering 1F4hrX-0005pt-6j to 127.0.0.1 [127.0.0.1] (rewrite-noreply@???)
17:03:15 22440 expanding: $primary_hostname
17:03:15 22440 result: kifaru.socialrugby.com
17:03:15 22440 Connecting to 127.0.0.1 [127.0.0.1]:24 ... connected
17:03:15 22440 waiting for data on socket
17:03:15 22440 read response data: size=77
17:03:15 22440 SMTP<< 220 kifaru.socialrugby.com LMTP Cyrus v2.2.12-Invoca-RPM-2.2.12-6.fc4 ready
17:03:15 22440 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
17:03:15 22440 SMTP>> LHLO kifaru.socialrugby.com
17:03:15 22440 waiting for data on socket
17:03:15 22440 read response data: size=129
17:03:15 22440 SMTP<< 250-kifaru.socialrugby.com
17:03:15 22440 250-8BITMIME
17:03:15 22440 250-ENHANCEDSTATUSCODES
17:03:15 22440 250-PIPELINING
17:03:15 22440 250-SIZE
17:03:15 22440 250-AUTH EXTERNAL
17:03:15 22440 250 IGNOREQUOTA
17:03:15 22440 127.0.0.1 in hosts_require_tls? no (option unset)
17:03:15 22440 using PIPELINING
17:03:15 22440 127.0.0.1 in hosts_require_auth? no (option unset)
17:03:15 22440 127.0.0.1 in hosts_try_auth? no (option unset)
17:03:15 22440 SMTP>> MAIL FROM:<> SIZE=2825
17:03:15 22440 SMTP>> RCPT TO:<rewrite-noreply@???>
17:03:15 22440 SMTP>> DATA
17:03:15 22440 waiting for data on socket
17:03:15 22440 read response data: size=188
17:03:15 22440 SMTP<< 250 2.1.0 ok
17:03:15 22440 SMTP<< 550-Mailbox unknown. Either there is no mailbox associated with this
17:03:15 22440 550-name or you do not have authorization to see it.
17:03:15 22440 550 5.1.1 User unknown
17:03:15 22440 SMTP<< 503 5.5.1 No recipients
17:03:15 22440 SMTP error from remote mail server after pipelined DATA: host 127.0.0.1 [127.0.0.1]: 503 5.5.1 No recipients
17:03:15 22440 error for DATA ignored: pipelining is in use and there were no good recipients
17:03:15 22440 ok=1 send_quit=1 send_rset=1 continue_more=0 yield=0 first_address is NULL
17:03:15 22440 transport_check_waiting entered
17:03:15 22440 sequence=1 local_max=500 global_max=-1
17:03:15 22440 locking /var/spool/exim/db/wait-cyrus_ltcp.lockfile
17:03:15 22440 locked /var/spool/exim/db/wait-cyrus_ltcp.lockfile
17:03:15 22440 EXIM_DBOPEN(/var/spool/exim/db/wait-cyrus_ltcp)
17:03:15 22440 returned from EXIM_DBOPEN
17:03:15 22440 opened hints database /var/spool/exim/db/wait-cyrus_ltcp: flags=2
17:03:15 22440 dbfn_read: key=127.0.0.1
17:03:15 22440 no messages waiting for 127.0.0.1
17:03:15 22440 SMTP>> QUIT
17:03:15 22440 set_process_info: 22440 delivering 1F4hrX-0005pt-6j: just tried 127.0.0.1 [127.0.0.1] for rewrite-noreply@???: result OK
17:03:15 22440 Leaving cyrus_ltcp transport
17:03:15 22440 set_process_info: 22440 delivering 1F4hrX-0005pt-6j (just run cyrus_ltcp for rewrite-noreply@??? in subprocess)
17:03:15 22440 search_tidyup called
17:03:15 22438 reading pipe for subprocess 22440 (not ended)
17:03:15 22438 read() yielded 5
17:03:15 22438 selecting on subprocess pipes
17:03:15 22438 reading pipe for subprocess 22440 (not ended)
17:03:15 22438 read() yielded 282
17:03:15 22438 selecting on subprocess pipes
17:03:15 22438 reading pipe for subprocess 22440 (not ended)
17:03:15 22438 read() yielded 2
17:03:15 22438 Z0 item read
17:03:15 22438 remote delivery process 22440 ended
17:03:15 22438 set_process_info: 22438 delivering 1F4hrX-0005pt-6j
17:03:15 22438 post-process rewrite-noreply@??? (2)
17:03:15 22438 LOG: MAIN
17:03:15 22438 ** rewrite-noreply@??? F=<> P=<> R=cyrus_vdom T=cyrus_ltcp: SMTP error from remote mail server after RCPT TO:<rewrite-noreply@???>: host 127.0.0.1 [127.0.0.1]: 550-Mailbox unknown. Either there is no mailbox associated with this\n550-name or you do not have authorization to see it.\n550 5.1.1 User unknown
17:03:15 22438 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
17:03:15 22438 changed uid/gid: post-delivery tidying
17:03:15 22438 uid=101 gid=101 pid=22438
17:03:15 22438 auxiliary group list: <none>
17:03:15 22438 set_process_info: 22438 tidying up after delivering 1F4hrX-0005pt-6j
17:03:15 22438 Processing retry items
17:03:15 22438 Succeeded addresses:
17:03:15 22438 Failed addresses:
17:03:15 22438 Deferred addresses:
17:03:15 22438 rewrite-noreply@???: no retry items
17:03:15 22438 end of retry processing
17:03:15 22438 LOG: MAIN
17:03:15 22438 Frozen (delivery error message)
17:03:15 22438 delivery deferred: update_spool=1 header_rewritten=0
17:03:15 22438 Writing spool header file
17:03:15 22438 Size of headers = 506
17:03:15 22438 end delivery of 1F4hrX-0005pt-6j
17:03:15 22438 search_tidyup called
17:03:15 22438 search_tidyup called
17:03:15 22438 >>>>>>>>>>>>>>>> Exim pid=22438 terminating with rc=0 >>>>>>>>>>>>>>>>
