Debug: quieten environment-cleaning
[exim.git] / test / stderr / 0398
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=p1234
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=p1234
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<< helo test
19 SMTP>> 250 mail.test.ex Hello CALLER at test
20 SMTP<< mail from:<qq@remote>
21 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
22 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
23 SMTP>> 250 OK
24 SMTP<< rcpt to:<abc@local>
25 using ACL "rcpt"
26 processing "deny" (TESTSUITE/test-config 19)
27 check senders = qq@remote
28 qq@remote in "qq@remote"?
29  list element: qq@remote
30  address match test: subject=qq@remote pattern=qq@remote
31  remote in "remote"?
32   list element: remote
33   remote in "remote"? yes (matched "remote")
34  qq@remote in "qq@remote"? yes (matched "qq@remote")
35 check !verify = sender
36 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
37 Verifying qq@remote
38 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
39 Considering qq@remote
40 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
41 routing qq@remote
42 --------> r1 router <--------
43 local_part=qq domain=remote
44 checking domains
45 remote in "local"?
46  list element: local
47 remote in "local"? no (end of list)
48 r1 router skipped: domains mismatch
49 --------> r2 router <--------
50 local_part=qq domain=remote
51 checking domains
52 remote in "remote"?
53  list element: remote
54  remote in "remote"? yes (matched "remote")
55 calling r2 router
56 r2 router called for qq@remote
57   domain = remote
58 route_item = * 127.0.0.1
59 remote in "*"?
60  list element: *
61  remote in "*"? yes (matched "*")
62 original list of hosts = '127.0.0.1' options = ''
63 expanded list of hosts = '127.0.0.1' options = ''
64 set transport t2
65 finding IP address for 127.0.0.1
66 calling host_find_byname
67 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
68 local host found for non-MX address
69 fully qualified name = 127.0.0.1
70 MUNGED: ::1 will be omitted in what follows
71 get[host|ipnode]byname[2] looked up these IP addresses:
72   name=127.0.0.1 address=127.0.0.1
73 remote host address is the local host: remote: configured to try delivery anyway
74 queued for t2 transport: local_part = qq
75 domain = remote
76   errors_to=NULL
77   domain_data=remote local_part_data=NULL
78 routed by r2 router
79   envelope to: qq@remote
80   transport: t2
81   host 127.0.0.1 [127.0.0.1]
82 ----------- end verify ------------
83 sender qq@remote verified ok
84 deny: condition test failed in ACL "rcpt"
85 processing "warn" (TESTSUITE/test-config 21)
86 check senders = qq@remote
87 qq@remote in "qq@remote"?
88  list element: qq@remote
89  address match test: subject=qq@remote pattern=qq@remote
90  remote in "remote"?
91   list element: remote
92   remote in "remote"? yes (matched "remote")
93  qq@remote in "qq@remote"? yes (matched "qq@remote")
94 check !verify = sender/callout
95 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
96 Verifying qq@remote
97 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
98 Considering qq@remote
99 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
100 routing qq@remote
101 --------> r1 router <--------
102 local_part=qq domain=remote
103 checking domains
104 remote in "local"?
105  list element: local
106 remote in "local"? no (end of list)
107 r1 router skipped: domains mismatch
108 --------> r2 router <--------
109 local_part=qq domain=remote
110 checking domains
111 remote in "remote"?
112  list element: remote
113  remote in "remote"? yes (matched "remote")
114 calling r2 router
115 r2 router called for qq@remote
116   domain = remote
117 route_item = * 127.0.0.1
118 remote in "*"?
119  list element: *
120  remote in "*"? yes (matched "*")
121 original list of hosts = '127.0.0.1' options = ''
122 expanded list of hosts = '127.0.0.1' options = ''
123 finding IP address for 127.0.0.1
124 calling host_find_byname
125 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
126 local host found for non-MX address
127 fully qualified name = 127.0.0.1
128 MUNGED: ::1 will be omitted in what follows
129 get[host|ipnode]byname[2] looked up these IP addresses:
130   name=127.0.0.1 address=127.0.0.1
131 remote host address is the local host: remote: configured to try delivery anyway
132 queued for t2 transport: local_part = qq
133 domain = remote
134   errors_to=NULL
135   domain_data=remote local_part_data=NULL
136 routed by r2 router
137   envelope to: qq@remote
138   transport: t2
139   host 127.0.0.1 [127.0.0.1]
140 Attempting full verification using callout
141  locking TESTSUITE/spool/db/callout.lockfile
142  locked  TESTSUITE/spool/db/callout.lockfile
143  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
144  returned from EXIM_DBOPEN: 0xAAAAAAAA
145  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
146  dbfn_read: key=remote
147  callout cache: found domain record for remote
148  dbfn_read: key=qq@remote
149  callout cache: no address record found for qq@remote
150  EXIM_DBCLOSE(0xAAAAAAAA)
151  closed hints database and lockfile
152 interface=NULL port=PORT_S
153 Connecting to 127.0.0.1 [127.0.0.1]:PORT_S ... 127.0.0.1 in hosts_try_fastopen?
154  list element: 
155  connected
156   SMTP<< 220 Server ready
157 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
158   SMTP>> EHLO mail.test.ex
159 cmd buf flush ddd bytes
160   SMTP<< 250 OK
161  compiled RE '.outlook.com$' not found in local cache
162  compiling RE '.outlook.com$'
163  compiled RE '.outlook.com$' saved in local cache
164 not using PIPELINING
165 not using DSN
166 127.0.0.1 in hosts_require_auth? no (option unset)
167   SMTP>> MAIL FROM:<>
168 cmd buf flush ddd bytes
169   SMTP<< 250 OK
170   SMTP>> RCPT TO:<qq@remote>
171 cmd buf flush ddd bytes
172 sync_responses expect rcpt for qq@remote
173   SMTP<< 550 Unknown
174   SMTP>> QUIT
175 cmd buf flush ddd bytes
176   SMTP<< 250 OK
177   SMTP(close)>>
178 cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250'
179  locking TESTSUITE/spool/db/callout.lockfile
180  locked  TESTSUITE/spool/db/callout.lockfile
181  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR|O_CREAT
182  returned from EXIM_DBOPEN: 0xAAAAAAAA
183  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
184  dbfn_write: key=remote
185  wrote callout cache domain record for remote:
186    result=1 postmaster=0 random=0
187  dbfn_write: key=qq@remote
188  wrote negative callout cache address record for qq@remote
189  EXIM_DBCLOSE(0xAAAAAAAA)
190  closed hints database and lockfile
191 ----------- end verify ------------
192 l_message: $acl_verify_message
193 warn: condition test succeeded in ACL "rcpt"
194 LOG: MAIN
195   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
196 processing "accept" (TESTSUITE/test-config 24)
197 check senders = qq@remote
198 qq@remote in "qq@remote"?
199  list element: qq@remote
200  address match test: subject=qq@remote pattern=qq@remote
201  remote in "remote"?
202   list element: remote
203   remote in "remote"? yes (matched "remote")
204  qq@remote in "qq@remote"? yes (matched "qq@remote")
205 accept: condition test succeeded in ACL "rcpt"
206 end of ACL "rcpt": ACCEPT
207 SMTP>> 250 Accepted
208 SMTP<< rcpt to:<xyz@local>
209 using ACL "rcpt"
210 processing "deny" (TESTSUITE/test-config 19)
211 check senders = qq@remote
212 qq@remote in "qq@remote"?
213  list element: qq@remote
214  address match test: subject=qq@remote pattern=qq@remote
215  remote in "remote"?
216   list element: remote
217   remote in "remote"? yes (matched "remote")
218  qq@remote in "qq@remote"? yes (matched "qq@remote")
219 check !verify = sender
220 using cached sender verify result
221 deny: condition test failed in ACL "rcpt"
222 processing "warn" (TESTSUITE/test-config 21)
223 check senders = qq@remote
224 qq@remote in "qq@remote"?
225  list element: qq@remote
226  address match test: subject=qq@remote pattern=qq@remote
227  remote in "remote"?
228   list element: remote
229   remote in "remote"? yes (matched "remote")
230  qq@remote in "qq@remote"? yes (matched "qq@remote")
231 check !verify = sender/callout
232 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
233 Verifying qq@remote
234 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
235 Considering qq@remote
236 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
237 routing qq@remote
238 --------> r1 router <--------
239 local_part=qq domain=remote
240 checking domains
241 remote in "local"?
242  list element: local
243 remote in "local"? no (end of list)
244 r1 router skipped: domains mismatch
245 --------> r2 router <--------
246 local_part=qq domain=remote
247 checking domains
248 remote in "remote"?
249  list element: remote
250  remote in "remote"? yes (matched "remote")
251 calling r2 router
252 r2 router called for qq@remote
253   domain = remote
254 route_item = * 127.0.0.1
255 remote in "*"?
256  list element: *
257  remote in "*"? yes (matched "*")
258 original list of hosts = '127.0.0.1' options = ''
259 expanded list of hosts = '127.0.0.1' options = ''
260 finding IP address for 127.0.0.1
261 calling host_find_byname
262 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
263 local host found for non-MX address
264 fully qualified name = 127.0.0.1
265 MUNGED: ::1 will be omitted in what follows
266 get[host|ipnode]byname[2] looked up these IP addresses:
267   name=127.0.0.1 address=127.0.0.1
268 remote host address is the local host: remote: configured to try delivery anyway
269 queued for t2 transport: local_part = qq
270 domain = remote
271   errors_to=NULL
272   domain_data=remote local_part_data=NULL
273 routed by r2 router
274   envelope to: qq@remote
275   transport: t2
276   host 127.0.0.1 [127.0.0.1]
277 Attempting full verification using callout
278  locking TESTSUITE/spool/db/callout.lockfile
279  locked  TESTSUITE/spool/db/callout.lockfile
280  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
281  returned from EXIM_DBOPEN: 0xAAAAAAAA
282  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
283  dbfn_read: key=remote
284  callout cache: found domain record for remote
285  dbfn_read: key=qq@remote
286  callout cache: found address record for qq@remote
287  callout cache: address record is negative
288  EXIM_DBCLOSE(0xAAAAAAAA)
289  closed hints database and lockfile
290 ----------- end verify ------------
291 l_message: $acl_verify_message
292 warn: condition test succeeded in ACL "rcpt"
293 LOG: MAIN
294   U=CALLER Warning: Sender verify failed
295 processing "accept" (TESTSUITE/test-config 24)
296 check senders = qq@remote
297 qq@remote in "qq@remote"?
298  list element: qq@remote
299  address match test: subject=qq@remote pattern=qq@remote
300  remote in "remote"?
301   list element: remote
302   remote in "remote"? yes (matched "remote")
303  qq@remote in "qq@remote"? yes (matched "qq@remote")
304 accept: condition test succeeded in ACL "rcpt"
305 end of ACL "rcpt": ACCEPT
306 SMTP>> 250 Accepted
307 SMTP<< quit
308 SMTP>> 221 mail.test.ex closing connection
309 LOG: smtp_connection MAIN
310   SMTP connection from CALLER closed by QUIT
311 search_tidyup called
312 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>