2 changed uid/gid: forcing real = effective
3 uid=uuuu gid=CALLER_GID pid=pppp
4 seeking password data for user "CALLER": cache not available
5 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
6 configuration file is TESTSUITE/test-config
9 changed uid/gid: privilege not needed
10 uid=EXIM_UID gid=EXIM_GID pid=pppp
11 DSN: r1 propagating DSN
12 seeking password data for user "CALLER": using cached result
13 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
14 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
15 sender address = CALLER@test.ex
16 sender_fullhost = [V4NET.9.8.7]
17 sender_rcvhost = [V4NET.9.8.7]
18 host in hosts_connection_nolog? no (option unset)
19 LOG: smtp_connection MAIN
20 SMTP connection from [V4NET.9.8.7]
21 host in host_lookup? no (option unset)
22 set_process_info: pppp handling incoming connection from [V4NET.9.8.7]
23 host in host_reject_connection? no (option unset)
24 host in sender_unqualified_hosts? no (option unset)
25 host in recipient_unqualified_hosts? no (option unset)
26 host in helo_verify_hosts? no (option unset)
27 host in helo_try_verify_hosts? no (option unset)
28 host in helo_accept_junk_hosts? no (option unset)
29 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
30 smtp_setup_msg entered
31 SMTP<< mail from:<x@y>
32 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
33 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
36 read ACL from file TESTSUITE/aux-fixed/0386.acl1
39 host in ":"? no (end of list)
40 accept: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
42 check local_parts = ^.*[@%!/|]
43 1 in "^.*[@%!/|]"? no (end of list)
44 deny: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
46 l_message: Invalid sender
47 message: Couldn't verify the sender
48 check verify = sender/defer_ok
49 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
51 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
53 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
55 --------> r1 router <--------
58 r1 router called for x@y
61 queued for t1 transport: local_part = x
64 domain_data=NULL localpart_data=NULL
68 ----------- end verify ------------
69 sender x@y verified ok
70 require: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
72 message: No such user here
73 deny: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
74 end of ACL "TESTSUITE/aux-fixed/0386.acl1": DENY
75 SMTP>> 550 No such user here
77 H=[V4NET.9.8.7] F=<x@y> rejected RCPT <1@b>: No such user here
80 SMTP<< mail from:<x@y>
81 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
82 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
85 using ACL "TESTSUITE/aux-fixed/0386.acl1"
88 host in ":"? no (end of list)
89 accept: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
91 check local_parts = ^.*[@%!/|]
92 1 in "^.*[@%!/|]"? no (end of list)
93 deny: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
95 l_message: Invalid sender
96 message: Couldn't verify the sender
97 check verify = sender/defer_ok
98 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
100 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
102 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
104 --------> r1 router <--------
105 local_part=x domain=y
107 r1 router called for x@y
109 queued for t1 transport: local_part = x
112 domain_data=NULL localpart_data=NULL
116 ----------- end verify ------------
117 sender x@y verified ok
118 require: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
120 message: No such user here
121 deny: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
122 end of ACL "TESTSUITE/aux-fixed/0386.acl1": DENY
123 SMTP>> 550 No such user here
125 H=[V4NET.9.8.7] F=<x@y> rejected RCPT <1@b>: No such user here
127 SMTP>> 221 myhost.test.ex closing connection
128 LOG: smtp_connection MAIN
129 SMTP connection from [V4NET.9.8.7] closed by QUIT
131 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
132 Exim version x.yz ....
133 changed uid/gid: forcing real = effective
134 uid=uuuu gid=CALLER_GID pid=pppp
135 seeking password data for user "CALLER": cache not available
136 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
137 configuration file is TESTSUITE/test-config
140 changed uid/gid: privilege not needed
141 uid=EXIM_UID gid=EXIM_GID pid=pppp
142 DSN: r1 propagating DSN
143 seeking password data for user "CALLER": using cached result
144 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
145 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
146 sender address = NULL
147 sender_fullhost = [V4NET.11.12.13]
148 sender_rcvhost = [V4NET.11.12.13] (ident=CALLER)
149 set_process_info: pppp handling incoming connection from [V4NET.11.12.13] via -oMa
150 set_process_info: pppp accepting a local SMTP message from <CALLER>
151 host in hosts_connection_nolog? no (option unset)
152 LOG: smtp_connection MAIN
153 SMTP connection from CALLER
154 host in host_lookup? no (option unset)
155 set_process_info: pppp handling incoming connection from [V4NET.11.12.13] U=CALLER
156 host in host_reject_connection? no (option unset)
157 host in sender_unqualified_hosts? no (option unset)
158 host in recipient_unqualified_hosts? no (option unset)
159 host in helo_verify_hosts? no (option unset)
160 host in helo_try_verify_hosts? no (option unset)
161 host in helo_accept_junk_hosts? no (option unset)
162 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
163 smtp_setup_msg entered
164 SMTP<< mail from:<x@y>
165 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
166 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
169 read ACL from file TESTSUITE/aux-fixed/0386.acl2
171 message: X-Warning: $sender_host_address is listed at $dnslist_domain\nX-Warning: $dnslist_text
172 l_message: found in $dnslist_domain: $dnslist_text
173 check dnslists = rbl.test.ex
174 DNS list check: rbl.test.ex
175 new DNS lookup for 13.12.11.V4NET.rbl.test.ex
176 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) using fakens
177 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded
178 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
179 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens
180 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded
181 => that means V4NET.11.12.13 is listed at rbl.test.ex
182 warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
184 H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message
185 created log directory TESTSUITE/spool/log
187 accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
188 end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT
190 DSN: orcpt: NULL flags: 0
192 SMTP>> 354 Enter message, ending with "." on a line by itself
197 >>Headers after rewriting and local additions:
199 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
200 Data file written for message 10HmaX-0005vi-00
201 >>Generated Received: header line
202 P Received: from [V4NET.11.12.13] (ident=CALLER)
203 by myhost.test.ex with smtp (Exim x.yz)
204 (envelope-from <x@y>)
206 for 2@b; Tue, 2 Mar 1999 09:44:33 +0000
207 >>Headers added by MAIL or RCPT ACL:
208 X-Warning: V4NET.11.12.13 is listed at rbl.test.ex
209 X-Warning: This is a test blacklisting message
211 calling local_scan(); timeout=300
212 local_scan() returned 0 NULL
213 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
214 DSN: Write SPOOL :-dsn_envid NULL
215 DSN: Write SPOOL :-dsn_ret 0
217 DSN: **** SPOOL_OUT - address: |2@b| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
218 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
219 Size of headers = sss
221 <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss
222 SMTP>> 250 OK id=10HmaX-0005vi-00
224 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaX-0005vi-00
225 Exim version x.yz ....
226 changed uid/gid: forcing real = effective
227 uid=uuuu gid=EXIM_GID pid=pppp
228 seeking password data for user "CALLER": cache not available
229 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
230 configuration file is TESTSUITE/test-config
233 DSN: r1 propagating DSN
234 seeking password data for user "CALLER": using cached result
235 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
236 set_process_info: pppp delivering specified messages
237 set_process_info: pppp delivering 10HmaX-0005vi-00
238 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
239 reading spool file 10HmaX-0005vi-00-H
240 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y
241 sender_fullhost = [V4NET.11.12.13]
242 sender_rcvhost = [V4NET.11.12.13] (ident=CALLER)
243 sender_local=0 ident=CALLER
246 ---- End of tree ----
248 **** SPOOL_IN - No additional fields
249 body_linecount=1 message_linecount=7
250 DSN: set orcpt: NULL flags: 0
251 Delivery address list:
253 locking TESTSUITE/spool/db/retry.lockfile
254 locked TESTSUITE/spool/db/retry.lockfile
255 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags 0x0
256 returned from EXIM_DBOPEN: (nil)
257 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
258 failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory
259 no retry data available
260 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
263 no domain retry record
264 no address retry record
265 2@b: queued for routing
266 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
268 --------> r1 router <--------
269 local_part=2 domain=b
271 r1 router called for 2@b
274 queued for t1 transport: local_part = 2
277 domain_data=NULL localpart_data=NULL
281 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
289 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
290 --------> 2@b <--------
291 locking TESTSUITE/spool/db/retry.lockfile
292 locked TESTSUITE/spool/db/retry.lockfile
293 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags 0x0
294 returned from EXIM_DBOPEN: (nil)
295 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
296 no retry data available
298 changed uid/gid: local delivery to 2 <2@b> transport=t1
299 uid=CALLER_UID gid=CALLER_GID pid=pppp
301 set_process_info: pppp delivering 10HmaX-0005vi-00 to 2 using t1
302 appendfile transport entered
303 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
304 file=TESTSUITE/test-mail/2 format=unix
305 message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
307 maildir_use_size_file=no
308 locking by lockfile fcntl
309 lock name: TESTSUITE/test-mail/2.lock
310 hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp
312 mailbox TESTSUITE/test-mail/2 is locked
313 writing to file TESTSUITE/test-mail/2
314 writing data block fd=dddd size=sss timeout=0
315 writing data block fd=dddd size=sss timeout=0
316 writing data block fd=dddd size=sss timeout=0
317 appendfile yields 0 with errno=dd more_errno=dd
320 t1 transport returned OK for 2@b
325 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
326 changed uid/gid: post-delivery tidying
327 uid=EXIM_UID gid=EXIM_GID pid=pppp
328 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
329 Processing retry items
334 end of retry processing
335 DSN: processing router : r1
336 DSN: processing successful delivery address: 2@b
337 DSN: Sender_address: x@y
338 DSN: orcpt: NULL flags: 0
339 DSN: envid: NULL ret: 0
340 DSN: Final recipient: 2@b
341 DSN: Remote SMTP server supports DSN: 0
342 DSN: not sending DSN success message
345 end delivery of 10HmaX-0005vi-00
348 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
349 smtp_setup_msg entered
352 SMTP<< mail from:<x@y>
353 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
354 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
357 using ACL "TESTSUITE/aux-fixed/0386.acl2"
359 message: X-Warning: $sender_host_address is listed at $dnslist_domain\nX-Warning: $dnslist_text
360 l_message: found in $dnslist_domain: $dnslist_text
361 check dnslists = rbl.test.ex
362 DNS list check: rbl.test.ex
363 using result of previous DNS lookup
364 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
365 => that means V4NET.11.12.13 is listed at rbl.test.ex
366 warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
368 H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message
370 accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
371 end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT
373 DSN: orcpt: NULL flags: 0
375 SMTP>> 354 Enter message, ending with "." on a line by itself
380 >>Headers after rewriting and local additions:
382 Data file name: TESTSUITE/spool//input//10HmaY-0005vi-00-D
383 Data file written for message 10HmaY-0005vi-00
384 >>Generated Received: header line
385 P Received: from [V4NET.11.12.13] (ident=CALLER)
386 by myhost.test.ex with smtp (Exim x.yz)
387 (envelope-from <x@y>)
389 for 2@b; Tue, 2 Mar 1999 09:44:33 +0000
390 >>Headers added by MAIL or RCPT ACL:
391 X-Warning: V4NET.11.12.13 is listed at rbl.test.ex
392 X-Warning: This is a test blacklisting message
394 calling local_scan(); timeout=300
395 local_scan() returned 0 NULL
396 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
397 DSN: Write SPOOL :-dsn_envid NULL
398 DSN: Write SPOOL :-dsn_ret 0
400 DSN: **** SPOOL_OUT - address: |2@b| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
401 Renaming spool header file: TESTSUITE/spool//input//10HmaY-0005vi-00-H
402 Size of headers = sss
404 <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss
405 SMTP>> 250 OK id=10HmaY-0005vi-00
407 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaY-0005vi-00
408 Exim version x.yz ....
409 changed uid/gid: forcing real = effective
410 uid=uuuu gid=EXIM_GID pid=pppp
411 seeking password data for user "CALLER": cache not available
412 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
413 configuration file is TESTSUITE/test-config
416 DSN: r1 propagating DSN
417 seeking password data for user "CALLER": using cached result
418 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
419 set_process_info: pppp delivering specified messages
420 set_process_info: pppp delivering 10HmaY-0005vi-00
421 Trying spool file TESTSUITE/spool//input//10HmaY-0005vi-00-D
422 reading spool file 10HmaY-0005vi-00-H
423 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y
424 sender_fullhost = [V4NET.11.12.13]
425 sender_rcvhost = [V4NET.11.12.13] (ident=CALLER)
426 sender_local=0 ident=CALLER
429 ---- End of tree ----
431 **** SPOOL_IN - No additional fields
432 body_linecount=1 message_linecount=7
433 DSN: set orcpt: NULL flags: 0
434 Delivery address list:
436 locking TESTSUITE/spool/db/retry.lockfile
437 locked TESTSUITE/spool/db/retry.lockfile
438 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags 0x0
439 returned from EXIM_DBOPEN: (nil)
440 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
441 no retry data available
442 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
445 no domain retry record
446 no address retry record
447 2@b: queued for routing
448 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
450 --------> r1 router <--------
451 local_part=2 domain=b
453 r1 router called for 2@b
456 queued for t1 transport: local_part = 2
459 domain_data=NULL localpart_data=NULL
463 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
471 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
472 --------> 2@b <--------
473 locking TESTSUITE/spool/db/retry.lockfile
474 locked TESTSUITE/spool/db/retry.lockfile
475 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags 0x0
476 returned from EXIM_DBOPEN: (nil)
477 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
478 no retry data available
480 changed uid/gid: local delivery to 2 <2@b> transport=t1
481 uid=CALLER_UID gid=CALLER_GID pid=pppp
483 set_process_info: pppp delivering 10HmaY-0005vi-00 to 2 using t1
484 appendfile transport entered
485 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
486 file=TESTSUITE/test-mail/2 format=unix
487 message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
489 maildir_use_size_file=no
490 locking by lockfile fcntl
491 lock name: TESTSUITE/test-mail/2.lock
492 hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp
494 mailbox TESTSUITE/test-mail/2 is locked
495 writing to file TESTSUITE/test-mail/2
496 writing data block fd=dddd size=sss timeout=0
497 writing data block fd=dddd size=sss timeout=0
498 writing data block fd=dddd size=sss timeout=0
499 appendfile yields 0 with errno=dd more_errno=dd
502 t1 transport returned OK for 2@b
507 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
508 changed uid/gid: post-delivery tidying
509 uid=EXIM_UID gid=EXIM_GID pid=pppp
510 set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00
511 Processing retry items
516 end of retry processing
517 DSN: processing router : r1
518 DSN: processing successful delivery address: 2@b
519 DSN: Sender_address: x@y
520 DSN: orcpt: NULL flags: 0
521 DSN: envid: NULL ret: 0
522 DSN: Final recipient: 2@b
523 DSN: Remote SMTP server supports DSN: 0
524 DSN: not sending DSN success message
527 end delivery of 10HmaY-0005vi-00
530 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
531 smtp_setup_msg entered
533 SMTP>> 221 myhost.test.ex closing connection
534 LOG: smtp_connection MAIN
535 SMTP connection from CALLER closed by QUIT
537 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>