consistent fork-time debug

[exim.git] / test / stderr / 0044

Exim version x.yz ....
changed uid/gid: forcing real = effective
  uid=uuuu gid=CALLER_GID pid=pppp
configuration file is TESTSUITE/test-config
admin user
changed uid/gid: privilege not needed
  uid=EXIM_UID gid=EXIM_GID pid=pppp
seeking password data for user "CALLER": cache not available
getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
sender address = CALLER@exim.test.ex
sender_fullhost = [V4NET.11.12.13]
sender_rcvhost = [V4NET.11.12.13]
host in hosts_connection_nolog? no (option unset)
LOG: smtp_connection MAIN
  SMTP connection from [V4NET.11.12.13]
host in host_lookup? no (option unset)
set_process_info: pppp handling incoming connection from [V4NET.11.12.13]
host in host_reject_connection? no (option unset)
host in sender_unqualified_hosts? no (option unset)
host in recipient_unqualified_hosts? no (option unset)
host in helo_verify_hosts? no (option unset)
host in helo_try_verify_hosts? no (option unset)
host in helo_accept_junk_hosts? no (option unset)
SMTP>> 220 the.local.host.name ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
smtp_setup_msg entered
SMTP<< ehlo exim.test.ex
exim.test.ex in helo_lookup_domains? no (end of list)
sender_fullhost = (exim.test.ex) [V4NET.11.12.13]
sender_rcvhost = [V4NET.11.12.13] (helo=exim.test.ex)
set_process_info: pppp handling incoming connection from (exim.test.ex) [V4NET.11.12.13]
host in dsn_advertise_hosts? no (option unset)
host in pipelining_advertise_hosts? yes (matched "*")
host in chunking_advertise_hosts? no (end of list)
SMTP>> 250-the.local.host.name Hello exim.test.ex [V4NET.11.12.13]
250-SIZE 52428800
250-8BITMIME
250-PIPELINING
250 HELP
SMTP<< mail from:postmaster@exim.test.ex
spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
SMTP>> 250 OK
SMTP<< rcpt to:<postmaster@exim.test.ex>
using ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 19)
check hosts = :
host in ":"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 20)
check recipients = postmaster@exim.test.ex
address match test: subject=postmaster@exim.test.ex pattern=postmaster@exim.test.ex
exim.test.ex in "exim.test.ex"? yes (matched "exim.test.ex")
postmaster@exim.test.ex in "postmaster@exim.test.ex"? yes (matched "postmaster@exim.test.ex")
accept: condition test succeeded in ACL "check_recipient"
end of ACL "check_recipient": ACCEPT
SMTP>> 250 Accepted
DSN: orcpt: NULL  flags: 0
SMTP<< rcpt to:list@exim.test.ex
using ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 19)
check hosts = :
host in ":"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 20)
check recipients = postmaster@exim.test.ex
address match test: subject=list@exim.test.ex pattern=postmaster@exim.test.ex
list@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 21)
check senders = myfriend@*
address match test: subject=postmaster@exim.test.ex pattern=myfriend@*
postmaster@exim.test.ex in "myfriend@*"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "deny" (TESTSUITE/test-config 22)
  message: host is listed in $dnslist_domain
check dnslists = rbl.test.ex
dnslists check: rbl.test.ex
new DNS lookup for 13.12.11.V4NET.rbl.test.ex
DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) using fakens
fresh-exec forking for child-open
postfork: child-open
fresh-exec forked for child-open: npppp
DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded
dnslists: wrote cache entry, ttl=3
DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens
fresh-exec forking for child-open
postfork: child-open
fresh-exec forked for child-open: npppp
DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded
=> that means V4NET.11.12.13 is listed at rbl.test.ex
deny: condition test succeeded in ACL "check_recipient"
end of ACL "check_recipient": DENY
SMTP>> 550 host is listed in rbl.test.ex
LOG: MAIN REJECT
  H=(exim.test.ex) [V4NET.11.12.13] F=<postmaster@exim.test.ex> rejected RCPT list@exim.test.ex: host is listed in rbl.test.ex
