Re: [Exim] Vacation problem exim 4.05

Startseite
Nachricht löschen
Nachricht beantworten
Autor: Simon Alman
Datum:  
To: exim-users
Betreff: Re: [Exim] Vacation problem exim 4.05
Hi, thanks once again for the response.

I have been using the -d to show a debuglog. From what I can see exim is
claiming to be doing the initial delivery and also returning a vacation
message to the sender.

I have included the debug log below, this shows a message being sent from
test1 to test2 where test2 is on vacation.

The only thing I can see which is suspicious is one line where it says:

"changed uid/gid: local delivery to >test1 <test1@???> <>test1
<test1@???>> transport=address_reply
uid=531 gid=531"

from checking /etc/passwd, 531 is the uid and gid of user test2, the fact
that it still claims a successful delivery -

"post-process >test1 <test1@???> (0)
>test1 <test1@???> delivered"


- even though this isn't happening is very confusing, admittedly I am
fairly new to this so I may be reading the log file incorrectly.

Once again .vacation.log is reporting having sent a message to test1
although test1 has not received any such message. Normal mail is arriving
for test1 fine however.

Once more I am stumped :(

Regards

Simon


>exim -d is your friend it will show you a nice debuglog, which helps to
>identify problems.
>
>ciao


[root exim]# exim -C exim_outgoing.conf -d -M 17oP7A-00079d-00
Exim version 4.05 uid=0 gid=0 pid=28098 L=834cd8 D=fff7577f
Berkeley DB: Sleepycat Software: DB 2.4.14: (6/2/98)
changed uid/gid: forcing real = effective
uid=0 gid=0
auxiliary group list: <none>
trusted user
admin user
skipping ACL configuration - not needed
set_process_info: 28098 delivering specified messages
set_process_info: 28098 delivering 17oP7A-00079d-00
reading spool file 17oP7A-00079d-00-H
user=root uid=0 gid=0 sender=test1@???
sender_fullhost = (grumpy.test.com) [192.168.100.113]
sender_rcvhost = [192.168.100.113] (helo=grumpy.test.com ident=test1)
sender_local=0 ident=test1
Non-recipients:
-->\0\test2@??? [1]
-->/home/test2/Backup/:test2@??? [0]
---- End of tree ----
recipients_count=1
body_linecount=2 message_linecount=14
Delivery address list:
test2@???
locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
opened hints database /var/spool/exim/db/retry: flags=0
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>

Considering: test2@???
active address test2@???
local_part=test2 domain=test.com
unique = test2@???
dbfn_read: key=R:test.com
dbfn_read: key=R:test2@???
no domain retry record
no address retry record
test2@???: queued for routing
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>

routing test2@???
--------> dnslookup router <--------
local_part=test2 domain=test.com
checking domains
test.com in "chameleon: test.com: *.test.com: localhost"? yes (matched
"test.com")
test.com in "! +local_domains"? no (matched "! +local_domains")
cached lookup data = NULL
dnslookup router skipped: domains mismatch
--------> system_aliases router <--------
local_part=test2 domain=test.com
calling system_aliases router
rda_interpret (string): ${lookup{$local_part}lsearch{/etc/aliases_$domain}}
search_open: lsearch "/etc/aliases_test.com"
search_find: file="/etc/aliases_test.com"
key="test2" partial=-1
LRU list:
8/etc/aliases_test.com
End
internal_search_find: file="/etc/aliases_test.com"
type=lsearch key="test2"
file lookup required for test2
in /etc/aliases_test.com
lookup failed
expanded:
file is not a filter file
parse_forward_list:
system_aliases router declined for test2@???
--------> real_localuser router <--------
local_part=test2 domain=test.com
real_localuser router skipped: prefix mismatch
--------> userforward router <--------
local_part=test2 domain=test.com
checking for local user
calling userforward router
rda_interpret (file): $home/.forward
expanded: /home/test2/.forward
changed uid/gid: userforward router
uid=531 gid=531
auxiliary group list: <none>
170 bytes read from /home/test2/.forward
data is a filter program
Filter: start of processing
Filter: end of processing
rda_interpret: subprocess yield=1 error=NULL
set transport address_reply
userforward router generated >test1 <test1@???>
pipe, file, or autoreply
errors_to=NULL transport=address_reply
uid=531 gid=531 home=\N/home/test2\N
set transport address_directory
userforward router generated /home/test2/Backup/
pipe, file, or autoreply
errors_to=NULL transport=address_directory
uid=531 gid=531 home=\N/home/test2\N
userforward router generated test2@???
routed by userforward router
envelope to: test2@???
transport: <none>
locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
opened hints database /var/spool/exim/db/retry: flags=0
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>

Considering: test2@???
active address test2@???
local_part=test2 domain=test.com
unique = \0\test2@???
\0\test2@??? was previously delivered: discarded
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>

Considering: /home/test2/Backup/
unique = /home/test2/Backup/:test2@???
/home/test2/Backup/ was previously delivered: discarded
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>

Considering: >test1 <test1@???>
unique = >test1 <test1@???>:test2@???
queued for address_reply transport
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>

After routing:
   Local deliveries:
     >test1 <test1@???>
   Remote deliveries:
   Failed addresses:
   Deferred addresses:
search_tidyup called

>>>>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>>>

--------> >test1 <test1@???> <--------
locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
opened hints database /var/spool/exim/db/retry: flags=0
dbfn_read: key=T:>test1 <test1@???>:test2@???
retry record exists: age=618 (max=604800)
time to retry = -282 expired = 0
search_tidyup called
changed uid/gid: local delivery to >test1 <test1@???> <>test1
<test1@???>> transport=address_reply
uid=531 gid=531
auxiliary group list: <none>
home=/home/test2 current=/home/test2
set_process_info: 28100 delivering 17oP7A-00079d-00 to >test1
<test1@???> using address_reply
address_reply transport entered
taking data from address
message previously sent to test1 <test1@???> and repeat time not reached
address_reply transport succeeded
search_tidyup called
journalling >test1 <test1@???>:test2@???
address_reply transport returned OK for >test1 <test1@???>
added retry item for T:>test1 <test1@???>:test2@???: errno=0 0
flags=1
post-process >test1 <test1@???> (0)
>test1 <test1@???> delivered

test2@???: children all complete
LOG: MAIN
=> >test1 <test1@???> <test2@???> R=userforward T=address_reply
>>>>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>>>

changed uid/gid: post-delivery tidying
uid=42 gid=12
auxiliary group list: <none>
set_process_info: 28098 tidying up after delivering 17oP7A-00079d-00
Processing retry items
Succeeded addresses:
>test1 <test1@???>

locking /var/spool/exim/db/retry.lockfile
locked /var/spool/exim/db/retry.lockfile
opened hints database /var/spool/exim/db/retry: flags=42
deleted retry information for T:>test1 <test1@???>:test2@???
test2@???: no retry items
test2@???: no retry items
Failed addresses:
Deferred addresses:
end of retry processing
LOG: MAIN
Completed
end delivery of 17oP7A-00079d-00
search_tidyup called
search_tidyup called
>>>>>>>>>>>>>>>>>> Exim pid=28098 terminating with rc=0 >>>>>>>>>>>>>>>>>>