Commit | Line | Data |
---|---|---|
54c5ebb1 PH |
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 | |
50dc7409 JH |
6 | DSN: r0 propagating DSN |
7 | DSN: r1 propagating DSN | |
54c5ebb1 PH |
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) | |
7eb59ff9 | 84 | Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected |
54c5ebb1 PH |
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 | |
3a061578 | 89 | 127.0.0.1 in hosts_avoid_pipelining? no (option unset) |
54c5ebb1 PH |
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 | |
c562fd30 | 96 | H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<x@y>: 451 Temporary error |
54c5ebb1 PH |
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 | |
cd5567b1 | 100 | address match test: subject=*@127.0.0.1 pattern=* |
54c5ebb1 PH |
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 | |
c562fd30 | 113 | H=V4NET.0.0.0 [V4NET.0.0.0] Network Error |
54c5ebb1 | 114 | set_process_info: pppp delivering 10HmaX-0005vi-00: just tried V4NET.0.0.0 [V4NET.0.0.0] for x@y: result DEFER |
7eb59ff9 | 115 | added retry item for T:V4NET.0.0.0:V4NET.0.0.0:1224: errno=dd more_errno=dd,A flags=2 |
54c5ebb1 PH |
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 | |
7eb59ff9 | 120 | reading retry information for T:V4NET.0.0.0:V4NET.0.0.0:1224 from subprocess |
54c5ebb1 PH |
121 | added retry item |
122 | reading retry information for R:x@y from subprocess | |
123 | added retry item | |
124 | LOG: MAIN | |
c562fd30 | 125 | == x@y R=r1 T=smtp defer (dd): Network Error H=127.0.0.1 [127.0.0.1] |
54c5ebb1 PH |
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 | |
cd5567b1 | 139 | address match test: subject=x@y pattern=* |
54c5ebb1 PH |
140 | y in "*"? yes (matched "*") |
141 | x@y in "*"? yes (matched "*") | |
ea49d0e1 | 142 | retry for R:x@y = * 0 0 |
54c5ebb1 | 143 | dbfn_read: key=R:x@y |
727071f8 | 144 | failing_interval=ttt message_age=ttt |
54c5ebb1 | 145 | Writing retry data for R:x@y |
727071f8 | 146 | first failed=dddd last try=dddd next try=+1 expired=1 |
c562fd30 | 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 |
54c5ebb1 | 148 | dbfn_write: key=R:x@y |
cd5567b1 | 149 | address match test: subject=*@V4NET.0.0.0 pattern=* |
54c5ebb1 PH |
150 | V4NET.0.0.0 in "*"? yes (matched "*") |
151 | *@V4NET.0.0.0 in "*"? yes (matched "*") | |
7eb59ff9 JH |
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 | |
727071f8 | 154 | failing_interval=ttt message_age=ttt |
dd16e114 | 155 | on queue longer than maximum retry |
7eb59ff9 | 156 | Writing retry data for T:V4NET.0.0.0:V4NET.0.0.0:1224 |
dd16e114 | 157 | first failed=dddd last try=dddd next try=+0 expired=0 |
54c5ebb1 | 158 | errno=dd more_errno=dd,A Network Error |
7eb59ff9 | 159 | dbfn_write: key=T:V4NET.0.0.0:V4NET.0.0.0:1224 |
54c5ebb1 PH |
160 | timed out: all retries expired |
161 | LOG: MAIN | |
162 | ** x@y: retry timeout exceeded | |
163 | end of retry processing | |
75e0e026 | 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 |
54c5ebb1 PH |
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 | |
50dc7409 JH |
173 | DSN: r0 propagating DSN |
174 | DSN: r1 propagating DSN | |
54c5ebb1 PH |
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 | |
50dc7409 JH |
185 | Content-Type: multipart/report; report-type=delivery-status; boundary=NNNNNNNNNN-eximdsn-MMMMMMMMMM |
186 | MIME-Version: 1.0 | |
54c5ebb1 PH |
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 | |
50dc7409 JH |
199 | Content-Type: multipart/report; report-type=delivery-status; boundary=NNNNNNNNNN-eximdsn-MMMMMMMMMM |
200 | MIME-Version: 1.0 | |
54c5ebb1 | 201 | Subject: Mail delivery failed: returning message to sender |
b3f43fa0 JJ |
202 | I Message-Id: <E10HmaY-0005vi-00@myhost.test.ex> |
203 | Date: Tue, 2 Mar 1999 09:44:33 +0000 | |
54c5ebb1 PH |
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 | |
50dc7409 JH |
224 | DSN: r0 propagating DSN |
225 | DSN: r1 propagating DSN | |
54c5ebb1 PH |
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 | |
48c7f9e2 | 238 | dbfn_read: key=R:CALLER@myhost.test.ex:<> |
54c5ebb1 PH |
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 | |
cd5567b1 | 249 | address match test: subject= pattern= |
54c5ebb1 PH |
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 >>>>>>>>>>>>>>>> |