Tidies to SMTP dialogue debugging output.
[exim.git] / test / stderr / 0002
1 Exim version x.yz ....
2 configuration file is TESTSUITE/test-config
3 admin user
4 expanding: primary_hostname: $primary_hostname
5    result: primary_hostname: myhost.test.ex
6 expanding: abcd
7    result: abcd
8 expanding: \N^([ab]+)(\w+)$\N
9    result: ^([ab]+)(\w+)$
10 condition: match{abcd}{\N^([ab]+)(\w+)$\N}
11    result: true
12 expanding: $2$1
13    result: cdab
14 expanding: match:  ${if match{abcd}{\N^([ab]+)(\w+)$\N}{$2$1}fail}
15    result: match:  cdab
16 expanding: wxyz
17    result: wxyz
18 expanding: \N^([ab]+)(\w+)$\N
19    result: ^([ab]+)(\w+)$
20 condition: match{wxyz}{\N^([ab]+)(\w+)$\N}
21    result: false
22 expanding: $2$1
23    result: 
24 skipping: result is not used
25 failed to expand: match:  ${if match{wxyz}{\N^([ab]+)(\w+)$\N}{$2$1}fail}
26    error message: "if" failed and "fail" requested
27 failure was forced
28 expanding: 1
29    result: 1
30 expanding: 1
31    result: 1
32 condition: eq {1}{1}
33    result: true
34 expanding: yes
35    result: yes
36 expanding: xx
37    result: xx
38 skipping: result is not used
39 expanding: /non/exist
40    result: /non/exist
41 skipping: result is not used
42 expanding: ${lookup{xx}lsearch{/non/exist}}
43    result: 
44 skipping: result is not used
45 expanding: ${if eq {1}{1}{yes}{${lookup{xx}lsearch{/non/exist}}}}
46    result: yes
47 expanding: a.b.c
48    result: a.b.c
49 expanding: a.b.c
50    result: a.b.c
51 LOG: MAIN PANIC
52   no @ found in the subject of an address list match: subject="a.b.c" pattern="a.b.c"
53 condition: match_address{a.b.c}{a.b.c}
54    result: false
55 expanding: yes
56    result: yes
57 skipping: result is not used
58 expanding: no
59    result: no
60 expanding: match_address:   ${if match_address{a.b.c}{a.b.c}{yes}{no}}
61    result: match_address:   no
62 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
63 Exim version x.yz ....
64 configuration file is TESTSUITE/test-config
65 admin user
66 expanding: -oMa  sender_host_address = $sender_host_address
67    result: -oMa  sender_host_address = V4NET.0.0.1
68 expanding:       sender_host_port = $sender_host_port
69    result:       sender_host_port = 1234
70 expanding: -oMaa sender_host_authenticated = $sender_host_authenticated
71    result: -oMaa sender_host_authenticated = AAA
72 expanding: -oMai authenticated_id = $authenticated_id
73    result: -oMai authenticated_id = philip
74 expanding: -oMas authenticated_sender = $authenticated_sender
75    result: -oMas authenticated_sender = xx@yy.zz
76 expanding: -oMi  interface_address = $interface_address
77    result: -oMi  interface_address = 1.1.1.1
78 expanding:       interface_port = $interface_port
79    result:       interface_port = 99
80 expanding: -oMr  received_protocol = $received_protocol
81    result: -oMr  received_protocol = special
82 expanding: -oMt  sender_ident = $sender_ident
83    result: -oMt  sender_ident = me
84 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
85 1999-03-02 09:44:33 no host name found for IP address V4NET.11.12.13
86 Exim version x.yz ....
87 configuration file is TESTSUITE/test-config
88 admin user
89 expanding: -oMa  sender_host_address = $sender_host_address
90    result: -oMa  sender_host_address = V4NET.0.0.1
91 expanding:       sender_host_port = $sender_host_port
92    result:       sender_host_port = 1234
93 expanding: -oMaa sender_host_authenticated = $sender_host_authenticated
94    result: -oMaa sender_host_authenticated = AAA
95 expanding: -oMai authenticated_id = $authenticated_id
96    result: -oMai authenticated_id = philip
97 expanding: -oMas authenticated_sender = $authenticated_sender
98    result: -oMas authenticated_sender = xx@yy.zz
99 expanding: -oMi  interface_address = $interface_address
100    result: -oMi  interface_address = 1.1.1.1
101 expanding:       interface_port = $interface_port
102    result:       interface_port = 99
103 expanding: -oMr  received_protocol = $received_protocol
104    result: -oMr  received_protocol = special
105 expanding: black
106    result: black
107 expanding: white
108    result: white
109 condition: eq{black}{white}
110    result: false
111 expanding: $sender_host_name
112    result: 
113 skipping: result is not used
114 expanding: No
115    result: No
116 expanding: ----> No lookup yet: ${if eq{black}{white}{$sender_host_name}{No}}
117    result: ----> No lookup yet: No
118 looking up host name for V4NET.0.0.1
119 IP address lookup yielded ten-1.test.ex
120 using host_fake_gethostbyname for ten-1.test.ex (IPv4)
121 MUNGED: ::1 will be omitted in what follows
122 get[host|ipnode]byname[2] looked up these IP addresses:
123   name=ten-1.test.ex address=V4NET.0.0.1
124 checking addresses for ten-1.test.ex
125   V4NET.0.0.1 OK
126 sender_fullhost = ten-1.test.ex [V4NET.0.0.1]
127 sender_rcvhost = ten-1.test.ex ([V4NET.0.0.1] ident=me)
128 expanding: -oMs  sender_host_name = $sender_host_name
129    result: -oMs  sender_host_name = ten-1.test.ex
130 expanding: -oMt  sender_ident = $sender_ident
131    result: -oMt  sender_ident = me
132 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
133 Exim version x.yz ....
134 changed uid/gid: forcing real = effective
135   uid=uuuu gid=CALLER_GID pid=pppp
136 configuration file is TESTSUITE/test-config
137 admin user
138 changed uid/gid: privilege not needed
139   uid=EXIM_UID gid=EXIM_GID pid=pppp
140 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
141 sender address = CALLER@myhost.test.ex
142 sender_fullhost = [V4NET.0.0.1]
143 sender_rcvhost = [V4NET.0.0.1]
144 host in hosts_connection_nolog? no (option unset)
145 LOG: smtp_connection MAIN
146   SMTP connection from [V4NET.0.0.1]
147 host in host_lookup? no (option unset)
148 set_process_info: pppp handling incoming connection from [V4NET.0.0.1]
149 host in host_reject_connection? no (option unset)
150 host in sender_unqualified_hosts? no (option unset)
151 host in recipient_unqualified_hosts? no (option unset)
152 host in helo_verify_hosts? no (option unset)
153 host in helo_try_verify_hosts? no (option unset)
154 host in helo_accept_junk_hosts? no (option unset)
155 using ACL "connect1"
156 processing "deny"
157 check hosts = partial-lsearch;TESTSUITE/aux-fixed/0002.lsearch
158 sender host name required, to match against partial-lsearch;TESTSUITE/aux-fixed/0002.lsearch
159 looking up host name for V4NET.0.0.1
160 DNS lookup of 1.0.0.V4NET.in-addr.arpa (PTR) using fakens
161 DNS lookup of 1.0.0.V4NET.in-addr.arpa (PTR) succeeded
162 IP address lookup yielded ten-1.test.ex
163 using host_fake_gethostbyname for ten-1.test.ex (IPv4)
164 DNS lookup of ten-1.test.ex (A) using fakens
165 DNS lookup of ten-1.test.ex (A) succeeded
166 MUNGED: ::1 will be omitted in what follows
167 get[host|ipnode]byname[2] looked up these IP addresses:
168   name=ten-1.test.ex address=V4NET.0.0.1
169 checking addresses for ten-1.test.ex
170   V4NET.0.0.1 OK
171 sender_fullhost = ten-1.test.ex [V4NET.0.0.1]
172 sender_rcvhost = ten-1.test.ex ([V4NET.0.0.1])
173 search_open: lsearch "TESTSUITE/aux-fixed/0002.lsearch"
174 search_find: file="TESTSUITE/aux-fixed/0002.lsearch"
175   key="ten-1.test.ex" partial=2 affix=*. starflags=0
176 LRU list:
177   :TESTSUITE/aux-fixed/0002.lsearch
178   End
179 internal_search_find: file="TESTSUITE/aux-fixed/0002.lsearch"
180   type=lsearch key="ten-1.test.ex"
181 file lookup required for ten-1.test.ex
182   in TESTSUITE/aux-fixed/0002.lsearch
183 lookup yielded: 
184 host in "partial-lsearch;TESTSUITE/aux-fixed/0002.lsearch"? yes (matched "partial-lsearch;TESTSUITE/aux-fixed/0002.lsearch")
185 deny: condition test succeeded
186 SMTP>> 550 Administrative prohibition
187 LOG: MAIN REJECT
188   H=ten-1.test.ex [V4NET.0.0.1] rejected connection in "connect" ACL
189 search_tidyup called
190 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
191 Exim version x.yz ....
192 changed uid/gid: forcing real = effective
193   uid=uuuu gid=CALLER_GID pid=pppp
194 configuration file is TESTSUITE/test-config
195 admin user
196 changed uid/gid: privilege not needed
197   uid=EXIM_UID gid=EXIM_GID pid=pppp
198 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
199 sender address = CALLER@myhost.test.ex
200 sender_fullhost = [V4NET.0.0.2]
201 sender_rcvhost = [V4NET.0.0.2]
202 host in hosts_connection_nolog? no (option unset)
203 LOG: smtp_connection MAIN
204   SMTP connection from [V4NET.0.0.2]
205 host in host_lookup? no (option unset)
206 set_process_info: pppp handling incoming connection from [V4NET.0.0.2]
207 host in host_reject_connection? no (option unset)
208 host in sender_unqualified_hosts? no (option unset)
209 host in recipient_unqualified_hosts? no (option unset)
210 host in helo_verify_hosts? no (option unset)
211 host in helo_try_verify_hosts? no (option unset)
212 host in helo_accept_junk_hosts? no (option unset)
213 using ACL "connect2"
214 processing "deny"
215 check hosts = net-lsearch;TESTSUITE/aux-fixed/0002.lsearch
216 search_open: lsearch "TESTSUITE/aux-fixed/0002.lsearch"
217 search_find: file="TESTSUITE/aux-fixed/0002.lsearch"
218   key="V4NET.0.0.2" partial=-1 affix=NULL starflags=0
219 LRU list:
220   :TESTSUITE/aux-fixed/0002.lsearch
221   End
222 internal_search_find: file="TESTSUITE/aux-fixed/0002.lsearch"
223   type=lsearch key="V4NET.0.0.2"
224 file lookup required for V4NET.0.0.2
225   in TESTSUITE/aux-fixed/0002.lsearch
226 lookup failed
227 host in "net-lsearch;TESTSUITE/aux-fixed/0002.lsearch"? no (end of list)
228 deny: condition test failed
229 end of ACL "connect2": implicit DENY
230 SMTP>> 550 Administrative prohibition
231 LOG: MAIN REJECT
232   H=[V4NET.0.0.2] rejected connection in "connect" ACL
233 search_tidyup called
234 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
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 "connect0"
244 >>> processing "accept"
245 >>> accept: condition test succeeded
246 >>> processing "accept"
247 >>> accept: condition test succeeded
248 >>> using ACL "check_data"
249 >>> processing "warn"
250 >>> check logwrite = Subject is: "$h_subject:"
251 >>>                = Subject is: ""
252 LOG: 10HmaX-0005vi-00 Subject is: ""
253 >>> warn: condition test succeeded
254 >>> processing "deny"
255 >>> deny: condition test succeeded
256 LOG: 10HmaX-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<>
257 >>> processing "accept"
258 >>> accept: condition test succeeded
259 >>> host in ignore_fromline_hosts? no (option unset)
260 >>> using ACL "check_data"
261 >>> processing "warn"
262 >>> check logwrite = Subject is: "$h_subject:"
263 >>>                = Subject is: ""
264 LOG: 10HmaY-0005vi-00 Subject is: ""
265 >>> warn: condition test succeeded
266 >>> processing "deny"
267 >>> deny: condition test succeeded
268 LOG: 10HmaY-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<a@b>
269 >>> processing "accept"
270 >>> accept: condition test succeeded
271 >>> host in ignore_fromline_hosts? no (option unset)
272 >>> using ACL "check_data"
273 >>> processing "warn"
274 >>> check logwrite = Subject is: "$h_subject:"
275 >>>                = Subject is: ""
276 LOG: 10HmaZ-0005vi-00 Subject is: ""
277 >>> warn: condition test succeeded
278 >>> processing "deny"
279 >>> deny: condition test succeeded
280 LOG: 10HmaZ-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<c@d>
281 >>> processing "accept"
282 >>> accept: condition test succeeded
283 >>> host in ignore_fromline_hosts? no (option unset)
284 >>> using ACL "check_data"
285 >>> processing "warn"
286 >>> check logwrite = Subject is: "$h_subject:"
287 >>>                = Subject is: ""
288 LOG: 10HmbA-0005vi-00 Subject is: ""
289 >>> warn: condition test succeeded
290 >>> processing "deny"
291 >>> deny: condition test succeeded
292 LOG: 10HmbA-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<>
293 >>> processing "accept"
294 >>> accept: condition test succeeded
295 >>> host in ignore_fromline_hosts? no (option unset)
296 >>> using ACL "check_data"
297 >>> processing "warn"
298 >>> check logwrite = Subject is: "$h_subject:"
299 >>>                = Subject is: ""
300 LOG: 10HmbB-0005vi-00 Subject is: ""
301 >>> warn: condition test succeeded
302 >>> processing "deny"
303 >>> deny: condition test succeeded
304 LOG: 10HmbB-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<x@y>
305 >>> host in hosts_connection_nolog? no (option unset)
306 >>> host in host_lookup? no (option unset)
307 >>> host in host_reject_connection? no (option unset)
308 >>> host in sender_unqualified_hosts? no (option unset)
309 >>> host in recipient_unqualified_hosts? no (option unset)
310 >>> host in helo_verify_hosts? no (option unset)
311 >>> host in helo_try_verify_hosts? no (option unset)
312 >>> host in helo_accept_junk_hosts? no (option unset)
313 >>> using ACL "connect0"
314 >>> processing "accept"
315 >>> accept: condition test succeeded
316 >>> processing "accept"
317 >>> accept: condition test succeeded
318 >>> host in ignore_fromline_hosts? no (option unset)
319 >>> using ACL "check_data"
320 >>> processing "warn"
321 >>> check logwrite = Subject is: "$h_subject:"
322 >>>                = Subject is: "=?iso-8859-8?Q?_here_we_go=3A_a_string_that_is_going_to_be_encoded=3A_it_will_go_over_the_75-char_limit_by_a_long_way=3B_in_fact_this_one_will_go_over_the_150_character_limit?="
323 LOG: 10HmbC-0005vi-00 Subject is: "=?iso-8859-8?Q?_here_we_go=3A_a_string_that_is_going_to_be_encoded=3A_it_will_go_over_the_75-char_limit_by_a_long_way=3B_in_fact_this_one_will_go_over_the_150_character_limit?="
324 >>> warn: condition test succeeded
325 >>> processing "deny"
326 >>> deny: condition test succeeded
327 LOG: 10HmbC-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<>
328 >>> host in hosts_connection_nolog? no (option unset)
329 >>> host in host_lookup? no (option unset)
330 >>> host in host_reject_connection? no (option unset)
331 >>> host in sender_unqualified_hosts? no (option unset)
332 >>> host in recipient_unqualified_hosts? no (option unset)
333 >>> host in helo_verify_hosts? no (option unset)
334 >>> host in helo_try_verify_hosts? no (option unset)
335 >>> host in helo_accept_junk_hosts? no (option unset)
336 >>> using ACL "connect0"
337 >>> processing "accept"
338 >>> accept: condition test succeeded
339 >>> processing "accept"
340 >>> accept: condition test succeeded
341 >>> host in ignore_fromline_hosts? no (option unset)
342 >>> using ACL "check_data"
343 >>> processing "warn"
344 >>> check logwrite = Subject is: "$h_subject:"
345 >>>                = Subject is: " here we go: a string that is going to be encoded: it will go over the 75-char limit by a long way; in fact this one will go over the 150 character limit"
346 LOG: 10HmbD-0005vi-00 Subject is: " here we go: a string that is going to be encoded: it will go over the 75-char limit by a long way; in fact this one will go over the 150 character limit"
347 >>> warn: condition test succeeded
348 >>> processing "deny"
349 >>> deny: condition test succeeded
350 LOG: 10HmbD-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<>
351 Exim version x.yz ....
352 changed uid/gid: -C, -D, -be or -bf forces real uid
353   uid=CALLER_UID gid=CALLER_GID pid=pppp
354 configuration file is TESTSUITE/test-config
355 admin user
356 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
357 sender address = CALLER@myhost.test.ex
358 1.2.3.4 in "1.2.3"? no (malformed IPv4 address or address mask)
359 1.2.3.4 in "1.2.3.4/abc"? no (malformed IPv4 address or address mask)
360 search_tidyup called
361 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>