Tidies to SMTP dialogue debugging output.
[users/heiko/exim.git] / test / stderr / 0398
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=pppp
4 configuration file is TESTSUITE/test-config
5 admin user
6 changed uid/gid: privilege not needed
7   uid=EXIM_UID gid=EXIM_GID pid=pppp
8 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
9 sender address = CALLER@test.ex
10 set_process_info: pppp accepting a local SMTP message from <CALLER@test.ex>
11  in hosts_connection_nolog? no (option unset)
12 LOG: smtp_connection MAIN
13   SMTP connection from CALLER
14 SMTP>> 220 mail.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
15 smtp_setup_msg entered
16 SMTP<< mail from:<qq@remote>
17 SMTP>> 250 OK
18 SMTP<< rcpt to:<abc@local>
19 using ACL "rcpt"
20 processing "deny"
21 check senders = qq@remote
22 address match: subject=qq@remote pattern=qq@remote
23 remote in "remote"? yes (matched "remote")
24 qq@remote in "qq@remote"? yes (matched "qq@remote")
25 check !verify = sender
26 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
27 Verifying qq@remote
28 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
29 Considering qq@remote
30 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
31 routing qq@remote
32 --------> r1 router <--------
33 local_part=qq domain=remote
34 checking domains
35 remote in "local"? no (end of list)
36 r1 router skipped: domains mismatch
37 --------> r2 router <--------
38 local_part=qq domain=remote
39 checking domains
40 remote in "remote"? yes (matched "remote")
41 calling r2 router
42 r2 router called for qq@remote
43   domain = remote
44 route_item = * 127.0.0.1
45 remote in "*"? yes (matched "*")
46 original list of hosts = "127.0.0.1" options = 
47 expanded list of hosts = "127.0.0.1" options = 
48 set transport t2
49 finding IP address for 127.0.0.1
50 calling host_find_byname
51 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
52 local host found for non-MX address
53 fully qualified name = 127.0.0.1
54 MUNGED: ::1 will be omitted in what follows
55 get[host|ipnode]byname[2] looked up these IP addresses:
56   name=127.0.0.1 address=127.0.0.1
57 remote host address is the local host: remote: configured to try delivery anyway
58 queued for t2 transport: local_part = qq
59 domain = remote
60   errors_to=NULL
61   domain_data=NULL localpart_data=NULL
62 routed by r2 router
63   envelope to: qq@remote
64   transport: t2
65   host 127.0.0.1 [127.0.0.1]
66 ----------- end verify ------------
67 sender qq@remote verified ok
68 deny: condition test failed
69 processing "warn"
70 check senders = qq@remote
71 address match: subject=qq@remote pattern=qq@remote
72 remote in "remote"? yes (matched "remote")
73 qq@remote in "qq@remote"? yes (matched "qq@remote")
74 check !verify = sender/callout
75 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
76 Verifying qq@remote
77 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
78 Considering qq@remote
79 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
80 routing qq@remote
81 --------> r1 router <--------
82 local_part=qq domain=remote
83 checking domains
84 remote in "local"? no (end of list)
85 r1 router skipped: domains mismatch
86 --------> r2 router <--------
87 local_part=qq domain=remote
88 checking domains
89 remote in "remote"? yes (matched "remote")
90 calling r2 router
91 r2 router called for qq@remote
92   domain = remote
93 route_item = * 127.0.0.1
94 remote in "*"? yes (matched "*")
95 original list of hosts = "127.0.0.1" options = 
96 expanded list of hosts = "127.0.0.1" options = 
97 finding IP address for 127.0.0.1
98 calling host_find_byname
99 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
100 local host found for non-MX address
101 fully qualified name = 127.0.0.1
102 MUNGED: ::1 will be omitted in what follows
103 get[host|ipnode]byname[2] looked up these IP addresses:
104   name=127.0.0.1 address=127.0.0.1
105 remote host address is the local host: remote: configured to try delivery anyway
106 queued for t2 transport: local_part = qq
107 domain = remote
108   errors_to=NULL
109   domain_data=NULL localpart_data=NULL
110 routed by r2 router
111   envelope to: qq@remote
112   transport: t2
113   host 127.0.0.1 [127.0.0.1]
114 Attempting full verification using callout
115 locking TESTSUITE/spool/db/callout.lockfile
116 locked TESTSUITE/spool/db/callout.lockfile
117 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
118 returned from EXIM_DBOPEN
119 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
120 dbfn_read: key=remote
121 callout cache: found domain record
122 dbfn_read: key=qq@remote
123 callout cache: no address record found
124 interface=NULL port=1224
125 Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected
126   SMTP<< 220 Server ready
127   SMTP>> HELO mail.test.ex
128   SMTP<< 250 OK
129   SMTP>> MAIL FROM:<>
130   SMTP<< 250 OK
131   SMTP>> RCPT TO:<qq@remote>
132   SMTP<< 550 Unknown
133   SMTP>> QUIT
134 locking TESTSUITE/spool/db/callout.lockfile
135 locked TESTSUITE/spool/db/callout.lockfile
136 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
137 returned from EXIM_DBOPEN
138 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR|O_CREAT
139 dbfn_write: key=remote
140 wrote callout cache domain record:
141   result=1 postmaster=0 random=0
142 dbfn_write: key=qq@remote
143 wrote negative callout cache address record
144 ----------- end verify ------------
145 warn: condition test succeeded
146 LOG: MAIN
147   U=CALLER Warning: Sender verify failed: response to "RCPT TO:<qq@remote>" from 127.0.0.1 [127.0.0.1] was: 550 Unknown
148 processing "accept"
149 check senders = qq@remote
150 address match: subject=qq@remote pattern=qq@remote
151 remote in "remote"? yes (matched "remote")
152 qq@remote in "qq@remote"? yes (matched "qq@remote")
153 accept: condition test succeeded
154 SMTP>> 250 Accepted
155 SMTP<< rcpt to:<xyz@local>
156 using ACL "rcpt"
157 processing "deny"
158 check senders = qq@remote
159 address match: subject=qq@remote pattern=qq@remote
160 remote in "remote"? yes (matched "remote")
161 qq@remote in "qq@remote"? yes (matched "qq@remote")
162 check !verify = sender
163 using cached sender verify result
164 deny: condition test failed
165 processing "warn"
166 check senders = qq@remote
167 address match: subject=qq@remote pattern=qq@remote
168 remote in "remote"? yes (matched "remote")
169 qq@remote in "qq@remote"? yes (matched "qq@remote")
170 check !verify = sender/callout
171 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
172 Verifying qq@remote
173 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
174 Considering qq@remote
175 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
176 routing qq@remote
177 --------> r1 router <--------
178 local_part=qq domain=remote
179 checking domains
180 remote in "local"? no (end of list)
181 r1 router skipped: domains mismatch
182 --------> r2 router <--------
183 local_part=qq domain=remote
184 checking domains
185 remote in "remote"? yes (matched "remote")
186 calling r2 router
187 r2 router called for qq@remote
188   domain = remote
189 route_item = * 127.0.0.1
190 remote in "*"? yes (matched "*")
191 original list of hosts = "127.0.0.1" options = 
192 expanded list of hosts = "127.0.0.1" options = 
193 finding IP address for 127.0.0.1
194 calling host_find_byname
195 using host_fake_gethostbyname for 127.0.0.1 (IPv4)
196 local host found for non-MX address
197 fully qualified name = 127.0.0.1
198 MUNGED: ::1 will be omitted in what follows
199 get[host|ipnode]byname[2] looked up these IP addresses:
200   name=127.0.0.1 address=127.0.0.1
201 remote host address is the local host: remote: configured to try delivery anyway
202 queued for t2 transport: local_part = qq
203 domain = remote
204   errors_to=NULL
205   domain_data=NULL localpart_data=NULL
206 routed by r2 router
207   envelope to: qq@remote
208   transport: t2
209   host 127.0.0.1 [127.0.0.1]
210 Attempting full verification using callout
211 locking TESTSUITE/spool/db/callout.lockfile
212 locked TESTSUITE/spool/db/callout.lockfile
213 EXIM_DBOPEN(TESTSUITE/spool/db/callout)
214 returned from EXIM_DBOPEN
215 opened hints database TESTSUITE/spool/db/callout: flags=O_RDWR
216 dbfn_read: key=remote
217 callout cache: found domain record
218 dbfn_read: key=qq@remote
219 callout cache: found address record
220 callout cache: address record is negative
221 ----------- end verify ------------
222 warn: condition test succeeded
223 LOG: MAIN
224   U=CALLER Warning: Sender verify failed
225 processing "accept"
226 check senders = qq@remote
227 address match: subject=qq@remote pattern=qq@remote
228 remote in "remote"? yes (matched "remote")
229 qq@remote in "qq@remote"? yes (matched "qq@remote")
230 accept: condition test succeeded
231 SMTP>> 250 Accepted
232 SMTP<< quit
233 SMTP>> 221 mail.test.ex closing connection
234 LOG: smtp_connection MAIN
235   SMTP connection from CALLER closed by QUIT
236 search_tidyup called
237 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>