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 | |
d8fe1c03 PH |
4 | seeking password data for user "CALLER": cache not available |
5 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
6 | configuration file is TESTSUITE/test-config |
7 | trusted user | |
8 | admin user | |
9 | changed uid/gid: privilege not needed | |
10 | uid=EXIM_UID gid=EXIM_GID pid=pppp | |
d8fe1c03 PH |
11 | seeking password data for user "CALLER": using cached result |
12 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
13 | originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME |
14 | sender address = CALLER@test.ex | |
15 | sender_fullhost = [V4NET.9.8.7] | |
16 | sender_rcvhost = [V4NET.9.8.7] | |
17 | host in hosts_connection_nolog? no (option unset) | |
18 | LOG: smtp_connection MAIN | |
19 | SMTP connection from [V4NET.9.8.7] | |
20 | host in host_lookup? no (option unset) | |
21 | set_process_info: pppp handling incoming connection from [V4NET.9.8.7] | |
22 | host in host_reject_connection? no (option unset) | |
23 | host in sender_unqualified_hosts? no (option unset) | |
24 | host in recipient_unqualified_hosts? no (option unset) | |
25 | host in helo_verify_hosts? no (option unset) | |
26 | host in helo_try_verify_hosts? no (option unset) | |
27 | host in helo_accept_junk_hosts? no (option unset) | |
898d150f | 28 | SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 |
54c5ebb1 PH |
29 | smtp_setup_msg entered |
30 | SMTP<< mail from:<x@y> | |
ddf1b11a | 31 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
ad424056 | 32 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 |
898d150f | 33 | SMTP>> 250 OK |
54c5ebb1 | 34 | SMTP<< rcpt to:<1@b> |
f3ebb786 JH |
35 | using ACL "chk_rcpt" |
36 | processing "accept" (TESTSUITE/test-config 18) | |
37 | check local_parts = 1 | |
38 | 1 in "1"? yes (matched "1") | |
39 | check acl = TESTSUITE/aux-fixed/0386.acl1 | |
40 | read ACL from file TESTSUITE/aux-fixed/0386.acl1 | |
41 | processing "accept" (TESTSUITE/test-config 43) | |
42 | check hosts = : | |
54c5ebb1 | 43 | host in ":"? no (end of list) |
f3ebb786 JH |
44 | accept: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1" |
45 | processing "deny" (TESTSUITE/test-config 43) | |
46 | check local_parts = ^.*[@%!/|] | |
54c5ebb1 | 47 | 1 in "^.*[@%!/|]"? no (end of list) |
f3ebb786 JH |
48 | deny: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1" |
49 | processing "require" (TESTSUITE/test-config 43) | |
50 | l_message: Invalid sender | |
51 | message: Couldn't verify the sender | |
52 | check verify = sender/defer_ok | |
54c5ebb1 PH |
53 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
54 | Verifying x@y | |
55 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
56 | Considering x@y | |
57 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
58 | routing x@y | |
59 | --------> r1 router <-------- | |
60 | local_part=x domain=y | |
61 | calling r1 router | |
62 | r1 router called for x@y | |
63 | domain = y | |
64 | set transport t1 | |
65 | queued for t1 transport: local_part = x | |
66 | domain = y | |
67 | errors_to=NULL | |
68 | domain_data=NULL localpart_data=NULL | |
69 | routed by r1 router | |
70 | envelope to: x@y | |
71 | transport: t1 | |
f3ebb786 JH |
72 | ----------- end verify ------------ |
73 | sender x@y verified ok | |
74 | require: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1" | |
75 | processing "deny" (TESTSUITE/test-config 43) | |
76 | message: No such user here | |
77 | deny: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1" | |
78 | end of ACL "TESTSUITE/aux-fixed/0386.acl1": DENY | |
79 | accept: condition test failed in ACL "chk_rcpt" | |
80 | accept: endpass encountered - denying access | |
898d150f | 81 | SMTP>> 550 No such user here |
54c5ebb1 PH |
82 | LOG: MAIN REJECT |
83 | H=[V4NET.9.8.7] F=<x@y> rejected RCPT <1@b>: No such user here | |
84 | SMTP<< rset | |
898d150f | 85 | SMTP>> 250 Reset OK |
54c5ebb1 | 86 | SMTP<< mail from:<x@y> |
ddf1b11a | 87 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
ad424056 | 88 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 |
898d150f | 89 | SMTP>> 250 OK |
54c5ebb1 | 90 | SMTP<< rcpt to:<1@b> |
f3ebb786 JH |
91 | using ACL "chk_rcpt" |
92 | processing "accept" (TESTSUITE/test-config 18) | |
93 | check local_parts = 1 | |
94 | 1 in "1"? yes (matched "1") | |
95 | check acl = TESTSUITE/aux-fixed/0386.acl1 | |
96 | using ACL "TESTSUITE/aux-fixed/0386.acl1" | |
97 | processing "accept" (TESTSUITE/test-config 43) | |
98 | check hosts = : | |
54c5ebb1 | 99 | host in ":"? no (end of list) |
f3ebb786 JH |
100 | accept: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1" |
101 | processing "deny" (TESTSUITE/test-config 43) | |
102 | check local_parts = ^.*[@%!/|] | |
54c5ebb1 | 103 | 1 in "^.*[@%!/|]"? no (end of list) |
f3ebb786 JH |
104 | deny: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1" |
105 | processing "require" (TESTSUITE/test-config 43) | |
106 | l_message: Invalid sender | |
107 | message: Couldn't verify the sender | |
108 | check verify = sender/defer_ok | |
54c5ebb1 PH |
109 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
110 | Verifying x@y | |
111 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
112 | Considering x@y | |
113 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
114 | routing x@y | |
115 | --------> r1 router <-------- | |
116 | local_part=x domain=y | |
117 | calling r1 router | |
118 | r1 router called for x@y | |
119 | domain = y | |
120 | queued for t1 transport: local_part = x | |
121 | domain = y | |
122 | errors_to=NULL | |
123 | domain_data=NULL localpart_data=NULL | |
124 | routed by r1 router | |
125 | envelope to: x@y | |
126 | transport: t1 | |
f3ebb786 JH |
127 | ----------- end verify ------------ |
128 | sender x@y verified ok | |
129 | require: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1" | |
130 | processing "deny" (TESTSUITE/test-config 43) | |
131 | message: No such user here | |
132 | deny: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1" | |
133 | end of ACL "TESTSUITE/aux-fixed/0386.acl1": DENY | |
134 | accept: condition test failed in ACL "chk_rcpt" | |
135 | accept: endpass encountered - denying access | |
898d150f | 136 | SMTP>> 550 No such user here |
54c5ebb1 PH |
137 | LOG: MAIN REJECT |
138 | H=[V4NET.9.8.7] F=<x@y> rejected RCPT <1@b>: No such user here | |
139 | SMTP<< quit | |
898d150f | 140 | SMTP>> 221 myhost.test.ex closing connection |
54c5ebb1 PH |
141 | LOG: smtp_connection MAIN |
142 | SMTP connection from [V4NET.9.8.7] closed by QUIT | |
143 | search_tidyup called | |
81022793 | 144 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |
54c5ebb1 PH |
145 | Exim version x.yz .... |
146 | changed uid/gid: forcing real = effective | |
147 | uid=uuuu gid=CALLER_GID pid=pppp | |
d8fe1c03 PH |
148 | seeking password data for user "CALLER": cache not available |
149 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
150 | configuration file is TESTSUITE/test-config |
151 | trusted user | |
152 | admin user | |
153 | changed uid/gid: privilege not needed | |
154 | uid=EXIM_UID gid=EXIM_GID pid=pppp | |
d8fe1c03 PH |
155 | seeking password data for user "CALLER": using cached result |
156 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
157 | originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME |
158 | sender address = NULL | |
159 | sender_fullhost = [V4NET.11.12.13] | |
160 | sender_rcvhost = [V4NET.11.12.13] (ident=CALLER) | |
161 | set_process_info: pppp handling incoming connection from [V4NET.11.12.13] via -oMa | |
273f34d0 | 162 | set_process_info: pppp accepting a local SMTP message from <CALLER> |
54c5ebb1 PH |
163 | host in hosts_connection_nolog? no (option unset) |
164 | LOG: smtp_connection MAIN | |
165 | SMTP connection from CALLER | |
166 | host in host_lookup? no (option unset) | |
167 | set_process_info: pppp handling incoming connection from [V4NET.11.12.13] U=CALLER | |
168 | host in host_reject_connection? no (option unset) | |
169 | host in sender_unqualified_hosts? no (option unset) | |
170 | host in recipient_unqualified_hosts? no (option unset) | |
171 | host in helo_verify_hosts? no (option unset) | |
172 | host in helo_try_verify_hosts? no (option unset) | |
173 | host in helo_accept_junk_hosts? no (option unset) | |
898d150f | 174 | SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 |
54c5ebb1 PH |
175 | smtp_setup_msg entered |
176 | SMTP<< mail from:<x@y> | |
ddf1b11a | 177 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
ad424056 | 178 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 |
898d150f | 179 | SMTP>> 250 OK |
54c5ebb1 | 180 | SMTP<< rcpt to:<2@b> |
f3ebb786 JH |
181 | using ACL "chk_rcpt" |
182 | processing "accept" (TESTSUITE/test-config 18) | |
183 | check local_parts = 1 | |
184 | 2 in "1"? no (end of list) | |
185 | accept: condition test failed in ACL "chk_rcpt" | |
186 | processing "accept" (TESTSUITE/test-config 21) | |
187 | check local_parts = 2 | |
188 | 2 in "2"? yes (matched "2") | |
189 | check acl = TESTSUITE/aux-fixed/0386.acl2 | |
190 | read ACL from file TESTSUITE/aux-fixed/0386.acl2 | |
191 | processing "warn" (TESTSUITE/test-config 43) | |
192 | message: X-Warning: $sender_host_address is listed at $dnslist_domain\nX-Warning: $dnslist_text | |
193 | l_message: found in $dnslist_domain: $dnslist_text | |
194 | check dnslists = rbl.test.ex | |
3462da30 | 195 | dnslists check: rbl.test.ex |
54c5ebb1 PH |
196 | new DNS lookup for 13.12.11.V4NET.rbl.test.ex |
197 | DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) using fakens | |
eb24befc JH |
198 | fresh-exec forking for fakens-search |
199 | postfork: fakens-search | |
200 | fresh-exec forked for fakens-search: npppp | |
54c5ebb1 | 201 | DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded |
2e860c76 | 202 | dnslists: wrote cache entry, ttl=3 |
54c5ebb1 PH |
203 | DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2) |
204 | DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens | |
eb24befc JH |
205 | fresh-exec forking for fakens-search |
206 | postfork: fakens-search | |
207 | fresh-exec forked for fakens-search: npppp | |
54c5ebb1 PH |
208 | DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded |
209 | => that means V4NET.11.12.13 is listed at rbl.test.ex | |
f3ebb786 | 210 | warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2" |
54c5ebb1 PH |
211 | LOG: MAIN |
212 | H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message | |
213 | created log directory TESTSUITE/spool/log | |
f3ebb786 JH |
214 | processing "accept" (TESTSUITE/test-config 43) |
215 | accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2" | |
216 | end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT | |
217 | accept: condition test succeeded in ACL "chk_rcpt" | |
218 | end of ACL "chk_rcpt": ACCEPT | |
898d150f | 219 | SMTP>> 250 Accepted |
50dc7409 | 220 | DSN: orcpt: NULL flags: 0 |
54c5ebb1 | 221 | SMTP<< data |
898d150f | 222 | SMTP>> 354 Enter message, ending with "." on a line by itself |
54c5ebb1 | 223 | search_tidyup called |
54c5ebb1 PH |
224 | >>Headers received: |
225 | ||
226 | search_tidyup called | |
227 | >>Headers after rewriting and local additions: | |
228 | ||
0971ec06 | 229 | Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D |
54c5ebb1 PH |
230 | Data file written for message 10HmaX-0005vi-00 |
231 | >>Generated Received: header line | |
232 | P Received: from [V4NET.11.12.13] (ident=CALLER) | |
233 | by myhost.test.ex with smtp (Exim x.yz) | |
234 | (envelope-from <x@y>) | |
235 | id 10HmaX-0005vi-00 | |
236 | for 2@b; Tue, 2 Mar 1999 09:44:33 +0000 | |
237 | >>Headers added by MAIL or RCPT ACL: | |
238 | X-Warning: V4NET.11.12.13 is listed at rbl.test.ex | |
239 | X-Warning: This is a test blacklisting message | |
240 | >> | |
ced52486 | 241 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00 |
df98a6ff JH |
242 | DSN: Write SPOOL: -dsn_envid NULL |
243 | DSN: Write SPOOL :-dsn_ret 0 | |
244 | DSN: Flags: 0x0 | |
245 | DSN: **** SPOOL_OUT - address: <2@b> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 | |
0971ec06 | 246 | Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H |
54c5ebb1 PH |
247 | Size of headers = sss |
248 | LOG: MAIN | |
249 | <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss | |
898d150f | 250 | SMTP>> 250 OK id=10HmaX-0005vi-00 |
54c5ebb1 | 251 | search_tidyup called |
32393657 JH |
252 | fresh-exec forking for local-accept-delivery |
253 | postfork: local-accept-delivery | |
254 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-0005vi-00 | |
255 | fresh-exec forked for local-accept-delivery: npppp | |
54c5ebb1 PH |
256 | Exim version x.yz .... |
257 | changed uid/gid: forcing real = effective | |
258 | uid=uuuu gid=EXIM_GID pid=pppp | |
d8fe1c03 PH |
259 | seeking password data for user "CALLER": cache not available |
260 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
261 | configuration file is TESTSUITE/test-config |
262 | trusted user | |
263 | admin user | |
4b424e0d | 264 | dropping to exim gid; retaining priv uid |
d8fe1c03 PH |
265 | seeking password data for user "CALLER": using cached result |
266 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
267 | set_process_info: pppp delivering specified messages |
268 | set_process_info: pppp delivering 10HmaX-0005vi-00 | |
0971ec06 | 269 | Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D |
54c5ebb1 PH |
270 | reading spool file 10HmaX-0005vi-00-H |
271 | user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y | |
272 | sender_fullhost = [V4NET.11.12.13] | |
273 | sender_rcvhost = [V4NET.11.12.13] (ident=CALLER) | |
274 | sender_local=0 ident=CALLER | |
275 | Non-recipients: | |
276 | Empty Tree | |
277 | ---- End of tree ---- | |
278 | recipients_count=1 | |
50dc7409 | 279 | **** SPOOL_IN - No additional fields |
54c5ebb1 | 280 | body_linecount=1 message_linecount=7 |
df98a6ff | 281 | DSN: set orcpt: flags: 0x0 |
54c5ebb1 PH |
282 | Delivery address list: |
283 | 2@b | |
966e829c JH |
284 | locking TESTSUITE/spool/db/retry.lockfile |
285 | locked TESTSUITE/spool/db/retry.lockfile | |
286 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
287 | returned from EXIM_DBOPEN: (nil) | |
288 | ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim | |
289 | failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory | |
54c5ebb1 PH |
290 | no retry data available |
291 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
292 | Considering: 2@b | |
293 | unique = 2@b | |
de6f74f2 JH |
294 | no domain retry record |
295 | no address retry record | |
54c5ebb1 PH |
296 | 2@b: queued for routing |
297 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
298 | routing 2@b | |
299 | --------> r1 router <-------- | |
300 | local_part=2 domain=b | |
301 | calling r1 router | |
302 | r1 router called for 2@b | |
303 | domain = b | |
304 | set transport t1 | |
305 | queued for t1 transport: local_part = 2 | |
306 | domain = b | |
307 | errors_to=NULL | |
308 | domain_data=NULL localpart_data=NULL | |
309 | routed by r1 router | |
310 | envelope to: 2@b | |
311 | transport: t1 | |
312 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
313 | After routing: | |
314 | Local deliveries: | |
315 | 2@b | |
316 | Remote deliveries: | |
317 | Failed addresses: | |
318 | Deferred addresses: | |
319 | search_tidyup called | |
320 | >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> | |
321 | --------> 2@b <-------- | |
966e829c JH |
322 | locking TESTSUITE/spool/db/retry.lockfile |
323 | locked TESTSUITE/spool/db/retry.lockfile | |
324 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
325 | returned from EXIM_DBOPEN: (nil) | |
326 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory | |
54c5ebb1 PH |
327 | no retry data available |
328 | search_tidyup called | |
32393657 JH |
329 | local-accept-delivery forking for delivery-local |
330 | postfork: delivery-local | |
54c5ebb1 PH |
331 | changed uid/gid: local delivery to 2 <2@b> transport=t1 |
332 | uid=CALLER_UID gid=CALLER_GID pid=pppp | |
333 | home=NULL current=/ | |
334 | set_process_info: pppp delivering 10HmaX-0005vi-00 to 2 using t1 | |
335 | appendfile transport entered | |
336 | appendfile: mode=600 notify_comsat=0 quota=0 warning=0 | |
337 | file=TESTSUITE/test-mail/2 format=unix | |
338 | message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n | |
339 | message_suffix=\n | |
340 | maildir_use_size_file=no | |
341 | locking by lockfile fcntl | |
342 | lock name: TESTSUITE/test-mail/2.lock | |
343 | hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp | |
344 | lock file created | |
345 | mailbox TESTSUITE/test-mail/2 is locked | |
346 | writing to file TESTSUITE/test-mail/2 | |
1b781f48 | 347 | writing data block fd=dddd size=sss timeout=0 |
328c5688 | 348 | cannot use sendfile for body: spoolfile not wireformat |
1b781f48 PH |
349 | writing data block fd=dddd size=sss timeout=0 |
350 | writing data block fd=dddd size=sss timeout=0 | |
54c5ebb1 PH |
351 | appendfile yields 0 with errno=dd more_errno=dd |
352 | search_tidyup called | |
32393657 | 353 | local-accept-delivery forked for delivery-local: npppp |
54c5ebb1 PH |
354 | journalling 2@b |
355 | t1 transport returned OK for 2@b | |
356 | post-process 2@b (0) | |
357 | 2@b delivered | |
358 | LOG: MAIN | |
359 | => 2 <2@b> R=r1 T=t1 | |
360 | >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> | |
361 | changed uid/gid: post-delivery tidying | |
362 | uid=EXIM_UID gid=EXIM_GID pid=pppp | |
363 | set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00 | |
364 | Processing retry items | |
365 | Succeeded addresses: | |
7b4c8c1f | 366 | 2@b: no retry items |
54c5ebb1 PH |
367 | Failed addresses: |
368 | Deferred addresses: | |
369 | end of retry processing | |
50dc7409 JH |
370 | DSN: processing router : r1 |
371 | DSN: processing successful delivery address: 2@b | |
372 | DSN: Sender_address: x@y | |
df98a6ff | 373 | DSN: orcpt: NULL flags: 0x0 |
50dc7409 JH |
374 | DSN: envid: NULL ret: 0 |
375 | DSN: Final recipient: 2@b | |
376 | DSN: Remote SMTP server supports DSN: 0 | |
9671784a | 377 | DSN: not sending DSN success message |
54c5ebb1 PH |
378 | LOG: MAIN |
379 | Completed | |
380 | end delivery of 10HmaX-0005vi-00 | |
381 | search_tidyup called | |
382 | search_tidyup called | |
81022793 | 383 | >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> |
54c5ebb1 PH |
384 | smtp_setup_msg entered |
385 | SMTP<< rset | |
898d150f | 386 | SMTP>> 250 Reset OK |
54c5ebb1 | 387 | SMTP<< mail from:<x@y> |
ddf1b11a JH |
388 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
389 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 | |
898d150f | 390 | SMTP>> 250 OK |
54c5ebb1 | 391 | SMTP<< rcpt to:<2@b> |
f3ebb786 JH |
392 | using ACL "chk_rcpt" |
393 | processing "accept" (TESTSUITE/test-config 18) | |
394 | check local_parts = 1 | |
395 | 2 in "1"? no (end of list) | |
396 | accept: condition test failed in ACL "chk_rcpt" | |
397 | processing "accept" (TESTSUITE/test-config 21) | |
398 | check local_parts = 2 | |
399 | 2 in "2"? yes (matched "2") | |
400 | check acl = TESTSUITE/aux-fixed/0386.acl2 | |
401 | using ACL "TESTSUITE/aux-fixed/0386.acl2" | |
402 | processing "warn" (TESTSUITE/test-config 43) | |
403 | message: X-Warning: $sender_host_address is listed at $dnslist_domain\nX-Warning: $dnslist_text | |
404 | l_message: found in $dnslist_domain: $dnslist_text | |
405 | check dnslists = rbl.test.ex | |
3462da30 JH |
406 | dnslists check: rbl.test.ex |
407 | dnslists: using result of previous lookup | |
54c5ebb1 PH |
408 | DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2) |
409 | => that means V4NET.11.12.13 is listed at rbl.test.ex | |
f3ebb786 | 410 | warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2" |
54c5ebb1 PH |
411 | LOG: MAIN |
412 | H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message | |
f3ebb786 JH |
413 | processing "accept" (TESTSUITE/test-config 43) |
414 | accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2" | |
415 | end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT | |
416 | accept: condition test succeeded in ACL "chk_rcpt" | |
417 | end of ACL "chk_rcpt": ACCEPT | |
898d150f | 418 | SMTP>> 250 Accepted |
50dc7409 | 419 | DSN: orcpt: NULL flags: 0 |
54c5ebb1 | 420 | SMTP<< data |
898d150f | 421 | SMTP>> 354 Enter message, ending with "." on a line by itself |
54c5ebb1 | 422 | search_tidyup called |
54c5ebb1 PH |
423 | >>Headers received: |
424 | ||
425 | search_tidyup called | |
426 | >>Headers after rewriting and local additions: | |
427 | ||
0971ec06 | 428 | Data file name: TESTSUITE/spool//input//10HmaY-0005vi-00-D |
54c5ebb1 PH |
429 | Data file written for message 10HmaY-0005vi-00 |
430 | >>Generated Received: header line | |
431 | P Received: from [V4NET.11.12.13] (ident=CALLER) | |
432 | by myhost.test.ex with smtp (Exim x.yz) | |
433 | (envelope-from <x@y>) | |
434 | id 10HmaY-0005vi-00 | |
435 | for 2@b; Tue, 2 Mar 1999 09:44:33 +0000 | |
436 | >>Headers added by MAIL or RCPT ACL: | |
437 | X-Warning: V4NET.11.12.13 is listed at rbl.test.ex | |
438 | X-Warning: This is a test blacklisting message | |
439 | >> | |
ced52486 | 440 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaY-0005vi-00 |
df98a6ff JH |
441 | DSN: Write SPOOL: -dsn_envid NULL |
442 | DSN: Write SPOOL :-dsn_ret 0 | |
443 | DSN: Flags: 0x0 | |
444 | DSN: **** SPOOL_OUT - address: <2@b> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 | |
0971ec06 | 445 | Renaming spool header file: TESTSUITE/spool//input//10HmaY-0005vi-00-H |
54c5ebb1 PH |
446 | Size of headers = sss |
447 | LOG: MAIN | |
448 | <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss | |
898d150f | 449 | SMTP>> 250 OK id=10HmaY-0005vi-00 |
54c5ebb1 | 450 | search_tidyup called |
32393657 JH |
451 | fresh-exec forking for local-accept-delivery |
452 | postfork: local-accept-delivery | |
453 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaY-0005vi-00 | |
454 | fresh-exec forked for local-accept-delivery: npppp | |
54c5ebb1 PH |
455 | Exim version x.yz .... |
456 | changed uid/gid: forcing real = effective | |
457 | uid=uuuu gid=EXIM_GID pid=pppp | |
d8fe1c03 PH |
458 | seeking password data for user "CALLER": cache not available |
459 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
460 | configuration file is TESTSUITE/test-config |
461 | trusted user | |
462 | admin user | |
4b424e0d | 463 | dropping to exim gid; retaining priv uid |
d8fe1c03 PH |
464 | seeking password data for user "CALLER": using cached result |
465 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
466 | set_process_info: pppp delivering specified messages |
467 | set_process_info: pppp delivering 10HmaY-0005vi-00 | |
0971ec06 | 468 | Trying spool file TESTSUITE/spool//input//10HmaY-0005vi-00-D |
54c5ebb1 PH |
469 | reading spool file 10HmaY-0005vi-00-H |
470 | user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y | |
471 | sender_fullhost = [V4NET.11.12.13] | |
472 | sender_rcvhost = [V4NET.11.12.13] (ident=CALLER) | |
473 | sender_local=0 ident=CALLER | |
474 | Non-recipients: | |
475 | Empty Tree | |
476 | ---- End of tree ---- | |
477 | recipients_count=1 | |
50dc7409 | 478 | **** SPOOL_IN - No additional fields |
54c5ebb1 | 479 | body_linecount=1 message_linecount=7 |
df98a6ff | 480 | DSN: set orcpt: flags: 0x0 |
54c5ebb1 PH |
481 | Delivery address list: |
482 | 2@b | |
966e829c JH |
483 | locking TESTSUITE/spool/db/retry.lockfile |
484 | locked TESTSUITE/spool/db/retry.lockfile | |
485 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
486 | returned from EXIM_DBOPEN: (nil) | |
487 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory | |
54c5ebb1 PH |
488 | no retry data available |
489 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
490 | Considering: 2@b | |
491 | unique = 2@b | |
de6f74f2 JH |
492 | no domain retry record |
493 | no address retry record | |
54c5ebb1 PH |
494 | 2@b: queued for routing |
495 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
496 | routing 2@b | |
497 | --------> r1 router <-------- | |
498 | local_part=2 domain=b | |
499 | calling r1 router | |
500 | r1 router called for 2@b | |
501 | domain = b | |
502 | set transport t1 | |
503 | queued for t1 transport: local_part = 2 | |
504 | domain = b | |
505 | errors_to=NULL | |
506 | domain_data=NULL localpart_data=NULL | |
507 | routed by r1 router | |
508 | envelope to: 2@b | |
509 | transport: t1 | |
510 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
511 | After routing: | |
512 | Local deliveries: | |
513 | 2@b | |
514 | Remote deliveries: | |
515 | Failed addresses: | |
516 | Deferred addresses: | |
517 | search_tidyup called | |
518 | >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> | |
519 | --------> 2@b <-------- | |
966e829c JH |
520 | locking TESTSUITE/spool/db/retry.lockfile |
521 | locked TESTSUITE/spool/db/retry.lockfile | |
522 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
523 | returned from EXIM_DBOPEN: (nil) | |
524 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory | |
54c5ebb1 PH |
525 | no retry data available |
526 | search_tidyup called | |
32393657 JH |
527 | local-accept-delivery forking for delivery-local |
528 | postfork: delivery-local | |
54c5ebb1 PH |
529 | changed uid/gid: local delivery to 2 <2@b> transport=t1 |
530 | uid=CALLER_UID gid=CALLER_GID pid=pppp | |
531 | home=NULL current=/ | |
532 | set_process_info: pppp delivering 10HmaY-0005vi-00 to 2 using t1 | |
533 | appendfile transport entered | |
534 | appendfile: mode=600 notify_comsat=0 quota=0 warning=0 | |
535 | file=TESTSUITE/test-mail/2 format=unix | |
536 | message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n | |
537 | message_suffix=\n | |
538 | maildir_use_size_file=no | |
539 | locking by lockfile fcntl | |
540 | lock name: TESTSUITE/test-mail/2.lock | |
541 | hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp | |
542 | lock file created | |
543 | mailbox TESTSUITE/test-mail/2 is locked | |
544 | writing to file TESTSUITE/test-mail/2 | |
1b781f48 | 545 | writing data block fd=dddd size=sss timeout=0 |
328c5688 | 546 | cannot use sendfile for body: spoolfile not wireformat |
1b781f48 PH |
547 | writing data block fd=dddd size=sss timeout=0 |
548 | writing data block fd=dddd size=sss timeout=0 | |
54c5ebb1 PH |
549 | appendfile yields 0 with errno=dd more_errno=dd |
550 | search_tidyup called | |
32393657 | 551 | local-accept-delivery forked for delivery-local: npppp |
54c5ebb1 PH |
552 | journalling 2@b |
553 | t1 transport returned OK for 2@b | |
554 | post-process 2@b (0) | |
555 | 2@b delivered | |
556 | LOG: MAIN | |
557 | => 2 <2@b> R=r1 T=t1 | |
558 | >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> | |
559 | changed uid/gid: post-delivery tidying | |
560 | uid=EXIM_UID gid=EXIM_GID pid=pppp | |
561 | set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00 | |
562 | Processing retry items | |
563 | Succeeded addresses: | |
7b4c8c1f | 564 | 2@b: no retry items |
54c5ebb1 PH |
565 | Failed addresses: |
566 | Deferred addresses: | |
567 | end of retry processing | |
50dc7409 JH |
568 | DSN: processing router : r1 |
569 | DSN: processing successful delivery address: 2@b | |
570 | DSN: Sender_address: x@y | |
df98a6ff | 571 | DSN: orcpt: NULL flags: 0x0 |
50dc7409 JH |
572 | DSN: envid: NULL ret: 0 |
573 | DSN: Final recipient: 2@b | |
574 | DSN: Remote SMTP server supports DSN: 0 | |
9671784a | 575 | DSN: not sending DSN success message |
54c5ebb1 PH |
576 | LOG: MAIN |
577 | Completed | |
578 | end delivery of 10HmaY-0005vi-00 | |
579 | search_tidyup called | |
580 | search_tidyup called | |
81022793 | 581 | >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> |
54c5ebb1 PH |
582 | smtp_setup_msg entered |
583 | SMTP<< quit | |
898d150f | 584 | SMTP>> 221 myhost.test.ex closing connection |
54c5ebb1 PH |
585 | LOG: smtp_connection MAIN |
586 | SMTP connection from CALLER closed by QUIT | |
587 | search_tidyup called | |
81022793 | 588 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |