You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@spamassassin.apache.org by Henk van Lingen <he...@cs.uu.nl> on 2005/02/13 16:03:34 UTC
spamd hanging or looping
Hi,
I'm using SA 3.0.2 on a CentOS 3.4 Linux system in a spamd/spamc setup.
spamc is called via 'maildrop' with user privileges. Now the problem is,
I have a message in my queue (postfix) that seems to hang spamd. Every time
it tries local delivery, spamc times out after 10 minutes but the spamd
child is going on using the CPU forever, without doing any syscalls.
The last thing spamd is telling in debug mode is it is doing 'tokenize:'
steps.
I don't know how to investigate this further?
Regards,
--
Henk van Lingen, Systems & Network Administrator (o- -+
Dept. of Computer Science, Utrecht University. /\ |
phone: +31-30-2535278 v_/_
http://henk.vanlingen.net/ http://www.tuxtown.net/netiquette/
Re: spamd hanging or looping
Posted by Per Eric Rosén <pe...@rosnix.nu>.
It seems to be the same problem with stock 3.01 too, alas.
/Per Eric
--
^): Per Eric Rosén http://rosnix.nu/~per/
/ per@rosnix.nu GPG 7A7A BD68 ADC0 01E1 F560 79FD 33D1 1EC3 1EBB 7311
Re: spamd hanging or looping
Posted by Henk van Lingen <he...@cs.uu.nl>.
On Mon, Feb 14, 2005 at 05:39:43AM -0800, Loren Wilton wrote:
> tests=ALL_TRUSTED,MISSING_DATE,MISSING_SUBJECT,NO_REAL_NAME
> > debug:
> subtests=__HAS_MSGID,__MSGID_OK_DIGITS,__MSGID_OK_HOST,__SANE_MSGID,__UNUSAB
> LE_MSGID
>
> Unless this example mail came from a local machine, this indicates that you
> have a configuration problem. Spam shouldn't be able to hit ALL_TRUSTED.
I think 'this mail' came from a local machine. These lines came from
spamassassin -D --lint on the mailserver itself. No mail was involved.
Cheers,
--
Henk van Lingen, Systems & Network Administrator (o- -+
Dept. of Computer Science, Utrecht University. /\ |
phone: +31-30-2535278 v_/_
http://henk.vanlingen.net/ http://www.tuxtown.net/netiquette/
Re: spamd hanging or looping
Posted by Loren Wilton <lw...@earthlink.net>.
tests=ALL_TRUSTED,MISSING_DATE,MISSING_SUBJECT,NO_REAL_NAME
> debug:
subtests=__HAS_MSGID,__MSGID_OK_DIGITS,__MSGID_OK_HOST,__SANE_MSGID,__UNUSAB
LE_MSGID
Unless this example mail came from a local machine, this indicates that you
have a configuration problem. Spam shouldn't be able to hit ALL_TRUSTED.
Loren
Re: spamd hanging or looping
Posted by Henk van Lingen <he...@cs.uu.nl>.
On Tue, Feb 15, 2005 at 06:27:39PM +0100, Sander Holthaus - Orange XL wrote:
>
> From reading your messages, I wouldn't be sure if it is a bug in spamd
> itself. It could very well be in either the Perl-version or related modules
> your are using. Some are actually quite old and have known bugs in them
> which can lead to endless loops.
Hm. If versions coming with RHEL 3 Linux cause it, I think I would still
call it a bug...
> Before submitting a bugreport, upgrade perl and related modules to their
> latest versions. Also save your db-files and the related messages (which can
> be handy if it is indeed an unresolved bug).
I have already filed a report including relevant files:
http://bugzilla.spamassassin.org/show_bug.cgi?id=4138
Cheers,
--
Henk van Lingen, Systems & Network Administrator (o- -+
Dept. of Computer Science, Utrecht University. /\ |
phone: +31-30-2535278 v_/_
http://henk.vanlingen.net/ http://www.tuxtown.net/netiquette/
RE: spamd hanging or looping
Posted by Sander Holthaus - Orange XL <in...@orangexl.com>.
> On Mon, Feb 14, 2005 at 08:18:47PM +0100, Henk van Lingen wrote:
> >
> > Additional info on this bug:
>
> Being a bit surprised about the lack of interest in a bug
> like this here,
> I'm trying to submit something to this 'bugzilla'. I've
> made an account
> and now it suggest reading the guidelines. However:
>
> "The requested URL /bugwritinghelp.html was not found on
> this server."
>
> So, what is priority, severity and URL? Or does it not
> really matter?
> And what component to choose? spamd seems logical but i
> think the prob
> is in a library.
>
> (I hate having to edit a message without vim in a 'textarea' :-))
>From reading your messages, I wouldn't be sure if it is a bug in spamd
itself. It could very well be in either the Perl-version or related modules
your are using. Some are actually quite old and have known bugs in them
which can lead to endless loops.
Before submitting a bugreport, upgrade perl and related modules to their
latest versions. Also save your db-files and the related messages (which can
be handy if it is indeed an unresolved bug).
Kind Regards,
Sander Holthaus
PS: What OS and which Perl-version are you using?
Re: spamd hanging or looping
Posted by Henk van Lingen <he...@cs.uu.nl>.
On Mon, Feb 14, 2005 at 08:18:47PM +0100, Henk van Lingen wrote:
>
> Additional info on this bug:
Being a bit surprised about the lack of interest in a bug like this here,
I'm trying to submit something to this 'bugzilla'. I've made an account
and now it suggest reading the guidelines. However:
"The requested URL /bugwritinghelp.html was not found on this server."
So, what is priority, severity and URL? Or does it not really matter?
And what component to choose? spamd seems logical but i think the prob
is in a library.
(I hate having to edit a message without vim in a 'textarea' :-))
Cheers,
--
Henk van Lingen, Systems & Network Administrator (o- -+
Dept. of Computer Science, Utrecht University. /\ |
phone: +31-30-2535278 v_/_
http://henk.vanlingen.net/ http://www.tuxtown.net/netiquette/
Re: spamd hanging or looping
Posted by Henk van Lingen <he...@cs.uu.nl>.
On Mon, Feb 14, 2005 at 01:30:01PM +0100, Henk van Lingen wrote:
> > with latest versions? What is the absolute last message that is logged?
>
> It's not specific to one message, it seems. Currently there's another
> message in my queue with the same prob. For the same user, however.
> There are also messages succeeding for this user.
>
> The last debug line this time was:
>
> Feb 14 12:56:51 dusk spamd[19933]: debug: tokenize: header tokens for *r = " mail pickup service by shaker-online.com Microsoft SMTPSVC; shaker-online.com (SHAKER_NT3 [10.1.1 ip*10.1.1.3 ]) by mail.shaker-online.com (Microsoft Exchange Internet Mail Service Version 5.5.2653.13) ; "
Additional info on this bug:
When I remove the users ~/.spamassassin/ dir all goes well. The message
is delivered and a new ~/.spamassassin/ made. Debug is showing the
following additional lines after the one named above:
Feb 14 19:22:32 dusk spamd[7564]: debug: bayes: Learned 'b9eccae48c5e4921fcffbe305d11195f1953e45a@sa_generated', atime: 1108371508
Feb 14 19:22:32 dusk spamd[7564]: debug: bayes: 7564 untie-ing
Feb 14 19:22:32 dusk spamd[7564]: debug: bayes: 7564 untie-ing db_toks
Feb 14 19:22:32 dusk spamd[7564]: debug: bayes: 7564 untie-ing db_seen
Feb 14 19:22:32 dusk spamd[7564]: debug: bayes: files locked, now unlocking lock Feb 14 19:22:32 dusk spamd[7564]: debug: unlock: 7564 unlink /users/pim/.spamassassin/bayes.lock
Feb 14 19:22:32 dusk spamd[7564]: debug: is spam? score=0 required=7
Feb 14 19:22:32 dusk spamd[7564]: debug: tests=
Feb 14 19:22:32 dusk spamd[7564]: debug: subtests=__CT,__CTE,__CTYPE_CHARSET_QUOTED,__CT_TEXT_PLAIN,__HAS_MIMEOLE,__HAS_MSGID,__HAS_SUBJECT,__MIME_QP,__MIME_VERSION,__MSGID_OK_DIGITS,__MSGID_OK_HOST,__SANE_MSGID
Feb 14 19:22:32 dusk spamd[7564]: logmsg: clean message (0.0/7.0) for pim:132 in 3.4 seconds, 13589 bytes.
etc.
When I remove the new ~/.spamassassin/ and move the old one back,
containing:
total 3012
-rw-r--r-- 1 132 root 1123 Feb 19 2003 user_prefs
-rw------- 1 132 110 1261568 Feb 14 14:15 bayes_toks
-rw------- 1 132 110 57344 Feb 14 18:15 bayes_seen
-rw------- 1 132 110 20 Feb 14 19:03 bayes.lock
-rw------- 1 132 110 195072 Feb 14 19:03 auto-whitelist
drwx------ 2 132 root 512 Feb 14 19:03 .
drwx------ 89 132 110 5632 Feb 14 19:40 ..
and reinsert the message in my (postfix) mailqueues, the problem is
back. So the problem seems to be related to the user data.
(NB: removing bayes.lock has no effect)
BTW: if one sends the hanging spamd child a TERM, it is terminated
nicely and the parent spawns a new child.
Regards,
--
Henk van Lingen, Systems & Network Administrator (o- -+
Dept. of Computer Science, Utrecht University. /\ |
phone: +31-30-2535278 v_/_
http://henk.vanlingen.net/ http://www.tuxtown.net/netiquette/
Re: spamd hanging or looping
Posted by Henk van Lingen <he...@cs.uu.nl>.
On Mon, Feb 14, 2005 at 03:03:56AM +0100, Sander Holthaus - Orange XL wrote:
> Is there anything specific with the message? (well, there most likely is :-)
> ). What kind of message is it? Are Perl and all related modules up to date
> with latest versions? What is the absolute last message that is logged?
It's not specific to one message, it seems. Currently there's another
message in my queue with the same prob. For the same user, however.
There are also messages succeeding for this user.
The last debug line this time was:
Feb 14 12:56:51 dusk spamd[19933]: debug: tokenize: header tokens for *r = " mail pickup service by shaker-online.com Microsoft SMTPSVC; shaker-online.com (SHAKER_NT3 [10.1.1 ip*10.1.1.3 ]) by mail.shaker-online.com (Microsoft Exchange Internet Mail Service Version 5.5.2653.13) ; "
this is the spamassassin -D --lint output, runned as the specific user:
debug: SpamAssassin version 3.0.2
debug: Score set 0 chosen.
debug: running in taint mode? yes
debug: Running in taint mode, removing unsafe env vars, and resetting PATH
debug: PATH included '/usr/kerberos/bin', keeping.
debug: PATH included '/bin', keeping.
debug: PATH included '/usr/bin', keeping.
debug: PATH included '/usr/local/bin', keeping.
debug: PATH included '/usr/bin/X11', keeping.
debug: PATH included '/usr/X11R6/bin', keeping.
debug: PATH included '/import/enterprise/home/pim/Tools/SMV-Cadence/bin', which doesn't exist, dropping.
debug: PATH included '/import/enterprise/home/pim/Tools/SMV-Cadence/bin', which doesn't exist, dropping.
debug: Final PATH set to: /usr/kerberos/bin:/bin:/usr/bin:/usr/local/bin:/usr/bin/X11:/usr/X11R6/bin
debug: diag: module installed: DBI, version 1.32
debug: diag: module installed: DB_File, version 1.806
debug: diag: module installed: Digest::SHA1, version 2.07
debug: diag: module installed: IO::Socket::UNIX, version 1.2
debug: diag: module installed: MIME::Base64, version 2.12
debug: diag: module installed: Net::DNS, version 0.38
debug: diag: module not installed: Net::LDAP ('require' failed)
debug: diag: module installed: Razor2::Client::Agent, version 2.40
debug: diag: module installed: Storable, version 2.06
debug: diag: module installed: URI, version 1.21
debug: ignore: using a test message to lint rules
debug: using "/etc/mail/spamassassin/init.pre" for site rules init.pre
debug: config: read file /etc/mail/spamassassin/init.pre
debug: using "/usr/share/spamassassin" for default rules dir
debug: config: read file /usr/share/spamassassin/10_misc.cf
debug: config: read file /usr/share/spamassassin/20_anti_ratware.cf
debug: config: read file /usr/share/spamassassin/20_body_tests.cf
debug: config: read file /usr/share/spamassassin/20_compensate.cf
debug: config: read file /usr/share/spamassassin/20_dnsbl_tests.cf
debug: config: read file /usr/share/spamassassin/20_drugs.cf
debug: config: read file /usr/share/spamassassin/20_fake_helo_tests.cf
debug: config: read file /usr/share/spamassassin/20_head_tests.cf
debug: config: read file /usr/share/spamassassin/20_html_tests.cf
debug: config: read file /usr/share/spamassassin/20_meta_tests.cf
debug: config: read file /usr/share/spamassassin/20_phrases.cf
debug: config: read file /usr/share/spamassassin/20_porn.cf
debug: config: read file /usr/share/spamassassin/20_ratware.cf
debug: config: read file /usr/share/spamassassin/20_uri_tests.cf
debug: config: read file /usr/share/spamassassin/23_bayes.cf
debug: config: read file /usr/share/spamassassin/25_body_tests_es.cf
debug: config: read file /usr/share/spamassassin/25_hashcash.cf
debug: config: read file /usr/share/spamassassin/25_spf.cf
debug: config: read file /usr/share/spamassassin/25_uribl.cf
debug: config: read file /usr/share/spamassassin/30_text_de.cf
debug: config: read file /usr/share/spamassassin/30_text_fr.cf
debug: config: read file /usr/share/spamassassin/30_text_nl.cf
debug: config: read file /usr/share/spamassassin/30_text_pl.cf
debug: config: read file /usr/share/spamassassin/50_scores.cf
debug: config: read file /usr/share/spamassassin/60_whitelist.cf
debug: using "/etc/mail/spamassassin" for site rules dir
debug: config: read file /etc/mail/spamassassin/local.cf
debug: using "/users/pim/.spamassassin" for user state dir
debug: using "/users/pim/.spamassassin/user_prefs" for user prefs file
debug: config: read file /users/pim/.spamassassin/user_prefs
debug: plugin: loading Mail::SpamAssassin::Plugin::URIDNSBL from @INC
debug: plugin: registered Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x9fe5b40)
debug: plugin: loading Mail::SpamAssassin::Plugin::Hashcash from @INC
debug: plugin: registered Mail::SpamAssassin::Plugin::Hashcash=HASH(0xa9c312c)
debug: plugin: loading Mail::SpamAssassin::Plugin::SPF from @INC
debug: plugin: registered Mail::SpamAssassin::Plugin::SPF=HASH(0xa9922dc)
debug: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x9fe5b40) implements 'parse_config'
debug: plugin: Mail::SpamAssassin::Plugin::Hashcash=HASH(0xa9c312c) implements 'parse_config'
debug: using "/users/pim/.spamassassin" for user state dir
debug: bayes: 26623 tie-ing to DB file R/O /users/pim/.spamassassin/bayes_toks
debug: bayes: 26623 tie-ing to DB file R/O /users/pim/.spamassassin/bayes_seen
debug: bayes: found bayes db version 3
debug: using "/users/pim/.spamassassin" for user state dir
debug: bayes: Not available for scanning, only 97 spam(s) in Bayes DB < 200
debug: bayes: 26623 untie-ing
debug: bayes: 26623 untie-ing db_toks
debug: bayes: 26623 untie-ing db_seen
debug: Score set 1 chosen.
debug: ---- MIME PARSER START ----
debug: main message type: text/plain
debug: parsing normal part
debug: added part, type: text/plain
debug: ---- MIME PARSER END ----
debug: bayes: 26623 tie-ing to DB file R/O /users/pim/.spamassassin/bayes_toks
debug: bayes: 26623 tie-ing to DB file R/O /users/pim/.spamassassin/bayes_seen
debug: bayes: found bayes db version 3
debug: bayes: Not available for scanning, only 97 spam(s) in Bayes DB < 200
debug: bayes: 26623 untie-ing
debug: bayes: 26623 untie-ing db_toks
debug: bayes: 26623 untie-ing db_seen
debug: metadata: X-Spam-Relays-Trusted:
debug: metadata: X-Spam-Relays-Untrusted:
debug: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x9fe5b40) implements 'parsed_metadata'
debug: is Net::DNS::Resolver available? yes
debug: Net::DNS version: 0.38
debug: trying (3) kernel.org...
debug: looking up NS for 'kernel.org'
debug: NS lookup of kernel.org succeeded => Dns available (set dns_available to hardcode)
debug: is DNS available? 1
debug: decoding: no encoding detected
debug: URIDNSBL: domains to query:
debug: Running tests for priority: 0
debug: running header regexp tests; score so far=0
debug: registering glue method for check_hashcash_double_spend (Mail::SpamAssassin::Plugin::Hashcash=HASH(0xa9c312c))
debug: registering glue method for check_for_spf_helo_pass (Mail::SpamAssassin::Plugin::SPF=HASH(0xa9922dc))
debug: SPF: message was delivered entirely via trusted relays, not required
debug: all '*From' addrs: ignore@compiling.spamassassin.taint.org
debug: registering glue method for check_hashcash_value (Mail::SpamAssassin::Plugin::Hashcash=HASH(0xa9c312c))
debug: all '*To' addrs:
debug: registering glue method for check_for_spf_softfail (Mail::SpamAssassin::Plugin::SPF=HASH(0xa9922dc))
debug: SPF: message was delivered entirely via trusted relays, not required
debug: registering glue method for check_for_spf_pass (Mail::SpamAssassin::Plugin::SPF=HASH(0xa9922dc))
debug: registering glue method for check_for_spf_helo_softfail (Mail::SpamAssassin::Plugin::SPF=HASH(0xa9922dc))
debug: registering glue method for check_for_spf_helo_fail (Mail::SpamAssassin::Plugin::SPF=HASH(0xa9922dc))
debug: running body-text per-line regexp tests; score so far=-2.623
debug: running uri tests; score so far=-2.623
debug: registering glue method for check_uridnsbl (Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x9fe5b40))
debug: Razor2 is available
debug: entering helper-app run mode
Razor-Log: Computed razorhome from env: /users/pim/.razor
Razor-Log: Found razorhome: /users/pim/.razor
Razor-Log: No /users/pim/.razor/razor-agent.conf found, skipping.
Razor-Log: No razor-agent.conf found, using defaults.
Feb 14 13:14:11.969133 check[26623]: [ 2] [bootup] Logging initiated LogDebugLevel=9 to stdout
Feb 14 13:14:11.970243 check[26623]: [ 5] computed razorhome=/users/pim/.razor, conf=, ident=/users/pim/.razor/identity
Feb 14 13:14:11.970425 check[26623]: [ 8] Client supported_engines: 4
Feb 14 13:14:11.970755 check[26623]: [ 8] prep_mail done: mail 1 headers=93, mime0=1376
Feb 14 13:14:11.981063 check[26623]: [ 5] read_file: 1 items read from /users/pim/.razor/servers.discovery.lst
Feb 14 13:14:11.994531 check[26623]: [ 5] read_file: 2 items read from /users/pim/.razor/servers.nomination.lst
Feb 14 13:14:11.996040 check[26623]: [ 5] read_file: 0 items read from /users/pim/.razor/servers.catalogue.lst
Feb 14 13:14:11.996279 check[26623]: [ 9] Assigning defaults to joy.cloudmark.com
Feb 14 13:14:11.996393 check[26623]: [ 9] Assigning defaults to folly.cloudmark.com
Feb 14 13:14:12.000067 check[26623]: [ 5] read_file: 16 items read from /users/pim/.razor/server.shock.cloudmark.com.conf
Feb 14 13:14:12.000888 check[26623]: [ 5] read_file: 16 items read from /users/pim/.razor/server.shock.cloudmark.com.conf
Feb 14 13:14:12.002500 check[26623]: [ 5] read_file: 15 items read from /users/pim/.razor/server.pride.cloudmark.com.conf
Feb 14 13:14:12.003268 check[26623]: [ 5] read_file: 15 items read from /users/pim/.razor/server.pride.cloudmark.com.conf
Feb 14 13:14:12.004714 check[26623]: [ 5] read_file: 15 items read from /users/pim/.razor/server.tension.cloudmark.com.conf
Feb 14 13:14:12.005539 check[26623]: [ 5] read_file: 15 items read from /users/pim/.razor/server.tension.cloudmark.com.conf
Feb 14 13:14:12.005721 check[26623]: [ 5] empty listfile: /users/pim/.razor/servers.catalogue.lst
Feb 14 13:14:12.005801 check[26623]: [ 8] already have 1 discovery servers
Feb 14 13:14:12.006000 check[26623]: [ 8] Checking with Razor Discovery Server 66.151.150.12
Feb 14 13:14:12.006087 check[26623]: [ 6] No port specified, using 2703
Feb 14 13:14:12.006214 check[26623]: [ 5] Connecting to 66.151.150.12 ...
Feb 14 13:14:12.315628 check[26623]: [ 8] Connection established
Feb 14 13:14:12.315766 check[26623]: [ 4] 66.151.150.12 >> 35 server greeting: sn=D&srl=476&a=l&a=cg&ep4=7542-10
Feb 14 13:14:12.315920 check[26623]: [ 4] 66.151.150.12 << 12
Feb 14 13:14:12.315971 check[26623]: [ 6] a=g&pm=csl
Feb 14 13:14:12.471796 check[26623]: [ 4] 66.151.150.12 >> 76
Feb 14 13:14:12.471873 check[26623]: [ 6] response to sent.1
-csl=?
shock.cloudmark.com
pride.cloudmark.com
tension.cloudmark.com
.
Feb 14 13:14:12.472048 check[26623]: [ 8] Discovery Server 66.151.150.12 replying with csl=shock.cloudmark.com
Feb 14 13:14:12.472102 check[26623]: [ 8] Discovery Server 66.151.150.12 replying with csl=pride.cloudmark.com
Feb 14 13:14:12.472149 check[26623]: [ 8] Discovery Server 66.151.150.12 replying with csl=tension.cloudmark.com
Feb 14 13:14:12.472267 check[26623]: [ 4] 66.151.150.12 << 12
Feb 14 13:14:12.472315 check[26623]: [ 6] a=g&pm=nsl
Feb 14 13:14:12.629193 check[26623]: [ 4] 66.151.150.12 >> 51
Feb 14 13:14:12.629281 check[26623]: [ 6] response to sent.2
-nsl=?
folly.cloudmark.com
joy.cloudmark.com
.
Feb 14 13:14:12.629429 check[26623]: [ 8] Discovery Server 66.151.150.12 replying with nsl=folly.cloudmark.com
Feb 14 13:14:12.629485 check[26623]: [ 8] Discovery Server 66.151.150.12 replying with nsl=joy.cloudmark.com
Feb 14 13:14:12.630515 check[26623]: [ 5] writeservers skipping .lst file: /users/pim/.razor/servers.catalogue.lst
Feb 14 13:14:12.651680 check[26623]: [ 5] wrote 2 ARRAY items to file: /users/pim/.razor/servers.nomination.lst
Feb 14 13:14:12.651915 check[26623]: [ 6] shock.cloudmark.com is a Catalogue Server srl 5060; computed min_cf=6, Server se: C8
Feb 14 13:14:12.652060 check[26623]: [ 8] Computed supported_engines: 4
Feb 14 13:14:12.652154 check[26623]: [ 8] Using next closest server shock.cloudmdebug: Using results from Razor v2.40
debug: Found Razor2 part: part=0 engine=4 ct=0 cf=0
debug: leaving helper-app run mode
ark.com:2703, cached info srl 5060
Feb 14 13:14:12.652315 check[26623]: [ 8] mail 1 has no subject
Feb 14 13:14:12.653346 check[26623]: [ 6] preproc: mail 1.0 went from 1376 bytes to 1339
Feb 14 13:14:12.653460 check[26623]: [ 6] computing sigs for mail 1.0, len 1339
Feb 14 13:14:12.655199 check[26623]: [ 6] skipping whitelist file (empty?): /users/pim/.razor/razor-whitelist
Feb 14 13:14:12.655306 check[26623]: [ 6] losing old server connection, 66.151.150.12, for new server, shock.cloudmark.com
Feb 14 13:14:12.655367 check[26623]: [ 5] disconnecting from server 66.151.150.12
Feb 14 13:14:12.655495 check[26623]: [ 4] 66.151.150.12 << 5
Feb 14 13:14:12.655542 check[26623]: [ 6] a=q
Feb 14 13:14:12.655646 check[26623]: [ 5] Connecting to shock.cloudmark.com ...
Feb 14 13:14:12.971912 check[26623]: [ 8] Connection established
Feb 14 13:14:12.972133 check[26623]: [ 4] shock.cloudmark.com >> 36 server greeting: sn=C&srl=5060&a=l&a=cg&ep4=7542-10
Feb 14 13:14:12.972441 check[26623]: [ 4] shock.cloudmark.com << 25
Feb 14 13:14:12.972496 check[26623]: [ 6] cn=razor-agents&cv=2.40
Feb 14 13:14:12.972656 check[26623]: [ 6] shock.cloudmark.com is a Catalogue Server srl 5060; computed min_cf=6, Server se: C8
Feb 14 13:14:12.972795 check[26623]: [ 8] Computed supported_engines: 4
Feb 14 13:14:12.972908 check[26623]: [ 8] mail 1.0 e4 sig: xFaZIZUVHk90OQfARnenjx5BZTMA
Feb 14 13:14:12.973032 check[26623]: [ 8] preparing 1 queries
Feb 14 13:14:12.973170 check[26623]: [ 8] sending 1 batches
Feb 14 13:14:12.973283 check[26623]: [ 4] shock.cloudmark.com << 52
Feb 14 13:14:12.973330 check[26623]: [ 6] a=c&e=4&ep4=7542-10&s=xFaZIZUVHk90OQfARnenjx5BZTMA
Feb 14 13:14:15.572020 check[26623]: [ 4] shock.cloudmark.com >> 5
Feb 14 13:14:15.572105 check[26623]: [ 6] response to sent.5
p=0
Feb 14 13:14:15.572421 check[26623]: [ 6] mail 1.0 e=4 sig=xFaZIZUVHk90OQfARnenjx5BZTMA: sig not found.
Feb 14 13:14:15.572502 check[26623]: [ 7] method 4: mail 1.0: no-contention part, spam=0
Feb 14 13:14:15.572553 check[26623]: [ 7] method 4: mail 1: all non-contention parts not spam, mail not spam
Feb 14 13:14:15.572600 check[26623]: [ 3] mail 1 is not known spam.
Feb 14 13:14:15.572655 check[26623]: [ 5] disconnecting from server shock.cloudmark.com
Feb 14 13:14:15.572774 check[26623]: [ 4] shock.cloudmark.com << 5
Feb 14 13:14:15.572820 check[26623]: [ 6] a=q
debug: Razor2 results: spam? 0 highest cf score: 0
debug: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x9fe5b40) implements 'check_tick'
debug: running raw-body-text per-line regexp tests; score so far=-2.623
debug: running full-text regexp tests; score so far=-2.623
debug: Razor2 is available
debug: Current PATH is: /usr/kerberos/bin:/bin:/usr/bin:/usr/local/bin:/usr/bin/X11:/usr/X11R6/bin
debug: Pyzor is not available: pyzor not found
debug: DCCifd is not available: no r/w dccifd socket found.
debug: DCC is not available: no executable dccproc found.
debug: Running tests for priority: 500
debug: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x9fe5b40) implements 'check_post_dnsbl'
debug: running meta tests; score so far=-2.623
debug: running header regexp tests; score so far=-1.053
debug: running body-text per-line regexp tests; score so far=-1.053
debug: running uri tests; score so far=-1.053
debug: running raw-body-text per-line regexp tests; score so far=-1.053
debug: running full-text regexp tests; score so far=-1.053
debug: Running tests for priority: 1000
debug: running meta tests; score so far=-1.053
debug: running header regexp tests; score so far=-1.053
debug: using "/users/pim/.spamassassin" for user state dir
debug: lock: 26623 created /users/pim/.spamassassin/auto-whitelist.lock.dusk.cs.uu.nl.26623
debug: lock: 26623 trying to get lock on /users/pim/.spamassassin/auto-whitelist with 0 retries
debug: lock: 26623 link to /users/pim/.spamassassin/auto-whitelist.lock: link ok
debug: Tie-ing to DB file R/W in /users/pim/.spamassassin/auto-whitelist
debug: auto-whitelist (db-based): ignore@compiling.spamassassin.taint.org|ip=none scores 0/0
debug: AWL active, pre-score: -1.053, autolearn score: -1.053, mean: undef, IP: undef
debug: DB addr list: untie-ing and unlocking.
debug: DB addr list: file locked, breaking lock.
debug: unlock: 26623 unlink /users/pim/.spamassassin/auto-whitelist.lock
debug: Post AWL score: -1.053
debug: running body-text per-line regexp tests; score so far=-1.053
debug: running uri tests; score so far=-1.053
debug: running raw-body-text per-line regexp tests; score so far=-1.053
debug: running full-text regexp tests; score so far=-1.053
debug: is spam? score=-1.053 required=7
debug: tests=ALL_TRUSTED,MISSING_DATE,MISSING_SUBJECT,NO_REAL_NAME
debug: subtests=__HAS_MSGID,__MSGID_OK_DIGITS,__MSGID_OK_HOST,__SANE_MSGID,__UNUSABLE_MSGID
--
Henk van Lingen, Systems & Network Administrator (o- -+
Dept. of Computer Science, Utrecht University. /\ |
phone: +31-30-2535278 v_/_
http://henk.vanlingen.net/ http://www.tuxtown.net/netiquette/
RE: spamd hanging or looping
Posted by Sander Holthaus - Orange XL <in...@orangexl.com>.
Is there anything specific with the message? (well, there most likely is :-)
). What kind of message is it? Are Perl and all related modules up to date
with latest versions? What is the absolute last message that is logged?
Kind Regards,
Sander Holthaus
> -----Original Message-----
> From: Henk van Lingen [mailto:henkvl@cs.uu.nl]
> Sent: Sunday, February 13, 2005 4:04 PM
> To: users@spamassassin.apache.org
> Subject: spamd hanging or looping
>
>
> Hi,
>
> I'm using SA 3.0.2 on a CentOS 3.4 Linux system in a
> spamd/spamc setup.
> spamc is called via 'maildrop' with user privileges. Now the
> problem is, I have a message in my queue (postfix) that seems
> to hang spamd. Every time it tries local delivery, spamc
> times out after 10 minutes but the spamd child is going on
> using the CPU forever, without doing any syscalls.
> The last thing spamd is telling in debug mode is it is doing
> 'tokenize:'
> steps.
>
> I don't know how to investigate this further?
>
> Regards,
> --
> Henk van Lingen, Systems & Network Administrator
> (o- -+
> Dept. of Computer Science, Utrecht University.
> /\ |
> phone: +31-30-2535278 v_/_
> http://henk.vanlingen.net/
> http://www.tuxtown.net/netiquette/