test/stderr/0432

   1 >>> host in hosts_connection_nolog? no (option unset)
   2 >>> host in host_lookup? no (option unset)
   3 >>> host in host_reject_connection? no (option unset)
   4 >>> host in sender_unqualified_hosts? no (option unset)
   5 >>> host in recipient_unqualified_hosts? no (option unset)
   6 >>> host in helo_verify_hosts? no (option unset)
   7 >>> host in helo_try_verify_hosts? no (option unset)
   8 >>> host in helo_accept_junk_hosts? no (option unset)
   9 >>> host in pipelining_connect_advertise_hosts?
  10 >>>  list element:
  11 >>> test in helo_lookup_domains?
  12 >>>  list element: @
  13 >>>  list element: @[]
  14 >>> test in helo_lookup_domains? no (end of list)
  15 >>> using ACL "mail"
  16 >>> processing "accept" (TESTSUITE/test-config 20)
  17 >>> check verify = sender/callout=1s,maxwait=1s
  18 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  19 >>> routing x@y
  20 >>> calling r1 router
  21 >>> routed by r1 router
  22 >>> local host found for non-MX address
  23 MUNGED: ::1 will be omitted in what follows
  24 >>> get[host|ipnode]byname[2] looked up these IP addresses:
  25 >>>   name=127.0.0.1 address=127.0.0.1
  26 >>> Attempting full verification using callout
  27 >>> ... callout omitted by default when host testing
  28 >>> (Use -bhc if you want the callouts to happen.)
  29 >>> ----------- end verify ------------
  30 >>> accept: condition test succeeded in ACL "mail"
  31 >>> end of ACL "mail": ACCEPT
  32 Exim version x.yz ....
  33 changed uid/gid: forcing real = effective
  34   uid=uuuu gid=CALLER_GID pid=p1234
  35 configuration file is TESTSUITE/test-config
  36 admin user
  37 changed uid/gid: privilege not needed
  38   uid=EXIM_UID gid=EXIM_GID pid=p1234
  39 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  40 sender address = CALLER@myhost.test.ex
  41 sender_fullhost = [1.2.3.4]
  42 sender_rcvhost = [1.2.3.4]
  43 host in hosts_connection_nolog? no (option unset)
  44 LOG: smtp_connection MAIN
  45   SMTP connection from [1.2.3.4]
  46 host in host_lookup? no (option unset)
  47 set_process_info: pppp handling incoming connection from [1.2.3.4]
  48 host in host_reject_connection? no (option unset)
  49 host in sender_unqualified_hosts? no (option unset)
  50 host in recipient_unqualified_hosts? no (option unset)
  51 host in helo_verify_hosts? no (option unset)
  52 host in helo_try_verify_hosts? no (option unset)
  53 host in helo_accept_junk_hosts? no (option unset)
  54 host in pipelining_connect_advertise_hosts?
  55  list element:
  56 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
  57 smtp_setup_msg entered
  58 SMTP<< helo test
  59 test in helo_lookup_domains?
  60  list element: @
  61  list element: @[]
  62 test in helo_lookup_domains? no (end of list)
  63 sender_fullhost = (test) [1.2.3.4]
  64 sender_rcvhost = [1.2.3.4] (helo=test)
  65 set_process_info: pppp handling incoming connection from (test) [1.2.3.4]
  66 SMTP>> 250 myhost.test.ex Hello test [1.2.3.4]
  67 SMTP<< mail from:<x@y>
  68 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
  69 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
  70 using ACL "mail"
  71 processing "accept" (TESTSUITE/test-config 20)
  72 check verify = sender/callout=1s,maxwait=1s
  73 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  74 Verifying x@y
  75 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  76 Considering x@y
  77 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  78 routing x@y
  79 --------> r1 router <--------
  80 local_part=x domain=y
  81 calling r1 router
  82 r1 router called for x@y
  83   domain = y
  84 set transport t1
  85 queued for t1 transport: local_part = x
  86 domain = y
  87   errors_to=NULL
  88   domain_data=NULL local_part_data=NULL
  89 routed by r1 router
  90   envelope to: x@y
  91   transport: t1
  92 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
  93 local host found for non-MX address
  94 MUNGED: ::1 will be omitted in what follows
  95 get[host|ipnode]byname[2] looked up these IP addresses:
  96   name=127.0.0.1 address=127.0.0.1
  97 Attempting full verification using callout
  98  locking TESTSUITE/spool/db/callout.lockfile
  99  locked  TESTSUITE/spool/db/callout.lockfile
 100  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
 101  returned from EXIM_DBOPEN: 0xAAAAAAAA
 102  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
 103  dbfn_read: key=y
 104  callout cache: no domain record found for y
 105  dbfn_read: key=x@y
 106  callout cache: no address record found for x@y
 107  EXIM_DBCLOSE(0xAAAAAAAA)
 108  closed hints database and lockfile
 109 interface=NULL port=PORT_S
 110 Connecting to 127.0.0.1 [127.0.0.1]:PORT_S ... 127.0.0.1 in hosts_try_fastopen?
 111  list element:
 112  connected
 113   SMTP<< 220 server ready
 114 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
 115   SMTP>> EHLO myhost.test.ex
 116 cmd buf flush ddd bytes
 117   SMTP<< 250 OK
 118  compiled RE '.outlook.com$' not found in local cache
 119  compiling RE '.outlook.com$'
 120  compiled RE '.outlook.com$' saved in local cache
 121 not using PIPELINING
 122 not using DSN
 123 127.0.0.1 in hosts_require_auth? no (option unset)
 124   SMTP>> MAIL FROM:<>
 125 cmd buf flush ddd bytes
 126   SMTP<< 250 OK
 127   SMTP>> RCPT TO:<x@y>
 128 cmd buf flush ddd bytes
 129 sync_responses expect rcpt for x@y
 130   SMTP<< 250 OK
 131   SMTP>> QUIT
 132 cmd buf flush ddd bytes
 133   SMTP<< 220 OK
 134   SMTP(close)>>
 135 cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:220'
 136  locking TESTSUITE/spool/db/callout.lockfile
 137  locked  TESTSUITE/spool/db/callout.lockfile
 138  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR|O_CREAT
 139  returned from EXIM_DBOPEN: 0xAAAAAAAA
 140  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
 141  dbfn_write: key=y
 142  wrote callout cache domain record for y:
 143    result=1 postmaster=0 random=0
 144  dbfn_write: key=x@y
 145  wrote positive callout cache address record for x@y
 146  EXIM_DBCLOSE(0xAAAAAAAA)
 147  closed hints database and lockfile
 148 ----------- end verify ------------
 149 sender x@y verified ok
 150 accept: condition test succeeded in ACL "mail"
 151 end of ACL "mail": ACCEPT
 152 SMTP>> 250 OK
 153 SMTP<< quit
 154 SMTP>> 221 myhost.test.ex closing connection
 155 LOG: smtp_connection MAIN
 156   SMTP connection from (test) [1.2.3.4] closed by QUIT
 157 search_tidyup called
 158 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 159 Exim version x.yz ....
 160 changed uid/gid: forcing real = effective
 161   uid=uuuu gid=CALLER_GID pid=p1235
 162 configuration file is TESTSUITE/test-config
 163 admin user
 164 changed uid/gid: privilege not needed
 165   uid=EXIM_UID gid=EXIM_GID pid=p1235
 166 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 167 sender address = CALLER@myhost.test.ex
 168 sender_fullhost = [1.2.3.4]
 169 sender_rcvhost = [1.2.3.4]
 170 host in hosts_connection_nolog? no (option unset)
 171 LOG: smtp_connection MAIN
 172   SMTP connection from [1.2.3.4]
 173 host in host_lookup? no (option unset)
 174 set_process_info: pppp handling incoming connection from [1.2.3.4]
 175 host in host_reject_connection? no (option unset)
 176 host in sender_unqualified_hosts? no (option unset)
 177 host in recipient_unqualified_hosts? no (option unset)
 178 host in helo_verify_hosts? no (option unset)
 179 host in helo_try_verify_hosts? no (option unset)
 180 host in helo_accept_junk_hosts? no (option unset)
 181 host in pipelining_connect_advertise_hosts?
 182  list element:
 183 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
 184 smtp_setup_msg entered
 185 SMTP<< helo test
 186 test in helo_lookup_domains?
 187  list element: @
 188  list element: @[]
 189 test in helo_lookup_domains? no (end of list)
 190 sender_fullhost = (test) [1.2.3.4]
 191 sender_rcvhost = [1.2.3.4] (helo=test)
 192 set_process_info: pppp handling incoming connection from (test) [1.2.3.4]
 193 SMTP>> 250 myhost.test.ex Hello test [1.2.3.4]
 194 SMTP<< mail from:<x@y>
 195 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
 196 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
 197 using ACL "mail"
 198 processing "accept" (TESTSUITE/test-config 20)
 199 check verify = sender/callout=1s,maxwait=1s
 200 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 201 Verifying x@y
 202 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 203 Considering x@y
 204 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 205 routing x@y
 206 --------> r1 router <--------
 207 local_part=x domain=y
 208 calling r1 router
 209 r1 router called for x@y
 210   domain = y
 211 set transport t1
 212 queued for t1 transport: local_part = x
 213 domain = y
 214   errors_to=NULL
 215   domain_data=NULL local_part_data=NULL
 216 routed by r1 router
 217   envelope to: x@y
 218   transport: t1
 219 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
 220 local host found for non-MX address
 221 MUNGED: ::1 will be omitted in what follows
 222 get[host|ipnode]byname[2] looked up these IP addresses:
 223   name=127.0.0.1 address=127.0.0.1
 224 Attempting full verification using callout
 225  locking TESTSUITE/spool/db/callout.lockfile
 226  locked  TESTSUITE/spool/db/callout.lockfile
 227  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
 228  returned from EXIM_DBOPEN: 0xAAAAAAAA
 229  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
 230  dbfn_read: key=y
 231  callout cache: found domain record for y
 232  dbfn_read: key=x@y
 233  callout cache: found address record for x@y
 234  callout cache: address record is positive
 235  EXIM_DBCLOSE(0xAAAAAAAA)
 236  closed hints database and lockfile
 237 ----------- end verify ------------
 238 sender x@y verified ok
 239 accept: condition test succeeded in ACL "mail"
 240 end of ACL "mail": ACCEPT
 241 SMTP>> 250 OK
 242 SMTP<< quit
 243 SMTP>> 221 myhost.test.ex closing connection
 244 LOG: smtp_connection MAIN
 245   SMTP connection from (test) [1.2.3.4] closed by QUIT
 246 search_tidyup called
 247 >>>>>>>>>>>>>>>> Exim pid=p1235 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 248 >>> host in hosts_connection_nolog? no (option unset)
 249 >>> host in host_lookup? no (option unset)
 250 >>> host in host_reject_connection? no (option unset)
 251 >>> host in sender_unqualified_hosts? no (option unset)
 252 >>> host in recipient_unqualified_hosts? no (option unset)
 253 >>> host in helo_verify_hosts? no (option unset)
 254 >>> host in helo_try_verify_hosts? no (option unset)
 255 >>> host in helo_accept_junk_hosts? no (option unset)
 256 >>> host in pipelining_connect_advertise_hosts?
 257 >>>  list element:
 258 >>> test in helo_lookup_domains?
 259 >>>  list element: @
 260 >>>  list element: @[]
 261 >>> test in helo_lookup_domains? no (end of list)
 262 >>> using ACL "mail"
 263 >>> processing "accept" (TESTSUITE/test-config 20)
 264 >>> check verify = sender/callout=1s,maxwait=1s
 265 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 266 >>> routing x@y
 267 >>> calling r1 router
 268 >>> routed by r1 router
 269 >>> local host found for non-MX address
 270 MUNGED: ::1 will be omitted in what follows
 271 >>> get[host|ipnode]byname[2] looked up these IP addresses:
 272 >>>   name=127.0.0.1 address=127.0.0.1
 273 >>> Attempting full verification using callout
 274 >>> callout cache: found domain record for y
 275 >>> callout cache: found address record for x@y
 276 >>> callout cache: address record is positive
 277 >>> ----------- end verify ------------
 278 >>> accept: condition test succeeded in ACL "mail"
 279 >>> end of ACL "mail": ACCEPT
 280 >>> host in hosts_connection_nolog? no (option unset)
 281 >>> host in host_lookup? no (option unset)
 282 >>> host in host_reject_connection? no (option unset)
 283 >>> host in sender_unqualified_hosts? no (option unset)
 284 >>> host in recipient_unqualified_hosts? no (option unset)
 285 >>> host in helo_verify_hosts? no (option unset)
 286 >>> host in helo_try_verify_hosts? no (option unset)
 287 >>> host in helo_accept_junk_hosts? no (option unset)
 288 >>> host in pipelining_connect_advertise_hosts?
 289 >>>  list element:
 290 >>> test in helo_lookup_domains?
 291 >>>  list element: @
 292 >>>  list element: @[]
 293 >>> test in helo_lookup_domains? no (end of list)
 294 >>> using ACL "mail"
 295 >>> processing "accept" (TESTSUITE/test-config 20)
 296 >>> check verify = sender/callout=1s,maxwait=1s
 297 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 298 >>> routing a@b
 299 >>> calling r1 router
 300 >>> routed by r1 router
 301 >>> local host found for non-MX address
 302 MUNGED: ::1 will be omitted in what follows
 303 >>> get[host|ipnode]byname[2] looked up these IP addresses:
 304 >>>   name=127.0.0.1 address=127.0.0.1
 305 >>> Attempting full verification using callout
 306 >>> callout cache: no domain record found for b
 307 >>> callout cache: no address record found for a@b
 308 >>> interface=NULL port=PORT_S
 309 >>> Connecting to 127.0.0.1 [127.0.0.1]:PORT_S ... 127.0.0.1 in hosts_try_fastopen?
 310 >>>  list element:
 311 >>> >>>  connected
 312 >>>   SMTP<< 220 server ready
 313 >>> 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
 314 >>>   SMTP>> EHLO myhost.test.ex
 315 >>> cmd buf flush 21 bytes
 316 >>>   SMTP<< 250 OK
 317 >>> 127.0.0.1 in hosts_require_auth? no (option unset)
 318 >>>   SMTP>> MAIL FROM:<>
 319 >>> cmd buf flush 14 bytes
 320 >>>   SMTP<< 250 OK
 321 >>>   SMTP>> RCPT TO:<a@b>
 322 >>> cmd buf flush 15 bytes
 323 >>>   SMTP<< 250 OK
 324 >>>   SMTP>> QUIT
 325 >>> cmd buf flush 6 bytes
 326 >>>   SMTP<< 220 OK
 327 >>>   SMTP(close)>>
 328 >>> cmdlog: '220:EHLO:250:MAIL:250:RCPT:250:QUIT:220'
 329 >>> wrote callout cache domain record for b:
 330 >>>   result=1 postmaster=0 random=0
 331 >>> wrote positive callout cache address record for a@b
 332 >>> ----------- end verify ------------
 333 >>> accept: condition test succeeded in ACL "mail"
 334 >>> end of ACL "mail": ACCEPT
 335 >>> host in hosts_connection_nolog? no (option unset)
 336 >>> host in host_lookup? no (option unset)
 337 >>> host in host_reject_connection? no (option unset)
 338 >>> host in sender_unqualified_hosts? no (option unset)
 339 >>> host in recipient_unqualified_hosts? no (option unset)
 340 >>> host in helo_verify_hosts? no (option unset)
 341 >>> host in helo_try_verify_hosts? no (option unset)
 342 >>> host in helo_accept_junk_hosts? no (option unset)
 343 >>> host in pipelining_connect_advertise_hosts?
 344 >>>  list element:
 345 >>> test in helo_lookup_domains?
 346 >>>  list element: @
 347 >>>  list element: @[]
 348 >>> test in helo_lookup_domains? no (end of list)
 349 >>> using ACL "mail"
 350 >>> processing "accept" (TESTSUITE/test-config 20)
 351 >>> check verify = sender/callout=1s,maxwait=1s
 352 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 353 >>> routing p1@q
 354 >>> calling r1 router
 355 >>> routed by r1 router
 356 >>> local host found for non-MX address
 357 MUNGED: ::1 will be omitted in what follows
 358 >>> get[host|ipnode]byname[2] looked up these IP addresses:
 359 >>>   name=127.0.0.1 address=127.0.0.1
 360 >>> Attempting full verification using callout
 361 >>> callout cache: no domain record found for q
 362 >>> callout cache: no address record found for p1@q
 363 >>> interface=NULL port=PORT_S
 364 >>> Connecting to 127.0.0.1 [127.0.0.1]:PORT_S ... 127.0.0.1 in hosts_try_fastopen?
 365 >>>  list element:
 366 >>> >>>  connected
 367 >>>   SMTP<< 220 server ready
 368 >>> 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
 369 >>>   SMTP>> EHLO myhost.test.ex
 370 >>> cmd buf flush 21 bytes
 371 >>>   SMTP(close)>>
 372 >>> cmdlog: '220:EHLO'
 373 >>> SMTP timeout
 374 >>> ----------- end verify ------------
 375 >>> accept: condition test deferred in ACL "mail"
 376 LOG: H=(test) [1.2.3.4] sender verify defer for <p1@q>: Could not complete sender verify callout: 127.0.0.1 [127.0.0.1] : SMTP timeout after EHLO myhost.test.ex
 377 LOG: H=(test) [1.2.3.4] temporarily rejected MAIL <p1@q>: Could not complete sender verify callout