Testsuite: debugging Solaris run ordering issue. Log +received_recipients
[users/jgh/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 = <\n partial-lsearch;TESTSUITE/aux-fixed/0002.lsearch \n 1.2.3.4
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   0TESTSUITE/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 "<
185  partial-lsearch;TESTSUITE/aux-fixed/0002.lsearch 
186  1.2.3.4"? yes (matched "partial-lsearch;TESTSUITE/aux-fixed/0002.lsearch")
187 deny: condition test succeeded in ACL "connect1"
188 end of ACL "connect1": DENY
189 SMTP>> 550 Administrative prohibition
190 LOG: MAIN REJECT
191   H=ten-1.test.ex [V4NET.0.0.1] rejected connection in "connect" ACL
192 search_tidyup called
193 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
194 Exim version x.yz ....
195 changed uid/gid: forcing real = effective
196   uid=uuuu gid=CALLER_GID pid=pppp
197 configuration file is TESTSUITE/test-config
198 admin user
199 changed uid/gid: privilege not needed
200   uid=EXIM_UID gid=EXIM_GID pid=pppp
201 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
202 sender address = CALLER@myhost.test.ex
203 sender_fullhost = [V4NET.0.0.2]
204 sender_rcvhost = [V4NET.0.0.2]
205 host in hosts_connection_nolog? no (option unset)
206 LOG: smtp_connection MAIN
207   SMTP connection from [V4NET.0.0.2]
208 host in host_lookup? no (option unset)
209 set_process_info: pppp handling incoming connection from [V4NET.0.0.2]
210 host in host_reject_connection? no (option unset)
211 host in sender_unqualified_hosts? no (option unset)
212 host in recipient_unqualified_hosts? no (option unset)
213 host in helo_verify_hosts? no (option unset)
214 host in helo_try_verify_hosts? no (option unset)
215 host in helo_accept_junk_hosts? no (option unset)
216 using ACL "connect2"
217 processing "deny"
218 check hosts = net-lsearch;TESTSUITE/aux-fixed/0002.lsearch
219 search_open: lsearch "TESTSUITE/aux-fixed/0002.lsearch"
220 search_find: file="TESTSUITE/aux-fixed/0002.lsearch"
221   key="V4NET.0.0.2" partial=-1 affix=NULL starflags=0
222 LRU list:
223   0TESTSUITE/aux-fixed/0002.lsearch
224   End
225 internal_search_find: file="TESTSUITE/aux-fixed/0002.lsearch"
226   type=lsearch key="V4NET.0.0.2"
227 file lookup required for V4NET.0.0.2
228   in TESTSUITE/aux-fixed/0002.lsearch
229 lookup failed
230 host in "net-lsearch;TESTSUITE/aux-fixed/0002.lsearch"? no (end of list)
231 deny: condition test failed in ACL "connect2"
232 end of ACL "connect2": implicit DENY
233 SMTP>> 550 Administrative prohibition
234 LOG: MAIN REJECT
235   H=[V4NET.0.0.2] rejected connection in "connect" ACL
236 search_tidyup called
237 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
238 >>> host in hosts_connection_nolog? no (option unset)
239 >>> host in host_lookup? no (option unset)
240 >>> host in host_reject_connection? no (option unset)
241 >>> host in sender_unqualified_hosts? no (option unset)
242 >>> host in recipient_unqualified_hosts? no (option unset)
243 >>> host in helo_verify_hosts? no (option unset)
244 >>> host in helo_try_verify_hosts? no (option unset)
245 >>> host in helo_accept_junk_hosts? no (option unset)
246 >>> using ACL "connect0"
247 >>> processing "accept"
248 >>> accept: condition test succeeded in ACL "connect0"
249 >>> end of ACL "connect0": ACCEPT
250 >>> processing "accept"
251 >>> accept: condition test succeeded in inline ACL
252 >>> end of inline ACL: ACCEPT
253 >>> using ACL "check_data"
254 >>> processing "warn"
255 >>> check logwrite = Subject is: "$h_subject:"
256 >>>                = Subject is: ""
257 LOG: 10HmaX-0005vi-00 Subject is: ""
258 >>> warn: condition test succeeded in ACL "check_data"
259 >>> processing "deny"
260 >>>   message: reply_address=<$reply_address>
261 >>> deny: condition test succeeded in ACL "check_data"
262 >>> end of ACL "check_data": DENY
263 LOG: 10HmaX-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<>
264 >>> processing "accept"
265 >>> accept: condition test succeeded in inline ACL
266 >>> end of inline ACL: ACCEPT
267 >>> host in ignore_fromline_hosts? no (option unset)
268 >>> using ACL "check_data"
269 >>> processing "warn"
270 >>> check logwrite = Subject is: "$h_subject:"
271 >>>                = Subject is: ""
272 LOG: 10HmaY-0005vi-00 Subject is: ""
273 >>> warn: condition test succeeded in ACL "check_data"
274 >>> processing "deny"
275 >>>   message: reply_address=<$reply_address>
276 >>> deny: condition test succeeded in ACL "check_data"
277 >>> end of ACL "check_data": DENY
278 LOG: 10HmaY-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<a@b>
279 >>> processing "accept"
280 >>> accept: condition test succeeded in inline ACL
281 >>> end of inline ACL: ACCEPT
282 >>> host in ignore_fromline_hosts? no (option unset)
283 >>> using ACL "check_data"
284 >>> processing "warn"
285 >>> check logwrite = Subject is: "$h_subject:"
286 >>>                = Subject is: ""
287 LOG: 10HmaZ-0005vi-00 Subject is: ""
288 >>> warn: condition test succeeded in ACL "check_data"
289 >>> processing "deny"
290 >>>   message: reply_address=<$reply_address>
291 >>> deny: condition test succeeded in ACL "check_data"
292 >>> end of ACL "check_data": DENY
293 LOG: 10HmaZ-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<c@d>
294 >>> processing "accept"
295 >>> accept: condition test succeeded in inline ACL
296 >>> end of inline ACL: ACCEPT
297 >>> host in ignore_fromline_hosts? no (option unset)
298 >>> using ACL "check_data"
299 >>> processing "warn"
300 >>> check logwrite = Subject is: "$h_subject:"
301 >>>                = Subject is: ""
302 LOG: 10HmbA-0005vi-00 Subject is: ""
303 >>> warn: condition test succeeded in ACL "check_data"
304 >>> processing "deny"
305 >>>   message: reply_address=<$reply_address>
306 >>> deny: condition test succeeded in ACL "check_data"
307 >>> end of ACL "check_data": DENY
308 LOG: 10HmbA-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<>
309 >>> processing "accept"
310 >>> accept: condition test succeeded in inline ACL
311 >>> end of inline ACL: ACCEPT
312 >>> host in ignore_fromline_hosts? no (option unset)
313 >>> using ACL "check_data"
314 >>> processing "warn"
315 >>> check logwrite = Subject is: "$h_subject:"
316 >>>                = Subject is: ""
317 LOG: 10HmbB-0005vi-00 Subject is: ""
318 >>> warn: condition test succeeded in ACL "check_data"
319 >>> processing "deny"
320 >>>   message: reply_address=<$reply_address>
321 >>> deny: condition test succeeded in ACL "check_data"
322 >>> end of ACL "check_data": DENY
323 LOG: 10HmbB-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<x@y>
324 >>> host in hosts_connection_nolog? no (option unset)
325 >>> host in host_lookup? no (option unset)
326 >>> host in host_reject_connection? no (option unset)
327 >>> host in sender_unqualified_hosts? no (option unset)
328 >>> host in recipient_unqualified_hosts? no (option unset)
329 >>> host in helo_verify_hosts? no (option unset)
330 >>> host in helo_try_verify_hosts? no (option unset)
331 >>> host in helo_accept_junk_hosts? no (option unset)
332 >>> using ACL "connect0"
333 >>> processing "accept"
334 >>> accept: condition test succeeded in ACL "connect0"
335 >>> end of ACL "connect0": ACCEPT
336 >>> processing "accept"
337 >>> accept: condition test succeeded in inline ACL
338 >>> end of inline ACL: ACCEPT
339 >>> host in ignore_fromline_hosts? no (option unset)
340 >>> using ACL "check_data"
341 >>> processing "warn"
342 >>> check logwrite = Subject is: "$h_subject:"
343 >>>                = 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?="
344 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?="
345 >>> warn: condition test succeeded in ACL "check_data"
346 >>> processing "deny"
347 >>>   message: reply_address=<$reply_address>
348 >>> deny: condition test succeeded in ACL "check_data"
349 >>> end of ACL "check_data": DENY
350 LOG: 10HmbC-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<>
351 >>> host in hosts_connection_nolog? no (option unset)
352 >>> host in host_lookup? no (option unset)
353 >>> host in host_reject_connection? no (option unset)
354 >>> host in sender_unqualified_hosts? no (option unset)
355 >>> host in recipient_unqualified_hosts? no (option unset)
356 >>> host in helo_verify_hosts? no (option unset)
357 >>> host in helo_try_verify_hosts? no (option unset)
358 >>> host in helo_accept_junk_hosts? no (option unset)
359 >>> using ACL "connect0"
360 >>> processing "accept"
361 >>> accept: condition test succeeded in ACL "connect0"
362 >>> end of ACL "connect0": ACCEPT
363 >>> processing "accept"
364 >>> accept: condition test succeeded in inline ACL
365 >>> end of inline ACL: ACCEPT
366 >>> host in ignore_fromline_hosts? no (option unset)
367 >>> using ACL "check_data"
368 >>> processing "warn"
369 >>> check logwrite = Subject is: "$h_subject:"
370 >>>                = 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"
371 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"
372 >>> warn: condition test succeeded in ACL "check_data"
373 >>> processing "deny"
374 >>>   message: reply_address=<$reply_address>
375 >>> deny: condition test succeeded in ACL "check_data"
376 >>> end of ACL "check_data": DENY
377 LOG: 10HmbD-0005vi-00 H=[V4NET.0.0.0] F=<> rejected after DATA: reply_address=<>
378 Exim version x.yz ....
379 changed uid/gid: -C, -D, -be or -bf forces real uid
380   uid=CALLER_UID gid=CALLER_GID pid=pppp
381 configuration file is TESTSUITE/test-config
382 admin user
383 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
384 sender address = CALLER@myhost.test.ex
385 1.2.3.4 in "1.2.3"? no (malformed IPv4 address or address mask)
386 1.2.3.4 in "1.2.3.4/abc"? no (malformed IPv4 address or address mask)
387 search_tidyup called
388 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>