Testsuite: wait for queue runner finish (more)
[users/jgh/exim.git] / test / stderr / 0375
1 Exim version x.yz ....
2 configuration file is TESTSUITE/test-config
3 admin user
4 DSN: u1 propagating DSN
5 DSN: ut2 propagating DSN
6 DSN: ut3 propagating DSN
7 DSN: ut4 propagating DSN
8 DSN: ut5 propagating DSN
9 DSN: ut6 propagating DSN
10 DSN: ut7 propagating DSN
11 DSN: ut8 propagating DSN
12 DSN: real propagating DSN
13 LOG: MAIN
14   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
15 created log directory TESTSUITE/spool/log
16 Exim version x.yz ....
17 configuration file is TESTSUITE/test-config
18 trusted user
19 admin user
20 DSN: u1 propagating DSN
21 DSN: ut2 propagating DSN
22 DSN: ut3 propagating DSN
23 DSN: ut4 propagating DSN
24 DSN: ut5 propagating DSN
25 DSN: ut6 propagating DSN
26 DSN: ut7 propagating DSN
27 DSN: ut8 propagating DSN
28 DSN: real propagating DSN
29 locking TESTSUITE/spool/db/retry.lockfile
30 no retry data available
31 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
32 Considering: a1@myhost.test.ex
33 unique = a1@myhost.test.ex
34 a1@myhost.test.ex: queued for routing
35 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
36 Considering: b1@myhost.test.ex
37 unique = b1@myhost.test.ex
38 b1@myhost.test.ex: queued for routing
39 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
40 Considering: c1@myhost.test.ex
41 unique = c1@myhost.test.ex
42 c1@myhost.test.ex: queued for routing
43 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
44 Considering: d1@myhost.test.ex
45 unique = d1@myhost.test.ex
46 d1@myhost.test.ex: queued for routing
47 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
48 Considering: d2@myhost.test.ex
49 unique = d2@myhost.test.ex
50 d2@myhost.test.ex: queued for routing
51 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
52 Considering: d3@myhost.test.ex
53 unique = d3@myhost.test.ex
54 d3@myhost.test.ex: queued for routing
55 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
56 Considering: e1@myhost.test.ex
57 unique = e1@myhost.test.ex
58 e1@myhost.test.ex: queued for routing
59 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
60 Considering: f1@myhost.test.ex
61 unique = f1@myhost.test.ex
62 f1@myhost.test.ex: queued for routing
63 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
64 Considering: f2@myhost.test.ex
65 unique = f2@myhost.test.ex
66 f2@myhost.test.ex: queued for routing
67 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
68 Considering: f3@myhost.test.ex
69 unique = f3@myhost.test.ex
70 f3@myhost.test.ex: queued for routing
71 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
72 Considering: g1@myhost.test.ex
73 unique = g1@myhost.test.ex
74 g1@myhost.test.ex: queued for routing
75 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
76 routing g1@myhost.test.ex
77 --------> u1 router <--------
78 local_part=g1 domain=myhost.test.ex
79 checking local_parts
80 u1 router skipped: local_parts mismatch
81 --------> ut2 router <--------
82 local_part=g1 domain=myhost.test.ex
83 checking local_parts
84 ut2 router skipped: local_parts mismatch
85 --------> ut3 router <--------
86 local_part=g1 domain=myhost.test.ex
87 checking local_parts
88 ut3 router skipped: local_parts mismatch
89 --------> ut4 router <--------
90 local_part=g1 domain=myhost.test.ex
91 checking local_parts
92 ut4 router skipped: local_parts mismatch
93 --------> ut5 router <--------
94 local_part=g1 domain=myhost.test.ex
95 checking local_parts
96 ut5 router skipped: local_parts mismatch
97 --------> ut6 router <--------
98 local_part=g1 domain=myhost.test.ex
99 checking local_parts
100 ut6 router skipped: local_parts mismatch
101 --------> ut7 router <--------
102 local_part=g1 domain=myhost.test.ex
103 checking local_parts
104 processing address_data
105 LOG: MAIN
106   == g1@myhost.test.ex R=ut7 defer (-1): expansion of "$bad expansion" failed in ut7 router: unknown variable name "bad"
107 log writing disabled
108 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
109 routing f3@myhost.test.ex
110 --------> u1 router <--------
111 local_part=f3 domain=myhost.test.ex
112 checking local_parts
113 u1 router skipped: local_parts mismatch
114 --------> ut2 router <--------
115 local_part=f3 domain=myhost.test.ex
116 checking local_parts
117 ut2 router skipped: local_parts mismatch
118 --------> ut3 router <--------
119 local_part=f3 domain=myhost.test.ex
120 checking local_parts
121 ut3 router skipped: local_parts mismatch
122 --------> ut4 router <--------
123 local_part=f3 domain=myhost.test.ex
124 checking local_parts
125 ut4 router skipped: local_parts mismatch
126 --------> ut5 router <--------
127 local_part=f3 domain=myhost.test.ex
128 checking local_parts
129 ut5 router skipped: local_parts mismatch
130 --------> ut6 router <--------
131 local_part=f3 domain=myhost.test.ex
132 checking local_parts
133 processing address_data
134 calling ut6 router
135 ut6 router called for f3@myhost.test.ex
136   domain = myhost.test.ex
137 set transport ut6
138 queued for ut6 transport: local_part = f3
139 domain = myhost.test.ex
140   errors_to=
141   domain_data=NULL localpart_data=NULL
142 routed by ut6 router (unseen)
143   envelope to: f3@myhost.test.ex
144   transport: ut6
145   errors to 
146 "unseen" set: replicated f3@myhost.test.ex
147 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
148 routing f2@myhost.test.ex
149 --------> u1 router <--------
150 local_part=f2 domain=myhost.test.ex
151 checking local_parts
152 u1 router skipped: local_parts mismatch
153 --------> ut2 router <--------
154 local_part=f2 domain=myhost.test.ex
155 checking local_parts
156 ut2 router skipped: local_parts mismatch
157 --------> ut3 router <--------
158 local_part=f2 domain=myhost.test.ex
159 checking local_parts
160 ut3 router skipped: local_parts mismatch
161 --------> ut4 router <--------
162 local_part=f2 domain=myhost.test.ex
163 checking local_parts
164 ut4 router skipped: local_parts mismatch
165 --------> ut5 router <--------
166 local_part=f2 domain=myhost.test.ex
167 checking local_parts
168 ut5 router skipped: local_parts mismatch
169 --------> ut6 router <--------
170 local_part=f2 domain=myhost.test.ex
171 checking local_parts
172 processing address_data
173 calling ut6 router
174 ut6 router called for f2@myhost.test.ex
175   domain = myhost.test.ex
176 queued for ut6 transport: local_part = f2
177 domain = myhost.test.ex
178   errors_to=
179   domain_data=NULL localpart_data=NULL
180 routed by ut6 router (unseen)
181   envelope to: f2@myhost.test.ex
182   transport: ut6
183   errors to 
184 "unseen" set: replicated f2@myhost.test.ex
185 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
186 routing f1@myhost.test.ex
187 --------> u1 router <--------
188 local_part=f1 domain=myhost.test.ex
189 checking local_parts
190 u1 router skipped: local_parts mismatch
191 --------> ut2 router <--------
192 local_part=f1 domain=myhost.test.ex
193 checking local_parts
194 ut2 router skipped: local_parts mismatch
195 --------> ut3 router <--------
196 local_part=f1 domain=myhost.test.ex
197 checking local_parts
198 ut3 router skipped: local_parts mismatch
199 --------> ut4 router <--------
200 local_part=f1 domain=myhost.test.ex
201 checking local_parts
202 ut4 router skipped: local_parts mismatch
203 --------> ut5 router <--------
204 local_part=f1 domain=myhost.test.ex
205 checking local_parts
206 ut5 router skipped: local_parts mismatch
207 --------> ut6 router <--------
208 local_part=f1 domain=myhost.test.ex
209 checking local_parts
210 processing address_data
211 calling ut6 router
212 ut6 router called for f1@myhost.test.ex
213   domain = myhost.test.ex
214 queued for ut6 transport: local_part = f1
215 domain = myhost.test.ex
216   errors_to=
217   domain_data=NULL localpart_data=NULL
218 routed by ut6 router (unseen)
219   envelope to: f1@myhost.test.ex
220   transport: ut6
221   errors to 
222 "unseen" set: replicated f1@myhost.test.ex
223 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
224 routing e1@myhost.test.ex
225 --------> u1 router <--------
226 local_part=e1 domain=myhost.test.ex
227 checking local_parts
228 u1 router skipped: local_parts mismatch
229 --------> ut2 router <--------
230 local_part=e1 domain=myhost.test.ex
231 checking local_parts
232 ut2 router skipped: local_parts mismatch
233 --------> ut3 router <--------
234 local_part=e1 domain=myhost.test.ex
235 checking local_parts
236 ut3 router skipped: local_parts mismatch
237 --------> ut4 router <--------
238 local_part=e1 domain=myhost.test.ex
239 checking local_parts
240 ut4 router skipped: local_parts mismatch
241 --------> ut5 router <--------
242 local_part=e1 domain=myhost.test.ex
243 checking local_parts
244 calling ut5 router
245 ut5 router called for e1@myhost.test.ex
246   domain = myhost.test.ex
247 set transport ut5
248 queued for ut5 transport: local_part = e1
249 domain = myhost.test.ex
250   errors_to=NULL
251   domain_data=NULL localpart_data=NULL
252 routed by ut5 router (unseen)
253   envelope to: e1@myhost.test.ex
254   transport: ut5
255 "unseen" set: replicated e1@myhost.test.ex
256 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
257 routing d3@myhost.test.ex
258 --------> u1 router <--------
259 local_part=d3 domain=myhost.test.ex
260 checking local_parts
261 u1 router skipped: local_parts mismatch
262 --------> ut2 router <--------
263 local_part=d3 domain=myhost.test.ex
264 checking local_parts
265 ut2 router skipped: local_parts mismatch
266 --------> ut3 router <--------
267 local_part=d3 domain=myhost.test.ex
268 checking local_parts
269 ut3 router skipped: local_parts mismatch
270 --------> ut4 router <--------
271 local_part=d3 domain=myhost.test.ex
272 checking local_parts
273 calling ut4 router
274 ut4 router called for d3@myhost.test.ex
275   domain = myhost.test.ex
276 set transport ut4
277 queued for ut4 transport: local_part = d3
278 domain = myhost.test.ex
279   errors_to=
280   domain_data=NULL localpart_data=NULL
281 routed by ut4 router (unseen)
282   envelope to: d3@myhost.test.ex
283   transport: ut4
284   errors to 
285 "unseen" set: replicated d3@myhost.test.ex
286 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
287 routing d2@myhost.test.ex
288 --------> u1 router <--------
289 local_part=d2 domain=myhost.test.ex
290 checking local_parts
291 u1 router skipped: local_parts mismatch
292 --------> ut2 router <--------
293 local_part=d2 domain=myhost.test.ex
294 checking local_parts
295 ut2 router skipped: local_parts mismatch
296 --------> ut3 router <--------
297 local_part=d2 domain=myhost.test.ex
298 checking local_parts
299 ut3 router skipped: local_parts mismatch
300 --------> ut4 router <--------
301 local_part=d2 domain=myhost.test.ex
302 checking local_parts
303 calling ut4 router
304 ut4 router called for d2@myhost.test.ex
305   domain = myhost.test.ex
306 queued for ut4 transport: local_part = d2
307 domain = myhost.test.ex
308   errors_to=
309   domain_data=NULL localpart_data=NULL
310 routed by ut4 router (unseen)
311   envelope to: d2@myhost.test.ex
312   transport: ut4
313   errors to 
314 "unseen" set: replicated d2@myhost.test.ex
315 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
316 routing d1@myhost.test.ex
317 --------> u1 router <--------
318 local_part=d1 domain=myhost.test.ex
319 checking local_parts
320 u1 router skipped: local_parts mismatch
321 --------> ut2 router <--------
322 local_part=d1 domain=myhost.test.ex
323 checking local_parts
324 ut2 router skipped: local_parts mismatch
325 --------> ut3 router <--------
326 local_part=d1 domain=myhost.test.ex
327 checking local_parts
328 ut3 router skipped: local_parts mismatch
329 --------> ut4 router <--------
330 local_part=d1 domain=myhost.test.ex
331 checking local_parts
332 calling ut4 router
333 ut4 router called for d1@myhost.test.ex
334   domain = myhost.test.ex
335 queued for ut4 transport: local_part = d1
336 domain = myhost.test.ex
337   errors_to=
338   domain_data=NULL localpart_data=NULL
339 routed by ut4 router (unseen)
340   envelope to: d1@myhost.test.ex
341   transport: ut4
342   errors to 
343 "unseen" set: replicated d1@myhost.test.ex
344 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
345 routing c1@myhost.test.ex
346 --------> u1 router <--------
347 local_part=c1 domain=myhost.test.ex
348 checking local_parts
349 u1 router skipped: local_parts mismatch
350 --------> ut2 router <--------
351 local_part=c1 domain=myhost.test.ex
352 checking local_parts
353 ut2 router skipped: local_parts mismatch
354 --------> ut3 router <--------
355 local_part=c1 domain=myhost.test.ex
356 checking local_parts
357 calling ut3 router
358 ut3 router called for c1@myhost.test.ex
359   domain = myhost.test.ex
360 set transport ut3
361 queued for ut3 transport: local_part = c1
362 domain = myhost.test.ex
363   errors_to=
364   domain_data=NULL localpart_data=NULL
365 routed by ut3 router (unseen)
366   envelope to: c1@myhost.test.ex
367   transport: ut3
368   errors to 
369 "unseen" set: replicated c1@myhost.test.ex
370 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
371 routing b1@myhost.test.ex
372 --------> u1 router <--------
373 local_part=b1 domain=myhost.test.ex
374 checking local_parts
375 u1 router skipped: local_parts mismatch
376 --------> ut2 router <--------
377 local_part=b1 domain=myhost.test.ex
378 checking local_parts
379 calling ut2 router
380 ut2 router called for b1@myhost.test.ex
381   domain = myhost.test.ex
382 set transport ut2
383 queued for ut2 transport: local_part = b1
384 domain = myhost.test.ex
385   errors_to=
386   domain_data=NULL localpart_data=NULL
387 routed by ut2 router (unseen)
388   envelope to: b1@myhost.test.ex
389   transport: ut2
390   errors to 
391 "unseen" set: replicated b1@myhost.test.ex
392 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
393 routing a1@myhost.test.ex
394 --------> u1 router <--------
395 local_part=a1 domain=myhost.test.ex
396 checking local_parts
397 calling u1 router
398 u1 router called for a1@myhost.test.ex
399   domain = myhost.test.ex
400 set transport ut1
401 queued for ut1 transport: local_part = a1
402 domain = myhost.test.ex
403   errors_to=
404   domain_data=NULL localpart_data=NULL
405 routed by u1 router (unseen)
406   envelope to: a1@myhost.test.ex
407   transport: ut1
408   errors to 
409 "unseen" set: replicated a1@myhost.test.ex
410 locking TESTSUITE/spool/db/retry.lockfile
411 no retry data available
412 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
413 Considering: a1@myhost.test.ex
414 unique = \0\a1@myhost.test.ex
415 a1@myhost.test.ex: queued for routing
416 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
417 Considering: b1@myhost.test.ex
418 unique = \0\b1@myhost.test.ex
419 b1@myhost.test.ex: queued for routing
420 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
421 Considering: c1@myhost.test.ex
422 unique = \0\c1@myhost.test.ex
423 c1@myhost.test.ex: queued for routing
424 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
425 Considering: d1@myhost.test.ex
426 unique = \0\d1@myhost.test.ex
427 d1@myhost.test.ex: queued for routing
428 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
429 Considering: d2@myhost.test.ex
430 unique = \0\d2@myhost.test.ex
431 d2@myhost.test.ex: queued for routing
432 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
433 Considering: d3@myhost.test.ex
434 unique = \0\d3@myhost.test.ex
435 d3@myhost.test.ex: queued for routing
436 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
437 Considering: e1@myhost.test.ex
438 unique = \0\e1@myhost.test.ex
439 e1@myhost.test.ex: queued for routing
440 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
441 Considering: f1@myhost.test.ex
442 unique = \0\f1@myhost.test.ex
443 f1@myhost.test.ex: queued for routing
444 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
445 Considering: f2@myhost.test.ex
446 unique = \0\f2@myhost.test.ex
447 f2@myhost.test.ex: queued for routing
448 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
449 Considering: f3@myhost.test.ex
450 unique = \0\f3@myhost.test.ex
451 f3@myhost.test.ex: queued for routing
452 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
453 routing f3@myhost.test.ex
454 --------> ut7 router <--------
455 local_part=f3 domain=myhost.test.ex
456 checking local_parts
457 ut7 router skipped: local_parts mismatch
458 --------> ut8 router <--------
459 local_part=f3 domain=myhost.test.ex
460 checking local_parts
461 ut8 router skipped: local_parts mismatch
462 --------> real router <--------
463 local_part=f3 domain=myhost.test.ex
464 calling real router
465 real router called for f3@myhost.test.ex
466   domain = myhost.test.ex
467 set transport real
468 queued for real transport: local_part = f3
469 domain = myhost.test.ex
470   errors_to=NULL
471   domain_data=NULL localpart_data=NULL
472 routed by real router
473   envelope to: f3@myhost.test.ex
474   transport: real
475 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
476 routing f2@myhost.test.ex
477 --------> ut7 router <--------
478 local_part=f2 domain=myhost.test.ex
479 checking local_parts
480 ut7 router skipped: local_parts mismatch
481 --------> ut8 router <--------
482 local_part=f2 domain=myhost.test.ex
483 checking local_parts
484 ut8 router skipped: local_parts mismatch
485 --------> real router <--------
486 local_part=f2 domain=myhost.test.ex
487 calling real router
488 real router called for f2@myhost.test.ex
489   domain = myhost.test.ex
490 queued for real transport: local_part = f2
491 domain = myhost.test.ex
492   errors_to=NULL
493   domain_data=NULL localpart_data=NULL
494 routed by real router
495   envelope to: f2@myhost.test.ex
496   transport: real
497 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
498 routing f1@myhost.test.ex
499 --------> ut7 router <--------
500 local_part=f1 domain=myhost.test.ex
501 checking local_parts
502 ut7 router skipped: local_parts mismatch
503 --------> ut8 router <--------
504 local_part=f1 domain=myhost.test.ex
505 checking local_parts
506 ut8 router skipped: local_parts mismatch
507 --------> real router <--------
508 local_part=f1 domain=myhost.test.ex
509 calling real router
510 real router called for f1@myhost.test.ex
511   domain = myhost.test.ex
512 queued for real transport: local_part = f1
513 domain = myhost.test.ex
514   errors_to=NULL
515   domain_data=NULL localpart_data=NULL
516 routed by real router
517   envelope to: f1@myhost.test.ex
518   transport: real
519 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
520 routing e1@myhost.test.ex
521 --------> ut6 router <--------
522 local_part=e1 domain=myhost.test.ex
523 checking local_parts
524 ut6 router skipped: local_parts mismatch
525 --------> ut7 router <--------
526 local_part=e1 domain=myhost.test.ex
527 checking local_parts
528 ut7 router skipped: local_parts mismatch
529 --------> ut8 router <--------
530 local_part=e1 domain=myhost.test.ex
531 checking local_parts
532 ut8 router skipped: local_parts mismatch
533 --------> real router <--------
534 local_part=e1 domain=myhost.test.ex
535 calling real router
536 real router called for e1@myhost.test.ex
537   domain = myhost.test.ex
538 queued for real transport: local_part = e1
539 domain = myhost.test.ex
540   errors_to=NULL
541   domain_data=NULL localpart_data=NULL
542 routed by real router
543   envelope to: e1@myhost.test.ex
544   transport: real
545 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
546 routing d3@myhost.test.ex
547 --------> ut5 router <--------
548 local_part=d3 domain=myhost.test.ex
549 checking local_parts
550 ut5 router skipped: local_parts mismatch
551 --------> ut6 router <--------
552 local_part=d3 domain=myhost.test.ex
553 checking local_parts
554 ut6 router skipped: local_parts mismatch
555 --------> ut7 router <--------
556 local_part=d3 domain=myhost.test.ex
557 checking local_parts
558 ut7 router skipped: local_parts mismatch
559 --------> ut8 router <--------
560 local_part=d3 domain=myhost.test.ex
561 checking local_parts
562 ut8 router skipped: local_parts mismatch
563 --------> real router <--------
564 local_part=d3 domain=myhost.test.ex
565 calling real router
566 real router called for d3@myhost.test.ex
567   domain = myhost.test.ex
568 queued for real transport: local_part = d3
569 domain = myhost.test.ex
570   errors_to=NULL
571   domain_data=NULL localpart_data=NULL
572 routed by real router
573   envelope to: d3@myhost.test.ex
574   transport: real
575 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
576 routing d2@myhost.test.ex
577 --------> ut5 router <--------
578 local_part=d2 domain=myhost.test.ex
579 checking local_parts
580 ut5 router skipped: local_parts mismatch
581 --------> ut6 router <--------
582 local_part=d2 domain=myhost.test.ex
583 checking local_parts
584 ut6 router skipped: local_parts mismatch
585 --------> ut7 router <--------
586 local_part=d2 domain=myhost.test.ex
587 checking local_parts
588 ut7 router skipped: local_parts mismatch
589 --------> ut8 router <--------
590 local_part=d2 domain=myhost.test.ex
591 checking local_parts
592 ut8 router skipped: local_parts mismatch
593 --------> real router <--------
594 local_part=d2 domain=myhost.test.ex
595 calling real router
596 real router called for d2@myhost.test.ex
597   domain = myhost.test.ex
598 queued for real transport: local_part = d2
599 domain = myhost.test.ex
600   errors_to=NULL
601   domain_data=NULL localpart_data=NULL
602 routed by real router
603   envelope to: d2@myhost.test.ex
604   transport: real
605 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
606 routing d1@myhost.test.ex
607 --------> ut5 router <--------
608 local_part=d1 domain=myhost.test.ex
609 checking local_parts
610 ut5 router skipped: local_parts mismatch
611 --------> ut6 router <--------
612 local_part=d1 domain=myhost.test.ex
613 checking local_parts
614 ut6 router skipped: local_parts mismatch
615 --------> ut7 router <--------
616 local_part=d1 domain=myhost.test.ex
617 checking local_parts
618 ut7 router skipped: local_parts mismatch
619 --------> ut8 router <--------
620 local_part=d1 domain=myhost.test.ex
621 checking local_parts
622 ut8 router skipped: local_parts mismatch
623 --------> real router <--------
624 local_part=d1 domain=myhost.test.ex
625 calling real router
626 real router called for d1@myhost.test.ex
627   domain = myhost.test.ex
628 queued for real transport: local_part = d1
629 domain = myhost.test.ex
630   errors_to=NULL
631   domain_data=NULL localpart_data=NULL
632 routed by real router
633   envelope to: d1@myhost.test.ex
634   transport: real
635 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
636 routing c1@myhost.test.ex
637 --------> ut4 router <--------
638 local_part=c1 domain=myhost.test.ex
639 checking local_parts
640 ut4 router skipped: local_parts mismatch
641 --------> ut5 router <--------
642 local_part=c1 domain=myhost.test.ex
643 checking local_parts
644 ut5 router skipped: local_parts mismatch
645 --------> ut6 router <--------
646 local_part=c1 domain=myhost.test.ex
647 checking local_parts
648 ut6 router skipped: local_parts mismatch
649 --------> ut7 router <--------
650 local_part=c1 domain=myhost.test.ex
651 checking local_parts
652 ut7 router skipped: local_parts mismatch
653 --------> ut8 router <--------
654 local_part=c1 domain=myhost.test.ex
655 checking local_parts
656 ut8 router skipped: local_parts mismatch
657 --------> real router <--------
658 local_part=c1 domain=myhost.test.ex
659 calling real router
660 real router called for c1@myhost.test.ex
661   domain = myhost.test.ex
662 queued for real transport: local_part = c1
663 domain = myhost.test.ex
664   errors_to=NULL
665   domain_data=NULL localpart_data=NULL
666 routed by real router
667   envelope to: c1@myhost.test.ex
668   transport: real
669 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
670 routing b1@myhost.test.ex
671 --------> ut3 router <--------
672 local_part=b1 domain=myhost.test.ex
673 checking local_parts
674 ut3 router skipped: local_parts mismatch
675 --------> ut4 router <--------
676 local_part=b1 domain=myhost.test.ex
677 checking local_parts
678 ut4 router skipped: local_parts mismatch
679 --------> ut5 router <--------
680 local_part=b1 domain=myhost.test.ex
681 checking local_parts
682 ut5 router skipped: local_parts mismatch
683 --------> ut6 router <--------
684 local_part=b1 domain=myhost.test.ex
685 checking local_parts
686 ut6 router skipped: local_parts mismatch
687 --------> ut7 router <--------
688 local_part=b1 domain=myhost.test.ex
689 checking local_parts
690 ut7 router skipped: local_parts mismatch
691 --------> ut8 router <--------
692 local_part=b1 domain=myhost.test.ex
693 checking local_parts
694 ut8 router skipped: local_parts mismatch
695 --------> real router <--------
696 local_part=b1 domain=myhost.test.ex
697 calling real router
698 real router called for b1@myhost.test.ex
699   domain = myhost.test.ex
700 queued for real transport: local_part = b1
701 domain = myhost.test.ex
702   errors_to=NULL
703   domain_data=NULL localpart_data=NULL
704 routed by real router
705   envelope to: b1@myhost.test.ex
706   transport: real
707 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
708 routing a1@myhost.test.ex
709 --------> ut2 router <--------
710 local_part=a1 domain=myhost.test.ex
711 checking local_parts
712 ut2 router skipped: local_parts mismatch
713 --------> ut3 router <--------
714 local_part=a1 domain=myhost.test.ex
715 checking local_parts
716 ut3 router skipped: local_parts mismatch
717 --------> ut4 router <--------
718 local_part=a1 domain=myhost.test.ex
719 checking local_parts
720 ut4 router skipped: local_parts mismatch
721 --------> ut5 router <--------
722 local_part=a1 domain=myhost.test.ex
723 checking local_parts
724 ut5 router skipped: local_parts mismatch
725 --------> ut6 router <--------
726 local_part=a1 domain=myhost.test.ex
727 checking local_parts
728 ut6 router skipped: local_parts mismatch
729 --------> ut7 router <--------
730 local_part=a1 domain=myhost.test.ex
731 checking local_parts
732 ut7 router skipped: local_parts mismatch
733 --------> ut8 router <--------
734 local_part=a1 domain=myhost.test.ex
735 checking local_parts
736 ut8 router skipped: local_parts mismatch
737 --------> real router <--------
738 local_part=a1 domain=myhost.test.ex
739 calling real router
740 real router called for a1@myhost.test.ex
741   domain = myhost.test.ex
742 queued for real transport: local_part = a1
743 domain = myhost.test.ex
744   errors_to=NULL
745   domain_data=NULL localpart_data=NULL
746 routed by real router
747   envelope to: a1@myhost.test.ex
748   transport: real
749 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
750 After routing:
751   Local deliveries:
752     a1@myhost.test.ex
753     b1@myhost.test.ex
754     c1@myhost.test.ex
755     d1@myhost.test.ex
756     d2@myhost.test.ex
757     d3@myhost.test.ex
758     e1@myhost.test.ex
759     f1@myhost.test.ex
760     f2@myhost.test.ex
761     f3@myhost.test.ex
762     a1@myhost.test.ex
763     b1@myhost.test.ex
764     c1@myhost.test.ex
765   Remote deliveries:
766     d1@myhost.test.ex
767     d2@myhost.test.ex
768     d3@myhost.test.ex
769     e1@myhost.test.ex
770     f1@myhost.test.ex
771     f2@myhost.test.ex
772     f3@myhost.test.ex
773   Failed addresses:
774   Deferred addresses:
775     g1@myhost.test.ex
776 locking TESTSUITE/spool/db/retry.lockfile
777 LOG: MAIN
778   => a1 <a1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
779 locking TESTSUITE/spool/db/retry.lockfile
780 LOG: MAIN
781   => b1 <b1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
782 locking TESTSUITE/spool/db/retry.lockfile
783 LOG: MAIN
784   => c1 <c1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
785 locking TESTSUITE/spool/db/retry.lockfile
786 LOG: MAIN
787   => d1 <d1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
788 locking TESTSUITE/spool/db/retry.lockfile
789 LOG: MAIN
790   => d2 <d2@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
791 locking TESTSUITE/spool/db/retry.lockfile
792 LOG: MAIN
793   => d3 <d3@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
794 locking TESTSUITE/spool/db/retry.lockfile
795 LOG: MAIN
796   => e1 <e1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
797 locking TESTSUITE/spool/db/retry.lockfile
798 LOG: MAIN
799   => f1 <f1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
800 locking TESTSUITE/spool/db/retry.lockfile
801 LOG: MAIN
802   => f2 <f2@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
803 locking TESTSUITE/spool/db/retry.lockfile
804 LOG: MAIN
805   => f3 <f3@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
806 locking TESTSUITE/spool/db/retry.lockfile
807 LOG: MAIN
808   => a1 <a1@myhost.test.ex> P=<> R=u1 T=ut1
809 log writing disabled
810 locking TESTSUITE/spool/db/retry.lockfile
811 transport error EPIPE ignored
812 LOG: MAIN
813   ** b1@myhost.test.ex P=<> R=ut2 T=ut2: Child process of ut2 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file
814 log writing disabled
815 locking TESTSUITE/spool/db/retry.lockfile
816 transport error EPIPE ignored
817 LOG: MAIN
818   == c1@myhost.test.ex R=ut3 T=ut3 defer (0): Child process of ut3 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file
819 log writing disabled
820 locking TESTSUITE/spool/db/retry.lockfile
821 locking TESTSUITE/spool/db/wait-ut4.lockfile
822 LOG: MAIN
823   => d1@myhost.test.ex P=<> R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1] C="250 OK"
824 log writing disabled
825 locking TESTSUITE/spool/db/retry.lockfile
826 LOG: MAIN
827   == d2@myhost.test.ex R=ut4 T=ut4 defer (-44) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d2@myhost.test.ex>: 450 soft error
828 log writing disabled
829 locking TESTSUITE/spool/db/retry.lockfile
830 locking TESTSUITE/spool/db/wait-ut4.lockfile
831 LOG: MAIN
832   ** d3@myhost.test.ex P=<> R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d3@myhost.test.ex>: 550 hard error
833 log writing disabled
834 locking TESTSUITE/spool/db/retry.lockfile
835 locking TESTSUITE/spool/db/wait-ut5.lockfile
836 LOG: MAIN
837   ** e1@myhost.test.ex P=<> R=ut5 T=ut5 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<e1@myhost.test.ex>: 550 hard error
838 log writing disabled
839 locking TESTSUITE/spool/db/retry.lockfile
840 locking TESTSUITE/spool/db/wait-ut6.lockfile
841 LOG: MAIN
842   => f1@myhost.test.ex P=<CALLER@myhost.test.ex> R=ut6 T=ut6 H=127.0.0.1 [127.0.0.1] C="250 OK"
843 log writing disabled
844 locking TESTSUITE/spool/db/retry.lockfile
845 LOG: MAIN
846   == f2@myhost.test.ex R=ut6 T=ut6 defer (-44) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<f2@myhost.test.ex>: 450 soft error
847 log writing disabled
848 locking TESTSUITE/spool/db/retry.lockfile
849 locking TESTSUITE/spool/db/wait-ut6.lockfile
850 LOG: MAIN
851   ** f3@myhost.test.ex P=<CALLER@myhost.test.ex> R=ut6 T=ut6 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<f3@myhost.test.ex>: 550 hard error
852 log writing disabled
853 locking TESTSUITE/spool/db/retry.lockfile
854 LOG: MAIN
855   f3@myhost.test.ex <f3@myhost.test.ex>: error ignored
856 log writing disabled
857 Exim version x.yz ....
858 configuration file is TESTSUITE/test-config
859 trusted user
860 admin user
861 DSN: u1 propagating DSN
862 DSN: ut2 propagating DSN
863 DSN: ut3 propagating DSN
864 DSN: ut4 propagating DSN
865 DSN: ut5 propagating DSN
866 DSN: ut6 propagating DSN
867 DSN: ut7 propagating DSN
868 DSN: ut8 propagating DSN
869 DSN: real propagating DSN
870 LOG: MAIN
871   <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss
872 Exim version x.yz ....
873 configuration file is TESTSUITE/test-config
874 trusted user
875 admin user
876 DSN: u1 propagating DSN
877 DSN: ut2 propagating DSN
878 DSN: ut3 propagating DSN
879 DSN: ut4 propagating DSN
880 DSN: ut5 propagating DSN
881 DSN: ut6 propagating DSN
882 DSN: ut7 propagating DSN
883 DSN: ut8 propagating DSN
884 DSN: real propagating DSN
885 locking TESTSUITE/spool/db/retry.lockfile
886 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
887 Considering: CALLER@myhost.test.ex
888 unique = CALLER@myhost.test.ex
889 CALLER@myhost.test.ex: queued for routing
890 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
891 routing CALLER@myhost.test.ex
892 --------> u1 router <--------
893 local_part=CALLER domain=myhost.test.ex
894 checking local_parts
895 u1 router skipped: local_parts mismatch
896 --------> ut2 router <--------
897 local_part=CALLER domain=myhost.test.ex
898 checking local_parts
899 ut2 router skipped: local_parts mismatch
900 --------> ut3 router <--------
901 local_part=CALLER domain=myhost.test.ex
902 checking local_parts
903 ut3 router skipped: local_parts mismatch
904 --------> ut4 router <--------
905 local_part=CALLER domain=myhost.test.ex
906 checking local_parts
907 ut4 router skipped: local_parts mismatch
908 --------> ut5 router <--------
909 local_part=CALLER domain=myhost.test.ex
910 checking local_parts
911 ut5 router skipped: local_parts mismatch
912 --------> ut6 router <--------
913 local_part=CALLER domain=myhost.test.ex
914 checking local_parts
915 ut6 router skipped: local_parts mismatch
916 --------> ut7 router <--------
917 local_part=CALLER domain=myhost.test.ex
918 checking local_parts
919 ut7 router skipped: local_parts mismatch
920 --------> ut8 router <--------
921 local_part=CALLER domain=myhost.test.ex
922 checking local_parts
923 ut8 router skipped: local_parts mismatch
924 --------> real router <--------
925 local_part=CALLER domain=myhost.test.ex
926 calling real router
927 real router called for CALLER@myhost.test.ex
928   domain = myhost.test.ex
929 set transport real
930 queued for real transport: local_part = CALLER
931 domain = myhost.test.ex
932   errors_to=NULL
933   domain_data=NULL localpart_data=NULL
934 routed by real router
935   envelope to: CALLER@myhost.test.ex
936   transport: real
937 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
938 After routing:
939   Local deliveries:
940     CALLER@myhost.test.ex
941   Remote deliveries:
942   Failed addresses:
943   Deferred addresses:
944 locking TESTSUITE/spool/db/retry.lockfile
945 LOG: MAIN
946   => CALLER <CALLER@myhost.test.ex> P=<> R=real T=real
947 locking TESTSUITE/spool/db/retry.lockfile
948 LOG: MAIN
949   Completed
950 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
951 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
952 LOG: MAIN
953   d3@myhost.test.ex <d3@myhost.test.ex>: error ignored
954 log writing disabled
955 LOG: MAIN
956   b1@myhost.test.ex <b1@myhost.test.ex>: error ignored
957 log writing disabled
958 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
959 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
960 Exim version x.yz ....
961 configuration file is TESTSUITE/test-config
962 admin user
963 DSN: u1 propagating DSN
964 DSN: ut2 propagating DSN
965 DSN: ut3 propagating DSN
966 DSN: ut4 propagating DSN
967 DSN: ut5 propagating DSN
968 DSN: ut6 propagating DSN
969 DSN: ut7 propagating DSN
970 DSN: ut8 propagating DSN
971 DSN: real propagating DSN
972 LOG: MAIN
973   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
974 Exim version x.yz ....
975 configuration file is TESTSUITE/test-config
976 trusted user
977 admin user
978 DSN: u1 propagating DSN
979 DSN: ut2 propagating DSN
980 DSN: ut3 propagating DSN
981 DSN: ut4 propagating DSN
982 DSN: ut5 propagating DSN
983 DSN: ut6 propagating DSN
984 DSN: ut7 propagating DSN
985 DSN: ut8 propagating DSN
986 DSN: real propagating DSN
987 locking TESTSUITE/spool/db/retry.lockfile
988 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
989 Considering: h1@myhost.test.ex
990 unique = h1@myhost.test.ex
991 h1@myhost.test.ex: queued for routing
992 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
993 routing h1@myhost.test.ex
994 --------> u1 router <--------
995 local_part=h1 domain=myhost.test.ex
996 checking local_parts
997 u1 router skipped: local_parts mismatch
998 --------> ut2 router <--------
999 local_part=h1 domain=myhost.test.ex
1000 checking local_parts
1001 ut2 router skipped: local_parts mismatch
1002 --------> ut3 router <--------
1003 local_part=h1 domain=myhost.test.ex
1004 checking local_parts
1005 ut3 router skipped: local_parts mismatch
1006 --------> ut4 router <--------
1007 local_part=h1 domain=myhost.test.ex
1008 checking local_parts
1009 ut4 router skipped: local_parts mismatch
1010 --------> ut5 router <--------
1011 local_part=h1 domain=myhost.test.ex
1012 checking local_parts
1013 ut5 router skipped: local_parts mismatch
1014 --------> ut6 router <--------
1015 local_part=h1 domain=myhost.test.ex
1016 checking local_parts
1017 ut6 router skipped: local_parts mismatch
1018 --------> ut7 router <--------
1019 local_part=h1 domain=myhost.test.ex
1020 checking local_parts
1021 ut7 router skipped: local_parts mismatch
1022 --------> ut8 router <--------
1023 local_part=h1 domain=myhost.test.ex
1024 checking local_parts
1025 calling ut8 router
1026 ut8 router called for h1@myhost.test.ex
1027   domain = myhost.test.ex
1028 forced expansion failure - ignoring errors_to
1029 set transport ut1
1030 queued for ut1 transport: local_part = h1
1031 domain = myhost.test.ex
1032   errors_to=NULL
1033   domain_data=NULL localpart_data=NULL
1034 routed by ut8 router (unseen)
1035   envelope to: h1@myhost.test.ex
1036   transport: ut1
1037 "unseen" set: replicated h1@myhost.test.ex
1038 locking TESTSUITE/spool/db/retry.lockfile
1039 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
1040 Considering: h1@myhost.test.ex
1041 unique = \0\h1@myhost.test.ex
1042 h1@myhost.test.ex: queued for routing
1043 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
1044 routing h1@myhost.test.ex
1045 --------> real router <--------
1046 local_part=h1 domain=myhost.test.ex
1047 calling real router
1048 real router called for h1@myhost.test.ex
1049   domain = myhost.test.ex
1050 set transport real
1051 queued for real transport: local_part = h1
1052 domain = myhost.test.ex
1053   errors_to=NULL
1054   domain_data=NULL localpart_data=NULL
1055 routed by real router
1056   envelope to: h1@myhost.test.ex
1057   transport: real
1058 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
1059 After routing:
1060   Local deliveries:
1061     h1@myhost.test.ex
1062     h1@myhost.test.ex
1063   Remote deliveries:
1064   Failed addresses:
1065   Deferred addresses:
1066 locking TESTSUITE/spool/db/retry.lockfile
1067 LOG: MAIN
1068   => h1 <h1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=real T=real
1069 locking TESTSUITE/spool/db/retry.lockfile
1070 LOG: MAIN
1071   => h1 <h1@myhost.test.ex> P=<CALLER@myhost.test.ex> R=ut8 T=ut1
1072 log writing disabled
1073 locking TESTSUITE/spool/db/retry.lockfile
1074 LOG: MAIN
1075   Completed
1076 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
1077 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>