Log expansion failures
[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 SMTP>> 250 OK
20 SMTP<< rcpt to:<abc@local>
21 using ACL "rcpt"
22 processing "deny"
23 check senders = qq@remote
24 address match test: 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 in ACL "rcpt"
71 processing "warn"
72 check senders = qq@remote
73 address match test: 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 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
130   SMTP>> EHLO mail.test.ex
131   SMTP<< 250 OK
132 127.0.0.1 in hosts_require_auth? no (option unset)
133   SMTP>> MAIL FROM:<>
134   SMTP<< 250 OK
135   SMTP>> RCPT TO:<qq@remote>
136   SMTP<< 550 Unknown
137   SMTP>> QUIT
138 locking TESTSUITE/spool/db/callout.lockfile
139 locked TESTSUITE/spool/db/callout.lockfile
140 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
141 returned from EXIM_DBOPEN
142 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
143 dbfn_write: key=remote
144 wrote callout cache domain record:
145   result=1 postmaster=0 random=0
146 dbfn_write: key=qq@remote
147 wrote negative callout cache address record
148 ----------- end verify ------------
149 warn: condition test succeeded in ACL "rcpt"
150 LOG: MAIN
151   U=CALLER Warning: Sender verify failed: response to "RCPT TO:<qq@remote>" from 127.0.0.1 [127.0.0.1] was: 550 Unknown
152 processing "accept"
153 check senders = qq@remote
154 address match test: subject=qq@remote pattern=qq@remote
155 remote in "remote"? yes (matched "remote")
156 qq@remote in "qq@remote"? yes (matched "qq@remote")
157 accept: condition test succeeded in ACL "rcpt"
158 SMTP>> 250 Accepted
159 SMTP<< rcpt to:<xyz@local>
160 using ACL "rcpt"
161 processing "deny"
162 check senders = qq@remote
163 address match test: subject=qq@remote pattern=qq@remote
164 remote in "remote"? yes (matched "remote")
165 qq@remote in "qq@remote"? yes (matched "qq@remote")
166 check !verify = sender
167 using cached sender verify result
168 deny: condition test failed in ACL "rcpt"
169 processing "warn"
170 check senders = qq@remote
171 address match test: subject=qq@remote pattern=qq@remote
172 remote in "remote"? yes (matched "remote")
173 qq@remote in "qq@remote"? yes (matched "qq@remote")
174 check !verify = sender/callout
175 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
176 Verifying qq@remote
177 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
178 Considering qq@remote
179 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
180 routing qq@remote
181 --------> r1 router <--------
182 local_part=qq domain=remote
183 checking domains
184 remote in "local"? no (end of list)
185 r1 router skipped: domains mismatch
186 --------> r2 router <--------
187 local_part=qq domain=remote
188 checking domains
189 remote in "remote"? yes (matched "remote")
190 calling r2 router
191 r2 router called for qq@remote
192   domain = remote
193 route_item = * 127.0.0.1
194 remote in "*"? yes (matched "*")
195 original list of hosts = "127.0.0.1" options = 
196 expanded list of hosts = "127.0.0.1" options = 
197 finding IP address for 127.0.0.1
198 calling host_find_byname
199 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
200 local host found for non-MX address
201 fully qualified name = 127.0.0.1
202 MUNGED: ::1 will be omitted in what follows
203 get[host|ipnode]byname[2] looked up these IP addresses:
204   name=127.0.0.1 address=127.0.0.1
205 remote host address is the local host: remote: configured to try delivery anyway
206 queued for t2 transport: local_part = qq
207 domain = remote
208   errors_to=NULL
209   domain_data=NULL localpart_data=NULL
210 routed by r2 router
211   envelope to: qq@remote
212   transport: t2
213   host 127.0.0.1 [127.0.0.1]
214 Attempting full verification using callout
215 locking TESTSUITE/spool/db/callout.lockfile
216 locked TESTSUITE/spool/db/callout.lockfile
217 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
218 returned from EXIM_DBOPEN
219 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
220 dbfn_read: key=remote
221 callout cache: found domain record
222 dbfn_read: key=qq@remote
223 callout cache: found address record
224 callout cache: address record is negative
225 ----------- end verify ------------
226 warn: condition test succeeded in ACL "rcpt"
227 LOG: MAIN
228   U=CALLER Warning: Sender verify failed
229 processing "accept"
230 check senders = qq@remote
231 address match test: subject=qq@remote pattern=qq@remote
232 remote in "remote"? yes (matched "remote")
233 qq@remote in "qq@remote"? yes (matched "qq@remote")
234 accept: condition test succeeded in ACL "rcpt"
235 SMTP>> 250 Accepted
236 SMTP<< quit
237 SMTP>> 221 mail.test.ex closing connection
238 LOG: smtp_connection MAIN
239   SMTP connection from CALLER closed by QUIT
240 search_tidyup called
241 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>