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