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