Hintsdb sqlite: use transaction rather than file lock
[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 LOG: MAIN
319   => aaaa <aaaa@myhost.test.ex> R=seen_aaaa T=t1
320 LOG: MAIN
321   => bbbb <bbbb@myhost.test.ex> R=bbbb_0 T=t1
322 LOG: MAIN
323   => cccc <cccc@myhost.test.ex> R=cccc_accept T=t1
324 >>>>>>>>>>>>>>>> Exim pid=p1237 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
325 >>>>>>>>>>>>>>>> Exim pid=p1236 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
326 Exim version x.yz ....
327 Hints DB:
328 configuration file is TESTSUITE/test-config
329 admin user
330 dropping to exim gid; retaining priv uid
331 LOG: queue_run MAIN
332   Start queue run: pid=p1234 -qf
333 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
334 Considering: aaaa@myhost.test.ex
335 unique = aaaa@myhost.test.ex
336 aaaa@myhost.test.ex: queued for routing
337 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
338 Considering: bbbb@myhost.test.ex
339 unique = bbbb@myhost.test.ex
340 bbbb@myhost.test.ex: queued for routing
341 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
342 Considering: cccc@myhost.test.ex
343 unique = cccc@myhost.test.ex
344 cccc@myhost.test.ex: queued for routing
345 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
346 routing cccc@myhost.test.ex
347 --------> defer router <--------
348 local_part=cccc domain=myhost.test.ex
349 checking local_parts
350 cccc in local_parts? no (end of list)
351 defer router skipped: local_parts mismatch
352 --------> unseen_aaaa router <--------
353 local_part=cccc domain=myhost.test.ex
354 checking local_parts
355 cccc in local_parts? no (end of list)
356 unseen_aaaa router skipped: local_parts mismatch
357 --------> seen_aaaa router <--------
358 local_part=cccc domain=myhost.test.ex
359 checking local_parts
360 cccc in local_parts? no (end of list)
361 seen_aaaa router skipped: local_parts mismatch
362 --------> bbbb router <--------
363 local_part=cccc domain=myhost.test.ex
364 checking local_parts
365 cccc in local_parts? no (end of list)
366 bbbb router skipped: local_parts mismatch
367 --------> bbbb_0 router <--------
368 local_part=cccc domain=myhost.test.ex
369 checking local_parts
370 cccc in local_parts? no (end of list)
371 bbbb_0 router skipped: local_parts mismatch
372 --------> cccc_2nd_time router <--------
373 local_part=cccc domain=myhost.test.ex
374 checking local_parts
375 checking "condition" "${if first_delivery{no}{yes}}"...
376 calling cccc_2nd_time router
377 rda_interpret (string): '$local_part@$domain'
378 expanded: 'cccc@myhost.test.ex' (tainted)
379 file is not a filter file
380 parse_forward_list: cccc@myhost.test.ex
381 extract item: cccc@myhost.test.ex
382 cccc_2nd_time router generated cccc@myhost.test.ex
383   errors_to=NULL transport=NULL
384   uid=unset gid=unset home=NULL
385 routed by cccc_2nd_time router
386   envelope to: cccc@myhost.test.ex
387   transport: <none>
388 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
389 routing bbbb@myhost.test.ex
390 --------> defer router <--------
391 local_part=bbbb domain=myhost.test.ex
392 checking local_parts
393 bbbb in local_parts? no (end of list)
394 defer router skipped: local_parts mismatch
395 --------> unseen_aaaa router <--------
396 local_part=bbbb domain=myhost.test.ex
397 checking local_parts
398 bbbb in local_parts? no (end of list)
399 unseen_aaaa router skipped: local_parts mismatch
400 --------> seen_aaaa router <--------
401 local_part=bbbb domain=myhost.test.ex
402 checking local_parts
403 bbbb in local_parts? no (end of list)
404 seen_aaaa router skipped: local_parts mismatch
405 --------> bbbb router <--------
406 local_part=bbbb domain=myhost.test.ex
407 checking local_parts
408 checking "condition" "${if first_delivery{yes}{no}}"...
409 bbbb router skipped: condition failure
410 --------> bbbb_0 router <--------
411 local_part=bbbb domain=myhost.test.ex
412 checking local_parts
413 calling bbbb_0 router
414 bbbb_0 router called for bbbb@myhost.test.ex
415   domain = myhost.test.ex
416 set transport t1
417 queued for t1 transport: local_part = bbbb
418 domain = myhost.test.ex
419   errors_to=NULL
420   domain_data=NULL local_part_data=bbbb
421 routed by bbbb_0 router
422   envelope to: bbbb@myhost.test.ex
423   transport: t1
424 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
425 routing aaaa@myhost.test.ex
426 --------> defer router <--------
427 local_part=aaaa domain=myhost.test.ex
428 checking local_parts
429 aaaa in local_parts? no (end of list)
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 local_part_data=aaaa
447 routed by seen_aaaa router
448   envelope to: aaaa@myhost.test.ex
449   transport: t1
450 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
451 Considering: cccc@myhost.test.ex
452 unique = \0\cccc@myhost.test.ex
453 cccc@myhost.test.ex: queued for routing
454 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
455 routing cccc@myhost.test.ex
456 --------> defer router <--------
457 local_part=cccc domain=myhost.test.ex
458 checking local_parts
459 cccc in local_parts? no (end of list)
460 defer router skipped: local_parts mismatch
461 --------> unseen_aaaa router <--------
462 local_part=cccc domain=myhost.test.ex
463 checking local_parts
464 cccc in local_parts? no (end of list)
465 unseen_aaaa router skipped: local_parts mismatch
466 --------> seen_aaaa router <--------
467 local_part=cccc domain=myhost.test.ex
468 checking local_parts
469 cccc in local_parts? no (end of list)
470 seen_aaaa router skipped: local_parts mismatch
471 --------> bbbb router <--------
472 local_part=cccc domain=myhost.test.ex
473 checking local_parts
474 cccc in local_parts? no (end of list)
475 bbbb router skipped: local_parts mismatch
476 --------> bbbb_0 router <--------
477 local_part=cccc domain=myhost.test.ex
478 checking local_parts
479 cccc in local_parts? no (end of list)
480 bbbb_0 router skipped: local_parts mismatch
481 --------> cccc_2nd_time router <--------
482 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
483 --------> cccc_redirect router <--------
484 local_part=cccc domain=myhost.test.ex
485 checking local_parts
486 calling cccc_redirect router
487 rda_interpret (string): 'cccc@$domain, defer_cccc@$domain'
488 expanded: 'cccc@myhost.test.ex, defer_cccc@myhost.test.ex' (tainted)
489 file is not a filter file
490 parse_forward_list: cccc@myhost.test.ex, defer_cccc@myhost.test.ex
491 extract item: cccc@myhost.test.ex
492 extract item: defer_cccc@myhost.test.ex
493 cccc_redirect router generated defer_cccc@myhost.test.ex
494   errors_to=NULL transport=NULL
495   uid=unset gid=unset home=NULL
496 cccc_redirect router generated cccc@myhost.test.ex
497   errors_to=NULL transport=NULL
498   uid=unset gid=unset home=NULL
499 routed by cccc_redirect router
500   envelope to: cccc@myhost.test.ex
501   transport: <none>
502 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
503 Considering: cccc@myhost.test.ex
504 unique = \1\cccc@myhost.test.ex
505 cccc@myhost.test.ex: queued for routing
506 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
507 Considering: defer_cccc@myhost.test.ex
508 unique = defer_cccc@myhost.test.ex
509 defer_cccc@myhost.test.ex: queued for routing
510 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
511 routing defer_cccc@myhost.test.ex
512 --------> defer router <--------
513 local_part=defer_cccc domain=myhost.test.ex
514 checking local_parts
515 calling defer router
516 rda_interpret (string): ':defer: forced defer'
517 expanded: ':defer: forced defer'
518 file is not a filter file
519 parse_forward_list: :defer: forced defer
520 extract item: :defer: forced defer
521 defer router: defer for defer_cccc@myhost.test.ex
522   message: forced defer
523 LOG: MAIN
524   == defer_cccc@myhost.test.ex <cccc@myhost.test.ex> R=defer defer (-1): forced defer
525 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
526 routing cccc@myhost.test.ex
527 --------> defer router <--------
528 local_part=cccc domain=myhost.test.ex
529 checking local_parts
530 cccc in local_parts? no (end of list)
531 defer router skipped: local_parts mismatch
532 --------> unseen_aaaa router <--------
533 local_part=cccc domain=myhost.test.ex
534 checking local_parts
535 cccc in local_parts? no (end of list)
536 unseen_aaaa router skipped: local_parts mismatch
537 --------> seen_aaaa router <--------
538 local_part=cccc domain=myhost.test.ex
539 checking local_parts
540 cccc in local_parts? no (end of list)
541 seen_aaaa router skipped: local_parts mismatch
542 --------> bbbb router <--------
543 local_part=cccc domain=myhost.test.ex
544 checking local_parts
545 cccc in local_parts? no (end of list)
546 bbbb router skipped: local_parts mismatch
547 --------> bbbb_0 router <--------
548 local_part=cccc domain=myhost.test.ex
549 checking local_parts
550 cccc in local_parts? no (end of list)
551 bbbb_0 router skipped: local_parts mismatch
552 --------> cccc_2nd_time router <--------
553 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
554 --------> cccc_redirect router <--------
555 cccc_redirect router skipped: previously routed cccc@myhost.test.ex
556 --------> cccc_accept router <--------
557 local_part=cccc domain=myhost.test.ex
558 checking local_parts
559 calling cccc_accept router
560 cccc_accept router called for cccc@myhost.test.ex
561   domain = myhost.test.ex
562 set transport t1
563 queued for t1 transport: local_part = cccc
564 domain = myhost.test.ex
565   errors_to=NULL
566   domain_data=NULL local_part_data=cccc
567 routed by cccc_accept router
568   envelope to: cccc@myhost.test.ex
569   transport: t1
570 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
571 After routing:
572   Local deliveries:
573     cccc@myhost.test.ex
574     aaaa@myhost.test.ex
575     bbbb@myhost.test.ex
576   Remote deliveries:
577   Failed addresses:
578   Deferred addresses:
579     defer_cccc@myhost.test.ex
580 cccc@myhost.test.ex was previously delivered (t1 transport): discarded
581 aaaa@myhost.test.ex was previously delivered (t1 transport): discarded
582 bbbb@myhost.test.ex was previously delivered (t1 transport): discarded
583 >>>>>>>>>>>>>>>> Exim pid=p1238 (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
584 LOG: queue_run MAIN
585   End queue run: pid=p1234 -qf
586 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
587 Exim version x.yz ....
588 Hints DB:
589 configuration file is TESTSUITE/test-config
590 admin user
591 dropping to exim gid; retaining priv uid
592 LOG: queue_run MAIN
593   Start queue run: pid=p1235 -qf
594 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
595 Considering: aaaa@myhost.test.ex
596 unique = aaaa@myhost.test.ex
597 aaaa@myhost.test.ex: queued for routing
598 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
599 Considering: bbbb@myhost.test.ex
600 unique = bbbb@myhost.test.ex
601 bbbb@myhost.test.ex: queued for routing
602 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
603 Considering: cccc@myhost.test.ex
604 unique = cccc@myhost.test.ex
605 cccc@myhost.test.ex: queued for routing
606 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
607 routing cccc@myhost.test.ex
608 --------> defer router <--------
609 local_part=cccc domain=myhost.test.ex
610 checking local_parts
611 cccc in local_parts? no (end of list)
612 defer router skipped: local_parts mismatch
613 --------> unseen_aaaa router <--------
614 local_part=cccc domain=myhost.test.ex
615 checking local_parts
616 cccc in local_parts? no (end of list)
617 unseen_aaaa router skipped: local_parts mismatch
618 --------> seen_aaaa router <--------
619 local_part=cccc domain=myhost.test.ex
620 checking local_parts
621 cccc in local_parts? no (end of list)
622 seen_aaaa router skipped: local_parts mismatch
623 --------> bbbb router <--------
624 local_part=cccc domain=myhost.test.ex
625 checking local_parts
626 cccc in local_parts? no (end of list)
627 bbbb router skipped: local_parts mismatch
628 --------> bbbb_0 router <--------
629 local_part=cccc domain=myhost.test.ex
630 checking local_parts
631 cccc in local_parts? no (end of list)
632 bbbb_0 router skipped: local_parts mismatch
633 --------> cccc_2nd_time router <--------
634 local_part=cccc domain=myhost.test.ex
635 checking local_parts
636 checking "condition" "${if first_delivery{no}{yes}}"...
637 calling cccc_2nd_time router
638 rda_interpret (string): '$local_part@$domain'
639 expanded: 'cccc@myhost.test.ex' (tainted)
640 file is not a filter file
641 parse_forward_list: cccc@myhost.test.ex
642 extract item: cccc@myhost.test.ex
643 cccc_2nd_time router generated cccc@myhost.test.ex
644   errors_to=NULL transport=NULL
645   uid=unset gid=unset home=NULL
646 routed by cccc_2nd_time router
647   envelope to: cccc@myhost.test.ex
648   transport: <none>
649 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
650 routing bbbb@myhost.test.ex
651 --------> defer router <--------
652 local_part=bbbb domain=myhost.test.ex
653 checking local_parts
654 bbbb in local_parts? no (end of list)
655 defer router skipped: local_parts mismatch
656 --------> unseen_aaaa router <--------
657 local_part=bbbb domain=myhost.test.ex
658 checking local_parts
659 bbbb in local_parts? no (end of list)
660 unseen_aaaa router skipped: local_parts mismatch
661 --------> seen_aaaa router <--------
662 local_part=bbbb domain=myhost.test.ex
663 checking local_parts
664 bbbb in local_parts? no (end of list)
665 seen_aaaa router skipped: local_parts mismatch
666 --------> bbbb router <--------
667 local_part=bbbb domain=myhost.test.ex
668 checking local_parts
669 checking "condition" "${if first_delivery{yes}{no}}"...
670 bbbb router skipped: condition failure
671 --------> bbbb_0 router <--------
672 local_part=bbbb domain=myhost.test.ex
673 checking local_parts
674 calling bbbb_0 router
675 bbbb_0 router called for bbbb@myhost.test.ex
676   domain = myhost.test.ex
677 set transport t1
678 queued for t1 transport: local_part = bbbb
679 domain = myhost.test.ex
680   errors_to=NULL
681   domain_data=NULL local_part_data=bbbb
682 routed by bbbb_0 router
683   envelope to: bbbb@myhost.test.ex
684   transport: t1
685 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
686 routing aaaa@myhost.test.ex
687 --------> defer router <--------
688 local_part=aaaa domain=myhost.test.ex
689 checking local_parts
690 aaaa in local_parts? no (end of list)
691 defer router skipped: local_parts mismatch
692 --------> unseen_aaaa router <--------
693 local_part=aaaa domain=myhost.test.ex
694 checking local_parts
695 checking "condition" "${if first_delivery{yes}{no}}"...
696 unseen_aaaa router skipped: condition failure
697 --------> seen_aaaa router <--------
698 local_part=aaaa domain=myhost.test.ex
699 checking local_parts
700 calling seen_aaaa router
701 seen_aaaa router called for aaaa@myhost.test.ex
702   domain = myhost.test.ex
703 set transport t1
704 queued for t1 transport: local_part = aaaa
705 domain = myhost.test.ex
706   errors_to=NULL
707   domain_data=NULL local_part_data=aaaa
708 routed by seen_aaaa router
709   envelope to: aaaa@myhost.test.ex
710   transport: t1
711 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
712 Considering: cccc@myhost.test.ex
713 unique = \0\cccc@myhost.test.ex
714 cccc@myhost.test.ex: queued for routing
715 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
716 routing cccc@myhost.test.ex
717 --------> defer router <--------
718 local_part=cccc domain=myhost.test.ex
719 checking local_parts
720 cccc in local_parts? no (end of list)
721 defer router skipped: local_parts mismatch
722 --------> unseen_aaaa router <--------
723 local_part=cccc domain=myhost.test.ex
724 checking local_parts
725 cccc in local_parts? no (end of list)
726 unseen_aaaa router skipped: local_parts mismatch
727 --------> seen_aaaa router <--------
728 local_part=cccc domain=myhost.test.ex
729 checking local_parts
730 cccc in local_parts? no (end of list)
731 seen_aaaa router skipped: local_parts mismatch
732 --------> bbbb router <--------
733 local_part=cccc domain=myhost.test.ex
734 checking local_parts
735 cccc in local_parts? no (end of list)
736 bbbb router skipped: local_parts mismatch
737 --------> bbbb_0 router <--------
738 local_part=cccc domain=myhost.test.ex
739 checking local_parts
740 cccc in local_parts? no (end of list)
741 bbbb_0 router skipped: local_parts mismatch
742 --------> cccc_2nd_time router <--------
743 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
744 --------> cccc_redirect router <--------
745 local_part=cccc domain=myhost.test.ex
746 checking local_parts
747 calling cccc_redirect router
748 rda_interpret (string): 'cccc@$domain, defer_cccc@$domain'
749 expanded: 'cccc@myhost.test.ex, defer_cccc@myhost.test.ex' (tainted)
750 file is not a filter file
751 parse_forward_list: cccc@myhost.test.ex, defer_cccc@myhost.test.ex
752 extract item: cccc@myhost.test.ex
753 extract item: defer_cccc@myhost.test.ex
754 cccc_redirect router generated defer_cccc@myhost.test.ex
755   errors_to=NULL transport=NULL
756   uid=unset gid=unset home=NULL
757 cccc_redirect router generated cccc@myhost.test.ex
758   errors_to=NULL transport=NULL
759   uid=unset gid=unset home=NULL
760 routed by cccc_redirect router
761   envelope to: cccc@myhost.test.ex
762   transport: <none>
763 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
764 Considering: cccc@myhost.test.ex
765 unique = \1\cccc@myhost.test.ex
766 cccc@myhost.test.ex: queued for routing
767 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
768 Considering: defer_cccc@myhost.test.ex
769 unique = defer_cccc@myhost.test.ex
770 defer_cccc@myhost.test.ex: queued for routing
771 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
772 routing defer_cccc@myhost.test.ex
773 --------> defer router <--------
774 local_part=defer_cccc domain=myhost.test.ex
775 checking local_parts
776 calling defer router
777 rda_interpret (string): ':defer: forced defer'
778 expanded: ':defer: forced defer'
779 file is not a filter file
780 parse_forward_list: :defer: forced defer
781 extract item: :defer: forced defer
782 defer router: defer for defer_cccc@myhost.test.ex
783   message: forced defer
784 LOG: MAIN
785   == defer_cccc@myhost.test.ex <cccc@myhost.test.ex> R=defer defer (-1): forced defer
786 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
787 routing cccc@myhost.test.ex
788 --------> defer router <--------
789 local_part=cccc domain=myhost.test.ex
790 checking local_parts
791 cccc in local_parts? no (end of list)
792 defer router skipped: local_parts mismatch
793 --------> unseen_aaaa router <--------
794 local_part=cccc domain=myhost.test.ex
795 checking local_parts
796 cccc in local_parts? no (end of list)
797 unseen_aaaa router skipped: local_parts mismatch
798 --------> seen_aaaa router <--------
799 local_part=cccc domain=myhost.test.ex
800 checking local_parts
801 cccc in local_parts? no (end of list)
802 seen_aaaa router skipped: local_parts mismatch
803 --------> bbbb router <--------
804 local_part=cccc domain=myhost.test.ex
805 checking local_parts
806 cccc in local_parts? no (end of list)
807 bbbb router skipped: local_parts mismatch
808 --------> bbbb_0 router <--------
809 local_part=cccc domain=myhost.test.ex
810 checking local_parts
811 cccc in local_parts? no (end of list)
812 bbbb_0 router skipped: local_parts mismatch
813 --------> cccc_2nd_time router <--------
814 cccc_2nd_time router skipped: previously routed cccc@myhost.test.ex
815 --------> cccc_redirect router <--------
816 cccc_redirect router skipped: previously routed cccc@myhost.test.ex
817 --------> cccc_accept router <--------
818 local_part=cccc domain=myhost.test.ex
819 checking local_parts
820 calling cccc_accept router
821 cccc_accept router called for cccc@myhost.test.ex
822   domain = myhost.test.ex
823 set transport t1
824 queued for t1 transport: local_part = cccc
825 domain = myhost.test.ex
826   errors_to=NULL
827   domain_data=NULL local_part_data=cccc
828 routed by cccc_accept router
829   envelope to: cccc@myhost.test.ex
830   transport: t1
831 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
832 After routing:
833   Local deliveries:
834     cccc@myhost.test.ex
835     aaaa@myhost.test.ex
836     bbbb@myhost.test.ex
837   Remote deliveries:
838   Failed addresses:
839   Deferred addresses:
840     defer_cccc@myhost.test.ex
841 cccc@myhost.test.ex was previously delivered (t1 transport): discarded
842 aaaa@myhost.test.ex was previously delivered (t1 transport): discarded
843 bbbb@myhost.test.ex was previously delivered (t1 transport): discarded
844 >>>>>>>>>>>>>>>> Exim pid=p1239 (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
845 LOG: queue_run MAIN
846   End queue run: pid=p1235 -qf
847 >>>>>>>>>>>>>>>> Exim pid=p1235 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>