You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@spamassassin.apache.org by Art Greenberg <ar...@artg.tv> on 2015/05/02 14:39:35 UTC

SA 3.4.1 - error messages in log?

I just moved from 3.4.0 to 3.4.1 and am seeing messages from SA in maillog 
that I've not seen before. Do they indicate an issue with my installation?

Here is a segment from the log. This pattern repeats each time SA 
processes a message. The use of uninitialized value and copy_config 
timeout are new, as is the change of child states.

May  2 06:45:29 sunshine spamd[22293]: Use of uninitialized value $hasStructureInfo in numeric eq (==) at (eval 46) line 5520.
May  2 06:45:40 sunshine spamd[22293]: spamd: identified spam (37.1/5.0) for artg:500 in 10.6 seconds, 2337 bytes.
May  2 06:45:40 sunshine spamd[22293]: spamd: result: Y 37 - BAYES_99,BAYES_999,BODY_URI_ONLY,CLAMAV,DCC_CHECK,DIGEST_MULTIPLE,HEADER_FROM_DIFFERENT_DOMAINS,HELO_DYNAMIC_IPADDR,HK_RANDOM_ENVFROM,HTML_MESSAGE,HTML_MIME_NO_HTML_TAG,KAM_INFOUSMEBIZ,KAM_RBL,MIME_HTML_ONLY,RAZOR2_CF_RANGE_51_100,RAZOR2_CF_RANGE_E8_51_100,RAZOR2_CHECK,RCVD_IN_PBL,RCVD_IN_PSBL,RCVD_IN_XBL,RDNS_NONE,RDNS_NONE_DIRECT_MX,TO_NO_BRKTS_NORDNS_HTML,TO_NO_BRKTS_PCNT,URIBL_BLACK,URIBL_DBL_ABUSE_REDIR scantime=10.6,size=2337,user=artg,uid=500,required_score=5.0,rhost=localhost.artg.tv,raddr=::1,rport=58511,mid=<66...@focsoncn.wbl.whitebear.k12.mn.us>,bayes=1.000000,autolearn=no autolearn_force=no
May  2 06:46:29 sunshine spamd[22290]: spamd: copy_config timeout, respawning child process after 1 messages at /usr/local/bin/spamd line 1447.
May  2 06:46:29 sunshine spamd[21741]: prefork: child states: BB
May  2 06:46:29 sunshine spamd[21741]: spamd: server successfully spawned child process, pid 24073
May  2 06:46:29 sunshine spamd[21741]: prefork: adjust: 0 idle children less than 1 minimum idle children. Increasing spamd children: 24073 started.
May  2 06:46:29 sunshine spamd[21741]: prefork: child states: BBI
May  2 06:46:30 sunshine spamd[21741]: spamd: handled cleanup of child pid [22290] due to SIGCHLD: exit 0
May  2 06:46:40 sunshine spamd[22293]: spamd: copy_config timeout, respawning child process after 1 messages at /usr/local/bin/spamd line 1447.
May  2 06:46:40 sunshine spamd[21741]: prefork: child states: BI
May  2 06:46:40 sunshine spamd[21741]: spamd: handled cleanup of child pid [22293] due to SIGCHLD: exit 0
May  2 06:46:40 sunshine spamd[21741]: spamd: server successfully spawned child process, pid 24074
May  2 06:46:40 sunshine spamd[21741]: prefork: child states: II

SA does seem to be processing messages correctly. But starting SA does 
seem to take forever ... I've had to increase the timeout on line 2977 in 
spamd from 180 to 600 seconds. I'm running SA just for personal email on a 
machine pretty much dedicated to handling email so performance is not a 
concern. Centos 6.6 64 bit, Intel E7300 2.66GHz with 4GB RAM and 500GB 
disk.


Thanks.

--
Art Greenberg
art@artg.tv


Re: SA 3.4.1 - error messages in log?

Posted by Art Greenberg <ar...@artg.tv>.
On Sun, 3 May 2015, Mark Martinec wrote:

>> On May 2, 2015 7:08:10 PM Mark Martinec wrote:
>>> > May  2 06:45:29 sunshine spamd[22293]: Use of uninitialized value
>>> > $hasStructureInfo in numeric eq (==) at (eval 46) line 5520.
>>>
>>> This one seems to come from a module Geo::IP, called form a
>>> SpamAssassin plugin URILocalBL.
>>> [...] Try disabling loading of a plugin URILocalBL as a start
>>> (in config file v341.pre).
>
> On 2015-05-03 2:26, Art Greenberg wrote:
>> The line for URILocalBL is commented out - I had not enabled it.
>
> There is also the RelayCountry plugin that is using the Geo::IP module.

Yes, thanks. I found that. I also found more than one version of Geo::IP 
on the computer. I resolved the issue by removing all versions of Geo::IP 
and the C API library and reinstalling them.

I resolved the issue with the timeout in copy_config by increasing the 
timeout value in spamd, line 1432, to 180 seconds. And I pointed out that 
I'd previously increased the timeout value in line 2977 to 600 seconds.

