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