SMTP<< rcpt to:list2@exim.test.ex
using ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 19)
check hosts = :
host in ":"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 20)
check recipients = postmaster@exim.test.ex
address match test: subject=list2@exim.test.ex pattern=postmaster@exim.test.ex
list2@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 21)
check senders = myfriend@*
address match test: subject=postmaster@exim.test.ex pattern=myfriend@*
postmaster@exim.test.ex in "myfriend@*"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "deny" (TESTSUITE/test-config 22)
  message: host is listed in $dnslist_domain
check dnslists = rbl.test.ex
dnslists check: rbl.test.ex
dnslists: using result of previous lookup
DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
=> that means V4NET.11.12.13 is listed at rbl.test.ex
deny: condition test succeeded in ACL "check_recipient"
end of ACL "check_recipient": DENY
SMTP>> 550 host is listed in rbl.test.ex
LOG: MAIN REJECT
  H=(exim.test.ex) [V4NET.11.12.13] F=<postmaster@exim.test.ex> rejected RCPT list2@exim.test.ex: host is listed in rbl.test.ex
SMTP<< data
SMTP>> 354 Enter message, ending with "." on a line by itself
search_tidyup called
host in ignore_fromline_hosts? no (option unset)
>>Headers received:

search_tidyup called
>>Headers after rewriting and local additions:

Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
Data file written for message 10HmaX-0005vi-00
>>Generated Received: header line
P Received: from [V4NET.11.12.13] (helo=exim.test.ex)
	by the.local.host.name with esmtp (Exim x.yz)
	(envelope-from <postmaster@exim.test.ex>)
	id 10HmaX-0005vi-00
	for postmaster@exim.test.ex; Tue, 2 Mar 1999 09:44:33 +0000
LOG: MAIN
  <= postmaster@exim.test.ex H=(exim.test.ex) [V4NET.11.12.13] P=esmtp S=sss
SMTP>> 250 OK id=10HmaX-0005vi-00
smtp_setup_msg entered
SMTP<< quit
SMTP>> 221 the.local.host.name closing connection
LOG: smtp_connection MAIN
  SMTP connection from (exim.test.ex) [V4NET.11.12.13] closed by QUIT
search_tidyup called
>>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
>>> host in hosts_connection_nolog? no (option unset)
>>> host in host_lookup? no (option unset)
>>> host in host_reject_connection? no (option unset)
>>> host in sender_unqualified_hosts? no (option unset)
>>> host in recipient_unqualified_hosts? no (option unset)
>>> host in helo_verify_hosts? no (option unset)
>>> host in helo_try_verify_hosts? no (option unset)
>>> host in helo_accept_junk_hosts? no (option unset)
>>> exim.test.ex in helo_lookup_domains? no (end of list)
>>> host in dsn_advertise_hosts? no (option unset)
>>> host in pipelining_advertise_hosts? yes (matched "*")
>>> host in chunking_advertise_hosts? no (end of list)
>>> using ACL "check_recipient"
>>> processing "accept" (TESTSUITE/test-config 19)
>>> check hosts = :
>>> host in ":"? no (end of list)
>>> accept: condition test failed in ACL "check_recipient"
>>> processing "accept" (TESTSUITE/test-config 20)
>>> check recipients = postmaster@exim.test.ex
>>> list@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
>>> accept: condition test failed in ACL "check_recipient"
>>> processing "accept" (TESTSUITE/test-config 21)
>>> check senders = myfriend@*
>>> there.test.ex in "*"? yes (matched "*")
>>> myfriend@there.test.ex in "myfriend@*"? yes (matched "myfriend@*")
>>> accept: condition test succeeded in ACL "check_recipient"
>>> end of ACL "check_recipient": ACCEPT
>>> host in ignore_fromline_hosts? no (option unset)
LOG: 10HmaY-0005vi-00 <= myfriend@there.test.ex H=(exim.test.ex) [V4NET.11.12.13] P=esmtp S=sss
Exim version x.yz ....
changed uid/gid: forcing real = effective
  uid=uuuu gid=CALLER_GID pid=pppp
configuration file is TESTSUITE/test-config
admin user
changed uid/gid: privilege not needed
  uid=EXIM_UID gid=EXIM_GID pid=pppp
seeking password data for user "CALLER": cache not available
getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
sender address = CALLER@exim.test.ex
sender_fullhost = [V4NET.99.99.99]
sender_rcvhost = [V4NET.99.99.99]
host in hosts_connection_nolog? no (option unset)
LOG: smtp_connection MAIN
  SMTP connection from [V4NET.99.99.99]