I'm not entirely comfortable increasing these hard-coded timeout values. 
But now I'm not seeing any other error messages with debug enabled. It 
just seems to be taking spamd a long time (~9 minutes) to start and 
copy_config takes almost 3 minutes.

Is it possible that my AWL and/or Bayes databases are too large? I've 
configured per-user AWL and Bayes.

What else should I look at?


--
Art Greenberg
art@artg.tv


Re: SA 3.4.1 - error messages in log?

Posted by Mark Martinec <Ma...@ijs.si>.
 > On May 2, 2015 7:08:10 PM Mark Martinec wrote:
 >> > May  2 06:45:29 sunshine spamd[22293]: Use of uninitialized value
 >> > $hasStructureInfo in numeric eq (==) at (eval 46) line 5520.
 >>
 >> This one seems to come from a module Geo::IP, called form a
 >> SpamAssassin plugin URILocalBL.
 >> [...] Try disabling loading of a plugin URILocalBL as a start
 >> (in config file v341.pre).


On 2015-05-03 2:26, Art Greenberg wrote:
> The line for URILocalBL is commented out - I had not enabled it.

There is also the RelayCountry plugin that is using the Geo::IP module.

   Mark



Re: SA 3.4.1 - error messages in log?

Posted by Art Greenberg <ar...@artg.tv>.
The line for URILocalBL is commented out - I had not enabled it.



On May 2, 2015 7:08:10 PM Mark Martinec <Ma...@ijs.si> wrote:

> On 2015-05-02 14:39, Art Greenberg wrote:
> > I just moved from 3.4.0 to 3.4.1 and am seeing messages from SA in
> > maillog that I've not seen before. Do they indicate an issue with my
> > installation?
> >
> > Here is a segment from the log. This pattern repeats each time SA
> > processes a message. The use of uninitialized value and copy_config
> > timeout are new, as is the change of child states.
> >
> > May  2 06:45:29 sunshine spamd[22293]: Use of uninitialized value
> > $hasStructureInfo in numeric eq (==) at (eval 46) line 5520.
>
> This one seems to come from a module Geo::IP, called form a
> SpamAssassin plugin URILocalBL.
>
> > May  2 06:46:29 sunshine spamd[22290]: spamd: copy_config timeout,
> > respawning child process after 1 messages at /usr/local/bin/spamd line
> > 1447.
> [...]
> > May  2 06:46:30 sunshine spamd[21741]: spamd: handled cleanup of child
> > pid [22290] due to SIGCHLD: exit 0
> > May  2 06:46:40 sunshine spamd[22293]: spamd: copy_config timeout,
> > respawning child process after 1 messages at /usr/local/bin/spamd line
> > 1447.
> [...]
> > SA does seem to be processing messages correctly. But starting SA does
> > seem to take forever ... I've had to increase the timeout on line 2977
> > in spamd from 180 to 600 seconds. I'm running SA just for personal email
> > on a machine pretty much dedicated to handling email so performance is
> > not a concern. Centos 6.6 64 bit, Intel E7300 2.66GHz with 4GB RAM and
> > 500GB disk.
>
> No idea. Try disabling loading of a plugin URILocalBL as a start
> (in config file v341.pre).
>
>    Mark



Re: SA 3.4.1 - error messages in log?

Posted by Mark Martinec <Ma...@ijs.si>.
On 2015-05-02 14:39, Art Greenberg wrote:
> I just moved from 3.4.0 to 3.4.1 and am seeing messages from SA in
> maillog that I've not seen before. Do they indicate an issue with my
> installation?
>
> Here is a segment from the log. This pattern repeats each time SA
> processes a message. The use of uninitialized value and copy_config
> timeout are new, as is the change of child states.
>
> May  2 06:45:29 sunshine spamd[22293]: Use of uninitialized value
> $hasStructureInfo in numeric eq (==) at (eval 46) line 5520.

This one seems to come from a module Geo::IP, called form a
SpamAssassin plugin URILocalBL.

> May  2 06:46:29 sunshine spamd[22290]: spamd: copy_config timeout,
> respawning child process after 1 messages at /usr/local/bin/spamd line
> 1447.
[...]
> May  2 06:46:30 sunshine spamd[21741]: spamd: handled cleanup of child
> pid [22290] due to SIGCHLD: exit 0
> May  2 06:46:40 sunshine spamd[22293]: spamd: copy_config timeout,
> respawning child process after 1 messages at /usr/local/bin/spamd line
> 1447.
[...]
> SA does seem to be processing messages correctly. But starting SA does
> seem to take forever ... I've had to increase the timeout on line 2977
> in spamd from 180 to 600 seconds. I'm running SA just for personal email
> on a machine pretty much dedicated to handling email so performance is
> not a concern. Centos 6.6 64 bit, Intel E7300 2.66GHz with 4GB RAM and
> 500GB disk.

No idea. Try disabling loading of a plugin URILocalBL as a start
(in config file v341.pre).

   Mark