test/stderr/0183

   1 Exim version x.yz ....
   2 changed uid/gid: forcing real = effective
   3   uid=uuuu gid=CALLER_GID pid=p1234
   4 configuration file is TESTSUITE/test-config
   5 admin user
   6 dropping to exim gid; retaining priv uid
   7 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
   8 sender address = CALLER@myhost.test.ex
   9 Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID
  10 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  11 Testing userx@test.again.dns
  12 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  13 Considering userx@test.again.dns
  14 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  15 routing userx@test.again.dns
  16 --------> srv router <--------
  17 local_part=userx domain=test.again.dns
  18 checking local_parts
  19 userx in "^srv"? no (end of list)
  20 srv router skipped: local_parts mismatch
  21 --------> useryz router <--------
  22 local_part=userx domain=test.again.dns
  23 checking local_parts
  24 userx in "usery:userz"? no (end of list)
  25 useryz router skipped: local_parts mismatch
  26 --------> lookuphost router <--------
  27 local_part=userx domain=test.again.dns
  28 checking local_parts
  29 userx in "!userd"? yes (end of list)
  30 calling lookuphost router
  31 lookuphost router called for userx@test.again.dns
  32   domain = test.again.dns
  33 test.again.dns in "*"? yes (matched "*")
  34 DNS lookup of test.again.dns (MX) using fakens
  35 DNS lookup of test.again.dns (MX) gave TRY_AGAIN
  36 test.again.dns in dns_again_means_nonexist? no (option unset)
  37 returning DNS_AGAIN
  38  writing neg-cache entry for test.again.dns-MX-xxxx, ttl -1
  39 lookuphost router: defer for userx@test.again.dns
  40   message: host lookup did not complete
  41 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  42 Testing abcd@test.again.dns
  43 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  44 Considering abcd@test.again.dns
  45 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  46 routing abcd@test.again.dns
  47 --------> srv router <--------
  48 local_part=abcd domain=test.again.dns
  49 checking local_parts
  50 abcd in "^srv"? no (end of list)
  51 srv router skipped: local_parts mismatch
  52 --------> useryz router <--------
  53 local_part=abcd domain=test.again.dns
  54 checking local_parts
  55 abcd in "usery:userz"? no (end of list)
  56 useryz router skipped: local_parts mismatch
  57 --------> lookuphost router <--------
  58 local_part=abcd domain=test.again.dns
  59 checking local_parts
  60 abcd in "!userd"? yes (end of list)
  61 calling lookuphost router
  62 lookuphost router called for abcd@test.again.dns
  63   domain = test.again.dns
  64 test.again.dns in "*"? yes (matched "*")
  65 DNS lookup of test.again.dns (MX): using cached value DNS_AGAIN
  66 lookuphost router: defer for abcd@test.again.dns
  67   message: host lookup did not complete
  68 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  69 Testing abcd@ten-1.test.ex
  70 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  71 Considering abcd@ten-1.test.ex
  72 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  73 routing abcd@ten-1.test.ex
  74 --------> srv router <--------
  75 local_part=abcd domain=ten-1.test.ex
  76 checking local_parts
  77 abcd in "^srv"? no (end of list)
  78 srv router skipped: local_parts mismatch
  79 --------> useryz router <--------
  80 local_part=abcd domain=ten-1.test.ex
  81 checking local_parts
  82 abcd in "usery:userz"? no (end of list)
  83 useryz router skipped: local_parts mismatch
  84 --------> lookuphost router <--------
  85 local_part=abcd domain=ten-1.test.ex
  86 checking local_parts
  87 abcd in "!userd"? yes (end of list)
  88 calling lookuphost router
  89 lookuphost router called for abcd@ten-1.test.ex
  90   domain = ten-1.test.ex
  91 ten-1.test.ex in "*"? yes (matched "*")
  92 DNS lookup of ten-1.test.ex (MX) using fakens
  93 DNS lookup of ten-1.test.ex (MX) gave NO_DATA
  94 returning DNS_NODATA
  95 faking res_search(MX) response length as 65535
  96  writing neg-cache entry for ten-1.test.ex-MX-xxxx, ttl 3000
  97 ten-1.test.ex (MX resp) DNSSEC
  98 DNS lookup of ten-1.test.ex (A) using fakens
  99 DNS lookup of ten-1.test.ex (A) succeeded
 100 fully qualified name = ten-1.test.ex
 101 ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx
 102 set transport smtp
 103 queued for smtp transport: local_part = abcd
 104 domain = ten-1.test.ex
 105   errors_to=NULL
 106   domain_data=NULL local_part_data=NULL
 107 routed by lookuphost router
 108   envelope to: abcd@ten-1.test.ex
 109   transport: smtp
 110   host ten-1.test.ex [V4NET.0.0.1]
 111 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 112 Testing usery@test.again.dns
 113 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 114 Considering usery@test.again.dns
 115 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 116 routing usery@test.again.dns
 117 --------> srv router <--------
 118 local_part=usery domain=test.again.dns
 119 checking local_parts
 120 usery in "^srv"? no (end of list)
 121 srv router skipped: local_parts mismatch
 122 --------> useryz router <--------
 123 local_part=usery domain=test.again.dns
 124 checking local_parts
 125 usery in "usery:userz"? yes (matched "usery")
 126 calling useryz router
 127 useryz router called for usery@test.again.dns
 128   domain = test.again.dns
 129 route_item = * $domain bydns
 130 test.again.dns in "*"? yes (matched "*")
 131 original list of hosts = '$domain' options = 'bydns'
 132 expanded list of hosts = 'test.again.dns' options = 'bydns'
 133 set transport smtp
 134 finding IP address for test.again.dns
 135 doing DNS lookup
 136 test.again.dns in "*"? yes (matched "*")
 137 DNS lookup of test.again.dns (A) using fakens
 138 DNS lookup of test.again.dns (A) gave TRY_AGAIN
 139 test.again.dns in dns_again_means_nonexist? no (option unset)
 140 returning DNS_AGAIN
 141  writing neg-cache entry for test.again.dns-A-xxxx, ttl -1
 142 useryz router: defer for usery@test.again.dns
 143   message: host lookup for test.again.dns did not complete (DNS timeout?)
 144 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 145 Testing userz@test.again.dns
 146 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 147 Considering userz@test.again.dns
 148 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 149 routing userz@test.again.dns
 150 --------> srv router <--------
 151 local_part=userz domain=test.again.dns
 152 checking local_parts
 153 userz in "^srv"? no (end of list)
 154 srv router skipped: local_parts mismatch
 155 --------> useryz router <--------
 156 local_part=userz domain=test.again.dns
 157 checking local_parts
 158 userz in "usery:userz"? yes (matched "userz")
 159 calling useryz router
 160 useryz router called for userz@test.again.dns
 161   domain = test.again.dns
 162 route_item = * $domain bydns
 163 test.again.dns in "*"? yes (matched "*")
 164 original list of hosts = '$domain' options = 'bydns'
 165 expanded list of hosts = 'test.again.dns' options = 'bydns'
 166 finding IP address for test.again.dns
 167 doing DNS lookup
 168 test.again.dns in "*"? yes (matched "*")
 169 DNS lookup of test.again.dns (A): using cached value DNS_AGAIN
 170 useryz router: defer for userz@test.again.dns
 171   message: host lookup for test.again.dns did not complete (DNS timeout?)
 172 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 173 Testing xyz@ten-1.test.ex
 174 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 175 Considering xyz@ten-1.test.ex
 176 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 177 routing xyz@ten-1.test.ex
 178 --------> srv router <--------
 179 local_part=xyz domain=ten-1.test.ex
 180 checking local_parts
 181 xyz in "^srv"? no (end of list)
 182 srv router skipped: local_parts mismatch
 183 --------> useryz router <--------
 184 local_part=xyz domain=ten-1.test.ex
 185 checking local_parts
 186 xyz in "usery:userz"? no (end of list)
 187 useryz router skipped: local_parts mismatch
 188 --------> lookuphost router <--------
 189 local_part=xyz domain=ten-1.test.ex
 190 checking local_parts
 191 xyz in "!userd"? yes (end of list)
 192 calling lookuphost router
 193 lookuphost router called for xyz@ten-1.test.ex
 194   domain = ten-1.test.ex
 195 ten-1.test.ex in "*"? yes (matched "*")
 196 DNS lookup of ten-1.test.ex (MX): using cached value DNS_NODATA
 197 DNS lookup of ten-1.test.ex (A) using fakens
 198 DNS lookup of ten-1.test.ex (A) succeeded
 199 fully qualified name = ten-1.test.ex
 200 ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx
 201 queued for smtp transport: local_part = xyz
 202 domain = ten-1.test.ex
 203   errors_to=NULL
 204   domain_data=NULL local_part_data=NULL
 205 routed by lookuphost router
 206   envelope to: xyz@ten-1.test.ex
 207   transport: smtp
 208   host ten-1.test.ex [V4NET.0.0.1]
 209 search_tidyup called
 210 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=1 >>>>>>>>>>>>>>>>
 211 Exim version x.yz ....
 212 changed uid/gid: forcing real = effective
 213   uid=uuuu gid=CALLER_GID pid=p1235
 214 configuration file is TESTSUITE/test-config
 215 admin user
 216 dropping to exim gid; retaining priv uid
 217 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 218 sender address = CALLER@myhost.test.ex
 219 Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID
 220 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 221 Testing userx@test.fail.dns
 222 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 223 Considering userx@test.fail.dns
 224 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 225 routing userx@test.fail.dns
 226 --------> srv router <--------
 227 local_part=userx domain=test.fail.dns
 228 checking local_parts
 229 userx in "^srv"? no (end of list)
 230 srv router skipped: local_parts mismatch
 231 --------> useryz router <--------
 232 local_part=userx domain=test.fail.dns
 233 checking local_parts
 234 userx in "usery:userz"? no (end of list)
 235 useryz router skipped: local_parts mismatch
 236 --------> lookuphost router <--------
 237 local_part=userx domain=test.fail.dns
 238 checking local_parts
 239 userx in "!userd"? yes (end of list)
 240 calling lookuphost router
 241 lookuphost router called for userx@test.fail.dns
 242   domain = test.fail.dns
 243 test.fail.dns in "*"? yes (matched "*")
 244 DNS lookup of test.fail.dns (MX) using fakens
 245 DNS lookup of test.fail.dns (MX) gave NO_RECOVERY
 246 returning DNS_FAIL
 247  writing neg-cache entry for test.fail.dns-MX-xxxx, ttl -1
 248 lookuphost router: defer for userx@test.fail.dns
 249   message: host lookup did not complete
 250 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 251 Testing abcd@test.fail.dns
 252 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 253 Considering abcd@test.fail.dns
 254 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 255 routing abcd@test.fail.dns
 256 --------> srv router <--------
 257 local_part=abcd domain=test.fail.dns
 258 checking local_parts
 259 abcd in "^srv"? no (end of list)
 260 srv router skipped: local_parts mismatch
 261 --------> useryz router <--------
 262 local_part=abcd domain=test.fail.dns
 263 checking local_parts
 264 abcd in "usery:userz"? no (end of list)
 265 useryz router skipped: local_parts mismatch
 266 --------> lookuphost router <--------
 267 local_part=abcd domain=test.fail.dns
 268 checking local_parts
 269 abcd in "!userd"? yes (end of list)
 270 calling lookuphost router
 271 lookuphost router called for abcd@test.fail.dns
 272   domain = test.fail.dns
 273 test.fail.dns in "*"? yes (matched "*")
 274 DNS lookup of test.fail.dns (MX): using cached value DNS_FAIL
 275 lookuphost router: defer for abcd@test.fail.dns
 276   message: host lookup did not complete
 277 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 278 Testing abcd@ten-1.test.ex
 279 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 280 Considering abcd@ten-1.test.ex
 281 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 282 routing abcd@ten-1.test.ex
 283 --------> srv router <--------
 284 local_part=abcd domain=ten-1.test.ex
 285 checking local_parts
 286 abcd in "^srv"? no (end of list)
 287 srv router skipped: local_parts mismatch
 288 --------> useryz router <--------
 289 local_part=abcd domain=ten-1.test.ex
 290 checking local_parts
 291 abcd in "usery:userz"? no (end of list)
 292 useryz router skipped: local_parts mismatch
 293 --------> lookuphost router <--------
 294 local_part=abcd domain=ten-1.test.ex
 295 checking local_parts
 296 abcd in "!userd"? yes (end of list)
 297 calling lookuphost router
 298 lookuphost router called for abcd@ten-1.test.ex
 299   domain = ten-1.test.ex
 300 ten-1.test.ex in "*"? yes (matched "*")
 301 DNS lookup of ten-1.test.ex (MX) using fakens
 302 DNS lookup of ten-1.test.ex (MX) gave NO_DATA
 303 returning DNS_NODATA
 304 faking res_search(MX) response length as 65535
 305  writing neg-cache entry for ten-1.test.ex-MX-xxxx, ttl 3000
 306 ten-1.test.ex (MX resp) DNSSEC
 307 DNS lookup of ten-1.test.ex (A) using fakens
 308 DNS lookup of ten-1.test.ex (A) succeeded
 309 fully qualified name = ten-1.test.ex
 310 ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx
 311 set transport smtp
 312 queued for smtp transport: local_part = abcd
 313 domain = ten-1.test.ex
 314   errors_to=NULL
 315   domain_data=NULL local_part_data=NULL
 316 routed by lookuphost router
 317   envelope to: abcd@ten-1.test.ex
 318   transport: smtp
 319   host ten-1.test.ex [V4NET.0.0.1]
 320 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 321 Testing usery@test.fail.dns
 322 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 323 Considering usery@test.fail.dns
 324 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 325 routing usery@test.fail.dns
 326 --------> srv router <--------
 327 local_part=usery domain=test.fail.dns
 328 checking local_parts
 329 usery in "^srv"? no (end of list)
 330 srv router skipped: local_parts mismatch
 331 --------> useryz router <--------
 332 local_part=usery domain=test.fail.dns
 333 checking local_parts
 334 usery in "usery:userz"? yes (matched "usery")
 335 calling useryz router
 336 useryz router called for usery@test.fail.dns
 337   domain = test.fail.dns
 338 route_item = * $domain bydns
 339 test.fail.dns in "*"? yes (matched "*")
 340 original list of hosts = '$domain' options = 'bydns'
 341 expanded list of hosts = 'test.fail.dns' options = 'bydns'
 342 set transport smtp
 343 finding IP address for test.fail.dns
 344 doing DNS lookup
 345 test.fail.dns in "*"? yes (matched "*")
 346 DNS lookup of test.fail.dns (A) using fakens
 347 DNS lookup of test.fail.dns (A) gave NO_RECOVERY
 348 returning DNS_FAIL
 349  writing neg-cache entry for test.fail.dns-A-xxxx, ttl -1
 350 useryz router: defer for usery@test.fail.dns
 351   message: host lookup for test.fail.dns did not complete (DNS timeout?)
 352 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 353 Testing userz@test.fail.dns
 354 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 355 Considering userz@test.fail.dns
 356 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 357 routing userz@test.fail.dns
 358 --------> srv router <--------
 359 local_part=userz domain=test.fail.dns
 360 checking local_parts
 361 userz in "^srv"? no (end of list)
 362 srv router skipped: local_parts mismatch
 363 --------> useryz router <--------
 364 local_part=userz domain=test.fail.dns
 365 checking local_parts
 366 userz in "usery:userz"? yes (matched "userz")
 367 calling useryz router
 368 useryz router called for userz@test.fail.dns
 369   domain = test.fail.dns
 370 route_item = * $domain bydns
 371 test.fail.dns in "*"? yes (matched "*")
 372 original list of hosts = '$domain' options = 'bydns'
 373 expanded list of hosts = 'test.fail.dns' options = 'bydns'
 374 finding IP address for test.fail.dns
 375 doing DNS lookup
 376 test.fail.dns in "*"? yes (matched "*")
 377 DNS lookup of test.fail.dns (A): using cached value DNS_FAIL
 378 useryz router: defer for userz@test.fail.dns
 379   message: host lookup for test.fail.dns did not complete (DNS timeout?)
 380 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 381 Testing xyz@ten-1.test.ex
 382 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 383 Considering xyz@ten-1.test.ex
 384 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 385 routing xyz@ten-1.test.ex
 386 --------> srv router <--------
 387 local_part=xyz domain=ten-1.test.ex
 388 checking local_parts
 389 xyz in "^srv"? no (end of list)
 390 srv router skipped: local_parts mismatch
 391 --------> useryz router <--------
 392 local_part=xyz domain=ten-1.test.ex
 393 checking local_parts
 394 xyz in "usery:userz"? no (end of list)
 395 useryz router skipped: local_parts mismatch
 396 --------> lookuphost router <--------
 397 local_part=xyz domain=ten-1.test.ex
 398 checking local_parts
 399 xyz in "!userd"? yes (end of list)
 400 calling lookuphost router
 401 lookuphost router called for xyz@ten-1.test.ex
 402   domain = ten-1.test.ex
 403 ten-1.test.ex in "*"? yes (matched "*")
 404 DNS lookup of ten-1.test.ex (MX): using cached value DNS_NODATA
 405 DNS lookup of ten-1.test.ex (A) using fakens
 406 DNS lookup of ten-1.test.ex (A) succeeded
 407 fully qualified name = ten-1.test.ex
 408 ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx
 409 queued for smtp transport: local_part = xyz
 410 domain = ten-1.test.ex
 411   errors_to=NULL
 412   domain_data=NULL local_part_data=NULL
 413 routed by lookuphost router
 414   envelope to: xyz@ten-1.test.ex
 415   transport: smtp
 416   host ten-1.test.ex [V4NET.0.0.1]
 417 search_tidyup called
 418 >>>>>>>>>>>>>>>> Exim pid=p1235 (fresh-exec) terminating with rc=1 >>>>>>>>>>>>>>>>
 419 Exim version x.yz ....
 420 changed uid/gid: forcing real = effective
 421   uid=uuuu gid=CALLER_GID pid=p1236
 422 configuration file is TESTSUITE/test-config
 423 admin user
 424 dropping to exim gid; retaining priv uid
 425 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 426 sender address = CALLER@myhost.test.ex
 427 Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID
 428 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 429 Testing userx@nonexist.test.ex
 430 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 431 Considering userx@nonexist.test.ex
 432 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 433 routing userx@nonexist.test.ex
 434 --------> srv router <--------
 435 local_part=userx domain=nonexist.test.ex
 436 checking local_parts
 437 userx in "^srv"? no (end of list)
 438 srv router skipped: local_parts mismatch
 439 --------> useryz router <--------
 440 local_part=userx domain=nonexist.test.ex
 441 checking local_parts
 442 userx in "usery:userz"? no (end of list)
 443 useryz router skipped: local_parts mismatch
 444 --------> lookuphost router <--------
 445 local_part=userx domain=nonexist.test.ex
 446 checking local_parts
 447 userx in "!userd"? yes (end of list)
 448 calling lookuphost router
 449 lookuphost router called for userx@nonexist.test.ex
 450   domain = nonexist.test.ex
 451 nonexist.test.ex in "*"? yes (matched "*")
 452 DNS lookup of nonexist.test.ex (MX) using fakens
 453 DNS lookup of nonexist.test.ex (MX) gave HOST_NOT_FOUND
 454 returning DNS_NOMATCH
 455 faking res_search(MX) response length as 65535
 456  writing neg-cache entry for nonexist.test.ex-MX-xxxx, ttl 3000
 457 lookuphost router declined for userx@nonexist.test.ex
 458 "more" is false: skipping remaining routers
 459 no more routers
 460 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 461 Testing abcd@nonexist.test.ex
 462 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 463 Considering abcd@nonexist.test.ex
 464 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 465 routing abcd@nonexist.test.ex
 466 --------> srv router <--------
 467 local_part=abcd domain=nonexist.test.ex
 468 checking local_parts
 469 abcd in "^srv"? no (end of list)
 470 srv router skipped: local_parts mismatch
 471 --------> useryz router <--------
 472 local_part=abcd domain=nonexist.test.ex
 473 checking local_parts
 474 abcd in "usery:userz"? no (end of list)
 475 useryz router skipped: local_parts mismatch
 476 --------> lookuphost router <--------
 477 local_part=abcd domain=nonexist.test.ex
 478 checking local_parts
 479 abcd in "!userd"? yes (end of list)
 480 calling lookuphost router
 481 lookuphost router called for abcd@nonexist.test.ex
 482   domain = nonexist.test.ex
 483 nonexist.test.ex in "*"? yes (matched "*")
 484 DNS lookup of nonexist.test.ex (MX): using cached value DNS_NOMATCH
 485 lookuphost router declined for abcd@nonexist.test.ex
 486 "more" is false: skipping remaining routers
 487 no more routers
 488 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 489 Testing abcd@ten-1.test.ex
 490 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 491 Considering abcd@ten-1.test.ex
 492 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 493 routing abcd@ten-1.test.ex
 494 --------> srv router <--------
 495 local_part=abcd domain=ten-1.test.ex
 496 checking local_parts
 497 abcd in "^srv"? no (end of list)
 498 srv router skipped: local_parts mismatch
 499 --------> useryz router <--------
 500 local_part=abcd domain=ten-1.test.ex
 501 checking local_parts
 502 abcd in "usery:userz"? no (end of list)
 503 useryz router skipped: local_parts mismatch
 504 --------> lookuphost router <--------
 505 local_part=abcd domain=ten-1.test.ex
 506 checking local_parts
 507 abcd in "!userd"? yes (end of list)
 508 calling lookuphost router
 509 lookuphost router called for abcd@ten-1.test.ex
 510   domain = ten-1.test.ex
 511 ten-1.test.ex in "*"? yes (matched "*")
 512 DNS lookup of ten-1.test.ex (MX) using fakens
 513 DNS lookup of ten-1.test.ex (MX) gave NO_DATA
 514 returning DNS_NODATA
 515 faking res_search(MX) response length as 65535
 516  writing neg-cache entry for ten-1.test.ex-MX-xxxx, ttl 3000
 517 ten-1.test.ex (MX resp) DNSSEC
 518 DNS lookup of ten-1.test.ex (A) using fakens
 519 DNS lookup of ten-1.test.ex (A) succeeded
 520 fully qualified name = ten-1.test.ex
 521 ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx
 522 set transport smtp
 523 queued for smtp transport: local_part = abcd
 524 domain = ten-1.test.ex
 525   errors_to=NULL
 526   domain_data=NULL local_part_data=NULL
 527 routed by lookuphost router
 528   envelope to: abcd@ten-1.test.ex
 529   transport: smtp
 530   host ten-1.test.ex [V4NET.0.0.1]
 531 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 532 Testing usery@nonexist.test.ex
 533 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 534 Considering usery@nonexist.test.ex
 535 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 536 routing usery@nonexist.test.ex
 537 --------> srv router <--------
 538 local_part=usery domain=nonexist.test.ex
 539 checking local_parts
 540 usery in "^srv"? no (end of list)
 541 srv router skipped: local_parts mismatch
 542 --------> useryz router <--------
 543 local_part=usery domain=nonexist.test.ex
 544 checking local_parts
 545 usery in "usery:userz"? yes (matched "usery")
 546 calling useryz router
 547 useryz router called for usery@nonexist.test.ex
 548   domain = nonexist.test.ex
 549 route_item = * $domain bydns
 550 nonexist.test.ex in "*"? yes (matched "*")
 551 original list of hosts = '$domain' options = 'bydns'
 552 expanded list of hosts = 'nonexist.test.ex' options = 'bydns'
 553 set transport smtp
 554 finding IP address for nonexist.test.ex
 555 doing DNS lookup
 556 nonexist.test.ex in "*"? yes (matched "*")
 557 DNS lookup of nonexist.test.ex (A) using fakens
 558 DNS lookup of nonexist.test.ex (A) gave HOST_NOT_FOUND
 559 returning DNS_NOMATCH
 560 faking res_search(A) response length as 65535
 561  writing neg-cache entry for nonexist.test.ex-A-xxxx, ttl 3000
 562 useryz router: defer for usery@nonexist.test.ex
 563   message: lookup of host "nonexist.test.ex" failed in useryz router
 564 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 565 Testing userz@nonexist.test.ex
 566 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 567 Considering userz@nonexist.test.ex
 568 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 569 routing userz@nonexist.test.ex
 570 --------> srv router <--------
 571 local_part=userz domain=nonexist.test.ex
 572 checking local_parts
 573 userz in "^srv"? no (end of list)
 574 srv router skipped: local_parts mismatch
 575 --------> useryz router <--------
 576 local_part=userz domain=nonexist.test.ex
 577 checking local_parts
 578 userz in "usery:userz"? yes (matched "userz")
 579 calling useryz router
 580 useryz router called for userz@nonexist.test.ex
 581   domain = nonexist.test.ex
 582 route_item = * $domain bydns
 583 nonexist.test.ex in "*"? yes (matched "*")
 584 original list of hosts = '$domain' options = 'bydns'
 585 expanded list of hosts = 'nonexist.test.ex' options = 'bydns'
 586 finding IP address for nonexist.test.ex
 587 doing DNS lookup
 588 nonexist.test.ex in "*"? yes (matched "*")
 589 DNS lookup of nonexist.test.ex (A): using cached value DNS_NOMATCH
 590 useryz router: defer for userz@nonexist.test.ex
 591   message: lookup of host "nonexist.test.ex" failed in useryz router
 592 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 593 Testing xyz@ten-1.test.ex
 594 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 595 Considering xyz@ten-1.test.ex
 596 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 597 routing xyz@ten-1.test.ex
 598 --------> srv router <--------
 599 local_part=xyz domain=ten-1.test.ex
 600 checking local_parts
 601 xyz in "^srv"? no (end of list)
 602 srv router skipped: local_parts mismatch
 603 --------> useryz router <--------
 604 local_part=xyz domain=ten-1.test.ex
 605 checking local_parts
 606 xyz in "usery:userz"? no (end of list)
 607 useryz router skipped: local_parts mismatch
 608 --------> lookuphost router <--------
 609 local_part=xyz domain=ten-1.test.ex
 610 checking local_parts
 611 xyz in "!userd"? yes (end of list)
 612 calling lookuphost router
 613 lookuphost router called for xyz@ten-1.test.ex
 614   domain = ten-1.test.ex
 615 ten-1.test.ex in "*"? yes (matched "*")
 616 DNS lookup of ten-1.test.ex (MX): using cached value DNS_NODATA
 617 DNS lookup of ten-1.test.ex (A) using fakens
 618 DNS lookup of ten-1.test.ex (A) succeeded
 619 fully qualified name = ten-1.test.ex
 620 ten-1.test.ex V4NET.0.0.1 mx=-1 sort=xx
 621 queued for smtp transport: local_part = xyz
 622 domain = ten-1.test.ex
 623   errors_to=NULL
 624   domain_data=NULL local_part_data=NULL
 625 routed by lookuphost router
 626   envelope to: xyz@ten-1.test.ex
 627   transport: smtp
 628   host ten-1.test.ex [V4NET.0.0.1]
 629 search_tidyup called
 630 >>>>>>>>>>>>>>>> Exim pid=p1236 (fresh-exec) terminating with rc=2 >>>>>>>>>>>>>>>>
 631 Exim version x.yz ....
 632 changed uid/gid: forcing real = effective
 633   uid=uuuu gid=CALLER_GID pid=p1237
 634 configuration file is TESTSUITE/test-config
 635 admin user
 636 dropping to exim gid; retaining priv uid
 637 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 638 sender address = CALLER@myhost.test.ex
 639 Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID
 640 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 641 Testing srv@test.again.dns
 642 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 643 Considering srv@test.again.dns
 644 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 645 routing srv@test.again.dns
 646 --------> srv router <--------
 647 local_part=srv domain=test.again.dns
 648 checking local_parts
 649 srv in "^srv"? yes (matched "^srv")
 650 calling srv router
 651 srv router called for srv@test.again.dns
 652   domain = test.again.dns
 653 test.again.dns in "*"? yes (matched "*")
 654 DNS lookup of _smtp._tcp.test.again.dns (SRV) using fakens
 655 DNS lookup of _smtp._tcp.test.again.dns (SRV) gave TRY_AGAIN
 656 _smtp._tcp.test.again.dns in dns_again_means_nonexist? no (option unset)
 657 returning DNS_AGAIN
 658  writing neg-cache entry for _smtp._tcp.test.again.dns-SRV-xxxx, ttl -1
 659 test.again.dns in "test.fail.dns"? no (end of list)
 660 srv router: defer for srv@test.again.dns
 661   message: host lookup did not complete
 662 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 663 Testing srv@test.fail.dns
 664 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 665 Considering srv@test.fail.dns
 666 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 667 routing srv@test.fail.dns
 668 --------> srv router <--------
 669 local_part=srv domain=test.fail.dns
 670 checking local_parts
 671 srv in "^srv"? yes (matched "^srv")
 672 calling srv router
 673 srv router called for srv@test.fail.dns
 674   domain = test.fail.dns
 675 test.fail.dns in "*"? yes (matched "*")
 676 DNS lookup of _smtp._tcp.test.fail.dns (SRV) using fakens
 677 DNS lookup of _smtp._tcp.test.fail.dns (SRV) gave NO_RECOVERY
 678 returning DNS_FAIL
 679  writing neg-cache entry for _smtp._tcp.test.fail.dns-SRV-xxxx, ttl -1
 680 test.fail.dns in "test.fail.dns"? yes (matched "test.fail.dns")
 681 DNS_FAIL treated as DNS_NODATA (domain in srv_fail_domains)
 682 DNS lookup of test.fail.dns (MX) using fakens
 683 DNS lookup of test.fail.dns (MX) gave NO_RECOVERY
 684 returning DNS_FAIL
 685  writing neg-cache entry for test.fail.dns-MX-xxxx, ttl -1
 686 test.fail.dns in "test.fail.dns"? yes (matched "test.fail.dns")
 687 DNS_FAIL treated as DNS_NODATA (domain in mx_fail_domains)
 688 DNS lookup of test.fail.dns (A) using fakens
 689 DNS lookup of test.fail.dns (A) gave NO_RECOVERY
 690 returning DNS_FAIL
 691  writing neg-cache entry for test.fail.dns-A-xxxx, ttl -1
 692 srv router: defer for srv@test.fail.dns
 693   message: host lookup did not complete
 694 search_tidyup called
 695 >>>>>>>>>>>>>>>> Exim pid=p1237 (fresh-exec) terminating with rc=1 >>>>>>>>>>>>>>>>
 696 Exim version x.yz ....
 697 changed uid/gid: forcing real = effective
 698   uid=uuuu gid=CALLER_GID pid=p1238
 699 configuration file is TESTSUITE/test-config
 700 admin user
 701 dropping to exim gid; retaining priv uid
 702 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 703 sender address = CALLER@myhost.test.ex
 704 Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID
 705 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 706 Testing userx@nonexist.example.com
 707 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 708 Considering userx@nonexist.example.com
 709 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 710 routing userx@nonexist.example.com
 711 --------> srv router <--------
 712 local_part=userx domain=nonexist.example.com
 713 checking local_parts
 714 userx in "^srv"? no (end of list)
 715 srv router skipped: local_parts mismatch
 716 --------> useryz router <--------
 717 local_part=userx domain=nonexist.example.com
 718 checking local_parts
 719 userx in "usery:userz"? no (end of list)
 720 useryz router skipped: local_parts mismatch
 721 --------> lookuphost router <--------
 722 local_part=userx domain=nonexist.example.com
 723 checking local_parts
 724 userx in "!userd"? yes (end of list)
 725 calling lookuphost router
 726 lookuphost router called for userx@nonexist.example.com
 727   domain = nonexist.example.com
 728 nonexist.example.com in "*"? yes (matched "*")
 729 DNS lookup of nonexist.example.com (MX) using fakens
 730 DNS lookup of nonexist.example.com (MX) gave HOST_NOT_FOUND
 731 returning DNS_NOMATCH
 732 faking res_search(MX) response length as 65535
 733  writing neg-cache entry for nonexist.example.com-MX-xxxx, ttl 2
 734 lookuphost router declined for userx@nonexist.example.com
 735 "more" is false: skipping remaining routers
 736 no more routers
 737 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 738 Testing userd@nonexist.example.com
 739 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 740 Considering userd@nonexist.example.com
 741 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 742 routing userd@nonexist.example.com
 743 --------> srv router <--------
 744 local_part=userd domain=nonexist.example.com
 745 checking local_parts
 746 userd in "^srv"? no (end of list)
 747 srv router skipped: local_parts mismatch
 748 --------> useryz router <--------
 749 local_part=userd domain=nonexist.example.com
 750 checking local_parts
 751 userd in "usery:userz"? no (end of list)
 752 useryz router skipped: local_parts mismatch
 753 --------> lookuphost router <--------
 754 local_part=userd domain=nonexist.example.com
 755 checking local_parts
 756 userd in "!userd"? no (matched "!userd")
 757 lookuphost router skipped: local_parts mismatch
 758 --------> delay router <--------
 759 local_part=userd domain=nonexist.example.com
 760 checking "condition" "${acl {delay}}"...
 761   using ACL "delay"
 762   processing "accept" (TESTSUITE/test-config 18)
 763   check delay = 3s
 764   delay modifier requests 3-second delay
 765     message: y
 766   accept: condition test succeeded in ACL "delay"
 767   end of ACL "delay": ACCEPT
 768 calling delay router
 769 delay router called for userd@nonexist.example.com
 770   domain = nonexist.example.com
 771 nonexist.example.com in "*"? yes (matched "*")
 772 DNS lookup of nonexist.example.com (MX): cached value DNS_NOMATCH past valid time
 773 DNS lookup of nonexist.example.com (MX) using fakens
 774 DNS lookup of nonexist.example.com (MX) gave HOST_NOT_FOUND
 775 returning DNS_NOMATCH
 776 faking res_search(MX) response length as 65535
 777  update neg-cache entry for nonexist.example.com-MX-xxxx, ttl 2
 778 delay router declined for userd@nonexist.example.com
 779 "more" is false: skipping remaining routers
 780 no more routers
 781 search_tidyup called
 782 >>>>>>>>>>>>>>>> Exim pid=p1238 (fresh-exec) terminating with rc=2 >>>>>>>>>>>>>>>>