TLS: rework error logging to pass more string back to caller for logging
[exim.git] / test / stderr / 0139
1 >>> host in hosts_connection_nolog? no (option unset)
2 >>> host in host_lookup? no (option unset)
3 >>> host in host_reject_connection? no (option unset)
4 >>> host in sender_unqualified_hosts? no (option unset)
5 >>> host in recipient_unqualified_hosts? no (option unset)
6 >>> host in helo_verify_hosts? no (option unset)
7 >>> host in helo_try_verify_hosts? no (option unset)
8 >>> host in helo_accept_junk_hosts? no (option unset)
9 >>> using ACL "check_mail"
10 >>> processing "warn"
11 >>> check dnslists = rbl4.test.ex&0.0.0.6
12 >>> DNS list check: rbl4.test.ex&0.0.0.6
13 >>> new DNS lookup for 14.12.11.V4NET.rbl4.test.ex
14 >>> DNS lookup for 14.12.11.V4NET.rbl4.test.ex failed
15 >>> => that means V4NET.11.12.14 is not listed at rbl4.test.ex
16 >>> warn: condition test failed in ACL "check_mail"
17 >>> processing "warn"
18 >>> check dnslists = rbl4.test.ex&127.0.0.3
19 >>> DNS list check: rbl4.test.ex&127.0.0.3
20 >>> using result of previous DNS lookup
21 >>> DNS lookup for 14.12.11.V4NET.rbl4.test.ex failed
22 >>> => that means V4NET.11.12.14 is not listed at rbl4.test.ex
23 >>> warn: condition test failed in ACL "check_mail"
24 >>> processing "warn"
25 >>> check dnslists = rbl4.test.ex!&0.0.0.7
26 >>> DNS list check: rbl4.test.ex!&0.0.0.7
27 >>> using result of previous DNS lookup
28 >>> DNS lookup for 14.12.11.V4NET.rbl4.test.ex failed
29 >>> => that means V4NET.11.12.14 is not listed at rbl4.test.ex
30 >>> warn: condition test failed in ACL "check_mail"
31 >>> processing "warn"
32 >>> check dnslists = rbl5.test.ex,rbl4.test.ex=127.0.0.128
33 >>> DNS list check: rbl5.test.ex,rbl4.test.ex=127.0.0.128
34 >>> using result of previous DNS lookup
35 >>> DNS lookup for 14.12.11.V4NET.rbl4.test.ex failed
36 >>> => that means V4NET.11.12.14 is not listed at rbl4.test.ex
37 >>> warn: condition test failed in ACL "check_mail"
38 >>> processing "accept"
39 >>> accept: condition test succeeded in ACL "check_mail"
40 >>> end of ACL "check_mail": ACCEPT
41 >>> using ACL "check_recipient"
42 >>> processing "warn"
43 >>>   message: X-Warn: host is listed in $dnslist_domain but not =127.0.0.3${if def:dnslist_text{\n  $dnslist_text}}
44 >>> check dnslists = rbl3.test.ex!=127.0.0.3
45 >>> DNS list check: rbl3.test.ex!=127.0.0.3
46 >>> new DNS lookup for 14.12.11.V4NET.rbl3.test.ex
47 >>> DNS lookup for 14.12.11.V4NET.rbl3.test.ex succeeded (yielding 127.0.0.2)
48 >>> => that means V4NET.11.12.14 is listed at rbl3.test.ex
49 >>> warn: condition test succeeded in ACL "check_recipient"
50 >>> processing "deny"
51 >>>   message: host is listed in $dnslist_domain with value 127.0.0.3${if def:dnslist_text{\n$dnslist_text}}
52 >>> check dnslists = rbl3.test.ex=127.0.0.3
53 >>> DNS list check: rbl3.test.ex=127.0.0.3
54 >>> using result of previous DNS lookup
55 >>> DNS lookup for 14.12.11.V4NET.rbl3.test.ex succeeded (yielding 127.0.0.2)
56 >>> => but we are not accepting this block class because
57 >>> => there was no match for =127.0.0.3
58 >>> deny: condition test failed in ACL "check_recipient"
59 >>> processing "require"
60 >>> check verify = sender
61 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
62 >>> routing postmaster@exim.test.ex
63 >>> calling system_aliases router
64 >>> routed by system_aliases router
65 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
66 >>> routing userx@exim.test.ex
67 >>> calling system_aliases router
68 >>> system_aliases router declined for userx@exim.test.ex
69 >>> userx in "userx"? yes (matched "userx")
70 >>> calling localuser router
71 >>> routed by localuser router
72 >>> ----------- end verify ------------
73 >>> require: condition test succeeded in ACL "check_recipient"
74 >>> processing "deny"
75 >>>   message: unrouteable address
76 >>> check !verify = recipient
77 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
78 >>> routing userx@exim.test.ex
79 >>> calling system_aliases router
80 >>> system_aliases router declined for userx@exim.test.ex
81 >>> userx in "userx"? yes (matched "userx")
82 >>> calling localuser router
83 >>> routed by localuser router
84 >>> ----------- end verify ------------
85 >>> deny: condition test failed in ACL "check_recipient"
86 >>> processing "accept"
87 >>> check domains = +local_domains
88 >>> exim.test.ex in "exim.test.ex"? yes (matched "exim.test.ex")
89 >>> exim.test.ex in "+local_domains"? yes (matched "+local_domains")
90 >>> accept: condition test succeeded in ACL "check_recipient"
91 >>> end of ACL "check_recipient": ACCEPT
92 >>> using ACL "check_recipient"
93 >>> processing "warn"
94 >>>   message: X-Warn: host is listed in $dnslist_domain but not =127.0.0.3${if def:dnslist_text{\n  $dnslist_text}}
95 >>> check dnslists = rbl3.test.ex!=127.0.0.3
96 >>> DNS list check: rbl3.test.ex!=127.0.0.3
97 >>> using result of previous DNS lookup
98 >>> DNS lookup for 14.12.11.V4NET.rbl3.test.ex succeeded (yielding 127.0.0.2)
99 >>> => that means V4NET.11.12.14 is listed at rbl3.test.ex
100 >>> warn: condition test succeeded in ACL "check_recipient"
101 >>> processing "deny"
102 >>>   message: host is listed in $dnslist_domain with value 127.0.0.3${if def:dnslist_text{\n$dnslist_text}}
103 >>> check dnslists = rbl3.test.ex=127.0.0.3
104 >>> DNS list check: rbl3.test.ex=127.0.0.3
105 >>> using result of previous DNS lookup
106 >>> DNS lookup for 14.12.11.V4NET.rbl3.test.ex succeeded (yielding 127.0.0.2)
107 >>> => but we are not accepting this block class because
108 >>> => there was no match for =127.0.0.3
109 >>> deny: condition test failed in ACL "check_recipient"
110 >>> processing "require"
111 >>> check verify = sender
112 >>> using cached sender verify result
113 >>> require: condition test succeeded in ACL "check_recipient"
114 >>> processing "deny"
115 >>>   message: unrouteable address
116 >>> check !verify = recipient
117 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
118 >>> routing list@exim.test.ex
119 >>> calling system_aliases router
120 >>> routed by system_aliases router
121 >>> ----------- end verify ------------
122 >>> deny: condition test failed in ACL "check_recipient"
123 >>> processing "accept"
124 >>> check domains = +local_domains
125 >>> exim.test.ex in "exim.test.ex"? yes (matched "exim.test.ex")
126 >>> exim.test.ex in "+local_domains"? yes (matched "+local_domains")
127 >>> accept: condition test succeeded in ACL "check_recipient"
128 >>> end of ACL "check_recipient": ACCEPT
129 >>> host in ignore_fromline_hosts? no (option unset)
130 LOG: 10HmaY-0005vi-00 <= postmaster@exim.test.ex H=[V4NET.11.12.14] P=smtp S=sss
131 >>> host in hosts_connection_nolog? no (option unset)
132 >>> host in host_lookup? no (option unset)
133 >>> host in host_reject_connection? no (option unset)
134 >>> host in sender_unqualified_hosts? no (option unset)
135 >>> host in recipient_unqualified_hosts? no (option unset)
136 >>> host in helo_verify_hosts? no (option unset)
137 >>> host in helo_try_verify_hosts? no (option unset)
138 >>> host in helo_accept_junk_hosts? no (option unset)
139 >>> using ACL "check_mail"
140 >>> processing "warn"
141 >>> check dnslists = rbl4.test.ex&0.0.0.6
142 >>> DNS list check: rbl4.test.ex&0.0.0.6
143 >>> new DNS lookup for 15.12.11.V4NET.rbl4.test.ex
144 >>> DNS lookup for 15.12.11.V4NET.rbl4.test.ex failed
145 >>> => that means V4NET.11.12.15 is not listed at rbl4.test.ex
146 >>> warn: condition test failed in ACL "check_mail"
147 >>> processing "warn"
148 >>> check dnslists = rbl4.test.ex&127.0.0.3
149 >>> DNS list check: rbl4.test.ex&127.0.0.3
150 >>> using result of previous DNS lookup
151 >>> DNS lookup for 15.12.11.V4NET.rbl4.test.ex failed
152 >>> => that means V4NET.11.12.15 is not listed at rbl4.test.ex
153 >>> warn: condition test failed in ACL "check_mail"
154 >>> processing "warn"
155 >>> check dnslists = rbl4.test.ex!&0.0.0.7
156 >>> DNS list check: rbl4.test.ex!&0.0.0.7
157 >>> using result of previous DNS lookup
158 >>> DNS lookup for 15.12.11.V4NET.rbl4.test.ex failed
159 >>> => that means V4NET.11.12.15 is not listed at rbl4.test.ex
160 >>> warn: condition test failed in ACL "check_mail"
161 >>> processing "warn"
162 >>> check dnslists = rbl5.test.ex,rbl4.test.ex=127.0.0.128
163 >>> DNS list check: rbl5.test.ex,rbl4.test.ex=127.0.0.128
164 >>> using result of previous DNS lookup
165 >>> DNS lookup for 15.12.11.V4NET.rbl4.test.ex failed
166 >>> => that means V4NET.11.12.15 is not listed at rbl4.test.ex
167 >>> warn: condition test failed in ACL "check_mail"
168 >>> processing "accept"
169 >>> accept: condition test succeeded in ACL "check_mail"
170 >>> end of ACL "check_mail": ACCEPT
171 >>> using ACL "check_recipient"
172 >>> processing "warn"
173 >>>   message: X-Warn: host is listed in $dnslist_domain but not =127.0.0.3${if def:dnslist_text{\n  $dnslist_text}}
174 >>> check dnslists = rbl3.test.ex!=127.0.0.3
175 >>> DNS list check: rbl3.test.ex!=127.0.0.3
176 >>> new DNS lookup for 15.12.11.V4NET.rbl3.test.ex
177 >>> DNS lookup for 15.12.11.V4NET.rbl3.test.ex succeeded (yielding 127.0.0.3)
178 >>> => but we are not accepting this block class because
179 >>> => there was an exclude match for =127.0.0.3
180 >>> warn: condition test failed in ACL "check_recipient"
181 >>> processing "deny"
182 >>>   message: host is listed in $dnslist_domain with value 127.0.0.3${if def:dnslist_text{\n$dnslist_text}}
183 >>> check dnslists = rbl3.test.ex=127.0.0.3
184 >>> DNS list check: rbl3.test.ex=127.0.0.3
185 >>> using result of previous DNS lookup
186 >>> DNS lookup for 15.12.11.V4NET.rbl3.test.ex succeeded (yielding 127.0.0.3)
187 >>> => that means V4NET.11.12.15 is listed at rbl3.test.ex
188 >>> deny: condition test succeeded in ACL "check_recipient"
189 >>> end of ACL "check_recipient": DENY
190 LOG: H=[V4NET.11.12.15] F=<postmaster@exim.test.ex> rejected RCPT <userx@exim.test.ex>: host is listed in rbl3.test.ex with value 127.0.0.3
191 >>> host in hosts_connection_nolog? no (option unset)
192 >>> host in host_lookup? no (option unset)
193 >>> host in host_reject_connection? no (option unset)
194 >>> host in sender_unqualified_hosts? no (option unset)
195 >>> host in recipient_unqualified_hosts? no (option unset)
196 >>> host in helo_verify_hosts? no (option unset)
197 >>> host in helo_try_verify_hosts? no (option unset)
198 >>> host in helo_accept_junk_hosts? no (option unset)
199 >>> using ACL "check_mail"
200 >>> processing "warn"
201 >>> check dnslists = rbl4.test.ex&0.0.0.6
202 >>> DNS list check: rbl4.test.ex&0.0.0.6
203 >>> new DNS lookup for 20.12.11.V4NET.rbl4.test.ex
204 >>> DNS lookup for 20.12.11.V4NET.rbl4.test.ex succeeded (yielding 127.0.0.6)
205 >>> => that means V4NET.11.12.20 is listed at rbl4.test.ex
206 >>> warn: condition test succeeded in ACL "check_mail"
207 >>> processing "warn"
208 >>> check dnslists = rbl4.test.ex&127.0.0.3
209 >>> DNS list check: rbl4.test.ex&127.0.0.3
210 >>> using result of previous DNS lookup
211 >>> DNS lookup for 20.12.11.V4NET.rbl4.test.ex succeeded (yielding 127.0.0.6)
212 >>> => but we are not accepting this block class because
213 >>> => there was no match for &127.0.0.3
214 >>> warn: condition test failed in ACL "check_mail"
215 >>> processing "warn"
216 >>> check dnslists = rbl4.test.ex!&0.0.0.7
217 >>> DNS list check: rbl4.test.ex!&0.0.0.7
218 >>> using result of previous DNS lookup
219 >>> DNS lookup for 20.12.11.V4NET.rbl4.test.ex succeeded (yielding 127.0.0.6)
220 >>> => that means V4NET.11.12.20 is listed at rbl4.test.ex
221 >>> check add_header = DNSlist: $dnslist_domain $dnslist_text $dnslist_matched
222 >>>                  = DNSlist: rbl4.test.ex  V4NET.11.12.20
223 >>> warn: condition test succeeded in ACL "check_mail"
224 >>> processing "warn"
225 >>> check dnslists = rbl5.test.ex,rbl4.test.ex=127.0.0.128
226 >>> DNS list check: rbl5.test.ex,rbl4.test.ex=127.0.0.128
227 >>> using result of previous DNS lookup
228 >>> DNS lookup for 20.12.11.V4NET.rbl4.test.ex succeeded (yielding 127.0.0.6)
229 >>> => but we are not accepting this block class because
230 >>> => there was no match for =127.0.0.128
231 >>> warn: condition test failed in ACL "check_mail"
232 >>> processing "accept"
233 >>> accept: condition test succeeded in ACL "check_mail"
234 >>> end of ACL "check_mail": ACCEPT
235 >>> host in hosts_connection_nolog? no (option unset)
236 >>> host in host_lookup? no (option unset)
237 >>> host in host_reject_connection? no (option unset)
238 >>> host in sender_unqualified_hosts? no (option unset)
239 >>> host in recipient_unqualified_hosts? no (option unset)
240 >>> host in helo_verify_hosts? no (option unset)
241 >>> host in helo_try_verify_hosts? no (option unset)
242 >>> host in helo_accept_junk_hosts? no (option unset)
243 >>> using ACL "check_mail"
244 >>> processing "warn"
245 >>> check dnslists = rbl4.test.ex&0.0.0.6
246 >>> DNS list check: rbl4.test.ex&0.0.0.6
247 >>> new DNS lookup for 21.12.11.V4NET.rbl4.test.ex
248 >>> DNS lookup for 21.12.11.V4NET.rbl4.test.ex succeeded (yielding 127.0.0.7)
249 >>> => that means V4NET.11.12.21 is listed at rbl4.test.ex
250 >>> warn: condition test succeeded in ACL "check_mail"
251 >>> processing "warn"
252 >>> check dnslists = rbl4.test.ex&127.0.0.3
253 >>> DNS list check: rbl4.test.ex&127.0.0.3
254 >>> using result of previous DNS lookup
255 >>> DNS lookup for 21.12.11.V4NET.rbl4.test.ex succeeded (yielding 127.0.0.7)
256 >>> => that means V4NET.11.12.21 is listed at rbl4.test.ex
257 >>> warn: condition test succeeded in ACL "check_mail"
258 >>> processing "warn"
259 >>> check dnslists = rbl4.test.ex!&0.0.0.7
260 >>> DNS list check: rbl4.test.ex!&0.0.0.7
261 >>> using result of previous DNS lookup
262 >>> DNS lookup for 21.12.11.V4NET.rbl4.test.ex succeeded (yielding 127.0.0.7)
263 >>> => but we are not accepting this block class because
264 >>> => there was an exclude match for &0.0.0.7
265 >>> warn: condition test failed in ACL "check_mail"
266 >>> processing "warn"
267 >>> check dnslists = rbl5.test.ex,rbl4.test.ex=127.0.0.128
268 >>> DNS list check: rbl5.test.ex,rbl4.test.ex=127.0.0.128
269 >>> using result of previous DNS lookup
270 >>> DNS lookup for 21.12.11.V4NET.rbl4.test.ex succeeded (yielding 127.0.0.7)
271 >>> => but we are not accepting this block class because
272 >>> => there was no match for =127.0.0.128
273 >>> warn: condition test failed in ACL "check_mail"
274 >>> processing "accept"
275 >>> accept: condition test succeeded in ACL "check_mail"
276 >>> end of ACL "check_mail": ACCEPT
277 >>> host in hosts_connection_nolog? no (option unset)
278 >>> host in host_lookup? no (option unset)
279 >>> host in host_reject_connection? no (option unset)
280 >>> host in sender_unqualified_hosts? no (option unset)
281 >>> host in recipient_unqualified_hosts? no (option unset)
282 >>> host in helo_verify_hosts? no (option unset)
283 >>> host in helo_try_verify_hosts? no (option unset)
284 >>> host in helo_accept_junk_hosts? no (option unset)
285 >>> a.b in helo_lookup_domains? no (end of list)
286 >>> using ACL "check_helo"
287 >>> processing "warn"
288 >>> check dnslists = rbl2.test.ex!=127.0.0.3 : rbl3.test.ex=127.0.0.3
289 >>> DNS list check: rbl2.test.ex!=127.0.0.3
290 >>> new DNS lookup for 15.12.11.V4NET.rbl2.test.ex
291 >>> DNS lookup for 15.12.11.V4NET.rbl2.test.ex failed
292 >>> => that means V4NET.11.12.15 is not listed at rbl2.test.ex
293 >>> DNS list check: rbl3.test.ex=127.0.0.3
294 >>> new DNS lookup for 15.12.11.V4NET.rbl3.test.ex
295 >>> DNS lookup for 15.12.11.V4NET.rbl3.test.ex succeeded (yielding 127.0.0.3)
296 >>> => that means V4NET.11.12.15 is listed at rbl3.test.ex
297 >>> warn: condition test succeeded in ACL "check_helo"
298 >>> processing "accept"
299 >>> accept: condition test succeeded in ACL "check_helo"
300 >>> end of ACL "check_helo": ACCEPT
301 >>> host in hosts_connection_nolog? no (option unset)
302 >>> host in host_lookup? no (option unset)
303 >>> host in host_reject_connection? no (option unset)
304 >>> host in sender_unqualified_hosts? no (option unset)
305 >>> host in recipient_unqualified_hosts? no (option unset)
306 >>> host in helo_verify_hosts? no (option unset)
307 >>> host in helo_try_verify_hosts? no (option unset)
308 >>> host in helo_accept_junk_hosts? no (option unset)
309 >>> host in smtp_accept_max_nonmail_hosts? yes (matched "*")
310 >>> using ACL "check_vrfy"
311 >>> processing "warn"
312 >>> check dnslists = rbl.test.ex=127.0.0.1
313 >>> DNS list check: rbl.test.ex=127.0.0.1
314 >>> new DNS lookup for 2.13.13.V4NET.rbl.test.ex
315 >>> DNS lookup for 2.13.13.V4NET.rbl.test.ex succeeded (yielding 127.0.0.1, 127.0.0.2)
316 >>> => that means V4NET.13.13.2 is listed at rbl.test.ex
317 >>> warn: condition test succeeded in ACL "check_vrfy"
318 >>> processing "warn"
319 >>> check dnslists = rbl.test.ex!=127.0.0.1
320 >>> DNS list check: rbl.test.ex!=127.0.0.1
321 >>> using result of previous DNS lookup
322 >>> DNS lookup for 2.13.13.V4NET.rbl.test.ex succeeded (yielding 127.0.0.1, 127.0.0.2)
323 >>> => but we are not accepting this block class because
324 >>> => there was an exclude match for =127.0.0.1
325 >>> warn: condition test failed in ACL "check_vrfy"
326 >>> processing "warn"
327 >>> check dnslists = rbl.test.ex!=127.0.0.3
328 >>> DNS list check: rbl.test.ex!=127.0.0.3
329 >>> using result of previous DNS lookup
330 >>> DNS lookup for 2.13.13.V4NET.rbl.test.ex succeeded (yielding 127.0.0.1, 127.0.0.2)
331 >>> => that means V4NET.13.13.2 is listed at rbl.test.ex
332 >>> warn: condition test succeeded in ACL "check_vrfy"
333 >>> processing "warn"
334 >>> check dnslists = rbl.test.ex==127.0.0.1
335 >>> DNS list check: rbl.test.ex==127.0.0.1
336 >>> using result of previous DNS lookup
337 >>> DNS lookup for 2.13.13.V4NET.rbl.test.ex succeeded (yielding 127.0.0.1, 127.0.0.2)
338 >>> => but we are not accepting this block class because
339 >>> => there was an IP address that did not match for ==127.0.0.1
340 >>> warn: condition test failed in ACL "check_vrfy"
341 >>> processing "warn"
342 >>> check dnslists = rbl.test.ex==127.0.0.1,127.0.0.2
343 >>> DNS list check: rbl.test.ex==127.0.0.1,127.0.0.2
344 >>> using result of previous DNS lookup
345 >>> DNS lookup for 2.13.13.V4NET.rbl.test.ex succeeded (yielding 127.0.0.1, 127.0.0.2)
346 >>> => that means V4NET.13.13.2 is listed at rbl.test.ex
347 >>> warn: condition test succeeded in ACL "check_vrfy"
348 >>> processing "warn"
349 >>> check dnslists = rbl.test.ex!==127.0.0.1
350 >>> DNS list check: rbl.test.ex!==127.0.0.1
351 >>> using result of previous DNS lookup
352 >>> DNS lookup for 2.13.13.V4NET.rbl.test.ex succeeded (yielding 127.0.0.1, 127.0.0.2)
353 >>> => that means V4NET.13.13.2 is listed at rbl.test.ex
354 >>> warn: condition test succeeded in ACL "check_vrfy"
355 >>> processing "warn"
356 >>> check dnslists = rbl.test.ex!==127.0.0.3
357 >>> DNS list check: rbl.test.ex!==127.0.0.3
358 >>> using result of previous DNS lookup
359 >>> DNS lookup for 2.13.13.V4NET.rbl.test.ex succeeded (yielding 127.0.0.1, 127.0.0.2)
360 >>> => that means V4NET.13.13.2 is listed at rbl.test.ex
361 >>> warn: condition test succeeded in ACL "check_vrfy"
362 >>> processing "warn"
363 >>> check dnslists = rbl.test.ex!==127.0.0.1,127.0.0.2
364 >>> DNS list check: rbl.test.ex!==127.0.0.1,127.0.0.2
365 >>> using result of previous DNS lookup
366 >>> DNS lookup for 2.13.13.V4NET.rbl.test.ex succeeded (yielding 127.0.0.1, 127.0.0.2)
367 >>> => but we are not accepting this block class because
368 >>> => there were no IP addresses that did not match for ==127.0.0.1,127.0.0.2
369 >>> warn: condition test failed in ACL "check_vrfy"
370 >>> processing "accept"
371 >>> accept: condition test succeeded in ACL "check_vrfy"
372 >>> end of ACL "check_vrfy": ACCEPT
373 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
374 >>> routing a@b
375 >>> calling system_aliases router
376 >>> system_aliases router declined for a@b
377 >>> a in "userx"? no (end of list)
378 >>> no more routers
379 LOG: VRFY failed for a@b H=[V4NET.13.13.2]