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 seeking password data for user "CALLER": using cached result
12 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
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)
28 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
29 smtp_setup_msg entered
30 SMTP<< mail from:<x@y>
31 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
32 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
35 read ACL from file TESTSUITE/aux-fixed/0386.acl1
38 host in ":"? no (end of list)
39 accept: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
41 check local_parts = ^.*[@%!/|]
42 1 in "^.*[@%!/|]"? no (end of list)
43 deny: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
45 l_message: Invalid sender
46 message: Couldn't verify the sender
47 check verify = sender/defer_ok
48 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
50 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
52 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
54 --------> r1 router <--------
57 r1 router called for x@y
60 queued for t1 transport: local_part = x
63 domain_data=NULL localpart_data=NULL
67 ----------- end verify ------------
68 sender x@y verified ok
69 require: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
71 message: No such user here
72 deny: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
73 end of ACL "TESTSUITE/aux-fixed/0386.acl1": DENY
74 SMTP>> 550 No such user here
76 H=[V4NET.9.8.7] F=<x@y> rejected RCPT <1@b>: No such user here
79 SMTP<< mail from:<x@y>
80 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
81 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
84 using ACL "TESTSUITE/aux-fixed/0386.acl1"
87 host in ":"? no (end of list)
88 accept: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
90 check local_parts = ^.*[@%!/|]
91 1 in "^.*[@%!/|]"? no (end of list)
92 deny: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
94 l_message: Invalid sender
95 message: Couldn't verify the sender
96 check verify = sender/defer_ok
97 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
99 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
101 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
103 --------> r1 router <--------
104 local_part=x domain=y
106 r1 router called for x@y
108 queued for t1 transport: local_part = x
111 domain_data=NULL localpart_data=NULL
115 ----------- end verify ------------
116 sender x@y verified ok
117 require: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
119 message: No such user here
120 deny: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
121 end of ACL "TESTSUITE/aux-fixed/0386.acl1": DENY
122 SMTP>> 550 No such user here
124 H=[V4NET.9.8.7] F=<x@y> rejected RCPT <1@b>: No such user here
126 SMTP>> 221 myhost.test.ex closing connection
127 LOG: smtp_connection MAIN
128 SMTP connection from [V4NET.9.8.7] closed by QUIT
130 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
131 Exim version x.yz ....
132 changed uid/gid: forcing real = effective
133 uid=uuuu gid=CALLER_GID pid=pppp
134 seeking password data for user "CALLER": cache not available
135 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
136 configuration file is TESTSUITE/test-config
139 changed uid/gid: privilege not needed
140 uid=EXIM_UID gid=EXIM_GID pid=pppp
141 seeking password data for user "CALLER": using cached result
142 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
143 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
144 sender address = NULL
145 sender_fullhost = [V4NET.11.12.13]
146 sender_rcvhost = [V4NET.11.12.13] (ident=CALLER)
147 set_process_info: pppp handling incoming connection from [V4NET.11.12.13] via -oMa
148 set_process_info: pppp accepting a local SMTP message from <CALLER>
149 host in hosts_connection_nolog? no (option unset)
150 LOG: smtp_connection MAIN
151 SMTP connection from CALLER
152 host in host_lookup? no (option unset)
153 set_process_info: pppp handling incoming connection from [V4NET.11.12.13] U=CALLER
154 host in host_reject_connection? no (option unset)
155 host in sender_unqualified_hosts? no (option unset)
156 host in recipient_unqualified_hosts? no (option unset)
157 host in helo_verify_hosts? no (option unset)
158 host in helo_try_verify_hosts? no (option unset)
159 host in helo_accept_junk_hosts? no (option unset)
160 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
161 smtp_setup_msg entered
162 SMTP<< mail from:<x@y>
163 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
164 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
167 read ACL from file TESTSUITE/aux-fixed/0386.acl2
169 message: X-Warning: $sender_host_address is listed at $dnslist_domain\nX-Warning: $dnslist_text
170 l_message: found in $dnslist_domain: $dnslist_text
171 check dnslists = rbl.test.ex
172 DNS list check: rbl.test.ex
173 new DNS lookup for 13.12.11.V4NET.rbl.test.ex
174 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) using fakens
175 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded
176 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
177 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens
178 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded
179 => that means V4NET.11.12.13 is listed at rbl.test.ex
180 warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
182 H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message
183 created log directory TESTSUITE/spool/log
185 accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
186 end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT
188 DSN: orcpt: NULL flags: 0
190 SMTP>> 354 Enter message, ending with "." on a line by itself
195 >>Headers after rewriting and local additions:
197 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
198 Data file written for message 10HmaX-0005vi-00
199 >>Generated Received: header line
200 P Received: from [V4NET.11.12.13] (ident=CALLER)
201 by myhost.test.ex with smtp (Exim x.yz)
202 (envelope-from <x@y>)
204 for 2@b; Tue, 2 Mar 1999 09:44:33 +0000
205 >>Headers added by MAIL or RCPT ACL:
206 X-Warning: V4NET.11.12.13 is listed at rbl.test.ex
207 X-Warning: This is a test blacklisting message
209 calling local_scan(); timeout=300
210 local_scan() returned 0 NULL
211 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
212 DSN: Write SPOOL :-dsn_envid NULL
213 DSN: Write SPOOL :-dsn_ret 0
215 DSN: **** SPOOL_OUT - address: |2@b| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
216 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
217 Size of headers = sss
219 <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss
220 SMTP>> 250 OK id=10HmaX-0005vi-00
222 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaX-0005vi-00
223 Exim version x.yz ....
224 changed uid/gid: forcing real = effective
225 uid=uuuu gid=EXIM_GID pid=pppp
226 seeking password data for user "CALLER": cache not available
227 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
228 configuration file is TESTSUITE/test-config
231 seeking password data for user "CALLER": using cached result
232 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
233 set_process_info: pppp delivering specified messages
234 set_process_info: pppp delivering 10HmaX-0005vi-00
235 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
236 reading spool file 10HmaX-0005vi-00-H
237 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y
238 sender_fullhost = [V4NET.11.12.13]
239 sender_rcvhost = [V4NET.11.12.13] (ident=CALLER)
240 sender_local=0 ident=CALLER
243 ---- End of tree ----
245 **** SPOOL_IN - No additional fields
246 body_linecount=1 message_linecount=7
247 DSN: set orcpt: NULL flags: 0
248 Delivery address list:
250 locking TESTSUITE/spool/db/retry.lockfile
251 locked TESTSUITE/spool/db/retry.lockfile
252 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
253 returned from EXIM_DBOPEN: (nil)
254 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
255 failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory
256 no retry data available
257 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
260 no domain retry record
261 no address retry record
262 2@b: queued for routing
263 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
265 --------> r1 router <--------
266 local_part=2 domain=b
268 r1 router called for 2@b
271 queued for t1 transport: local_part = 2
274 domain_data=NULL localpart_data=NULL
278 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
286 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
287 --------> 2@b <--------
288 locking TESTSUITE/spool/db/retry.lockfile
289 locked TESTSUITE/spool/db/retry.lockfile
290 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
291 returned from EXIM_DBOPEN: (nil)
292 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
293 no retry data available
295 changed uid/gid: local delivery to 2 <2@b> transport=t1
296 uid=CALLER_UID gid=CALLER_GID pid=pppp
298 set_process_info: pppp delivering 10HmaX-0005vi-00 to 2 using t1
299 appendfile transport entered
300 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
301 file=TESTSUITE/test-mail/2 format=unix
302 message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
304 maildir_use_size_file=no
305 locking by lockfile fcntl
306 lock name: TESTSUITE/test-mail/2.lock
307 hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp
309 mailbox TESTSUITE/test-mail/2 is locked
310 writing to file TESTSUITE/test-mail/2
311 writing data block fd=dddd size=sss timeout=0
312 cannot use sendfile for body: spoolfile not wireformat
313 writing data block fd=dddd size=sss timeout=0
314 writing data block fd=dddd size=sss timeout=0
315 appendfile yields 0 with errno=dd more_errno=dd
318 t1 transport returned OK for 2@b
323 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
324 changed uid/gid: post-delivery tidying
325 uid=EXIM_UID gid=EXIM_GID pid=pppp
326 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
327 Processing retry items
332 end of retry processing
333 DSN: processing router : r1
334 DSN: processing successful delivery address: 2@b
335 DSN: Sender_address: x@y
336 DSN: orcpt: NULL flags: 0
337 DSN: envid: NULL ret: 0
338 DSN: Final recipient: 2@b
339 DSN: Remote SMTP server supports DSN: 0
340 DSN: not sending DSN success message
343 end delivery of 10HmaX-0005vi-00
346 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
347 smtp_setup_msg entered
350 SMTP<< mail from:<x@y>
351 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
352 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
355 using ACL "TESTSUITE/aux-fixed/0386.acl2"
357 message: X-Warning: $sender_host_address is listed at $dnslist_domain\nX-Warning: $dnslist_text
358 l_message: found in $dnslist_domain: $dnslist_text
359 check dnslists = rbl.test.ex
360 DNS list check: rbl.test.ex
361 using result of previous DNS lookup
362 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
363 => that means V4NET.11.12.13 is listed at rbl.test.ex
364 warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
366 H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message
368 accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
369 end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT
371 DSN: orcpt: NULL flags: 0
373 SMTP>> 354 Enter message, ending with "." on a line by itself
378 >>Headers after rewriting and local additions:
380 Data file name: TESTSUITE/spool//input//10HmaY-0005vi-00-D
381 Data file written for message 10HmaY-0005vi-00
382 >>Generated Received: header line
383 P Received: from [V4NET.11.12.13] (ident=CALLER)
384 by myhost.test.ex with smtp (Exim x.yz)
385 (envelope-from <x@y>)
387 for 2@b; Tue, 2 Mar 1999 09:44:33 +0000
388 >>Headers added by MAIL or RCPT ACL:
389 X-Warning: V4NET.11.12.13 is listed at rbl.test.ex
390 X-Warning: This is a test blacklisting message
392 calling local_scan(); timeout=300
393 local_scan() returned 0 NULL
394 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
395 DSN: Write SPOOL :-dsn_envid NULL
396 DSN: Write SPOOL :-dsn_ret 0
398 DSN: **** SPOOL_OUT - address: |2@b| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
399 Renaming spool header file: TESTSUITE/spool//input//10HmaY-0005vi-00-H
400 Size of headers = sss
402 <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss
403 SMTP>> 250 OK id=10HmaY-0005vi-00
405 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaY-0005vi-00
406 Exim version x.yz ....
407 changed uid/gid: forcing real = effective
408 uid=uuuu gid=EXIM_GID pid=pppp
409 seeking password data for user "CALLER": cache not available
410 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
411 configuration file is TESTSUITE/test-config
414 seeking password data for user "CALLER": using cached result
415 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
416 set_process_info: pppp delivering specified messages
417 set_process_info: pppp delivering 10HmaY-0005vi-00
418 Trying spool file TESTSUITE/spool//input//10HmaY-0005vi-00-D
419 reading spool file 10HmaY-0005vi-00-H
420 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y
421 sender_fullhost = [V4NET.11.12.13]
422 sender_rcvhost = [V4NET.11.12.13] (ident=CALLER)
423 sender_local=0 ident=CALLER
426 ---- End of tree ----
428 **** SPOOL_IN - No additional fields
429 body_linecount=1 message_linecount=7
430 DSN: set orcpt: NULL flags: 0
431 Delivery address list:
433 locking TESTSUITE/spool/db/retry.lockfile
434 locked TESTSUITE/spool/db/retry.lockfile
435 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
436 returned from EXIM_DBOPEN: (nil)
437 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
438 no retry data available
439 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
442 no domain retry record
443 no address retry record
444 2@b: queued for routing
445 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
447 --------> r1 router <--------
448 local_part=2 domain=b
450 r1 router called for 2@b
453 queued for t1 transport: local_part = 2
456 domain_data=NULL localpart_data=NULL
460 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
468 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
469 --------> 2@b <--------
470 locking TESTSUITE/spool/db/retry.lockfile
471 locked TESTSUITE/spool/db/retry.lockfile
472 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
473 returned from EXIM_DBOPEN: (nil)
474 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
475 no retry data available
477 changed uid/gid: local delivery to 2 <2@b> transport=t1
478 uid=CALLER_UID gid=CALLER_GID pid=pppp
480 set_process_info: pppp delivering 10HmaY-0005vi-00 to 2 using t1
481 appendfile transport entered
482 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
483 file=TESTSUITE/test-mail/2 format=unix
484 message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
486 maildir_use_size_file=no
487 locking by lockfile fcntl
488 lock name: TESTSUITE/test-mail/2.lock
489 hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp
491 mailbox TESTSUITE/test-mail/2 is locked
492 writing to file TESTSUITE/test-mail/2
493 writing data block fd=dddd size=sss timeout=0
494 cannot use sendfile for body: spoolfile not wireformat
495 writing data block fd=dddd size=sss timeout=0
496 writing data block fd=dddd size=sss timeout=0
497 appendfile yields 0 with errno=dd more_errno=dd
500 t1 transport returned OK for 2@b
505 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
506 changed uid/gid: post-delivery tidying
507 uid=EXIM_UID gid=EXIM_GID pid=pppp
508 set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00
509 Processing retry items
514 end of retry processing
515 DSN: processing router : r1
516 DSN: processing successful delivery address: 2@b
517 DSN: Sender_address: x@y
518 DSN: orcpt: NULL flags: 0
519 DSN: envid: NULL ret: 0
520 DSN: Final recipient: 2@b
521 DSN: Remote SMTP server supports DSN: 0
522 DSN: not sending DSN success message
525 end delivery of 10HmaY-0005vi-00
528 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
529 smtp_setup_msg entered
531 SMTP>> 221 myhost.test.ex closing connection
532 LOG: smtp_connection MAIN
533 SMTP connection from CALLER closed by QUIT
535 >>>>>>>>>>>>>>>> Exim pid=pppp (msg setup toplevel) terminating with rc=0 >>>>>>>>>>>>>>>>