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