Cutthrough: handle request when a callout-hold is active. Bug 2604
[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 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 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
20 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
21 SMTP>> 250 OK
22 SMTP<< rcpt to:<abc@local>
23 using ACL "rcpt"
24 processing "deny" (TESTSUITE/test-config 19)
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 host_fake_gethostbyname returned 1 (HOST_NOT_FOUND)
56 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
57 local host found for non-MX address
58 fully qualified name = 127.0.0.1
59 MUNGED: ::1 will be omitted in what follows
60 get[host|ipnode]byname[2] looked up these IP addresses:
61   name=127.0.0.1 address=127.0.0.1
62 remote host address is the local host: remote: configured to try delivery anyway
63 queued for t2 transport: local_part = qq
64 domain = remote
65   errors_to=NULL
66   domain_data=remote localpart_data=NULL
67 routed by r2 router
68   envelope to: qq@remote
69   transport: t2
70   host 127.0.0.1 [127.0.0.1]
71 ----------- end verify ------------
72 sender qq@remote verified ok
73 deny: condition test failed in ACL "rcpt"
74 processing "warn" (TESTSUITE/test-config 21)
75 check senders = qq@remote
76 address match test: subject=qq@remote pattern=qq@remote
77 remote in "remote"? yes (matched "remote")
78 qq@remote in "qq@remote"? yes (matched "qq@remote")
79 check !verify = sender/callout
80 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
81 Verifying qq@remote
82 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
83 Considering qq@remote
84 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
85 routing qq@remote
86 --------> r1 router <--------
87 local_part=qq domain=remote
88 checking domains
89 remote in "local"? no (end of list)
90 r1 router skipped: domains mismatch
91 --------> r2 router <--------
92 local_part=qq domain=remote
93 checking domains
94 remote in "remote"? yes (matched "remote")
95 calling r2 router
96 r2 router called for qq@remote
97   domain = remote
98 route_item = * 127.0.0.1
99 remote in "*"? yes (matched "*")
100 original list of hosts = '127.0.0.1' options = ''
101 expanded list of hosts = '127.0.0.1' options = ''
102 finding IP address for 127.0.0.1
103 calling host_find_byname
104 host_fake_gethostbyname returned 1 (HOST_NOT_FOUND)
105 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
106 local host found for non-MX address
107 fully qualified name = 127.0.0.1
108 MUNGED: ::1 will be omitted in what follows
109 get[host|ipnode]byname[2] looked up these IP addresses:
110   name=127.0.0.1 address=127.0.0.1
111 remote host address is the local host: remote: configured to try delivery anyway
112 queued for t2 transport: local_part = qq
113 domain = remote
114   errors_to=NULL
115   domain_data=remote localpart_data=NULL
116 routed by r2 router
117   envelope to: qq@remote
118   transport: t2
119   host 127.0.0.1 [127.0.0.1]
120 Attempting full verification using callout
121  locking TESTSUITE/spool/db/callout.lockfile
122  locked  TESTSUITE/spool/db/callout.lockfile
123  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
124  returned from EXIM_DBOPEN: 0xAAAAAAAA
125  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
126  dbfn_read: key=remote
127  callout cache: found domain record for remote
128  dbfn_read: key=qq@remote
129  callout cache: no address record found for qq@remote
130  EXIM_DBCLOSE(0xAAAAAAAA)
131  closed hints database and lockfile
132 interface=NULL port=1224
133 Connecting to 127.0.0.1 [127.0.0.1]:1224 ...  connected
134   SMTP<< 220 Server ready
135 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
136   SMTP>> EHLO mail.test.ex
137 cmd buf flush ddd bytes
138   SMTP<< 250 OK
139 not using PIPELINING
140 not using DSN
141 127.0.0.1 in hosts_require_auth? no (option unset)
142   SMTP>> MAIL FROM:<>
143 cmd buf flush ddd bytes
144   SMTP<< 250 OK
145   SMTP>> RCPT TO:<qq@remote>
146 cmd buf flush ddd bytes
147 sync_responses expect rcpt
148   SMTP<< 550 Unknown
149   SMTP>> QUIT
150 cmd buf flush ddd bytes
151   SMTP<< 250 OK
152   SMTP(close)>>
153  locking TESTSUITE/spool/db/callout.lockfile
154  locked  TESTSUITE/spool/db/callout.lockfile
155  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR|O_CREAT
156  returned from EXIM_DBOPEN: 0xAAAAAAAA
157  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
158  dbfn_write: key=remote
159  wrote callout cache domain record for remote:
160    result=1 postmaster=0 random=0
161  dbfn_write: key=qq@remote
162  wrote negative callout cache address record for qq@remote
163  EXIM_DBCLOSE(0xAAAAAAAA)
164  closed hints database and lockfile
165 ----------- end verify ------------
166 l_message: $acl_verify_message
167 warn: condition test succeeded in ACL "rcpt"
168 LOG: MAIN
169   U=CALLER Warning: Sender verify failed: 127.0.0.1 [127.0.0.1] : SMTP error from remote mail server after RCPT TO:<qq@remote>: 550 Unknown
170 processing "accept" (TESTSUITE/test-config 24)
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 accept: condition test succeeded in ACL "rcpt"
176 end of ACL "rcpt": ACCEPT
177 SMTP>> 250 Accepted
178 SMTP<< rcpt to:<xyz@local>
179 using ACL "rcpt"
180 processing "deny" (TESTSUITE/test-config 19)
181 check senders = qq@remote
182 address match test: subject=qq@remote pattern=qq@remote
183 remote in "remote"? yes (matched "remote")
184 qq@remote in "qq@remote"? yes (matched "qq@remote")
185 check !verify = sender
186 using cached sender verify result
187 deny: condition test failed in ACL "rcpt"
188 processing "warn" (TESTSUITE/test-config 21)
189 check senders = qq@remote
190 address match test: subject=qq@remote pattern=qq@remote
191 remote in "remote"? yes (matched "remote")
192 qq@remote in "qq@remote"? yes (matched "qq@remote")
193 check !verify = sender/callout
194 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
195 Verifying qq@remote
196 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
197 Considering qq@remote
198 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
199 routing qq@remote
200 --------> r1 router <--------
201 local_part=qq domain=remote
202 checking domains
203 remote in "local"? no (end of list)
204 r1 router skipped: domains mismatch
205 --------> r2 router <--------
206 local_part=qq domain=remote
207 checking domains
208 remote in "remote"? yes (matched "remote")
209 calling r2 router
210 r2 router called for qq@remote
211   domain = remote
212 route_item = * 127.0.0.1
213 remote in "*"? yes (matched "*")
214 original list of hosts = '127.0.0.1' options = ''
215 expanded list of hosts = '127.0.0.1' options = ''
216 finding IP address for 127.0.0.1
217 calling host_find_byname
218 host_fake_gethostbyname returned 1 (HOST_NOT_FOUND)
219 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
220 local host found for non-MX address
221 fully qualified name = 127.0.0.1
222 MUNGED: ::1 will be omitted in what follows
223 get[host|ipnode]byname[2] looked up these IP addresses:
224   name=127.0.0.1 address=127.0.0.1
225 remote host address is the local host: remote: configured to try delivery anyway
226 queued for t2 transport: local_part = qq
227 domain = remote
228   errors_to=NULL
229   domain_data=remote localpart_data=NULL
230 routed by r2 router
231   envelope to: qq@remote
232   transport: t2
233   host 127.0.0.1 [127.0.0.1]
234 Attempting full verification using callout
235  locking TESTSUITE/spool/db/callout.lockfile
236  locked  TESTSUITE/spool/db/callout.lockfile
237  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
238  returned from EXIM_DBOPEN: 0xAAAAAAAA
239  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
240  dbfn_read: key=remote
241  callout cache: found domain record for remote
242  dbfn_read: key=qq@remote
243  callout cache: found address record for qq@remote
244  callout cache: address record is negative
245  EXIM_DBCLOSE(0xAAAAAAAA)
246  closed hints database and lockfile
247 ----------- end verify ------------
248 l_message: $acl_verify_message
249 warn: condition test succeeded in ACL "rcpt"
250 LOG: MAIN
251   U=CALLER Warning: Sender verify failed
252 processing "accept" (TESTSUITE/test-config 24)
253 check senders = qq@remote
254 address match test: subject=qq@remote pattern=qq@remote
255 remote in "remote"? yes (matched "remote")
256 qq@remote in "qq@remote"? yes (matched "qq@remote")
257 accept: condition test succeeded in ACL "rcpt"
258 end of ACL "rcpt": ACCEPT
259 SMTP>> 250 Accepted
260 SMTP<< quit
261 SMTP>> 221 mail.test.ex closing connection
262 LOG: smtp_connection MAIN
263   SMTP connection from CALLER closed by QUIT
264 search_tidyup called
265 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>