Re: missing spamassassin checks

On 24/08/2020 13.46, Martin Thomas Schrott wrote:
> 
>> Anyone has a similar issue? What can be the cause?
> 
> 
> Hi, yes same here - had no time yet to see what the problem is though. But at least, you are not alone ;-)
> 
> 

spamassasin log:
[root@black ~]# less sa_log |grep URIBL_DBL_SPAM
	URIBL_DBL_SPAM,ZABOJCASPAMU_BAYES_HIGH,ZABOJCASPAMU_FROM_UNKNOWN
 2.5 URIBL_DBL_SPAM         Contains a spam URL listed in the Spamhaus DBL
 2.5 URIBL_DBL_SPAM         Contains a spam URL listed in the Spamhaus DBL
Aug 24 14:38:29.072 [1673120] dbg: async: query 57701/IN/A/freshwarm.cyou.dbl.spamhaus.org already underway, adding no.3 URIBL_DBL_SPAM
Aug 24 14:38:29.072 [1673120] dbg: dns: URIBL_DBL_SPAM lookup start
Aug 24 14:38:29.104 [1673120] dbg: async: query 14205/IN/A/imgstore.host.dbl.spamhaus.org already underway, adding no.3 URIBL_DBL_SPAM
Aug 24 14:38:29.104 [1673120] dbg: dns: URIBL_DBL_SPAM lookup start
Aug 24 14:38:29.303 [1673120] dbg: async: calling callback on key DNSBL:imgstore.host:dbl.spamhaus.org, rule URIBL_DBL_SPAM
Aug 24 14:38:29.303 [1673120] dbg: uridnsbl: complete_dnsbl_lookup URIBL_DBL_SPAM DNSBL:imgstore.host:dbl.spamhaus.org
Aug 24 14:38:29.312 [1673120] dbg: async: calling callback on key DNSBL:freshwarm.cyou:dbl.spamhaus.org, rule URIBL_DBL_SPAM
Aug 24 14:38:29.312 [1673120] dbg: uridnsbl: complete_dnsbl_lookup URIBL_DBL_SPAM DNSBL:freshwarm.cyou:dbl.spamhaus.org
Aug 24 14:38:29.313 [1673120] dbg: uridnsbl: freshwarm.cyou . dbl.spamhaus.org -> 127.0.1.2, URIBL_DBL_SPAM, subtest:2130706690-2130706690
Aug 24 14:38:29.313 [1673120] dbg: uridnsbl: freshwarm.cyou . dbl.spamhaus.org -> 127.0.1.2, URIBL_DBL_SPAM, 7f000102 == 7f000102 match
Aug 24 14:38:29.313 [1673120] dbg: uridnsbl: domain "freshwarm.cyou" listed (URIBL_DBL_SPAM): 127.0.1.2
Aug 24 14:38:29.314 [1673120] dbg: dns: URIBL_DBL_SPAM lookup finished

amavis log:
[root@black ~]# cat amamvis_sa.log |grep URIBL_DBL_SPAM
Aug 24 04:53:10 black amavis[1561530]: (1561530-09) SA dbg: async: query 41830/IN/A/freshwarm.cyou.dbl.spamhaus.org already underway, adding no.8 URIBL_DBL_SPAM
Aug 24 04:53:10 black amavis[1561530]: (1561530-09) SA dbg: dns: URIBL_DBL_SPAM lookup start
Aug 24 04:53:11 black amavis[1561530]: (1561530-09) SA dbg: async: query 31094/IN/A/imgstore.host.dbl.spamhaus.org already underway, adding no.8 URIBL_DBL_SPAM
Aug 24 04:53:11 black amavis[1561530]: (1561530-09) SA dbg: dns: URIBL_DBL_SPAM lookup start
Aug 24 04:53:11 black amavis[1561530]: (1561530-09) SA dbg: async: calling callback on key DNSBL:freshwarm.cyou:dbl.spamhaus.org, rule URIBL_DBL_SPAM
Aug 24 04:53:11 black amavis[1561530]: (1561530-09) SA dbg: uridnsbl: complete_dnsbl_lookup URIBL_DBL_SPAM DNSBL:freshwarm.cyou:dbl.spamhaus.org
Aug 24 04:53:11 black amavis[1561530]: (1561530-09) SA dbg: async: calling callback on key DNSBL:imgstore.host:dbl.spamhaus.org, rule URIBL_DBL_SPAM
Aug 24 04:53:11 black amavis[1561530]: (1561530-09) SA dbg: uridnsbl: complete_dnsbl_lookup URIBL_DBL_SPAM DNSBL:imgstore.host:dbl.spamhaus.org

Does this mean that URIBL_DBL_SPAM query is not finished in this case?

Regards,
Łukasz