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