Early-pipe: invalidate cache on a failure of required-auth

[exim.git] / test / stderr / 0398

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@test.ex
set_process_info: pppp accepting a local SMTP message from <CALLER@test.ex>
 in hosts_connection_nolog? no (option unset)
LOG: smtp_connection MAIN
  SMTP connection from CALLER
SMTP>> 220 mail.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
smtp_setup_msg entered
SMTP<< mail from:<qq@remote>
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:<abc@local>
using ACL "rcpt"
processing "deny" (TESTSUITE/test-config 19)
check senders = qq@remote
address match test: subject=qq@remote pattern=qq@remote
remote in "remote"? yes (matched "remote")
qq@remote in "qq@remote"? yes (matched "qq@remote")
check !verify = sender
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Verifying qq@remote
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Considering qq@remote
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
routing qq@remote
--------> r1 router <--------
local_part=qq domain=remote
checking domains
remote in "local"? no (end of list)
r1 router skipped: domains mismatch
--------> r2 router <--------
local_part=qq domain=remote
checking domains
remote in "remote"? yes (matched "remote")
calling r2 router
r2 router called for qq@remote
  domain = remote
route_item = * 127.0.0.1
remote in "*"? yes (matched "*")
original list of hosts = '127.0.0.1' options = ''
expanded list of hosts = '127.0.0.1' options = ''
set transport t2
finding IP address for 127.0.0.1
calling host_find_byname
using host_fake_gethostbyname for 127.0.0.1 (IPv4)
local host found for non-MX address
fully qualified name = 127.0.0.1
MUNGED: ::1 will be omitted in what follows
get[host|ipnode]byname[2] looked up these IP addresses:
  name=127.0.0.1 address=127.0.0.1
remote host address is the local host: remote: configured to try delivery anyway
queued for t2 transport: local_part = qq
domain = remote
  errors_to=NULL
  domain_data=NULL localpart_data=NULL
routed by r2 router
  envelope to: qq@remote
  transport: t2
  host 127.0.0.1 [127.0.0.1]
----------- end verify ------------
sender qq@remote verified ok
deny: condition test failed in ACL "rcpt"
processing "warn" (TESTSUITE/test-config 21)
check senders = qq@remote
address match test: subject=qq@remote pattern=qq@remote
remote in "remote"? yes (matched "remote")
qq@remote in "qq@remote"? yes (matched "qq@remote")
check !verify = sender/callout
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Verifying qq@remote
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Considering qq@remote
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
routing qq@remote
--------> r1 router <--------
local_part=qq domain=remote
checking domains
remote in "local"? no (end of list)
r1 router skipped: domains mismatch
--------> r2 router <--------
local_part=qq domain=remote
checking domains
remote in "remote"? yes (matched "remote")
calling r2 router
r2 router called for qq@remote
  domain = remote
route_item = * 127.0.0.1
remote in "*"? yes (matched "*")
original list of hosts = '127.0.0.1' options = ''
expanded list of hosts = '127.0.0.1' options = ''
finding IP address for 127.0.0.1
calling host_find_byname
using host_fake_gethostbyname for 127.0.0.1 (IPv4)
local host found for non-MX address
fully qualified name = 127.0.0.1
MUNGED: ::1 will be omitted in what follows
get[host|ipnode]byname[2] looked up these IP addresses:
  name=127.0.0.1 address=127.0.0.1
remote host address is the local host: remote: configured to try delivery anyway
queued for t2 transport: local_part = qq
domain = remote
  errors_to=NULL
  domain_data=NULL localpart_data=NULL
routed by r2 router
  envelope to: qq@remote
  transport: t2
  host 127.0.0.1 [127.0.0.1]
Attempting full verification using callout
 locking TESTSUITE/spool/db/callout.lockfile
 locked  TESTSUITE/spool/db/callout.lockfile
 EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
 returned from EXIM_DBOPEN: 0xAAAAAAAA
 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
 dbfn_read: key=remote
callout cache: found domain record for remote
 dbfn_read: key=qq@remote
callout cache: no address record found for qq@remote
 EXIM_DBCLOSE(0xAAAAAAAA)
 closed hints database and lockfile
interface=NULL port=1224
Connecting to 127.0.0.1 [127.0.0.1]:1224 ...  connected
  SMTP<< 220 Server ready
127.0.0.1 in hosts_avoid_esmtp? no (option unset)
  SMTP>> EHLO mail.test.ex
cmd buf flush ddd bytes
  SMTP<< 250 OK
not using PIPELINING
not using DSN
127.0.0.1 in hosts_require_auth? no (option unset)
  SMTP>> MAIL FROM:<>
cmd buf flush ddd bytes
  SMTP<< 250 OK
  SMTP>> RCPT TO:<qq@remote>
