BUGFIX: forced-fail smtp option tls_sni would dereference NULL
[exim.git] / test / stderr / 0432
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 "mail"
10 >>> processing "accept"
11 >>> check verify = sender/callout=1s,maxwait=1s
12 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
13 >>> routing x@y
14 >>> calling r1 router
15 >>> routed by r1 router
16 >>> local host found for non-MX address
17 >>> fully qualified name = 127.0.0.1
18 MUNGED: ::1 will be omitted in what follows
19 >>> get[host|ipnode]byname[2] looked up these IP addresses:
20 >>>   name=127.0.0.1 address=127.0.0.1
21 >>> Attempting full verification using callout
22 >>> ... callout omitted by default when host testing
23 >>> (Use -bhc if you want the callouts to happen.)
24 >>> ----------- end verify ------------
25 >>> accept: condition test succeeded in ACL "mail"
26 Exim version x.yz ....
27 changed uid/gid: forcing real = effective
28   uid=uuuu gid=CALLER_GID pid=pppp
29 configuration file is TESTSUITE/test-config
30 admin user
31 changed uid/gid: privilege not needed
32   uid=EXIM_UID gid=EXIM_GID pid=pppp
33 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
34 sender address = CALLER@myhost.test.ex
35 sender_fullhost = [1.2.3.4]
36 sender_rcvhost = [1.2.3.4]
37 host in hosts_connection_nolog? no (option unset)
38 LOG: smtp_connection MAIN
39   SMTP connection from [1.2.3.4]
40 host in host_lookup? no (option unset)
41 set_process_info: pppp handling incoming connection from [1.2.3.4]
42 host in host_reject_connection? no (option unset)
43 host in sender_unqualified_hosts? no (option unset)
44 host in recipient_unqualified_hosts? no (option unset)
45 host in helo_verify_hosts? no (option unset)
46 host in helo_try_verify_hosts? no (option unset)
47 host in helo_accept_junk_hosts? no (option unset)
48 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
49 smtp_setup_msg entered
50 SMTP<< mail from:<x@y>
51 using ACL "mail"
52 processing "accept"
53 check verify = sender/callout=1s,maxwait=1s
54 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
55 Verifying x@y
56 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
57 Considering x@y
58 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
59 routing x@y
60 --------> r1 router <--------
61 local_part=x domain=y
62 calling r1 router
63 r1 router called for x@y
64   domain = y
65 set transport t1
66 queued for t1 transport: local_part = x
67 domain = y
68   errors_to=NULL
69   domain_data=NULL localpart_data=NULL
70 routed by r1 router
71   envelope to: x@y
72   transport: t1
73 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
74 local host found for non-MX address
75 fully qualified name = 127.0.0.1
76 MUNGED: ::1 will be omitted in what follows
77 get[host|ipnode]byname[2] looked up these IP addresses:
78   name=127.0.0.1 address=127.0.0.1
79 Attempting full verification using callout
80 locking TESTSUITE/spool/db/callout.lockfile
81 locked TESTSUITE/spool/db/callout.lockfile
82 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
83 returned from EXIM_DBOPEN
84 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
85 dbfn_read: key=y
86 callout cache: no domain record found
87 dbfn_read: key=x@y
88 callout cache: no address record found
89 interface=NULL port=1224
90 Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected
91   SMTP<< 220 server ready
92 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
93   SMTP>> EHLO myhost.test.ex
94   SMTP<< 250 OK
95   SMTP>> MAIL FROM:<>
96   SMTP<< 250 OK
97   SMTP>> RCPT TO:<x@y>
98   SMTP<< 250 OK
99   SMTP>> QUIT
100 locking TESTSUITE/spool/db/callout.lockfile
101 locked TESTSUITE/spool/db/callout.lockfile
102 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
103 returned from EXIM_DBOPEN
104 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
105 dbfn_write: key=y
106 wrote callout cache domain record:
107   result=1 postmaster=0 random=0
108 dbfn_write: key=x@y
109 wrote positive callout cache address record
110 ----------- end verify ------------
111 sender x@y verified ok
112 accept: condition test succeeded in ACL "mail"
113 SMTP>> 250 OK
114 SMTP<< quit
115 SMTP>> 221 myhost.test.ex closing connection
116 LOG: smtp_connection MAIN
117   SMTP connection from [1.2.3.4] closed by QUIT
118 search_tidyup called
119 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
120 Exim version x.yz ....
121 changed uid/gid: forcing real = effective
122   uid=uuuu gid=CALLER_GID pid=pppp
123 configuration file is TESTSUITE/test-config
124 admin user
125 changed uid/gid: privilege not needed
126   uid=EXIM_UID gid=EXIM_GID pid=pppp
127 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
128 sender address = CALLER@myhost.test.ex
129 sender_fullhost = [1.2.3.4]
130 sender_rcvhost = [1.2.3.4]
131 host in hosts_connection_nolog? no (option unset)
132 LOG: smtp_connection MAIN
133   SMTP connection from [1.2.3.4]
134 host in host_lookup? no (option unset)
135 set_process_info: pppp handling incoming connection from [1.2.3.4]
136 host in host_reject_connection? no (option unset)
137 host in sender_unqualified_hosts? no (option unset)
138 host in recipient_unqualified_hosts? no (option unset)
139 host in helo_verify_hosts? no (option unset)
140 host in helo_try_verify_hosts? no (option unset)
141 host in helo_accept_junk_hosts? no (option unset)
142 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
143 smtp_setup_msg entered
144 SMTP<< mail from:<x@y>
145 using ACL "mail"
146 processing "accept"
147 check verify = sender/callout=1s,maxwait=1s
148 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
149 Verifying x@y
150 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
151 Considering x@y
152 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
153 routing x@y
154 --------> r1 router <--------
155 local_part=x domain=y
156 calling r1 router
157 r1 router called for x@y
158   domain = y
159 set transport t1
160 queued for t1 transport: local_part = x
161 domain = y
162   errors_to=NULL
163   domain_data=NULL localpart_data=NULL
164 routed by r1 router
165   envelope to: x@y
166   transport: t1
167 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
168 local host found for non-MX address
169 fully qualified name = 127.0.0.1
170 MUNGED: ::1 will be omitted in what follows
171 get[host|ipnode]byname[2] looked up these IP addresses:
172   name=127.0.0.1 address=127.0.0.1
173 Attempting full verification using callout
174 locking TESTSUITE/spool/db/callout.lockfile
175 locked TESTSUITE/spool/db/callout.lockfile
176 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
177 returned from EXIM_DBOPEN
178 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
179 dbfn_read: key=y
180 callout cache: found domain record
181 dbfn_read: key=x@y
182 callout cache: found address record
183 callout cache: address record is positive
184 ----------- end verify ------------
185 sender x@y verified ok
186 accept: condition test succeeded in ACL "mail"
187 SMTP>> 250 OK
188 SMTP<< quit
189 SMTP>> 221 myhost.test.ex closing connection
190 LOG: smtp_connection MAIN
191   SMTP connection from [1.2.3.4] closed by QUIT
192 search_tidyup called
193 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
194 >>> host in hosts_connection_nolog? no (option unset)
195 >>> host in host_lookup? no (option unset)
196 >>> host in host_reject_connection? no (option unset)
197 >>> host in sender_unqualified_hosts? no (option unset)
198 >>> host in recipient_unqualified_hosts? no (option unset)
199 >>> host in helo_verify_hosts? no (option unset)
200 >>> host in helo_try_verify_hosts? no (option unset)
201 >>> host in helo_accept_junk_hosts? no (option unset)
202 >>> using ACL "mail"
203 >>> processing "accept"
204 >>> check verify = sender/callout=1s,maxwait=1s
205 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
206 >>> routing x@y
207 >>> calling r1 router
208 >>> routed by r1 router
209 >>> local host found for non-MX address
210 >>> fully qualified name = 127.0.0.1
211 MUNGED: ::1 will be omitted in what follows
212 >>> get[host|ipnode]byname[2] looked up these IP addresses:
213 >>>   name=127.0.0.1 address=127.0.0.1
214 >>> Attempting full verification using callout
215 >>> callout cache: found domain record
216 >>> callout cache: found address record
217 >>> callout cache: address record is positive
218 >>> ----------- end verify ------------
219 >>> accept: condition test succeeded in ACL "mail"
220 >>> host in hosts_connection_nolog? no (option unset)
221 >>> host in host_lookup? no (option unset)
222 >>> host in host_reject_connection? no (option unset)
223 >>> host in sender_unqualified_hosts? no (option unset)
224 >>> host in recipient_unqualified_hosts? no (option unset)
225 >>> host in helo_verify_hosts? no (option unset)
226 >>> host in helo_try_verify_hosts? no (option unset)
227 >>> host in helo_accept_junk_hosts? no (option unset)
228 >>> using ACL "mail"
229 >>> processing "accept"
230 >>> check verify = sender/callout=1s,maxwait=1s
231 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
232 >>> routing a@b
233 >>> calling r1 router
234 >>> routed by r1 router
235 >>> local host found for non-MX address
236 >>> fully qualified name = 127.0.0.1
237 MUNGED: ::1 will be omitted in what follows
238 >>> get[host|ipnode]byname[2] looked up these IP addresses:
239 >>>   name=127.0.0.1 address=127.0.0.1
240 >>> Attempting full verification using callout
241 >>> callout cache: no domain record found
242 >>> callout cache: no address record found
243 >>> interface=NULL port=1224
244 >>> Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected
245 >>>   SMTP<< 220 server ready
246 >>> 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
247 >>>   SMTP>> EHLO myhost.test.ex
248 >>>   SMTP<< 250 OK
249 >>>   SMTP>> MAIL FROM:<>
250 >>>   SMTP<< 250 OK
251 >>>   SMTP>> RCPT TO:<a@b>
252 >>>   SMTP<< 250 OK
253 >>>   SMTP>> QUIT
254 >>> wrote callout cache domain record:
255 >>>   result=1 postmaster=0 random=0
256 >>> wrote positive callout cache address record
257 >>> ----------- end verify ------------
258 >>> accept: condition test succeeded in ACL "mail"
259 >>> host in hosts_connection_nolog? no (option unset)
260 >>> host in host_lookup? no (option unset)
261 >>> host in host_reject_connection? no (option unset)
262 >>> host in sender_unqualified_hosts? no (option unset)
263 >>> host in recipient_unqualified_hosts? no (option unset)
264 >>> host in helo_verify_hosts? no (option unset)
265 >>> host in helo_try_verify_hosts? no (option unset)
266 >>> host in helo_accept_junk_hosts? no (option unset)
267 >>> using ACL "mail"
268 >>> processing "accept"
269 >>> check verify = sender/callout=1s,maxwait=1s
270 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
271 >>> routing p1@q
272 >>> calling r1 router
273 >>> routed by r1 router
274 >>> local host found for non-MX address
275 >>> fully qualified name = 127.0.0.1
276 MUNGED: ::1 will be omitted in what follows
277 >>> get[host|ipnode]byname[2] looked up these IP addresses:
278 >>>   name=127.0.0.1 address=127.0.0.1
279 >>> Attempting full verification using callout
280 >>> callout cache: no domain record found
281 >>> callout cache: no address record found
282 >>> interface=NULL port=1224
283 >>> Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected
284 >>>   SMTP<< 220 server ready
285 >>> 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
286 >>>   SMTP>> EHLO myhost.test.ex
287 >>> SMTP timeout
288 >>> ----------- end verify ------------
289 >>> accept: condition test deferred in ACL "mail"
290 LOG: H=[1.2.3.4] sender verify defer for <p1@q>: Could not complete sender verify callout
291 LOG: H=[1.2.3.4] temporarily rejected MAIL <p1@q>: Could not complete sender verify callout