host in host_lookup? no (option unset)
set_process_info: pppp handling incoming connection from [V4NET.99.99.99]
host in host_reject_connection? no (option unset)
host in sender_unqualified_hosts? no (option unset)
host in recipient_unqualified_hosts? no (option unset)
host in helo_verify_hosts? no (option unset)
host in helo_try_verify_hosts? no (option unset)
host in helo_accept_junk_hosts? no (option unset)
SMTP>> 220 the.local.host.name ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
smtp_setup_msg entered
SMTP<< ehlo exim.test.ex
exim.test.ex in helo_lookup_domains? no (end of list)
sender_fullhost = (exim.test.ex) [V4NET.99.99.99]
sender_rcvhost = [V4NET.99.99.99] (helo=exim.test.ex)
set_process_info: pppp handling incoming connection from (exim.test.ex) [V4NET.99.99.99]
host in dsn_advertise_hosts? no (option unset)
host in pipelining_advertise_hosts? yes (matched "*")
host in chunking_advertise_hosts? no (end of list)
SMTP>> 250-the.local.host.name Hello exim.test.ex [V4NET.99.99.99]
250-SIZE 52428800
250-8BITMIME
250-PIPELINING
250 HELP
SMTP<< mail from:postmaster@exim.test.ex
spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
SMTP>> 250 OK
SMTP<< rcpt to:list@exim.test.ex
using ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 19)
check hosts = :
host in ":"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 20)
check recipients = postmaster@exim.test.ex
address match test: subject=list@exim.test.ex pattern=postmaster@exim.test.ex
list@exim.test.ex in "postmaster@exim.test.ex"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "accept" (TESTSUITE/test-config 21)
check senders = myfriend@*
address match test: subject=postmaster@exim.test.ex pattern=myfriend@*
postmaster@exim.test.ex in "myfriend@*"? no (end of list)
accept: condition test failed in ACL "check_recipient"
processing "deny" (TESTSUITE/test-config 22)
  message: host is listed in $dnslist_domain
check dnslists = rbl.test.ex
dnslists check: rbl.test.ex
new DNS lookup for 99.99.99.V4NET.rbl.test.ex
DNS lookup of 99.99.99.V4NET.rbl.test.ex (A) using fakens
fresh-exec forking for child-open
postfork: child-open
fresh-exec forked for child-open: npppp
DNS lookup of 99.99.99.V4NET.rbl.test.ex (A) gave HOST_NOT_FOUND
returning DNS_NOMATCH
faking res_search(A) response length as 65535
 writing neg-cache entry for 99.99.99.V4NET.rbl.test.ex-A-xxxx, ttl 3000
faking res_search(A) response length as 65535
dnslists: wrote cache entry, ttl=3000
DNS lookup for 99.99.99.V4NET.rbl.test.ex failed
=> that means V4NET.99.99.99 is not listed at rbl.test.ex
deny: condition test failed in ACL "check_recipient"
processing "require" (TESTSUITE/test-config 24)
check verify = sender
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Verifying postmaster@exim.test.ex
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Considering postmaster@exim.test.ex
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
routing postmaster@exim.test.ex
--------> localuser router <--------
local_part=postmaster domain=exim.test.ex
checking local_parts
postmaster in "userx"? no (end of list)
localuser router skipped: local_parts mismatch
no more routers
----------- end verify ------------
require: condition test failed in ACL "check_recipient"
end of ACL "check_recipient": not OK
LOG: MAIN REJECT
  H=(exim.test.ex) [V4NET.99.99.99] sender verify fail for <postmaster@exim.test.ex>: Unrouteable address
SMTP>> 550-Verification failed for <postmaster@exim.test.ex>
SMTP>> 550-Unrouteable address
SMTP>> 550 Sender verify failed
LOG: MAIN REJECT
  H=(exim.test.ex) [V4NET.99.99.99] F=<postmaster@exim.test.ex> rejected RCPT list@exim.test.ex: Sender verify failed
SMTP>> 421 the.local.host.name lost input connection
LOG: lost_incoming_connection MAIN
  unexpected disconnection while reading SMTP command from (exim.test.ex) [V4NET.99.99.99] D=qqs
search_tidyup called
>>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>