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