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