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 | |
198 | DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded | |
2e860c76 | 199 | dnslists: wrote cache entry, ttl=3 |
54c5ebb1 PH |
200 | DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2) |
201 | DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens | |
202 | DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded | |
203 | => that means V4NET.11.12.13 is listed at rbl.test.ex | |
f3ebb786 | 204 | warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2" |
54c5ebb1 PH |
205 | LOG: MAIN |
206 | H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message | |
207 | created log directory TESTSUITE/spool/log | |
f3ebb786 JH |
208 | processing "accept" (TESTSUITE/test-config 43) |
209 | accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2" | |
210 | end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT | |
211 | accept: condition test succeeded in ACL "chk_rcpt" | |
212 | end of ACL "chk_rcpt": ACCEPT | |
898d150f | 213 | SMTP>> 250 Accepted |
50dc7409 | 214 | DSN: orcpt: NULL flags: 0 |
54c5ebb1 | 215 | SMTP<< data |
898d150f | 216 | SMTP>> 354 Enter message, ending with "." on a line by itself |
54c5ebb1 | 217 | search_tidyup called |
54c5ebb1 PH |
218 | >>Headers received: |
219 | ||
220 | search_tidyup called | |
221 | >>Headers after rewriting and local additions: | |
222 | ||
0971ec06 | 223 | Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D |
54c5ebb1 PH |
224 | Data file written for message 10HmaX-0005vi-00 |
225 | >>Generated Received: header line | |
226 | P Received: from [V4NET.11.12.13] (ident=CALLER) | |
227 | by myhost.test.ex with smtp (Exim x.yz) | |
228 | (envelope-from <x@y>) | |
229 | id 10HmaX-0005vi-00 | |
230 | for 2@b; Tue, 2 Mar 1999 09:44:33 +0000 | |
231 | >>Headers added by MAIL or RCPT ACL: | |
232 | X-Warning: V4NET.11.12.13 is listed at rbl.test.ex | |
233 | X-Warning: This is a test blacklisting message | |
234 | >> | |
ced52486 | 235 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00 |
df98a6ff JH |
236 | DSN: Write SPOOL: -dsn_envid NULL |
237 | DSN: Write SPOOL :-dsn_ret 0 | |
238 | DSN: Flags: 0x0 | |
239 | DSN: **** SPOOL_OUT - address: <2@b> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 | |
0971ec06 | 240 | Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H |
54c5ebb1 PH |
241 | Size of headers = sss |
242 | LOG: MAIN | |
243 | <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss | |
898d150f | 244 | SMTP>> 250 OK id=10HmaX-0005vi-00 |
54c5ebb1 | 245 | search_tidyup called |
32393657 | 246 | fresh-exec forking for local-accept-delivery |
32393657 | 247 | fresh-exec forked for local-accept-delivery: npppp |
836c3e41 | 248 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-0005vi-00 |
54c5ebb1 PH |
249 | Exim version x.yz .... |
250 | changed uid/gid: forcing real = effective | |
251 | uid=uuuu gid=EXIM_GID pid=pppp | |
d8fe1c03 PH |
252 | seeking password data for user "CALLER": cache not available |
253 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
254 | configuration file is TESTSUITE/test-config |
255 | trusted user | |
256 | admin user | |
4b424e0d | 257 | dropping to exim gid; retaining priv uid |
d8fe1c03 PH |
258 | seeking password data for user "CALLER": using cached result |
259 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
260 | set_process_info: pppp delivering specified messages |
261 | set_process_info: pppp delivering 10HmaX-0005vi-00 | |
0971ec06 | 262 | Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D |
54c5ebb1 PH |
263 | reading spool file 10HmaX-0005vi-00-H |
264 | user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y | |
265 | sender_fullhost = [V4NET.11.12.13] | |
266 | sender_rcvhost = [V4NET.11.12.13] (ident=CALLER) | |
267 | sender_local=0 ident=CALLER | |
268 | Non-recipients: | |
269 | Empty Tree | |
270 | ---- End of tree ---- | |
271 | recipients_count=1 | |
50dc7409 | 272 | **** SPOOL_IN - No additional fields |
54c5ebb1 | 273 | body_linecount=1 message_linecount=7 |
df98a6ff | 274 | DSN: set orcpt: flags: 0x0 |
54c5ebb1 PH |
275 | Delivery address list: |
276 | 2@b | |
966e829c JH |
277 | locking TESTSUITE/spool/db/retry.lockfile |
278 | locked TESTSUITE/spool/db/retry.lockfile | |
279 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
280 | returned from EXIM_DBOPEN: (nil) | |
281 | ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim | |
282 | failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory | |
54c5ebb1 PH |
283 | no retry data available |
284 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
285 | Considering: 2@b | |
286 | unique = 2@b | |
de6f74f2 JH |
287 | no domain retry record |
288 | no address retry record | |
54c5ebb1 PH |
289 | 2@b: queued for routing |
290 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
291 | routing 2@b | |
292 | --------> r1 router <-------- | |
293 | local_part=2 domain=b | |
294 | calling r1 router | |
295 | r1 router called for 2@b | |
296 | domain = b | |
297 | set transport t1 | |
298 | queued for t1 transport: local_part = 2 | |
299 | domain = b | |
300 | errors_to=NULL | |
301 | domain_data=NULL localpart_data=NULL | |
302 | routed by r1 router | |
303 | envelope to: 2@b | |
304 | transport: t1 | |
305 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
306 | After routing: | |
307 | Local deliveries: | |
308 | 2@b | |
309 | Remote deliveries: | |
310 | Failed addresses: | |
311 | Deferred addresses: | |
312 | search_tidyup called | |
313 | >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> | |
314 | --------> 2@b <-------- | |
966e829c JH |
315 | locking TESTSUITE/spool/db/retry.lockfile |
316 | locked TESTSUITE/spool/db/retry.lockfile | |
317 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
318 | returned from EXIM_DBOPEN: (nil) | |
319 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory | |
54c5ebb1 PH |
320 | no retry data available |
321 | search_tidyup called | |
32393657 | 322 | local-accept-delivery forking for delivery-local |
836c3e41 | 323 | local-accept-delivery forked for delivery-local: npppp |
54c5ebb1 PH |
324 | changed uid/gid: local delivery to 2 <2@b> transport=t1 |
325 | uid=CALLER_UID gid=CALLER_GID pid=pppp | |
326 | home=NULL current=/ | |
327 | set_process_info: pppp delivering 10HmaX-0005vi-00 to 2 using t1 | |
328 | appendfile transport entered | |
329 | appendfile: mode=600 notify_comsat=0 quota=0 warning=0 | |
330 | file=TESTSUITE/test-mail/2 format=unix | |
331 | message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n | |
332 | message_suffix=\n | |
333 | maildir_use_size_file=no | |
334 | locking by lockfile fcntl | |
335 | lock name: TESTSUITE/test-mail/2.lock | |
336 | hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp | |
337 | lock file created | |
338 | mailbox TESTSUITE/test-mail/2 is locked | |
339 | writing to file TESTSUITE/test-mail/2 | |
1b781f48 | 340 | writing data block fd=dddd size=sss timeout=0 |
328c5688 | 341 | cannot use sendfile for body: spoolfile not wireformat |
1b781f48 PH |
342 | writing data block fd=dddd size=sss timeout=0 |
343 | writing data block fd=dddd size=sss timeout=0 | |
54c5ebb1 PH |
344 | appendfile yields 0 with errno=dd more_errno=dd |
345 | search_tidyup called | |
346 | journalling 2@b | |
347 | t1 transport returned OK for 2@b | |
348 | post-process 2@b (0) | |
349 | 2@b delivered | |
350 | LOG: MAIN | |
351 | => 2 <2@b> R=r1 T=t1 | |
352 | >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> | |
353 | changed uid/gid: post-delivery tidying | |
354 | uid=EXIM_UID gid=EXIM_GID pid=pppp | |
355 | set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00 | |
356 | Processing retry items | |
357 | Succeeded addresses: | |
7b4c8c1f | 358 | 2@b: no retry items |
54c5ebb1 PH |
359 | Failed addresses: |
360 | Deferred addresses: | |
361 | end of retry processing | |
50dc7409 JH |
362 | DSN: processing router : r1 |
363 | DSN: processing successful delivery address: 2@b | |
364 | DSN: Sender_address: x@y | |
df98a6ff | 365 | DSN: orcpt: NULL flags: 0x0 |
50dc7409 JH |
366 | DSN: envid: NULL ret: 0 |
367 | DSN: Final recipient: 2@b | |
368 | DSN: Remote SMTP server supports DSN: 0 | |
9671784a | 369 | DSN: not sending DSN success message |
54c5ebb1 PH |
370 | LOG: MAIN |
371 | Completed | |
372 | end delivery of 10HmaX-0005vi-00 | |
373 | search_tidyup called | |
374 | search_tidyup called | |
81022793 | 375 | >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> |
54c5ebb1 PH |
376 | smtp_setup_msg entered |
377 | SMTP<< rset | |
898d150f | 378 | SMTP>> 250 Reset OK |
54c5ebb1 | 379 | SMTP<< mail from:<x@y> |
ddf1b11a JH |
380 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
381 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 | |
898d150f | 382 | SMTP>> 250 OK |
54c5ebb1 | 383 | SMTP<< rcpt to:<2@b> |
f3ebb786 JH |
384 | using ACL "chk_rcpt" |
385 | processing "accept" (TESTSUITE/test-config 18) | |
386 | check local_parts = 1 | |
387 | 2 in "1"? no (end of list) | |
388 | accept: condition test failed in ACL "chk_rcpt" | |
389 | processing "accept" (TESTSUITE/test-config 21) | |
390 | check local_parts = 2 | |
391 | 2 in "2"? yes (matched "2") | |
392 | check acl = TESTSUITE/aux-fixed/0386.acl2 | |
393 | using ACL "TESTSUITE/aux-fixed/0386.acl2" | |
394 | processing "warn" (TESTSUITE/test-config 43) | |
395 | message: X-Warning: $sender_host_address is listed at $dnslist_domain\nX-Warning: $dnslist_text | |
396 | l_message: found in $dnslist_domain: $dnslist_text | |
397 | check dnslists = rbl.test.ex | |
3462da30 JH |
398 | dnslists check: rbl.test.ex |
399 | dnslists: using result of previous lookup | |
54c5ebb1 PH |
400 | DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2) |
401 | => that means V4NET.11.12.13 is listed at rbl.test.ex | |
f3ebb786 | 402 | warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2" |
54c5ebb1 PH |
403 | LOG: MAIN |
404 | H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message | |
f3ebb786 JH |
405 | processing "accept" (TESTSUITE/test-config 43) |
406 | accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2" | |
407 | end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT | |
408 | accept: condition test succeeded in ACL "chk_rcpt" | |
409 | end of ACL "chk_rcpt": ACCEPT | |
898d150f | 410 | SMTP>> 250 Accepted |
50dc7409 | 411 | DSN: orcpt: NULL flags: 0 |
54c5ebb1 | 412 | SMTP<< data |
898d150f | 413 | SMTP>> 354 Enter message, ending with "." on a line by itself |
54c5ebb1 | 414 | search_tidyup called |
54c5ebb1 PH |
415 | >>Headers received: |
416 | ||
417 | search_tidyup called | |
418 | >>Headers after rewriting and local additions: | |
419 | ||
0971ec06 | 420 | Data file name: TESTSUITE/spool//input//10HmaY-0005vi-00-D |
54c5ebb1 PH |
421 | Data file written for message 10HmaY-0005vi-00 |
422 | >>Generated Received: header line | |
423 | P Received: from [V4NET.11.12.13] (ident=CALLER) | |
424 | by myhost.test.ex with smtp (Exim x.yz) | |
425 | (envelope-from <x@y>) | |
426 | id 10HmaY-0005vi-00 | |
427 | for 2@b; Tue, 2 Mar 1999 09:44:33 +0000 | |
428 | >>Headers added by MAIL or RCPT ACL: | |
429 | X-Warning: V4NET.11.12.13 is listed at rbl.test.ex | |
430 | X-Warning: This is a test blacklisting message | |
431 | >> | |
ced52486 | 432 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaY-0005vi-00 |
df98a6ff JH |
433 | DSN: Write SPOOL: -dsn_envid NULL |
434 | DSN: Write SPOOL :-dsn_ret 0 | |
435 | DSN: Flags: 0x0 | |
436 | DSN: **** SPOOL_OUT - address: <2@b> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 | |
0971ec06 | 437 | Renaming spool header file: TESTSUITE/spool//input//10HmaY-0005vi-00-H |
54c5ebb1 PH |
438 | Size of headers = sss |
439 | LOG: MAIN | |
440 | <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss | |
898d150f | 441 | SMTP>> 250 OK id=10HmaY-0005vi-00 |
54c5ebb1 | 442 | search_tidyup called |
32393657 | 443 | fresh-exec forking for local-accept-delivery |
32393657 | 444 | fresh-exec forked for local-accept-delivery: npppp |
836c3e41 | 445 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaY-0005vi-00 |
54c5ebb1 PH |
446 | Exim version x.yz .... |
447 | changed uid/gid: forcing real = effective | |
448 | uid=uuuu gid=EXIM_GID pid=pppp | |
d8fe1c03 PH |
449 | seeking password data for user "CALLER": cache not available |
450 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
451 | configuration file is TESTSUITE/test-config |
452 | trusted user | |
453 | admin user | |
4b424e0d | 454 | dropping to exim gid; retaining priv uid |
d8fe1c03 PH |
455 | seeking password data for user "CALLER": using cached result |
456 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
457 | set_process_info: pppp delivering specified messages |
458 | set_process_info: pppp delivering 10HmaY-0005vi-00 | |
0971ec06 | 459 | Trying spool file TESTSUITE/spool//input//10HmaY-0005vi-00-D |
54c5ebb1 PH |
460 | reading spool file 10HmaY-0005vi-00-H |
461 | user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y | |
462 | sender_fullhost = [V4NET.11.12.13] | |
463 | sender_rcvhost = [V4NET.11.12.13] (ident=CALLER) | |
464 | sender_local=0 ident=CALLER | |
465 | Non-recipients: | |
466 | Empty Tree | |
467 | ---- End of tree ---- | |
468 | recipients_count=1 | |
50dc7409 | 469 | **** SPOOL_IN - No additional fields |
54c5ebb1 | 470 | body_linecount=1 message_linecount=7 |
df98a6ff | 471 | DSN: set orcpt: flags: 0x0 |
54c5ebb1 PH |
472 | Delivery address list: |
473 | 2@b | |
966e829c JH |
474 | locking TESTSUITE/spool/db/retry.lockfile |
475 | locked TESTSUITE/spool/db/retry.lockfile | |
476 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
477 | returned from EXIM_DBOPEN: (nil) | |
478 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory | |
54c5ebb1 PH |
479 | no retry data available |
480 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
481 | Considering: 2@b | |
482 | unique = 2@b | |
de6f74f2 JH |
483 | no domain retry record |
484 | no address retry record | |
54c5ebb1 PH |
485 | 2@b: queued for routing |
486 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
487 | routing 2@b | |
488 | --------> r1 router <-------- | |
489 | local_part=2 domain=b | |
490 | calling r1 router | |
491 | r1 router called for 2@b | |
492 | domain = b | |
493 | set transport t1 | |
494 | queued for t1 transport: local_part = 2 | |
495 | domain = b | |
496 | errors_to=NULL | |
497 | domain_data=NULL localpart_data=NULL | |
498 | routed by r1 router | |
499 | envelope to: 2@b | |
500 | transport: t1 | |
501 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
502 | After routing: | |
503 | Local deliveries: | |
504 | 2@b | |
505 | Remote deliveries: | |
506 | Failed addresses: | |
507 | Deferred addresses: | |
508 | search_tidyup called | |
509 | >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> | |
510 | --------> 2@b <-------- | |
966e829c JH |
511 | locking TESTSUITE/spool/db/retry.lockfile |
512 | locked TESTSUITE/spool/db/retry.lockfile | |
513 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
514 | returned from EXIM_DBOPEN: (nil) | |
515 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory | |
54c5ebb1 PH |
516 | no retry data available |
517 | search_tidyup called | |
32393657 | 518 | local-accept-delivery forking for delivery-local |
836c3e41 | 519 | local-accept-delivery forked for delivery-local: npppp |
54c5ebb1 PH |
520 | changed uid/gid: local delivery to 2 <2@b> transport=t1 |
521 | uid=CALLER_UID gid=CALLER_GID pid=pppp | |
522 | home=NULL current=/ | |
523 | set_process_info: pppp delivering 10HmaY-0005vi-00 to 2 using t1 | |
524 | appendfile transport entered | |
525 | appendfile: mode=600 notify_comsat=0 quota=0 warning=0 | |
526 | file=TESTSUITE/test-mail/2 format=unix | |
527 | message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n | |
528 | message_suffix=\n | |
529 | maildir_use_size_file=no | |
530 | locking by lockfile fcntl | |
531 | lock name: TESTSUITE/test-mail/2.lock | |
532 | hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp | |
533 | lock file created | |
534 | mailbox TESTSUITE/test-mail/2 is locked | |
535 | writing to file TESTSUITE/test-mail/2 | |
1b781f48 | 536 | writing data block fd=dddd size=sss timeout=0 |
328c5688 | 537 | cannot use sendfile for body: spoolfile not wireformat |
1b781f48 PH |
538 | writing data block fd=dddd size=sss timeout=0 |
539 | writing data block fd=dddd size=sss timeout=0 | |
54c5ebb1 PH |
540 | appendfile yields 0 with errno=dd more_errno=dd |
541 | search_tidyup called | |
542 | journalling 2@b | |
543 | t1 transport returned OK for 2@b | |
544 | post-process 2@b (0) | |
545 | 2@b delivered | |
546 | LOG: MAIN | |
547 | => 2 <2@b> R=r1 T=t1 | |
548 | >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> | |
549 | changed uid/gid: post-delivery tidying | |
550 | uid=EXIM_UID gid=EXIM_GID pid=pppp | |
551 | set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00 | |
552 | Processing retry items | |
553 | Succeeded addresses: | |
7b4c8c1f | 554 | 2@b: no retry items |
54c5ebb1 PH |
555 | Failed addresses: |
556 | Deferred addresses: | |
557 | end of retry processing | |
50dc7409 JH |
558 | DSN: processing router : r1 |
559 | DSN: processing successful delivery address: 2@b | |
560 | DSN: Sender_address: x@y | |
df98a6ff | 561 | DSN: orcpt: NULL flags: 0x0 |
50dc7409 JH |
562 | DSN: envid: NULL ret: 0 |
563 | DSN: Final recipient: 2@b | |
564 | DSN: Remote SMTP server supports DSN: 0 | |
9671784a | 565 | DSN: not sending DSN success message |
54c5ebb1 PH |
566 | LOG: MAIN |
567 | Completed | |
568 | end delivery of 10HmaY-0005vi-00 | |
569 | search_tidyup called | |
570 | search_tidyup called | |
81022793 | 571 | >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> |
54c5ebb1 PH |
572 | smtp_setup_msg entered |
573 | SMTP<< quit | |
898d150f | 574 | SMTP>> 221 myhost.test.ex closing connection |
54c5ebb1 PH |
575 | LOG: smtp_connection MAIN |
576 | SMTP connection from CALLER closed by QUIT | |
577 | search_tidyup called | |
81022793 | 578 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |