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