Docs: more info for dovecot auth driver
[users/jgh/exim.git] / test / stderr / 0044
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=pppp
4 configuration file is TESTSUITE/test-config
5 admin user
6 changed uid/gid: privilege not needed
7   uid=EXIM_UID gid=EXIM_GID pid=pppp
8 seeking password data for user "CALLER": cache not available
9 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
10 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
11 sender address = CALLER@exim.test.ex
12 sender_fullhost = [V4NET.11.12.13]
13 sender_rcvhost = [V4NET.11.12.13]
14 host in hosts_connection_nolog? no (option unset)
15 LOG: smtp_connection MAIN
16   SMTP connection from [V4NET.11.12.13]
17 host in host_lookup? no (option unset)
18 set_process_info: pppp handling incoming connection from [V4NET.11.12.13]
19 host in host_reject_connection? no (option unset)
20 host in sender_unqualified_hosts? no (option unset)
21 host in recipient_unqualified_hosts? no (option unset)
22 host in helo_verify_hosts? no (option unset)
23 host in helo_try_verify_hosts? no (option unset)
24 host in helo_accept_junk_hosts? no (option unset)
25 SMTP>> 220 the.local.host.name ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
26 smtp_setup_msg entered
27 SMTP<< ehlo exim.test.ex
28 exim.test.ex in helo_lookup_domains? no (end of list)
29 sender_fullhost = (exim.test.ex) [V4NET.11.12.13]
30 sender_rcvhost = [V4NET.11.12.13] (helo=exim.test.ex)
31 set_process_info: pppp handling incoming connection from (exim.test.ex) [V4NET.11.12.13]
32 host in dsn_advertise_hosts? no (option unset)
33 host in pipelining_advertise_hosts? yes (matched "*")
34 host in chunking_advertise_hosts? no (end of list)
35 SMTP>> 250-the.local.host.name Hello exim.test.ex [V4NET.11.12.13]
36 250-SIZE 52428800
37 250-8BITMIME
38 250-PIPELINING
39 250 HELP
40 SMTP<< mail from:postmaster@exim.test.ex
41 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
42 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
43 SMTP>> 250 OK
44 SMTP<< rcpt to:<postmaster@exim.test.ex>
45 using ACL "check_recipient"
46 processing "accept" (TESTSUITE/test-config 19)
47 check hosts = :
48 host in ":"? no (end of list)
49 accept: condition test failed in ACL "check_recipient"
50 processing "accept" (TESTSUITE/test-config 20)
51 check recipients = postmaster@exim.test.ex
52 address match test: subject=postmaster@exim.test.ex pattern=postmaster@exim.test.ex
53 exim.test.ex in "exim.test.ex"? yes (matched "exim.test.ex")
54 postmaster@exim.test.ex in "postmaster@exim.test.ex"? yes (matched "postmaster@exim.test.ex")
55 accept: condition test succeeded in ACL "check_recipient"
56 end of ACL "check_recipient": ACCEPT
57 SMTP>> 250 Accepted
58 DSN: orcpt: NULL  flags: 0
59 SMTP<< rcpt to:list@exim.test.ex
60 using ACL "check_recipient"
61 processing "accept" (TESTSUITE/test-config 19)
62 check hosts = :
63 host in ":"? no (end of list)
64 accept: condition test failed in ACL "check_recipient"
65 processing "accept" (TESTSUITE/test-config 20)
66 check recipients = postmaster@exim.test.ex
67 address match test: subject=list@exim.test.ex pattern=postmaster@exim.test.ex
68 list@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
69 accept: condition test failed in ACL "check_recipient"
70 processing "accept" (TESTSUITE/test-config 21)
71 check senders = myfriend@*
72 address match test: subject=postmaster@exim.test.ex pattern=myfriend@*
73 postmaster@exim.test.ex in "myfriend@*"? no (end of list)
74 accept: condition test failed in ACL "check_recipient"
75 processing "deny" (TESTSUITE/test-config 22)
76   message: host is listed in $dnslist_domain
77 check dnslists = rbl.test.ex
78 dnslists check: rbl.test.ex
79 new DNS lookup for 13.12.11.V4NET.rbl.test.ex
80 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) using fakens
81 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded
82 dnslists: wrote cache entry, ttl=3
83 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
84 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens
85 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded
86 => that means V4NET.11.12.13 is listed at rbl.test.ex
87 deny: condition test succeeded in ACL "check_recipient"
88 end of ACL "check_recipient": DENY
89 SMTP>> 550 host is listed in rbl.test.ex
90 LOG: MAIN REJECT
91   H=(exim.test.ex) [V4NET.11.12.13] F=<postmaster@exim.test.ex> rejected RCPT list@exim.test.ex: host is listed in rbl.test.ex
92 SMTP<< rcpt to:list2@exim.test.ex
93 using ACL "check_recipient"
94 processing "accept" (TESTSUITE/test-config 19)
95 check hosts = :
96 host in ":"? no (end of list)
97 accept: condition test failed in ACL "check_recipient"
98 processing "accept" (TESTSUITE/test-config 20)
99 check recipients = postmaster@exim.test.ex
100 address match test: subject=list2@exim.test.ex pattern=postmaster@exim.test.ex
101 list2@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
102 accept: condition test failed in ACL "check_recipient"
103 processing "accept" (TESTSUITE/test-config 21)
104 check senders = myfriend@*
105 address match test: subject=postmaster@exim.test.ex pattern=myfriend@*
106 postmaster@exim.test.ex in "myfriend@*"? no (end of list)
107 accept: condition test failed in ACL "check_recipient"
108 processing "deny" (TESTSUITE/test-config 22)
109   message: host is listed in $dnslist_domain
110 check dnslists = rbl.test.ex
111 dnslists check: rbl.test.ex
112 dnslists: using result of previous lookup
113 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
114 => that means V4NET.11.12.13 is listed at rbl.test.ex
115 deny: condition test succeeded in ACL "check_recipient"
116 end of ACL "check_recipient": DENY
117 SMTP>> 550 host is listed in rbl.test.ex
118 LOG: MAIN REJECT
119   H=(exim.test.ex) [V4NET.11.12.13] F=<postmaster@exim.test.ex> rejected RCPT list2@exim.test.ex: host is listed in rbl.test.ex
120 SMTP<< data
121 SMTP>> 354 Enter message, ending with "." on a line by itself
122 search_tidyup called
123 host in ignore_fromline_hosts? no (option unset)
124 >>Headers received:
125
126 search_tidyup called
127 >>Headers after rewriting and local additions:
128
129 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
130 Data file written for message 10HmaX-0005vi-00
131 >>Generated Received: header line
132 P Received: from [V4NET.11.12.13] (helo=exim.test.ex)
133         by the.local.host.name with esmtp (Exim x.yz)
134         (envelope-from <postmaster@exim.test.ex>)
135         id 10HmaX-0005vi-00
136         for postmaster@exim.test.ex; Tue, 2 Mar 1999 09:44:33 +0000
137 LOG: MAIN
138   <= postmaster@exim.test.ex H=(exim.test.ex) [V4NET.11.12.13] P=esmtp S=sss
139 SMTP>> 250 OK id=10HmaX-0005vi-00
140 smtp_setup_msg entered
141 SMTP<< quit
142 SMTP>> 221 the.local.host.name closing connection
143 LOG: smtp_connection MAIN
144   SMTP connection from (exim.test.ex) [V4NET.11.12.13] closed by QUIT
145 search_tidyup called
146 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
147 >>> host in hosts_connection_nolog? no (option unset)
148 >>> host in host_lookup? no (option unset)
149 >>> host in host_reject_connection? no (option unset)
150 >>> host in sender_unqualified_hosts? no (option unset)
151 >>> host in recipient_unqualified_hosts? no (option unset)
152 >>> host in helo_verify_hosts? no (option unset)
153 >>> host in helo_try_verify_hosts? no (option unset)
154 >>> host in helo_accept_junk_hosts? no (option unset)
155 >>> exim.test.ex in helo_lookup_domains? no (end of list)
156 >>> host in dsn_advertise_hosts? no (option unset)
157 >>> host in pipelining_advertise_hosts? yes (matched "*")
158 >>> host in chunking_advertise_hosts? no (end of list)
159 >>> using ACL "check_recipient"
160 >>> processing "accept" (TESTSUITE/test-config 19)
161 >>> check hosts = :
162 >>> host in ":"? no (end of list)
163 >>> accept: condition test failed in ACL "check_recipient"
164 >>> processing "accept" (TESTSUITE/test-config 20)
165 >>> check recipients = postmaster@exim.test.ex
166 >>> list@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
167 >>> accept: condition test failed in ACL "check_recipient"
168 >>> processing "accept" (TESTSUITE/test-config 21)
169 >>> check senders = myfriend@*
170 >>> there.test.ex in "*"? yes (matched "*")
171 >>> myfriend@there.test.ex in "myfriend@*"? yes (matched "myfriend@*")
172 >>> accept: condition test succeeded in ACL "check_recipient"
173 >>> end of ACL "check_recipient": ACCEPT
174 >>> host in ignore_fromline_hosts? no (option unset)
175 LOG: 10HmaY-0005vi-00 <= myfriend@there.test.ex H=(exim.test.ex) [V4NET.11.12.13] P=esmtp S=sss
176 Exim version x.yz ....
177 changed uid/gid: forcing real = effective
178   uid=uuuu gid=CALLER_GID pid=pppp
179 configuration file is TESTSUITE/test-config
180 admin user
181 changed uid/gid: privilege not needed
182   uid=EXIM_UID gid=EXIM_GID pid=pppp
183 seeking password data for user "CALLER": cache not available
184 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
185 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
186 sender address = CALLER@exim.test.ex
187 sender_fullhost = [V4NET.99.99.99]
188 sender_rcvhost = [V4NET.99.99.99]
189 host in hosts_connection_nolog? no (option unset)
190 LOG: smtp_connection MAIN
191   SMTP connection from [V4NET.99.99.99]
192 host in host_lookup? no (option unset)
193 set_process_info: pppp handling incoming connection from [V4NET.99.99.99]
194 host in host_reject_connection? no (option unset)
195 host in sender_unqualified_hosts? no (option unset)
196 host in recipient_unqualified_hosts? no (option unset)
197 host in helo_verify_hosts? no (option unset)
198 host in helo_try_verify_hosts? no (option unset)
199 host in helo_accept_junk_hosts? no (option unset)
200 SMTP>> 220 the.local.host.name ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
201 smtp_setup_msg entered
202 SMTP<< ehlo exim.test.ex
203 exim.test.ex in helo_lookup_domains? no (end of list)
204 sender_fullhost = (exim.test.ex) [V4NET.99.99.99]
205 sender_rcvhost = [V4NET.99.99.99] (helo=exim.test.ex)
206 set_process_info: pppp handling incoming connection from (exim.test.ex) [V4NET.99.99.99]
207 host in dsn_advertise_hosts? no (option unset)
208 host in pipelining_advertise_hosts? yes (matched "*")
209 host in chunking_advertise_hosts? no (end of list)
210 SMTP>> 250-the.local.host.name Hello exim.test.ex [V4NET.99.99.99]
211 250-SIZE 52428800
212 250-8BITMIME
213 250-PIPELINING
214 250 HELP
215 SMTP<< mail from:postmaster@exim.test.ex
216 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
217 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
218 SMTP>> 250 OK
219 SMTP<< rcpt to:list@exim.test.ex
220 using ACL "check_recipient"
221 processing "accept" (TESTSUITE/test-config 19)
222 check hosts = :
223 host in ":"? no (end of list)
224 accept: condition test failed in ACL "check_recipient"
225 processing "accept" (TESTSUITE/test-config 20)
226 check recipients = postmaster@exim.test.ex
227 address match test: subject=list@exim.test.ex pattern=postmaster@exim.test.ex
228 list@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
229 accept: condition test failed in ACL "check_recipient"
230 processing "accept" (TESTSUITE/test-config 21)
231 check senders = myfriend@*
232 address match test: subject=postmaster@exim.test.ex pattern=myfriend@*
233 postmaster@exim.test.ex in "myfriend@*"? no (end of list)
234 accept: condition test failed in ACL "check_recipient"
235 processing "deny" (TESTSUITE/test-config 22)
236   message: host is listed in $dnslist_domain
237 check dnslists = rbl.test.ex
238 dnslists check: rbl.test.ex
239 new DNS lookup for 99.99.99.V4NET.rbl.test.ex
240 DNS lookup of 99.99.99.V4NET.rbl.test.ex (A) using fakens
241 DNS lookup of 99.99.99.V4NET.rbl.test.ex (A) gave HOST_NOT_FOUND
242 returning DNS_NOMATCH
243 faking res_search(A) response length as 65535
244  writing neg-cache entry for 99.99.99.V4NET.rbl.test.ex-A-xxxx, ttl 3000
245 faking res_search(A) response length as 65535
246 dnslists: wrote cache entry, ttl=3000
247 DNS lookup for 99.99.99.V4NET.rbl.test.ex failed
248 => that means V4NET.99.99.99 is not listed at rbl.test.ex
249 deny: condition test failed in ACL "check_recipient"
250 processing "require" (TESTSUITE/test-config 24)
251 check verify = sender
252 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
253 Verifying postmaster@exim.test.ex
254 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
255 Considering postmaster@exim.test.ex
256 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
257 routing postmaster@exim.test.ex
258 --------> localuser router <--------
259 local_part=postmaster domain=exim.test.ex
260 checking local_parts
261 postmaster in "userx"? no (end of list)
262 localuser router skipped: local_parts mismatch
263 no more routers
264 ----------- end verify ------------
265 require: condition test failed in ACL "check_recipient"
266 end of ACL "check_recipient": not OK
267 LOG: MAIN REJECT
268   H=(exim.test.ex) [V4NET.99.99.99] sender verify fail for <postmaster@exim.test.ex>: Unrouteable address
269 SMTP>> 550-Verification failed for <postmaster@exim.test.ex>
270 SMTP>> 550-Unrouteable address
271 SMTP>> 550 Sender verify failed
272 LOG: MAIN REJECT
273   H=(exim.test.ex) [V4NET.99.99.99] F=<postmaster@exim.test.ex> rejected RCPT list@exim.test.ex: Sender verify failed
274 SMTP>> 421 the.local.host.name lost input connection
275 LOG: lost_incoming_connection MAIN
276   unexpected disconnection while reading SMTP command from (exim.test.ex) [V4NET.99.99.99] D=qqs
277 search_tidyup called
278 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>