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