More debug output
[exim.git] / test / stderr / 3400
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_connect"
10 >>> processing "warn"
11 >>> check hosts = 10.0.0.6
12 >>> host in "10.0.0.6"? no (end of list)
13 >>> warn: condition test failed in ACL "check_connect"
14 >>> processing "accept"
15 >>> accept: condition test succeeded in ACL "check_connect"
16 >>> host in smtp_accept_max_nonmail_hosts? yes (matched "*")
17 >>> using ACL "check_vrfy"
18 >>> processing "deny"
19 >>> check hosts = +auth_hosts
20 >>> host in "10.0.0.1"? no (end of list)
21 >>> host in "+auth_hosts"? no (end of list)
22 >>> deny: condition test failed in ACL "check_vrfy"
23 >>> processing "accept"
24 >>> accept: condition test succeeded in ACL "check_vrfy"
25 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
26 >>> routing userx@test.ex
27 >>> test.ex in "test.ex : *.test.ex"? yes (matched "test.ex")
28 >>> test.ex in "! +local_domains"? no (matched "! +local_domains")
29 >>> userx in "userx"? yes (matched "userx")
30 >>> calling localuser router
31 >>> routed by localuser router
32 >>> using ACL "check_expn"
33 >>> processing "deny"
34 >>> check hosts = +auth_hosts
35 >>> host in "+auth_hosts"? no (end of list)
36 >>> deny: condition test failed in ACL "check_expn"
37 >>> processing "accept"
38 >>> check hosts = 10.0.0.0/24
39 >>> host in "10.0.0.0/24"? yes (matched "10.0.0.0/24")
40 >>> accept: condition test succeeded in ACL "check_expn"
41 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
42 >>> routing list@test.ex
43 >>> test.ex in "test.ex : *.test.ex"? yes (matched "test.ex")
44 >>> test.ex in "! +local_domains"? no (matched "! +local_domains")
45 >>> list in "userx"? no (end of list)
46 >>> no more routers
47 LOG: ETRN #abcd received from [10.0.0.2]
48 >>> using ACL "check_etrn"
49 >>> processing "deny"
50 >>> check hosts = +auth_hosts
51 >>> host in "+auth_hosts"? no (end of list)
52 >>> deny: condition test failed in ACL "check_etrn"
53 >>> processing "require"
54 >>> check hosts = 10.0.0.0/24
55 >>> host in "10.0.0.0/24"? yes (matched "10.0.0.0/24")
56 >>> require: condition test succeeded in ACL "check_etrn"
57 >>> processing "warn"
58 >>> l_message: accepted ETRN $smtp_command_argument
59 >>> warn: condition test succeeded in ACL "check_etrn"
60 LOG: H=[10.0.0.2] Warning: accepted ETRN #abcd
61 >>> processing "accept"
62 >>> accept: condition test succeeded in ACL "check_etrn"
63 >>> ETRN command is: exim -R
64 >>> ETRN command execution skipped
65 >>> host in hosts_connection_nolog? no (option unset)
66 >>> host in host_lookup? no (option unset)
67 >>> host in host_reject_connection? no (option unset)
68 >>> host in sender_unqualified_hosts? no (option unset)
69 >>> host in recipient_unqualified_hosts? no (option unset)
70 >>> host in helo_verify_hosts? no (option unset)
71 >>> host in helo_try_verify_hosts? no (option unset)
72 >>> host in helo_accept_junk_hosts? no (option unset)
73 >>> using ACL "check_connect"
74 >>> processing "warn"
75 >>> check hosts = 10.0.0.6
76 >>> host in "10.0.0.6"? no (end of list)
77 >>> warn: condition test failed in ACL "check_connect"
78 >>> processing "accept"
79 >>> accept: condition test succeeded in ACL "check_connect"
80 >>> test.host in helo_lookup_domains? no (end of list)
81 >>> host in pipelining_advertise_hosts? yes (matched "*")
82 >>> host in "10.0.0.1"? yes (matched "10.0.0.1")
83 >>> host in auth_advertise_hosts? yes (matched "+auth_hosts")
84 >>> host in smtp_accept_max_nonmail_hosts? yes (matched "*")
85 >>> using ACL "check_vrfy"
86 >>> processing "deny"
87 >>> check hosts = +auth_hosts
88 >>> host in "+auth_hosts"? yes (matched "+auth_hosts" - cached)
89 >>>   message: authentication required
90 >>> check !authenticated = *
91 >>> deny: condition test succeeded in ACL "check_vrfy"
92 LOG: H=(test.host) [10.0.0.1] rejected VRFY userx@test.ex: authentication required
93 >>> using ACL "check_expn"
94 >>> processing "deny"
95 >>> check hosts = +auth_hosts
96 >>> host in "+auth_hosts"? yes (matched "+auth_hosts" - cached)
97 >>>   message: authentication required
98 >>> check !authenticated = *
99 >>> deny: condition test succeeded in ACL "check_expn"
100 LOG: H=(test.host) [10.0.0.1] rejected EXPN list@test.ex: authentication required
101 LOG: ETRN abcd received from (test.host) [10.0.0.1]
102 >>> using ACL "check_etrn"
103 >>> processing "deny"
104 >>> check hosts = +auth_hosts
105 >>> host in "+auth_hosts"? yes (matched "+auth_hosts" - cached)
106 >>>   message: authentication required
107 >>> check !authenticated = *
108 >>> deny: condition test succeeded in ACL "check_etrn"
109 LOG: H=(test.host) [10.0.0.1] rejected ETRN abcd: authentication required
110 >>> using ACL "check_recipient"
111 >>> processing "warn"
112 >>> check hosts = 10.0.0.5
113 >>> host in "10.0.0.5"? no (end of list)
114 >>> warn: condition test failed in ACL "check_recipient"
115 >>> processing "accept"
116 >>> check hosts = 10.0.0.5
117 >>> host in "10.0.0.5"? no (end of list)
118 >>> accept: condition test failed in ACL "check_recipient"
119 >>> processing "accept"
120 >>> check hosts = :
121 >>> host in ":"? no (end of list)
122 >>> accept: condition test failed in ACL "check_recipient"
123 >>> processing "deny"
124 >>> check hosts = +auth_hosts
125 >>> host in "+auth_hosts"? yes (matched "+auth_hosts" - cached)
126 >>>   message: authentication required
127 >>> check !authenticated = *
128 >>> deny: condition test succeeded in ACL "check_recipient"
129 LOG: H=(test.host) [10.0.0.1] F=<junk@jink.jonk.test.ex> rejected RCPT <userx@test.ex>: authentication required
130 >>> mylogin authenticator server_condition:
131 >>>   $auth1 = userx secret
132 >>>   $1 = userx secret
133 >>> +++MYLOGIN $1="userx secret" $2="" $3=""
134 >>> expanded string: yes
135 >>> using ACL "check_recipient"
136 >>> processing "warn"
137 >>> check hosts = 10.0.0.5
138 >>> host in "10.0.0.5"? no (end of list)
139 >>> warn: condition test failed in ACL "check_recipient"
140 >>> processing "accept"
141 >>> check hosts = 10.0.0.5
142 >>> host in "10.0.0.5"? no (end of list)
143 >>> accept: condition test failed in ACL "check_recipient"
144 >>> processing "accept"
145 >>> check hosts = :
146 >>> host in ":"? no (end of list)
147 >>> accept: condition test failed in ACL "check_recipient"
148 >>> processing "deny"
149 >>> check hosts = +auth_hosts
150 >>> host in "+auth_hosts"? yes (matched "+auth_hosts" - cached)
151 >>>   message: authentication required
152 >>> check !authenticated = *
153 >>> mylogin in "*"? yes (matched "*")
154 >>> deny: condition test failed in ACL "check_recipient"
155 >>> processing "accept"
156 >>> check domains = +local_domains
157 >>> test.ex in "test.ex : *.test.ex"? yes (matched "test.ex")
158 >>> test.ex in "+local_domains"? yes (matched "+local_domains")
159 >>> accept: condition test succeeded in ACL "check_recipient"
160 >>> using ACL "check_recipient"
161 >>> processing "warn"
162 >>> check hosts = 10.0.0.5
163 >>> host in "10.0.0.5"? no (end of list)
164 >>> warn: condition test failed in ACL "check_recipient"
165 >>> processing "accept"
166 >>> check hosts = 10.0.0.5
167 >>> host in "10.0.0.5"? no (end of list)
168 >>> accept: condition test failed in ACL "check_recipient"
169 >>> processing "accept"
170 >>> check hosts = :
171 >>> host in ":"? no (end of list)
172 >>> accept: condition test failed in ACL "check_recipient"
173 >>> processing "deny"
174 >>> check hosts = +auth_hosts
175 >>> host in "+auth_hosts"? yes (matched "+auth_hosts" - cached)
176 >>>   message: authentication required
177 >>> check !authenticated = *
178 >>> mylogin in "*"? yes (matched "*")
179 >>> deny: condition test failed in ACL "check_recipient"
180 >>> processing "accept"
181 >>> check domains = +local_domains
182 >>> cus.cam.ac.uk in "test.ex : *.test.ex"? no (end of list)
183 >>> cus.cam.ac.uk in "+local_domains"? no (end of list)
184 >>> accept: condition test failed in ACL "check_recipient"
185 >>> processing "accept"
186 >>> check hosts = +relay_hosts
187 >>> host in "10.0.0.4"? no (end of list)
188 >>> host in "+relay_hosts"? no (end of list)
189 >>> accept: condition test failed in ACL "check_recipient"
190 >>> processing "accept"
191 >>> check hosts = +auth_relay_hosts
192 >>> host in "10.0.0.3 : 10.0.0.4"? no (end of list)
193 >>> host in "+auth_relay_hosts"? no (end of list)
194 >>> accept: condition test failed in ACL "check_recipient"
195 >>> processing "deny"
196 >>>   message: relay not permitted
197 >>> deny: condition test succeeded in ACL "check_recipient"
198 LOG: H=(test.host) [10.0.0.1] F=<junk@jink.jonk.test.ex> A=mylogin rejected RCPT <userx@cus.cam.ac.uk>: relay not permitted
199 >>> using ACL "check_vrfy"
200 >>> processing "deny"
201 >>> check hosts = +auth_hosts
202 >>> host in "+auth_hosts"? yes (matched "+auth_hosts" - cached)
203 >>>   message: authentication required
204 >>> check !authenticated = *
205 >>> mylogin in "*"? yes (matched "*")
206 >>> deny: condition test failed in ACL "check_vrfy"
207 >>> processing "accept"
208 >>> accept: condition test succeeded in ACL "check_vrfy"
209 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
210 >>> routing userx@test.ex
211 >>> test.ex in "test.ex : *.test.ex"? yes (matched "test.ex")
212 >>> test.ex in "! +local_domains"? no (matched "! +local_domains")
213 >>> userx in "userx"? yes (matched "userx")
214 >>> calling localuser router
215 >>> routed by localuser router
216 >>> using ACL "check_expn"
217 >>> processing "deny"
218 >>> check hosts = +auth_hosts
219 >>> host in "+auth_hosts"? yes (matched "+auth_hosts" - cached)
220 >>>   message: authentication required
221 >>> check !authenticated = *
222 >>> mylogin in "*"? yes (matched "*")
223 >>> deny: condition test failed in ACL "check_expn"
224 >>> processing "accept"
225 >>> check hosts = 10.0.0.0/24
226 >>> host in "10.0.0.0/24"? yes (matched "10.0.0.0/24")
227 >>> accept: condition test succeeded in ACL "check_expn"
228 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
229 >>> routing list@test.ex
230 >>> test.ex in "test.ex : *.test.ex"? yes (matched "test.ex")
231 >>> test.ex in "! +local_domains"? no (matched "! +local_domains")
232 >>> list in "userx"? no (end of list)
233 >>> no more routers
234 LOG: ETRN #abcd received from (test.host) [10.0.0.1]
235 >>> using ACL "check_etrn"
236 >>> processing "deny"
237 >>> check hosts = +auth_hosts
238 >>> host in "+auth_hosts"? yes (matched "+auth_hosts" - cached)
239 >>>   message: authentication required
240 >>> check !authenticated = *
241 >>> mylogin in "*"? yes (matched "*")
242 >>> deny: condition test failed in ACL "check_etrn"
243 >>> processing "require"
244 >>> check hosts = 10.0.0.0/24
245 >>> host in "10.0.0.0/24"? yes (matched "10.0.0.0/24")
246 >>> require: condition test succeeded in ACL "check_etrn"
247 >>> processing "warn"
248 >>> l_message: accepted ETRN $smtp_command_argument
249 >>> warn: condition test succeeded in ACL "check_etrn"
250 LOG: H=(test.host) [10.0.0.1] Warning: accepted ETRN #abcd
251 >>> processing "accept"
252 >>> accept: condition test succeeded in ACL "check_etrn"
253 >>> ETRN command is: exim -R
254 >>> ETRN command execution skipped
255 >>> host in hosts_connection_nolog? no (option unset)
256 >>> host in host_lookup? no (option unset)
257 >>> host in host_reject_connection? no (option unset)
258 >>> host in sender_unqualified_hosts? no (option unset)
259 >>> host in recipient_unqualified_hosts? no (option unset)
260 >>> host in helo_verify_hosts? no (option unset)
261 >>> host in helo_try_verify_hosts? no (option unset)
262 >>> host in helo_accept_junk_hosts? no (option unset)
263 >>> using ACL "check_connect"
264 >>> processing "warn"
265 >>> check hosts = 10.0.0.6
266 >>> host in "10.0.0.6"? no (end of list)
267 >>> warn: condition test failed in ACL "check_connect"
268 >>> processing "accept"
269 >>> accept: condition test succeeded in ACL "check_connect"
270 >>> test.host in helo_lookup_domains? no (end of list)
271 >>> host in pipelining_advertise_hosts? yes (matched "*")
272 >>> host in "10.0.0.1"? no (end of list)
273 >>> host in "10.0.0.4"? no (end of list)
274 >>> host in "10.0.0.3 : 10.0.0.4"? yes (matched "10.0.0.3")
275 >>> host in auth_advertise_hosts? yes (matched "+auth_relay_hosts")
276 >>> using ACL "check_recipient"
277 >>> processing "warn"
278 >>> check hosts = 10.0.0.5
279 >>> host in "10.0.0.5"? no (end of list)
280 >>> warn: condition test failed in ACL "check_recipient"
281 >>> processing "accept"
282 >>> check hosts = 10.0.0.5
283 >>> host in "10.0.0.5"? no (end of list)
284 >>> accept: condition test failed in ACL "check_recipient"
285 >>> processing "accept"
286 >>> check hosts = :
287 >>> host in ":"? no (end of list)
288 >>> accept: condition test failed in ACL "check_recipient"
289 >>> processing "deny"
290 >>> check hosts = +auth_hosts
291 >>> host in "+auth_hosts"? no (end of list)
292 >>> deny: condition test failed in ACL "check_recipient"
293 >>> processing "accept"
294 >>> check domains = +local_domains
295 >>> cus.cam.ac.uk in "test.ex : *.test.ex"? no (end of list)
296 >>> cus.cam.ac.uk in "+local_domains"? no (end of list)
297 >>> accept: condition test failed in ACL "check_recipient"
298 >>> processing "accept"
299 >>> check hosts = +relay_hosts
300 >>> host in "+relay_hosts"? no (end of list)
301 >>> accept: condition test failed in ACL "check_recipient"
302 >>> processing "accept"
303 >>> check hosts = +auth_relay_hosts
304 >>> host in "+auth_relay_hosts"? yes (matched "+auth_relay_hosts" - cached)
305 >>>   message: authentication required
306 >>> check authenticated = *
307 >>> accept: condition test failed in ACL "check_recipient"
308 >>> accept: endpass encountered - denying access
309 LOG: H=(test.host) [10.0.0.3] F=<junk@jink.jonk.test.ex> rejected RCPT <userx@cus.cam.ac.uk>: authentication required
310 >>> mylogin authenticator server_condition:
311 >>>   $auth1 = userx secret
312 >>>   $1 = userx secret
313 >>> +++MYLOGIN $1="userx secret" $2="" $3=""
314 >>> expanded string: yes
315 >>> using ACL "check_recipient"
316 >>> processing "warn"
317 >>> check hosts = 10.0.0.5
318 >>> host in "10.0.0.5"? no (end of list)
319 >>> warn: condition test failed in ACL "check_recipient"
320 >>> processing "accept"
321 >>> check hosts = 10.0.0.5
322 >>> host in "10.0.0.5"? no (end of list)
323 >>> accept: condition test failed in ACL "check_recipient"
324 >>> processing "accept"
325 >>> check hosts = :
326 >>> host in ":"? no (end of list)
327 >>> accept: condition test failed in ACL "check_recipient"
328 >>> processing "deny"
329 >>> check hosts = +auth_hosts
330 >>> host in "+auth_hosts"? no (end of list)
331 >>> deny: condition test failed in ACL "check_recipient"
332 >>> processing "accept"
333 >>> check domains = +local_domains
334 >>> cus.cam.ac.uk in "test.ex : *.test.ex"? no (end of list)
335 >>> cus.cam.ac.uk in "+local_domains"? no (end of list)
336 >>> accept: condition test failed in ACL "check_recipient"
337 >>> processing "accept"
338 >>> check hosts = +relay_hosts
339 >>> host in "+relay_hosts"? no (end of list)
340 >>> accept: condition test failed in ACL "check_recipient"
341 >>> processing "accept"
342 >>> check hosts = +auth_relay_hosts
343 >>> host in "+auth_relay_hosts"? yes (matched "+auth_relay_hosts" - cached)
344 >>>   message: authentication required
345 >>> check authenticated = *
346 >>> mylogin in "*"? yes (matched "*")
347 >>> accept: condition test succeeded in ACL "check_recipient"
348 >>> host in hosts_connection_nolog? no (option unset)
349 >>> host in host_lookup? no (option unset)
350 >>> host in host_reject_connection? no (option unset)
351 >>> host in sender_unqualified_hosts? no (option unset)
352 >>> host in recipient_unqualified_hosts? no (option unset)
353 >>> host in helo_verify_hosts? no (option unset)
354 >>> host in helo_try_verify_hosts? no (option unset)
355 >>> host in helo_accept_junk_hosts? no (option unset)
356 >>> using ACL "check_connect"
357 >>> processing "warn"
358 >>> check hosts = 10.0.0.6
359 >>> host in "10.0.0.6"? no (end of list)
360 >>> warn: condition test failed in ACL "check_connect"
361 >>> processing "accept"
362 >>> accept: condition test succeeded in ACL "check_connect"
363 >>> test.host in helo_lookup_domains? no (end of list)
364 >>> host in pipelining_advertise_hosts? yes (matched "*")
365 >>> host in "10.0.0.1"? no (end of list)
366 >>> host in "10.0.0.4"? yes (matched "10.0.0.4")
367 >>> host in auth_advertise_hosts? no (matched "!+relay_hosts")
368 Exim version x.yz ....
369 changed uid/gid: forcing real = effective
370   uid=uuuu gid=CALLER_GID pid=pppp
371 seeking password data for user "CALLER": cache not available
372 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
373 configuration file is TESTSUITE/test-config
374 trusted user
375 admin user
376 changed uid/gid: privilege not needed
377   uid=EXIM_UID gid=EXIM_GID pid=pppp
378 seeking password data for user "CALLER": using cached result
379 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
380 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
381 sender address = NULL
382 sender_fullhost = [10.0.0.5]
383 sender_rcvhost = [10.0.0.5] (ident=CALLER)
384 set_process_info: pppp handling incoming connection from [10.0.0.5] via -oMa
385 set_process_info: pppp accepting a local SMTP message from <CALLER>
386 host in hosts_connection_nolog? no (option unset)
387 LOG: smtp_connection MAIN
388   SMTP connection from CALLER
389 host in host_lookup? no (option unset)
390 set_process_info: pppp handling incoming connection from [10.0.0.5] U=CALLER
391 host in host_reject_connection? no (option unset)
392 host in sender_unqualified_hosts? no (option unset)
393 host in recipient_unqualified_hosts? no (option unset)
394 host in helo_verify_hosts? no (option unset)
395 host in helo_try_verify_hosts? no (option unset)
396 host in helo_accept_junk_hosts? no (option unset)
397 using ACL "check_connect"
398 processing "warn"
399 check hosts = 10.0.0.6
400 host in "10.0.0.6"? no (end of list)
401 warn: condition test failed in ACL "check_connect"
402 processing "accept"
403 accept: condition test succeeded in ACL "check_connect"
404 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
405 smtp_setup_msg entered
406 SMTP<< ehlo testing.testing
407 testing.testing in helo_lookup_domains? no (end of list)
408 sender_fullhost = (testing.testing) [10.0.0.5]
409 sender_rcvhost = [10.0.0.5] (helo=testing.testing ident=CALLER)
410 set_process_info: pppp handling incoming connection from (testing.testing) [10.0.0.5] U=CALLER
411 host in pipelining_advertise_hosts? yes (matched "*")
412 host in "10.0.0.1"? no (end of list)
413 host in "10.0.0.4"? no (end of list)
414 host in "10.0.0.3 : 10.0.0.4"? no (end of list)
415 host in auth_advertise_hosts? yes (matched "10.0.0.5")
416 SMTP>> 250-myhost.test.ex Hello CALLER at testing.testing [10.0.0.5]
417 250-SIZE 52428800
418 250-8BITMIME
419 250-ETRN
420 250-EXPN
421 250-PIPELINING
422 250-AUTH MYLOGIN PLAIN EXPLAIN EXPANDED EXPANDFAIL DEFER LOGIN
423 250 HELP
424 SMTP<< auth mylogin dXNlcnggc2VjcmV0
425 mylogin authenticator server_condition:
426   $auth1 = userx secret
427   $1 = userx secret
428 +++MYLOGIN $1="userx secret" $2="" $3=""
429 expanded string: yes
430 SMTP>> 235 Authentication succeeded
431 SMTP<< quit
432 SMTP>> 221 myhost.test.ex closing connection
433 LOG: smtp_connection MAIN
434   SMTP connection from CALLER closed by QUIT
435 search_tidyup called
436 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>