cmd buf flush ddd bytes
sync_responses expect rcpt
  SMTP<< 550 Unknown
  SMTP>> QUIT
cmd buf flush ddd bytes
  SMTP<< 250 OK
  SMTP(close)>>
 locking TESTSUITE/spool/db/callout.lockfile
 locked  TESTSUITE/spool/db/callout.lockfile
 EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR|O_CREAT
 returned from EXIM_DBOPEN: 0xAAAAAAAA
 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
 dbfn_write: key=remote
wrote callout cache domain record for remote:
  result=1 postmaster=0 random=0
 dbfn_write: key=qq@remote
wrote negative callout cache address record for qq@remote
 EXIM_DBCLOSE(0xAAAAAAAA)
 closed hints database and lockfile
----------- end verify ------------
l_message: $acl_verify_message
warn: condition test succeeded in ACL "rcpt"
LOG: MAIN
  U=CALLER Warning: Sender verify failed: 127.0.0.1 [127.0.0.1] : SMTP error from remote mail server after RCPT TO:<qq@remote>: 550 Unknown
processing "accept" (TESTSUITE/test-config 24)
check senders = qq@remote
address match test: subject=qq@remote pattern=qq@remote
remote in "remote"? yes (matched "remote")
qq@remote in "qq@remote"? yes (matched "qq@remote")
accept: condition test succeeded in ACL "rcpt"
end of ACL "rcpt": ACCEPT
SMTP>> 250 Accepted
DSN: orcpt: NULL  flags: 0
SMTP<< rcpt to:<xyz@local>
using ACL "rcpt"
processing "deny" (TESTSUITE/test-config 19)
check senders = qq@remote
address match test: subject=qq@remote pattern=qq@remote
remote in "remote"? yes (matched "remote")
qq@remote in "qq@remote"? yes (matched "qq@remote")
check !verify = sender
using cached sender verify result
deny: condition test failed in ACL "rcpt"
processing "warn" (TESTSUITE/test-config 21)
check senders = qq@remote
address match test: subject=qq@remote pattern=qq@remote
remote in "remote"? yes (matched "remote")
qq@remote in "qq@remote"? yes (matched "qq@remote")
check !verify = sender/callout
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Verifying qq@remote
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
Considering qq@remote
>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
routing qq@remote
--------> r1 router <--------
local_part=qq domain=remote
checking domains
remote in "local"? no (end of list)
r1 router skipped: domains mismatch
--------> r2 router <--------
local_part=qq domain=remote
checking domains
remote in "remote"? yes (matched "remote")
calling r2 router
r2 router called for qq@remote
  domain = remote
route_item = * 127.0.0.1
remote in "*"? yes (matched "*")
original list of hosts = '127.0.0.1' options = ''
expanded list of hosts = '127.0.0.1' options = ''
finding IP address for 127.0.0.1
calling host_find_byname
using host_fake_gethostbyname for 127.0.0.1 (IPv4)
local host found for non-MX address
fully qualified name = 127.0.0.1
MUNGED: ::1 will be omitted in what follows
get[host|ipnode]byname[2] looked up these IP addresses:
  name=127.0.0.1 address=127.0.0.1
remote host address is the local host: remote: configured to try delivery anyway
queued for t2 transport: local_part = qq
domain = remote
  errors_to=NULL
  domain_data=NULL localpart_data=NULL
routed by r2 router
  envelope to: qq@remote
  transport: t2
  host 127.0.0.1 [127.0.0.1]
Attempting full verification using callout
 locking TESTSUITE/spool/db/callout.lockfile
 locked  TESTSUITE/spool/db/callout.lockfile
 EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
 returned from EXIM_DBOPEN: 0xAAAAAAAA
 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
 dbfn_read: key=remote
callout cache: found domain record for remote
 dbfn_read: key=qq@remote
callout cache: found address record for qq@remote
callout cache: address record is negative
 EXIM_DBCLOSE(0xAAAAAAAA)
 closed hints database and lockfile
----------- end verify ------------
l_message: $acl_verify_message
warn: condition test succeeded in ACL "rcpt"
LOG: MAIN
  U=CALLER Warning: Sender verify failed
processing "accept" (TESTSUITE/test-config 24)
check senders = qq@remote
address match test: subject=qq@remote pattern=qq@remote
remote in "remote"? yes (matched "remote")
qq@remote in "qq@remote"? yes (matched "qq@remote")
accept: condition test succeeded in ACL "rcpt"
end of ACL "rcpt": ACCEPT
SMTP>> 250 Accepted
DSN: orcpt: NULL  flags: 0
SMTP<< quit
SMTP>> 221 mail.test.ex closing connection
LOG: smtp_connection MAIN
  SMTP connection from CALLER closed by QUIT
search_tidyup called
>>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>