test/stderr/0375

   1 Exim version x.yz ....
   2 configuration file is TESTSUITE/test-config
   3 admin user
   4 LOG: MAIN
   5   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
   6 created log directory TESTSUITE/spool/log
   7 Exim version x.yz ....
   8 configuration file is TESTSUITE/test-config
   9 trusted user
  10 admin user
  11 dropping to exim gid; retaining priv uid
  12 locking TESTSUITE/spool/db/retry.lockfile
  13 no retry data available
  14 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  15 Considering: a1@myhost.test.ex
  16 unique = a1@myhost.test.ex
  17 a1@myhost.test.ex: queued for routing
  18 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  19 Considering: b1@myhost.test.ex
  20 unique = b1@myhost.test.ex
  21 b1@myhost.test.ex: queued for routing
  22 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  23 Considering: c1@myhost.test.ex
  24 unique = c1@myhost.test.ex
  25 c1@myhost.test.ex: queued for routing
  26 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  27 Considering: d1@myhost.test.ex
  28 unique = d1@myhost.test.ex
  29 d1@myhost.test.ex: queued for routing
  30 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  31 Considering: d2@myhost.test.ex
  32 unique = d2@myhost.test.ex
  33 d2@myhost.test.ex: queued for routing
  34 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  35 Considering: d3@myhost.test.ex
  36 unique = d3@myhost.test.ex
  37 d3@myhost.test.ex: queued for routing
  38 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  39 Considering: e1@myhost.test.ex
  40 unique = e1@myhost.test.ex
  41 e1@myhost.test.ex: queued for routing
  42 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  43 Considering: f1@myhost.test.ex
  44 unique = f1@myhost.test.ex
  45 f1@myhost.test.ex: queued for routing
  46 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  47 Considering: f2@myhost.test.ex
  48 unique = f2@myhost.test.ex
  49 f2@myhost.test.ex: queued for routing
  50 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  51 Considering: f3@myhost.test.ex
  52 unique = f3@myhost.test.ex
  53 f3@myhost.test.ex: queued for routing
  54 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  55 Considering: g1@myhost.test.ex
  56 unique = g1@myhost.test.ex
  57 g1@myhost.test.ex: queued for routing
  58 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  59 routing g1@myhost.test.ex
  60 --------> u1 router <--------
  61 local_part=g1 domain=myhost.test.ex
  62 checking local_parts
  63 u1 router skipped: local_parts mismatch
  64 --------> ut2 router <--------
  65 local_part=g1 domain=myhost.test.ex
  66 checking local_parts
  67 ut2 router skipped: local_parts mismatch
  68 --------> ut3 router <--------
  69 local_part=g1 domain=myhost.test.ex
  70 checking local_parts
  71 ut3 router skipped: local_parts mismatch
  72 --------> ut4 router <--------
  73 local_part=g1 domain=myhost.test.ex
  74 checking local_parts
  75 ut4 router skipped: local_parts mismatch
  76 --------> ut5 router <--------
  77 local_part=g1 domain=myhost.test.ex
  78 checking local_parts
  79 ut5 router skipped: local_parts mismatch
  80 --------> ut6 router <--------
  81 local_part=g1 domain=myhost.test.ex
  82 checking local_parts
  83 ut6 router skipped: local_parts mismatch
  84 --------> ut7 router <--------
  85 local_part=g1 domain=myhost.test.ex
  86 checking local_parts
  87 processing address_data
  88 LOG: MAIN
  89   == g1@myhost.test.ex R=ut7 defer (-1): expansion of "$bad expansion" failed in ut7 router: unknown variable name "bad"
  90 log writing disabled
  91 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  92 routing f3@myhost.test.ex
  93 --------> u1 router <--------
  94 local_part=f3 domain=myhost.test.ex
  95 checking local_parts
  96 u1 router skipped: local_parts mismatch
  97 --------> ut2 router <--------
  98 local_part=f3 domain=myhost.test.ex
  99 checking local_parts
 100 ut2 router skipped: local_parts mismatch
 101 --------> ut3 router <--------
 102 local_part=f3 domain=myhost.test.ex
 103 checking local_parts
 104 ut3 router skipped: local_parts mismatch
 105 --------> ut4 router <--------
 106 local_part=f3 domain=myhost.test.ex
 107 checking local_parts
 108 ut4 router skipped: local_parts mismatch
 109 --------> ut5 router <--------
 110 local_part=f3 domain=myhost.test.ex
 111 checking local_parts
 112 ut5 router skipped: local_parts mismatch
 113 --------> ut6 router <--------
 114 local_part=f3 domain=myhost.test.ex
 115 checking local_parts
 116 processing address_data
 117 calling ut6 router
 118 ut6 router called for f3@myhost.test.ex
 119   domain = myhost.test.ex
 120 set transport ut6
 121 queued for ut6 transport: local_part = f3
 122 domain = myhost.test.ex
 123   errors_to=
 124   domain_data=NULL local_part_data=^f\d
 125 routed by ut6 router (unseen)
 126   envelope to: f3@myhost.test.ex
 127   transport: ut6
 128   errors to
 129 "unseen" set: replicated f3@myhost.test.ex
 130 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 131 routing f2@myhost.test.ex
 132 --------> u1 router <--------
 133 local_part=f2 domain=myhost.test.ex
 134 checking local_parts
 135 u1 router skipped: local_parts mismatch
 136 --------> ut2 router <--------
 137 local_part=f2 domain=myhost.test.ex
 138 checking local_parts
 139 ut2 router skipped: local_parts mismatch
 140 --------> ut3 router <--------
 141 local_part=f2 domain=myhost.test.ex
 142 checking local_parts
 143 ut3 router skipped: local_parts mismatch
 144 --------> ut4 router <--------
 145 local_part=f2 domain=myhost.test.ex
 146 checking local_parts
 147 ut4 router skipped: local_parts mismatch
 148 --------> ut5 router <--------
 149 local_part=f2 domain=myhost.test.ex
 150 checking local_parts
 151 ut5 router skipped: local_parts mismatch
 152 --------> ut6 router <--------
 153 local_part=f2 domain=myhost.test.ex
 154 checking local_parts
 155 processing address_data
 156 calling ut6 router
 157 ut6 router called for f2@myhost.test.ex
 158   domain = myhost.test.ex
 159 queued for ut6 transport: local_part = f2
 160 domain = myhost.test.ex
 161   errors_to=
 162   domain_data=NULL local_part_data=^f\d
 163 routed by ut6 router (unseen)
 164   envelope to: f2@myhost.test.ex
 165   transport: ut6
 166   errors to
 167 "unseen" set: replicated f2@myhost.test.ex
 168 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 169 routing f1@myhost.test.ex
 170 --------> u1 router <--------
 171 local_part=f1 domain=myhost.test.ex
 172 checking local_parts
 173 u1 router skipped: local_parts mismatch
 174 --------> ut2 router <--------
 175 local_part=f1 domain=myhost.test.ex
 176 checking local_parts
 177 ut2 router skipped: local_parts mismatch
 178 --------> ut3 router <--------
 179 local_part=f1 domain=myhost.test.ex
 180 checking local_parts
 181 ut3 router skipped: local_parts mismatch
 182 --------> ut4 router <--------
 183 local_part=f1 domain=myhost.test.ex
 184 checking local_parts
 185 ut4 router skipped: local_parts mismatch
 186 --------> ut5 router <--------
 187 local_part=f1 domain=myhost.test.ex
 188 checking local_parts
 189 ut5 router skipped: local_parts mismatch
 190 --------> ut6 router <--------
 191 local_part=f1 domain=myhost.test.ex
 192 checking local_parts
 193 processing address_data
 194 calling ut6 router
 195 ut6 router called for f1@myhost.test.ex
 196   domain = myhost.test.ex
 197 queued for ut6 transport: local_part = f1
 198 domain = myhost.test.ex
 199   errors_to=
 200   domain_data=NULL local_part_data=^f\d
 201 routed by ut6 router (unseen)
 202   envelope to: f1@myhost.test.ex
 203   transport: ut6
 204   errors to
 205 "unseen" set: replicated f1@myhost.test.ex
 206 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 207 routing e1@myhost.test.ex
 208 --------> u1 router <--------
 209 local_part=e1 domain=myhost.test.ex
 210 checking local_parts
 211 u1 router skipped: local_parts mismatch
 212 --------> ut2 router <--------
 213 local_part=e1 domain=myhost.test.ex
 214 checking local_parts
 215 ut2 router skipped: local_parts mismatch
 216 --------> ut3 router <--------
 217 local_part=e1 domain=myhost.test.ex
 218 checking local_parts
 219 ut3 router skipped: local_parts mismatch
 220 --------> ut4 router <--------
 221 local_part=e1 domain=myhost.test.ex
 222 checking local_parts
 223 ut4 router skipped: local_parts mismatch
 224 --------> ut5 router <--------
 225 local_part=e1 domain=myhost.test.ex
 226 checking local_parts
 227 calling ut5 router
 228 ut5 router called for e1@myhost.test.ex
 229   domain = myhost.test.ex
 230 set transport ut5
 231 queued for ut5 transport: local_part = e1
 232 domain = myhost.test.ex
 233   errors_to=NULL
 234   domain_data=NULL local_part_data=^e\d
 235 routed by ut5 router (unseen)
 236   envelope to: e1@myhost.test.ex
 237   transport: ut5
 238 "unseen" set: replicated e1@myhost.test.ex
 239 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 240 routing d3@myhost.test.ex
 241 --------> u1 router <--------
 242 local_part=d3 domain=myhost.test.ex
 243 checking local_parts
 244 u1 router skipped: local_parts mismatch
 245 --------> ut2 router <--------
 246 local_part=d3 domain=myhost.test.ex
 247 checking local_parts
 248 ut2 router skipped: local_parts mismatch
 249 --------> ut3 router <--------
 250 local_part=d3 domain=myhost.test.ex
 251 checking local_parts
 252 ut3 router skipped: local_parts mismatch
 253 --------> ut4 router <--------
 254 local_part=d3 domain=myhost.test.ex
 255 checking local_parts
 256 calling ut4 router
 257 ut4 router called for d3@myhost.test.ex
 258   domain = myhost.test.ex
 259 set transport ut4
 260 queued for ut4 transport: local_part = d3
 261 domain = myhost.test.ex
 262   errors_to=
 263   domain_data=NULL local_part_data=^d\d
 264 routed by ut4 router (unseen)
 265   envelope to: d3@myhost.test.ex
 266   transport: ut4
 267   errors to
 268 "unseen" set: replicated d3@myhost.test.ex
 269 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 270 routing d2@myhost.test.ex
 271 --------> u1 router <--------
 272 local_part=d2 domain=myhost.test.ex
 273 checking local_parts
 274 u1 router skipped: local_parts mismatch
 275 --------> ut2 router <--------
 276 local_part=d2 domain=myhost.test.ex
 277 checking local_parts
 278 ut2 router skipped: local_parts mismatch
 279 --------> ut3 router <--------
 280 local_part=d2 domain=myhost.test.ex
 281 checking local_parts
 282 ut3 router skipped: local_parts mismatch
 283 --------> ut4 router <--------
 284 local_part=d2 domain=myhost.test.ex
 285 checking local_parts
 286 calling ut4 router
 287 ut4 router called for d2@myhost.test.ex
 288   domain = myhost.test.ex
 289 queued for ut4 transport: local_part = d2
 290 domain = myhost.test.ex
 291   errors_to=
 292   domain_data=NULL local_part_data=^d\d
 293 routed by ut4 router (unseen)
 294   envelope to: d2@myhost.test.ex
 295   transport: ut4
 296   errors to
 297 "unseen" set: replicated d2@myhost.test.ex
 298 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 299 routing d1@myhost.test.ex
 300 --------> u1 router <--------
 301 local_part=d1 domain=myhost.test.ex
 302 checking local_parts
 303 u1 router skipped: local_parts mismatch
 304 --------> ut2 router <--------
 305 local_part=d1 domain=myhost.test.ex
 306 checking local_parts
 307 ut2 router skipped: local_parts mismatch
 308 --------> ut3 router <--------
 309 local_part=d1 domain=myhost.test.ex
 310 checking local_parts
 311 ut3 router skipped: local_parts mismatch
 312 --------> ut4 router <--------
 313 local_part=d1 domain=myhost.test.ex
 314 checking local_parts
 315 calling ut4 router
 316 ut4 router called for d1@myhost.test.ex
 317   domain = myhost.test.ex
 318 queued for ut4 transport: local_part = d1
 319 domain = myhost.test.ex
 320   errors_to=
 321   domain_data=NULL local_part_data=^d\d
 322 routed by ut4 router (unseen)
 323   envelope to: d1@myhost.test.ex
 324   transport: ut4
 325   errors to
 326 "unseen" set: replicated d1@myhost.test.ex
 327 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 328 routing c1@myhost.test.ex
 329 --------> u1 router <--------
 330 local_part=c1 domain=myhost.test.ex
 331 checking local_parts
 332 u1 router skipped: local_parts mismatch
 333 --------> ut2 router <--------
 334 local_part=c1 domain=myhost.test.ex
 335 checking local_parts
 336 ut2 router skipped: local_parts mismatch
 337 --------> ut3 router <--------
 338 local_part=c1 domain=myhost.test.ex
 339 checking local_parts
 340 calling ut3 router
 341 ut3 router called for c1@myhost.test.ex
 342   domain = myhost.test.ex
 343 set transport ut3
 344 queued for ut3 transport: local_part = c1
 345 domain = myhost.test.ex
 346   errors_to=
 347   domain_data=NULL local_part_data=^c\d
 348 routed by ut3 router (unseen)
 349   envelope to: c1@myhost.test.ex
 350   transport: ut3
 351   errors to
 352 "unseen" set: replicated c1@myhost.test.ex
 353 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 354 routing b1@myhost.test.ex
 355 --------> u1 router <--------
 356 local_part=b1 domain=myhost.test.ex
 357 checking local_parts
 358 u1 router skipped: local_parts mismatch
 359 --------> ut2 router <--------
 360 local_part=b1 domain=myhost.test.ex
 361 checking local_parts
 362 calling ut2 router
 363 ut2 router called for b1@myhost.test.ex
 364   domain = myhost.test.ex
 365 set transport ut2
 366 queued for ut2 transport: local_part = b1
 367 domain = myhost.test.ex
 368   errors_to=
 369   domain_data=NULL local_part_data=^b\d
 370 routed by ut2 router (unseen)
 371   envelope to: b1@myhost.test.ex
 372   transport: ut2
 373   errors to
 374 "unseen" set: replicated b1@myhost.test.ex
 375 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 376 routing a1@myhost.test.ex
 377 --------> u1 router <--------
 378 local_part=a1 domain=myhost.test.ex
 379 checking local_parts
 380 calling u1 router
 381 u1 router called for a1@myhost.test.ex
 382   domain = myhost.test.ex
 383 set transport ut1
 384 queued for ut1 transport: local_part = a1
 385 domain = myhost.test.ex
 386   errors_to=
 387   domain_data=NULL local_part_data=^a\d
 388 routed by u1 router (unseen)
 389   envelope to: a1@myhost.test.ex
 390   transport: ut1
 391   errors to
 392 "unseen" set: replicated a1@myhost.test.ex
 393 locking TESTSUITE/spool/db/retry.lockfile
 394 no retry data available
 395 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 396 Considering: a1@myhost.test.ex
 397 unique = \0\a1@myhost.test.ex
 398 a1@myhost.test.ex: queued for routing
 399 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 400 Considering: b1@myhost.test.ex
 401 unique = \0\b1@myhost.test.ex
 402 b1@myhost.test.ex: queued for routing
 403 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 404 Considering: c1@myhost.test.ex
 405 unique = \0\c1@myhost.test.ex
 406 c1@myhost.test.ex: queued for routing
 407 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 408 Considering: d1@myhost.test.ex
 409 unique = \0\d1@myhost.test.ex
 410 d1@myhost.test.ex: queued for routing
 411 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 412 Considering: d2@myhost.test.ex
 413 unique = \0\d2@myhost.test.ex
 414 d2@myhost.test.ex: queued for routing
 415 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 416 Considering: d3@myhost.test.ex
 417 unique = \0\d3@myhost.test.ex
 418 d3@myhost.test.ex: queued for routing
 419 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 420 Considering: e1@myhost.test.ex
 421 unique = \0\e1@myhost.test.ex
 422 e1@myhost.test.ex: queued for routing
 423 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 424 Considering: f1@myhost.test.ex
 425 unique = \0\f1@myhost.test.ex
 426 f1@myhost.test.ex: queued for routing
 427 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 428 Considering: f2@myhost.test.ex
 429 unique = \0\f2@myhost.test.ex
 430 f2@myhost.test.ex: queued for routing
 431 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 432 Considering: f3@myhost.test.ex
 433 unique = \0\f3@myhost.test.ex
 434 f3@myhost.test.ex: queued for routing
 435 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 436 routing f3@myhost.test.ex
 437 --------> ut7 router <--------
 438 local_part=f3 domain=myhost.test.ex
 439 checking local_parts
 440 ut7 router skipped: local_parts mismatch
 441 --------> ut8 router <--------
 442 local_part=f3 domain=myhost.test.ex
 443 checking local_parts
 444 ut8 router skipped: local_parts mismatch
 445 --------> real router <--------
 446 local_part=f3 domain=myhost.test.ex
 447 calling real router
 448 real router called for f3@myhost.test.ex
 449   domain = myhost.test.ex
 450 set transport real
 451 queued for real transport: local_part = f3
 452 domain = myhost.test.ex
 453   errors_to=NULL
 454   domain_data=NULL local_part_data=NULL
 455 routed by real router
 456   envelope to: f3@myhost.test.ex
 457   transport: real
 458 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 459 routing f2@myhost.test.ex
 460 --------> ut7 router <--------
 461 local_part=f2 domain=myhost.test.ex
 462 checking local_parts
 463 ut7 router skipped: local_parts mismatch
 464 --------> ut8 router <--------
 465 local_part=f2 domain=myhost.test.ex
 466 checking local_parts
 467 ut8 router skipped: local_parts mismatch
 468 --------> real router <--------
 469 local_part=f2 domain=myhost.test.ex
 470 calling real router
 471 real router called for f2@myhost.test.ex
 472   domain = myhost.test.ex
 473 queued for real transport: local_part = f2
 474 domain = myhost.test.ex
 475   errors_to=NULL
 476   domain_data=NULL local_part_data=NULL
 477 routed by real router
 478   envelope to: f2@myhost.test.ex
 479   transport: real
 480 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 481 routing f1@myhost.test.ex
 482 --------> ut7 router <--------
 483 local_part=f1 domain=myhost.test.ex
 484 checking local_parts
 485 ut7 router skipped: local_parts mismatch
 486 --------> ut8 router <--------
 487 local_part=f1 domain=myhost.test.ex
 488 checking local_parts
 489 ut8 router skipped: local_parts mismatch
 490 --------> real router <--------
 491 local_part=f1 domain=myhost.test.ex
 492 calling real router
 493 real router called for f1@myhost.test.ex
 494   domain = myhost.test.ex
 495 queued for real transport: local_part = f1
 496 domain = myhost.test.ex
 497   errors_to=NULL
 498   domain_data=NULL local_part_data=NULL
 499 routed by real router
 500   envelope to: f1@myhost.test.ex
 501   transport: real
 502 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 503 routing e1@myhost.test.ex
 504 --------> ut6 router <--------
 505 local_part=e1 domain=myhost.test.ex
 506 checking local_parts
 507 ut6 router skipped: local_parts mismatch
 508 --------> ut7 router <--------
 509 local_part=e1 domain=myhost.test.ex
 510 checking local_parts
 511 ut7 router skipped: local_parts mismatch
 512 --------> ut8 router <--------
 513 local_part=e1 domain=myhost.test.ex
 514 checking local_parts
 515 ut8 router skipped: local_parts mismatch
 516 --------> real router <--------
 517 local_part=e1 domain=myhost.test.ex
 518 calling real router
 519 real router called for e1@myhost.test.ex
 520   domain = myhost.test.ex
 521 queued for real transport: local_part = e1
 522 domain = myhost.test.ex
 523   errors_to=NULL
 524   domain_data=NULL local_part_data=NULL
 525 routed by real router
 526   envelope to: e1@myhost.test.ex
 527   transport: real
 528 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 529 routing d3@myhost.test.ex
 530 --------> ut5 router <--------
 531 local_part=d3 domain=myhost.test.ex
 532 checking local_parts
 533 ut5 router skipped: local_parts mismatch
 534 --------> ut6 router <--------
 535 local_part=d3 domain=myhost.test.ex
 536 checking local_parts
 537 ut6 router skipped: local_parts mismatch
 538 --------> ut7 router <--------
 539 local_part=d3 domain=myhost.test.ex
 540 checking local_parts
 541 ut7 router skipped: local_parts mismatch
 542 --------> ut8 router <--------
 543 local_part=d3 domain=myhost.test.ex
 544 checking local_parts
 545 ut8 router skipped: local_parts mismatch
 546 --------> real router <--------
 547 local_part=d3 domain=myhost.test.ex
 548 calling real router
 549 real router called for d3@myhost.test.ex
 550   domain = myhost.test.ex
 551 queued for real transport: local_part = d3
 552 domain = myhost.test.ex
 553   errors_to=NULL
 554   domain_data=NULL local_part_data=NULL
 555 routed by real router
 556   envelope to: d3@myhost.test.ex
 557   transport: real
 558 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 559 routing d2@myhost.test.ex
 560 --------> ut5 router <--------
 561 local_part=d2 domain=myhost.test.ex
 562 checking local_parts
 563 ut5 router skipped: local_parts mismatch
 564 --------> ut6 router <--------
 565 local_part=d2 domain=myhost.test.ex
 566 checking local_parts
 567 ut6 router skipped: local_parts mismatch
 568 --------> ut7 router <--------
 569 local_part=d2 domain=myhost.test.ex
 570 checking local_parts
 571 ut7 router skipped: local_parts mismatch
 572 --------> ut8 router <--------
 573 local_part=d2 domain=myhost.test.ex
 574 checking local_parts
 575 ut8 router skipped: local_parts mismatch
 576 --------> real router <--------
 577 local_part=d2 domain=myhost.test.ex
 578 calling real router
 579 real router called for d2@myhost.test.ex
 580   domain = myhost.test.ex
 581 queued for real transport: local_part = d2
 582 domain = myhost.test.ex
 583   errors_to=NULL
 584   domain_data=NULL local_part_data=NULL
 585 routed by real router
 586   envelope to: d2@myhost.test.ex
 587   transport: real
 588 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 589 routing d1@myhost.test.ex
 590 --------> ut5 router <--------
 591 local_part=d1 domain=myhost.test.ex
 592 checking local_parts
 593 ut5 router skipped: local_parts mismatch
 594 --------> ut6 router <--------
 595 local_part=d1 domain=myhost.test.ex
 596 checking local_parts
 597 ut6 router skipped: local_parts mismatch
 598 --------> ut7 router <--------
 599 local_part=d1 domain=myhost.test.ex
 600 checking local_parts
 601 ut7 router skipped: local_parts mismatch
 602 --------> ut8 router <--------
 603 local_part=d1 domain=myhost.test.ex
 604 checking local_parts
 605 ut8 router skipped: local_parts mismatch
 606 --------> real router <--------
 607 local_part=d1 domain=myhost.test.ex
 608 calling real router
 609 real router called for d1@myhost.test.ex
 610   domain = myhost.test.ex
 611 queued for real transport: local_part = d1
 612 domain = myhost.test.ex
 613   errors_to=NULL
 614   domain_data=NULL local_part_data=NULL
 615 routed by real router
 616   envelope to: d1@myhost.test.ex
 617   transport: real
 618 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 619 routing c1@myhost.test.ex
 620 --------> ut4 router <--------
 621 local_part=c1 domain=myhost.test.ex
 622 checking local_parts
 623 ut4 router skipped: local_parts mismatch
 624 --------> ut5 router <--------
 625 local_part=c1 domain=myhost.test.ex
 626 checking local_parts
 627 ut5 router skipped: local_parts mismatch
 628 --------> ut6 router <--------
 629 local_part=c1 domain=myhost.test.ex
 630 checking local_parts
 631 ut6 router skipped: local_parts mismatch
 632 --------> ut7 router <--------
 633 local_part=c1 domain=myhost.test.ex
 634 checking local_parts
 635 ut7 router skipped: local_parts mismatch
 636 --------> ut8 router <--------
 637 local_part=c1 domain=myhost.test.ex
 638 checking local_parts
 639 ut8 router skipped: local_parts mismatch
 640 --------> real router <--------
 641 local_part=c1 domain=myhost.test.ex
 642 calling real router
 643 real router called for c1@myhost.test.ex
 644   domain = myhost.test.ex
 645 queued for real transport: local_part = c1
 646 domain = myhost.test.ex
 647   errors_to=NULL
 648   domain_data=NULL local_part_data=NULL
 649 routed by real router
 650   envelope to: c1@myhost.test.ex
 651   transport: real
 652 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 653 routing b1@myhost.test.ex
 654 --------> ut3 router <--------
 655 local_part=b1 domain=myhost.test.ex
 656 checking local_parts
 657 ut3 router skipped: local_parts mismatch
 658 --------> ut4 router <--------
 659 local_part=b1 domain=myhost.test.ex
 660 checking local_parts
 661 ut4 router skipped: local_parts mismatch
 662 --------> ut5 router <--------
 663 local_part=b1 domain=myhost.test.ex
 664 checking local_parts
 665 ut5 router skipped: local_parts mismatch
 666 --------> ut6 router <--------
 667 local_part=b1 domain=myhost.test.ex
 668 checking local_parts
 669 ut6 router skipped: local_parts mismatch
 670 --------> ut7 router <--------
 671 local_part=b1 domain=myhost.test.ex
 672 checking local_parts
 673 ut7 router skipped: local_parts mismatch
 674 --------> ut8 router <--------
 675 local_part=b1 domain=myhost.test.ex
 676 checking local_parts
 677 ut8 router skipped: local_parts mismatch
 678 --------> real router <--------
 679 local_part=b1 domain=myhost.test.ex
 680 calling real router
 681 real router called for b1@myhost.test.ex
 682   domain = myhost.test.ex
 683 queued for real transport: local_part = b1
 684 domain = myhost.test.ex
 685   errors_to=NULL
 686   domain_data=NULL local_part_data=NULL
 687 routed by real router
 688   envelope to: b1@myhost.test.ex
 689   transport: real
 690 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 691 routing a1@myhost.test.ex
 692 --------> ut2 router <--------
 693 local_part=a1 domain=myhost.test.ex
 694 checking local_parts
 695 ut2 router skipped: local_parts mismatch
 696 --------> ut3 router <--------
 697 local_part=a1 domain=myhost.test.ex
 698 checking local_parts
 699 ut3 router skipped: local_parts mismatch
 700 --------> ut4 router <--------
 701 local_part=a1 domain=myhost.test.ex
 702 checking local_parts
 703 ut4 router skipped: local_parts mismatch
 704 --------> ut5 router <--------
 705 local_part=a1 domain=myhost.test.ex
 706 checking local_parts
 707 ut5 router skipped: local_parts mismatch
 708 --------> ut6 router <--------
 709 local_part=a1 domain=myhost.test.ex
 710 checking local_parts
 711 ut6 router skipped: local_parts mismatch
 712 --------> ut7 router <--------
 713 local_part=a1 domain=myhost.test.ex
 714 checking local_parts
 715 ut7 router skipped: local_parts mismatch
 716 --------> ut8 router <--------
 717 local_part=a1 domain=myhost.test.ex
 718 checking local_parts
 719 ut8 router skipped: local_parts mismatch
 720 --------> real router <--------
 721 local_part=a1 domain=myhost.test.ex
 722 calling real router
 723 real router called for a1@myhost.test.ex
 724   domain = myhost.test.ex
 725 queued for real transport: local_part = a1
 726 domain = myhost.test.ex
 727   errors_to=NULL
 728   domain_data=NULL local_part_data=NULL
 729 routed by real router
 730   envelope to: a1@myhost.test.ex
 731   transport: real
 732 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 733 After routing:
 734   Local deliveries:
 735     a1@myhost.test.ex
 736     b1@myhost.test.ex
 737     c1@myhost.test.ex
 738     d1@myhost.test.ex
 739     d2@myhost.test.ex
 740     d3@myhost.test.ex
 741     e1@myhost.test.ex
 742     f1@myhost.test.ex
 743     f2@myhost.test.ex
 744     f3@myhost.test.ex
 745     a1@myhost.test.ex
 746     b1@myhost.test.ex
 747     c1@myhost.test.ex
 748   Remote deliveries:
 749     d1@myhost.test.ex
 750     d2@myhost.test.ex
 751     d3@myhost.test.ex
 752     e1@myhost.test.ex
 753     f1@myhost.test.ex
 754     f2@myhost.test.ex
 755     f3@myhost.test.ex
 756   Failed addresses:
 757   Deferred addresses:
 758     g1@myhost.test.ex
 759 locking TESTSUITE/spool/db/retry.lockfile
 760 LOG: MAIN
 761   => a1 <a1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 762 locking TESTSUITE/spool/db/retry.lockfile
 763 LOG: MAIN
 764   => b1 <b1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 765 locking TESTSUITE/spool/db/retry.lockfile
 766 LOG: MAIN
 767   => c1 <c1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 768 locking TESTSUITE/spool/db/retry.lockfile
 769 LOG: MAIN
 770   => d1 <d1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 771 locking TESTSUITE/spool/db/retry.lockfile
 772 LOG: MAIN
 773   => d2 <d2@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 774 locking TESTSUITE/spool/db/retry.lockfile
 775 LOG: MAIN
 776   => d3 <d3@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 777 locking TESTSUITE/spool/db/retry.lockfile
 778 LOG: MAIN
 779   => e1 <e1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 780 locking TESTSUITE/spool/db/retry.lockfile
 781 LOG: MAIN
 782   => f1 <f1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 783 locking TESTSUITE/spool/db/retry.lockfile
 784 LOG: MAIN
 785   => f2 <f2@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 786 locking TESTSUITE/spool/db/retry.lockfile
 787 LOG: MAIN
 788   => f3 <f3@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
 789 locking TESTSUITE/spool/db/retry.lockfile
 790 LOG: MAIN
 791   => a1 <a1@myhost.test.ex> P=<> R=u1 T=ut1
 792 log writing disabled
 793 locking TESTSUITE/spool/db/retry.lockfile
 794 transport error EPIPE ignored
 795 LOG: MAIN
 796   ** b1@myhost.test.ex P=<> R=ut2 T=ut2: Child process of ut2 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file
 797 log writing disabled
 798 locking TESTSUITE/spool/db/retry.lockfile
 799 transport error EPIPE ignored
 800 LOG: MAIN
 801   == c1@myhost.test.ex R=ut3 T=ut3 defer (0): Child process of ut3 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file
 802 log writing disabled
 803 locking TESTSUITE/spool/db/retry.lockfile
 804 locking TESTSUITE/spool/db/wait-ut4.lockfile
 805 LOG: MAIN
 806   => d1@myhost.test.ex P=<> R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1] C="250 OK"
 807 log writing disabled
 808 locking TESTSUITE/spool/db/retry.lockfile
 809 LOG: MAIN
 810   == d2@myhost.test.ex R=ut4 T=ut4 defer (-44) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d2@myhost.test.ex>: 450 soft error
 811 log writing disabled
 812 locking TESTSUITE/spool/db/retry.lockfile
 813 locking TESTSUITE/spool/db/wait-ut4.lockfile
 814 LOG: MAIN
 815   ** d3@myhost.test.ex P=<> R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d3@myhost.test.ex>: 550 hard error
 816 log writing disabled
 817 locking TESTSUITE/spool/db/retry.lockfile
 818 locking TESTSUITE/spool/db/wait-ut5.lockfile
 819 LOG: MAIN
 820   ** e1@myhost.test.ex P=<> R=ut5 T=ut5 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<e1@myhost.test.ex>: 550 hard error
 821 log writing disabled
 822 locking TESTSUITE/spool/db/retry.lockfile
 823 locking TESTSUITE/spool/db/wait-ut6.lockfile
 824 LOG: MAIN
 825   => f1@myhost.test.ex P=<CALLER@myhost.test.ex> R=ut6 T=ut6 H=127.0.0.1 [127.0.0.1] C="250 OK"
 826 log writing disabled
 827 locking TESTSUITE/spool/db/retry.lockfile
 828 LOG: MAIN
 829   == f2@myhost.test.ex R=ut6 T=ut6 defer (-44) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<f2@myhost.test.ex>: 450 soft error
 830 log writing disabled
 831 locking TESTSUITE/spool/db/retry.lockfile
 832 locking TESTSUITE/spool/db/wait-ut6.lockfile
 833 LOG: MAIN
 834   ** f3@myhost.test.ex P=<CALLER@myhost.test.ex> R=ut6 T=ut6 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<f3@myhost.test.ex>: 550 hard error
 835 log writing disabled
 836 locking TESTSUITE/spool/db/retry.lockfile
 837 LOG: MAIN
 838   f3@myhost.test.ex <f3@myhost.test.ex>: error ignored
 839 log writing disabled
 840 Exim version x.yz ....
 841 configuration file is TESTSUITE/test-config
 842 trusted user
 843 admin user
 844 LOG: MAIN
 845   <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss
 846 Exim version x.yz ....
 847 configuration file is TESTSUITE/test-config
 848 trusted user
 849 admin user
 850 dropping to exim gid; retaining priv uid
 851 locking TESTSUITE/spool/db/retry.lockfile
 852 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 853 Considering: CALLER@myhost.test.ex
 854 unique = CALLER@myhost.test.ex
 855 CALLER@myhost.test.ex: queued for routing
 856 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 857 routing CALLER@myhost.test.ex
 858 --------> u1 router <--------
 859 local_part=CALLER domain=myhost.test.ex
 860 checking local_parts
 861 u1 router skipped: local_parts mismatch
 862 --------> ut2 router <--------
 863 local_part=CALLER domain=myhost.test.ex
 864 checking local_parts
 865 ut2 router skipped: local_parts mismatch
 866 --------> ut3 router <--------
 867 local_part=CALLER domain=myhost.test.ex
 868 checking local_parts
 869 ut3 router skipped: local_parts mismatch
 870 --------> ut4 router <--------
 871 local_part=CALLER domain=myhost.test.ex
 872 checking local_parts
 873 ut4 router skipped: local_parts mismatch
 874 --------> ut5 router <--------
 875 local_part=CALLER domain=myhost.test.ex
 876 checking local_parts
 877 ut5 router skipped: local_parts mismatch
 878 --------> ut6 router <--------
 879 local_part=CALLER domain=myhost.test.ex
 880 checking local_parts
 881 ut6 router skipped: local_parts mismatch
 882 --------> ut7 router <--------
 883 local_part=CALLER domain=myhost.test.ex
 884 checking local_parts
 885 ut7 router skipped: local_parts mismatch
 886 --------> ut8 router <--------
 887 local_part=CALLER domain=myhost.test.ex
 888 checking local_parts
 889 ut8 router skipped: local_parts mismatch
 890 --------> real router <--------
 891 local_part=CALLER domain=myhost.test.ex
 892 calling real router
 893 real router called for CALLER@myhost.test.ex
 894   domain = myhost.test.ex
 895 set transport real
 896 queued for real transport: local_part = CALLER
 897 domain = myhost.test.ex
 898   errors_to=NULL
 899   domain_data=NULL local_part_data=NULL
 900 routed by real router
 901   envelope to: CALLER@myhost.test.ex
 902   transport: real
 903 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 904 After routing:
 905   Local deliveries:
 906     CALLER@myhost.test.ex
 907   Remote deliveries:
 908   Failed addresses:
 909   Deferred addresses:
 910 locking TESTSUITE/spool/db/retry.lockfile
 911 LOG: MAIN
 912   => CALLER <CALLER@myhost.test.ex> P=<> R=real T=real
 913 LOG: MAIN
 914   Completed
 915 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 916 >>>>>>>>>>>>>>>> Exim pid=pppp (bounce-message) terminating with rc=0 >>>>>>>>>>>>>>>>
 917 LOG: MAIN
 918   d3@myhost.test.ex <d3@myhost.test.ex>: error ignored
 919 log writing disabled
 920 LOG: MAIN
 921   b1@myhost.test.ex <b1@myhost.test.ex>: error ignored
 922 log writing disabled
 923 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 924 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 925 Exim version x.yz ....
 926 configuration file is TESTSUITE/test-config
 927 admin user
 928 LOG: MAIN
 929   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
 930 Exim version x.yz ....
 931 configuration file is TESTSUITE/test-config
 932 trusted user
 933 admin user
 934 dropping to exim gid; retaining priv uid
 935 locking TESTSUITE/spool/db/retry.lockfile
 936 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 937 Considering: h1@myhost.test.ex
 938 unique = h1@myhost.test.ex
 939 h1@myhost.test.ex: queued for routing
 940 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 941 routing h1@myhost.test.ex
 942 --------> u1 router <--------
 943 local_part=h1 domain=myhost.test.ex
 944 checking local_parts
 945 u1 router skipped: local_parts mismatch
 946 --------> ut2 router <--------
 947 local_part=h1 domain=myhost.test.ex
 948 checking local_parts
 949 ut2 router skipped: local_parts mismatch
 950 --------> ut3 router <--------
 951 local_part=h1 domain=myhost.test.ex
 952 checking local_parts
 953 ut3 router skipped: local_parts mismatch
 954 --------> ut4 router <--------
 955 local_part=h1 domain=myhost.test.ex
 956 checking local_parts
 957 ut4 router skipped: local_parts mismatch
 958 --------> ut5 router <--------
 959 local_part=h1 domain=myhost.test.ex
 960 checking local_parts
 961 ut5 router skipped: local_parts mismatch
 962 --------> ut6 router <--------
 963 local_part=h1 domain=myhost.test.ex
 964 checking local_parts
 965 ut6 router skipped: local_parts mismatch
 966 --------> ut7 router <--------
 967 local_part=h1 domain=myhost.test.ex
 968 checking local_parts
 969 ut7 router skipped: local_parts mismatch
 970 --------> ut8 router <--------
 971 local_part=h1 domain=myhost.test.ex
 972 checking local_parts
 973 calling ut8 router
 974 ut8 router called for h1@myhost.test.ex
 975   domain = myhost.test.ex
 976 forced expansion failure - ignoring errors_to
 977 set transport ut1
 978 queued for ut1 transport: local_part = h1
 979 domain = myhost.test.ex
 980   errors_to=NULL
 981   domain_data=NULL local_part_data=^h\d
 982 routed by ut8 router (unseen)
 983   envelope to: h1@myhost.test.ex
 984   transport: ut1
 985 "unseen" set: replicated h1@myhost.test.ex
 986 locking TESTSUITE/spool/db/retry.lockfile
 987 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 988 Considering: h1@myhost.test.ex
 989 unique = \0\h1@myhost.test.ex
 990 h1@myhost.test.ex: queued for routing
 991 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 992 routing h1@myhost.test.ex
 993 --------> real router <--------
 994 local_part=h1 domain=myhost.test.ex
 995 calling real router
 996 real router called for h1@myhost.test.ex
 997   domain = myhost.test.ex
 998 set transport real
 999 queued for real transport: local_part = h1
1000 domain = myhost.test.ex
1001   errors_to=NULL
1002   domain_data=NULL local_part_data=NULL
1003 routed by real router
1004   envelope to: h1@myhost.test.ex
1005   transport: real
1006 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
1007 After routing:
1008   Local deliveries:
1009     h1@myhost.test.ex
1010     h1@myhost.test.ex
1011   Remote deliveries:
1012   Failed addresses:
1013   Deferred addresses:
1014 locking TESTSUITE/spool/db/retry.lockfile
1015 LOG: MAIN
1016   => h1 <h1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
1017 locking TESTSUITE/spool/db/retry.lockfile
1018 LOG: MAIN
1019   => h1 <h1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=ut8 T=ut1
1020 log writing disabled
1021 LOG: MAIN
1022   Completed
1023 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
1024 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>