ACL: Ensure that acl_smtp_notquit is called for a conndrop between data-go-ahead...
[users/jgh/exim.git] / test / stderr / 0398
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=pppp
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=pppp
8 DSN: r1 propagating DSN
9 DSN: r2 propagating DSN
10 seeking password data for user "CALLER": cache not available
11 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
12 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
13 sender address = CALLER@test.ex
14 set_process_info: pppp accepting a local SMTP message from <CALLER@test.ex>
15  in hosts_connection_nolog? no (option unset)
16 LOG: smtp_connection MAIN
17   SMTP connection from CALLER
18 SMTP>> 220 mail.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
19 smtp_setup_msg entered
20 SMTP<< mail from:<qq@remote>
21 SMTP>> 250 OK
22 SMTP<< rcpt to:<abc@local>
23 using ACL "rcpt"
24 processing "deny"
25 check senders = qq@remote
26 address match test: subject=qq@remote pattern=qq@remote
27 remote in "remote"? yes (matched "remote")
28 qq@remote in "qq@remote"? yes (matched "qq@remote")
29 check !verify = sender
30 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
31 Verifying qq@remote
32 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
33 Considering qq@remote
34 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
35 routing qq@remote
36 --------> r1 router <--------
37 local_part=qq domain=remote
38 checking domains
39 remote in "local"? no (end of list)
40 r1 router skipped: domains mismatch
41 --------> r2 router <--------
42 local_part=qq domain=remote
43 checking domains
44 remote in "remote"? yes (matched "remote")
45 calling r2 router
46 r2 router called for qq@remote
47   domain = remote
48 route_item = * 127.0.0.1
49 remote in "*"? yes (matched "*")
50 original list of hosts = "127.0.0.1" options = 
51 expanded list of hosts = "127.0.0.1" options = 
52 set transport t2
53 finding IP address for 127.0.0.1
54 calling host_find_byname
55 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
56 local host found for non-MX address
57 fully qualified name = 127.0.0.1
58 MUNGED: ::1 will be omitted in what follows
59 get[host|ipnode]byname[2] looked up these IP addresses:
60   name=127.0.0.1 address=127.0.0.1
61 remote host address is the local host: remote: configured to try delivery anyway
62 queued for t2 transport: local_part = qq
63 domain = remote
64   errors_to=NULL
65   domain_data=NULL localpart_data=NULL
66 routed by r2 router
67   envelope to: qq@remote
68   transport: t2
69   host 127.0.0.1 [127.0.0.1]
70 ----------- end verify ------------
71 sender qq@remote verified ok
72 deny: condition test failed in ACL "rcpt"
73 processing "warn"
74 check senders = qq@remote
75 address match test: subject=qq@remote pattern=qq@remote
76 remote in "remote"? yes (matched "remote")
77 qq@remote in "qq@remote"? yes (matched "qq@remote")
78 check !verify = sender/callout
79 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
80 Verifying qq@remote
81 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
82 Considering qq@remote
83 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
84 routing qq@remote
85 --------> r1 router <--------
86 local_part=qq domain=remote
87 checking domains
88 remote in "local"? no (end of list)
89 r1 router skipped: domains mismatch
90 --------> r2 router <--------
91 local_part=qq domain=remote
92 checking domains
93 remote in "remote"? yes (matched "remote")
94 calling r2 router
95 r2 router called for qq@remote
96   domain = remote
97 route_item = * 127.0.0.1
98 remote in "*"? yes (matched "*")
99 original list of hosts = "127.0.0.1" options = 
100 expanded list of hosts = "127.0.0.1" options = 
101 finding IP address for 127.0.0.1
102 calling host_find_byname
103 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
104 local host found for non-MX address
105 fully qualified name = 127.0.0.1
106 MUNGED: ::1 will be omitted in what follows
107 get[host|ipnode]byname[2] looked up these IP addresses:
108   name=127.0.0.1 address=127.0.0.1
109 remote host address is the local host: remote: configured to try delivery anyway
110 queued for t2 transport: local_part = qq
111 domain = remote
112   errors_to=NULL
113   domain_data=NULL localpart_data=NULL
114 routed by r2 router
115   envelope to: qq@remote
116   transport: t2
117   host 127.0.0.1 [127.0.0.1]
118 Attempting full verification using callout
119 locking TESTSUITE/spool/db/callout.lockfile
120 locked TESTSUITE/spool/db/callout.lockfile
121 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
122 returned from EXIM_DBOPEN
123 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
124 dbfn_read: key=remote
125 callout cache: found domain record for remote
126 dbfn_read: key=qq@remote
127 callout cache: no address record found for qq@remote
128 interface=NULL port=1224
129 Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected
130   SMTP<< 220 Server ready
131 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
132   SMTP>> EHLO mail.test.ex
133 cmd buf flush ddd bytes
134   SMTP<< 250 OK
135 127.0.0.1 in hosts_require_auth? no (option unset)
136   SMTP>> MAIL FROM:<>
137 cmd buf flush ddd bytes
138   SMTP<< 250 OK
139   SMTP>> RCPT TO:<qq@remote>
140 cmd buf flush ddd bytes
141   SMTP<< 550 Unknown
142   SMTP>> QUIT
143 cmd buf flush ddd bytes
144 locking TESTSUITE/spool/db/callout.lockfile
145 locked TESTSUITE/spool/db/callout.lockfile
146 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
147 returned from EXIM_DBOPEN
148 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
149 dbfn_write: key=remote
150 wrote callout cache domain record for remote:
151   result=1 postmaster=0 random=0
152 dbfn_write: key=qq@remote
153 wrote negative callout cache address record for qq@remote
154 ----------- end verify ------------
155 l_message: $acl_verify_message
156 warn: condition test succeeded in ACL "rcpt"
157 LOG: MAIN
158   U=CALLER Warning: Sender verify failed: response to "RCPT TO:<qq@remote>" from 127.0.0.1 [127.0.0.1] was: 550 Unknown
159 processing "accept"
160 check senders = qq@remote
161 address match test: subject=qq@remote pattern=qq@remote
162 remote in "remote"? yes (matched "remote")
163 qq@remote in "qq@remote"? yes (matched "qq@remote")
164 accept: condition test succeeded in ACL "rcpt"
165 end of ACL "rcpt": ACCEPT
166 SMTP>> 250 Accepted
167 DSN: orcpt: NULL  flags: 0
168 SMTP<< rcpt to:<xyz@local>
169 using ACL "rcpt"
170 processing "deny"
171 check senders = qq@remote
172 address match test: subject=qq@remote pattern=qq@remote
173 remote in "remote"? yes (matched "remote")
174 qq@remote in "qq@remote"? yes (matched "qq@remote")
175 check !verify = sender
176 using cached sender verify result
177 deny: condition test failed in ACL "rcpt"
178 processing "warn"
179 check senders = qq@remote
180 address match test: subject=qq@remote pattern=qq@remote
181 remote in "remote"? yes (matched "remote")
182 qq@remote in "qq@remote"? yes (matched "qq@remote")
183 check !verify = sender/callout
184 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
185 Verifying qq@remote
186 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
187 Considering qq@remote
188 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
189 routing qq@remote
190 --------> r1 router <--------
191 local_part=qq domain=remote
192 checking domains
193 remote in "local"? no (end of list)
194 r1 router skipped: domains mismatch
195 --------> r2 router <--------
196 local_part=qq domain=remote
197 checking domains
198 remote in "remote"? yes (matched "remote")
199 calling r2 router
200 r2 router called for qq@remote
201   domain = remote
202 route_item = * 127.0.0.1
203 remote in "*"? yes (matched "*")
204 original list of hosts = "127.0.0.1" options = 
205 expanded list of hosts = "127.0.0.1" options = 
206 finding IP address for 127.0.0.1
207 calling host_find_byname
208 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
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 remote host address is the local host: remote: configured to try delivery anyway
215 queued for t2 transport: local_part = qq
216 domain = remote
217   errors_to=NULL
218   domain_data=NULL localpart_data=NULL
219 routed by r2 router
220   envelope to: qq@remote
221   transport: t2
222   host 127.0.0.1 [127.0.0.1]
223 Attempting full verification using callout
224 locking TESTSUITE/spool/db/callout.lockfile
225 locked TESTSUITE/spool/db/callout.lockfile
226 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
227 returned from EXIM_DBOPEN
228 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
229 dbfn_read: key=remote
230 callout cache: found domain record for remote
231 dbfn_read: key=qq@remote
232 callout cache: found address record for qq@remote
233 callout cache: address record is negative
234 ----------- end verify ------------
235 l_message: $acl_verify_message
236 warn: condition test succeeded in ACL "rcpt"
237 LOG: MAIN
238   U=CALLER Warning: Sender verify failed
239 processing "accept"
240 check senders = qq@remote
241 address match test: subject=qq@remote pattern=qq@remote
242 remote in "remote"? yes (matched "remote")
243 qq@remote in "qq@remote"? yes (matched "qq@remote")
244 accept: condition test succeeded in ACL "rcpt"
245 end of ACL "rcpt": ACCEPT
246 SMTP>> 250 Accepted
247 DSN: orcpt: NULL  flags: 0
248 SMTP<< quit
249 SMTP>> 221 mail.test.ex closing connection
250 LOG: smtp_connection MAIN
251   SMTP connection from CALLER closed by QUIT
252 search_tidyup called
253 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>