Re: [exim-dev] Authenticated_id and redirect condition

Top Page
Delete this message
Reply to this message
Author: Leszek Dubiel
Date:  
To: exim-dev
Subject: Re: [exim-dev] Authenticated_id and redirect condition


>> I modified that router -- in third line i have put "authenticated_id"
>> instead of "local_part", so it looks like this:
>>
>> copysend:
>> driver = redirect
>> data = ${if eq{$authenticated_id}{nowak} {kowalski} }
>> headers_remove = Subject
>> headers_add = Subject: authenticated_id is $authenticated_id...
>> unseen = yes
>>
>>
>> When user "nowak" sends mail to user "test", then user "kowalski" gets
>> copy of that mail, but subject is NOT changed. So router is run, because
>> $authenticated_id equals "nowak", so mail is copied to "kowalski". I
>> DON'T understand why this time headers are not changed.
>>
>
> Try running with -d to get debugging information to see if that shows
> you what is happening.
>


I have made as you suggested. Data is expanded as expected -- we get
"kowalski". But when transport is beeing done headers are not added. If
I replace "authenticated_id" in "data=" line with "local_part", then
everything works ok -- mail is unseen copied to kowalski.

Below I describe problem in more detail.




I have made two tests:

FIRST TEST:

-- copysend contains "data = ${if eq{$authenticated_id}{nowak}
{kowalski} }"
-- user nowak sends email to himself
-- kowalski gets email with subject NOT changed


SECOND TEST:

-- copysend contains "data = ${if eq{$local_part}{nowak} {kowalski} }"
-- user nowak sends email to himself
-- kowalski gets email with subject "authenticated_id is nowak"


In both logs we can see that router is run ("kowalski" is expanded). But
when we use "$authenticated_id" in "data=" field headers_add and
headers_remove options don't work.






Here is full (experimental = very simple) configuration for FIRST TEST:


*******************************************************
*************************** exim config
*******************************************************

primary_hostname = dubiel.pl

acl_smtp_rcpt = accept
acl_smtp_data = accept

begin routers

copysend:
driver = redirect
data = ${if eq{$authenticated_id}{nowak} {kowalski} }
headers_remove = Subject
headers_add = Subject: authenticated_id is $authenticated_id...
unseen = yes

user:
driver = redirect
check_local_user
group = mail
data = /var/mail/$local_part
file_transport = to_file

begin transports

to_file:
driver = appendfile

begin authenticators

plain_local:
driver = plaintext
public_name = PLAIN
server_condition = "${if
crypteq{$3}{${extract{1}{:}{${lookup{$2}lsearch{/etc/exim4/passwd}{$value}{*:*}}}}}{1}{0}}"
server_set_id = $2

**************************************************************
***************************** end of exim config for first test
***************************************************************

Here is log of command exim -bd -d if user "nowak" sends email to
himself and kowalski gets email with


***************************************************************
********************************** exim log for first test
****************************************************************

Exim version 4.50 uid=0 gid=0 pid=19247 D=fbb95cfd
Berkeley DB: Sleepycat Software: Berkeley DB 4.2.52: (December  3, 2003)
Support for: iconv() IPv6 GnuTLS
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
changed uid/gid: forcing real = effective
  uid=0 gid=0 pid=19247
  auxiliary group list: <none>
