test/stderr/0398

   1 Exim version x.yz ....
   2 changed uid/gid: forcing real = effective
   3   uid=uuuu gid=CALLER_GID pid=p1234
   4 configuration file is TESTSUITE/test-config
   5 admin user
   6 changed uid/gid: privilege not needed
   7   uid=EXIM_UID gid=EXIM_GID pid=p1234
   8 seeking password data for user "CALLER": cache not available
   9 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  10 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  11 sender address = CALLER@test.ex
  12 set_process_info: pppp accepting a local SMTP message from <CALLER@test.ex>
  13  in hosts_connection_nolog? no (option unset)
  14 LOG: smtp_connection MAIN
  15   SMTP connection from CALLER
  16 SMTP>> 220 mail.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
  17 smtp_setup_msg entered
  18 SMTP<< helo test
  19 SMTP>> 250 mail.test.ex Hello CALLER at test
  20 SMTP<< mail from:<qq@remote>
  21 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
  22 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
  23 SMTP>> 250 OK
  24 SMTP<< rcpt to:<abc@local>
  25 using ACL "rcpt"
  26 processing "deny" (TESTSUITE/test-config 19)
  27 check senders = qq@remote
  28 qq@remote in "qq@remote"?
  29  list element: qq@remote
  30  address match test: subject=qq@remote pattern=qq@remote
  31  remote in "remote"?
  32   list element: remote
  33   remote in "remote"? yes (matched "remote")
  34  qq@remote in "qq@remote"? yes (matched "qq@remote")
  35 check !verify = sender
  36 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  37 Verifying qq@remote
  38 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  39 Considering qq@remote
  40 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  41 routing qq@remote
  42 --------> r1 router <--------
  43 local_part=qq domain=remote
  44 checking domains
  45 remote in domains?
  46  list element: local
  47 remote in domains? no (end of list)
  48 r1 router skipped: domains mismatch
  49 --------> r2 router <--------
  50 local_part=qq domain=remote
  51 checking domains
  52 remote in domains?
  53  list element: remote
  54  remote in domains? yes (matched "remote")
  55 calling r2 router
  56 r2 router called for qq@remote
  57   domain = remote
  58 route_item = * 127.0.0.1
  59 remote in "*"?
  60  list element: *
  61  remote in "*"? yes (matched "*")
  62 original list of hosts = '127.0.0.1' options = ''
  63 expanded list of hosts = '127.0.0.1' options = ''
  64 set transport t2
  65 finding IP address for 127.0.0.1
  66 calling host_find_byname
  67 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
  68 local host found for non-MX address
  69 fully qualified name = 127.0.0.1
  70 MUNGED: ::1 will be omitted in what follows
  71 get[host|ipnode]byname[2] looked up these IP addresses:
  72   name=127.0.0.1 address=127.0.0.1
  73 remote host address is the local host: remote: configured to try delivery anyway
  74 queued for t2 transport: local_part = qq
  75 domain = remote
  76   errors_to=NULL
  77   domain_data=remote local_part_data=NULL
  78 routed by r2 router
  79   envelope to: qq@remote
  80   transport: t2
  81   host 127.0.0.1 [127.0.0.1]
  82 ----------- end verify ------------
  83 sender qq@remote verified ok
  84 deny: condition test failed in ACL "rcpt"
  85 processing "warn" (TESTSUITE/test-config 21)
  86 check senders = qq@remote
  87 qq@remote in "qq@remote"?
  88  list element: qq@remote
  89  address match test: subject=qq@remote pattern=qq@remote
  90  remote in "remote"?
  91   list element: remote
  92   remote in "remote"? yes (matched "remote")
  93  qq@remote in "qq@remote"? yes (matched "qq@remote")
  94 check !verify = sender/callout
  95 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  96 Verifying qq@remote
  97 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  98 Considering qq@remote
  99 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 100 routing qq@remote
 101 --------> r1 router <--------
 102 local_part=qq domain=remote
 103 checking domains
 104 remote in domains?
 105  list element: local
 106 remote in domains? no (end of list)
 107 r1 router skipped: domains mismatch
 108 --------> r2 router <--------
 109 local_part=qq domain=remote
 110 checking domains
 111 remote in domains?
 112  list element: remote
 113  remote in domains? yes (matched "remote")
 114 calling r2 router
 115 r2 router called for qq@remote
 116   domain = remote
 117 route_item = * 127.0.0.1
 118 remote in "*"?
 119  list element: *
 120  remote in "*"? yes (matched "*")
 121 original list of hosts = '127.0.0.1' options = ''
 122 expanded list of hosts = '127.0.0.1' options = ''
 123 finding IP address for 127.0.0.1
 124 calling host_find_byname
 125 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
 126 local host found for non-MX address
 127 fully qualified name = 127.0.0.1
 128 MUNGED: ::1 will be omitted in what follows
 129 get[host|ipnode]byname[2] looked up these IP addresses:
 130   name=127.0.0.1 address=127.0.0.1
 131 remote host address is the local host: remote: configured to try delivery anyway
 132 queued for t2 transport: local_part = qq
 133 domain = remote
 134   errors_to=NULL
 135   domain_data=remote local_part_data=NULL
 136 routed by r2 router
 137   envelope to: qq@remote
 138   transport: t2
 139   host 127.0.0.1 [127.0.0.1]
 140 Attempting full verification using callout
 141  locking TESTSUITE/spool/db/callout.lockfile
 142  locked  TESTSUITE/spool/db/callout.lockfile
 143  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
 144  returned from EXIM_DBOPEN: 0xAAAAAAAA
 145  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
 146  dbfn_read: key=remote
 147  callout cache: found domain record for remote
 148  dbfn_read: key=qq@remote
 149  callout cache: no address record found for qq@remote
 150  EXIM_DBCLOSE(0xAAAAAAAA)
 151  closed hints database and lockfile
 152 interface=NULL port=PORT_S
 153 Connecting to 127.0.0.1 [127.0.0.1]:PORT_S ...
 154  127.0.0.1 in hosts_try_fastopen?
 155   list element:
 156  connected
 157   SMTP<< 220 Server ready
 158 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
 159   SMTP>> EHLO mail.test.ex
 160 cmd buf flush ddd bytes
 161   SMTP<< 250 OK
 162 not using PIPELINING
 163 not using DSN
 164 127.0.0.1 in hosts_require_auth? no (option unset)
 165   SMTP>> MAIL FROM:<>
 166 cmd buf flush ddd bytes
 167   SMTP<< 250 OK
 168   SMTP>> RCPT TO:<qq@remote>
 169 cmd buf flush ddd bytes
 170 sync_responses expect rcpt for qq@remote
 171   SMTP<< 550 Unknown
 172   SMTP>> QUIT
 173 cmd buf flush ddd bytes
 174   SMTP<< 250 OK
 175   SMTP(close)>>
 176 cmdlog: '220:EHLO:250:MAIL:250:RCPT:550:QUIT:250'
 177  locking TESTSUITE/spool/db/callout.lockfile
 178  locked  TESTSUITE/spool/db/callout.lockfile
 179  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR|O_CREAT
 180  returned from EXIM_DBOPEN: 0xAAAAAAAA
 181  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
 182  dbfn_write: key=remote
 183  wrote callout cache domain record for remote:
 184    result=1 postmaster=0 random=0
 185  dbfn_write: key=qq@remote
 186  wrote negative callout cache address record for qq@remote
 187  EXIM_DBCLOSE(0xAAAAAAAA)
 188  closed hints database and lockfile
 189 ----------- end verify ------------
 190 l_message: $acl_verify_message
 191 warn: condition test succeeded in ACL "rcpt"
 192 LOG: MAIN
 193   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
 194 processing "accept" (TESTSUITE/test-config 24)
 195 check senders = qq@remote
 196 qq@remote in "qq@remote"?
 197  list element: qq@remote
 198  address match test: subject=qq@remote pattern=qq@remote
 199  remote in "remote"?
 200   list element: remote
 201   remote in "remote"? yes (matched "remote")
 202  qq@remote in "qq@remote"? yes (matched "qq@remote")
 203 accept: condition test succeeded in ACL "rcpt"
 204 end of ACL "rcpt": ACCEPT
 205 SMTP>> 250 Accepted
 206 SMTP<< rcpt to:<xyz@local>
 207 using ACL "rcpt"
 208 processing "deny" (TESTSUITE/test-config 19)
 209 check senders = qq@remote
 210 qq@remote in "qq@remote"?
 211  list element: qq@remote
 212  address match test: subject=qq@remote pattern=qq@remote
 213  remote in "remote"?
 214   list element: remote
 215   remote in "remote"? yes (matched "remote")
 216  qq@remote in "qq@remote"? yes (matched "qq@remote")
 217 check !verify = sender
 218 using cached sender verify result
 219 deny: condition test failed in ACL "rcpt"
 220 processing "warn" (TESTSUITE/test-config 21)
 221 check senders = qq@remote
 222 qq@remote in "qq@remote"?
 223  list element: qq@remote
 224  address match test: subject=qq@remote pattern=qq@remote
 225  remote in "remote"?
 226   list element: remote
 227   remote in "remote"? yes (matched "remote")
 228  qq@remote in "qq@remote"? yes (matched "qq@remote")
 229 check !verify = sender/callout
 230 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 231 Verifying qq@remote
 232 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 233 Considering qq@remote
 234 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 235 routing qq@remote
 236 --------> r1 router <--------
 237 local_part=qq domain=remote
 238 checking domains
 239 remote in domains?
 240  list element: local
 241 remote in domains? no (end of list)
 242 r1 router skipped: domains mismatch
 243 --------> r2 router <--------
 244 local_part=qq domain=remote
 245 checking domains
 246 remote in domains?
 247  list element: remote
 248  remote in domains? yes (matched "remote")
 249 calling r2 router
 250 r2 router called for qq@remote
 251   domain = remote
 252 route_item = * 127.0.0.1
 253 remote in "*"?
 254  list element: *
 255  remote in "*"? yes (matched "*")
 256 original list of hosts = '127.0.0.1' options = ''
 257 expanded list of hosts = '127.0.0.1' options = ''
 258 finding IP address for 127.0.0.1
 259 calling host_find_byname
 260 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
 261 local host found for non-MX address
 262 fully qualified name = 127.0.0.1
 263 MUNGED: ::1 will be omitted in what follows
 264 get[host|ipnode]byname[2] looked up these IP addresses:
 265   name=127.0.0.1 address=127.0.0.1
 266 remote host address is the local host: remote: configured to try delivery anyway
 267 queued for t2 transport: local_part = qq
 268 domain = remote
 269   errors_to=NULL
 270   domain_data=remote local_part_data=NULL
 271 routed by r2 router
 272   envelope to: qq@remote
 273   transport: t2
 274   host 127.0.0.1 [127.0.0.1]
 275 Attempting full verification using callout
 276  locking TESTSUITE/spool/db/callout.lockfile
 277  locked  TESTSUITE/spool/db/callout.lockfile
 278  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
 279  returned from EXIM_DBOPEN: 0xAAAAAAAA
 280  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
 281  dbfn_read: key=remote
 282  callout cache: found domain record for remote
 283  dbfn_read: key=qq@remote
 284  callout cache: found address record for qq@remote
 285  callout cache: address record is negative
 286  EXIM_DBCLOSE(0xAAAAAAAA)
 287  closed hints database and lockfile
 288 ----------- end verify ------------
 289 l_message: $acl_verify_message
 290 warn: condition test succeeded in ACL "rcpt"
 291 LOG: MAIN
 292   U=CALLER Warning: Sender verify failed
 293 processing "accept" (TESTSUITE/test-config 24)
 294 check senders = qq@remote
 295 qq@remote in "qq@remote"?
 296  list element: qq@remote
 297  address match test: subject=qq@remote pattern=qq@remote
 298  remote in "remote"?
 299   list element: remote
 300   remote in "remote"? yes (matched "remote")
 301  qq@remote in "qq@remote"? yes (matched "qq@remote")
 302 accept: condition test succeeded in ACL "rcpt"
 303 end of ACL "rcpt": ACCEPT
 304 SMTP>> 250 Accepted
 305 SMTP<< quit
 306 SMTP>> 221 mail.test.ex closing connection
 307 LOG: smtp_connection MAIN
 308   SMTP connection from CALLER D=qqs closed by QUIT
 309 search_tidyup called
 310 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>