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