Testsuite: fix munge around tpt connect time
[exim.git] / test / stderr / 0476
1 Exim version x.yz ....
2 configuration file is TESTSUITE/test-config
3 admin user
4 dropping to exim gid; retaining priv uid
5 set_process_info: pppp running the queue (single queue run)
6 LOG: queue_run MAIN
7   Start queue run: pid=p1234
8 set_process_info: pppp running queue: 10HmaX-000000005vi-0000
9 set_process_info: pppp delivering 10HmaX-000000005vi-0000 (queue run pid p1234)
10 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
11 --------> userx@test.ex <--------
12 set_process_info: pppp delivering 10HmaX-000000005vi-0000 using t1
13 t1 transport entered
14   userx@test.ex
15 hostlist:
16   '127.0.0.1' IP 127.0.0.1 port -1
17 checking retry status of 127.0.0.1
18 127.0.0.1 [127.0.0.1]:1111 retry-status = usable
19 delivering 10HmaX-000000005vi-0000 to 127.0.0.1 [127.0.0.1] (userx@test.ex)
20 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to 127.0.0.1 [127.0.0.1]:PORT_S (userx@test.ex)
21 Connecting to 127.0.0.1 [127.0.0.1]:PORT_S ...
22 connected
23   SMTP<< 220 Server ready
24   SMTP>> EHLO the.local.host.name
25 cmd buf flush ddd bytes
26   SMTP<< 250-server id
27          250-PIPELINING
28          250 OK
29 using PIPELINING
30 not using DSN
31   SMTP|> MAIL FROM:<CALLER@the.local.host.name>
32   SMTP|> RCPT TO:<userx@test.ex>
33   SMTP>> DATA
34 cmd buf flush ddd bytes
35 sync_responses expect mail
36   SMTP<< 250 OK
37 sync_responses expect rcpt for userx@test.ex
38   SMTP<< 550 NO
39 sync_responses expect data
40   SMTP(closed)<<
41 Remote host closed connection in response to pipelined DATA
42 error for DATA ignored: pipelining is in use and there were no good recipients
43 ok=1 send_quit=1 send_rset=1 continue_more=0 yield=0 first_address is NULL
44 transport_check_waiting entered
45   sequence=1 local_max=500 global_max=-1
46 transport_check_waiting: TRUE
47   SMTP>> RSET
48 cmd buf flush ddd bytes
49   SMTP(closed)<<
50 H=127.0.0.1 [127.0.0.1] Remote host closed connection in response to RSET
51   SMTP(close)>>
52 cmdlog: '220:EHLO:250-:MAIL|:RCPT|:DATA:250:550:RSET'
53 set_process_info: pppp delivering 10HmaX-000000005vi-0000: just tried 127.0.0.1 [127.0.0.1]:PORT_S for userx@test.ex: result OK
54 Leaving t1 transport
55 set_process_info: pppp delivering 10HmaX-000000005vi-0000 (just run t1 for userx@test.ex in subprocess)
56 set_process_info: pppp running queue: waiting for 10HmaX-000000005vi-0000 (pppp)
57 set_process_info: pppp delivering 10HmaX-000000005vi-0000: waiting for a remote delivery subprocess to finish
58 set_process_info: pppp delivering 10HmaX-000000005vi-0000
59 LOG: MAIN
60   ** 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
61 set_process_info: pppp tidying up after delivering 10HmaX-000000005vi-0000
62 Exim version x.yz ....
63 configuration file is TESTSUITE/test-config
64 trusted user
65 admin user
66 set_process_info: pppp accepting a local non-SMTP message from <>
67 cannot use sendfile for body: spoolfile not wireformat
68 writing data block fd=dddd size=sss timeout=0
69 LOG: MAIN
70   <= <> R=10HmaX-000000005vi-0000 U=EXIMUSER P=local S=sss
71 Exim version x.yz ....
72 configuration file is TESTSUITE/test-config
73 trusted user
74 admin user
75 dropping to exim gid; retaining priv uid
76 set_process_info: pppp delivering specified messages
77 set_process_info: pppp delivering 10HmaZ-000000005vi-0000
78 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
79 --------> CALLER@the.local.host.name <--------
80 set_process_info: pppp delivering 10HmaZ-000000005vi-0000 using t1
81 t1 transport entered
82   CALLER@the.local.host.name
83 hostlist:
84   '127.0.0.1' IP 127.0.0.1 port -1
85 checking retry status of 127.0.0.1
86 127.0.0.1 [127.0.0.1]:1111 retry-status = usable
87 delivering 10HmaZ-000000005vi-0000 to 127.0.0.1 [127.0.0.1] (CALLER@the.local.host.name)
88 set_process_info: pppp delivering 10HmaZ-000000005vi-0000 to 127.0.0.1 [127.0.0.1]:PORT_S (CALLER@the.local.host.name)
89 Connecting to 127.0.0.1 [127.0.0.1]:PORT_S ...
90  failed: Connection refused
91 LOG: MAIN
92   H=127.0.0.1 [127.0.0.1] Connection refused
93 set_process_info: pppp delivering 10HmaZ-000000005vi-0000: just tried 127.0.0.1 [127.0.0.1]:PORT_S for CALLER@the.local.host.name: result DEFER
94 added retry item for T:[127.0.0.1]:127.0.0.1:PORT_S: errno=dd more_errno=dd,A flags=2
95 all IP addresses skipped or deferred at least one address
96 updating wait-t1 database
97 added 10HmaZ-000000005vi-0000 to queue for 127.0.0.1
98 Leaving t1 transport
99 set_process_info: pppp delivering 10HmaZ-000000005vi-0000 (just run t1 for CALLER@the.local.host.name in subprocess)
100 set_process_info: pppp delivering 10HmaZ-000000005vi-0000: waiting for a remote delivery subprocess to finish
101 set_process_info: pppp delivering 10HmaZ-000000005vi-0000
102 LOG: MAIN
103   == CALLER@the.local.host.name R=r1 T=t1 defer (dd): Connection refused
104 set_process_info: pppp tidying up after delivering 10HmaZ-000000005vi-0000
105 >>>>>>>>>>>>>>>> Exim pid=p1236 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
106 >>>>>>>>>>>>>>>> Exim pid=p1235 (bounce-message) terminating with rc=0 >>>>>>>>>>>>>>>>
107 LOG: MAIN
108   Completed
109 >>>>>>>>>>>>>>>> Exim pid=p1237 (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
110 set_process_info: pppp running queue: waiting for children of pppp
111 set_process_info: pppp running queue
112 set_process_info: pppp running queue: 10HmaY-000000005vi-0000
113 set_process_info: pppp delivering 10HmaY-000000005vi-0000 (queue run pid p1234)
114 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
115 --------> usery@test.ex <--------
116 set_process_info: pppp delivering 10HmaY-000000005vi-0000 using t1
117 t1 transport entered
118   usery@test.ex
119 hostlist:
120   '127.0.0.1' IP 127.0.0.1 port -1
121 checking retry status of 127.0.0.1
122 no message retry record
123 127.0.0.1 [127.0.0.1]:1111 retry-status = unusable
124 all IP addresses skipped or deferred at least one address
125 updating wait-t1 database
126 added 10HmaY-000000005vi-0000 to queue for 127.0.0.1
127 Leaving t1 transport
128 set_process_info: pppp delivering 10HmaY-000000005vi-0000 (just run t1 for usery@test.ex in subprocess)
129 set_process_info: pppp running queue: waiting for 10HmaY-000000005vi-0000 (pppp)
130 set_process_info: pppp delivering 10HmaY-000000005vi-0000: waiting for a remote delivery subprocess to finish
131 set_process_info: pppp delivering 10HmaY-000000005vi-0000
132 LOG: retry_defer MAIN
133   == usery@test.ex R=r1 T=t1 defer (-54): retry time not reached for any host for 'test.ex'
134 set_process_info: pppp tidying up after delivering 10HmaY-000000005vi-0000
135 >>>>>>>>>>>>>>>> Exim pid=p1238 (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
136 set_process_info: pppp running queue: waiting for children of pppp
137 set_process_info: pppp running queue
138 LOG: queue_run MAIN
139   End queue run: pid=p1234
140 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>