2 ### wait for db startup, set password on the root user
3 ### create testdb and extra users
5 configuration file is TESTSUITE/test-config
7 dropping to exim gid; retaining priv uid
8 search_open: mysql "NULL"
9 search_find: file="NULL"
10 key="select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
12 internal_search_find: file="NULL"
13 type=mysql key="select name from them where id='ph10';" opts=NULL
14 database lookup required for select name from them where id='ph10';
15 MySQL query: "select name from them where id='ph10';" opts 'NULL'
16 MYSQL new connection: host=127.0.0.1 port=PORT_N socket=NULL database=test user=root
17 creating new cache entry
18 lookup yielded: Philip Hazel
19 search_open: mysql "NULL"
21 search_find: file="NULL"
22 key="select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
24 internal_search_find: file="NULL"
25 type=mysql 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: mysql "NULL"
30 search_find: file="NULL"
31 key="select name from them where id='xxxx';" partial=-1 affix=NULL starflags=0 opts=NULL
33 internal_search_find: file="NULL"
34 type=mysql key="select name from them where id='xxxx';" opts=NULL
35 database lookup required for select name from them where id='xxxx';
36 MySQL query: "select name from them where id='xxxx';" opts 'NULL'
37 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
39 creating new cache entry
41 search_open: mysql "NULL"
43 search_find: file="NULL"
44 key="select name from them where id='nothing';" partial=-1 affix=NULL starflags=0 opts=NULL
46 internal_search_find: file="NULL"
47 type=mysql key="select name from them where id='nothing';" opts=NULL
48 database lookup required for select name from them where id='nothing';
49 MySQL query: "select name from them where id='nothing';" opts 'NULL'
50 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
51 creating new cache entry
53 search_open: mysql "NULL"
55 search_find: file="NULL"
56 key="select id,name from them where id='nothing';" partial=-1 affix=NULL starflags=0 opts=NULL
58 internal_search_find: file="NULL"
59 type=mysql key="select id,name from them where id='nothing';" opts=NULL
60 database lookup required for select id,name from them where id='nothing';
61 MySQL query: "select id,name from them where id='nothing';" opts 'NULL'
62 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
63 creating new cache entry
64 lookup yielded: id=nothing name=""
65 search_open: mysql "NULL"
67 search_find: file="NULL"
68 key="delete from them where id='nonexist';" partial=-1 affix=NULL starflags=0 opts=NULL
70 internal_search_find: file="NULL"
71 type=mysql key="delete from them where id='nonexist';" opts=NULL
72 database lookup required for delete from them where id='nonexist';
73 MySQL query: "delete from them where id='nonexist';" opts 'NULL'
74 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
75 MYSQL: query was not one that returns data
76 lookup forced cache cleanup
78 search_open: mysql "NULL"
80 search_find: file="NULL"
81 key="select * from them where id='quote';" partial=-1 affix=NULL starflags=0 opts=NULL
83 internal_search_find: file="NULL"
84 type=mysql key="select * from them where id='quote';" opts=NULL
85 database lookup required for select * from them where id='quote';
86 MySQL query: "select * from them where id='quote';" opts 'NULL'
87 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
89 creating new cache entry
91 search_open: mysql "NULL"
93 search_find: file="NULL"
94 key="select * from them where id='filter';" partial=-1 affix=NULL starflags=0 opts=NULL
96 internal_search_find: file="NULL"
97 type=mysql key="select * from them where id='filter';" opts=NULL
98 database lookup required for select * from them where id='filter';
99 MySQL query: "select * from them where id='filter';" opts 'NULL'
100 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
102 creating new cache entry
104 search_open: mysql "NULL"
106 search_find: file="NULL"
107 key="select * from them where id='quote2';" partial=-1 affix=NULL starflags=0 opts=NULL
109 internal_search_find: file="NULL"
110 type=mysql key="select * from them where id='quote2';" opts=NULL
111 database lookup required for select * from them where id='quote2';
112 MySQL query: "select * from them where id='quote2';" opts 'NULL'
113 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
114 creating new cache entry
115 lookup yielded: name="\"stquot" id=quote2
116 search_open: mysql "NULL"
118 search_find: file="NULL"
119 key="select * from them where id='nlonly';" partial=-1 affix=NULL starflags=0 opts=NULL
121 internal_search_find: file="NULL"
122 type=mysql key="select * from them where id='nlonly';" opts=NULL
123 database lookup required for select * from them where id='nlonly';
124 MySQL query: "select * from them where id='nlonly';" opts 'NULL'
125 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
127 creating new cache entry
129 search_open: mysql "NULL"
131 search_find: file="NULL"
132 key="servers=x:127.0.0.1::PORT_N; select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
134 internal_search_find: file="NULL"
135 type=mysql key="servers=x:127.0.0.1::PORT_N; select name from them where id='ph10';" opts=NULL
136 database lookup required for servers=x:127.0.0.1::PORT_N; select name from them where id='ph10';
137 MySQL query: "servers=x:127.0.0.1::PORT_N; select name from them where id='ph10';" opts 'NULL'
138 lookup deferred: MySQL server "x" not found in mysql_servers
139 search_open: mysql "NULL"
141 search_find: file="NULL"
142 key="servers=127.0.0.1::PORT_N:x; select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
144 internal_search_find: file="NULL"
145 type=mysql key="servers=127.0.0.1::PORT_N:x; select name from them where id='ph10';" opts=NULL
146 database lookup required for servers=127.0.0.1::PORT_N:x; select name from them where id='ph10';
147 MySQL query: "servers=127.0.0.1::PORT_N:x; select name from them where id='ph10';" opts 'NULL'
148 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
149 creating new cache entry
150 lookup yielded: Philip Hazel
151 search_open: mysql "NULL"
153 search_find: file="NULL"
154 key="servers=127.0.0.1::PORT_N/test/root/:x; select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
156 internal_search_find: file="NULL"
157 type=mysql key="servers=127.0.0.1::PORT_N/test/root/:x; select name from them where id='ph10';" opts=NULL
158 database lookup required for servers=127.0.0.1::PORT_N/test/root/:x; select name from them where id='ph10';
159 MySQL query: "servers=127.0.0.1::PORT_N/test/root/:x; select name from them where id='ph10';" opts 'NULL'
160 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
161 creating new cache entry
162 lookup yielded: Philip Hazel
163 search_open: mysql "NULL"
165 search_find: file="NULL"
166 key="servers=ip4.ip4.ip4.ip4::1223/test/root/:127.0.0.1::PORT_N; select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
168 internal_search_find: file="NULL"
169 type=mysql key="servers=ip4.ip4.ip4.ip4::1223/test/root/:127.0.0.1::PORT_N; select name from them where id='ph10';" opts=NULL
170 database lookup required for servers=ip4.ip4.ip4.ip4::1223/test/root/:127.0.0.1::PORT_N; select name from them where id='ph10';
171 MySQL query: "servers=ip4.ip4.ip4.ip4::1223/test/root/:127.0.0.1::PORT_N; select name from them where id='ph10';" opts 'NULL'
172 MYSQL new connection: host=ip4.ip4.ip4.ip4 port=PORT_N socket=NULL database=test user=root
173 creating new cache entry
174 lookup yielded: Philip Hazel
175 search_open: mysql "NULL"
177 search_find: file="NULL"
178 key="servers=localhost(TESTSUITE/mysql/sock)/test/root/pass; select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
180 internal_search_find: file="NULL"
181 type=mysql key="servers=localhost(TESTSUITE/mysql/sock)/test/root/pass; select name from them where id='ph10';" opts=NULL
182 database lookup required for servers=localhost(TESTSUITE/mysql/sock)/test/root/pass; select name from them where id='ph10';
183 MySQL query: "servers=localhost(TESTSUITE/mysql/sock)/test/root/pass; select name from them where id='ph10';" opts 'NULL'
184 MYSQL new connection: host=localhost port=0 socket=TESTSUITE/mysql/sock database=test user=root
185 creating new cache entry
186 lookup yielded: Philip Hazel
187 search_open: mysql "NULL"
189 search_find: file="NULL"
190 key="SELECT name FROM them WHERE id IN ('ph10', 'aaaa');" partial=-1 affix=NULL starflags=0 opts=NULL
192 internal_search_find: file="NULL"
193 type=mysql key="SELECT name FROM them WHERE id IN ('ph10', 'aaaa');" opts=NULL
194 database lookup required for SELECT name FROM them WHERE id IN ('ph10', 'aaaa');
195 MySQL query: "SELECT name FROM them WHERE id IN ('ph10', 'aaaa');" opts 'NULL'
196 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
197 creating new cache entry
198 lookup yielded: Philip Hazel
200 search_open: mysql "NULL"
202 search_find: file="NULL"
203 key="SELECT * FROM them WHERE id IN ('ph10', 'aaaa');" partial=-1 affix=NULL starflags=0 opts=NULL
205 internal_search_find: file="NULL"
206 type=mysql key="SELECT * FROM them WHERE id IN ('ph10', 'aaaa');" opts=NULL
207 database lookup required for SELECT * FROM them WHERE id IN ('ph10', 'aaaa');
208 MySQL query: "SELECT * FROM them WHERE id IN ('ph10', 'aaaa');" opts 'NULL'
209 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
210 creating new cache entry
211 lookup yielded: name="Philip Hazel" id=ph10
212 name=Aristotle id=aaaa
213 search_open: mysql "NULL"
215 search_find: file="NULL"
216 key="delete from them where id='aaaa'" partial=-1 affix=NULL starflags=0 opts=NULL
218 internal_search_find: file="NULL"
219 type=mysql key="delete from them where id='aaaa'" opts=NULL
220 database lookup required for delete from them where id='aaaa'
221 MySQL query: "delete from them where id='aaaa'" opts 'NULL'
222 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
223 MYSQL: query was not one that returns data
224 lookup forced cache cleanup
227 close MYSQL connection: localhost(TESTSUITE/mysql/sock)/test/root
228 close MYSQL connection: ip4.ip4.ip4.ip4:1223/test/root
229 close MYSQL connection: 127.0.0.1:PORT_N/test/root
230 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
231 Exim version x.yz ....
232 changed uid/gid: forcing real = effective
233 uid=uuuu gid=CALLER_GID pid=p1235
234 configuration file is TESTSUITE/test-config
236 changed uid/gid: privilege not needed
237 uid=EXIM_UID gid=EXIM_GID pid=p1235
238 seeking password data for user "CALLER": cache not available
239 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
240 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
241 sender address = CALLER@myhost.test.ex
242 sender_fullhost = [10.0.0.0]
243 sender_rcvhost = [10.0.0.0]
244 host in hosts_connection_nolog? no (option unset)
245 LOG: smtp_connection MAIN
246 SMTP connection from [10.0.0.0]
247 host in host_lookup? no (option unset)
248 set_process_info: pppp handling incoming connection from [10.0.0.0]
249 host in host_reject_connection? no (option unset)
250 host in sender_unqualified_hosts? no (option unset)
251 host in recipient_unqualified_hosts? no (option unset)
252 host in helo_verify_hosts? no (option unset)
253 host in helo_try_verify_hosts? no (option unset)
254 host in helo_accept_junk_hosts? no (option unset)
255 host in pipelining_connect_advertise_hosts?
257 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
258 smtp_setup_msg entered
260 test in helo_lookup_domains?
263 test in helo_lookup_domains? no (end of list)
264 sender_fullhost = (test) [10.0.0.0]
265 sender_rcvhost = [10.0.0.0] (helo=test)
266 set_process_info: pppp handling incoming connection from (test) [10.0.0.0]
267 SMTP>> 250 myhost.test.ex Hello test [10.0.0.0]
268 SMTP<< mail from:<a@b>
269 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
270 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
273 using ACL "check_recipient"
274 processing "warn" (TESTSUITE/test-config 26)
275 search_open: mysql "NULL"
276 search_find: file="NULL"
277 key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts=NULL
279 internal_search_find: file="NULL"
280 type=mysql key="select name from them where id = 'c'" opts=NULL
281 database lookup required for select name from them where id = 'c'
282 (tainted, quoted:mysql)
283 MySQL query: "select name from them where id = 'c'" opts 'NULL'
284 MYSQL new connection: host=127.0.0.1 port=PORT_N socket=NULL database=test user=root
286 creating new cache entry
288 check set acl_m0 = ok: ${lookup mysql {select name from them where id = '${quote_mysql:$local_part}'}}
290 search_open: mysql "NULL"
292 search_find: file="NULL"
293 key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="no_rd"
295 internal_search_find: file="NULL"
296 type=mysql key="select name from them where id = 'c'" opts="no_rd"
297 cached data found but wrong opts; database lookup required for select name from them where id = 'c'
300 tainted search query is not properly quoted (ACL warn, TESTSUITE/test-config 26): select name from them where id = 'c'
301 search_type NN (mysql) quoting -1 (none)
302 MySQL query: "select name from them where id = 'c'" opts 'no_rd'
303 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
305 replacing old cache entry
307 check set acl_m0 = FAIL: ${lookup mysql,no_rd {select name from them where id = '$local_part'}}
309 warn: condition test succeeded in ACL "check_recipient"
310 processing "warn" (TESTSUITE/test-config 31)
311 search_open: mysql "NULL"
313 search_find: file="NULL"
314 key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=127.0.0.1::PORT_N/test/root/pass"
316 internal_search_find: file="NULL"
317 type=mysql key="select name from them where id = 'c'" opts="servers=127.0.0.1::PORT_N/test/root/pass"
318 cached data found but wrong opts; database lookup required for select name from them where id = 'c'
319 (tainted, quoted:mysql)
320 MySQL query: "select name from them where id = 'c'" opts 'servers=127.0.0.1::PORT_N/test/root/pass'
321 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
323 replacing old cache entry
325 check set acl_m0 = ok: ${lookup mysql,servers=127.0.0.1::PORT_N/test/root/pass {select name from them where id = '${quote_mysql:$local_part}'}}
327 search_open: mysql "NULL"
329 search_find: file="NULL"
330 key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=127.0.0.1::PORT_N"
332 internal_search_find: file="NULL"
333 type=mysql key="select name from them where id = 'c'" opts="servers=127.0.0.1::PORT_N"
334 cached data found but wrong opts; database lookup required for select name from them where id = 'c'
335 (tainted, quoted:mysql)
336 MySQL query: "select name from them where id = 'c'" opts 'servers=127.0.0.1::PORT_N'
337 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
339 replacing old cache entry
341 check set acl_m0 = ok: ${lookup mysql,servers=127.0.0.1::PORT_N {select name from them where id = '${quote_mysql:$local_part}'}}
343 search_open: mysql "NULL"
345 search_find: file="NULL"
346 key="servers=127.0.0.1::PORT_N/test/root/pass; select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts=NULL
348 internal_search_find: file="NULL"
349 type=mysql key="servers=127.0.0.1::PORT_N/test/root/pass; select name from them where id = 'c'" opts=NULL
350 database lookup required for servers=127.0.0.1::PORT_N/test/root/pass; select name from them where id = 'c'
351 (tainted, quoted:mysql)
352 MySQL query: "servers=127.0.0.1::PORT_N/test/root/pass; select name from them where id = 'c'" opts 'NULL'
353 lookup deferred: MySQL server "127.0.0.1:PORT_N/test/root/pass" is tainted
354 warn: condition test deferred in ACL "check_recipient"
356 H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: MySQL server "127.0.0.1:PORT_N/test/root/pass" is tainted
357 processing "warn" (TESTSUITE/test-config 40)
358 check set acl_m0 = ok: hostlist
359 check hosts = net-mysql;select * from them where id='${quote_mysql:$local_part}'
360 host in "net-mysql;select * from them where id='c'"?
361 list element: net-mysql;select * from them where id='c'
362 search_open: mysql "NULL"
364 search_find: file="NULL"
365 key="select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
367 internal_search_find: file="NULL"
368 type=mysql key="select * from them where id='c'" opts=NULL
369 database lookup required for select * from them where id='c'
370 (tainted, quoted:mysql)
371 MySQL query: "select * from them where id='c'" opts 'NULL'
372 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
374 creating new cache entry
376 host in "net-mysql;select * from them where id='c'"? no (end of list)
377 warn: condition test failed in ACL "check_recipient"
378 processing "warn" (TESTSUITE/test-config 43)
379 check set acl_m0 = FAIL: hostlist
380 check hosts = <& net-mysql;servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='${quote_mysql:$local_part}'
381 host in "<& net-mysql;servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'"?
382 list element: net-mysql;servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'
383 search_open: mysql "NULL"
385 search_find: file="NULL"
386 key="servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
388 internal_search_find: file="NULL"
389 type=mysql key="servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'" opts=NULL
390 database lookup required for servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'
391 (tainted, quoted:mysql)
392 MySQL query: "servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'" opts 'NULL'
393 lookup deferred: MySQL server "127.0.0.1:PORT_N/test/root/pass" is tainted
394 host in "<& net-mysql;servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'"? list match deferred for net-mysql;servers=127.0.0.1::1223/test/root/pass; select * from them where id='c'
395 warn: condition test deferred in ACL "check_recipient"
397 H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: MySQL server "127.0.0.1:PORT_N/test/root/pass" is tainted
398 processing "warn" (TESTSUITE/test-config 48)
399 check set acl_m0 = FAIL: hostlist
400 check hosts = <& net-mysql,servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='${quote_mysql:$local_part}'
401 host in "<& net-mysql,servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'"?
402 list element: net-mysql,servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'
403 search_open: mysql "NULL"
405 search_find: file="NULL"
406 key=" select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts="servers=127.0.0.1::PORT_N/test/root/pass"
408 internal_search_find: file="NULL"
409 type=mysql key=" select * from them where id='c'" opts="servers=127.0.0.1::PORT_N/test/root/pass"
410 database lookup required for select * from them where id='c'
411 (tainted, quoted:mysql)
412 MySQL query: " select * from them where id='c'" opts 'servers=127.0.0.1::PORT_N/test/root/pass'
413 lookup deferred: MySQL server "127.0.0.1:PORT_N/test/root/pass" is tainted
414 host in "<& net-mysql,servers=127.0.0.1::PORT_N/test/root/pass; select * from them where id='c'"? list match deferred for net-mysql,servers=127.0.0.1::1223/test/root/pass; select * from them where id='c'
415 warn: condition test deferred in ACL "check_recipient"
417 H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: MySQL server "127.0.0.1:PORT_N/test/root/pass" is tainted
418 processing "accept" (TESTSUITE/test-config 51)
419 check domains = +local_domains
420 d in "+local_domains"?
421 list element: +local_domains
422 start sublist local_domains
425 d in "@"? no (end of list)
426 end sublist local_domains
427 d in "+local_domains"? no (end of list)
428 accept: condition test failed in ACL "check_recipient"
429 processing "accept" (TESTSUITE/test-config 54)
430 check hosts = +relay_hosts
431 host in "+relay_hosts"?
432 list element: +relay_hosts
433 start sublist relay_hosts
434 host in "net-mysql;select * from them where id='10.0.0.0'"?
435 ╎list element: net-mysql;select * from them where id='10.0.0.0'
436 ╎search_open: mysql "NULL"
438 ╎search_find: file="NULL"
439 ╎ key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0 opts=NULL
441 ╎internal_search_find: file="NULL"
442 ╎ type=mysql key="select * from them where id='10.0.0.0'" opts=NULL
443 ╎database lookup required for select * from them where id='10.0.0.0'
444 ╎MySQL query: "select * from them where id='10.0.0.0'" opts 'NULL'
445 ╎MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
446 ╎MYSQL: no data found
447 ╎creating new cache entry
449 host in "net-mysql;select * from them where id='10.0.0.0'"? no (end of list)
450 end sublist relay_hosts
451 host in "+relay_hosts"? no (end of list)
452 accept: condition test failed in ACL "check_recipient"
453 processing "deny" (TESTSUITE/test-config 55)
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
459 H=(test) [10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
461 SMTP>> 221 myhost.test.ex closing connection
462 LOG: smtp_connection MAIN
463 SMTP connection from (test) [10.0.0.0] closed by QUIT
465 close MYSQL connection: 127.0.0.1:PORT_N/test/root
466 >>>>>>>>>>>>>>>> Exim pid=p1235 (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=p1236
470 configuration file is TESTSUITE/test-config
472 changed uid/gid: privilege not needed
473 uid=EXIM_UID gid=EXIM_GID pid=p1236
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
487 qualify & rewrite recipients list
490 rewrite_one_header: type=F:
491 From: CALLER_NAME <CALLER@myhost.test.ex>
493 >>Headers after rewriting and local additions:
494 I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex>
495 F From: CALLER_NAME <CALLER@myhost.test.ex>
496 Date: Tue, 2 Mar 1999 09:44:33 +0000
498 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
499 Data file written for message 10HmaX-0005vi-00
500 >>Generated Received: header line
501 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
502 (envelope-from <CALLER@myhost.test.ex>)
504 for ph10@myhost.test.ex;
505 Tue, 2 Mar 1999 09:44:33 +0000
506 using ACL "check_notsmtp"
507 processing "accept" (TESTSUITE/test-config 58)
508 check set acl_m_qtest = ${quote_mysql:$recipients}
509 = ph10@myhost.test.ex
510 accept: condition test succeeded in ACL "check_notsmtp"
511 end of ACL "check_notsmtp": ACCEPT
512 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00
513 DSN: **** SPOOL_OUT - address: <ph10@myhost.test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
514 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
515 Size of headers = sss
517 <= CALLER@myhost.test.ex U=CALLER P=local S=sss
518 created log directory TESTSUITE/spool/log
520 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-0005vi-00
521 Exim version x.yz ....
522 changed uid/gid: forcing real = effective
523 uid=uuuu gid=EXIM_GID pid=p1237
524 configuration file is TESTSUITE/test-config
527 dropping to exim gid; retaining priv uid
528 seeking password data for user "CALLER": cache not available
529 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
530 set_process_info: pppp delivering specified messages
531 set_process_info: pppp delivering 10HmaX-0005vi-00
532 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
533 reading spool file 10HmaX-0005vi-00-H
534 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@myhost.test.ex
535 sender_local=1 ident=CALLER
538 ---- End of tree ----
540 **** SPOOL_IN - No additional fields
541 body_linecount=1 message_linecount=8
542 DSN: set orcpt: flags: 0x0
543 Delivery address list:
545 locking TESTSUITE/spool/db/retry.lockfile
546 locked TESTSUITE/spool/db/retry.lockfile
547 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
548 returned from EXIM_DBOPEN: (nil)
549 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
550 no retry data available
551 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
552 Considering: ph10@myhost.test.ex
553 unique = ph10@myhost.test.ex
554 no domain retry record
555 no address retry record
556 ph10@myhost.test.ex: queued for routing
557 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
558 routing ph10@myhost.test.ex
559 --------> r1 router <--------
560 local_part=ph10 domain=myhost.test.ex
561 search_open: mysql "NULL"
562 search_find: file="NULL"
563 key="select name from them where id='ph10@myhost.test.ex'" partial=-1 affix=NULL starflags=0 opts=NULL
565 internal_search_find: file="NULL"
566 type=mysql key="select name from them where id='ph10@myhost.test.ex'" opts=NULL
567 database lookup required for select name from them where id='ph10@myhost.test.ex'
568 (tainted, quoted:mysql)
569 MySQL query: "select name from them where id='ph10@myhost.test.ex'" opts 'NULL'
570 MYSQL new connection: host=127.0.0.1 port=PORT_N socket=NULL database=test user=root
572 creating new cache entry
574 acl_m_qtest: <ph10@myhost.test.ex> lkup: <>
575 processing address_data
576 search_open: mysql "NULL"
578 search_find: file="NULL"
579 key="select name from them where id='ph10'" partial=-1 affix=NULL starflags=0 opts=NULL
581 internal_search_find: file="NULL"
582 type=mysql key="select name from them where id='ph10'" opts=NULL
583 database lookup required for select name from them where id='ph10'
586 tainted search query is not properly quoted (router r1, TESTSUITE/test-config 66): select name from them where id='ph10'
587 search_type NN (mysql) quoting -1 (none)
588 MySQL query: "select name from them where id='ph10'" opts 'NULL'
589 MYSQL using cached connection for 127.0.0.1:PORT_N/test/root
590 creating new cache entry
591 lookup yielded: Philip Hazel
593 r1 router called for ph10@myhost.test.ex
594 domain = myhost.test.ex
596 queued for t1 transport: local_part = ph10
597 domain = myhost.test.ex
599 domain_data=NULL local_part_data=NULL
601 envelope to: ph10@myhost.test.ex
603 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
611 close MYSQL connection: 127.0.0.1:PORT_N/test/root
612 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
613 --------> ph10@myhost.test.ex <--------
614 locking TESTSUITE/spool/db/retry.lockfile
615 locked TESTSUITE/spool/db/retry.lockfile
616 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
617 returned from EXIM_DBOPEN: (nil)
618 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
619 no retry data available
621 changed uid/gid: local delivery to ph10 <ph10@myhost.test.ex> transport=t1
622 uid=CALLER_UID gid=CALLER_GID pid=p1238
624 set_process_info: pppp delivering 10HmaX-0005vi-00 to ph10 using t1
625 appendfile transport entered
626 search_open: mysql "NULL"
627 search_find: file="NULL"
628 key="select id from them where id='ph10'" partial=-1 affix=NULL starflags=0 opts=NULL
630 internal_search_find: file="NULL"
631 type=mysql key="select id from them where id='ph10'" opts=NULL
632 database lookup required for select id from them where id='ph10'
635 tainted search query is not properly quoted (transport t1, TESTSUITE/test-config 79): select id from them where id='ph10'
636 search_type NN (mysql) quoting -1 (none)
637 MySQL query: "select id from them where id='ph10'" opts 'NULL'
638 MYSQL new connection: host=127.0.0.1 port=PORT_N socket=NULL database=test user=root
639 creating new cache entry
641 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
642 file=TESTSUITE/test-mail/ph10 format=unix
643 message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
645 maildir_use_size_file=no
646 locking by lockfile fcntl
647 lock name: TESTSUITE/test-mail/ph10.lock
648 hitch name: TESTSUITE/test-mail/ph10.lock.test.ex.dddddddd.pppppppp
650 mailbox TESTSUITE/test-mail/ph10 is locked
651 writing to file TESTSUITE/test-mail/ph10
652 writing data block fd=dddd size=sss timeout=0
653 cannot use sendfile for body: spoolfile not wireformat
654 writing data block fd=dddd size=sss timeout=0
655 writing data block fd=dddd size=sss timeout=0
656 appendfile yields 0 with errno=dd more_errno=dd
658 close MYSQL connection: 127.0.0.1:PORT_N/test/root
659 journalling ph10@myhost.test.ex
660 t1 transport returned OK for ph10@myhost.test.ex
661 post-process ph10@myhost.test.ex (0)
662 ph10@myhost.test.ex delivered
664 => ph10 <ph10@myhost.test.ex> R=r1 T=t1
665 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
666 changed uid/gid: post-delivery tidying
667 uid=EXIM_UID gid=EXIM_GID pid=p1237
668 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
669 Processing retry items
671 ph10@myhost.test.ex: no retry items
674 end of retry processing
675 DSN: processing router : r1
676 DSN: processing successful delivery address: ph10@myhost.test.ex
677 DSN: Sender_address: CALLER@myhost.test.ex
678 DSN: orcpt: NULL flags: 0x0
679 DSN: envid: NULL ret: 0
680 DSN: Final recipient: ph10@myhost.test.ex
681 DSN: Remote SMTP server supports DSN: 0
682 DSN: not sending DSN success message
685 end delivery of 10HmaX-0005vi-00
688 >>>>>>>>>>>>>>>> Exim pid=p1237 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
690 >>>>>>>>>>>>>>>> Exim pid=p1236 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>