Debug: quieten environment-cleaning
[exim.git] / test / stderr / 0038
1 >>> host in hosts_connection_nolog? no (option unset)
2 >>> host in host_lookup? no (option unset)
3 >>> host in host_reject_connection? no (option unset)
4 >>> host in sender_unqualified_hosts? no (option unset)
5 >>> host in recipient_unqualified_hosts? no (option unset)
6 >>> host in helo_verify_hosts? no (option unset)
7 >>> host in helo_try_verify_hosts? no (option unset)
8 >>> host in helo_accept_junk_hosts? no (option unset)
9 >>> host in pipelining_connect_advertise_hosts?
10 >>>  list element: 
11 >>> test.ex in helo_lookup_domains?
12 >>>  list element: @
13 >>>  list element: @[]
14 >>> test.ex in helo_lookup_domains? no (end of list)
15 >>> host in limits_advertise_hosts?
16 >>>  list element: !*
17 >>> host in dsn_advertise_hosts? no (option unset)
18 >>> host in pipelining_advertise_hosts?
19 >>>  list element: *
20 >>>  host in pipelining_advertise_hosts? yes (matched "*")
21 >>> host in chunking_advertise_hosts?
22 >>> host in chunking_advertise_hosts? no (end of list)
23 >>> host in tls_advertise_hosts?
24 >>> using ACL "check_rcpt"
25 >>> processing "warn" (TESTSUITE/test-config 23)
26 >>> check ratelimit = 0/1h/strict
27 >>> ratelimit condition count=1 0.0/1h/per_mail/V4NET.9.8.7
28 >>> ratelimit creating new rate data block
29 >>> ratelimit initializing new key's rate data
30 >>> ratelimit db updated
31 >>> ratelimit computed rate 1.0
32 >>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
33 >>> warn: condition test succeeded in ACL "check_rcpt"
34 LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h
35 >>> processing "accept" (TESTSUITE/test-config 28)
36 >>> accept: condition test succeeded in ACL "check_rcpt"
37 >>> end of ACL "check_rcpt": ACCEPT
38 >>> host in ignore_fromline_hosts? no (option unset)
39 >>> using ACL "check_data"
40 >>> processing "warn" (TESTSUITE/test-config 46)
41 >>> check ratelimit = 0/1h/per_byte/strict
42 >>> ratelimit condition count=19 0.0/1h/per_mail/V4NET.9.8.7
43 >>> ratelimit found pre-computed rate 1.0
44 >>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
45 >>> warn: condition test succeeded in ACL "check_data"
46 LOG: 10HmaX-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h
47 >>> processing "deny" (TESTSUITE/test-config 51)
48 >>> deny: condition test succeeded in ACL "check_data"
49 >>> end of ACL "check_data": DENY
50 LOG: 10HmaX-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA
51 >>> host in hosts_connection_nolog? no (option unset)
52 >>> host in host_lookup? no (option unset)
53 >>> host in host_reject_connection? no (option unset)
54 >>> host in sender_unqualified_hosts? no (option unset)
55 >>> host in recipient_unqualified_hosts? no (option unset)
56 >>> host in helo_verify_hosts? no (option unset)
57 >>> host in helo_try_verify_hosts? no (option unset)
58 >>> host in helo_accept_junk_hosts? no (option unset)
59 >>> host in pipelining_connect_advertise_hosts?
60 >>>  list element: 
61 >>> test.ex in helo_lookup_domains?
62 >>>  list element: @
63 >>>  list element: @[]
64 >>> test.ex in helo_lookup_domains? no (end of list)
65 >>> host in limits_advertise_hosts?
66 >>>  list element: !*
67 >>> host in dsn_advertise_hosts? no (option unset)
68 >>> host in pipelining_advertise_hosts?
69 >>>  list element: *
70 >>>  host in pipelining_advertise_hosts? yes (matched "*")
71 >>> host in chunking_advertise_hosts?
72 >>> host in chunking_advertise_hosts? no (end of list)
73 >>> host in tls_advertise_hosts?
74 >>> using ACL "check_rcpt"
75 >>> processing "warn" (TESTSUITE/test-config 23)
76 >>> check ratelimit = 0/1h/strict
77 >>> ratelimit condition count=1 0.0/1h/per_mail/V4NET.9.8.7
78 >>> ratelimit found key in database
79 >>> ratelimit db updated
80 >>> ratelimit computed rate 2.0
81 >>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
82 >>> warn: condition test succeeded in ACL "check_rcpt"
83 LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=2.0 sender_rate_limit=0 sender_rate_period=1h
84 >>> processing "accept" (TESTSUITE/test-config 28)
85 >>> accept: condition test succeeded in ACL "check_rcpt"
86 >>> end of ACL "check_rcpt": ACCEPT
87 >>> host in ignore_fromline_hosts? no (option unset)
88 >>> using ACL "check_data"
89 >>> processing "warn" (TESTSUITE/test-config 46)
90 >>> check ratelimit = 0/1h/per_byte/strict
91 >>> ratelimit condition count=19 0.0/1h/per_mail/V4NET.9.8.7
92 >>> ratelimit found pre-computed rate 2.0
93 >>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
94 >>> warn: condition test succeeded in ACL "check_data"
95 LOG: 10HmaY-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=2.0 sender_rate_limit=0 sender_rate_period=1h
96 >>> processing "deny" (TESTSUITE/test-config 51)
97 >>> deny: condition test succeeded in ACL "check_data"
98 >>> end of ACL "check_data": DENY
99 LOG: 10HmaY-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA
100 >>> host in hosts_connection_nolog? no (option unset)
101 >>> host in host_lookup? no (option unset)
102 >>> host in host_reject_connection? no (option unset)
103 >>> host in sender_unqualified_hosts? no (option unset)
104 >>> host in recipient_unqualified_hosts? no (option unset)
105 >>> host in helo_verify_hosts? no (option unset)
106 >>> host in helo_try_verify_hosts? no (option unset)
107 >>> host in helo_accept_junk_hosts? no (option unset)
108 >>> host in pipelining_connect_advertise_hosts?
109 >>>  list element: 
110 >>> test.ex in helo_lookup_domains?
111 >>>  list element: @
112 >>>  list element: @[]
113 >>> test.ex in helo_lookup_domains? no (end of list)
114 >>> host in limits_advertise_hosts?
115 >>>  list element: !*
116 >>> host in dsn_advertise_hosts? no (option unset)
117 >>> host in pipelining_advertise_hosts?
118 >>>  list element: *
119 >>>  host in pipelining_advertise_hosts? yes (matched "*")
120 >>> host in chunking_advertise_hosts?
121 >>> host in chunking_advertise_hosts? no (end of list)
122 >>> host in tls_advertise_hosts?
123 >>> using ACL "check_rcpt"
124 >>> processing "warn" (TESTSUITE/test-config 23)
125 >>> check ratelimit = 0/1h/per_conn/strict
126 >>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7
127 >>> ratelimit creating new rate data block
128 >>> ratelimit initializing new key's rate data
129 >>> ratelimit db updated
130 >>> ratelimit computed rate 1.0
131 >>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
132 >>> warn: condition test succeeded in ACL "check_rcpt"
133 LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h
134 >>> processing "accept" (TESTSUITE/test-config 28)
135 >>> accept: condition test succeeded in ACL "check_rcpt"
136 >>> end of ACL "check_rcpt": ACCEPT
137 >>> host in ignore_fromline_hosts? no (option unset)
138 >>> using ACL "check_data"
139 >>> processing "warn" (TESTSUITE/test-config 46)
140 >>> check ratelimit = 0/1h/per_conn/strict
141 >>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7
142 >>> ratelimit found pre-computed rate 1.0
143 >>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
144 >>> warn: condition test succeeded in ACL "check_data"
145 LOG: 10HmaZ-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h
146 >>> processing "deny" (TESTSUITE/test-config 51)
147 >>> deny: condition test succeeded in ACL "check_data"
148 >>> end of ACL "check_data": DENY
149 LOG: 10HmaZ-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA
150 >>> host in hosts_connection_nolog? no (option unset)
151 >>> host in host_lookup? no (option unset)
152 >>> host in host_reject_connection? no (option unset)
153 >>> host in sender_unqualified_hosts? no (option unset)
154 >>> host in recipient_unqualified_hosts? no (option unset)
155 >>> host in helo_verify_hosts? no (option unset)
156 >>> host in helo_try_verify_hosts? no (option unset)
157 >>> host in helo_accept_junk_hosts? no (option unset)
158 >>> host in pipelining_connect_advertise_hosts?
159 >>>  list element: 
160 >>> test.ex in helo_lookup_domains?
161 >>>  list element: @
162 >>>  list element: @[]
163 >>> test.ex in helo_lookup_domains? no (end of list)
164 >>> host in limits_advertise_hosts?
165 >>>  list element: !*
166 >>> host in dsn_advertise_hosts? no (option unset)
167 >>> host in pipelining_advertise_hosts?
168 >>>  list element: *
169 >>>  host in pipelining_advertise_hosts? yes (matched "*")
170 >>> host in chunking_advertise_hosts?
171 >>> host in chunking_advertise_hosts? no (end of list)
172 >>> host in tls_advertise_hosts?
173 >>> using ACL "check_rcpt"
174 >>> processing "warn" (TESTSUITE/test-config 23)
175 >>> check ratelimit = 0/1h/per_conn/strict
176 >>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7
177 >>> ratelimit found key in database
178 >>> ratelimit db updated
179 >>> ratelimit computed rate 2.0
180 >>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
181 >>> warn: condition test succeeded in ACL "check_rcpt"
182 LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=2.0 sender_rate_limit=0 sender_rate_period=1h
183 >>> processing "accept" (TESTSUITE/test-config 28)
184 >>> accept: condition test succeeded in ACL "check_rcpt"
185 >>> end of ACL "check_rcpt": ACCEPT
186 >>> host in ignore_fromline_hosts? no (option unset)
187 >>> using ACL "check_data"
188 >>> processing "warn" (TESTSUITE/test-config 46)
189 >>> check ratelimit = 0/1h/per_conn/strict
190 >>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7
191 >>> ratelimit found pre-computed rate 2.0
192 >>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
193 >>> warn: condition test succeeded in ACL "check_data"
194 LOG: 10HmbA-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=2.0 sender_rate_limit=0 sender_rate_period=1h
195 >>> processing "deny" (TESTSUITE/test-config 51)
196 >>> deny: condition test succeeded in ACL "check_data"
197 >>> end of ACL "check_data": DENY
198 LOG: 10HmbA-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA
199 >>> host in hosts_connection_nolog? no (option unset)
200 >>> host in host_lookup? no (option unset)
201 >>> host in host_reject_connection? no (option unset)
202 >>> host in sender_unqualified_hosts? no (option unset)
203 >>> host in recipient_unqualified_hosts? no (option unset)
204 >>> host in helo_verify_hosts? no (option unset)
205 >>> host in helo_try_verify_hosts? no (option unset)
206 >>> host in helo_accept_junk_hosts? no (option unset)
207 >>> host in pipelining_connect_advertise_hosts?
208 >>>  list element: 
209 >>> test.ex in helo_lookup_domains?
210 >>>  list element: @
211 >>>  list element: @[]
212 >>> test.ex in helo_lookup_domains? no (end of list)
213 >>> host in limits_advertise_hosts?
214 >>>  list element: !*
215 >>> host in dsn_advertise_hosts? no (option unset)
216 >>> host in pipelining_advertise_hosts?
217 >>>  list element: *
218 >>>  host in pipelining_advertise_hosts? yes (matched "*")
219 >>> host in chunking_advertise_hosts?
220 >>> host in chunking_advertise_hosts? no (end of list)
221 >>> host in tls_advertise_hosts?
222 >>> using ACL "check_rcpt"
223 >>> processing "warn" (TESTSUITE/test-config 23)
224 >>> check ratelimit = 0/1h/per_rcpt
225 >>> ratelimit condition count=1 0.0/1h/per_rcpt/V4NET.9.8.7
226 >>> ratelimit creating new rate data block
227 >>> ratelimit initializing new key's rate data
228 >>> ratelimit db not updated: over the limit, but leaky
229 >>> ratelimit computed rate 1.0
230 >>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
231 >>> warn: condition test succeeded in ACL "check_rcpt"
232 LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h
233 >>> processing "accept" (TESTSUITE/test-config 28)
234 >>> accept: condition test succeeded in ACL "check_rcpt"
235 >>> end of ACL "check_rcpt": ACCEPT
236 >>> using ACL "check_rcpt"
237 >>> processing "warn" (TESTSUITE/test-config 23)
238 >>> check ratelimit = 0/1h/per_rcpt
239 >>> ratelimit condition count=1 0.0/1h/per_rcpt/V4NET.9.8.7
240 >>> ratelimit creating new rate data block
241 >>> ratelimit initializing new key's rate data
242 >>> ratelimit db not updated: over the limit, but leaky
243 >>> ratelimit computed rate 1.0
244 >>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
245 >>> warn: condition test succeeded in ACL "check_rcpt"
246 >>> processing "accept" (TESTSUITE/test-config 28)
247 >>> accept: condition test succeeded in ACL "check_rcpt"
248 >>> end of ACL "check_rcpt": ACCEPT
249 >>> using ACL "check_rcpt"
250 >>> processing "warn" (TESTSUITE/test-config 23)
251 >>> check ratelimit = 0/1h/per_rcpt
252 >>> ratelimit condition count=1 0.0/1h/per_rcpt/V4NET.9.8.7
253 >>> ratelimit creating new rate data block
254 >>> ratelimit initializing new key's rate data
255 >>> ratelimit db not updated: over the limit, but leaky
256 >>> ratelimit computed rate 1.0
257 >>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
258 >>> warn: condition test succeeded in ACL "check_rcpt"
259 >>> processing "accept" (TESTSUITE/test-config 28)
260 >>> accept: condition test succeeded in ACL "check_rcpt"
261 >>> end of ACL "check_rcpt": ACCEPT
262 >>> host in ignore_fromline_hosts? no (option unset)
263 >>> using ACL "check_data"
264 >>> processing "warn" (TESTSUITE/test-config 46)
265 >>> check ratelimit = 0/1h/per_conn
266 >>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7
267 >>> ratelimit found key in database
268 >>> ratelimit db not updated: over the limit, but leaky
269 >>> ratelimit computed rate 3.0
270 >>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
271 >>> warn: condition test succeeded in ACL "check_data"
272 LOG: 10HmbB-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=3.0 sender_rate_limit=0 sender_rate_period=1h
273 >>> processing "deny" (TESTSUITE/test-config 51)
274 >>> deny: condition test succeeded in ACL "check_data"
275 >>> end of ACL "check_data": DENY
276 LOG: 10HmbB-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA
277 >>> host in hosts_connection_nolog? no (option unset)
278 >>> host in host_lookup? no (option unset)
279 >>> host in host_reject_connection? no (option unset)
280 >>> host in sender_unqualified_hosts? no (option unset)
281 >>> host in recipient_unqualified_hosts? no (option unset)
282 >>> host in helo_verify_hosts? no (option unset)
283 >>> host in helo_try_verify_hosts? no (option unset)
284 >>> host in helo_accept_junk_hosts? no (option unset)
285 >>> host in pipelining_connect_advertise_hosts?
286 >>>  list element: 
287 >>> test.ex in helo_lookup_domains?
288 >>>  list element: @
289 >>>  list element: @[]
290 >>> test.ex in helo_lookup_domains? no (end of list)
291 >>> host in limits_advertise_hosts?
292 >>>  list element: !*
293 >>> host in dsn_advertise_hosts? no (option unset)
294 >>> host in pipelining_advertise_hosts?
295 >>>  list element: *
296 >>>  host in pipelining_advertise_hosts? yes (matched "*")
297 >>> host in chunking_advertise_hosts?
298 >>> host in chunking_advertise_hosts? no (end of list)
299 >>> host in tls_advertise_hosts?
300 >>> using ACL "check_rcpt2"
301 >>> processing "warn" (TESTSUITE/test-config 31)
302 >>> check ratelimit = 1/1m/per_rcpt/noupdate
303 >>> ratelimit condition count=0 1.0/1m/per_rcpt/V4NET.9.8.6
304 >>> ratelimit creating new rate data block
305 >>> ratelimit initializing new key's rate data
306 >>> ratelimit db not updated: readonly mode
307 >>> ratelimit computed rate 0.0
308 >>> warn: condition test failed in ACL "check_rcpt2"
309 >>> processing "warn" (TESTSUITE/test-config 37)
310 >>> check ratelimit = 1/1m/per_rcpt
311 >>> ratelimit condition count=1 1.0/1m/per_rcpt/V4NET.9.8.6
312 >>> ratelimit found pre-computed rate 0.0
313 >>> warn: condition test failed in ACL "check_rcpt2"
314 >>> processing "accept" (TESTSUITE/test-config 43)
315 >>> accept: condition test succeeded in ACL "check_rcpt2"
316 >>> end of ACL "check_rcpt2": ACCEPT
317 >>> using ACL "check_rcpt2"
318 >>> processing "warn" (TESTSUITE/test-config 31)
319 >>> check ratelimit = 1/1m/per_rcpt/noupdate
320 >>> ratelimit condition count=0 1.0/1m/per_rcpt/V4NET.9.8.6
321 >>> ratelimit creating new rate data block
322 >>> ratelimit initializing new key's rate data
323 >>> ratelimit db not updated: readonly mode
324 >>> ratelimit computed rate 0.0
325 >>> warn: condition test failed in ACL "check_rcpt2"
326 >>> processing "warn" (TESTSUITE/test-config 37)
327 >>> check ratelimit = 1/1m/per_rcpt
328 >>> ratelimit condition count=1 1.0/1m/per_rcpt/V4NET.9.8.6
329 >>> ratelimit found pre-computed rate 0.0
330 >>> warn: condition test failed in ACL "check_rcpt2"
331 >>> processing "accept" (TESTSUITE/test-config 43)
332 >>> accept: condition test succeeded in ACL "check_rcpt2"
333 >>> end of ACL "check_rcpt2": ACCEPT
334 >>> host in ignore_fromline_hosts? no (option unset)
335 >>> using ACL "check_data"
336 >>> processing "warn" (TESTSUITE/test-config 46)
337 >>> check ratelimit = 0/1h/per_byte/strict
338 >>> ratelimit condition count=19 0.0/1h/per_mail/V4NET.9.8.6
339 >>> ratelimit creating new rate data block
340 >>> ratelimit initializing new key's rate data
341 >>> ratelimit db updated
342 >>> ratelimit computed rate 19.0
343 >>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period
344 >>> warn: condition test succeeded in ACL "check_data"
345 LOG: 10HmbC-0005vi-00 H=(test.ex) [V4NET.9.8.6] Warning: DATA: sender_rate=19.0 sender_rate_limit=0 sender_rate_period=1h
346 >>> processing "deny" (TESTSUITE/test-config 51)
347 >>> deny: condition test succeeded in ACL "check_data"
348 >>> end of ACL "check_data": DENY
349 LOG: 10HmbC-0005vi-00 H=(test.ex) [V4NET.9.8.6] F=<> rejected after DATA