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' (tainted)
  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' (tainted)
  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' (tainted)
 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 local_part_data=cccc
 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 local_part_data=bbbb
 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 local_part_data=aaaa
 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 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 312 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) 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' (tainted)
 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 local_part_data=bbbb
 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 local_part_data=aaaa
 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' (tainted)
 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 local_part_data=cccc
 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 >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 555 LOG: queue_run MAIN
 556   End queue run: pid=pppp -qf
 557 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 558 Exim version x.yz ....
 559 configuration file is TESTSUITE/test-config
 560 admin user
 561 dropping to exim gid; retaining priv uid
 562 LOG: queue_run MAIN
 563   Start queue run: pid=pppp -qf
 564 locking TESTSUITE/spool/db/retry.lockfile
 565 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 566 Considering: aaaa@myhost.test.ex
 567 unique = aaaa@myhost.test.ex
 568 aaaa@myhost.test.ex: queued for routing
 569 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 570 Considering: bbbb@myhost.test.ex
 571 unique = bbbb@myhost.test.ex
 572 bbbb@myhost.test.ex: queued for routing
 573 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 574 Considering: cccc@myhost.test.ex
 575 unique = cccc@myhost.test.ex
 576 cccc@myhost.test.ex: queued for routing
 577 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 578 routing cccc@myhost.test.ex
 579 --------> defer router <--------
 580 local_part=cccc domain=myhost.test.ex
 581 checking local_parts
 582 defer router skipped: local_parts mismatch
 583 --------> unseen_aaaa router <--------
 584 local_part=cccc domain=myhost.test.ex
 585 checking local_parts
 586 unseen_aaaa router skipped: local_parts mismatch
 587 --------> seen_aaaa router <--------
 588 local_part=cccc domain=myhost.test.ex
 589 checking local_parts
 590 seen_aaaa router skipped: local_parts mismatch
 591 --------> bbbb router <--------
 592 local_part=cccc domain=myhost.test.ex
 593 checking local_parts
 594 bbbb router skipped: local_parts mismatch
 595 --------> bbbb_0 router <--------
 596 local_part=cccc domain=myhost.test.ex
 597 checking local_parts
 598 bbbb_0 router skipped: local_parts mismatch
 599 --------> cccc_2nd_time router <--------
 600 local_part=cccc domain=myhost.test.ex
 601 checking local_parts
 602 checking "condition" "${if first_delivery{no}{yes}}"...
 603 calling cccc_2nd_time router
 604 rda_interpret (string): '$local_part@$domain'
 605 expanded: 'cccc@myhost.test.ex' (tainted)
 606 file is not a filter file
 607 parse_forward_list: cccc@myhost.test.ex
 608 extract item: cccc@myhost.test.ex
 609 cccc_2nd_time router generated cccc@myhost.test.ex
 610   errors_to=NULL transport=NULL
 611   uid=unset gid=unset home=NULL
 612 routed by cccc_2nd_time router
 613   envelope to: cccc@myhost.test.ex
 614   transport: <none>
 615 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 616 routing bbbb@myhost.test.ex
 617 --------> defer router <--------
 618 local_part=bbbb domain=myhost.test.ex
 619 checking local_parts
 620 defer router skipped: local_parts mismatch
 621 --------> unseen_aaaa router <--------
 622 local_part=bbbb domain=myhost.test.ex
 623 checking local_parts
 624 unseen_aaaa router skipped: local_parts mismatch
 625 --------> seen_aaaa router <--------
 626 local_part=bbbb domain=myhost.test.ex
 627 checking local_parts
 628 seen_aaaa router skipped: local_parts mismatch
 629 --------> bbbb router <--------
 630 local_part=bbbb domain=myhost.test.ex
 631 checking local_parts
 632 checking "condition" "${if first_delivery{yes}{no}}"...
 633 bbbb router skipped: condition failure
 634 --------> bbbb_0 router <--------
 635 local_part=bbbb domain=myhost.test.ex
 636 checking local_parts
 637 calling bbbb_0 router
 638 bbbb_0 router called for bbbb@myhost.test.ex
 639   domain = myhost.test.ex
 640 set transport t1
 641 queued for t1 transport: local_part = bbbb
 642 domain = myhost.test.ex
 643   errors_to=NULL
 644   domain_data=NULL local_part_data=bbbb
 645 routed by bbbb_0 router
 646   envelope to: bbbb@myhost.test.ex
 647   transport: t1
 648 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 649 routing aaaa@myhost.test.ex
 650 --------> defer router <--------
 651 local_part=aaaa domain=myhost.test.ex
 652 checking local_parts
 653 defer router skipped: local_parts mismatch
 654 --------> unseen_aaaa router <--------
 655 local_part=aaaa domain=myhost.test.ex
 656 checking local_parts
 657 checking "condition" "${if first_delivery{yes}{no}}"...
 658 unseen_aaaa router skipped: condition failure
 659 --------> seen_aaaa router <--------
 660 local_part=aaaa domain=myhost.test.ex
 661 checking local_parts
 662 calling seen_aaaa router
 663 seen_aaaa router called for aaaa@myhost.test.ex
 664   domain = myhost.test.ex
 665 set transport t1
 666 queued for t1 transport: local_part = aaaa
 667 domain = myhost.test.ex
 668   errors_to=NULL
 669   domain_data=NULL local_part_data=aaaa
 670 routed by seen_aaaa router
 671   envelope to: aaaa@myhost.test.ex
 672   transport: t1
 673 locking TESTSUITE/spool/db/retry.lockfile
 674 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 675 Considering: cccc@myhost.test.ex
 676 unique = \0\cccc@myhost.test.ex
 677 cccc@myhost.test.ex: queued for routing
 678 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 679 routing cccc@myhost.test.ex
 680 --------> defer router <--------
 681 local_part=cccc domain=myhost.test.ex
 682 checking local_parts
 683 defer router skipped: local_parts mismatch
 684 --------> unseen_aaaa router <--------
 685 local_part=cccc domain=myhost.test.ex
 686 checking local_parts
 687 unseen_aaaa router skipped: local_parts mismatch
 688 --------> seen_aaaa router <--------
 689 local_part=cccc domain=myhost.test.ex
 690 checking local_parts
 691 seen_aaaa router skipped: local_parts mismatch
 692 --------> bbbb router <--------
 693 local_part=cccc domain=myhost.test.ex
 694 checking local_parts
 695 bbbb router skipped: local_parts mismatch
 696 --------> bbbb_0 router <--------
 697 local_part=cccc domain=myhost.test.ex
 698 checking local_parts
 699 bbbb_0 router skipped: local_parts mismatch
 700 --------> cccc_2nd_time router <--------
 701 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
 702 --------> cccc_redirect router <--------
 703 local_part=cccc domain=myhost.test.ex
 704 checking local_parts
 705 calling cccc_redirect router
 706 rda_interpret (string): 'cccc@$domain, defer_cccc@$domain'
 707 expanded: 'cccc@myhost.test.ex, defer_cccc@myhost.test.ex' (tainted)
 708 file is not a filter file
 709 parse_forward_list: cccc@myhost.test.ex, defer_cccc@myhost.test.ex
 710 extract item: cccc@myhost.test.ex
 711 extract item: defer_cccc@myhost.test.ex
 712 cccc_redirect router generated defer_cccc@myhost.test.ex
 713   errors_to=NULL transport=NULL
 714   uid=unset gid=unset home=NULL
 715 cccc_redirect router generated cccc@myhost.test.ex
 716   errors_to=NULL transport=NULL
 717   uid=unset gid=unset home=NULL
 718 routed by cccc_redirect router
 719   envelope to: cccc@myhost.test.ex
 720   transport: <none>
 721 locking TESTSUITE/spool/db/retry.lockfile
 722 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 723 Considering: cccc@myhost.test.ex
 724 unique = \1\cccc@myhost.test.ex
 725 cccc@myhost.test.ex: queued for routing
 726 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 727 Considering: defer_cccc@myhost.test.ex
 728 unique = defer_cccc@myhost.test.ex
 729 defer_cccc@myhost.test.ex: queued for routing
 730 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 731 routing defer_cccc@myhost.test.ex
 732 --------> defer router <--------
 733 local_part=defer_cccc domain=myhost.test.ex
 734 checking local_parts
 735 calling defer router
 736 rda_interpret (string): ':defer: forced defer'
 737 expanded: ':defer: forced defer'
 738 file is not a filter file
 739 parse_forward_list: :defer: forced defer
 740 extract item: :defer: forced defer
 741 defer router: defer for defer_cccc@myhost.test.ex
 742   message: forced defer
 743 LOG: MAIN
 744   == defer_cccc@myhost.test.ex <cccc@myhost.test.ex> R=defer defer (-1): forced defer
 745 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 746 routing cccc@myhost.test.ex
 747 --------> defer router <--------
 748 local_part=cccc domain=myhost.test.ex
 749 checking local_parts
 750 defer router skipped: local_parts mismatch
 751 --------> unseen_aaaa router <--------
 752 local_part=cccc domain=myhost.test.ex
 753 checking local_parts
 754 unseen_aaaa router skipped: local_parts mismatch
 755 --------> seen_aaaa router <--------
 756 local_part=cccc domain=myhost.test.ex
 757 checking local_parts
 758 seen_aaaa router skipped: local_parts mismatch
 759 --------> bbbb router <--------
 760 local_part=cccc domain=myhost.test.ex
 761 checking local_parts
 762 bbbb router skipped: local_parts mismatch
 763 --------> bbbb_0 router <--------
 764 local_part=cccc domain=myhost.test.ex
 765 checking local_parts
 766 bbbb_0 router skipped: local_parts mismatch
 767 --------> cccc_2nd_time router <--------
 768 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
 769 --------> cccc_redirect router <--------
 770 cccc_redirect router skipped: previously routed cccc@myhost.test.ex
 771 --------> cccc_accept router <--------
 772 local_part=cccc domain=myhost.test.ex
 773 checking local_parts
 774 calling cccc_accept router
 775 cccc_accept router called for cccc@myhost.test.ex
 776   domain = myhost.test.ex
 777 set transport t1
 778 queued for t1 transport: local_part = cccc
 779 domain = myhost.test.ex
 780   errors_to=NULL
 781   domain_data=NULL local_part_data=cccc
 782 routed by cccc_accept router
 783   envelope to: cccc@myhost.test.ex
 784   transport: t1
 785 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 786 After routing:
 787   Local deliveries:
 788     cccc@myhost.test.ex
 789     aaaa@myhost.test.ex
 790     bbbb@myhost.test.ex
 791   Remote deliveries:
 792   Failed addresses:
 793   Deferred addresses:
 794     defer_cccc@myhost.test.ex
 795 cccc@myhost.test.ex was previously delivered (t1 transport): discarded
 796 aaaa@myhost.test.ex was previously delivered (t1 transport): discarded
 797 bbbb@myhost.test.ex was previously delivered (t1 transport): discarded
 798 locking TESTSUITE/spool/db/retry.lockfile
 799 >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 800 LOG: queue_run MAIN
 801   End queue run: pid=pppp -qf
 802 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>