configuration file is /etc/exim4/exim4.conf
log selectors = 00000ffc 00020800
trusted user
admin user
originator: uid=0 gid=0 login=root name=root
19247 listening on all interfaces (IPv6) port 25
19247 listening on all interfaces (IPv4) port 25
19247 pid written to /var/run/exim4/exim.pid
19247 changed uid/gid: running as a daemon
19247   uid=102 gid=102 pid=19247
19247   auxiliary group list: 102
19247 LOG: MAIN
19247   exim 4.50 daemon started: pid=19247, no queue runs, listening 
for SMTP on port 25 (IPv6 and IPv4)
19247 set_process_info: 19247 daemon: no queue runs, listening for SMTP 
on port 25 (IPv6 and IPv4)
19247 daemon running with uid=102 gid=102 euid=102 egid=102
19247 Listening...
19247 Connection request from 192.168.18.35 port 1357
19247 search_tidyup called
19261 host in rfc1413_hosts? yes (matched "*")
19261 doing ident callback
19247 1 SMTP accept process running
19247 Listening...
19261 ident connection to 192.168.18.35 failed: Connection timed out
19261 sender_fullhost = [192.168.18.35]
19261 sender_rcvhost = [192.168.18.35]
19261 Process 19261 is handling incoming connection from [192.168.18.35]
19261 host in host_lookup? no (option unset)
19261 set_process_info: 19261 handling incoming connection from 
[192.168.18.35]
19261 host in host_reject_connection? no (option unset)
19261 host in sender_unqualified_hosts? no (option unset)
19261 host in recipient_unqualified_hosts? no (option unset)
19261 host in helo_verify_hosts? no (option unset)
19261 host in helo_try_verify_hosts? no (option unset)
19261 host in helo_accept_junk_hosts? no (option unset)
19261 SMTP>> 220 dubiel.pl ESMTP Exim 4.50 Tue, 10 Apr 2007 18:06:47 +0200
19261 Process 19261 is ready for new message
19261 smtp_setup_msg entered
19261 SMTP<< EHLO [192.168.18.35]
19261 [192.168.18.35] in helo_lookup_domains? no (end of list)
19261 sender_fullhost = ([192.168.18.35]) [192.168.18.35]
19261 sender_rcvhost = [192.168.18.35] (helo=[192.168.18.35])
19261 set_process_info: 19261 handling incoming connection from 
([192.168.18.35]) [192.168.18.35]
19261 host in pipelining_advertise_hosts? yes (matched "*")
19261 host in auth_advertise_hosts? yes (matched "*")
19261 host in tls_advertise_hosts? no (option unset)
19261 SMTP>> 250-dubiel.pl Hello [192.168.18.35] [192.168.18.35]
19261 250-SIZE 52428800
19261 250-PIPELINING
19261 250-AUTH PLAIN
19261 250 HELP
19261 SMTP<< AUTH PLAIN AG5vd2FrAGFkYW0=
19261 search_open: lsearch "/etc/exim4/passwd"
19261 search_find: file="/etc/exim4/passwd"
19261   key="nowak" partial=-1 affix=NULL starflags=0
19261 LRU list:
19261   :/etc/exim4/passwd
19261   End
19261 internal_search_find: file="/etc/exim4/passwd"
19261   type=lsearch key="nowak"
19261 file lookup required for nowak
19261   in /etc/exim4/passwd
19261 lookup yielded: Fy5vuaV5eXDMM
19261 crypteq: using crypt()
19261   subject=Fy5vuaV5eXDMM
19261   crypted=Fy5vuaV5eXDMM
19261 plain_local authenticator:
19261   $1 =
19261   $2 = nowak
19261   $3 = adam
19261 expanded string: 1
19261 SMTP>> 235 Authentication succeeded
19261 SMTP<< MAIL FROM:<nowak@???> SIZE=325
19261 spool directory space = 7338760K inodes = -1 check_space = 0K 
inodes = 0 msg_size = 5325
19261 SMTP>> 250 OK
19261 SMTP<< RCPT TO:<nowak@???>
19261 processing "accept"
19261 accept: condition test succeeded
19261 SMTP>> 250 Accepted
19261 SMTP<< DATA
19261 SMTP>> 354 Enter message, ending with "." on a line by itself
19261 search_tidyup called
19261 host in ignore_fromline_hosts? no (option unset)
19261 >>Headers received:
19261 Message-ID: <461BB641.3000301@???>
19261 Date: Tue, 10 Apr 2007 18:07:29 +0200
19261 From: nowak <nowak@???>
19261 User-Agent: Thunderbird 1.5.0.10 (Windows/20070221)
19261 MIME-Version: 1.0
19261 To:  nowak@???
19261 Subject: test2
19261 Content-Type: text/plain; charset=ISO-8859-2; format=flowed
19261 Content-Transfer-Encoding: 7bit
19261
19261 rewrite_one_header: type=F:
19261   From: nowak <nowak@???>
19261 rewrite_one_header: type=T:
19261   To:  nowak@???
19261 search_tidyup called
19261 >>Headers after rewriting and local additions:
19261 I Message-ID: <461BB641.3000301@???>
19261   Date: Tue, 10 Apr 2007 18:07:29 +0200
19261 F From: nowak <nowak@???>
19261   User-Agent: Thunderbird 1.5.0.10 (Windows/20070221)
19261   MIME-Version: 1.0
19261 T To:  nowak@???
19261   Subject: test2
19261   Content-Type: text/plain; charset=ISO-8859-2; format=flowed
19261   Content-Transfer-Encoding: 7bit
19261
19261 Data file written for message 1HbIro-00050f-03
19261 >>Generated Received: header line
19261 P Received: from [192.168.18.35] (helo=[192.168.18.35])
19261     by dubiel.pl with esmtpa (Exim 4.50)
19261     id 1HbIro-00050f-03
19261     for nowak@???; Tue, 10 Apr 2007 18:06:48 +0200
19261 processing "accept"
19261 accept: condition test succeeded
19261 calling local_scan(); timeout=300
19261 local_scan() returned 0 NULL
19261 Writing spool header file
19261 Size of headers = 474
19261 LOG: MAIN
19261   <= nowak@??? H=([192.168.18.35]) [192.168.18.35] P=esmtpa 
A=plain_local:nowak S=481 id=461BB641.3000301@???
19261 SMTP>> 250 OK id=1HbIro-00050f-03
19261 search_tidyup called
19261 Sender: nowak@???
19261 Recipients:
19261   nowak@???
19286 exec /usr/sbin/exim4 -d=0xfbbd5cfd -Mc 1HbIro-00050f-03
19261 forked delivery process 19286
19261 Process 19261 is ready for new message
19261 smtp_setup_msg entered
19261 SMTP<< QUIT
19261 SMTP>> 221 dubiel.pl closing connection
19261 LOG: smtp_connection MAIN
19261   SMTP connection from ([192.168.18.35]) [192.168.18.35] closed by 
QUIT
19261 search_tidyup called
19247 child 19261 ended: status=0x0
19247 0 SMTP accept processes now running
19247 Listening...
19286 Exim version 4.50 uid=102 gid=102 pid=19286 D=fbbd5cfd
Berkeley DB: Sleepycat Software: Berkeley DB 4.2.52: (December  3, 2003)
Support for: iconv() IPv6 GnuTLS
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
19286 changed uid/gid: forcing real = effective
19286   uid=0 gid=102 pid=19286
19286   auxiliary group list: <none>
19286 configuration file is /etc/exim4/exim4.conf
19286 log selectors = 00000ffc 00020800
19286 trusted user
19286 admin user
19286 set_process_info: 19286 delivering specified messages
19286 set_process_info: 19286 delivering 1HbIro-00050f-03
19286 reading spool file 1HbIro-00050f-03-H
19286 user=root uid=0 gid=0 sender=nowak@???
19286 sender_fullhost = ([192.168.18.35]) [192.168.18.35]
19286 sender_rcvhost = [192.168.18.35] (helo=[192.168.18.35])
19286 sender_local=0 ident=unset
19286 Non-recipients:
19286 Empty Tree
19286 ---- End of tree ----
19286 recipients_count=1
19286 body_linecount=1 message_linecount=13
19286 Delivery address list:
19286   nowak@???
19286 locking /var/spool/exim4/db/retry.lockfile
19286 locked /var/spool/exim4/db/retry.lockfile
19286 opened hints database /var/spool/exim4/db/retry: flags=0
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 Considering: nowak@???
19286 unique = nowak@???
19286 dbfn_read: key=R:dubiel.pl
19286 dbfn_read: key=R:nowak@???
19286 no domain retry record
19286 no address retry record
19286 nowak@???: queued for routing
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 routing nowak@???
19286 --------> copysend router <--------
19286 local_part=nowak domain=dubiel.pl
19286 calling copysend router
19286 rda_interpret (string): ${if eq{$authenticated_id}{nowak} {kowalski} }
19286 expanded: kowalski
19286 file is not a filter file
19286 parse_forward_list: kowalski
19286 extract item: kowalski
19286 copysend router generated kowalski@???
19286   errors_to=NULL transport=NULL
19286   uid=unset gid=unset home=NULL
19286 routed by copysend router (unseen)
19286   envelope to: nowak@???
19286   transport: <none>
19286 "unseen" set: replicated nowak@???
19286 locking /var/spool/exim4/db/retry.lockfile
19286 locked /var/spool/exim4/db/retry.lockfile
19286 opened hints database /var/spool/exim4/db/retry: flags=0
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 Considering: nowak@???
19286 unique = \0\nowak@???
19286 dbfn_read: key=R:dubiel.pl
19286 dbfn_read: key=R:nowak@???
19286 no domain retry record
19286 no address retry record
19286 nowak@???: queued for routing
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 Considering: kowalski@???
19286 unique = kowalski@???
19286 dbfn_read: key=R:dubiel.pl
19286 dbfn_read: key=R:kowalski@???
19286 no domain retry record
19286 no address retry record
19286 kowalski@???: queued for routing
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 routing kowalski@???
19286 --------> copysend router <--------
19286 local_part=kowalski domain=dubiel.pl
19286 calling copysend router
19286 rda_interpret (string): ${if eq{$authenticated_id}{nowak} {kowalski} }
19286 expanded: kowalski
19286 file is not a filter file
19286 parse_forward_list: kowalski
19286 extract item: kowalski
19286 copysend router generated kowalski@???
19286   errors_to=NULL transport=NULL
19286   uid=unset gid=unset home=NULL
19286 routed by copysend router (unseen)
19286   envelope to: kowalski@???
19286   transport: <none>
19286 "unseen" set: replicated kowalski@???
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 routing nowak@???
19286 --------> user router <--------
19286 local_part=nowak domain=dubiel.pl
19286 checking for local user
19286 calling user router
19286 rda_interpret (string): /var/mail/$local_part
19286 expanded: /var/mail/nowak
19286 file is not a filter file
19286 parse_forward_list: /var/mail/nowak
19286 extract item: /var/mail/nowak
19286 set transport to_file
19286 user router generated /var/mail/nowak
19286   pipe, file, or autoreply
19286   errors_to=NULL transport=to_file
19286   uid=1008 gid=8 home=\N/home/nowak\N
19286 routed by user router
19286   envelope to: nowak@???
19286   transport: <none>
19286 locking /var/spool/exim4/db/retry.lockfile
19286 locked /var/spool/exim4/db/retry.lockfile
19286 opened hints database /var/spool/exim4/db/retry: flags=0
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 Considering: /var/mail/nowak
19286 unique = /var/mail/nowak:nowak@???
19286 queued for to_file transport
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 Considering: kowalski@???
19286 unique = \0\kowalski@???
19286 dbfn_read: key=R:dubiel.pl
19286 dbfn_read: key=R:kowalski@???
19286 no domain retry record
19286 no address retry record
19286 kowalski@???: queued for routing
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 Considering: kowalski@???
19286 unique = \0\kowalski@???
19286 \0\kowalski@??? is a duplicate address: discarded
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 routing kowalski@???
19286 --------> user router <--------
19286 local_part=kowalski domain=dubiel.pl
19286 checking for local user
19286 calling user router
19286 rda_interpret (string): /var/mail/$local_part
19286 expanded: /var/mail/kowalski
19286 file is not a filter file
19286 parse_forward_list: /var/mail/kowalski
19286 extract item: /var/mail/kowalski
19286 user router generated /var/mail/kowalski
19286   pipe, file, or autoreply
19286   errors_to=NULL transport=to_file
19286   uid=1007 gid=8 home=\N/home/kowalski\N
19286 routed by user router
19286   envelope to: kowalski@???
19286   transport: <none>
19286 locking /var/spool/exim4/db/retry.lockfile
19286 locked /var/spool/exim4/db/retry.lockfile
19286 opened hints database /var/spool/exim4/db/retry: flags=0
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 Considering: /var/mail/kowalski
19286 unique = /var/mail/kowalski:kowalski@???
19286 queued for to_file transport
19286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19286 After routing:
19286   Local deliveries:
19286     /var/mail/kowalski
19286     /var/mail/nowak
19286   Remote deliveries:
19286   Failed addresses:
19286   Deferred addresses:
19286 search_tidyup called
19286 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
19286 --------> /var/mail/kowalski <--------
19286 locking /var/spool/exim4/db/retry.lockfile
19286 locked /var/spool/exim4/db/retry.lockfile
19286 opened hints database /var/spool/exim4/db/retry: flags=0
19286 dbfn_read: key=T:/var/mail/kowalski:kowalski@???
19286 no retry record exists
19286 search_tidyup called
19290 changed uid/gid: local delivery to /var/mail/kowalski 
</var/mail/kowalski> transport=to_file
19290   uid=1007 gid=8 pid=19290
19290   auxiliary group list: <none>
19290   home=/home/kowalski current=/home/kowalski
19290 set_process_info: 19290 delivering 1HbIro-00050f-03 to 
/var/mail/kowalski using to_file
19290 appendfile transport entered
19290 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
19290   file=/var/mail/kowalski format=unix
19290   message_prefix=From ${if 
def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
19290   message_suffix=\n
19290   maildir_use_size_file=no
19290   locking by lockfile fcntl
19290 lock name: /var/mail/kowalski.lock
19290 hitch name: /var/mail/kowalski.lock.dubiel.pl.461bb61a.00004b5a
19290 lock file created
19290 mailbox /var/mail/kowalski is locked
19290 writing to file /var/mail/kowalski
19290 writing data block fd=6 size=46 timeout=0
19290 writing data block fd=6 size=481 timeout=0
19290 writing data block fd=6 size=1 timeout=0
19290 appendfile yields 0 with errno=0 more_errno=0
19286 journalling /var/mail/kowalski:kowalski@???
19290 search_tidyup called
19286 to_file transport returned OK for /var/mail/kowalski
19286 post-process /var/mail/kowalski (0)
19286 /var/mail/kowalski delivered
19286 kowalski@???: children all complete
19286 LOG: MAIN
19286   => /var/mail/kowalski (kowalski@???) <nowak@???> 
R=user T=to_file
19286 --------> /var/mail/nowak <--------
19286 locking /var/spool/exim4/db/retry.lockfile
19286 locked /var/spool/exim4/db/retry.lockfile
19286 opened hints database /var/spool/exim4/db/retry: flags=0
19286 dbfn_read: key=T:/var/mail/nowak:nowak@???
19286 no retry record exists
19286 search_tidyup called
19291 changed uid/gid: local delivery to /var/mail/nowak 
</var/mail/nowak> transport=to_file
19291   uid=1008 gid=8 pid=19291
19291   auxiliary group list: <none>
19291   home=/home/nowak current=/home/nowak
19291 set_process_info: 19291 delivering 1HbIro-00050f-03 to 
/var/mail/nowak using to_file
19291 appendfile transport entered
19291 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
19291   file=/var/mail/nowak format=unix
19291   message_prefix=From ${if 
def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
19291   message_suffix=\n
19291   maildir_use_size_file=no
19291   locking by lockfile fcntl
19291 lock name: /var/mail/nowak.lock
19291 hitch name: /var/mail/nowak.lock.dubiel.pl.461bb61a.00004b5b
19291 lock file created
19291 mailbox /var/mail/nowak is locked
19291 writing to file /var/mail/nowak
19291 writing data block fd=7 size=46 timeout=0
19291 writing data block fd=7 size=481 timeout=0
19291 writing data block fd=7 size=1 timeout=0
19291 appendfile yields 0 with errno=0 more_errno=0
19286 journalling /var/mail/nowak:nowak@???
19291 search_tidyup called
19286 to_file transport returned OK for /var/mail/nowak
19286 post-process /var/mail/nowak (0)
19286 /var/mail/nowak delivered
19286 nowak@???: children all complete
19286 LOG: MAIN
19286   => /var/mail/nowak (nowak@???) <nowak@???> R=user 
T=to_file
19286 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
19286 changed uid/gid: post-delivery tidying
19286   uid=102 gid=102 pid=19286
19286   auxiliary group list: <none>
19286 set_process_info: 19286 tidying up after delivering 1HbIro-00050f-03
19286 Processing retry items
19286 Succeeded addresses:
19286 /var/mail/nowak: no retry items
19286 nowak@???: no retry items
19286 nowak@???: no retry items
19286 /var/mail/kowalski: no retry items
19286 kowalski@???: no retry items
19286 kowalski@???: no retry items
19286 nowak@???: no retry items
19286 nowak@???: no retry items
19286 kowalski@???: no retry items
19286 kowalski@???: no retry items
19286 nowak@???: no retry items
19286 nowak@???: no retry items
19286 nowak@???: no retry items
19286 nowak@???: no retry items
19286 kowalski@???: no retry items
19286 kowalski@???: no retry items
19286 nowak@???: no retry items
19286 nowak@???: no retry items
19286 nowak@???: no retry items
19286 nowak@???: no retry items
19286 Failed addresses:
19286 Deferred addresses:
19286 end of retry processing
19286 LOG: MAIN
19286   Completed
19286 end delivery of 1HbIro-00050f-03
19286 search_tidyup called
19286 search_tidyup called
19286 >>>>>>>>>>>>>>>> Exim pid=19286 terminating with rc=0 >>>>>>>>>>>>>>>>


******************************************************
*************** end of exim log for first test
******************************************************







Now let's look at the SECOND TEST configuration

*********************************************************
************************** exim config for second test
*********************************************************

primary_hostname = dubiel.pl

acl_smtp_rcpt = accept
acl_smtp_data = accept

begin routers

copysend:
driver = redirect
data = ${if eq{$local_part}{nowak} {kowalski} }
headers_remove = Subject
headers_add = Subject: authenticated_id is $authenticated_id...
unseen = yes

user:
driver = redirect
check_local_user
group = mail
data = /var/mail/$local_part
file_transport = to_file

begin transports

to_file:
driver = appendfile

begin authenticators

plain_local:
driver = plaintext
public_name = PLAIN
server_condition = "${if
crypteq{$3}{${extract{1}{:}{${lookup{$2}lsearch{/etc/exim4/passwd}{$value}{*:*}}}}}{1}{0}}"
server_set_id = $2

********************************************************
**************** end of exim config for second test
********************************************************

User nowak send email to himself and we get such a log:

*****************************************************
****************** exim log of second test
****************************************************

Exim version 4.50 uid=0 gid=0 pid=19154 D=fbb95cfd
Berkeley DB: Sleepycat Software: Berkeley DB 4.2.52: (December  3, 2003)
Support for: iconv() IPv6 GnuTLS
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
changed uid/gid: forcing real = effective
  uid=0 gid=0 pid=19154
  auxiliary group list: <none>
configuration file is /etc/exim4/exim4.conf
log selectors = 00000ffc 00020800
trusted user
admin user
originator: uid=0 gid=0 login=root name=root
19154 listening on all interfaces (IPv6) port 25
19154 listening on all interfaces (IPv4) port 25
19154 pid written to /var/run/exim4/exim.pid
19154 changed uid/gid: running as a daemon
19154   uid=102 gid=102 pid=19154
19154   auxiliary group list: 102
19154 LOG: MAIN
19154   exim 4.50 daemon started: pid=19154, no queue runs, listening 
for SMTP on port 25 (IPv6 and IPv4)
19154 set_process_info: 19154 daemon: no queue runs, listening for SMTP 
on port 25 (IPv6 and IPv4)
19154 daemon running with uid=102 gid=102 euid=102 egid=102
19154 Listening...
19154 Connection request from 192.168.18.35 port 1351
19154 search_tidyup called
19165 host in rfc1413_hosts? yes (matched "*")
19165 doing ident callback
19154 1 SMTP accept process running
19154 Listening...
19165 ident connection to 192.168.18.35 failed: Connection timed out
19165 sender_fullhost = [192.168.18.35]
19165 sender_rcvhost = [192.168.18.35]
19165 Process 19165 is handling incoming connection from [192.168.18.35]
19165 host in host_lookup? no (option unset)
19165 set_process_info: 19165 handling incoming connection from 
[192.168.18.35]
19165 host in host_reject_connection? no (option unset)
19165 host in sender_unqualified_hosts? no (option unset)
19165 host in recipient_unqualified_hosts? no (option unset)
19165 host in helo_verify_hosts? no (option unset)
19165 host in helo_try_verify_hosts? no (option unset)
19165 host in helo_accept_junk_hosts? no (option unset)
19165 SMTP>> 220 dubiel.pl ESMTP Exim 4.50 Tue, 10 Apr 2007 18:04:58 +0200
19165 Process 19165 is ready for new message
19165 smtp_setup_msg entered
19165 SMTP<< EHLO [192.168.18.35]
19165 [192.168.18.35] in helo_lookup_domains? no (end of list)
19165 sender_fullhost = ([192.168.18.35]) [192.168.18.35]
19165 sender_rcvhost = [192.168.18.35] (helo=[192.168.18.35])
19165 set_process_info: 19165 handling incoming connection from 
([192.168.18.35]) [192.168.18.35]
19165 host in pipelining_advertise_hosts? yes (matched "*")
19165 host in auth_advertise_hosts? yes (matched "*")
19165 host in tls_advertise_hosts? no (option unset)
19165 SMTP>> 250-dubiel.pl Hello [192.168.18.35] [192.168.18.35]
19165 250-SIZE 52428800
19165 250-PIPELINING
19165 250-AUTH PLAIN
19165 250 HELP
19165 SMTP<< AUTH PLAIN AG5vd2FrAGFkYW0=
19165 search_open: lsearch "/etc/exim4/passwd"
19165 search_find: file="/etc/exim4/passwd"
19165   key="nowak" partial=-1 affix=NULL starflags=0
19165 LRU list:
19165   :/etc/exim4/passwd
19165   End
19165 internal_search_find: file="/etc/exim4/passwd"
19165   type=lsearch key="nowak"
19165 file lookup required for nowak
19165   in /etc/exim4/passwd
19165 lookup yielded: Fy5vuaV5eXDMM
19165 crypteq: using crypt()
19165   subject=Fy5vuaV5eXDMM
19165   crypted=Fy5vuaV5eXDMM
19165 plain_local authenticator:
19165   $1 =
19165   $2 = nowak
19165   $3 = adam
19165 expanded string: 1
19165 SMTP>> 235 Authentication succeeded
19165 SMTP<< MAIL FROM:<nowak@???> SIZE=327
19165 spool directory space = 7338800K inodes = -1 check_space = 0K 
inodes = 0 msg_size = 5327
19165 SMTP>> 250 OK
19165 SMTP<< RCPT TO:<nowak@???>
19165 processing "accept"
19165 accept: condition test succeeded
19165 SMTP>> 250 Accepted
19165 SMTP<< DATA
19165 SMTP>> 354 Enter message, ending with "." on a line by itself
19165 search_tidyup called
19165 host in ignore_fromline_hosts? no (option unset)
19165 >>Headers received:
19165 Message-ID: <461BB5D4.4020300@???>
19165 Date: Tue, 10 Apr 2007 18:05:40 +0200
19165 From: nowak <nowak@???>
19165 User-Agent: Thunderbird 1.5.0.10 (Windows/20070221)
19165 MIME-Version: 1.0
19165 To:  nowak@???
19165 Subject: test1
19165 Content-Type: text/plain; charset=ISO-8859-2; format=flowed
19165 Content-Transfer-Encoding: 7bit
19165
19165 rewrite_one_header: type=F:
19165   From: nowak <nowak@???>
19165 rewrite_one_header: type=T:
19165   To:  nowak@???
19165 search_tidyup called
19165 >>Headers after rewriting and local additions:
19165 I Message-ID: <461BB5D4.4020300@???>
19165   Date: Tue, 10 Apr 2007 18:05:40 +0200
19165 F From: nowak <nowak@???>
19165   User-Agent: Thunderbird 1.5.0.10 (Windows/20070221)
19165   MIME-Version: 1.0
19165 T To:  nowak@???
19165   Subject: test1
19165   Content-Type: text/plain; charset=ISO-8859-2; format=flowed
19165   Content-Transfer-Encoding: 7bit
19165
19165 Data file written for message 1HbIq3-0004z7-1Y
19165 >>Generated Received: header line
19165 P Received: from [192.168.18.35] (helo=[192.168.18.35])
19165     by dubiel.pl with esmtpa (Exim 4.50)
19165     id 1HbIq3-0004z7-1Y
19165     for nowak@???; Tue, 10 Apr 2007 18:04:59 +0200
19165 processing "accept"
19165 accept: condition test succeeded
19165 calling local_scan(); timeout=300
19165 local_scan() returned 0 NULL
19165 Writing spool header file
19165 Size of headers = 474
19165 LOG: MAIN
19165   <= nowak@??? H=([192.168.18.35]) [192.168.18.35] P=esmtpa 
A=plain_local:nowak S=482 id=461BB5D4.4020300@???
19165 SMTP>> 250 OK id=1HbIq3-0004z7-1Y
19165 search_tidyup called
19165 Sender: nowak@???
19165 Recipients:
19165   nowak@???
19189 exec /usr/sbin/exim4 -d=0xfbbd5cfd -Mc 1HbIq3-0004z7-1Y
19165 forked delivery process 19189
19165 Process 19165 is ready for new message
19165 smtp_setup_msg entered
19165 SMTP<< QUIT
19165 SMTP>> 221 dubiel.pl closing connection
19165 LOG: smtp_connection MAIN
19165   SMTP connection from ([192.168.18.35]) [192.168.18.35] closed by 
QUIT
19165 search_tidyup called
19154 child 19165 ended: status=0x0
19154 0 SMTP accept processes now running
19154 Listening...
19189 Exim version 4.50 uid=102 gid=102 pid=19189 D=fbbd5cfd
Berkeley DB: Sleepycat Software: Berkeley DB 4.2.52: (December  3, 2003)
Support for: iconv() IPv6 GnuTLS
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
19189 changed uid/gid: forcing real = effective
19189   uid=0 gid=102 pid=19189
19189   auxiliary group list: <none>
19189 configuration file is /etc/exim4/exim4.conf
19189 log selectors = 00000ffc 00020800
19189 trusted user
19189 admin user
19189 set_process_info: 19189 delivering specified messages
19189 set_process_info: 19189 delivering 1HbIq3-0004z7-1Y
19189 reading spool file 1HbIq3-0004z7-1Y-H
19189 user=root uid=0 gid=0 sender=nowak@???
19189 sender_fullhost = ([192.168.18.35]) [192.168.18.35]
19189 sender_rcvhost = [192.168.18.35] (helo=[192.168.18.35])
19189 sender_local=0 ident=unset
19189 Non-recipients:
19189 Empty Tree
19189 ---- End of tree ----
19189 recipients_count=1
19189 body_linecount=2 message_linecount=13
19189 Delivery address list:
19189   nowak@???
19189 locking /var/spool/exim4/db/retry.lockfile
19189 locked /var/spool/exim4/db/retry.lockfile
19189 opened hints database /var/spool/exim4/db/retry: flags=0
19189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19189 Considering: nowak@???
19189 unique = nowak@???
19189 dbfn_read: key=R:dubiel.pl
19189 dbfn_read: key=R:nowak@???
19189 no domain retry record
19189 no address retry record
19189 nowak@???: queued for routing
19189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19189 routing nowak@???
19189 --------> copysend router <--------
19189 local_part=nowak domain=dubiel.pl
19189 calling copysend router
19189 rda_interpret (string): ${if eq{$local_part}{nowak} {kowalski} }
19189 expanded: kowalski
19189 file is not a filter file
19189 parse_forward_list: kowalski
19189 extract item: kowalski
19189 copysend router generated kowalski@???
19189   errors_to=NULL transport=NULL
19189   uid=unset gid=unset home=NULL
19189 routed by copysend router (unseen)
19189   envelope to: nowak@???
19189   transport: <none>
19189 "unseen" set: replicated nowak@???
19189 locking /var/spool/exim4/db/retry.lockfile
19189 locked /var/spool/exim4/db/retry.lockfile
19189 opened hints database /var/spool/exim4/db/retry: flags=0
19189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19189 Considering: nowak@???
19189 unique = \0\nowak@???
19189 dbfn_read: key=R:dubiel.pl
19189 dbfn_read: key=R:nowak@???
19189 no domain retry record
19189 no address retry record
19189 nowak@???: queued for routing
19189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19189 Considering: kowalski@???
19189 unique = kowalski@???
19189 dbfn_read: key=R:dubiel.pl
19189 dbfn_read: key=R:kowalski@???
19189 no domain retry record
19189 no address retry record
19189 kowalski@???: queued for routing
19189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19189 routing kowalski@???
19189 --------> copysend router <--------
19189 local_part=kowalski domain=dubiel.pl
19189 calling copysend router
19189 rda_interpret (string): ${if eq{$local_part}{nowak} {kowalski} }
19189 expanded:
19189 file is not a filter file
19189 parse_forward_list:
19189 copysend router declined for kowalski@???
19189 --------> user router <--------
19189 local_part=kowalski domain=dubiel.pl
19189 checking for local user
19189 calling user router
19189 rda_interpret (string): /var/mail/$local_part
19189 expanded: /var/mail/kowalski
19189 file is not a filter file
19189 parse_forward_list: /var/mail/kowalski
19189 extract item: /var/mail/kowalski
19189 set transport to_file
19189 user router generated /var/mail/kowalski
19189   pipe, file, or autoreply
19189   errors_to=NULL transport=to_file
19189   uid=1007 gid=8 home=\N/home/kowalski\N
19189 routed by user router
19189   envelope to: kowalski@???
19189   transport: <none>
19189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19189 routing nowak@???
19189 --------> user router <--------
19189 local_part=nowak domain=dubiel.pl
19189 checking for local user
19189 calling user router
19189 rda_interpret (string): /var/mail/$local_part
19189 expanded: /var/mail/nowak
19189 file is not a filter file
19189 parse_forward_list: /var/mail/nowak
19189 extract item: /var/mail/nowak
19189 user router generated /var/mail/nowak
19189   pipe, file, or autoreply
19189   errors_to=NULL transport=to_file
19189   uid=1008 gid=8 home=\N/home/nowak\N
19189 routed by user router
19189   envelope to: nowak@???
19189   transport: <none>
19189 locking /var/spool/exim4/db/retry.lockfile
19189 locked /var/spool/exim4/db/retry.lockfile
19189 opened hints database /var/spool/exim4/db/retry: flags=0
19189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19189 Considering: /var/mail/nowak
19189 unique = /var/mail/nowak:nowak@???
19189 queued for to_file transport
19189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19189 Considering: /var/mail/kowalski
19189 unique = /var/mail/kowalski:kowalski@???
19189 queued for to_file transport
19189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19189 After routing:
19189   Local deliveries:
19189     /var/mail/kowalski
19189     /var/mail/nowak
19189   Remote deliveries:
19189   Failed addresses:
19189   Deferred addresses:
19189 search_tidyup called
19189 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
19189 --------> /var/mail/kowalski <--------
19189 locking /var/spool/exim4/db/retry.lockfile
19189 locked /var/spool/exim4/db/retry.lockfile
19189 opened hints database /var/spool/exim4/db/retry: flags=0
19189 dbfn_read: key=T:/var/mail/kowalski:kowalski@???
19189 no retry record exists
19189 search_tidyup called
19190 changed uid/gid: local delivery to /var/mail/kowalski 
</var/mail/kowalski> transport=to_file
19190   uid=1007 gid=8 pid=19190
19190   auxiliary group list: <none>
19190   home=/home/kowalski current=/home/kowalski
19190 set_process_info: 19190 delivering 1HbIq3-0004z7-1Y to 
/var/mail/kowalski using to_file
19190 appendfile transport entered
19190 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
19190   file=/var/mail/kowalski format=unix
19190   message_prefix=From ${if 
def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
19190   message_suffix=\n
19190   maildir_use_size_file=no
19190   locking by lockfile fcntl
19190 lock name: /var/mail/kowalski.lock
19190 hitch name: /var/mail/kowalski.lock.dubiel.pl.461bb5ad.00004af6
19190 lock file created
19190 mailbox /var/mail/kowalski is locked
19190 writing to file /var/mail/kowalski
19190 writing data block fd=6 size=46 timeout=0
19190 removed header line:
19190 Subject: test1
19190 ---
19190 added header line(s):
19190 Subject: authenticated_id is nowak...
19190 ---
19190 writing data block fd=6 size=505 timeout=0
19190 writing data block fd=6 size=1 timeout=0
19190 appendfile yields 0 with errno=0 more_errno=0
19189 journalling /var/mail/kowalski:kowalski@???
19190 search_tidyup called
19189 to_file transport returned OK for /var/mail/kowalski
19189 post-process /var/mail/kowalski (0)
19189 /var/mail/kowalski delivered
19189 kowalski@???: children all complete
19189 LOG: MAIN
19189   => /var/mail/kowalski (kowalski@???) <nowak@???> 
R=user T=to_file
19189 --------> /var/mail/nowak <--------
19189 locking /var/spool/exim4/db/retry.lockfile
19189 locked /var/spool/exim4/db/retry.lockfile
19189 opened hints database /var/spool/exim4/db/retry: flags=0
19189 dbfn_read: key=T:/var/mail/nowak:nowak@???
19189 no retry record exists
19189 search_tidyup called
19191 changed uid/gid: local delivery to /var/mail/nowak 
</var/mail/nowak> transport=to_file
19191   uid=1008 gid=8 pid=19191
19191   auxiliary group list: <none>
19191   home=/home/nowak current=/home/nowak
19191 set_process_info: 19191 delivering 1HbIq3-0004z7-1Y to 
/var/mail/nowak using to_file
19191 appendfile transport entered
19191 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
19191   file=/var/mail/nowak format=unix
19191   message_prefix=From ${if 
def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
19191   message_suffix=\n
19191   maildir_use_size_file=no
19191   locking by lockfile fcntl
19191 lock name: /var/mail/nowak.lock
19191 hitch name: /var/mail/nowak.lock.dubiel.pl.461bb5ad.00004af7
19191 lock file created
19191 mailbox /var/mail/nowak is locked
19191 writing to file /var/mail/nowak
19191 writing data block fd=7 size=46 timeout=0
19191 writing data block fd=7 size=482 timeout=0
19191 writing data block fd=7 size=1 timeout=0
19191 appendfile yields 0 with errno=0 more_errno=0
19189 journalling /var/mail/nowak:nowak@???
19191 search_tidyup called
19189 to_file transport returned OK for /var/mail/nowak
19189 post-process /var/mail/nowak (0)
19189 /var/mail/nowak delivered
19189 nowak@???: children all complete
19189 LOG: MAIN
19189   => /var/mail/nowak (nowak@???) <nowak@???> R=user 
T=to_file
19189 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
19189 changed uid/gid: post-delivery tidying
19189   uid=102 gid=102 pid=19189
19189   auxiliary group list: <none>
19189 set_process_info: 19189 tidying up after delivering 1HbIq3-0004z7-1Y
19189 Processing retry items
19189 Succeeded addresses:
19189 /var/mail/nowak: no retry items
19189 nowak@???: no retry items
19189 nowak@???: no retry items
19189 /var/mail/kowalski: no retry items
19189 kowalski@???: no retry items
19189 nowak@???: no retry items
19189 nowak@???: no retry items
19189 nowak@???: no retry items
19189 nowak@???: no retry items
19189 kowalski@???: no retry items
19189 nowak@???: no retry items
19189 nowak@???: no retry items
19189 nowak@???: no retry items
19189 nowak@???: no retry items
19189 Failed addresses:
19189 Deferred addresses:
19189 end of retry processing
19189 LOG: MAIN
19189   Completed
19189 end delivery of 1HbIq3-0004z7-1Y
19189 search_tidyup called
19189 search_tidyup called
19189 >>>>>>>>>>>>>>>> Exim pid=19189 terminating with rc=0 >>>>>>>>>>>>>>>>


**************************************************************
************************ end of exim log for the second test
*****************************************************************




Any help will be grateful!