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