Debug: clarify SMTP DATA ops in transport
[exim.git] / test / stderr / 0911
1 Exim version x.yz ....
2 configuration file is TESTSUITE/test-config
3 trusted user
4 admin user
5 LOG: smtp_connection MAIN
6   SMTP connection from root
7 created log directory TESTSUITE/spool/log
8 LOG: MAIN
9   <= fred@myhost.test.ex U=root P=local-smtp S=sss
10 Exim version x.yz ....
11 configuration file is TESTSUITE/test-config
12 trusted user
13 admin user
14 dropping to exim gid; retaining priv uid
15 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
16 --------> good@test.ex <--------
17 send_to_server transport entered
18   good@test.ex
19 using the transport's hosts: 127.0.0.1
20 getting address for 127.0.0.1
21 checking status of 127.0.0.1
22 127.0.0.1 [127.0.0.1]:1111 retry-status = usable
23 delivering 10HmaX-0005vi-00 to 127.0.0.1 [127.0.0.1] (good@test.ex)
24 Connecting to 127.0.0.1 [127.0.0.1]:1225 ...  connected
25   SMTP<< 220 Server ready
26   SMTP>> EHLO myhost.test.ex
27 cmd buf flush ddd bytes
28   SMTP<< 250-hi there
29          250-PIPELINING
30          250-CHUNKING
31          250 OK
32 using PIPELINING
33 CHUNKING usable
34 not using DSN
35   SMTP|> MAIL FROM:<>
36   SMTP|> RCPT TO:<good@test.ex>
37          will write message using CHUNKING
38 transport_check_waiting entered
39   sequence=1 local_max=500 global_max=-1
40  no messages waiting for 127.0.0.1
41 transport_check_waiting: FALSE
42 will pipeline QUIT
43   SMTP+> BDAT 315 LAST
44 cmd buf flush ddd bytes (more expected)
45 cannot use sendfile for body: spoolfile not wireformat
46 writing data block fd=dddd size=sss timeout=300 (more expected)
47   SMTP+> QUIT
48 cmd buf flush ddd bytes (more expected)
49   SMTP(shutdown)>>
50 sync_responses expect mail
51   SMTP<< 250 OK mail
52 sync_responses expect rcpt for good@test.ex
53   SMTP<< 250 OK rcpt
54   SMTP<< 250 OK chunked message data
55 ok=1 send_quit=0 send_rset=0 continue_more=0 yield=0 first_address is NULL
56   SMTP<< 221 Closing connection
57   SMTP(close)>>
58 cmdlog: '220:EHLO:250-:MAIL|:RCPT|:BDAT:QUIT:250:250:250:221'
59 Leaving send_to_server transport
60 LOG: MAIN
61   => good@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1] L K C="250 OK chunked message data"
62 LOG: MAIN
63   Completed
64 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
65 LOG: smtp_connection MAIN
66   SMTP connection from root closed by QUIT
67 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
68 Exim version x.yz ....
69 configuration file is TESTSUITE/test-config
70 trusted user
71 admin user
72 LOG: smtp_connection MAIN
73   SMTP connection from root
74 LOG: MAIN
75   <= fred@myhost.test.ex U=root P=local-smtp S=sss
76 Exim version x.yz ....
77 configuration file is TESTSUITE/test-config
78 trusted user
79 admin user
80 dropping to exim gid; retaining priv uid
81 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
82 --------> nopipe@test.ex <--------
83 send_to_server transport entered
84   nopipe@test.ex
85 using the transport's hosts: 127.0.0.1
86 getting address for 127.0.0.1
87 checking status of 127.0.0.1
88 127.0.0.1 [127.0.0.1]:1111 retry-status = usable
89 delivering 10HmaY-0005vi-00 to 127.0.0.1 [127.0.0.1] (nopipe@test.ex)
90 Connecting to 127.0.0.1 [127.0.0.1]:1225 ...  connected
91   SMTP<< 220 Server ready
92   SMTP>> EHLO myhost.test.ex
93 cmd buf flush ddd bytes
94   SMTP<< 250-hi there
95          250-CHUNKING
96          250 OK
97 not using PIPELINING
98 CHUNKING usable
99 not using DSN
100   SMTP>> MAIL FROM:<>
101 cmd buf flush ddd bytes
102   SMTP<< 250 OK mail
103   SMTP>> RCPT TO:<nopipe@test.ex>
104 cmd buf flush ddd bytes
105 sync_responses expect rcpt for nopipe@test.ex
106   SMTP<< 250 OK rcpt
107          will write message using CHUNKING
108   SMTP+> BDAT 317 LAST
109 cmd buf flush ddd bytes (more expected)
110 cannot use sendfile for body: spoolfile not wireformat
111 writing data block fd=dddd size=sss timeout=300
112   SMTP<< 250 OK chunked message data
113 ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_address is NULL
114 transport_check_waiting entered
115   sequence=1 local_max=500 global_max=-1
116  no messages waiting for 127.0.0.1
117 transport_check_waiting: FALSE
118   SMTP+> QUIT
119 cmd buf flush ddd bytes (more expected)
120   SMTP(shutdown)>>
121   SMTP<< 221 Closing connection
122   SMTP(close)>>
123 cmdlog: '220:EHLO:250-:MAIL:250:RCPT:250:BDAT:250:QUIT:221'
124 Leaving send_to_server transport
125 LOG: MAIN
126   => nopipe@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1] K C="250 OK chunked message data"
127 LOG: MAIN
128   Completed
129 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
130 LOG: smtp_connection MAIN
131   SMTP connection from root closed by QUIT
132 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
133 Exim version x.yz ....
134 configuration file is TESTSUITE/test-config
135 trusted user
136 admin user
137 LOG: smtp_connection MAIN
138   SMTP connection from root
139 LOG: MAIN
140   <= fred@myhost.test.ex U=root P=local-smtp S=sss
141 Exim version x.yz ....
142 configuration file is TESTSUITE/test-config
143 trusted user
144 admin user
145 dropping to exim gid; retaining priv uid
146 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
147 --------> tempreject@test.ex <--------
148 send_to_server transport entered
149   tempreject@test.ex
150 using the transport's hosts: 127.0.0.1
151 getting address for 127.0.0.1
152 checking status of 127.0.0.1
153 127.0.0.1 [127.0.0.1]:1111 retry-status = usable
154 delivering 10HmaZ-0005vi-00 to 127.0.0.1 [127.0.0.1] (tempreject@test.ex)
155 Connecting to 127.0.0.1 [127.0.0.1]:1225 ...  connected
156   SMTP<< 220 Server ready
157   SMTP>> EHLO myhost.test.ex
158 cmd buf flush ddd bytes
159   SMTP<< 250-hi there
160          250-PIPELINING
161          250-CHUNKING
162          250 OK
163 using PIPELINING
164 CHUNKING usable
165 not using DSN
166   SMTP|> MAIL FROM:<>
167   SMTP|> RCPT TO:<tempreject@test.ex>
168          will write message using CHUNKING
169 transport_check_waiting entered
170   sequence=1 local_max=500 global_max=-1
171  no messages waiting for 127.0.0.1
172 transport_check_waiting: FALSE
173 will pipeline QUIT
174   SMTP+> BDAT 321 LAST
175 cmd buf flush ddd bytes (more expected)
176 cannot use sendfile for body: spoolfile not wireformat
177 writing data block fd=dddd size=sss timeout=300 (more expected)
178   SMTP+> QUIT
179 cmd buf flush ddd bytes (more expected)
180   SMTP(shutdown)>>
181 sync_responses expect mail
182   SMTP<< 250 OK mail
183 sync_responses expect rcpt for tempreject@test.ex
184   SMTP<< 250 OK rcpt
185   SMTP<< 451 Service not available
186 LOG: MAIN
187   H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after pipelined end of data: 451 Service not available
188 ok=0 send_quit=0 send_rset=1 continue_more=0 yield=0 first_address is NULL
189   SMTP<< 221 Closing connection
190   SMTP(close)>>
191 cmdlog: '220:EHLO:250-:MAIL|:RCPT|:BDAT:QUIT:250:250:451:221'
192 added retry item for T:127.0.0.1:127.0.0.1:1225:10HmaZ-0005vi-00: errno=-46 more_errno=dd,A flags=6
193 all IP addresses skipped or deferred at least one address
194 Leaving send_to_server transport
195 LOG: MAIN
196   == tempreject@test.ex R=client T=send_to_server defer (-46) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after pipelined end of data: 451 Service not available
197 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
198 LOG: smtp_connection MAIN
199   SMTP connection from root closed by QUIT
200 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
201 Exim version x.yz ....
202 configuration file is TESTSUITE/test-config
203 trusted user
204 admin user
205 LOG: smtp_connection MAIN
206   SMTP connection from root
207 LOG: MAIN
208   <= fred@myhost.test.ex U=root P=local-smtp S=sss
209 Exim version x.yz ....
210 configuration file is TESTSUITE/test-config
211 trusted user
212 admin user
213 dropping to exim gid; retaining priv uid
214 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
215 --------> permreject@test.ex <--------
216 send_to_server transport entered
217   permreject@test.ex
218 using the transport's hosts: 127.0.0.1
219 getting address for 127.0.0.1
220 checking status of 127.0.0.1
221 no host retry record
222 no message retry record
223 127.0.0.1 [127.0.0.1]:1111 retry-status = usable
224 delivering 10HmbA-0005vi-00 to 127.0.0.1 [127.0.0.1] (permreject@test.ex)
225 Connecting to 127.0.0.1 [127.0.0.1]:1225 ...  connected
226   SMTP<< 220 Server ready
227   SMTP>> EHLO myhost.test.ex
228 cmd buf flush ddd bytes
229   SMTP<< 250-hi there
230          250-PIPELINING
231          250-CHUNKING
232          250 OK
233 using PIPELINING
234 CHUNKING usable
235 not using DSN
236   SMTP|> MAIL FROM:<>
237   SMTP|> RCPT TO:<permreject@test.ex>
238          will write message using CHUNKING
239 transport_check_waiting entered
240   sequence=1 local_max=500 global_max=-1
241  no messages waiting for 127.0.0.1
242 transport_check_waiting: FALSE
243 will pipeline QUIT
244   SMTP+> BDAT 321 LAST
245 cmd buf flush ddd bytes (more expected)
246 cannot use sendfile for body: spoolfile not wireformat
247 writing data block fd=dddd size=sss timeout=300 (more expected)
248   SMTP+> QUIT
249 cmd buf flush ddd bytes (more expected)
250   SMTP(shutdown)>>
251 sync_responses expect mail
252   SMTP<< 250 OK mail
253 sync_responses expect rcpt for permreject@test.ex
254   SMTP<< 250 OK rcpt
255   SMTP<< 550 content rejected
256 ok=0 send_quit=0 send_rset=1 continue_more=0 yield=0 first_address is NULL
257   SMTP<< 221 Closing connection
258   SMTP(close)>>
259 cmdlog: '220:EHLO:250-:MAIL|:RCPT|:BDAT:QUIT:250:250:550:221'
260 Leaving send_to_server transport
261 LOG: MAIN
262   ** permreject@test.ex R=client T=send_to_server H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after pipelined end of data: 550 content rejected
263 LOG: MAIN
264   permreject@test.ex: error ignored
265 LOG: MAIN
266   Completed
267 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
268 LOG: smtp_connection MAIN
269   SMTP connection from root closed by QUIT
270 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
271 Exim version x.yz ....
272 configuration file is TESTSUITE/test-config
273 trusted user
274 admin user
275 LOG: smtp_connection MAIN
276   SMTP connection from root
277 LOG: MAIN
278   <= fred@myhost.test.ex U=root P=local-smtp S=sss
279 Exim version x.yz ....
280 configuration file is TESTSUITE/test-config
281 trusted user
282 admin user
283 dropping to exim gid; retaining priv uid
284 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
285 --------> dataloss@test.ex <--------
286 send_to_server transport entered
287   dataloss@test.ex
288 using the transport's hosts: 127.0.0.1
289 getting address for 127.0.0.1
290 checking status of 127.0.0.1
291 no host retry record
292 no message retry record
293 127.0.0.1 [127.0.0.1]:1111 retry-status = usable
294 delivering 10HmbB-0005vi-00 to 127.0.0.1 [127.0.0.1] (dataloss@test.ex)
295 Connecting to 127.0.0.1 [127.0.0.1]:1225 ...  connected
296   SMTP<< 220 Server ready
297   SMTP>> EHLO myhost.test.ex
298 cmd buf flush ddd bytes
299   SMTP<< 250-hi there
300          250-PIPELINING
301          250-CHUNKING
302          250 OK
303 using PIPELINING
304 CHUNKING usable
305 not using DSN
306   SMTP|> MAIL FROM:<>
307   SMTP|> RCPT TO:<dataloss@test.ex>
308          will write message using CHUNKING
309 transport_check_waiting entered
310   sequence=1 local_max=500 global_max=-1
311  no messages waiting for 127.0.0.1
312 transport_check_waiting: FALSE
313 will pipeline QUIT
314   SMTP+> BDAT 319 LAST
315 cmd buf flush ddd bytes (more expected)
316 cannot use sendfile for body: spoolfile not wireformat
317 writing data block fd=dddd size=sss timeout=300 (more expected)
318   SMTP+> QUIT
319 cmd buf flush ddd bytes (more expected)
320   SMTP(shutdown)>>
321 sync_responses expect mail
322   SMTP<< 250 OK mail
323 sync_responses expect rcpt for dataloss@test.ex
324   SMTP<< 250 OK rcpt
325   SMTP(closed)<<
326 LOG: MAIN
327   H=127.0.0.1 [127.0.0.1]: Remote host closed connection in response to pipelined end of data
328 ok=0 send_quit=0 send_rset=1 continue_more=0 yield=0 first_address is NULL
329   SMTP(closed)<<
330   SMTP(close)>>
331 cmdlog: '220:EHLO:250-:MAIL|:RCPT|:BDAT:QUIT:250:250'
332 added retry item for T:127.0.0.1:127.0.0.1:1225:10HmbB-0005vi-00: errno=-18 more_errno=dd,A flags=6
333 all IP addresses skipped or deferred at least one address
334 Leaving send_to_server transport
335 LOG: MAIN
336   == dataloss@test.ex R=client T=send_to_server defer (-18) H=127.0.0.1 [127.0.0.1]: Remote host closed connection in response to pipelined end of data
337 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
338 LOG: smtp_connection MAIN
339   SMTP connection from root closed by QUIT
340 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>