Log lengthy DNS lookups. Bug 514
[users/heiko/exim.git] / test / stderr / 0476
1 Exim version x.yz ....
2 configuration file is TESTSUITE/test-config
3 admin user
4 set_process_info: pppp running the queue (single queue run)
5 LOG: queue_run MAIN
6   Start queue run: pid=pppp
7 set_process_info: pppp running queue: 10HmaX-0005vi-00-H
8 set_process_info: pppp running queue: waiting for 10HmaX-0005vi-00 (pppp)
9 set_process_info: pppp delivering 10HmaX-0005vi-00 (queue run pid ppppp)
10 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
11 --------> userx@test.ex <--------
12 set_process_info: pppp delivering 10HmaX-0005vi-00 using t1
13 t1 transport entered
14   userx@test.ex
15 checking status of 127.0.0.1
16 127.0.0.1 [127.0.0.1]:1111 status = usable
17 delivering 10HmaX-0005vi-00 to 127.0.0.1 [127.0.0.1] (userx@test.ex)
18 set_process_info: pppp delivering 10HmaX-0005vi-00 to 127.0.0.1 [127.0.0.1] (userx@test.ex)
19 Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected
20   SMTP<< 220 Server ready
21   SMTP>> EHLO the.local.host.name
22   SMTP<< 250-server id
23          250-PIPELINING
24          250 OK
25 using PIPELINING
26 use_dsn=0
27   SMTP>> MAIL FROM:<CALLER@the.local.host.name>
28   SMTP>> RCPT TO:<userx@test.ex>
29   SMTP>> DATA
30   SMTP<< 250 OK
31   SMTP<< 550 NO
32 Remote host closed connection in response to pipelined DATA
33 error for DATA ignored: pipelining is in use and there were no good recipients
34 ok=1 send_quit=1 send_rset=1 continue_more=0 yield=0 first_address is NULL
35 transport_check_waiting entered
36   sequence=1 local_max=500 global_max=-1
37   SMTP>> RSET
38 H=127.0.0.1 [127.0.0.1] Remote host closed connection in response to RSET
39 set_process_info: pppp delivering 10HmaX-0005vi-00: just tried 127.0.0.1 [127.0.0.1] for userx@test.ex: result OK
40 Leaving t1 transport
41 set_process_info: pppp delivering 10HmaX-0005vi-00 (just run t1 for userx@test.ex in subprocess)
42 set_process_info: pppp delivering 10HmaX-0005vi-00: waiting for a remote delivery subprocess to finish
43 set_process_info: pppp delivering 10HmaX-0005vi-00
44 LOG: MAIN
45   ** userx@test.ex R=r1 T=t1 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<userx@test.ex>: 550 NO
46 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
47 writing data block fd=dddd size=sss timeout=0
48 Exim version x.yz ....
49 configuration file is TESTSUITE/test-config
50 trusted user
51 admin user
52 set_process_info: pppp accepting a local non-SMTP message from <>
53 LOG: MAIN
54   <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss
55 Exim version x.yz ....
56 configuration file is TESTSUITE/test-config
57 trusted user
58 admin user
59 set_process_info: pppp delivering specified messages
60 set_process_info: pppp delivering 10HmaZ-0005vi-00
61 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
62 --------> CALLER@the.local.host.name <--------
63 set_process_info: pppp delivering 10HmaZ-0005vi-00 using t1
64 t1 transport entered
65   CALLER@the.local.host.name
66 checking status of 127.0.0.1
67 127.0.0.1 [127.0.0.1]:1111 status = usable
68 delivering 10HmaZ-0005vi-00 to 127.0.0.1 [127.0.0.1] (CALLER@the.local.host.name)
69 set_process_info: pppp delivering 10HmaZ-0005vi-00 to 127.0.0.1 [127.0.0.1] (CALLER@the.local.host.name)
70 Connecting to 127.0.0.1 [127.0.0.1]:1224 ... failed: Connection refused
71 LOG: MAIN
72   H=127.0.0.1 [127.0.0.1] Connection refused
73 set_process_info: pppp delivering 10HmaZ-0005vi-00: just tried 127.0.0.1 [127.0.0.1] for CALLER@the.local.host.name: result DEFER
74 added retry item for T:127.0.0.1:127.0.0.1:1224: errno=dd more_errno=dd,A flags=2
75 all IP addresses skipped or deferred at least one address
76 updating wait-t1 database
77 added to list for 127.0.0.1
78 Leaving t1 transport
79 set_process_info: pppp delivering 10HmaZ-0005vi-00 (just run t1 for CALLER@the.local.host.name in subprocess)
80 set_process_info: pppp delivering 10HmaZ-0005vi-00: waiting for a remote delivery subprocess to finish
81 set_process_info: pppp delivering 10HmaZ-0005vi-00
82 LOG: MAIN
83   == CALLER@the.local.host.name R=r1 T=t1 defer (dd): Connection refused
84 set_process_info: pppp tidying up after delivering 10HmaZ-0005vi-00
85 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
86 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
87 LOG: MAIN
88   Completed
89 set_process_info: pppp running queue: waiting for children of pppp
90 set_process_info: pppp running queue
91 set_process_info: pppp running queue: 10HmaY-0005vi-00-H
92 set_process_info: pppp running queue: waiting for 10HmaY-0005vi-00 (pppp)
93 set_process_info: pppp delivering 10HmaY-0005vi-00 (queue run pid ppppp)
94 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
95 --------> usery@test.ex <--------
96 set_process_info: pppp delivering 10HmaY-0005vi-00 using t1
97 t1 transport entered
98   usery@test.ex
99 checking status of 127.0.0.1
100 no message retry record
101 127.0.0.1 [127.0.0.1]:1111 status = unusable
102 all IP addresses skipped or deferred at least one address
103 updating wait-t1 database
104 added to list for 127.0.0.1
105 Leaving t1 transport
106 set_process_info: pppp delivering 10HmaY-0005vi-00 (just run t1 for usery@test.ex in subprocess)
107 set_process_info: pppp delivering 10HmaY-0005vi-00: waiting for a remote delivery subprocess to finish
108 set_process_info: pppp delivering 10HmaY-0005vi-00
109 LOG: retry_defer MAIN
110   == usery@test.ex R=r1 T=t1 defer (-53): retry time not reached for any host
111 set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00
112 set_process_info: pppp running queue: waiting for children of pppp
113 set_process_info: pppp running queue
114 LOG: queue_run MAIN
115   End queue run: pid=pppp
116 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>