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