Testsuite: more connect-time munge tweaking
[exim.git] / test / stderr / 0044
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=p1234
4 configuration file is TESTSUITE/test-config
5 admin user
6 changed uid/gid: privilege not needed
7   uid=EXIM_UID gid=EXIM_GID pid=p1234
8 seeking password data for user "CALLER": cache not available
9 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
10 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
11 sender address = CALLER@exim.test.ex
12 sender_fullhost = [V4NET.11.12.13]
13 sender_rcvhost = [V4NET.11.12.13]
14 host in hosts_connection_nolog? no (option unset)
15 LOG: smtp_connection MAIN
16   SMTP connection from [V4NET.11.12.13]
17 host in host_lookup? no (option unset)
18 set_process_info: pppp handling incoming connection from [V4NET.11.12.13]
19 host in host_reject_connection? no (option unset)
20 host in sender_unqualified_hosts? no (option unset)
21 host in recipient_unqualified_hosts? no (option unset)
22 host in helo_verify_hosts? no (option unset)
23 host in helo_try_verify_hosts? no (option unset)
24 host in helo_accept_junk_hosts? no (option unset)
25 SMTP>> 220 the.local.host.name ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
26 smtp_setup_msg entered
27 SMTP<< ehlo exim.test.ex
28 exim.test.ex in helo_lookup_domains?
29  list element: @
30  list element: @[]
31 exim.test.ex in helo_lookup_domains? no (end of list)
32 sender_fullhost = (exim.test.ex) [V4NET.11.12.13]
33 sender_rcvhost = [V4NET.11.12.13] (helo=exim.test.ex)
34 set_process_info: pppp handling incoming connection from (exim.test.ex) [V4NET.11.12.13]
35  list element: *
36   host in limits_advertise_hosts? yes (matched "*")
37 host in dsn_advertise_hosts? no (option unset)
38 host in pipelining_advertise_hosts?
39  list element: *
40   host in pipelining_advertise_hosts? yes (matched "*")
41 host in chunking_advertise_hosts?
42 host in chunking_advertise_hosts? no (end of list)
43 SMTP>> 250-the.local.host.name Hello exim.test.ex [V4NET.11.12.13]
44        250-SIZE 52428800
45        250-LIMITS MAILMAX=1000 RCPTMAX=50000
46        250-8BITMIME
47        250-PIPELINING
48        250 HELP
49 SMTP<< mail from:postmaster@exim.test.ex
50 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
51 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
52 SMTP>> 250 OK
53 SMTP<< rcpt to:<postmaster@exim.test.ex>
54 using ACL "check_recipient"
55 processing "accept" (TESTSUITE/test-config 19)
56 check hosts = :
57 host in ":"?
58  list element: 
59 host in ":"? no (end of list)
60 accept: condition test failed in ACL "check_recipient"
61 processing "accept" (TESTSUITE/test-config 20)
62 check recipients = postmaster@exim.test.ex
63 postmaster@exim.test.ex in "postmaster@exim.test.ex"?
64  list element: postmaster@exim.test.ex
65  address match test: subject=postmaster@exim.test.ex pattern=postmaster@exim.test.ex
66  exim.test.ex in "exim.test.ex"?
67   list element: exim.test.ex
68   exim.test.ex in "exim.test.ex"? yes (matched "exim.test.ex")
69  postmaster@exim.test.ex in "postmaster@exim.test.ex"? yes (matched "postmaster@exim.test.ex")
70 accept: condition test succeeded in ACL "check_recipient"
71 end of ACL "check_recipient": ACCEPT
72 SMTP>> 250 Accepted
73 SMTP<< rcpt to:list@exim.test.ex
74 using ACL "check_recipient"
75 processing "accept" (TESTSUITE/test-config 19)
76 check hosts = :
77 host in ":"?
78  list element: 
79 host in ":"? no (end of list)
80 accept: condition test failed in ACL "check_recipient"
81 processing "accept" (TESTSUITE/test-config 20)
82 check recipients = postmaster@exim.test.ex
83 list@exim.test.ex in "postmaster@exim.test.ex"?
84  list element: postmaster@exim.test.ex
85  address match test: subject=list@exim.test.ex pattern=postmaster@exim.test.ex
86 list@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
87 accept: condition test failed in ACL "check_recipient"
88 processing "accept" (TESTSUITE/test-config 21)
89 check senders = myfriend@*
90 postmaster@exim.test.ex in "myfriend@*"?
91  list element: myfriend@*
92  address match test: subject=postmaster@exim.test.ex pattern=myfriend@*
93 postmaster@exim.test.ex in "myfriend@*"? no (end of list)
94 accept: condition test failed in ACL "check_recipient"
95 processing "deny" (TESTSUITE/test-config 22)
96   message: host is listed in $dnslist_domain
97 check dnslists = rbl.test.ex
98 dnslists check: rbl.test.ex
99 new DNS lookup for 13.12.11.V4NET.rbl.test.ex
100 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) using fakens
101 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded
102 dnslists: wrote cache entry, ttl=3
103 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
104 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens
105 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded
106 => that means V4NET.11.12.13 is listed at rbl.test.ex
107 deny: condition test succeeded in ACL "check_recipient"
108 end of ACL "check_recipient": DENY
109 SMTP>> 550 host is listed in rbl.test.ex
110 LOG: MAIN REJECT
111   H=(exim.test.ex) [V4NET.11.12.13] F=<postmaster@exim.test.ex> rejected RCPT list@exim.test.ex: host is listed in rbl.test.ex
112 SMTP<< rcpt to:list2@exim.test.ex
113 using ACL "check_recipient"
114 processing "accept" (TESTSUITE/test-config 19)
115 check hosts = :
116 host in ":"?
117  list element: 
118 host in ":"? no (end of list)
119 accept: condition test failed in ACL "check_recipient"
120 processing "accept" (TESTSUITE/test-config 20)
121 check recipients = postmaster@exim.test.ex
122 list2@exim.test.ex in "postmaster@exim.test.ex"?
123  list element: postmaster@exim.test.ex
124  address match test: subject=list2@exim.test.ex pattern=postmaster@exim.test.ex
125 list2@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
126 accept: condition test failed in ACL "check_recipient"
127 processing "accept" (TESTSUITE/test-config 21)
128 check senders = myfriend@*
129 postmaster@exim.test.ex in "myfriend@*"?
130  list element: myfriend@*
131  address match test: subject=postmaster@exim.test.ex pattern=myfriend@*
132 postmaster@exim.test.ex in "myfriend@*"? no (end of list)
133 accept: condition test failed in ACL "check_recipient"
134 processing "deny" (TESTSUITE/test-config 22)
135   message: host is listed in $dnslist_domain
136 check dnslists = rbl.test.ex
137 dnslists check: rbl.test.ex
138 dnslists: using result of previous lookup
139 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
140 => that means V4NET.11.12.13 is listed at rbl.test.ex
141 deny: condition test succeeded in ACL "check_recipient"
142 end of ACL "check_recipient": DENY
143 SMTP>> 550 host is listed in rbl.test.ex
144 LOG: MAIN REJECT
145   H=(exim.test.ex) [V4NET.11.12.13] F=<postmaster@exim.test.ex> rejected RCPT list2@exim.test.ex: host is listed in rbl.test.ex
146 SMTP<< data
147 SMTP>> 354 Enter message, ending with "." on a line by itself
148 search_tidyup called
149 host in ignore_fromline_hosts? no (option unset)
150 >>Headers received:
151
152 qualify & rewrite recipients list
153 rewrite rules on sender address
154 qualify and rewrite headers
155 search_tidyup called
156 >>Headers after rewriting and local additions:
157
158 Data file name: TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
159 Data file written for message 10HmaX-000000005vi-0000
160 >>Generated Received: header line
161 P Received: from [V4NET.11.12.13] (helo=exim.test.ex)
162         by the.local.host.name with esmtp (Exim x.yz)
163         (envelope-from <postmaster@exim.test.ex>)
164         id 10HmaX-000000005vi-0000
165         for postmaster@exim.test.ex;
166         Tue, 2 Mar 1999 09:44:33 +0000
167 LOG: MAIN
168   <= postmaster@exim.test.ex H=(exim.test.ex) [V4NET.11.12.13] P=esmtp S=sss
169 SMTP>> 250 OK id=10HmaX-000000005vi-0000
170 smtp_setup_msg entered
171 SMTP<< quit
172 SMTP>> 221 the.local.host.name closing connection
173 LOG: smtp_connection MAIN
174   SMTP connection from (exim.test.ex) [V4NET.11.12.13] D=qqs closed by QUIT
175 search_tidyup called
176 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
177 >>> host in hosts_connection_nolog? no (option unset)
178 >>> host in host_lookup? no (option unset)
179 >>> host in host_reject_connection? no (option unset)
180 >>> host in sender_unqualified_hosts? no (option unset)
181 >>> host in recipient_unqualified_hosts? no (option unset)
182 >>> host in helo_verify_hosts? no (option unset)
183 >>> host in helo_try_verify_hosts? no (option unset)
184 >>> host in helo_accept_junk_hosts? no (option unset)
185 >>> exim.test.ex in helo_lookup_domains?
186 >>>  list element: @
187 >>>  list element: @[]
188 >>> exim.test.ex in helo_lookup_domains? no (end of list)
189 >>>  list element: *
190 >>>  host in limits_advertise_hosts? yes (matched "*")
191 >>> host in dsn_advertise_hosts? no (option unset)
192 >>> host in pipelining_advertise_hosts?
193 >>>  list element: *
194 >>>  host in pipelining_advertise_hosts? yes (matched "*")
195 >>> host in chunking_advertise_hosts?
196 >>> host in chunking_advertise_hosts? no (end of list)
197 >>> using ACL "check_recipient"
198 >>> processing "accept" (TESTSUITE/test-config 19)
199 >>> check hosts = :
200 >>> host in ":"?
201 >>>  list element: 
202 >>> host in ":"? no (end of list)
203 >>> accept: condition test failed in ACL "check_recipient"
204 >>> processing "accept" (TESTSUITE/test-config 20)
205 >>> check recipients = postmaster@exim.test.ex
206 >>> list@exim.test.ex in "postmaster@exim.test.ex"?
207 >>>  list element: postmaster@exim.test.ex
208 >>> list@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
209 >>> accept: condition test failed in ACL "check_recipient"
210 >>> processing "accept" (TESTSUITE/test-config 21)
211 >>> check senders = myfriend@*
212 >>> myfriend@there.test.ex in "myfriend@*"?
213 >>>  list element: myfriend@*
214 >>>  there.test.ex in "*"?
215 >>>   list element: *
216 >>>   there.test.ex in "*"? yes (matched "*")
217 >>>  myfriend@there.test.ex in "myfriend@*"? yes (matched "myfriend@*")
218 >>> accept: condition test succeeded in ACL "check_recipient"
219 >>> end of ACL "check_recipient": ACCEPT
220 >>> host in ignore_fromline_hosts? no (option unset)
221 LOG: 10HmaY-000000005vi-0000 <= myfriend@there.test.ex H=(exim.test.ex) [V4NET.11.12.13] P=esmtp S=sss
222 Exim version x.yz ....
223 changed uid/gid: forcing real = effective
224   uid=uuuu gid=CALLER_GID pid=p1235
225 configuration file is TESTSUITE/test-config
226 admin user
227 changed uid/gid: privilege not needed
228   uid=EXIM_UID gid=EXIM_GID pid=p1235
229 seeking password data for user "CALLER": cache not available
230 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
231 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
232 sender address = CALLER@exim.test.ex
233 sender_fullhost = [V4NET.99.99.99]
234 sender_rcvhost = [V4NET.99.99.99]
235 host in hosts_connection_nolog? no (option unset)
236 LOG: smtp_connection MAIN
237   SMTP connection from [V4NET.99.99.99]
238 host in host_lookup? no (option unset)
239 set_process_info: pppp handling incoming connection from [V4NET.99.99.99]
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 SMTP>> 220 the.local.host.name ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
247 smtp_setup_msg entered
248 SMTP<< ehlo exim.test.ex
249 exim.test.ex in helo_lookup_domains?
250  list element: @
251  list element: @[]
252 exim.test.ex in helo_lookup_domains? no (end of list)
253 sender_fullhost = (exim.test.ex) [V4NET.99.99.99]
254 sender_rcvhost = [V4NET.99.99.99] (helo=exim.test.ex)
255 set_process_info: pppp handling incoming connection from (exim.test.ex) [V4NET.99.99.99]
256  list element: *
257   host in limits_advertise_hosts? yes (matched "*")
258 host in dsn_advertise_hosts? no (option unset)
259 host in pipelining_advertise_hosts?
260  list element: *
261   host in pipelining_advertise_hosts? yes (matched "*")
262 host in chunking_advertise_hosts?
263 host in chunking_advertise_hosts? no (end of list)
264 SMTP>> 250-the.local.host.name Hello exim.test.ex [V4NET.99.99.99]
265        250-SIZE 52428800
266        250-LIMITS MAILMAX=1000 RCPTMAX=50000
267        250-8BITMIME
268        250-PIPELINING
269        250 HELP
270 SMTP<< mail from:postmaster@exim.test.ex
271 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
272 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
273 SMTP>> 250 OK
274 SMTP<< rcpt to:list@exim.test.ex
275 using ACL "check_recipient"
276 processing "accept" (TESTSUITE/test-config 19)
277 check hosts = :
278 host in ":"?
279  list element: 
280 host in ":"? no (end of list)
281 accept: condition test failed in ACL "check_recipient"
282 processing "accept" (TESTSUITE/test-config 20)
283 check recipients = postmaster@exim.test.ex
284 list@exim.test.ex in "postmaster@exim.test.ex"?
285  list element: postmaster@exim.test.ex
286  address match test: subject=list@exim.test.ex pattern=postmaster@exim.test.ex
287 list@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
288 accept: condition test failed in ACL "check_recipient"
289 processing "accept" (TESTSUITE/test-config 21)
290 check senders = myfriend@*
291 postmaster@exim.test.ex in "myfriend@*"?
292  list element: myfriend@*
293  address match test: subject=postmaster@exim.test.ex pattern=myfriend@*
294 postmaster@exim.test.ex in "myfriend@*"? no (end of list)
295 accept: condition test failed in ACL "check_recipient"
296 processing "deny" (TESTSUITE/test-config 22)
297   message: host is listed in $dnslist_domain
298 check dnslists = rbl.test.ex
299 dnslists check: rbl.test.ex
300 new DNS lookup for 99.99.99.V4NET.rbl.test.ex
301 DNS lookup of 99.99.99.V4NET.rbl.test.ex (A) using fakens
302 DNS lookup of 99.99.99.V4NET.rbl.test.ex (A) gave HOST_NOT_FOUND
303 returning DNS_NOMATCH
304 faking res_search(A) response length as 65535
305  writing neg-cache entry for 99.99.99.V4NET.rbl.test.ex-A-xxxx, ttl 3000
306 faking res_search(A) response length as 65535
307 dnslists: wrote cache entry, ttl=3000
308 DNS lookup for 99.99.99.V4NET.rbl.test.ex failed
309 => that means V4NET.99.99.99 is not listed at rbl.test.ex
310 deny: condition test failed in ACL "check_recipient"
311 processing "require" (TESTSUITE/test-config 24)
312 check verify = sender
313 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
314 Verifying postmaster@exim.test.ex
315 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
316 Considering postmaster@exim.test.ex
317 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
318 routing postmaster@exim.test.ex
319 --------> localuser router <--------
320 local_part=postmaster domain=exim.test.ex
321 checking local_parts
322 postmaster in local_parts?
323  list element: userx
324 postmaster in local_parts? no (end of list)
325 localuser router skipped: local_parts mismatch
326 no more routers
327 ----------- end verify ------------
328 require: condition test failed in ACL "check_recipient"
329 end of ACL "check_recipient": not OK
330 LOG: MAIN REJECT
331   H=(exim.test.ex) [V4NET.99.99.99] sender verify fail for <postmaster@exim.test.ex>: Unrouteable address
332 SMTP>> 550-Verification failed for <postmaster@exim.test.ex>
333 SMTP>> 550-Unrouteable address
334 SMTP>> 550 Sender verify failed
335 LOG: MAIN REJECT
336   H=(exim.test.ex) [V4NET.99.99.99] F=<postmaster@exim.test.ex> rejected RCPT list@exim.test.ex: Sender verify failed
337 SMTP>> 421 the.local.host.name lost input connection
338 LOG: lost_incoming_connection MAIN
339   unexpected disconnection while reading SMTP command from (exim.test.ex) [V4NET.99.99.99] D=qqs
340 search_tidyup called
341 >>>>>>>>>>>>>>>> Exim pid=p1235 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>