2500 timeouts a day!

[Jason Burzenski]

I had the same problem 2 weeks ago with slightly more timeouts and my
problem was related to bayes database size/corruption.  I went through the
whole debugging things but couldn't catch a timeout successfully.  I ended
up using the bayes starter db from fsl.com as an immediate replacement for
my old, rickety bayes db that was over 150MB.

You need SA 2.63 to use bayes-starter and I would run in debug mode first to
make sure it sticks (make sure you adjust permissions so your new
.spamassassin dir and files within match your old one).

Here is my cmd line:

$ cd /root
$ service MailScanner stop
$ mv .spamassassin spamold
$ wget http://www.fsl.com/support/bayes-starter.tar.gz
$ tar xvzf bayes-starter.tar.gz
$ mv bayes .spamassassin
$ cp spamold/user_prefs .spamassassin
$ service MailScanner start

This completely solved my problem.  I have been processing about 60K msgs
per day per MS server with 0 SA timeouts.  I'm not sure if it will solve
your problem but it might be worth a shot.  How large is your bayes db now?
Do you do any regularly scheduled maintenance on it (via MS, SA, etc.?).


> -----Original Message-----
> From: Max Kipness [mailto:mkipness at GENIANT.COM]
> Sent: Wednesday, May 26, 2004 8:31 AM
> To: MAILSCANNER at JISCMAIL.AC.UK
> Subject: 2500 timeouts a day!
>
>
> Hi,
>
> I'm being plagued by about 2500 spamassassin timeouts per day
> that is obviously allowing spam to slip through. I read on a
> previous post to kill all MS processes and set MS and SA to
> debug, then run check_MailScanner and look for pauses? I've
> done this several times and don't really see anything. Is
> there any other way that I can figure out what my problem is?
>
> I run several SA rules and run a huge blacklist. I thought I
> was running DCC ok, but the debug shows that it's not working now.
>
> Here is a the output of the debug. If anybody could help me
> with this, I would sure appreciate it.
>
> Starting MailScanner...
> In Debugging mode, not forking...
> debug: Score set 0 chosen.
> debug: running in taint mode? no
> debug: ignore: test message to precompile patterns and load modules
> debug: using "/usr/share/spamassassin" for default rules dir
> debug: using "/etc/mail/spamassassin" for site rules dir
> debug: using "/etc/MailScanner/spam.assassin.prefs.conf" for
> user prefs file
> debug: bayes: 21126 tie-ing to DB file R/O
> /root/.spamassassin/bayes_toks
> debug: bayes: 21126 tie-ing to DB file R/O
> /root/.spamassassin/bayes_seen
> debug: bayes: found bayes db version 2
> debug: Score set 3 chosen.
> debug: Initialising learner
> debug: is Net::DNS::Resolver available? yes
> debug: trying (3) yahoo.de...
> debug: looking up MX for 'yahoo.de'
> debug: MX for 'yahoo.de' exists? 1
> debug: MX lookup of yahoo.de succeeded => Dns available (set
> dns_available to hardcode)
> debug: is DNS available? 1
> debug: all '*From' addrs: ignore at compiling.spamassassin.taint.org
> debug: running header regexp tests; score so far=0
> debug: running body-text per-line regexp tests; score so far=2.077
> debug: bayes corpus size: nspam = 8496, nham = 5760
> debug: uri tests: Done uriRE
> debug: tokenize: header tokens for *F = "U*ignore
> D*compiling.spamassassin.taint.org D*spamassassin.taint.org
> D*taint.org D*org"
> debug: tokenize: header tokens for *m = " 1085574063 12887
> spamassassin_spamd_init "
> debug: bayes token 'H*F:D*org' => 0.0460172181871846
> debug: bayes token 'N:H*m:NNNNN' => 0.875176741681377
> debug: bayes: score = 0.39857883440039
> debug: bayes: 21126 untie-ing
> debug: bayes: 21126 untie-ing db_toks
> debug: bayes: 21126 untie-ing db_seen
> debug: Razor2 is available
> debug: entering helper-app run mode
>  Razor-Log: Computed razorhome from env: /root/.razor
>  Razor-Log: Found razorhome: /root/.razor
>  Razor-Log: read_file: 16 items read from
> /root/.razor/razor-agent.conf May 26 07:21:05.335440
> check[21126]: [ 1] [bootup] Logging initiated LogDebugLevel=9
> to stdout May 26 07:21:05.336365 check[21126]: [ 5] computed
> razorhome=/root/.razor, conf=/root/.razor/razor-agent.conf,
> ident=/root/.razor/identity-mkipness at geniant.com
> May 26 07:21:05.336836 check[21126]: [ 8] Client
> supported_engines: 1 2 3 4 May 26 07:21:05.337615
> check[21126]: [ 8]  prep_mail done: mail 1 headers=102,
> mime0=1376 May 26 07:21:05.338299 check[21126]: [ 5]
> read_file: 1 items read from /root/.razor/servers.discovery.lst
> May 26 07:21:05.338889 check[21126]: [ 5] read_file: 2 items
> read from /root/.razor/servers.nomination.lst
> May 26 07:21:05.339462 check[21126]: [ 5] read_file: 2 items
> read from /root/.razor/servers.catalogue.lst
> May 26 07:21:05.340180 check[21126]: [ 9] Assigning defaults
> to folly.cloudmark.com May 26 07:21:05.340602 check[21126]: [
> 9] Assigning defaults to joy.cloudmark.com May 26
> 07:21:05.341013 check[21126]: [ 9] Assigning defaults to
> pride.cloudmark.com May 26 07:21:05.341411 check[21126]: [ 9]
> Assigning defaults to thrill.cloudmark.com May 26
> 07:21:05.342848 check[21126]: [ 5] read_file: 16 items read
> from /root/.razor/server.pride.cloudmark.com.conf
> May 26 07:21:05.343966 check[21126]: [ 5] read_file: 14 items
> read from /root/.razor/server.prejudice.cloudmark.com.conf
> May 26 07:21:05.345185 check[21126]: [ 5] read_file: 16 items
> read from /root/.razor/server.wonder.cloudmark.com.conf
> May 26 07:21:05.346277 check[21126]: [ 5] read_file: 13 items
> read from /root/.razor/server.joy.cloudmark.com.conf
> May 26 07:21:05.347425 check[21126]: [ 5] read_file: 16 items
> read from /root/.razor/server.thrill.cloudmark.com.conf
> May 26 07:21:05.348497 check[21126]: [ 5] read_file: 14 items
> read from /root/.razor/server.stress.cloudmark.com.conf
> May 26 07:21:05.349595 check[21126]: [ 5] read_file: 14 items
> read from /root/.razor/server.tension.cloudmark.com.conf
> May 26 07:21:05.350686 check[21126]: [ 5] read_file: 14 items
> read from /root/.razor/server.malice.cloudmark.com.conf
> May 26 07:21:05.351735 check[21126]: [ 5] read_file: 13 items
> read from /root/.razor/server.solace.cloudmark.com.conf
> May 26 07:21:05.352834 check[21126]: [ 5] read_file: 14 items
> read from /root/.razor/server.shock.cloudmark.com.conf
> May 26 07:21:05.353939 check[21126]: [ 5] read_file: 14 items
> read from /root/.razor/server.truth.cloudmark.com.conf
> May 26 07:21:05.354370 check[21126]: [ 5] 113683 seconds
> before closest server discovery May 26 07:21:05.354913
> check[21126]: [ 6] pride.cloudmark.com is a Catalogue Server
> srl 5003; computed min_cf=6, Server se: D8 May 26
> 07:21:05.355310 check[21126]: [ 8] Computed
> supported_engines: 4 May 26 07:21:05.355655 check[21126]: [
> 8] Using next closest server pride.cloudmark.com:2703, cached
> info srl 5003 May 26 07:21:05.356021 check[21126]: [ 8] mail
> 1 has no subject May 26 07:21:05.357757 check[21126]: [ 6]
> preproc: mail 1.0 went from 1376 bytes to 1339
> May 26 07:21:05.358076 check[21126]: [ 6] computing sigs for
> mail 1.0, len 1339 May 26 07:21:05.360018 check[21126]: [ 6]
> skipping whitelist file
> (empty?): /root/.razor/razor-whitelist
> May 26 07:21:05.360375 check[21126]: [ 5] Connecting to
> pride.cloudmark.com ... May 26 07:21:05.536166 check[21126]:
> [ 8] Connection established May 26 07:21:05.536483
> check[21126]: [ 4] pride.cloudmark.com >> 36 server greeting:
> sn=C&srl=5003&a=l&a=cg&ep4=7542-10
> May 26 07:21:05.537106 check[21126]: [ 4] pride.cloudmark.com
> << 25 May 26 07:21:05.537437 check[21126]: [ 6]
> cn=razor-agents&cv=2.36 May 26 07:21:05.537866 check[21126]:
> [ 6] pride.cloudmark.com is a Catalogue Server srl 5003;
> computed min_cf=6, Server se: D8 May 26 07:21:05.538264
> check[21126]: [ 8] Computed supported_engines: 4 May 26
> 07:21:05.538731 check[21126]: [ 8] mail 1.0 e4 sig:
> xFaZIZUVHk90OQfARnenjx5BZTMA May 26 07:21:05.539142
> check[21126]: [ 8] preparing 1 queries May 26 07:21:05.539547
> check[21126]: [ 8] sending 1 batches May 26 07:21:05.539886
> check[21126]: [ 4] pride.cloudmark.com << 52 May 26
> 07:21:05.540184 check[21126]: [ 6]
> a=c&e=4&ep4=7542-10&s=xFaZIZUVHk90OQfARnenjx5BZTMA
> May 26 07:21:05.782230 check[21126]: [ 4] pride.cloudmark.com
> >> 5 May 26 07:21:05.782451 check[21126]: [ 6] response to
> sent.2 p=0 May 26 07:21:05.783125 check[21126]: [ 6] mail 1.0 e=4
> sig=xFaZIZUVHk90OQfARnenjx5BZTMA: sig not found.
> May 26 07:21:05.783416 check[21126]: [ 7] method 4: mail 1.0:
> no-contention part, spam=0 May 26 07:21:05.783729
> check[21126]: [ 7] method 4: mail 1: all non-contention parts
> not spam, mail not spam May 26 07:21:05.783947 check[21126]:
> [ 3] mail 1 is not known spam. May 26 07:21:05.784198
> check[21126]: [ 5] disconnecting from server
> pride.cloudmark.com May 26 07:21:05.784626 check[21126]: [ 4]
> pride.cloudmark.com << 5 May 26 07:21:05.784842 check[21126]: [ 6] a=q
> debug: Using results from Razor v2.36
> debug: Found Razor2 part: part=0 engine=4 ct=0 cf=0
> debug: leaving helper-app run mode
> debug: Razor2 results: spam? 0  highest cf score: 0
> debug: running raw-body-text per-line regexp tests; score so far=2.077
> debug: running uri tests; score so far=2.077
> debug: uri tests: Done uriRE
> debug: running full-text regexp tests; score so far=2.077
> debug: Razor2 is available
> debug: Current PATH is: /sbin:/bin:/usr/sbin:/usr/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: all '*To' addrs:
> debug: RBL: success for 1 of 1 queries
> debug: running meta tests; score so far=2.077
> debug: is spam? score=1.173 required=5
> tests=BAYES_30,DATE_MISSING,NO_REAL_NAME
> debug: received-header: parsed as [ ip=66.63.176.180
> rdns=m3-8.dtmiles.com helo=M3-8.dtmiles.com
> by=manhattan.aztechsolutions.com ident= ]
> debug: received-header: 'by' manhattan.aztechsolutions.com
> has reserved IP 10.11.20.41
> debug: received-header: 'by' manhattan.aztechsolutions.com
> has no public IPs
> debug: received-header: relay 66.63.176.180 trusted? yes
> debug: is Net::DNS::Resolver available? yes
> debug: all '*From' addrs: 14199.20709397 at dtmiles.com
> debug: running header regexp tests; score so far=0
> debug: running body-text per-line regexp tests; score so far=0.994
> debug: bayes: 21128 tie-ing to DB file R/O
> /root/.spamassassin/bayes_toks
> debug: bayes: 21128 tie-ing to DB file R/O
> /root/.spamassassin/bayes_seen
> debug: bayes: found bayes db version 2
> debug: bayes corpus size: nspam = 8496, nham = 5760
> debug: uri tests: Done uriRE
> debug: tokenize: header tokens for *p = ""
> debug: tokenize: header tokens for *m = " 14199 20709397 dtmiles com "
> debug: tokenize: header tokens for *F = "U*14199.20709397
> D*dtmiles.com D*com"
> debug: tokenize: header tokens for To = "U*jcenter
> D*groteconsulting.com D*com"
> debug: tokenize: header tokens for X-E = "kdfoufsAhspufdpotvmujoh/dpn"
> debug: tokenize: header tokens for X-I = "14199.20709397"
> debug: tokenize: header tokens for X-Rec =
> "groteconsulting.com!jcenter"
> debug: tokenize: header tokens for Mime-Version = "1.0"
> debug: tokenize: header tokens for *c =
> "multipart/alternative; boundary=-14199.20709397"
> debug: tokenize: header tokens for *r = "by M3-8.dtmiles.com
> (PowerMTA(TM) v1.6a30); envelope-  <OnlineSurvey at dtmiles.com>)"
> debug: tokenize: header tokens for *r = "by M3-8.dtmiles.com
> (PowerMTA(TM) v1.6a30); envelope-
> <OnlineSurvey at dtmiles.com>) M3-8.dtmiles.com
> (m3-8.dtmiles.com [66.63.176]) by
> manhattan.aztechsolutions.com      idi4QCHjXw020760
> <jcenter at groteconsulting.com>; "
> debug: bayes token 'H*r:PowerMTA' => 0.999806775407779
> debug: bayes token 'Removal' => 0.999615320566195
> debug: bayes token 'Lauderdale' => 0.999514195583596
> debug: bayes token 'removals' => 0.999503759398496
> debug: bayes token 'Opt-out' => 0.999498371335505
> debug: bayes token '187' => 0.999498371335505
> debug: bayes token '6278' => 0.999492864983535
> debug: bayes token 'advertiser' => 0.999487236403996
> debug: bayes token '33308' => 0.999481481481482
> debug: bayes token 'UD:GIF' => 0.999290322580645
> debug: bayes token '317' => 0.998295202952029
> debug: bayes token 'HX-E:dpn' => 0.998229885057471
> debug: bayes token 'N:H*r:vN.NaNN' => 0.998229885057471
> debug: bayes token 'N:sk:NNNNNIN' => 0.998229885057471
> debug: bayes token 'H*r:v1.6a30' => 0.998229885057471
> debug: bayes token 'N:sk:NNNNNON' => 0.998229885057471
> debug: bayes token 'H*r:66.63.176' => 0.998159362549801
> debug: bayes token 'bucks' => 0.997581151832461
> debug: bayes token 'UD:HTM' => 0.997581151832461
> debug: bayes token 'N:H*F:U*NNNNN.NNNNNNNN' => 0.997447513812155
> debug: bayes token 'UD:dtmiles.com' => 0.997130434782609
> debug: bayes token 'N:H*c:NNNNN.NNNNNNNN' => 0.997130434782609
> debug: bayes token 'N:HX-I:NNNNN.NNNNNNNN' => 0.997130434782609
> debug: bayes token 'N:NNN.gif' => 0.997130434782609
> debug: bayes token 'H*m:dtmiles' => 0.997130434782609
> debug: bayes token 'www.dtmiles.com' => 0.997130434782609
> debug: bayes token 'H*F:D*dtmiles.com' => 0.997130434782609
> debug: bayes token 'N:H*r:sk:MN-N.dt' => 0.996940397350993
> debug: bayes token 'N:H*r:sk:mN-N.dt' => 0.996940397350993
> debug: bayes token 'HX-Rec:sk:groteco' => 0.996723404255319
> debug: bayes token 'HX-E:sk:kdfoufs' => 0.996723404255319
> debug: bayes token 'H*m:20709397' => 0.994296296296296
> debug: bayes token 'us!' => 0.988731707317073
> debug: bayes token 'UD:gif' => 0.985932549192803
> debug: bayes token 'UD:jpg' => 0.985101086602717
> debug: bayes token '456' => 0.985096774193548
> debug: bayes token 'Scout' => 0.0173548387096774
> debug: bayes token 'easiest' => 0.978
> debug: bayes token 'telling' => 0.978
> debug: bayes token 'H*r:sk:m3-8.dt' => 0.978
> debug: bayes token 'H*r:sk:M3-8.dt' => 0.978
> debug: bayes token 'seller' => 0.965575274881969
> debug: bayes token 'URI' => 0.965120411392134
> debug: bayes token 'receipt' => 0.962453188595835
> debug: bayes token 'Works' => 0.958976653589229
> debug: bayes token 'sk:www.qua' => 0.958
> debug: bayes token 'H*r:sk:jcenter' => 0.952729334291984
> debug: bayes token 'Write' => 0.950442799143232
> debug: bayes token 'promise' => 0.948374092044443
> debug: bayes token 'HTo:D*groteconsulting.com' => 0.946086523810392
> debug: bayes token 'Companies' => 0.940120287293403
> debug: bayes token 'career' => 0.939399922944703
> debug: bayes token 'East' => 0.935623061011694
> debug: bayes token 'money' => 0.932293225247586
> debug: bayes token 'HTo:U*jcenter' => 0.930169305025821
> debug: bayes token 'Hwy' => 0.927571356604324
> debug: bayes token 'yourself' => 0.919276923392342
> debug: bayes token 'paid' => 0.911736797195204
> debug: bayes token 'emails' => 0.906566137767734
> debug: bayes token 'H*c:alternative' => 0.90410141423876
> debug: bayes token 'Get' => 0.900108510765839
> debug: bayes token 'marketing' => 0.890854856218948
> debug: bayes token 'federal' => 0.888822282043085
> debug: bayes token 'Marketing' => 0.8876301327067
> debug: bayes token 'End' => 0.880325646789985
> debug: bayes token 'Privacy' => 0.880001927251804
> debug: bayes token 'N:H*m:NNNNN' => 0.875176741681377
> debug: bayes token 'learn' => 0.870189405730155
> debug: bayes token 'H*r:envelope' => 0.868361700043087
> debug: bayes token 'month' => 0.862704213458833
> debug: bayes token 'terms' => 0.862535712992171
> debug: bayes token 'longer' => 0.861026210251235
> debug: bayes token 'H*c:multipart' => 0.859834684510929
> debug: bayes token 'provider' => 0.852946621801994
> debug: bayes token 'prefer' => 0.851302795491674
> debug: bayes token 'Policy' => 0.85090579655665
> debug: bayes token 'product' => 0.847237427739184
> debug: bayes: score = 1
> debug: bayes: 21128 untie-ing
> debug: bayes: 21128 untie-ing db_toks
> debug: bayes: 21128 untie-ing db_seen
> debug: Razor2 is available
> debug: entering helper-app run mode
>  Razor-Log: Computed razorhome from env: /root/.razor
>  Razor-Log: Found razorhome: /root/.razor
>  Razor-Log: read_file: 16 items read from
> /root/.razor/razor-agent.conf May 26 07:21:07.175062
> check[21128]: [ 1] [bootup] Logging initiated LogDebugLevel=9
> to stdout May 26 07:21:07.176138 check[21128]: [ 5] computed
> razorhome=/root/.razor, conf=/root/.razor/razor-agent.conf,
> ident=/root/.razor/identity-mkipness at geniant.com
> May 26 07:21:07.176701 check[21128]: [ 8] Client
> supported_engines: 1 2 3 4 May 26 07:21:07.178772
> check[21128]: [ 8]  prep_mail done: mail 1 headers=722,
> mime0=1163, mime1=3389 May 26 07:21:07.179494 check[21128]: [
> 5] read_file: 1 items read from /root/.razor/servers.discovery.lst
> May 26 07:21:07.180118 check[21128]: [ 5] read_file: 2 items
> read from /root/.razor/servers.nomination.lst
> May 26 07:21:07.180697 check[21128]: [ 5] read_file: 2 items
> read from /root/.razor/servers.catalogue.lst
> May 26 07:21:07.181509 check[21128]: [ 9] Assigning defaults
> to folly.cloudmark.com May 26 07:21:07.181957 check[21128]: [
> 9] Assigning defaults to joy.cloudmark.com May 26
> 07:21:07.182392 check[21128]: [ 9] Assigning defaults to
> pride.cloudmark.com May 26 07:21:07.182833 check[21128]: [ 9]
> Assigning defaults to thrill.cloudmark.com May 26
> 07:21:07.184244 check[21128]: [ 5] read_file: 16 items read
> from /root/.razor/server.pride.cloudmark.com.conf
> May 26 07:21:07.185351 check[21128]: [ 5] read_file: 14 items
> read from /root/.razor/server.prejudice.cloudmark.com.conf
> May 26 07:21:07.186704 check[21128]: [ 5] read_file: 16 items
> read from /root/.razor/server.wonder.cloudmark.com.conf
> May 26 07:21:07.187796 check[21128]: [ 5] read_file: 13 items
> read from /root/.razor/server.joy.cloudmark.com.conf
> May 26 07:21:07.188887 check[21128]: [ 5] read_file: 16 items
> read from /root/.razor/server.thrill.cloudmark.com.conf
> May 26 07:21:07.189996 check[21128]: [ 5] read_file: 14 items
> read from /root/.razor/server.stress.cloudmark.com.conf
> May 26 07:21:07.191125 check[21128]: [ 5] read_file: 14 items
> read from /root/.razor/server.tension.cloudmark.com.conf
> May 26 07:21:07.192217 check[21128]: [ 5] read_file: 14 items
> read from /root/.razor/server.malice.cloudmark.com.conf
> May 26 07:21:07.193283 check[21128]: [ 5] read_file: 13 items
> read from /root/.razor/server.solace.cloudmark.com.conf
> May 26 07:21:07.194476 check[21128]: [ 5] read_file: 14 items
> read from /root/.razor/server.shock.cloudmark.com.conf
> May 26 07:21:07.195628 check[21128]: [ 5] read_file: 14 items
> read from /root/.razor/server.truth.cloudmark.com.conf
> May 26 07:21:07.196183 check[21128]: [ 5] 98883 seconds
> before closest server discovery May 26 07:21:07.196682
> check[21128]: [ 6] pride.cloudmark.com is a Catalogue Server
> srl 5003; computed min_cf=6, Server se: D8 May 26
> 07:21:07.197163 check[21128]: [ 8] Computed
> supported_engines: 4 May 26 07:21:07.197536 check[21128]: [
> 8] Using next closest server pride.cloudmark.com:2703, cached
> info srl 5003 May 26 07:21:07.197981 check[21128]: [ 8] mail
> 1 Subject: Make money for your opinions! May 26
> 07:21:07.200218 check[21128]: [ 6] preproc: mail 1.0 went
> from 1163 bytes to 1047
> May 26 07:21:07.200948 check[21128]: [ 6] preproc: mail 1.1
> went from 3389 bytes to 993
> May 26 07:21:07.201346 check[21128]: [ 6] computing sigs for
> mail 1.0, len 1047 May 26 07:21:07.203291 check[21128]: [ 6]
> computing sigs for mail 1.1, len 993 May 26 07:21:07.205235
> check[21128]: [ 6] skipping whitelist file
> (empty?): /root/.razor/razor-whitelist
> May 26 07:21:07.205638 check[21128]: [ 5] Connecting to
> pride.cloudmark.com ... May 26 07:21:07.368999 check[21128]:
> [ 8] Connection established May 26 07:21:07.369357
> check[21128]: [ 4] pride.cloudmark.com >> 36 server greeting:
> sn=C&srl=5003&a=l&a=cg&ep4=7542-10
> May 26 07:21:07.370171 check[21128]: [ 4] pride.cloudmark.com
> << 25 May 26 07:21:07.370490 check[21128]: [ 6]
> cn=razor-agents&cv=2.36 May 26 07:21:07.370949 check[21128]:
> [ 6] pride.cloudmark.com is a Catalogue Server srl 5003;
> computed min_cf=6, Server se: D8 May 26 07:21:07.371379
> check[21128]: [ 8] Computed supported_engines: 4 May 26
> 07:21:07.371883 check[21128]: [ 8] mail 1.0 e4 sig:
> BCzNZYLJ5tfOnmABFYshPcr9YA8A May 26 07:21:07.372310
> check[21128]: [ 8] mail 1.1 e4 sig:
> PvAgJ8J7-7SGzgRHIb_8ZI8K6QkA May 26 07:21:07.372730
> check[21128]: [ 8] preparing 2 queries May 26 07:21:07.373490
> check[21128]: [ 8] sending 1 batches May 26 07:21:07.373963
> check[21128]: [ 4] pride.cloudmark.com << 108 May 26
> 07:21:07.374193 check[21128]: [ 6]
> -a=c&e=4&ep4=7542-10&s=BCzNZYLJ5tfOnmABFYshPcr9YA8A
> a=c&e=4&ep4=7542-10&s=PvAgJ8J7-7SGzgRHIb_8ZI8K6QkA
> .
> May 26 07:21:07.579867 check[21128]: [ 4] pride.cloudmark.com
> >> 21 May 26 07:21:07.580142 check[21128]: [ 6] response to
> sent.2 -p=0 p=1&cf=100 . May 26 07:21:07.581133 check[21128]:
> [ 6] mail 1.0 e=4
> sig=BCzNZYLJ5tfOnmABFYshPcr9YA8A: sig not found.
> May 26 07:21:07.581554 check[21128]: [ 6] mail 1.1 e=4
> sig=PvAgJ8J7-7SGzgRHIb_8ZI8K6QkA: Is spam: cf 100 >= min_cf 6
> May 26 07:21:07.581865 check[21128]: [ 7] method 4: mail 1.0:
> no-contention part, spam=0 May 26 07:21:07.582116
> check[21128]: [ 7] method 4: mail 1.1: no-contention part,
> spam=1 May 26 07:21:07.582427 check[21128]: [ 7] method 4:
> mail 1: a non-contention part was spam, mail spam May 26
> 07:21:07.582647 check[21128]: [ 3] mail 1 is known spam. May
> 26 07:21:07.582913 check[21128]: [ 5] disconnecting from
> server pride.cloudmark.com May 26 07:21:07.583373
> check[21128]: [ 4] pride.cloudmark.com << 5 May 26
> 07:21:07.583592 check[21128]: [ 6] a=q
> debug: Using results from Razor v2.36
> debug: Found Razor2 part: part=0 engine=4 ct=0 cf=0
> debug: Found Razor2 part: part=1 engine=4 ct=0 cf=100
> debug: leaving helper-app run mode
> debug: Razor2 results: spam? 1  highest cf score: 100
> debug: running raw-body-text per-line regexp tests; score so far=4.74
> debug: running uri tests; score so far=4.74
> debug: uri tests: Done uriRE
> debug: running full-text regexp tests; score so far=4.74
> debug: Razor2 is available
> 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: all '*To' addrs: jcenter at groteconsulting.com
> debug: DNS MX records found: 2
> debug: RBL: success for 1 of 1 queries
> debug: running meta tests; score so far=5.787
> debug: auto-learn? ham=0.1, spam=7, body-hits=4.793, head-hits=2.041
> debug: auto-learn: currently using scoreset 3.  recomputing
> score based on scoreset 1.
> debug: Score set 1 chosen.
> debug: auto-learn: original score: 5.787, recomputed score: 5.604
> debug: Score set 3 chosen.
> debug: auto-learn? no: inside auto-learn thresholds
> debug: is spam? score=11.187 required=5
> tests=BAYES_99,EVILNUMBER_A_6XX_1,FROM_ENDS_IN_NUMS,GET_PAID,H
> TML_50_60,
> HTML_FONT_BIG,HTML_MESSAGE,RAZOR2_CF_RANGE_51_100,RAZOR2_CHECK
> Stopping now as you are debugging me.
>
> -------------------------- MailScanner list ----------------------
> To leave, send    leave mailscanner    to jiscmail at jiscmail.ac.uk
> Before posting, please see the Most Asked Questions at
> http://www.mailscanner.biz/maq/     and the archives at
> http://www.jiscmail.ac.uk/lists/mailscanner.html
>

-------------------------- MailScanner list ----------------------
To leave, send    leave mailscanner    to jiscmail at jiscmail.ac.uk
Before posting, please see the Most Asked Questions at
http://www.mailscanner.biz/maq/     and the archives at
http://www.jiscmail.ac.uk/lists/mailscanner.html
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.mailscanner.info/pipermail/mailscanner/attachments/20040526/f3a0b43a/attachment.html