test/stderr/0377

   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: aaaa@myhost.test.ex
  16 unique = aaaa@myhost.test.ex
  17 aaaa@myhost.test.ex: queued for routing
  18 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  19 Considering: bbbb@myhost.test.ex
  20 unique = bbbb@myhost.test.ex
  21 bbbb@myhost.test.ex: queued for routing
  22 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  23 Considering: cccc@myhost.test.ex
  24 unique = cccc@myhost.test.ex
  25 cccc@myhost.test.ex: queued for routing
  26 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  27 routing cccc@myhost.test.ex
  28 --------> defer router <--------
  29 local_part=cccc domain=myhost.test.ex
  30 checking local_parts
  31 defer router skipped: local_parts mismatch
  32 --------> unseen_aaaa router <--------
  33 local_part=cccc domain=myhost.test.ex
  34 checking local_parts
  35 unseen_aaaa router skipped: local_parts mismatch
  36 --------> seen_aaaa router <--------
  37 local_part=cccc domain=myhost.test.ex
  38 checking local_parts
  39 seen_aaaa router skipped: local_parts mismatch
  40 --------> bbbb router <--------
  41 local_part=cccc domain=myhost.test.ex
  42 checking local_parts
  43 bbbb router skipped: local_parts mismatch
  44 --------> bbbb_0 router <--------
  45 local_part=cccc domain=myhost.test.ex
  46 checking local_parts
  47 bbbb_0 router skipped: local_parts mismatch
  48 --------> cccc_2nd_time router <--------
  49 local_part=cccc domain=myhost.test.ex
  50 checking local_parts
  51 checking "condition" "${if first_delivery{no}{yes}}"...
  52 cccc_2nd_time router skipped: condition failure
  53 --------> cccc_redirect router <--------
  54 local_part=cccc domain=myhost.test.ex
  55 checking local_parts
  56 calling cccc_redirect router
  57 rda_interpret (string): 'cccc@$domain, defer_cccc@$domain'
  58 expanded: 'cccc@myhost.test.ex, defer_cccc@myhost.test.ex'
  59 file is not a filter file
  60 parse_forward_list: cccc@myhost.test.ex, defer_cccc@myhost.test.ex
  61 extract item: cccc@myhost.test.ex
  62 extract item: defer_cccc@myhost.test.ex
  63 cccc_redirect router generated defer_cccc@myhost.test.ex
  64   errors_to=NULL transport=NULL
  65   uid=unset gid=unset home=NULL
  66 cccc_redirect router generated cccc@myhost.test.ex
  67   errors_to=NULL transport=NULL
  68   uid=unset gid=unset home=NULL
  69 routed by cccc_redirect router
  70   envelope to: cccc@myhost.test.ex
  71   transport: <none>
  72 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  73 routing bbbb@myhost.test.ex
  74 --------> defer router <--------
  75 local_part=bbbb domain=myhost.test.ex
  76 checking local_parts
  77 defer router skipped: local_parts mismatch
  78 --------> unseen_aaaa router <--------
  79 local_part=bbbb domain=myhost.test.ex
  80 checking local_parts
  81 unseen_aaaa router skipped: local_parts mismatch
  82 --------> seen_aaaa router <--------
  83 local_part=bbbb domain=myhost.test.ex
  84 checking local_parts
  85 seen_aaaa router skipped: local_parts mismatch
  86 --------> bbbb router <--------
  87 local_part=bbbb domain=myhost.test.ex
  88 checking local_parts
  89 checking "condition" "${if first_delivery{yes}{no}}"...
  90 calling bbbb router
  91 rda_interpret (string): 'bbbb@$domain, defer_bbbb@$domain'
  92 expanded: 'bbbb@myhost.test.ex, defer_bbbb@myhost.test.ex'
  93 file is not a filter file
  94 parse_forward_list: bbbb@myhost.test.ex, defer_bbbb@myhost.test.ex
  95 extract item: bbbb@myhost.test.ex
  96 extract item: defer_bbbb@myhost.test.ex
  97 bbbb router generated defer_bbbb@myhost.test.ex
  98   errors_to=NULL transport=NULL
  99   uid=unset gid=unset home=NULL
 100 bbbb router generated bbbb@myhost.test.ex
 101   errors_to=NULL transport=NULL
 102   uid=unset gid=unset home=NULL
 103 routed by bbbb router
 104   envelope to: bbbb@myhost.test.ex
 105   transport: <none>
 106 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 107 routing aaaa@myhost.test.ex
 108 --------> defer router <--------
 109 local_part=aaaa domain=myhost.test.ex
 110 checking local_parts
 111 defer router skipped: local_parts mismatch
 112 --------> unseen_aaaa router <--------
 113 local_part=aaaa domain=myhost.test.ex
 114 checking local_parts
 115 checking "condition" "${if first_delivery{yes}{no}}"...
 116 calling unseen_aaaa router
 117 rda_interpret (string): 'defer_aaaa@$domain'
 118 expanded: 'defer_aaaa@myhost.test.ex'
 119 file is not a filter file
 120 parse_forward_list: defer_aaaa@myhost.test.ex
 121 extract item: defer_aaaa@myhost.test.ex
 122 unseen_aaaa router generated defer_aaaa@myhost.test.ex
 123   errors_to=NULL transport=NULL
 124   uid=unset gid=unset home=NULL
 125 routed by unseen_aaaa router (unseen)
 126   envelope to: aaaa@myhost.test.ex
 127   transport: <none>
 128 "unseen" set: replicated aaaa@myhost.test.ex
 129 locking TESTSUITE/spool/db/retry.lockfile
 130 no retry data available
 131 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 132 Considering: aaaa@myhost.test.ex
 133 unique = \0\aaaa@myhost.test.ex
 134 aaaa@myhost.test.ex: queued for routing
 135 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 136 Considering: defer_aaaa@myhost.test.ex
 137 unique = defer_aaaa@myhost.test.ex
 138 defer_aaaa@myhost.test.ex: queued for routing
 139 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 140 Considering: bbbb@myhost.test.ex
 141 unique = \0\bbbb@myhost.test.ex
 142 bbbb@myhost.test.ex: queued for routing
 143 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 144 Considering: defer_bbbb@myhost.test.ex
 145 unique = defer_bbbb@myhost.test.ex
 146 defer_bbbb@myhost.test.ex: queued for routing
 147 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 148 Considering: cccc@myhost.test.ex
 149 unique = \0\cccc@myhost.test.ex
 150 cccc@myhost.test.ex: queued for routing
 151 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 152 Considering: defer_cccc@myhost.test.ex
 153 unique = defer_cccc@myhost.test.ex
 154 defer_cccc@myhost.test.ex: queued for routing
 155 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 156 routing defer_cccc@myhost.test.ex
 157 --------> defer router <--------
 158 local_part=defer_cccc domain=myhost.test.ex
 159 checking local_parts
 160 calling defer router
 161 rda_interpret (string): ':defer: forced defer'
 162 expanded: ':defer: forced defer'
 163 file is not a filter file
 164 parse_forward_list: :defer: forced defer
 165 extract item: :defer: forced defer
 166 defer router: defer for defer_cccc@myhost.test.ex
 167   message: forced defer
 168 LOG: MAIN
 169   == defer_cccc@myhost.test.ex <cccc@myhost.test.ex> R=defer defer (-1): forced defer
 170 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 171 routing cccc@myhost.test.ex
 172 --------> defer router <--------
 173 local_part=cccc domain=myhost.test.ex
 174 checking local_parts
 175 defer router skipped: local_parts mismatch
 176 --------> unseen_aaaa router <--------
 177 local_part=cccc domain=myhost.test.ex
 178 checking local_parts
 179 unseen_aaaa router skipped: local_parts mismatch
 180 --------> seen_aaaa router <--------
 181 local_part=cccc domain=myhost.test.ex
 182 checking local_parts
 183 seen_aaaa router skipped: local_parts mismatch
 184 --------> bbbb router <--------
 185 local_part=cccc domain=myhost.test.ex
 186 checking local_parts
 187 bbbb router skipped: local_parts mismatch
 188 --------> bbbb_0 router <--------
 189 local_part=cccc domain=myhost.test.ex
 190 checking local_parts
 191 bbbb_0 router skipped: local_parts mismatch
 192 --------> cccc_2nd_time router <--------
 193 local_part=cccc domain=myhost.test.ex
 194 checking local_parts
 195 checking "condition" "${if first_delivery{no}{yes}}"...
 196 cccc_2nd_time router skipped: condition failure
 197 --------> cccc_redirect router <--------
 198 cccc_redirect router skipped: previously routed cccc@myhost.test.ex
 199 --------> cccc_accept router <--------
 200 local_part=cccc domain=myhost.test.ex
 201 checking local_parts
 202 calling cccc_accept router
 203 cccc_accept router called for cccc@myhost.test.ex
 204   domain = myhost.test.ex
 205 set transport t1
 206 queued for t1 transport: local_part = cccc
 207 domain = myhost.test.ex
 208   errors_to=NULL
 209   domain_data=NULL localpart_data=NULL
 210 routed by cccc_accept router
 211   envelope to: cccc@myhost.test.ex
 212   transport: t1
 213 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 214 routing defer_bbbb@myhost.test.ex
 215 --------> defer router <--------
 216 local_part=defer_bbbb domain=myhost.test.ex
 217 checking local_parts
 218 calling defer router
 219 rda_interpret (string): ':defer: forced defer'
 220 expanded: ':defer: forced defer'
 221 file is not a filter file
 222 parse_forward_list: :defer: forced defer
 223 extract item: :defer: forced defer
 224 defer router: defer for defer_bbbb@myhost.test.ex
 225   message: forced defer
 226 LOG: MAIN
 227   == defer_bbbb@myhost.test.ex <bbbb@myhost.test.ex> R=defer defer (-1): forced defer
 228 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 229 routing bbbb@myhost.test.ex
 230 --------> defer router <--------
 231 local_part=bbbb domain=myhost.test.ex
 232 checking local_parts
 233 defer router skipped: local_parts mismatch
 234 --------> unseen_aaaa router <--------
 235 local_part=bbbb domain=myhost.test.ex
 236 checking local_parts
 237 unseen_aaaa router skipped: local_parts mismatch
 238 --------> seen_aaaa router <--------
 239 local_part=bbbb domain=myhost.test.ex
 240 checking local_parts
 241 seen_aaaa router skipped: local_parts mismatch
 242 --------> bbbb router <--------
 243 bbbb router skipped: previously routed bbbb@myhost.test.ex
 244 --------> bbbb_0 router <--------
 245 local_part=bbbb domain=myhost.test.ex
 246 checking local_parts
 247 calling bbbb_0 router
 248 bbbb_0 router called for bbbb@myhost.test.ex
 249   domain = myhost.test.ex
 250 set transport t1
 251 queued for t1 transport: local_part = bbbb
 252 domain = myhost.test.ex
 253   errors_to=NULL
 254   domain_data=NULL localpart_data=NULL
 255 routed by bbbb_0 router
 256   envelope to: bbbb@myhost.test.ex
 257   transport: t1
 258 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 259 routing defer_aaaa@myhost.test.ex
 260 --------> defer router <--------
 261 local_part=defer_aaaa domain=myhost.test.ex
 262 checking local_parts
 263 calling defer router
 264 rda_interpret (string): ':defer: forced defer'
 265 expanded: ':defer: forced defer'
 266 file is not a filter file
 267 parse_forward_list: :defer: forced defer
 268 extract item: :defer: forced defer
 269 defer router: defer for defer_aaaa@myhost.test.ex
 270   message: forced defer
 271 LOG: MAIN
 272   == defer_aaaa@myhost.test.ex <aaaa@myhost.test.ex> R=defer defer (-1): forced defer
 273 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 274 routing aaaa@myhost.test.ex
 275 --------> seen_aaaa router <--------
 276 local_part=aaaa domain=myhost.test.ex
 277 checking local_parts
 278 calling seen_aaaa router
 279 seen_aaaa router called for aaaa@myhost.test.ex
 280   domain = myhost.test.ex
 281 set transport t1
 282 queued for t1 transport: local_part = aaaa
 283 domain = myhost.test.ex
 284   errors_to=NULL
 285   domain_data=NULL localpart_data=NULL
 286 routed by seen_aaaa router
 287   envelope to: aaaa@myhost.test.ex
 288   transport: t1
 289 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 290 After routing:
 291   Local deliveries:
 292     aaaa@myhost.test.ex
 293     bbbb@myhost.test.ex
 294     cccc@myhost.test.ex
 295   Remote deliveries:
 296   Failed addresses:
 297   Deferred addresses:
 298     defer_aaaa@myhost.test.ex
 299     defer_bbbb@myhost.test.ex
 300     defer_cccc@myhost.test.ex
 301 locking TESTSUITE/spool/db/retry.lockfile
 302 LOG: MAIN
 303   => aaaa <aaaa@myhost.test.ex> R=seen_aaaa T=t1
 304 locking TESTSUITE/spool/db/retry.lockfile
 305 LOG: MAIN
 306   => bbbb <bbbb@myhost.test.ex> R=bbbb_0 T=t1
 307 locking TESTSUITE/spool/db/retry.lockfile
 308 LOG: MAIN
 309   => cccc <cccc@myhost.test.ex> R=cccc_accept T=t1
 310 locking TESTSUITE/spool/db/retry.lockfile
 311 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
 312 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
 313 Exim version x.yz ....
 314 configuration file is TESTSUITE/test-config
 315 admin user
 316 dropping to exim gid; retaining priv uid
 317 LOG: queue_run MAIN
 318   Start queue run: pid=pppp -qf
 319 locking TESTSUITE/spool/db/retry.lockfile
 320 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 321 Considering: aaaa@myhost.test.ex
 322 unique = aaaa@myhost.test.ex
 323 aaaa@myhost.test.ex: queued for routing
 324 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 325 Considering: bbbb@myhost.test.ex
 326 unique = bbbb@myhost.test.ex
 327 bbbb@myhost.test.ex: queued for routing
 328 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 329 Considering: cccc@myhost.test.ex
 330 unique = cccc@myhost.test.ex
 331 cccc@myhost.test.ex: queued for routing
 332 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 333 routing cccc@myhost.test.ex
 334 --------> defer router <--------
 335 local_part=cccc domain=myhost.test.ex
 336 checking local_parts
 337 defer router skipped: local_parts mismatch
 338 --------> unseen_aaaa router <--------
 339 local_part=cccc domain=myhost.test.ex
 340 checking local_parts
 341 unseen_aaaa router skipped: local_parts mismatch
 342 --------> seen_aaaa router <--------
 343 local_part=cccc domain=myhost.test.ex
 344 checking local_parts
 345 seen_aaaa router skipped: local_parts mismatch
 346 --------> bbbb router <--------
 347 local_part=cccc domain=myhost.test.ex
 348 checking local_parts
 349 bbbb router skipped: local_parts mismatch
 350 --------> bbbb_0 router <--------
 351 local_part=cccc domain=myhost.test.ex
 352 checking local_parts
 353 bbbb_0 router skipped: local_parts mismatch
 354 --------> cccc_2nd_time router <--------
 355 local_part=cccc domain=myhost.test.ex
 356 checking local_parts
 357 checking "condition" "${if first_delivery{no}{yes}}"...
 358 calling cccc_2nd_time router
 359 rda_interpret (string): '$local_part@$domain'
 360 expanded: 'cccc@myhost.test.ex'
 361 file is not a filter file
 362 parse_forward_list: cccc@myhost.test.ex
 363 extract item: cccc@myhost.test.ex
 364 cccc_2nd_time router generated cccc@myhost.test.ex
 365   errors_to=NULL transport=NULL
 366   uid=unset gid=unset home=NULL
 367 routed by cccc_2nd_time router
 368   envelope to: cccc@myhost.test.ex
 369   transport: <none>
 370 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 371 routing bbbb@myhost.test.ex
 372 --------> defer router <--------
 373 local_part=bbbb domain=myhost.test.ex
 374 checking local_parts
 375 defer router skipped: local_parts mismatch
 376 --------> unseen_aaaa router <--------
 377 local_part=bbbb domain=myhost.test.ex
 378 checking local_parts
 379 unseen_aaaa router skipped: local_parts mismatch
 380 --------> seen_aaaa router <--------
 381 local_part=bbbb domain=myhost.test.ex
 382 checking local_parts
 383 seen_aaaa router skipped: local_parts mismatch
 384 --------> bbbb router <--------
 385 local_part=bbbb domain=myhost.test.ex
 386 checking local_parts
 387 checking "condition" "${if first_delivery{yes}{no}}"...
 388 bbbb router skipped: condition failure
 389 --------> bbbb_0 router <--------
 390 local_part=bbbb domain=myhost.test.ex
 391 checking local_parts
 392 calling bbbb_0 router
 393 bbbb_0 router called for bbbb@myhost.test.ex
 394   domain = myhost.test.ex
 395 set transport t1
 396 queued for t1 transport: local_part = bbbb
 397 domain = myhost.test.ex
 398   errors_to=NULL
 399   domain_data=NULL localpart_data=NULL
 400 routed by bbbb_0 router
 401   envelope to: bbbb@myhost.test.ex
 402   transport: t1
 403 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 404 routing aaaa@myhost.test.ex
 405 --------> defer router <--------
 406 local_part=aaaa domain=myhost.test.ex
 407 checking local_parts
 408 defer router skipped: local_parts mismatch
 409 --------> unseen_aaaa router <--------
 410 local_part=aaaa domain=myhost.test.ex
 411 checking local_parts
 412 checking "condition" "${if first_delivery{yes}{no}}"...
 413 unseen_aaaa router skipped: condition failure
 414 --------> seen_aaaa router <--------
 415 local_part=aaaa domain=myhost.test.ex
 416 checking local_parts
 417 calling seen_aaaa router
 418 seen_aaaa router called for aaaa@myhost.test.ex
 419   domain = myhost.test.ex
 420 set transport t1
 421 queued for t1 transport: local_part = aaaa
 422 domain = myhost.test.ex
 423   errors_to=NULL
 424   domain_data=NULL localpart_data=NULL
 425 routed by seen_aaaa router
 426   envelope to: aaaa@myhost.test.ex
 427   transport: t1
 428 locking TESTSUITE/spool/db/retry.lockfile
 429 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 430 Considering: cccc@myhost.test.ex
 431 unique = \0\cccc@myhost.test.ex
 432 cccc@myhost.test.ex: queued for routing
 433 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 434 routing cccc@myhost.test.ex
 435 --------> defer router <--------
 436 local_part=cccc domain=myhost.test.ex
 437 checking local_parts
 438 defer router skipped: local_parts mismatch
 439 --------> unseen_aaaa router <--------
 440 local_part=cccc domain=myhost.test.ex
 441 checking local_parts
 442 unseen_aaaa router skipped: local_parts mismatch
 443 --------> seen_aaaa router <--------
 444 local_part=cccc domain=myhost.test.ex
 445 checking local_parts
 446 seen_aaaa router skipped: local_parts mismatch
 447 --------> bbbb router <--------
 448 local_part=cccc domain=myhost.test.ex
 449 checking local_parts
 450 bbbb router skipped: local_parts mismatch
 451 --------> bbbb_0 router <--------
 452 local_part=cccc domain=myhost.test.ex
 453 checking local_parts
 454 bbbb_0 router skipped: local_parts mismatch
 455 --------> cccc_2nd_time router <--------
 456 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
 457 --------> cccc_redirect router <--------
 458 local_part=cccc domain=myhost.test.ex
 459 checking local_parts
 460 calling cccc_redirect router
 461 rda_interpret (string): 'cccc@$domain, defer_cccc@$domain'
 462 expanded: 'cccc@myhost.test.ex, defer_cccc@myhost.test.ex'
 463 file is not a filter file
 464 parse_forward_list: cccc@myhost.test.ex, defer_cccc@myhost.test.ex
 465 extract item: cccc@myhost.test.ex
 466 extract item: defer_cccc@myhost.test.ex
 467 cccc_redirect router generated defer_cccc@myhost.test.ex
 468   errors_to=NULL transport=NULL
 469   uid=unset gid=unset home=NULL
 470 cccc_redirect router generated cccc@myhost.test.ex
 471   errors_to=NULL transport=NULL
 472   uid=unset gid=unset home=NULL
 473 routed by cccc_redirect router
 474   envelope to: cccc@myhost.test.ex
 475   transport: <none>
 476 locking TESTSUITE/spool/db/retry.lockfile
 477 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 478 Considering: cccc@myhost.test.ex
 479 unique = \1\cccc@myhost.test.ex
 480 cccc@myhost.test.ex: queued for routing
 481 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 482 Considering: defer_cccc@myhost.test.ex
 483 unique = defer_cccc@myhost.test.ex
 484 defer_cccc@myhost.test.ex: queued for routing
 485 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 486 routing defer_cccc@myhost.test.ex
 487 --------> defer router <--------
 488 local_part=defer_cccc domain=myhost.test.ex
 489 checking local_parts
 490 calling defer router
 491 rda_interpret (string): ':defer: forced defer'
 492 expanded: ':defer: forced defer'
 493 file is not a filter file
 494 parse_forward_list: :defer: forced defer
 495 extract item: :defer: forced defer
 496 defer router: defer for defer_cccc@myhost.test.ex
 497   message: forced defer
 498 LOG: MAIN
 499   == defer_cccc@myhost.test.ex <cccc@myhost.test.ex> R=defer defer (-1): forced defer
 500 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 501 routing cccc@myhost.test.ex
 502 --------> defer router <--------
 503 local_part=cccc domain=myhost.test.ex
 504 checking local_parts
 505 defer router skipped: local_parts mismatch
 506 --------> unseen_aaaa router <--------
 507 local_part=cccc domain=myhost.test.ex
 508 checking local_parts
 509 unseen_aaaa router skipped: local_parts mismatch
 510 --------> seen_aaaa router <--------
 511 local_part=cccc domain=myhost.test.ex
 512 checking local_parts
 513 seen_aaaa router skipped: local_parts mismatch
 514 --------> bbbb router <--------
 515 local_part=cccc domain=myhost.test.ex
 516 checking local_parts
 517 bbbb router skipped: local_parts mismatch
 518 --------> bbbb_0 router <--------
 519 local_part=cccc domain=myhost.test.ex
 520 checking local_parts
 521 bbbb_0 router skipped: local_parts mismatch
 522 --------> cccc_2nd_time router <--------
 523 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
 524 --------> cccc_redirect router <--------
 525 cccc_redirect router skipped: previously routed cccc@myhost.test.ex
 526 --------> cccc_accept router <--------
 527 local_part=cccc domain=myhost.test.ex
 528 checking local_parts
 529 calling cccc_accept router
 530 cccc_accept router called for cccc@myhost.test.ex
 531   domain = myhost.test.ex
 532 set transport t1
 533 queued for t1 transport: local_part = cccc
 534 domain = myhost.test.ex
 535   errors_to=NULL
 536   domain_data=NULL localpart_data=NULL
 537 routed by cccc_accept router
 538   envelope to: cccc@myhost.test.ex
 539   transport: t1
 540 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 541 After routing:
 542   Local deliveries:
 543     cccc@myhost.test.ex
 544     aaaa@myhost.test.ex
 545     bbbb@myhost.test.ex
 546   Remote deliveries:
 547   Failed addresses:
 548   Deferred addresses:
 549     defer_cccc@myhost.test.ex
 550 cccc@myhost.test.ex was previously delivered (t1 transport): discarded
 551 aaaa@myhost.test.ex was previously delivered (t1 transport): discarded
 552 bbbb@myhost.test.ex was previously delivered (t1 transport): discarded
 553 locking TESTSUITE/spool/db/retry.lockfile
 554 LOG: queue_run MAIN
 555   End queue run: pid=pppp -qf
 556 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
 557 Exim version x.yz ....
 558 configuration file is TESTSUITE/test-config
 559 admin user
 560 dropping to exim gid; retaining priv uid
 561 LOG: queue_run MAIN
 562   Start queue run: pid=pppp -qf
 563 locking TESTSUITE/spool/db/retry.lockfile
 564 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 565 Considering: aaaa@myhost.test.ex
 566 unique = aaaa@myhost.test.ex
 567 aaaa@myhost.test.ex: queued for routing
 568 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 569 Considering: bbbb@myhost.test.ex
 570 unique = bbbb@myhost.test.ex
 571 bbbb@myhost.test.ex: queued for routing
 572 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 573 Considering: cccc@myhost.test.ex
 574 unique = cccc@myhost.test.ex
 575 cccc@myhost.test.ex: queued for routing
 576 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 577 routing cccc@myhost.test.ex
 578 --------> defer router <--------
 579 local_part=cccc domain=myhost.test.ex
 580 checking local_parts
 581 defer router skipped: local_parts mismatch
 582 --------> unseen_aaaa router <--------
 583 local_part=cccc domain=myhost.test.ex
 584 checking local_parts
 585 unseen_aaaa router skipped: local_parts mismatch
 586 --------> seen_aaaa router <--------
 587 local_part=cccc domain=myhost.test.ex
 588 checking local_parts
 589 seen_aaaa router skipped: local_parts mismatch
 590 --------> bbbb router <--------
 591 local_part=cccc domain=myhost.test.ex
 592 checking local_parts
 593 bbbb router skipped: local_parts mismatch
 594 --------> bbbb_0 router <--------
 595 local_part=cccc domain=myhost.test.ex
 596 checking local_parts
 597 bbbb_0 router skipped: local_parts mismatch
 598 --------> cccc_2nd_time router <--------
 599 local_part=cccc domain=myhost.test.ex
 600 checking local_parts
 601 checking "condition" "${if first_delivery{no}{yes}}"...
 602 calling cccc_2nd_time router
 603 rda_interpret (string): '$local_part@$domain'
 604 expanded: 'cccc@myhost.test.ex'
 605 file is not a filter file
 606 parse_forward_list: cccc@myhost.test.ex
 607 extract item: cccc@myhost.test.ex
 608 cccc_2nd_time router generated cccc@myhost.test.ex
 609   errors_to=NULL transport=NULL
 610   uid=unset gid=unset home=NULL
 611 routed by cccc_2nd_time router
 612   envelope to: cccc@myhost.test.ex
 613   transport: <none>
 614 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 615 routing bbbb@myhost.test.ex
 616 --------> defer router <--------
 617 local_part=bbbb domain=myhost.test.ex
 618 checking local_parts
 619 defer router skipped: local_parts mismatch
 620 --------> unseen_aaaa router <--------
 621 local_part=bbbb domain=myhost.test.ex
 622 checking local_parts
 623 unseen_aaaa router skipped: local_parts mismatch
 624 --------> seen_aaaa router <--------
 625 local_part=bbbb domain=myhost.test.ex
 626 checking local_parts
 627 seen_aaaa router skipped: local_parts mismatch
 628 --------> bbbb router <--------
 629 local_part=bbbb domain=myhost.test.ex
 630 checking local_parts
 631 checking "condition" "${if first_delivery{yes}{no}}"...
 632 bbbb router skipped: condition failure
 633 --------> bbbb_0 router <--------
 634 local_part=bbbb domain=myhost.test.ex
 635 checking local_parts
 636 calling bbbb_0 router
 637 bbbb_0 router called for bbbb@myhost.test.ex
 638   domain = myhost.test.ex
 639 set transport t1
 640 queued for t1 transport: local_part = bbbb
 641 domain = myhost.test.ex
 642   errors_to=NULL
 643   domain_data=NULL localpart_data=NULL
 644 routed by bbbb_0 router
 645   envelope to: bbbb@myhost.test.ex
 646   transport: t1
 647 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 648 routing aaaa@myhost.test.ex
 649 --------> defer router <--------
 650 local_part=aaaa domain=myhost.test.ex
 651 checking local_parts
 652 defer router skipped: local_parts mismatch
 653 --------> unseen_aaaa router <--------
 654 local_part=aaaa domain=myhost.test.ex
 655 checking local_parts
 656 checking "condition" "${if first_delivery{yes}{no}}"...
 657 unseen_aaaa router skipped: condition failure
 658 --------> seen_aaaa router <--------
 659 local_part=aaaa domain=myhost.test.ex
 660 checking local_parts
 661 calling seen_aaaa router
 662 seen_aaaa router called for aaaa@myhost.test.ex
 663   domain = myhost.test.ex
 664 set transport t1
 665 queued for t1 transport: local_part = aaaa
 666 domain = myhost.test.ex
 667   errors_to=NULL
 668   domain_data=NULL localpart_data=NULL
 669 routed by seen_aaaa router
 670   envelope to: aaaa@myhost.test.ex
 671   transport: t1
 672 locking TESTSUITE/spool/db/retry.lockfile
 673 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 674 Considering: cccc@myhost.test.ex
 675 unique = \0\cccc@myhost.test.ex
 676 cccc@myhost.test.ex: queued for routing
 677 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 678 routing cccc@myhost.test.ex
 679 --------> defer router <--------
 680 local_part=cccc domain=myhost.test.ex
 681 checking local_parts
 682 defer router skipped: local_parts mismatch
 683 --------> unseen_aaaa router <--------
 684 local_part=cccc domain=myhost.test.ex
 685 checking local_parts
 686 unseen_aaaa router skipped: local_parts mismatch
 687 --------> seen_aaaa router <--------
 688 local_part=cccc domain=myhost.test.ex
 689 checking local_parts
 690 seen_aaaa router skipped: local_parts mismatch
 691 --------> bbbb router <--------
 692 local_part=cccc domain=myhost.test.ex
 693 checking local_parts
 694 bbbb router skipped: local_parts mismatch
 695 --------> bbbb_0 router <--------
 696 local_part=cccc domain=myhost.test.ex
 697 checking local_parts
 698 bbbb_0 router skipped: local_parts mismatch
 699 --------> cccc_2nd_time router <--------
 700 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
 701 --------> cccc_redirect router <--------
 702 local_part=cccc domain=myhost.test.ex
 703 checking local_parts
 704 calling cccc_redirect router
 705 rda_interpret (string): 'cccc@$domain, defer_cccc@$domain'
 706 expanded: 'cccc@myhost.test.ex, defer_cccc@myhost.test.ex'
 707 file is not a filter file
 708 parse_forward_list: cccc@myhost.test.ex, defer_cccc@myhost.test.ex
 709 extract item: cccc@myhost.test.ex
 710 extract item: defer_cccc@myhost.test.ex
 711 cccc_redirect router generated defer_cccc@myhost.test.ex
 712   errors_to=NULL transport=NULL
 713   uid=unset gid=unset home=NULL
 714 cccc_redirect router generated cccc@myhost.test.ex
 715   errors_to=NULL transport=NULL
 716   uid=unset gid=unset home=NULL
 717 routed by cccc_redirect router
 718   envelope to: cccc@myhost.test.ex
 719   transport: <none>
 720 locking TESTSUITE/spool/db/retry.lockfile
 721 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 722 Considering: cccc@myhost.test.ex
 723 unique = \1\cccc@myhost.test.ex
 724 cccc@myhost.test.ex: queued for routing
 725 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 726 Considering: defer_cccc@myhost.test.ex
 727 unique = defer_cccc@myhost.test.ex
 728 defer_cccc@myhost.test.ex: queued for routing
 729 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 730 routing defer_cccc@myhost.test.ex
 731 --------> defer router <--------
 732 local_part=defer_cccc domain=myhost.test.ex
 733 checking local_parts
 734 calling defer router
 735 rda_interpret (string): ':defer: forced defer'
 736 expanded: ':defer: forced defer'
 737 file is not a filter file
 738 parse_forward_list: :defer: forced defer
 739 extract item: :defer: forced defer
 740 defer router: defer for defer_cccc@myhost.test.ex
 741   message: forced defer
 742 LOG: MAIN
 743   == defer_cccc@myhost.test.ex <cccc@myhost.test.ex> R=defer defer (-1): forced defer
 744 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 745 routing cccc@myhost.test.ex
 746 --------> defer router <--------
 747 local_part=cccc domain=myhost.test.ex
 748 checking local_parts
 749 defer router skipped: local_parts mismatch
 750 --------> unseen_aaaa router <--------
 751 local_part=cccc domain=myhost.test.ex
 752 checking local_parts
 753 unseen_aaaa router skipped: local_parts mismatch
 754 --------> seen_aaaa router <--------
 755 local_part=cccc domain=myhost.test.ex
 756 checking local_parts
 757 seen_aaaa router skipped: local_parts mismatch
 758 --------> bbbb router <--------
 759 local_part=cccc domain=myhost.test.ex
 760 checking local_parts
 761 bbbb router skipped: local_parts mismatch
 762 --------> bbbb_0 router <--------
 763 local_part=cccc domain=myhost.test.ex
 764 checking local_parts
 765 bbbb_0 router skipped: local_parts mismatch
 766 --------> cccc_2nd_time router <--------
 767 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
 768 --------> cccc_redirect router <--------
 769 cccc_redirect router skipped: previously routed cccc@myhost.test.ex
 770 --------> cccc_accept router <--------
 771 local_part=cccc domain=myhost.test.ex
 772 checking local_parts
 773 calling cccc_accept router
 774 cccc_accept router called for cccc@myhost.test.ex
 775   domain = myhost.test.ex
 776 set transport t1
 777 queued for t1 transport: local_part = cccc
 778 domain = myhost.test.ex
 779   errors_to=NULL
 780   domain_data=NULL localpart_data=NULL
 781 routed by cccc_accept router
 782   envelope to: cccc@myhost.test.ex
 783   transport: t1
 784 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 785 After routing:
 786   Local deliveries:
 787     cccc@myhost.test.ex
 788     aaaa@myhost.test.ex
 789     bbbb@myhost.test.ex
 790   Remote deliveries:
 791   Failed addresses:
 792   Deferred addresses:
 793     defer_cccc@myhost.test.ex
 794 cccc@myhost.test.ex was previously delivered (t1 transport): discarded
 795 aaaa@myhost.test.ex was previously delivered (t1 transport): discarded
 796 bbbb@myhost.test.ex was previously delivered (t1 transport): discarded
 797 locking TESTSUITE/spool/db/retry.lockfile
 798 LOG: queue_run MAIN
 799   End queue run: pid=pppp -qf
 800 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>