hosts_require_helo
[exim.git] / test / stderr / 2600
1 Exim version x.yz ....
2 configuration file is TESTSUITE/test-config
3 admin user
4 dropping to exim gid; retaining priv uid
5  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
6  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
7    key="select name from them where id='userx';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
8  LRU list:
9  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
10    type=sqlite key="select name from them where id='userx';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
11  file lookup required for select name from them where id='userx';
12    in TESTSUITE/aux-fixed/sqlitedb
13  creating new cache entry
14  lookup yielded: Ayen Other
15  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
16    cached open
17  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
18    key="select name from them where id='userx';" partial=-1 affix=NULL starflags=0 opts=NULL
19  LRU list:
20  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
21    type=sqlite key="select name from them where id='userx';" opts=NULL
22  cached data found but wrong opts;  file lookup required for select name from them where id='userx';
23  c  in TESTSUITE/aux-fixed/sqlitedb
24  replacing old cache entry
25  lookup yielded: Ayen Other
26  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
27    cached open
28  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
29    key="select name from them where id='userx';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
30  LRU list:
31  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
32    type=sqlite key="select name from them where id='userx';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
33  cached data found but wrong opts;  file lookup required for select name from them where id='userx';
34  c  in TESTSUITE/aux-fixed/sqlitedb
35  replacing old cache entry
36  lookup yielded: Ayen Other
37  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
38    cached open
39  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
40    key="select name from them where id='userx';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
41  LRU list:
42  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
43    type=sqlite key="select name from them where id='userx';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
44  cached data used for lookup of select name from them where id='userx';
45    in TESTSUITE/aux-fixed/sqlitedb
46  lookup yielded: Ayen Other
47  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
48    cached open
49  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
50    key="select name from them where id='xxxx';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
51  LRU list:
52  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
53    type=sqlite key="select name from them where id='xxxx';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
54  file lookup required for select name from them where id='xxxx';
55    in TESTSUITE/aux-fixed/sqlitedb
56  lookup forced cache cleanup
57  lookup failed
58  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
59    cached open
60  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
61    key="select name from them where id='nothing';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
62  LRU list:
63  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
64    type=sqlite key="select name from them where id='nothing';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
65  file lookup required for select name from them where id='nothing';
66    in TESTSUITE/aux-fixed/sqlitedb
67  creating new cache entry
68  lookup yielded: 
69  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
70    cached open
71  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
72    key="select id,name from them where id='nothing';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
73  LRU list:
74  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
75    type=sqlite key="select id,name from them where id='nothing';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
76  file lookup required for select id,name from them where id='nothing';
77    in TESTSUITE/aux-fixed/sqlitedb
78  creating new cache entry
79  lookup yielded: id=nothing name="" 
80  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
81    cached open
82  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
83    key="select * from them where id='quote2';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
84  LRU list:
85  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
86    type=sqlite key="select * from them where id='quote2';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
87  file lookup required for select * from them where id='quote2';
88    in TESTSUITE/aux-fixed/sqlitedb
89  creating new cache entry
90  lookup yielded: name="\"stquot" id=quote2 
91  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
92    cached open
93  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
94    key="select * from them where id='newline';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
95  LRU list:
96  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
97    type=sqlite key="select * from them where id='newline';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
98  file lookup required for select * from them where id='newline';
99    in TESTSUITE/aux-fixed/sqlitedb
100  creating new cache entry
101  lookup yielded: name="before
102  after" id=newline 
103  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
104    cached open
105  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
106    key="select * from them where id='tab';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
107  LRU list:
108  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
109    type=sqlite key="select * from them where id='tab';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
110  file lookup required for select * from them where id='tab';
111    in TESTSUITE/aux-fixed/sqlitedb
112  creating new cache entry
113  lookup yielded: name="x        x" id=tab 
114  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
115    cached open
116  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
117    key="select * from them where id='its';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
118  LRU list:
119  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
120    type=sqlite key="select * from them where id='its';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
121  file lookup required for select * from them where id='its';
122    in TESTSUITE/aux-fixed/sqlitedb
123  creating new cache entry
124  lookup yielded: name=it's id=its 
125  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
126    cached open
127  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
128    key="select * from them where name='it''s';" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
129  LRU list:
130  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
131    type=sqlite key="select * from them where name='it''s';" opts="file=TESTSUITE/aux-fixed/sqlitedb"
132  file lookup required for select * from them where name='it''s';
133    in TESTSUITE/aux-fixed/sqlitedb
134  creating new cache entry
135  lookup yielded: name=it's id=its 
136 search_tidyup called
137 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
138 Exim version x.yz ....
139 changed uid/gid: forcing real = effective
140   uid=uuuu gid=CALLER_GID pid=pppp
141 configuration file is TESTSUITE/test-config
142 admin user
143 changed uid/gid: privilege not needed
144   uid=EXIM_UID gid=EXIM_GID pid=pppp
145 seeking password data for user "CALLER": cache not available
146 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
147 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
148 sender address = CALLER@myhost.test.ex
149 sender_fullhost = [10.0.0.0]
150 sender_rcvhost = [10.0.0.0]
151 host in hosts_connection_nolog? no (option unset)
152 LOG: smtp_connection MAIN
153   SMTP connection from [10.0.0.0]
154 host in host_lookup? no (option unset)
155 set_process_info: pppp handling incoming connection from [10.0.0.0]
156 host in host_reject_connection? no (option unset)
157 host in sender_unqualified_hosts? no (option unset)
158 host in recipient_unqualified_hosts? no (option unset)
159 host in helo_verify_hosts? no (option unset)
160 host in helo_try_verify_hosts? no (option unset)
161 host in helo_accept_junk_hosts? no (option unset)
162 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
163 smtp_setup_msg entered
164 SMTP<< helo test
165 test in helo_lookup_domains? no (end of list)
166 sender_fullhost = (test) [10.0.0.0]
167 sender_rcvhost = [10.0.0.0] (helo=test)
168 set_process_info: pppp handling incoming connection from (test) [10.0.0.0]
169 SMTP>> 250 myhost.test.ex Hello test [10.0.0.0]
170 SMTP<< mail from:<a@b>
171 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
172 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
173 SMTP>> 250 OK
174 SMTP<< rcpt to:<c@d>
175 using ACL "check_recipient"
176 processing "accept" (TESTSUITE/test-config 32)
177 check domains = +local_domains
178 d in "@"? no (end of list)
179 d in "+local_domains"? no (end of list)
180 accept: condition test failed in ACL "check_recipient"
181 processing "accept" (TESTSUITE/test-config 33)
182 check hosts = +relay_hosts
183 search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
184 search_find: file="TESTSUITE/aux-fixed/sqlitedb"
185   key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
186 LRU list:
187 internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
188   type=sqlite key="select * from them where id='10.0.0.0'" opts="file=TESTSUITE/aux-fixed/sqlitedb"
189 file lookup required for select * from them where id='10.0.0.0'
190   in TESTSUITE/aux-fixed/sqlitedb
191 lookup forced cache cleanup
192 lookup failed
193 host in "sqlite,file=TESTSUITE/aux-fixed/sqlitedb; select * from them where id='10.0.0.0'"? no (end of list)
194 host in "+relay_hosts"? no (end of list)
195 accept: condition test failed in ACL "check_recipient"
196 processing "deny" (TESTSUITE/test-config 34)
197   message: relay not permitted
198 deny: condition test succeeded in ACL "check_recipient"
199 end of ACL "check_recipient": DENY
200 SMTP>> 550 relay not permitted
201 LOG: MAIN REJECT
202   H=(test) [10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
203 SMTP<< rcpt to:<c@d>
204 using ACL "check_recipient"
205 processing "accept" (TESTSUITE/test-config 32)
206 check domains = +local_domains
207 d in "@"? no (end of list)
208 d in "+local_domains"? no (end of list)
209 accept: condition test failed in ACL "check_recipient"
210 processing "accept" (TESTSUITE/test-config 33)
211 check hosts = +relay_hosts
212 search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
213   cached open
214 search_find: file="TESTSUITE/aux-fixed/sqlitedb"
215   key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0 opts="file=TESTSUITE/aux-fixed/sqlitedb"
216 LRU list:
217 internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
218   type=sqlite key="select * from them where id='10.0.0.0'" opts="file=TESTSUITE/aux-fixed/sqlitedb"
219 file lookup required for select * from them where id='10.0.0.0'
220   in TESTSUITE/aux-fixed/sqlitedb
221 lookup forced cache cleanup
222 lookup failed
223 host in "sqlite,file=TESTSUITE/aux-fixed/sqlitedb; select * from them where id='10.0.0.0'"? no (end of list)
224 host in "+relay_hosts"? no (end of list)
225 accept: condition test failed in ACL "check_recipient"
226 processing "deny" (TESTSUITE/test-config 34)
227   message: relay not permitted
228 deny: condition test succeeded in ACL "check_recipient"
229 end of ACL "check_recipient": DENY
230 SMTP>> 550 relay not permitted
231 LOG: MAIN REJECT
232   H=(test) [10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
233 SMTP<< quit
234 SMTP>> 221 myhost.test.ex closing connection
235 LOG: smtp_connection MAIN
236   SMTP connection from (test) [10.0.0.0] closed by QUIT
237 search_tidyup called
238 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
239 Exim version x.yz ....
240 changed uid/gid: forcing real = effective
241   uid=uuuu gid=CALLER_GID pid=pppp
242 configuration file is TESTSUITE/test-config
243 admin user
244 changed uid/gid: privilege not needed
245   uid=EXIM_UID gid=EXIM_GID pid=pppp
246 seeking password data for user "CALLER": cache not available
247 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
248 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
249 sender address = CALLER@myhost.test.ex
250 sender_fullhost = [10.0.0.0]
251 sender_rcvhost = [10.0.0.0]
252 host in hosts_connection_nolog? no (option unset)
253 LOG: smtp_connection MAIN
254   SMTP connection from [10.0.0.0]
255 host in host_lookup? no (option unset)
256 set_process_info: pppp handling incoming connection from [10.0.0.0]
257 host in host_reject_connection? no (option unset)
258 host in sender_unqualified_hosts? no (option unset)
259 host in recipient_unqualified_hosts? no (option unset)
260 host in helo_verify_hosts? no (option unset)
261 host in helo_try_verify_hosts? no (option unset)
262 host in helo_accept_junk_hosts? no (option unset)
263 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
264 smtp_setup_msg entered
265 SMTP<< helo test
266 test in helo_lookup_domains? no (end of list)
267 sender_fullhost = (test) [10.0.0.0]
268 sender_rcvhost = [10.0.0.0] (helo=test)
269 set_process_info: pppp handling incoming connection from (test) [10.0.0.0]
270 SMTP>> 250 myhost.test.ex Hello test [10.0.0.0]
271 SMTP<< mail from:<a@b>
272 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
273 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
274 SMTP>> 250 OK
275 SMTP<< rcpt to:<c@d>
276 using ACL "check_recipient"
277 processing "accept" (TESTSUITE/test-config 32)
278 check domains = +local_domains
279 d in "@"? no (end of list)
280 d in "+local_domains"? no (end of list)
281 accept: condition test failed in ACL "check_recipient"
282 processing "accept" (TESTSUITE/test-config 33)
283 check hosts = +relay_hosts
284 search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
285 search_find: file="TESTSUITE/aux-fixed/sqlitedb"
286   key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0 opts=NULL
287 LRU list:
288 internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
289   type=sqlite key="select * from them where id='10.0.0.0'" opts=NULL
290 file lookup required for select * from them where id='10.0.0.0'
291   in TESTSUITE/aux-fixed/sqlitedb
292 lookup forced cache cleanup
293 lookup failed
294 host in "sqlite;TESTSUITE/aux-fixed/sqlitedb select * from them where id='10.0.0.0'"? no (end of list)
295 host in "+relay_hosts"? no (end of list)
296 accept: condition test failed in ACL "check_recipient"
297 processing "deny" (TESTSUITE/test-config 34)
298   message: relay not permitted
299 deny: condition test succeeded in ACL "check_recipient"
300 end of ACL "check_recipient": DENY
301 SMTP>> 550 relay not permitted
302 LOG: MAIN REJECT
303   H=(test) [10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
304 SMTP<< rcpt to:<c@d>
305 using ACL "check_recipient"
306 processing "accept" (TESTSUITE/test-config 32)
307 check domains = +local_domains
308 d in "@"? no (end of list)
309 d in "+local_domains"? no (end of list)
310 accept: condition test failed in ACL "check_recipient"
311 processing "accept" (TESTSUITE/test-config 33)
312 check hosts = +relay_hosts
313 search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
314   cached open
315 search_find: file="TESTSUITE/aux-fixed/sqlitedb"
316   key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0 opts=NULL
317 LRU list:
318 internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
319   type=sqlite key="select * from them where id='10.0.0.0'" opts=NULL
320 file lookup required for select * from them where id='10.0.0.0'
321   in TESTSUITE/aux-fixed/sqlitedb
322 lookup forced cache cleanup
323 lookup failed
324 host in "sqlite;TESTSUITE/aux-fixed/sqlitedb select * from them where id='10.0.0.0'"? no (end of list)
325 host in "+relay_hosts"? no (end of list)
326 accept: condition test failed in ACL "check_recipient"
327 processing "deny" (TESTSUITE/test-config 34)
328   message: relay not permitted
329 deny: condition test succeeded in ACL "check_recipient"
330 end of ACL "check_recipient": DENY
331 SMTP>> 550 relay not permitted
332 LOG: MAIN REJECT
333   H=(test) [10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
334 SMTP<< quit
335 SMTP>> 221 myhost.test.ex closing connection
336 LOG: smtp_connection MAIN
337   SMTP connection from (test) [10.0.0.0] closed by QUIT
338 search_tidyup called
339 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
340 Exim version x.yz ....
341 changed uid/gid: forcing real = effective
342   uid=uuuu gid=CALLER_GID pid=pppp
343 configuration file is TESTSUITE/test-config
344 admin user
345 changed uid/gid: privilege not needed
346   uid=EXIM_UID gid=EXIM_GID pid=pppp
347 seeking password data for user "CALLER": cache not available
348 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
349 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
350 sender address = CALLER@myhost.test.ex
351 sender_fullhost = [10.10.10.10]
352 sender_rcvhost = [10.10.10.10]
353 host in hosts_connection_nolog? no (option unset)
354 LOG: smtp_connection MAIN
355   SMTP connection from [10.10.10.10]
356 host in host_lookup? no (option unset)
357 set_process_info: pppp handling incoming connection from [10.10.10.10]
358 host in host_reject_connection? no (option unset)
359 host in sender_unqualified_hosts? no (option unset)
360 host in recipient_unqualified_hosts? no (option unset)
361 host in helo_verify_hosts? no (option unset)
362 host in helo_try_verify_hosts? no (option unset)
363 host in helo_accept_junk_hosts? no (option unset)
364 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
365 smtp_setup_msg entered
366 SMTP<< helo test
367 test in helo_lookup_domains? no (end of list)
368 sender_fullhost = (test) [10.10.10.10]
369 sender_rcvhost = [10.10.10.10] (helo=test)
370 set_process_info: pppp handling incoming connection from (test) [10.10.10.10]
371 SMTP>> 250 myhost.test.ex Hello test [10.10.10.10]
372 SMTP<< mail from:<a@b>
373 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
374 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
375 SMTP>> 250 OK
376 SMTP<< rcpt to:<c@d>
377 using ACL "check_recipient"
378 processing "accept" (TESTSUITE/test-config 32)
379 check domains = +local_domains
380 d in "@"? no (end of list)
381 d in "+local_domains"? no (end of list)
382 accept: condition test failed in ACL "check_recipient"
383 processing "accept" (TESTSUITE/test-config 33)
384 check hosts = +relay_hosts
385 search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
386 search_find: file="TESTSUITE/aux-fixed/sqlitedb"
387   key="select * from them where id='10.10.10.10'" partial=-1 affix=NULL starflags=0 opts=NULL
388 LRU list:
389 internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
390   type=sqlite key="select * from them where id='10.10.10.10'" opts=NULL
391 file lookup required for select * from them where id='10.10.10.10'
392   in TESTSUITE/aux-fixed/sqlitedb
393 creating new cache entry
394 lookup yielded: name=ok id=10.10.10.10 
395 host in "sqlite;TESTSUITE/aux-fixed/sqlitedb select * from them where id='10.10.10.10'"? yes (matched "sqlite;TESTSUITE/aux-fixed/sqlitedb select * from them where id='10.10.10.10'")
396 host in "+relay_hosts"? yes (matched "+relay_hosts")
397 accept: condition test succeeded in ACL "check_recipient"
398 end of ACL "check_recipient": ACCEPT
399 SMTP>> 250 Accepted
400 SMTP<< rcpt to:<c@d>
401 using ACL "check_recipient"
402 processing "accept" (TESTSUITE/test-config 32)
403 check domains = +local_domains
404 d in "@"? no (end of list)
405 d in "+local_domains"? no (end of list)
406 accept: condition test failed in ACL "check_recipient"
407 processing "accept" (TESTSUITE/test-config 33)
408 check hosts = +relay_hosts
409 search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
410   cached open
411 search_find: file="TESTSUITE/aux-fixed/sqlitedb"
412   key="select * from them where id='10.10.10.10'" partial=-1 affix=NULL starflags=0 opts=NULL
413 LRU list:
414 internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
415   type=sqlite key="select * from them where id='10.10.10.10'" opts=NULL
416 cached data used for lookup of select * from them where id='10.10.10.10'
417   in TESTSUITE/aux-fixed/sqlitedb
418 lookup yielded: name=ok id=10.10.10.10 
419 host in "sqlite;TESTSUITE/aux-fixed/sqlitedb select * from them where id='10.10.10.10'"? yes (matched "sqlite;TESTSUITE/aux-fixed/sqlitedb select * from them where id='10.10.10.10'")
420 host in "+relay_hosts"? yes (matched "+relay_hosts")
421 accept: condition test succeeded in ACL "check_recipient"
422 end of ACL "check_recipient": ACCEPT
423 SMTP>> 250 Accepted
424 SMTP<< quit
425 SMTP>> 221 myhost.test.ex closing connection
426 LOG: smtp_connection MAIN
427   SMTP connection from (test) [10.10.10.10] closed by QUIT
428 search_tidyup called
429 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
430 Exim version x.yz ....
431 changed uid/gid: forcing real = effective
432   uid=uuuu gid=CALLER_GID pid=pppp
433 configuration file is TESTSUITE/test-config
434 admin user
435 changed uid/gid: privilege not needed
436   uid=EXIM_UID gid=EXIM_GID pid=pppp
437 seeking password data for user "CALLER": cache not available
438 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
439 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
440 sender address = CALLER@myhost.test.ex
441 set_process_info: pppp accepting a local non-SMTP message from <CALLER@myhost.test.ex>
442 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
443 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
444 Sender: CALLER@myhost.test.ex
445 Recipients:
446   userx
447 search_tidyup called
448 >>Headers received:
449
450 rewrite_one_header: type=F:
451   From: CALLER_NAME <CALLER@myhost.test.ex>
452 search_tidyup called
453 >>Headers after rewriting and local additions:
454 I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex>
455 F From: CALLER_NAME <CALLER@myhost.test.ex>
456   Date: Tue, 2 Mar 1999 09:44:33 +0000
457
458 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
459 Data file written for message 10HmaX-0005vi-00
460 >>Generated Received: header line
461 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
462         (envelope-from <CALLER@myhost.test.ex>)
463         id 10HmaX-0005vi-00
464         for userx@myhost.test.ex;
465         Tue, 2 Mar 1999 09:44:33 +0000
466 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00
467 DSN: **** SPOOL_OUT - address: <userx@myhost.test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
468 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
469 Size of headers = sss
470 LOG: MAIN
471   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
472 created log directory TESTSUITE/spool/log
473 search_tidyup called
474 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -DOPT=y -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-0005vi-00
475 Exim version x.yz ....
476 changed uid/gid: forcing real = effective
477   uid=uuuu gid=EXIM_GID pid=pppp
478 configuration file is TESTSUITE/test-config
479 trusted user
480 admin user
481 dropping to exim gid; retaining priv uid
482 seeking password data for user "CALLER": cache not available
483 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
484 set_process_info: pppp delivering specified messages
485 set_process_info: pppp delivering 10HmaX-0005vi-00
486 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
487 reading spool file 10HmaX-0005vi-00-H
488 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@myhost.test.ex
489 sender_local=1 ident=CALLER
490 Non-recipients:
491  Empty Tree
492 ---- End of tree ----
493 recipients_count=1
494 **** SPOOL_IN - No additional fields
495 body_linecount=1 message_linecount=8
496 DSN: set orcpt:   flags: 0x0
497 Delivery address list:
498   userx@myhost.test.ex 
499  locking TESTSUITE/spool/db/retry.lockfile
500  locked  TESTSUITE/spool/db/retry.lockfile
501  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
502  returned from EXIM_DBOPEN: (nil)
503  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
504 no retry data available
505 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
506 Considering: userx@myhost.test.ex
507 unique = userx@myhost.test.ex
508 no   domain  retry record
509 no   address retry record
510 userx@myhost.test.ex: queued for routing
511 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
512 routing userx@myhost.test.ex
513 --------> r1 router <--------
514 local_part=userx domain=myhost.test.ex
515 processing address_data
516  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
517  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
518    key="select name from them where id='userx'" partial=-1 affix=NULL starflags=0 opts=NULL
519  LRU list:
520  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
521    type=sqlite key="select name from them where id='userx'" opts=NULL
522  file lookup required for select name from them where id='userx'
523    in TESTSUITE/aux-fixed/sqlitedb
524  creating new cache entry
525  lookup yielded: Ayen Other
526 calling r1 router
527 r1 router called for userx@myhost.test.ex
528   domain = myhost.test.ex
529 set transport t1
530 queued for t1 transport: local_part = userx
531 domain = myhost.test.ex
532   errors_to=NULL
533   domain_data=NULL local_part_data=NULL
534 routed by r1 router
535   envelope to: userx@myhost.test.ex
536   transport: t1
537 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
538 After routing:
539   Local deliveries:
540     userx@myhost.test.ex
541   Remote deliveries:
542   Failed addresses:
543   Deferred addresses:
544 search_tidyup called
545 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
546 --------> userx@myhost.test.ex <--------
547  locking TESTSUITE/spool/db/retry.lockfile
548  locked  TESTSUITE/spool/db/retry.lockfile
549  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
550  returned from EXIM_DBOPEN: (nil)
551  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
552 no retry data available
553 search_tidyup called
554 changed uid/gid: local delivery to userx <userx@myhost.test.ex> transport=t1
555   uid=CALLER_UID gid=CALLER_GID pid=pppp
556   home=NULL current=/
557 set_process_info: pppp delivering 10HmaX-0005vi-00 to userx using t1
558 appendfile transport entered
559  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
560  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
561    key="select id from them where id='userx'" partial=-1 affix=NULL starflags=0 opts=NULL
562  LRU list:
563  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
564    type=sqlite key="select id from them where id='userx'" opts=NULL
565  file lookup required for select id from them where id='userx'
566    in TESTSUITE/aux-fixed/sqlitedb
567  creating new cache entry
568  lookup yielded: userx
569 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
570   file=TESTSUITE/test-mail/userx format=unix
571   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
572   message_suffix=\n
573   maildir_use_size_file=no
574   locking by lockfile fcntl 
575 lock name: TESTSUITE/test-mail/userx.lock
576 hitch name: TESTSUITE/test-mail/userx.lock.test.ex.dddddddd.pppppppp
577 lock file created
578 mailbox TESTSUITE/test-mail/userx is locked
579 writing to file TESTSUITE/test-mail/userx
580 writing data block fd=dddd size=sss timeout=0
581 cannot use sendfile for body: spoolfile not wireformat
582 writing data block fd=dddd size=sss timeout=0
583 writing data block fd=dddd size=sss timeout=0
584 appendfile yields 0 with errno=dd more_errno=dd
585 search_tidyup called
586 journalling userx@myhost.test.ex
587 t1 transport returned OK for userx@myhost.test.ex
588 post-process userx@myhost.test.ex (0)
589 userx@myhost.test.ex delivered
590 LOG: MAIN
591   => userx <userx@myhost.test.ex> R=r1 T=t1
592 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
593 changed uid/gid: post-delivery tidying
594   uid=EXIM_UID gid=EXIM_GID pid=pppp
595 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
596 Processing retry items
597 Succeeded addresses:
598  userx@myhost.test.ex: no retry items
599 Failed addresses:
600 Deferred addresses:
601 end of retry processing
602 DSN: processing router : r1
603 DSN: processing successful delivery address: userx@myhost.test.ex
604 DSN: Sender_address: CALLER@myhost.test.ex
605 DSN: orcpt: NULL  flags: 0x0
606 DSN: envid: NULL  ret: 0
607 DSN: Final recipient: userx@myhost.test.ex
608 DSN: Remote SMTP server supports DSN: 0
609 DSN: not sending DSN success message
610 LOG: MAIN
611   Completed
612 end delivery of 10HmaX-0005vi-00
613 search_tidyup called
614 search_tidyup called
615 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
616 search_tidyup called
617 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
618 Exim version x.yz ....
619 configuration file is TESTSUITE/test-config
620 admin user
621 dropping to exim gid; retaining priv uid
622  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
623  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
624    key="select name from them where id='userx';" partial=-1 affix=NULL starflags=0 opts=NULL
625  LRU list:
626  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
627    type=sqlite key="select name from them where id='userx';" opts=NULL
628  file lookup required for select name from them where id='userx';
629    in TESTSUITE/aux-fixed/sqlitedb
630  creating new cache entry
631  lookup yielded: Ayen Other
632 search_tidyup called
633 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
634 Exim version x.yz ....
635 configuration file is TESTSUITE/test-config
636 admin user
637 dropping to exim gid; retaining priv uid
638  search_open: sqlite "NULL"
639  Using sqlite_dbfile: TESTSUITE/aux-fixed/sqlitedb
640  search_find: file="NULL"
641    key="select name from them where id='userx';" partial=-1 affix=NULL starflags=0 opts=NULL
642  LRU list:
643  internal_search_find: file="NULL"
644    type=sqlite key="select name from them where id='userx';" opts=NULL
645  database lookup required for select name from them where id='userx';
646  creating new cache entry
647  lookup yielded: Ayen Other
648 search_tidyup called
649 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
650 Exim version x.yz ....
651 configuration file is TESTSUITE/test-config
652 admin user
653 dropping to exim gid; retaining priv uid
654  search_open: sqlite "NULL"
655  Using sqlite_dbfile: nonabsolute_filename
656 search_tidyup called
657 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
658 Exim version x.yz ....
659 configuration file is TESTSUITE/test-config
660 admin user
661 dropping to exim gid; retaining priv uid
662  search_open: sqlite "NULL"
663  Using sqlite_dbfile: TESTSUITE/missingfile
664  search_find: file="NULL"
665    key="select name from them where id='userx';" partial=-1 affix=NULL starflags=0 opts=NULL
666  LRU list:
667  internal_search_find: file="NULL"
668    type=sqlite key="select name from them where id='userx';" opts=NULL
669  database lookup required for select name from them where id='userx';
670  sqlite3_exec failed: no such table: them
671  creating new cache entry
672  lookup failed
673 search_tidyup called
674 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>