X-Git-Url: https://git.exim.org/users/jgh/exim.git/blobdiff_plain/8f2401034e2ce4007b1f270cd389381753c814eb..0509be3542344cf27658df9935d930cb2d2b9560:/test/stderr/0038 diff --git a/test/stderr/0038 b/test/stderr/0038 index 5176c99a3..2cde5de35 100644 --- a/test/stderr/0038 +++ b/test/stderr/0038 @@ -11,26 +11,29 @@ >>> using ACL "check_rcpt" >>> processing "warn" >>> check ratelimit = 0/1h/strict ->>> ratelimit condition limit=0 period=3600 key=1h/per_mail/strict/V4NET.9.8.7 ->>> ratelimit initializing new key's data +>>> ratelimit condition count=1 0.0/1h/per_mail/V4NET.9.8.7 +>>> ratelimit creating new rate data block +>>> ratelimit initializing new key's rate data >>> ratelimit db updated ->>> ratelimit computed rate 0.0 ->>> warn: condition test succeeded -LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=0.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit computed rate 1.0 +>>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_rcpt" +LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h >>> processing "accept" ->>> accept: condition test succeeded +>>> accept: condition test succeeded in ACL "check_rcpt" +>>> end of ACL "check_rcpt": ACCEPT >>> host in ignore_fromline_hosts? no (option unset) >>> using ACL "check_data" >>> processing "warn" >>> check ratelimit = 0/1h/per_byte/strict ->>> ratelimit condition limit=0 period=3600 key=1h/per_byte/strict/V4NET.9.8.7 ->>> ratelimit initializing new key's data ->>> ratelimit db updated ->>> ratelimit computed rate 0.0 ->>> warn: condition test succeeded -LOG: 10HmaX-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=0.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit condition count=19 0.0/1h/per_mail/V4NET.9.8.7 +>>> ratelimit found pre-computed rate 1.0 +>>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_data" +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 >>> processing "deny" ->>> deny: condition test succeeded +>>> deny: condition test succeeded in ACL "check_data" +>>> end of ACL "check_data": DENY LOG: 10HmaX-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> host in hosts_connection_nolog? no (option unset) >>> host in host_lookup? no (option unset) @@ -45,24 +48,28 @@ LOG: 10HmaX-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> using ACL "check_rcpt" >>> processing "warn" >>> check ratelimit = 0/1h/strict ->>> ratelimit condition limit=0 period=3600 key=1h/per_mail/strict/V4NET.9.8.7 +>>> ratelimit condition count=1 0.0/1h/per_mail/V4NET.9.8.7 +>>> ratelimit found key in database >>> ratelimit db updated ->>> ratelimit computed rate 1.0 ->>> warn: condition test succeeded -LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit computed rate 2.0 +>>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_rcpt" +LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=2.0 sender_rate_limit=0 sender_rate_period=1h >>> processing "accept" ->>> accept: condition test succeeded +>>> accept: condition test succeeded in ACL "check_rcpt" +>>> end of ACL "check_rcpt": ACCEPT >>> host in ignore_fromline_hosts? no (option unset) >>> using ACL "check_data" >>> processing "warn" >>> check ratelimit = 0/1h/per_byte/strict ->>> ratelimit condition limit=0 period=3600 key=1h/per_byte/strict/V4NET.9.8.7 ->>> ratelimit db updated ->>> ratelimit computed rate 19.0 ->>> warn: condition test succeeded -LOG: 10HmaY-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=19.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit condition count=19 0.0/1h/per_mail/V4NET.9.8.7 +>>> ratelimit found pre-computed rate 2.0 +>>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_data" +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 >>> processing "deny" ->>> deny: condition test succeeded +>>> deny: condition test succeeded in ACL "check_data" +>>> end of ACL "check_data": DENY LOG: 10HmaY-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> host in hosts_connection_nolog? no (option unset) >>> host in host_lookup? no (option unset) @@ -77,24 +84,29 @@ LOG: 10HmaY-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> using ACL "check_rcpt" >>> processing "warn" >>> check ratelimit = 0/1h/per_conn/strict ->>> ratelimit condition limit=0 period=3600 key=1h/per_conn/strict/V4NET.9.8.7 ->>> ratelimit initializing new key's data +>>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7 +>>> ratelimit creating new rate data block +>>> ratelimit initializing new key's rate data >>> ratelimit db updated ->>> ratelimit computed rate 0.0 ->>> warn: condition test succeeded -LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=0.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit computed rate 1.0 +>>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_rcpt" +LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h >>> processing "accept" ->>> accept: condition test succeeded +>>> accept: condition test succeeded in ACL "check_rcpt" +>>> end of ACL "check_rcpt": ACCEPT >>> host in ignore_fromline_hosts? no (option unset) >>> using ACL "check_data" >>> processing "warn" >>> check ratelimit = 0/1h/per_conn/strict ->>> ratelimit condition limit=0 period=3600 key=1h/per_conn/strict/V4NET.9.8.7 ->>> ratelimit found pre-computed rate 0.0 ->>> warn: condition test succeeded -LOG: 10HmaZ-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=0.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7 +>>> ratelimit found pre-computed rate 1.0 +>>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_data" +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 >>> processing "deny" ->>> deny: condition test succeeded +>>> deny: condition test succeeded in ACL "check_data" +>>> end of ACL "check_data": DENY LOG: 10HmaZ-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> host in hosts_connection_nolog? no (option unset) >>> host in host_lookup? no (option unset) @@ -109,23 +121,28 @@ LOG: 10HmaZ-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> using ACL "check_rcpt" >>> processing "warn" >>> check ratelimit = 0/1h/per_conn/strict ->>> ratelimit condition limit=0 period=3600 key=1h/per_conn/strict/V4NET.9.8.7 +>>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7 +>>> ratelimit found key in database >>> ratelimit db updated ->>> ratelimit computed rate 1.0 ->>> warn: condition test succeeded -LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit computed rate 2.0 +>>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_rcpt" +LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=2.0 sender_rate_limit=0 sender_rate_period=1h >>> processing "accept" ->>> accept: condition test succeeded +>>> accept: condition test succeeded in ACL "check_rcpt" +>>> end of ACL "check_rcpt": ACCEPT >>> host in ignore_fromline_hosts? no (option unset) >>> using ACL "check_data" >>> processing "warn" >>> check ratelimit = 0/1h/per_conn/strict ->>> ratelimit condition limit=0 period=3600 key=1h/per_conn/strict/V4NET.9.8.7 ->>> ratelimit found pre-computed rate 1.0 ->>> warn: condition test succeeded -LOG: 10HmbA-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7 +>>> ratelimit found pre-computed rate 2.0 +>>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_data" +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 >>> processing "deny" ->>> deny: condition test succeeded +>>> deny: condition test succeeded in ACL "check_data" +>>> end of ACL "check_data": DENY LOG: 10HmbA-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> host in hosts_connection_nolog? no (option unset) >>> host in host_lookup? no (option unset) @@ -140,46 +157,57 @@ LOG: 10HmbA-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> using ACL "check_rcpt" >>> processing "warn" >>> check ratelimit = 0/1h/per_rcpt ->>> ratelimit condition limit=0 period=3600 key=1h/per_cmd/leaky/V4NET.9.8.7 ->>> ratelimit initializing new key's data +>>> ratelimit condition count=1 0.0/1h/per_rcpt/V4NET.9.8.7 +>>> ratelimit creating new rate data block +>>> ratelimit initializing new key's rate data >>> ratelimit db not updated: over the limit, but leaky ->>> ratelimit computed rate 0.0 ->>> warn: condition test succeeded -LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=0.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit computed rate 1.0 +>>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_rcpt" +LOG: H=(test.ex) [V4NET.9.8.7] Warning: RCPT: sender_rate=1.0 sender_rate_limit=0 sender_rate_period=1h >>> processing "accept" ->>> accept: condition test succeeded +>>> accept: condition test succeeded in ACL "check_rcpt" +>>> end of ACL "check_rcpt": ACCEPT >>> using ACL "check_rcpt" >>> processing "warn" >>> check ratelimit = 0/1h/per_rcpt ->>> ratelimit condition limit=0 period=3600 key=1h/per_cmd/leaky/V4NET.9.8.7 ->>> ratelimit initializing new key's data +>>> ratelimit condition count=1 0.0/1h/per_rcpt/V4NET.9.8.7 +>>> ratelimit creating new rate data block +>>> ratelimit initializing new key's rate data >>> ratelimit db not updated: over the limit, but leaky ->>> ratelimit computed rate 0.0 ->>> warn: condition test succeeded +>>> ratelimit computed rate 1.0 +>>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_rcpt" >>> processing "accept" ->>> accept: condition test succeeded +>>> accept: condition test succeeded in ACL "check_rcpt" +>>> end of ACL "check_rcpt": ACCEPT >>> using ACL "check_rcpt" >>> processing "warn" >>> check ratelimit = 0/1h/per_rcpt ->>> ratelimit condition limit=0 period=3600 key=1h/per_cmd/leaky/V4NET.9.8.7 ->>> ratelimit initializing new key's data +>>> ratelimit condition count=1 0.0/1h/per_rcpt/V4NET.9.8.7 +>>> ratelimit creating new rate data block +>>> ratelimit initializing new key's rate data >>> ratelimit db not updated: over the limit, but leaky ->>> ratelimit computed rate 0.0 ->>> warn: condition test succeeded +>>> ratelimit computed rate 1.0 +>>> l_message: RCPT: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_rcpt" >>> processing "accept" ->>> accept: condition test succeeded +>>> accept: condition test succeeded in ACL "check_rcpt" +>>> end of ACL "check_rcpt": ACCEPT >>> host in ignore_fromline_hosts? no (option unset) >>> using ACL "check_data" >>> processing "warn" >>> check ratelimit = 0/1h/per_conn ->>> ratelimit condition limit=0 period=3600 key=1h/per_conn/leaky/V4NET.9.8.7 ->>> ratelimit initializing new key's data +>>> ratelimit condition count=1 0.0/1h/per_conn/V4NET.9.8.7 +>>> ratelimit found key in database >>> ratelimit db not updated: over the limit, but leaky ->>> ratelimit computed rate 0.0 ->>> warn: condition test succeeded -LOG: 10HmbB-0005vi-00 H=(test.ex) [V4NET.9.8.7] Warning: DATA: sender_rate=0.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit computed rate 3.0 +>>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_data" +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 >>> processing "deny" ->>> deny: condition test succeeded +>>> deny: condition test succeeded in ACL "check_data" +>>> end of ACL "check_data": DENY LOG: 10HmbB-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> host in hosts_connection_nolog? no (option unset) >>> host in host_lookup? no (option unset) @@ -194,45 +222,50 @@ LOG: 10HmbB-0005vi-00 H=(test.ex) [V4NET.9.8.7] F=<> rejected after DATA >>> using ACL "check_rcpt2" >>> processing "warn" >>> check ratelimit = 1/1m/per_rcpt/noupdate ->>> ratelimit condition limit=1 period=60 key=1m/per_cmd/leaky/V4NET.9.8.6 ->>> ratelimit initializing new key's data ->>> ratelimit db not updated: noupdate set +>>> ratelimit condition count=0 1.0/1m/per_rcpt/V4NET.9.8.6 +>>> ratelimit creating new rate data block +>>> ratelimit initializing new key's rate data +>>> ratelimit db not updated: readonly mode >>> ratelimit computed rate 0.0 ->>> warn: condition test failed +>>> warn: condition test failed in ACL "check_rcpt2" >>> processing "warn" >>> check ratelimit = 1/1m/per_rcpt ->>> ratelimit condition limit=1 period=60 key=1m/per_cmd/leaky/V4NET.9.8.6 ->>> ratelimit initializing new key's data ->>> ratelimit db updated ->>> ratelimit computed rate 0.0 ->>> warn: condition test failed +>>> ratelimit condition count=1 1.0/1m/per_rcpt/V4NET.9.8.6 +>>> ratelimit found pre-computed rate 0.0 +>>> warn: condition test failed in ACL "check_rcpt2" >>> processing "accept" ->>> accept: condition test succeeded +>>> accept: condition test succeeded in ACL "check_rcpt2" +>>> end of ACL "check_rcpt2": ACCEPT >>> using ACL "check_rcpt2" >>> processing "warn" >>> check ratelimit = 1/1m/per_rcpt/noupdate ->>> ratelimit condition limit=1 period=60 key=1m/per_cmd/leaky/V4NET.9.8.6 ->>> ratelimit db not updated: noupdate set ->>> ratelimit computed rate 1.0 ->>> warn: condition test failed +>>> ratelimit condition count=0 1.0/1m/per_rcpt/V4NET.9.8.6 +>>> ratelimit creating new rate data block +>>> ratelimit initializing new key's rate data +>>> ratelimit db not updated: readonly mode +>>> ratelimit computed rate 0.0 +>>> warn: condition test failed in ACL "check_rcpt2" >>> processing "warn" >>> check ratelimit = 1/1m/per_rcpt ->>> ratelimit condition limit=1 period=60 key=1m/per_cmd/leaky/V4NET.9.8.6 ->>> ratelimit db updated ->>> ratelimit computed rate 1.0 ->>> warn: condition test failed +>>> ratelimit condition count=1 1.0/1m/per_rcpt/V4NET.9.8.6 +>>> ratelimit found pre-computed rate 0.0 +>>> warn: condition test failed in ACL "check_rcpt2" >>> processing "accept" ->>> accept: condition test succeeded +>>> accept: condition test succeeded in ACL "check_rcpt2" +>>> end of ACL "check_rcpt2": ACCEPT >>> host in ignore_fromline_hosts? no (option unset) >>> using ACL "check_data" >>> processing "warn" >>> check ratelimit = 0/1h/per_byte/strict ->>> ratelimit condition limit=0 period=3600 key=1h/per_byte/strict/V4NET.9.8.6 ->>> ratelimit initializing new key's data +>>> ratelimit condition count=19 0.0/1h/per_mail/V4NET.9.8.6 +>>> ratelimit creating new rate data block +>>> ratelimit initializing new key's rate data >>> ratelimit db updated ->>> ratelimit computed rate 0.0 ->>> warn: condition test succeeded -LOG: 10HmbC-0005vi-00 H=(test.ex) [V4NET.9.8.6] Warning: DATA: sender_rate=0.0 sender_rate_limit=0 sender_rate_period=1h +>>> ratelimit computed rate 19.0 +>>> l_message: DATA: sender_rate=$sender_rate sender_rate_limit=$sender_rate_limit sender_rate_period=$sender_rate_period +>>> warn: condition test succeeded in ACL "check_data" +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 >>> processing "deny" ->>> deny: condition test succeeded +>>> deny: condition test succeeded in ACL "check_data" +>>> end of ACL "check_data": DENY LOG: 10HmbC-0005vi-00 H=(test.ex) [V4NET.9.8.6] F=<> rejected after DATA