6f85db524303a9f468bd91c81b5930eea3693c50
[exim.git] / test / stderr / 0377
1 Exim version x.yz ....
2 configuration file is TESTSUITE/test-config
3 admin user
4 LOG: MAIN
5   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
6 created log directory TESTSUITE/spool/log
7 Exim version x.yz ....
8 configuration file is TESTSUITE/test-config
9 trusted user
10 admin user
11 dropping to exim gid; retaining priv uid
12 locking TESTSUITE/spool/db/retry.lockfile
13 no retry data available
14 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
15 Considering: aaaa@myhost.test.ex
16 unique = aaaa@myhost.test.ex
17 aaaa@myhost.test.ex: queued for routing
18 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
19 Considering: bbbb@myhost.test.ex
20 unique = bbbb@myhost.test.ex
21 bbbb@myhost.test.ex: queued for routing
22 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
23 Considering: cccc@myhost.test.ex
24 unique = cccc@myhost.test.ex
25 cccc@myhost.test.ex: queued for routing
26 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
27 routing cccc@myhost.test.ex
28 --------> defer router <--------
29 local_part=cccc domain=myhost.test.ex
30 checking local_parts
31 cccc in local_parts? no (end of list)
32 defer router skipped: local_parts mismatch
33 --------> unseen_aaaa router <--------
34 local_part=cccc domain=myhost.test.ex
35 checking local_parts
36 cccc in local_parts? no (end of list)
37 unseen_aaaa router skipped: local_parts mismatch
38 --------> seen_aaaa router <--------
39 local_part=cccc domain=myhost.test.ex
40 checking local_parts
41 cccc in local_parts? no (end of list)
42 seen_aaaa router skipped: local_parts mismatch
43 --------> bbbb router <--------
44 local_part=cccc domain=myhost.test.ex
45 checking local_parts
46 cccc in local_parts? no (end of list)
47 bbbb router skipped: local_parts mismatch
48 --------> bbbb_0 router <--------
49 local_part=cccc domain=myhost.test.ex
50 checking local_parts
51 cccc in local_parts? no (end of list)
52 bbbb_0 router skipped: local_parts mismatch
53 --------> cccc_2nd_time router <--------
54 local_part=cccc domain=myhost.test.ex
55 checking local_parts
56 checking "condition" "${if first_delivery{no}{yes}}"...
57 cccc_2nd_time router skipped: condition failure
58 --------> cccc_redirect router <--------
59 local_part=cccc domain=myhost.test.ex
60 checking local_parts
61 calling cccc_redirect router
62 rda_interpret (string): 'cccc@$domain, defer_cccc@$domain'
63 expanded: 'cccc@myhost.test.ex, defer_cccc@myhost.test.ex' (tainted)
64 file is not a filter file
65 parse_forward_list: cccc@myhost.test.ex, defer_cccc@myhost.test.ex
66 extract item: cccc@myhost.test.ex
67 extract item: defer_cccc@myhost.test.ex
68 cccc_redirect router generated defer_cccc@myhost.test.ex
69   errors_to=NULL transport=NULL
70   uid=unset gid=unset home=NULL
71 cccc_redirect router generated cccc@myhost.test.ex
72   errors_to=NULL transport=NULL
73   uid=unset gid=unset home=NULL
74 routed by cccc_redirect router
75   envelope to: cccc@myhost.test.ex
76   transport: <none>
77 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
78 routing bbbb@myhost.test.ex
79 --------> defer router <--------
80 local_part=bbbb domain=myhost.test.ex
81 checking local_parts
82 bbbb in local_parts? no (end of list)
83 defer router skipped: local_parts mismatch
84 --------> unseen_aaaa router <--------
85 local_part=bbbb domain=myhost.test.ex
86 checking local_parts
87 bbbb in local_parts? no (end of list)
88 unseen_aaaa router skipped: local_parts mismatch
89 --------> seen_aaaa router <--------
90 local_part=bbbb domain=myhost.test.ex
91 checking local_parts
92 bbbb in local_parts? no (end of list)
93 seen_aaaa router skipped: local_parts mismatch
94 --------> bbbb router <--------
95 local_part=bbbb domain=myhost.test.ex
96 checking local_parts
97 checking "condition" "${if first_delivery{yes}{no}}"...
98 calling bbbb router
99 rda_interpret (string): 'bbbb@$domain, defer_bbbb@$domain'
100 expanded: 'bbbb@myhost.test.ex, defer_bbbb@myhost.test.ex' (tainted)
101 file is not a filter file
102 parse_forward_list: bbbb@myhost.test.ex, defer_bbbb@myhost.test.ex
103 extract item: bbbb@myhost.test.ex
104 extract item: defer_bbbb@myhost.test.ex
105 bbbb router generated defer_bbbb@myhost.test.ex
106   errors_to=NULL transport=NULL
107   uid=unset gid=unset home=NULL
108 bbbb router generated bbbb@myhost.test.ex
109   errors_to=NULL transport=NULL
110   uid=unset gid=unset home=NULL
111 routed by bbbb router
112   envelope to: bbbb@myhost.test.ex
113   transport: <none>
114 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
115 routing aaaa@myhost.test.ex
116 --------> defer router <--------
117 local_part=aaaa domain=myhost.test.ex
118 checking local_parts
119 aaaa in local_parts? no (end of list)
120 defer router skipped: local_parts mismatch
121 --------> unseen_aaaa router <--------
122 local_part=aaaa domain=myhost.test.ex
123 checking local_parts
124 checking "condition" "${if first_delivery{yes}{no}}"...
125 calling unseen_aaaa router
126 rda_interpret (string): 'defer_aaaa@$domain'
127 expanded: 'defer_aaaa@myhost.test.ex' (tainted)
128 file is not a filter file
129 parse_forward_list: defer_aaaa@myhost.test.ex
130 extract item: defer_aaaa@myhost.test.ex
131 unseen_aaaa router generated defer_aaaa@myhost.test.ex
132   errors_to=NULL transport=NULL
133   uid=unset gid=unset home=NULL
134 routed by unseen_aaaa router (unseen)
135   envelope to: aaaa@myhost.test.ex
136   transport: <none>
137 "unseen" set: replicated aaaa@myhost.test.ex
138 locking TESTSUITE/spool/db/retry.lockfile
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 locking TESTSUITE/spool/db/retry.lockfile
319 LOG: MAIN
320   => aaaa <aaaa@myhost.test.ex> R=seen_aaaa T=t1
321 locking TESTSUITE/spool/db/retry.lockfile
322 LOG: MAIN
323   => bbbb <bbbb@myhost.test.ex> R=bbbb_0 T=t1
324 locking TESTSUITE/spool/db/retry.lockfile
325 LOG: MAIN
326   => cccc <cccc@myhost.test.ex> R=cccc_accept T=t1
327 locking TESTSUITE/spool/db/retry.lockfile
328 >>>>>>>>>>>>>>>> Exim pid=p1237 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
329 >>>>>>>>>>>>>>>> Exim pid=p1236 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
330 Exim version x.yz ....
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 locking TESTSUITE/spool/db/retry.lockfile
337 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
338 Considering: aaaa@myhost.test.ex
339 unique = aaaa@myhost.test.ex
340 aaaa@myhost.test.ex: queued for routing
341 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
342 Considering: bbbb@myhost.test.ex
343 unique = bbbb@myhost.test.ex
344 bbbb@myhost.test.ex: queued for routing
345 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
346 Considering: cccc@myhost.test.ex
347 unique = cccc@myhost.test.ex
348 cccc@myhost.test.ex: queued for routing
349 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
350 routing cccc@myhost.test.ex
351 --------> defer router <--------
352 local_part=cccc domain=myhost.test.ex
353 checking local_parts
354 cccc in local_parts? no (end of list)
355 defer router skipped: local_parts mismatch
356 --------> unseen_aaaa router <--------
357 local_part=cccc domain=myhost.test.ex
358 checking local_parts
359 cccc in local_parts? no (end of list)
360 unseen_aaaa router skipped: local_parts mismatch
361 --------> seen_aaaa router <--------
362 local_part=cccc domain=myhost.test.ex
363 checking local_parts
364 cccc in local_parts? no (end of list)
365 seen_aaaa router skipped: local_parts mismatch
366 --------> bbbb router <--------
367 local_part=cccc domain=myhost.test.ex
368 checking local_parts
369 cccc in local_parts? no (end of list)
370 bbbb router skipped: local_parts mismatch
371 --------> bbbb_0 router <--------
372 local_part=cccc domain=myhost.test.ex
373 checking local_parts
374 cccc in local_parts? no (end of list)
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' (tainted)
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 bbbb in local_parts? no (end of list)
398 defer router skipped: local_parts mismatch
399 --------> unseen_aaaa router <--------
400 local_part=bbbb domain=myhost.test.ex
401 checking local_parts
402 bbbb in local_parts? no (end of list)
403 unseen_aaaa router skipped: local_parts mismatch
404 --------> seen_aaaa router <--------
405 local_part=bbbb domain=myhost.test.ex
406 checking local_parts
407 bbbb in local_parts? no (end of list)
408 seen_aaaa router skipped: local_parts mismatch
409 --------> bbbb router <--------
410 local_part=bbbb domain=myhost.test.ex
411 checking local_parts
412 checking "condition" "${if first_delivery{yes}{no}}"...
413 bbbb router skipped: condition failure
414 --------> bbbb_0 router <--------
415 local_part=bbbb domain=myhost.test.ex
416 checking local_parts
417 calling bbbb_0 router
418 bbbb_0 router called for bbbb@myhost.test.ex
419   domain = myhost.test.ex
420 set transport t1
421 queued for t1 transport: local_part = bbbb
422 domain = myhost.test.ex
423   errors_to=NULL
424   domain_data=NULL local_part_data=bbbb
425 routed by bbbb_0 router
426   envelope to: bbbb@myhost.test.ex
427   transport: t1
428 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
429 routing aaaa@myhost.test.ex
430 --------> defer router <--------
431 local_part=aaaa domain=myhost.test.ex
432 checking local_parts
433 aaaa in local_parts? no (end of list)
434 defer router skipped: local_parts mismatch
435 --------> unseen_aaaa router <--------
436 local_part=aaaa domain=myhost.test.ex
437 checking local_parts
438 checking "condition" "${if first_delivery{yes}{no}}"...
439 unseen_aaaa router skipped: condition failure
440 --------> seen_aaaa router <--------
441 local_part=aaaa domain=myhost.test.ex
442 checking local_parts
443 calling seen_aaaa router
444 seen_aaaa router called for aaaa@myhost.test.ex
445   domain = myhost.test.ex
446 set transport t1
447 queued for t1 transport: local_part = aaaa
448 domain = myhost.test.ex
449   errors_to=NULL
450   domain_data=NULL local_part_data=aaaa
451 routed by seen_aaaa router
452   envelope to: aaaa@myhost.test.ex
453   transport: t1
454 locking TESTSUITE/spool/db/retry.lockfile
455 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
456 Considering: cccc@myhost.test.ex
457 unique = \0\cccc@myhost.test.ex
458 cccc@myhost.test.ex: queued for routing
459 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
460 routing cccc@myhost.test.ex
461 --------> defer router <--------
462 local_part=cccc domain=myhost.test.ex
463 checking local_parts
464 cccc in local_parts? no (end of list)
465 defer router skipped: local_parts mismatch
466 --------> unseen_aaaa router <--------
467 local_part=cccc domain=myhost.test.ex
468 checking local_parts
469 cccc in local_parts? no (end of list)
470 unseen_aaaa router skipped: local_parts mismatch
471 --------> seen_aaaa router <--------
472 local_part=cccc domain=myhost.test.ex
473 checking local_parts
474 cccc in local_parts? no (end of list)
475 seen_aaaa router skipped: local_parts mismatch
476 --------> bbbb router <--------
477 local_part=cccc domain=myhost.test.ex
478 checking local_parts
479 cccc in local_parts? no (end of list)
480 bbbb router skipped: local_parts mismatch
481 --------> bbbb_0 router <--------
482 local_part=cccc domain=myhost.test.ex
483 checking local_parts
484 cccc in local_parts? no (end of list)
485 bbbb_0 router skipped: local_parts mismatch
486 --------> cccc_2nd_time router <--------
487 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
488 --------> cccc_redirect router <--------
489 local_part=cccc domain=myhost.test.ex
490 checking local_parts
491 calling cccc_redirect router
492 rda_interpret (string): 'cccc@$domain, defer_cccc@$domain'
493 expanded: 'cccc@myhost.test.ex, defer_cccc@myhost.test.ex' (tainted)
494 file is not a filter file
495 parse_forward_list: cccc@myhost.test.ex, defer_cccc@myhost.test.ex
496 extract item: cccc@myhost.test.ex
497 extract item: defer_cccc@myhost.test.ex
498 cccc_redirect router generated defer_cccc@myhost.test.ex
499   errors_to=NULL transport=NULL
500   uid=unset gid=unset home=NULL
501 cccc_redirect router generated cccc@myhost.test.ex
502   errors_to=NULL transport=NULL
503   uid=unset gid=unset home=NULL
504 routed by cccc_redirect router
505   envelope to: cccc@myhost.test.ex
506   transport: <none>
507 locking TESTSUITE/spool/db/retry.lockfile
508 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
509 Considering: cccc@myhost.test.ex
510 unique = \1\cccc@myhost.test.ex
511 cccc@myhost.test.ex: queued for routing
512 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
513 Considering: defer_cccc@myhost.test.ex
514 unique = defer_cccc@myhost.test.ex
515 defer_cccc@myhost.test.ex: queued for routing
516 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
517 routing defer_cccc@myhost.test.ex
518 --------> defer router <--------
519 local_part=defer_cccc domain=myhost.test.ex
520 checking local_parts
521 calling defer router
522 rda_interpret (string): ':defer: forced defer'
523 expanded: ':defer: forced defer'
524 file is not a filter file
525 parse_forward_list: :defer: forced defer
526 extract item: :defer: forced defer
527 defer router: defer for defer_cccc@myhost.test.ex
528   message: forced defer
529 LOG: MAIN
530   == defer_cccc@myhost.test.ex <cccc@myhost.test.ex> R=defer defer (-1): forced defer
531 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
532 routing cccc@myhost.test.ex
533 --------> defer router <--------
534 local_part=cccc domain=myhost.test.ex
535 checking local_parts
536 cccc in local_parts? no (end of list)
537 defer router skipped: local_parts mismatch
538 --------> unseen_aaaa router <--------
539 local_part=cccc domain=myhost.test.ex
540 checking local_parts
541 cccc in local_parts? no (end of list)
542 unseen_aaaa router skipped: local_parts mismatch
543 --------> seen_aaaa router <--------
544 local_part=cccc domain=myhost.test.ex
545 checking local_parts
546 cccc in local_parts? no (end of list)
547 seen_aaaa router skipped: local_parts mismatch
548 --------> bbbb router <--------
549 local_part=cccc domain=myhost.test.ex
550 checking local_parts
551 cccc in local_parts? no (end of list)
552 bbbb router skipped: local_parts mismatch
553 --------> bbbb_0 router <--------
554 local_part=cccc domain=myhost.test.ex
555 checking local_parts
556 cccc in local_parts? no (end of list)
557 bbbb_0 router skipped: local_parts mismatch
558 --------> cccc_2nd_time router <--------
559 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
560 --------> cccc_redirect router <--------
561 cccc_redirect router skipped: previously routed cccc@myhost.test.ex
562 --------> cccc_accept router <--------
563 local_part=cccc domain=myhost.test.ex
564 checking local_parts
565 calling cccc_accept router
566 cccc_accept router called for cccc@myhost.test.ex
567   domain = myhost.test.ex
568 set transport t1
569 queued for t1 transport: local_part = cccc
570 domain = myhost.test.ex
571   errors_to=NULL
572   domain_data=NULL local_part_data=cccc
573 routed by cccc_accept router
574   envelope to: cccc@myhost.test.ex
575   transport: t1
576 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
577 After routing:
578   Local deliveries:
579     cccc@myhost.test.ex
580     aaaa@myhost.test.ex
581     bbbb@myhost.test.ex
582   Remote deliveries:
583   Failed addresses:
584   Deferred addresses:
585     defer_cccc@myhost.test.ex
586 cccc@myhost.test.ex was previously delivered (t1 transport): discarded
587 aaaa@myhost.test.ex was previously delivered (t1 transport): discarded
588 bbbb@myhost.test.ex was previously delivered (t1 transport): discarded
589 locking TESTSUITE/spool/db/retry.lockfile
590 >>>>>>>>>>>>>>>> Exim pid=p1238 (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
591 LOG: queue_run MAIN
592   End queue run: pid=p1234 -qf
593 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
594 Exim version x.yz ....
595 configuration file is TESTSUITE/test-config
596 admin user
597 dropping to exim gid; retaining priv uid
598 LOG: queue_run MAIN
599   Start queue run: pid=p1235 -qf
600 locking TESTSUITE/spool/db/retry.lockfile
601 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
602 Considering: aaaa@myhost.test.ex
603 unique = aaaa@myhost.test.ex
604 aaaa@myhost.test.ex: queued for routing
605 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
606 Considering: bbbb@myhost.test.ex
607 unique = bbbb@myhost.test.ex
608 bbbb@myhost.test.ex: queued for routing
609 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
610 Considering: cccc@myhost.test.ex
611 unique = cccc@myhost.test.ex
612 cccc@myhost.test.ex: queued for routing
613 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
614 routing cccc@myhost.test.ex
615 --------> defer router <--------
616 local_part=cccc domain=myhost.test.ex
617 checking local_parts
618 cccc in local_parts? no (end of list)
619 defer router skipped: local_parts mismatch
620 --------> unseen_aaaa router <--------
621 local_part=cccc domain=myhost.test.ex
622 checking local_parts
623 cccc in local_parts? no (end of list)
624 unseen_aaaa router skipped: local_parts mismatch
625 --------> seen_aaaa router <--------
626 local_part=cccc domain=myhost.test.ex
627 checking local_parts
628 cccc in local_parts? no (end of list)
629 seen_aaaa router skipped: local_parts mismatch
630 --------> bbbb router <--------
631 local_part=cccc domain=myhost.test.ex
632 checking local_parts
633 cccc in local_parts? no (end of list)
634 bbbb router skipped: local_parts mismatch
635 --------> bbbb_0 router <--------
636 local_part=cccc domain=myhost.test.ex
637 checking local_parts
638 cccc in local_parts? no (end of list)
639 bbbb_0 router skipped: local_parts mismatch
640 --------> cccc_2nd_time router <--------
641 local_part=cccc domain=myhost.test.ex
642 checking local_parts
643 checking "condition" "${if first_delivery{no}{yes}}"...
644 calling cccc_2nd_time router
645 rda_interpret (string): '$local_part@$domain'
646 expanded: 'cccc@myhost.test.ex' (tainted)
647 file is not a filter file
648 parse_forward_list: cccc@myhost.test.ex
649 extract item: cccc@myhost.test.ex
650 cccc_2nd_time router generated cccc@myhost.test.ex
651   errors_to=NULL transport=NULL
652   uid=unset gid=unset home=NULL
653 routed by cccc_2nd_time router
654   envelope to: cccc@myhost.test.ex
655   transport: <none>
656 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
657 routing bbbb@myhost.test.ex
658 --------> defer router <--------
659 local_part=bbbb domain=myhost.test.ex
660 checking local_parts
661 bbbb in local_parts? no (end of list)
662 defer router skipped: local_parts mismatch
663 --------> unseen_aaaa router <--------
664 local_part=bbbb domain=myhost.test.ex
665 checking local_parts
666 bbbb in local_parts? no (end of list)
667 unseen_aaaa router skipped: local_parts mismatch
668 --------> seen_aaaa router <--------
669 local_part=bbbb domain=myhost.test.ex
670 checking local_parts
671 bbbb in local_parts? no (end of list)
672 seen_aaaa router skipped: local_parts mismatch
673 --------> bbbb router <--------
674 local_part=bbbb domain=myhost.test.ex
675 checking local_parts
676 checking "condition" "${if first_delivery{yes}{no}}"...
677 bbbb router skipped: condition failure
678 --------> bbbb_0 router <--------
679 local_part=bbbb domain=myhost.test.ex
680 checking local_parts
681 calling bbbb_0 router
682 bbbb_0 router called for bbbb@myhost.test.ex
683   domain = myhost.test.ex
684 set transport t1
685 queued for t1 transport: local_part = bbbb
686 domain = myhost.test.ex
687   errors_to=NULL
688   domain_data=NULL local_part_data=bbbb
689 routed by bbbb_0 router
690   envelope to: bbbb@myhost.test.ex
691   transport: t1
692 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
693 routing aaaa@myhost.test.ex
694 --------> defer router <--------
695 local_part=aaaa domain=myhost.test.ex
696 checking local_parts
697 aaaa in local_parts? no (end of list)
698 defer router skipped: local_parts mismatch
699 --------> unseen_aaaa router <--------
700 local_part=aaaa domain=myhost.test.ex
701 checking local_parts
702 checking "condition" "${if first_delivery{yes}{no}}"...
703 unseen_aaaa router skipped: condition failure
704 --------> seen_aaaa router <--------
705 local_part=aaaa domain=myhost.test.ex
706 checking local_parts
707 calling seen_aaaa router
708 seen_aaaa router called for aaaa@myhost.test.ex
709   domain = myhost.test.ex
710 set transport t1
711 queued for t1 transport: local_part = aaaa
712 domain = myhost.test.ex
713   errors_to=NULL
714   domain_data=NULL local_part_data=aaaa
715 routed by seen_aaaa router
716   envelope to: aaaa@myhost.test.ex
717   transport: t1
718 locking TESTSUITE/spool/db/retry.lockfile
719 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
720 Considering: cccc@myhost.test.ex
721 unique = \0\cccc@myhost.test.ex
722 cccc@myhost.test.ex: queued for routing
723 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
724 routing cccc@myhost.test.ex
725 --------> defer router <--------
726 local_part=cccc domain=myhost.test.ex
727 checking local_parts
728 cccc in local_parts? no (end of list)
729 defer router skipped: local_parts mismatch
730 --------> unseen_aaaa router <--------
731 local_part=cccc domain=myhost.test.ex
732 checking local_parts
733 cccc in local_parts? no (end of list)
734 unseen_aaaa router skipped: local_parts mismatch
735 --------> seen_aaaa router <--------
736 local_part=cccc domain=myhost.test.ex
737 checking local_parts
738 cccc in local_parts? no (end of list)
739 seen_aaaa router skipped: local_parts mismatch
740 --------> bbbb router <--------
741 local_part=cccc domain=myhost.test.ex
742 checking local_parts
743 cccc in local_parts? no (end of list)
744 bbbb router skipped: local_parts mismatch
745 --------> bbbb_0 router <--------
746 local_part=cccc domain=myhost.test.ex
747 checking local_parts
748 cccc in local_parts? no (end of list)
749 bbbb_0 router skipped: local_parts mismatch
750 --------> cccc_2nd_time router <--------
751 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
752 --------> cccc_redirect router <--------
753 local_part=cccc domain=myhost.test.ex
754 checking local_parts
755 calling cccc_redirect router
756 rda_interpret (string): 'cccc@$domain, defer_cccc@$domain'
757 expanded: 'cccc@myhost.test.ex, defer_cccc@myhost.test.ex' (tainted)
758 file is not a filter file
759 parse_forward_list: cccc@myhost.test.ex, defer_cccc@myhost.test.ex
760 extract item: cccc@myhost.test.ex
761 extract item: defer_cccc@myhost.test.ex
762 cccc_redirect router generated defer_cccc@myhost.test.ex
763   errors_to=NULL transport=NULL
764   uid=unset gid=unset home=NULL
765 cccc_redirect router generated cccc@myhost.test.ex
766   errors_to=NULL transport=NULL
767   uid=unset gid=unset home=NULL
768 routed by cccc_redirect router
769   envelope to: cccc@myhost.test.ex
770   transport: <none>
771 locking TESTSUITE/spool/db/retry.lockfile
772 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
773 Considering: cccc@myhost.test.ex
774 unique = \1\cccc@myhost.test.ex
775 cccc@myhost.test.ex: queued for routing
776 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
777 Considering: defer_cccc@myhost.test.ex
778 unique = defer_cccc@myhost.test.ex
779 defer_cccc@myhost.test.ex: queued for routing
780 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
781 routing defer_cccc@myhost.test.ex
782 --------> defer router <--------
783 local_part=defer_cccc domain=myhost.test.ex
784 checking local_parts
785 calling defer router
786 rda_interpret (string): ':defer: forced defer'
787 expanded: ':defer: forced defer'
788 file is not a filter file
789 parse_forward_list: :defer: forced defer
790 extract item: :defer: forced defer
791 defer router: defer for defer_cccc@myhost.test.ex
792   message: forced defer
793 LOG: MAIN
794   == defer_cccc@myhost.test.ex <cccc@myhost.test.ex> R=defer defer (-1): forced defer
795 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
796 routing cccc@myhost.test.ex
797 --------> defer router <--------
798 local_part=cccc domain=myhost.test.ex
799 checking local_parts
800 cccc in local_parts? no (end of list)
801 defer router skipped: local_parts mismatch
802 --------> unseen_aaaa router <--------
803 local_part=cccc domain=myhost.test.ex
804 checking local_parts
805 cccc in local_parts? no (end of list)
806 unseen_aaaa router skipped: local_parts mismatch
807 --------> seen_aaaa router <--------
808 local_part=cccc domain=myhost.test.ex
809 checking local_parts
810 cccc in local_parts? no (end of list)
811 seen_aaaa router skipped: local_parts mismatch
812 --------> bbbb router <--------
813 local_part=cccc domain=myhost.test.ex
814 checking local_parts
815 cccc in local_parts? no (end of list)
816 bbbb router skipped: local_parts mismatch
817 --------> bbbb_0 router <--------
818 local_part=cccc domain=myhost.test.ex
819 checking local_parts
820 cccc in local_parts? no (end of list)
821 bbbb_0 router skipped: local_parts mismatch
822 --------> cccc_2nd_time router <--------
823 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
824 --------> cccc_redirect router <--------
825 cccc_redirect router skipped: previously routed cccc@myhost.test.ex
826 --------> cccc_accept router <--------
827 local_part=cccc domain=myhost.test.ex
828 checking local_parts
829 calling cccc_accept router
830 cccc_accept router called for cccc@myhost.test.ex
831   domain = myhost.test.ex
832 set transport t1
833 queued for t1 transport: local_part = cccc
834 domain = myhost.test.ex
835   errors_to=NULL
836   domain_data=NULL local_part_data=cccc
837 routed by cccc_accept router
838   envelope to: cccc@myhost.test.ex
839   transport: t1
840 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
841 After routing:
842   Local deliveries:
843     cccc@myhost.test.ex
844     aaaa@myhost.test.ex
845     bbbb@myhost.test.ex
846   Remote deliveries:
847   Failed addresses:
848   Deferred addresses:
849     defer_cccc@myhost.test.ex
850 cccc@myhost.test.ex was previously delivered (t1 transport): discarded
851 aaaa@myhost.test.ex was previously delivered (t1 transport): discarded
852 bbbb@myhost.test.ex was previously delivered (t1 transport): discarded
853 locking TESTSUITE/spool/db/retry.lockfile
854 >>>>>>>>>>>>>>>> Exim pid=p1239 (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
855 LOG: queue_run MAIN
856   End queue run: pid=p1235 -qf
857 >>>>>>>>>>>>>>>> Exim pid=p1235 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>