Debug: indent lookup operations
[users/heiko/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 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" (TESTSUITE/test-config 21)
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: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
122  returned from EXIM_DBOPEN: 0xAAAAAAAA
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  EXIM_DBCLOSE(0xAAAAAAAA)
129  closed hints database and lockfile
130 interface=NULL port=1224
131 Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected
132   SMTP<< 220 Server ready
133 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
134   SMTP>> EHLO mail.test.ex
135 cmd buf flush ddd bytes
136   SMTP<< 250 OK
137 not using PIPELINING
138 not using DSN
139 127.0.0.1 in hosts_require_auth? no (option unset)
140   SMTP>> MAIL FROM:<>
141 cmd buf flush ddd bytes
142   SMTP<< 250 OK
143   SMTP>> RCPT TO:<qq@remote>
144 cmd buf flush ddd bytes
145 sync_responses expect rcpt
146   SMTP<< 550 Unknown
147   SMTP>> QUIT
148 cmd buf flush ddd bytes
149   SMTP<< 250 OK
150   SMTP(close)>>
151  locking TESTSUITE/spool/db/callout.lockfile
152  locked  TESTSUITE/spool/db/callout.lockfile
153  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR|O_CREAT
154  returned from EXIM_DBOPEN: 0xAAAAAAAA
155  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
156  dbfn_write: key=remote
157 wrote callout cache domain record for remote:
158   result=1 postmaster=0 random=0
159  dbfn_write: key=qq@remote
160 wrote negative callout cache address record for qq@remote
161  EXIM_DBCLOSE(0xAAAAAAAA)
162  closed hints database and lockfile
163 ----------- end verify ------------
164 l_message: $acl_verify_message
165 warn: condition test succeeded in ACL "rcpt"
166 LOG: MAIN
167   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
168 processing "accept" (TESTSUITE/test-config 24)
169 check senders = qq@remote
170 address match test: subject=qq@remote pattern=qq@remote
171 remote in "remote"? yes (matched "remote")
172 qq@remote in "qq@remote"? yes (matched "qq@remote")
173 accept: condition test succeeded in ACL "rcpt"
174 end of ACL "rcpt": ACCEPT
175 SMTP>> 250 Accepted
176 DSN: orcpt: NULL  flags: 0
177 SMTP<< rcpt to:<xyz@local>
178 using ACL "rcpt"
179 processing "deny" (TESTSUITE/test-config 19)
180 check senders = qq@remote
181 address match test: subject=qq@remote pattern=qq@remote
182 remote in "remote"? yes (matched "remote")
183 qq@remote in "qq@remote"? yes (matched "qq@remote")
184 check !verify = sender
185 using cached sender verify result
186 deny: condition test failed in ACL "rcpt"
187 processing "warn" (TESTSUITE/test-config 21)
188 check senders = qq@remote
189 address match test: subject=qq@remote pattern=qq@remote
190 remote in "remote"? yes (matched "remote")
191 qq@remote in "qq@remote"? yes (matched "qq@remote")
192 check !verify = sender/callout
193 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
194 Verifying qq@remote
195 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
196 Considering qq@remote
197 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
198 routing qq@remote
199 --------> r1 router <--------
200 local_part=qq domain=remote
201 checking domains
202 remote in "local"? no (end of list)
203 r1 router skipped: domains mismatch
204 --------> r2 router <--------
205 local_part=qq domain=remote
206 checking domains
207 remote in "remote"? yes (matched "remote")
208 calling r2 router
209 r2 router called for qq@remote
210   domain = remote
211 route_item = * 127.0.0.1
212 remote in "*"? yes (matched "*")
213 original list of hosts = '127.0.0.1' options = ''
214 expanded list of hosts = '127.0.0.1' options = ''
215 finding IP address for 127.0.0.1
216 calling host_find_byname
217 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
218 local host found for non-MX address
219 fully qualified name = 127.0.0.1
220 MUNGED: ::1 will be omitted in what follows
221 get[host|ipnode]byname[2] looked up these IP addresses:
222   name=127.0.0.1 address=127.0.0.1
223 remote host address is the local host: remote: configured to try delivery anyway
224 queued for t2 transport: local_part = qq
225 domain = remote
226   errors_to=NULL
227   domain_data=NULL localpart_data=NULL
228 routed by r2 router
229   envelope to: qq@remote
230   transport: t2
231   host 127.0.0.1 [127.0.0.1]
232 Attempting full verification using callout
233  locking TESTSUITE/spool/db/callout.lockfile
234  locked  TESTSUITE/spool/db/callout.lockfile
235  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
236  returned from EXIM_DBOPEN: 0xAAAAAAAA
237  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
238  dbfn_read: key=remote
239 callout cache: found domain record for remote
240  dbfn_read: key=qq@remote
241 callout cache: found address record for qq@remote
242 callout cache: address record is negative
243  EXIM_DBCLOSE(0xAAAAAAAA)
244  closed hints database and lockfile
245 ----------- end verify ------------
246 l_message: $acl_verify_message
247 warn: condition test succeeded in ACL "rcpt"
248 LOG: MAIN
249   U=CALLER Warning: Sender verify failed
250 processing "accept" (TESTSUITE/test-config 24)
251 check senders = qq@remote
252 address match test: subject=qq@remote pattern=qq@remote
253 remote in "remote"? yes (matched "remote")
254 qq@remote in "qq@remote"? yes (matched "qq@remote")
255 accept: condition test succeeded in ACL "rcpt"
256 end of ACL "rcpt": ACCEPT
257 SMTP>> 250 Accepted
258 DSN: orcpt: NULL  flags: 0
259 SMTP<< quit
260 SMTP>> 221 mail.test.ex closing connection
261 LOG: smtp_connection MAIN
262   SMTP connection from CALLER closed by QUIT
263 search_tidyup called
264 >>>>>>>>>>>>>>>> Exim pid=pppp (msg setup toplevel) terminating with rc=0 >>>>>>>>>>>>>>>>