Move DSN support to mainline
[users/heiko/exim.git] / test / stderr / 0388
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 DSN: r0 propagating DSN
7 DSN: r1 propagating DSN
8 set_process_info: pppp delivering specified messages
9 set_process_info: pppp delivering 10HmaX-0005vi-00
10 locking TESTSUITE/spool/db/retry.lockfile
11 locked TESTSUITE/spool/db/retry.lockfile
12 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
13 returned from EXIM_DBOPEN
14 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
15 no retry data available
16 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
17 Considering: x@y
18 unique = x@y
19 no domain retry record
20 no address retry record
21 x@y: queued for routing
22 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
23 routing x@y
24 --------> r0 router <--------
25 local_part=x domain=y
26 checking local_parts
27 x in "CALLER"? no (end of list)
28 r0 router skipped: local_parts mismatch
29 --------> r1 router <--------
30 local_part=x domain=y
31 calling r1 router
32 r1 router called for x@y
33   domain = y
34 route_item = * "127.0.0.1 : V4NET.0.0.0"
35 y in "*"? yes (matched "*")
36 original list of hosts = "127.0.0.1 : V4NET.0.0.0" options = 
37 expanded list of hosts = "127.0.0.1 : V4NET.0.0.0" options = 
38 set transport smtp
39 finding IP address for 127.0.0.1
40 calling host_find_byname
41 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
42 local host found for non-MX address
43 fully qualified name = 127.0.0.1
44 MUNGED: ::1 will be omitted in what follows
45 get[host|ipnode]byname[2] looked up these IP addresses:
46   name=127.0.0.1 address=127.0.0.1
47 remote host address is the local host: y: configured to try delivery anyway
48 finding IP address for V4NET.0.0.0
49 calling host_find_byname
50 using host_fake_gethostbyname for V4NET.0.0.0 (IPv4)
51 fully qualified name = V4NET.0.0.0
52 MUNGED: ::1 will be omitted in what follows
53 get[host|ipnode]byname[2] looked up these IP addresses:
54   name=V4NET.0.0.0 address=V4NET.0.0.0
55 queued for smtp transport: local_part = x
56 domain = y
57   errors_to=NULL
58   domain_data=NULL localpart_data=NULL
59 routed by r1 router
60   envelope to: x@y
61   transport: smtp
62   host 127.0.0.1 [127.0.0.1]
63   host V4NET.0.0.0 [V4NET.0.0.0]
64 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
65 After routing:
66   Local deliveries:
67   Remote deliveries:
68     x@y
69   Failed addresses:
70   Deferred addresses:
71 search_tidyup called
72 search_tidyup called
73 changed uid/gid: remote delivery to x@y with transport=smtp
74   uid=EXIM_UID gid=EXIM_GID pid=pppp
75 set_process_info: pppp delivering 10HmaX-0005vi-00 using smtp
76 checking status of 127.0.0.1
77 locking TESTSUITE/spool/db/retry.lockfile
78 locked TESTSUITE/spool/db/retry.lockfile
79 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
80 returned from EXIM_DBOPEN
81 no retry data available
82 127.0.0.1 in serialize_hosts? no (option unset)
83 set_process_info: pppp delivering 10HmaX-0005vi-00 to 127.0.0.1 [127.0.0.1] (x@y)
84 Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected
85   SMTP<< 220 Server ready
86 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
87   SMTP>> EHLO myhost.test.ex
88   SMTP<< 250 OK
89 127.0.0.1 in hosts_avoid_pipelining? no (option unset)
90 127.0.0.1 in hosts_require_auth? no (option unset)
91   SMTP>> MAIL FROM:<CALLER@myhost.test.ex>
92   SMTP<< 250 OK
93   SMTP>> RCPT TO:<x@y>
94   SMTP<< 451 Temporary error
95 LOG: MAIN
96   H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<x@y>: 451 Temporary error
97 added retry item for R:x@y: errno=-44 more_errno=dd,A flags=0
98   SMTP>> QUIT
99 set_process_info: pppp delivering 10HmaX-0005vi-00: just tried 127.0.0.1 [127.0.0.1] for x@y: result OK
100 address match test: subject=*@127.0.0.1 pattern=*
101 127.0.0.1 in "*"? yes (matched "*")
102 *@127.0.0.1 in "*"? yes (matched "*")
103 checking status of V4NET.0.0.0
104 locking TESTSUITE/spool/db/retry.lockfile
105 locked TESTSUITE/spool/db/retry.lockfile
106 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
107 returned from EXIM_DBOPEN
108 no retry data available
109 V4NET.0.0.0 in serialize_hosts? no (option unset)
110 set_process_info: pppp delivering 10HmaX-0005vi-00 to V4NET.0.0.0 [V4NET.0.0.0] (x@y)
111 Connecting to V4NET.0.0.0 [V4NET.0.0.0]:1224 ... failed: Network Error
112 LOG: MAIN
113   H=V4NET.0.0.0 [V4NET.0.0.0] Network Error
114 set_process_info: pppp delivering 10HmaX-0005vi-00: just tried V4NET.0.0.0 [V4NET.0.0.0] for x@y: result DEFER
115 added retry item for T:V4NET.0.0.0:V4NET.0.0.0:1224: errno=dd more_errno=dd,A flags=2
116 set_process_info: pppp delivering 10HmaX-0005vi-00 (just run smtp for x@y in subprocess)
117 search_tidyup called
118 set_process_info: pppp delivering 10HmaX-0005vi-00: waiting for a remote delivery subprocess to finish
119 set_process_info: pppp delivering 10HmaX-0005vi-00
120 reading retry information for T:V4NET.0.0.0:V4NET.0.0.0:1224 from subprocess
121   added retry item
122 reading retry information for R:x@y from subprocess
123   added retry item
124 LOG: MAIN
125   == x@y R=r1 T=smtp defer (dd): Network Error H=127.0.0.1 [127.0.0.1]
126 changed uid/gid: post-delivery tidying
127   uid=EXIM_UID gid=EXIM_GID pid=pppp
128 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
129 Processing retry items
130 Succeeded addresses:
131 Failed addresses:
132 Deferred addresses:
133 x@y
134 locking TESTSUITE/spool/db/retry.lockfile
135 locked TESTSUITE/spool/db/retry.lockfile
136 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
137 returned from EXIM_DBOPEN
138 opened hints database TESTSUITE/spool/db/retry: flags=O_RDWR
139 address match test: subject=x@y pattern=*
140 y in "*"? yes (matched "*")
141 x@y in "*"? yes (matched "*")
142 retry for R:x@y = * 0 0
143 dbfn_read: key=R:x@y
144 failing_interval=ttt message_age=ttt
145 Writing retry data for R:x@y
146   first failed=dddd last try=dddd next try=+1 expired=1
147   errno=-44 more_errno=dd,A H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<x@y>: 451 Temporary error
148 dbfn_write: key=R:x@y
149 address match test: subject=*@V4NET.0.0.0 pattern=*
150 V4NET.0.0.0 in "*"? yes (matched "*")
151 *@V4NET.0.0.0 in "*"? yes (matched "*")
152 retry for T:V4NET.0.0.0:V4NET.0.0.0:1224 (y) = * 0 0
153 dbfn_read: key=T:V4NET.0.0.0:V4NET.0.0.0:1224
154 failing_interval=ttt message_age=ttt
155 on queue longer than maximum retry
156 Writing retry data for T:V4NET.0.0.0:V4NET.0.0.0:1224
157   first failed=dddd last try=dddd next try=+0 expired=0
158   errno=dd more_errno=dd,A Network Error
159 dbfn_write: key=T:V4NET.0.0.0:V4NET.0.0.0:1224
160 timed out: all retries expired
161 LOG: MAIN
162   ** x@y: retry timeout exceeded
163 end of retry processing
164 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xebb95ced -odi -odi -t -oem -oi -f <> -E10HmaX-0005vi-00
165 Exim version x.yz ....
166 changed uid/gid: forcing real = effective
167   uid=uuuu gid=EXIM_GID pid=pppp
168 configuration file is TESTSUITE/test-config
169 trusted user
170 admin user
171 changed uid/gid: privilege not needed
172   uid=EXIM_UID gid=EXIM_GID pid=pppp
173 DSN: r0 propagating DSN
174 DSN: r1 propagating DSN
175 originator: uid=EXIM_UID gid=EXIM_GID login=EXIMUSER name=
176 sender address = 
177 set_process_info: pppp accepting a local non-SMTP message from <>
178 Sender: 
179 search_tidyup called
180 >>Headers received:
181 X-Failed-Recipients: x@y
182 Auto-Submitted: auto-replied
183 From: Mail Delivery System <Mailer-Daemon@myhost.test.ex>
184 To: CALLER@myhost.test.ex
185 Content-Type: multipart/report; report-type=delivery-status; boundary=NNNNNNNNNN-eximdsn-MMMMMMMMMM
186 MIME-Version: 1.0
187 Subject: Mail delivery failed: returning message to sender
188
189 rewrite_one_header: type=F:
190   From: Mail Delivery System <Mailer-Daemon@myhost.test.ex>
191 rewrite_one_header: type=T:
192   To: CALLER@myhost.test.ex
193 search_tidyup called
194 >>Headers after rewriting and local additions:
195   X-Failed-Recipients: x@y
196   Auto-Submitted: auto-replied
197 F From: Mail Delivery System <Mailer-Daemon@myhost.test.ex>
198 T To: CALLER@myhost.test.ex
199   Content-Type: multipart/report; report-type=delivery-status; boundary=NNNNNNNNNN-eximdsn-MMMMMMMMMM
200   MIME-Version: 1.0
201   Subject: Mail delivery failed: returning message to sender
202 I Message-Id: <E10HmaY-0005vi-00@myhost.test.ex>
203   Date: Tue, 2 Mar 1999 09:44:33 +0000
204
205 Data file written for message 10HmaY-0005vi-00
206 >>Generated Received: header line
207 P Received: from EXIMUSER by myhost.test.ex with local (Exim x.yz)
208         id 10HmaY-0005vi-00
209         for CALLER@myhost.test.ex; Tue, 2 Mar 1999 09:44:33 +0000
210 calling local_scan(); timeout=300
211 local_scan() returned 0 NULL
212 Writing spool header file
213 Size of headers = sss
214 LOG: MAIN
215   <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss
216 search_tidyup called
217 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xebb95ced -odi -Mc 10HmaY-0005vi-00
218 Exim version x.yz ....
219 changed uid/gid: forcing real = effective
220   uid=uuuu gid=EXIM_GID pid=pppp
221 configuration file is TESTSUITE/test-config
222 trusted user
223 admin user
224 DSN: r0 propagating DSN
225 DSN: r1 propagating DSN
226 set_process_info: pppp delivering specified messages
227 set_process_info: pppp delivering 10HmaY-0005vi-00
228 locking TESTSUITE/spool/db/retry.lockfile
229 locked TESTSUITE/spool/db/retry.lockfile
230 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
231 returned from EXIM_DBOPEN
232 opened hints database TESTSUITE/spool/db/retry: flags=O_RDONLY
233 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
234 Considering: CALLER@myhost.test.ex
235 unique = CALLER@myhost.test.ex
236 dbfn_read: key=R:myhost.test.ex
237 dbfn_read: key=R:CALLER@myhost.test.ex
238 dbfn_read: key=R:CALLER@myhost.test.ex:<>
239 no domain retry record
240 no address retry record
241 CALLER@myhost.test.ex: queued for routing
242 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
243 routing CALLER@myhost.test.ex
244 --------> r0 router <--------
245 local_part=CALLER domain=myhost.test.ex
246 checking local_parts
247 CALLER in "CALLER"? yes (matched "CALLER")
248 checking senders
249 address match test: subject= pattern=
250  in ":"? yes (matched "")
251 calling r0 router
252 rda_interpret (string): :blackhole:
253 expanded: :blackhole:
254 file is not a filter file
255 parse_forward_list: :blackhole:
256 extract item: :blackhole:
257 address :blackhole:d
258 LOG: MAIN
259   => :blackhole: <CALLER@myhost.test.ex> R=r0
260 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
261 After routing:
262   Local deliveries:
263   Remote deliveries:
264   Failed addresses:
265   Deferred addresses:
266 search_tidyup called
267 changed uid/gid: post-delivery tidying
268   uid=EXIM_UID gid=EXIM_GID pid=pppp
269 set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00
270 Processing retry items
271 Succeeded addresses:
272 CALLER@myhost.test.ex: no retry items
273 Failed addresses:
274 Deferred addresses:
275 end of retry processing
276 LOG: MAIN
277   Completed
278 search_tidyup called
279 search_tidyup called
280 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
281 search_tidyup called
282 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
283 Writing spool header file
284 Size of headers = sss
285 LOG: MAIN
286   Completed
287 search_tidyup called
288 search_tidyup called
289 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>