Amavis process pinning CPU at 100% returning after 5 to 30 minutes

[Arrigo Triulzi]

On 30 Aug 2022, at 15:27, Damian <amavis at arcsin.de> wrote:
>> Aug 30 12:50:09 mailgate-fra-1 amavis[24524]: (24524-01) truncating a message passed to SA at 414138 bytes, orig 569545
>> 
>> [process gets killed after 5m]
>> 
>> Aug 30 12:54:48 mailgate-fra-1 amavis[24524]: (24524-01) (!)TempDir removal: tempdir is to be PRESERVED: /var/amavisd/tmp/amavis-20220830T125008-24524-HdayDdgJ
>> 
>> Any better debugging ideas?
>> 
> Truncate the message for your manual test as amavis did. It is possible that a SpamAssassin rule regex heavily backtracks when it encounters end-of-input instead of what comes next naturally.

Duh, of course… thank you for pointing that out. Sadly no change, terminates in 5s or so.

Aug 30 14:21:58.765 [27174] dbg: timing: total 5358 ms - init: 3431 (64.0%), parse: 23 (0.4%), extract_message_metadata: 229 (4.3%), get_uri_detail_list: 40 (0.7%), tests_pri_-1000: 112 (2.1%), compile_gen: 186 (3.5%), compile_eval: 39 (0.7%), tests_pri_-950: 5 (0.1%), tests_pri_-900: 6 (0.1%), tests_pri_-90: 4.6 (0.1%), tests_pri_0: 1362 (25.4%), check_spf: 62 (1.2%), dkim_load_modules: 39 (0.7%), check_dkim_signature: 11 (0.2%), check_dkim_adsp: 5 (0.1%), poll_dns_idle: 0.07 (0.0%), tests_pri_20: 6 (0.1%), tests_pri_30: 6 (0.1%), check_pyzor: 0.38 (0.0%), tests_pri_500: 146 (2.7%)
Aug 30 14:21:58.769 [27174] dbg: check: tagrun - tag SENDERDOMAIN is still blocking action 3
Aug 30 14:21:58.769 [27174] dbg: check: tagrun - tag DKIMDOMAIN is still blocking action 0