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