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" (TESTSUITE/test-config 20)
  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 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  34 sender address = CALLER@myhost.test.ex
  35 sender_fullhost = [1.2.3.4]
  36 sender_rcvhost = [1.2.3.4]
  37 host in hosts_connection_nolog? no (option unset)
  38 LOG: smtp_connection MAIN
  39   SMTP connection from [1.2.3.4]
  40 host in host_lookup? no (option unset)
  41 set_process_info: pppp handling incoming connection from [1.2.3.4]
  42 host in host_reject_connection? no (option unset)
  43 host in sender_unqualified_hosts? no (option unset)
  44 host in recipient_unqualified_hosts? no (option unset)
  45 host in helo_verify_hosts? no (option unset)
  46 host in helo_try_verify_hosts? no (option unset)
  47 host in helo_accept_junk_hosts? no (option unset)
  48 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
  49 smtp_setup_msg entered
  50 SMTP<< mail from:<x@y>
  51 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
  52 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
  53 using ACL "mail"
  54 processing "accept" (TESTSUITE/test-config 20)
  55 check verify = sender/callout=1s,maxwait=1s
  56 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  57 Verifying x@y
  58 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  59 Considering x@y
  60 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  61 routing x@y
  62 --------> r1 router <--------
  63 local_part=x domain=y
  64 calling r1 router
  65 r1 router called for x@y
  66   domain = y
  67 set transport t1
  68 queued for t1 transport: local_part = x
  69 domain = y
  70   errors_to=NULL
  71   domain_data=NULL local_part_data=NULL
  72 routed by r1 router
  73   envelope to: x@y
  74   transport: t1
  75 host_fake_gethostbyname returned 1 (HOST_NOT_FOUND)
  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 sync_responses expect rcpt
 109   SMTP<< 250 OK
 110   SMTP>> QUIT
 111 cmd buf flush ddd bytes
 112   SMTP<< 220 OK
 113   SMTP(close)>>
 114  locking TESTSUITE/spool/db/callout.lockfile
 115  locked  TESTSUITE/spool/db/callout.lockfile
 116  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR|O_CREAT
 117  returned from EXIM_DBOPEN: 0xAAAAAAAA
 118  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
 119  dbfn_write: key=y
 120 wrote callout cache domain record for y:
 121   result=1 postmaster=0 random=0
 122  dbfn_write: key=x@y
 123 wrote positive callout cache address record for x@y
 124  EXIM_DBCLOSE(0xAAAAAAAA)
 125  closed hints database and lockfile
 126 ----------- end verify ------------
 127 sender x@y verified ok
 128 accept: condition test succeeded in ACL "mail"
 129 end of ACL "mail": ACCEPT
 130 SMTP>> 250 OK
 131 SMTP<< quit
 132 SMTP>> 221 myhost.test.ex closing connection
 133 LOG: smtp_connection MAIN
 134   SMTP connection from [1.2.3.4] closed by QUIT
 135 search_tidyup called
 136 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 137 Exim version x.yz ....
 138 changed uid/gid: forcing real = effective
 139   uid=uuuu gid=CALLER_GID pid=pppp
 140 configuration file is TESTSUITE/test-config
 141 admin user
 142 changed uid/gid: privilege not needed
 143   uid=EXIM_UID gid=EXIM_GID pid=pppp
 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" (TESTSUITE/test-config 20)
 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 local_part_data=NULL
 183 routed by r1 router
 184   envelope to: x@y
 185   transport: t1
 186 host_fake_gethostbyname returned 1 (HOST_NOT_FOUND)
 187 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
 188 local host found for non-MX address
 189 MUNGED: ::1 will be omitted in what follows
 190 get[host|ipnode]byname[2] looked up these IP addresses:
 191   name=127.0.0.1 address=127.0.0.1
 192 Attempting full verification using callout
 193  locking TESTSUITE/spool/db/callout.lockfile
 194  locked  TESTSUITE/spool/db/callout.lockfile
 195  EXIM_DBOPEN: file <TESTSUITE/spool/db/callout> dir <TESTSUITE/spool/db> flags=O_RDWR
 196  returned from EXIM_DBOPEN: 0xAAAAAAAA
 197  opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
 198  dbfn_read: key=y
 199 callout cache: found domain record for y
 200  dbfn_read: key=x@y
 201 callout cache: found address record for x@y
 202 callout cache: address record is positive
 203  EXIM_DBCLOSE(0xAAAAAAAA)
 204  closed hints database and lockfile
 205 ----------- end verify ------------
 206 sender x@y verified ok
 207 accept: condition test succeeded in ACL "mail"
 208 end of ACL "mail": ACCEPT
 209 SMTP>> 250 OK
 210 SMTP<< quit
 211 SMTP>> 221 myhost.test.ex closing connection
 212 LOG: smtp_connection MAIN
 213   SMTP connection from [1.2.3.4] closed by QUIT
 214 search_tidyup called
 215 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 216 >>> host in hosts_connection_nolog? no (option unset)
 217 >>> host in host_lookup? no (option unset)
 218 >>> host in host_reject_connection? no (option unset)
 219 >>> host in sender_unqualified_hosts? no (option unset)
 220 >>> host in recipient_unqualified_hosts? no (option unset)
 221 >>> host in helo_verify_hosts? no (option unset)
 222 >>> host in helo_try_verify_hosts? no (option unset)
 223 >>> host in helo_accept_junk_hosts? no (option unset)
 224 >>> using ACL "mail"
 225 >>> processing "accept" (TESTSUITE/test-config 20)
 226 >>> check verify = sender/callout=1s,maxwait=1s
 227 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 228 >>> routing x@y
 229 >>> calling r1 router
 230 >>> routed by r1 router
 231 >>> local host found for non-MX address
 232 MUNGED: ::1 will be omitted in what follows
 233 >>> get[host|ipnode]byname[2] looked up these IP addresses:
 234 >>>   name=127.0.0.1 address=127.0.0.1
 235 >>> Attempting full verification using callout
 236 >>> callout cache: found domain record for y
 237 >>> callout cache: found address record for x@y
 238 >>> callout cache: address record is positive
 239 >>> ----------- end verify ------------
 240 >>> accept: condition test succeeded in ACL "mail"
 241 >>> end of ACL "mail": ACCEPT
 242 >>> host in hosts_connection_nolog? no (option unset)
 243 >>> host in host_lookup? no (option unset)
 244 >>> host in host_reject_connection? no (option unset)
 245 >>> host in sender_unqualified_hosts? no (option unset)
 246 >>> host in recipient_unqualified_hosts? no (option unset)
 247 >>> host in helo_verify_hosts? no (option unset)
 248 >>> host in helo_try_verify_hosts? no (option unset)
 249 >>> host in helo_accept_junk_hosts? no (option unset)
 250 >>> using ACL "mail"
 251 >>> processing "accept" (TESTSUITE/test-config 20)
 252 >>> check verify = sender/callout=1s,maxwait=1s
 253 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 254 >>> routing a@b
 255 >>> calling r1 router
 256 >>> routed by r1 router
 257 >>> local host found for non-MX address
 258 MUNGED: ::1 will be omitted in what follows
 259 >>> get[host|ipnode]byname[2] looked up these IP addresses:
 260 >>>   name=127.0.0.1 address=127.0.0.1
 261 >>> Attempting full verification using callout
 262 >>> callout cache: no domain record found for b
 263 >>> callout cache: no address record found for a@b
 264 >>> interface=NULL port=1224
 265 >>> Connecting to 127.0.0.1 [127.0.0.1]:1224 ...  connected
 266 >>>   SMTP<< 220 server ready
 267 >>> 127.0.0.1 in hosts_avoid_esmtp? no (option unset)
 268 >>>   SMTP>> EHLO myhost.test.ex
 269 >>> cmd buf flush 21 bytes
 270 >>>   SMTP<< 250 OK
 271 >>> 127.0.0.1 in hosts_require_auth? no (option unset)
 272 >>>   SMTP>> MAIL FROM:<>
 273 >>> cmd buf flush 14 bytes
 274 >>>   SMTP<< 250 OK
 275 >>>   SMTP>> RCPT TO:<a@b>
 276 >>> cmd buf flush 15 bytes
 277 >>>   SMTP<< 250 OK
 278 >>>   SMTP>> QUIT
 279 >>> cmd buf flush 6 bytes
 280 >>>   SMTP<< 220 OK
 281 >>>   SMTP(close)>>
 282 >>> wrote callout cache domain record for b:
 283 >>>   result=1 postmaster=0 random=0
 284 >>> wrote positive callout cache address record for a@b
 285 >>> ----------- end verify ------------
 286 >>> accept: condition test succeeded in ACL "mail"
 287 >>> end of ACL "mail": ACCEPT
 288 >>> host in hosts_connection_nolog? no (option unset)
 289 >>> host in host_lookup? no (option unset)
 290 >>> host in host_reject_connection? no (option unset)
 291 >>> host in sender_unqualified_hosts? no (option unset)
 292 >>> host in recipient_unqualified_hosts? no (option unset)
 293 >>> host in helo_verify_hosts? no (option unset)
 294 >>> host in helo_try_verify_hosts? no (option unset)
 295 >>> host in helo_accept_junk_hosts? no (option unset)
 296 >>> using ACL "mail"
 297 >>> processing "accept" (TESTSUITE/test-config 20)
 298 >>> check verify = sender/callout=1s,maxwait=1s
 299 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 300 >>> routing p1@q
 301 >>> calling r1 router
 302 >>> routed by r1 router
 303 >>> local host found for non-MX address
 304 MUNGED: ::1 will be omitted in what follows
 305 >>> get[host|ipnode]byname[2] looked up these IP addresses:
 306 >>>   name=127.0.0.1 address=127.0.0.1
 307 >>> Attempting full verification using callout
 308 >>> callout cache: no domain record found for q
 309 >>> callout cache: no address record found for p1@q
 310 >>> interface=NULL port=1224
 311 >>> Connecting to 127.0.0.1 [127.0.0.1]:1224 ...  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(close)>>
 317 >>> SMTP timeout
 318 >>> ----------- end verify ------------
 319 >>> accept: condition test deferred in ACL "mail"
 320 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
 321 LOG: H=[1.2.3.4] temporarily rejected MAIL <p1@q>: Could not complete sender verify callout