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