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