Réponse - Informaticien.be

Poster une réponse à un sujet: SpamAssassin me casse la tête et oublie Razor

Attention, ce sujet est un sujet ancien (5338 jours sans réponse)

zion

J'ai trouvééé \o/

C'est une connerie de sa-update qui a rajouté un répertoire dans lequel les règles de base n'y sont pas, la soluce:

http://old.nabble.com/%28no-report-template-found%29-td14623651.html

Running "sa-compile" created a folder like
/var/lib/spamassassin/3xxxxxxx
which is being picked up by the spamassassin config and causing the 'template not found' error.

Solution:
spamassassin --lint -D
sa-compile
rm -rf /var/lib/spamassassin/3xxxxxx
/etc/rc.d/init.d/spamassassin restart

Et de fait, il manquait updates_spamassassin_org.cf dans le répertoire qui va bien, et zoupla!

zion

Testé sur une autre machine avec une config similaire, là ça fonctionne...

Bon, effacer toute la config, recommencer de 0, je vois que ça :oh:

zion

Je suis parti 3h, j'ai 245 mails :ciler:

Max, benh non je l'ai pas dans le mail, et en ligne de commande j'ai juste un:
Mar 23 12:55:29.647 [24903] dbg: check: is spam? score=0 required=5

Spoiler:

Mar 23 17:38:57.926 [7858] dbg: timing: total 1410 ms - init: 951 (67.5%), parse: 6 (0.4%), extract_message_metadata: 30 (2.2%), poll_dns_idle: 1.15 (0.1%), get_uri_detail_list: 1.33 (0.1%), tests_pri_0: 362 (25.7%), compile_gen: 216 (15.3%), compile_eval: 0.78 (0.1%), tests_pri_500: 51 (3.6%)
From - Tue Mar 23 11:50:23 2010
X-Spam-Checker-Version: SpamAssassin 3.3.0 (2010-01-18) on p4.akretio.be
X-Account-Key: account1
X-UIDL: 0000008a4ba7e4ec
X-Mozilla-Status: 0001
X-Mozilla-Status2: 00000000
X-Mozilla-Keys:
Return-Path: <bryanxF@worldatlas.com>
X-Original-To: sbuysse@akretio.be
Delivered-To: sbuysse@akretio.be
Received: by firewall.akretio.be (Postfix, from userid 510)
id 9C97DE10FE; Tue, 23 Mar 2010 11:50:09 +0100 (CET)
Received: from arb1 (unknown [115.118.196.190])
by firewall.akretio.be (Postfix) with SMTP id E8387E0FFB;
Tue, 23 Mar 2010 10:50:07 +0000 (UTC)
Received: (qmail 5560 by uid 560); Tue, 23 Mar 2010 16:19:04 -0530
From: "Try Viagra for Free" <bryanxF@worldatlas.com>
To: <antoine@buypin.com>
Subject: Want to try Viagra risk-free?
Date: Tue, 23 Mar 2010 16:10:08 -0530
Message-ID: <002e01cacaa4$978d0810$c6a71830$@com>
MIME-Version: 1.0
Content-Type: multipart/alternative;
boundary="----=_NextPart_000_002D_01CACAA4.978D0810"
X-Mailer: Microsoft Office Outlook 12.0
Thread-Index: AcjqYOYA1ojYRIGV5w9Dm5WVP+6oSg==
Content-Language: en-us
X-Cyberoam-Version: 9.6.0.16
X-Cyberoam-smtpxy-version: 1.0.6.5
X-Cyberoam-AV-Policy: None
X-Cyberoam-AS-Policy: None

This is a multipart message in MIME format.

------=_NextPart_000_002D_01CACAA4.978D0810
Content-Type: text/plain;

Tu vois, il rajoute juste le X-Spam-Checker, pas le reste :kiki:

kortenberg

Citation de: max

Sinon, apt-get install et volle petrol!

Aucun des 3 pkg existe :grin:

max

Dans ton cas de Score: 0, tu as droit à un rapport qui explique pourquoi ? Genre +5 -5 = 0 la tête à charlot (soit dans les entêtes, soit en fin de process avec l'option -t) ?

Sinon, apt-get install et volle petrol!

zion

Oui, c est le log que je lis partout, etl install est simpliste c est chiant :oh:

Autre soucis, il me rajoute pas le x spam.level sur tous les mails... m est d avis que les deux bugs sont liés :petrus:

max

quand razor et pyzor bossent, j'ai un truc qui ressemble à ça:

Spoiler:

[22397] dbg: razor2: part=0 engine=4 contested=0 confidence=100
[22397] dbg: razor2: part=1 engine=4 contested=0 confidence=0
[22397] dbg: razor2: part=2 engine=4 contested=0 confidence=0
[22397] dbg: razor2: results: spam? 1
[22397] dbg: razor2: results: engine 8, highest cf score: 0
[22397] dbg: razor2: results: engine 4, highest cf score: 100
[22397] dbg: rules: ran eval rule RAZOR2_CF_RANGE_E4_51_100 ======> got hit (1)
[22397] dbg: rules: ran eval rule RAZOR2_CHECK ======> got hit (1)
[22397] dbg: rules: ran eval rule RAZOR2_CF_RANGE_51_100 ======> got hit (1)
[22397] dbg: util: current PATH is: /usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
[22397] dbg: util: executable for pyzor was found at /usr/bin/pyzor
[22397] dbg: pyzor: pyzor is available: /usr/bin/pyzor
[22397] dbg: info: entering helper-app run mode
[22397] dbg: pyzor: opening pipe: /usr/bin/pyzor check < /tmp/.spamassassin22397vz6GTttmp
[22407] dbg: util: setuid: ruid=0 euid=0
[22397] dbg: pyzor: killed stale helper [22407]
[22397] dbg: pyzor: [22407] terminated: exit=0x000f
[22397] dbg: info: leaving helper-app run mode
[22397] dbg: pyzor: check timed out after 3.5 seconds

zion

C'est un test en ligne de commande oui, il load bien mon /etc/mail/spamassassin/local.cf comme un brave, et j'ai bien:

Mar 23 12:55:28.320 [24903] dbg: plugin: loading Mail::SpamAssassin::Plugin::Razor2 from @INC
Mar 23 12:55:28.435 [24903] dbg: razor2: razor2 is available, version 2.84

Mais après il l'utilise pas :oh:

max

il utilise le /root/.spamassin/ , c'est normal ? c'est un test en local depuis la ligne de commande ? sinon, c'est peut-être une piste..

zion

Plop,

J'ai utilisé un vilain spam, testé sur Razor avec le razor-client, il est reporté comme spam.

Passé à la moulinette via spamassassin, il me sort un score de 0/5. Ben non justement :kiki:

Un indice la dedans?

Spoiler:

Mar 23 12:38:45.496 [24152] dbg: logger: adding facilities: all
Mar 23 12:38:45.497 [24152] dbg: logger: logging level is DBG
Mar 23 12:38:45.497 [24152] dbg: generic: SpamAssassin version 3.3.0
Mar 23 12:38:45.497 [24152] dbg: generic: Perl 5.010000, PREFIX=/usr, DEF_RULES_DIR=/usr/share/spamassassin, LOCAL_RULES_DIR=/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin
Mar 23 12:38:45.497 [24152] dbg: config: timing enabled
Mar 23 12:38:45.498 [24152] dbg: config: score set 0 chosen.
Mar 23 12:38:45.501 [24152] dbg: util: running in taint mode? yes
Mar 23 12:38:45.502 [24152] dbg: util: taint mode: deleting unsafe environment variables, resetting PATH
Mar 23 12:38:45.502 [24152] dbg: util: PATH included '/usr/kerberos/sbin', keeping
Mar 23 12:38:45.502 [24152] dbg: util: PATH included '/usr/kerberos/bin', keeping
Mar 23 12:38:45.502 [24152] dbg: util: PATH included '/usr/local/bin', keeping
Mar 23 12:38:45.502 [24152] dbg: util: PATH included '/bin', keeping
Mar 23 12:38:45.503 [24152] dbg: util: PATH included '/usr/bin', keeping
Mar 23 12:38:45.503 [24152] dbg: util: PATH included '/usr/local/sbin', keeping
Mar 23 12:38:45.503 [24152] dbg: util: PATH included '/usr/sbin', keeping
Mar 23 12:38:45.503 [24152] dbg: util: PATH included '/sbin', keeping
Mar 23 12:38:45.504 [24152] dbg: util: PATH included '/home/sbuysse/bin', which is unusable, dropping: No such file or directory
Mar 23 12:38:45.504 [24152] dbg: util: final PATH set to: /usr/kerberos/sbin:/usr/kerberos/bin:/usr/local/bin:/bin:/usr/bin:/usr/local/sb- in:/usr/sbin:/sbin
Mar 23 12:38:45.513 [24152] dbg: dns: is Net::DNS::Resolver available? yes
Mar 23 12:38:45.513 [24152] dbg: dns: Net::DNS version: 0.65
Mar 23 12:38:45.518 [24152] dbg: config: using "/etc/mail/spamassassin" for site rules pre files
Mar 23 12:38:45.519 [24152] dbg: config: read file /etc/mail/spamassassin/init.pre
Mar 23 12:38:45.519 [24152] dbg: config: read file /etc/mail/spamassassin/v310.pre
Mar 23 12:38:45.519 [24152] dbg: config: read file /etc/mail/spamassassin/v312.pre
Mar 23 12:38:45.520 [24152] dbg: config: read file /etc/mail/spamassassin/v320.pre
Mar 23 12:38:45.520 [24152] dbg: config: read file /etc/mail/spamassassin/v330.pre
Mar 23 12:38:45.520 [24152] dbg: config: using "/var/lib/spamassassin/3.003000" for sys rules pre files
Mar 23 12:38:45.520 [24152] dbg: config: using "/var/lib/spamassassin/3.003000" for default rules dir
Mar 23 12:38:45.521 [24152] dbg: config: read file /var/lib/spamassassin/3.003000/sought_rules_yerp_org.cf
Mar 23 12:38:45.521 [24152] dbg: config: using "/etc/mail/spamassassin" for site rules dir
Mar 23 12:38:45.522 [24152] dbg: config: read file /etc/mail/spamassassin/70_sare_adult.cf
Mar 23 12:38:45.523 [24152] dbg: config: read file /etc/mail/spamassassin/70_sare_evilnum0.cf
Mar 23 12:38:45.523 [24152] dbg: config: read file /etc/mail/spamassassin/70_sc_top200.cf
Mar 23 12:38:45.523 [24152] dbg: config: read file /etc/mail/spamassassin/90_ FreeMail.cf
Mar 23 12:38:45.524 [24152] dbg: config: read file /etc/mail/spamassassin/90_2tld.cf
Mar 23 12:38:45.524 [24152] dbg: config: read file /etc/mail/spamassassin/90_sare_freemail.cf
Mar 23 12:38:45.524 [24152] dbg: config: read file /etc/mail/spamassassin/FreeMail.cf
Mar 23 12:38:45.524 [24152] dbg: config: read file /etc/mail/spamassassin/blacklist.cf
Mar 23 12:38:45.525 [24152] dbg: config: read file /etc/mail/spamassassin/local.cf
Mar 23 12:38:45.525 [24152] dbg: config: read file /etc/mail/spamassassin/whitelist.cf
Mar 23 12:38:45.526 [24152] dbg: config: using "/root/.spamassassin" for user state dir
Mar 23 12:38:45.526 [24152] dbg: config: using "/root/.spamassassin/user_prefs" for user prefs file
Mar 23 12:38:45.526 [24152] dbg: config: read file /root/.spamassassin/user_prefs
Mar 23 12:38:45.532 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDNSBL from @INC
Mar 23 12:38:45.542 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::Hashcash from @INC
Mar 23 12:38:45.559 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::SPF from @INC
Mar 23 12:38:45.568 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::Pyzor from @INC
Mar 23 12:38:45.573 [24152] dbg: pyzor: network tests on, attempting Pyzor
Mar 23 12:38:45.574 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::Razor2 from @INC
Mar 23 12:38:45.688 [24152] dbg: razor2: razor2 is available, version 2.84
Mar 23 12:38:45.689 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::SpamCop from @INC
Mar 23 12:38:45.716 [24152] dbg: reporter: network tests on, attempting SpamCop
Mar 23 12:38:45.716 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::AutoLearnThreshold from @INC
Mar 23 12:38:45.719 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::WhiteListSubject from @INC
Mar 23 12:38:45.722 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEHeader from @INC
Mar 23 12:38:45.725 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::ReplaceTags from @INC
Mar 23 12:38:45.729 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::DKIM from @INC
Mar 23 12:38:45.740 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::Check from @INC
Mar 23 12:38:45.755 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTTPSMismatch from @INC
Mar 23 12:38:45.758 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDetail from @INC
Mar 23 12:38:45.762 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::Bayes from @INC
Mar 23 12:38:45.783 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::BodyEval from @INC
Mar 23 12:38:45.788 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::DNSEval from @INC
Mar 23 12:38:45.793 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTMLEval from @INC
Mar 23 12:38:45.798 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::HeaderEval from @INC
Mar 23 12:38:45.813 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEEval from @INC
Mar 23 12:38:45.820 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::RelayEval from @INC
Mar 23 12:38:45.825 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIEval from @INC
Mar 23 12:38:45.827 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::WLBLEval from @INC
Mar 23 12:38:45.832 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::VBounce from @INC
Mar 23 12:38:45.835 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::ImageInfo from @INC
Mar 23 12:38:45.841 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::FreeMail from @INC
Mar 23 12:38:45.848 [24152] dbg: config: fixed relative path: /var/lib/spamassassin/3.003000/sought_rules_yerp_org/20_sought.cf
Mar 23 12:38:45.848 [24152] dbg: config: using "/var/lib/spamassassin/3.003000/sought_rules_yerp_org/20_sought.cf" for included file
Mar 23 12:38:45.849 [24152] dbg: config: read file /var/lib/spamassassin/3.003000/sought_rules_yerp_org/20_sought.cf
Mar 23 12:38:45.925 [24152] dbg: config: fixed relative path: /var/lib/spamassassin/3.003000/sought_rules_yerp_org/20_sought_fraud.cf
Mar 23 12:38:45.925 [24152] dbg: config: using "/var/lib/spamassassin/3.003000/sought_rules_yerp_org/20_sought_fraud.cf" for included file
Mar 23 12:38:45.926 [24152] dbg: config: read file /var/lib/spamassassin/3.003000/sought_rules_yerp_org/20_sought_fraud.cf
Mar 23 12:38:46.134 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x9e11304) implements 'parse_config', priority 0
Mar 23 12:38:46.144 [24152] dbg: plugin: did not register Mail::SpamAssassin::Plugin::FreeMail, already registered
Mar 23 12:38:46.151 [24152] dbg: plugin: loading Mail::SpamAssassin::Plugin::DCC from @INC
Mar 23 12:38:46.165 [24152] dbg: dcc: network tests on, registering DCC
Mar 23 12:38:46.393 [24152] dbg: rules: __SEEK_FRAUD_YM7Q1U merged duplicates: __SEEK_YM7Q1U
Mar 23 12:38:46.394 [24152] dbg: rules: SARE_SUBJ_SLUT merged duplicates: __FPS_SLUT
Mar 23 12:38:46.394 [24152] dbg: rules: __SEEK_2811F9 merged duplicates: __SEEK_FRAUD_2811F9
Mar 23 12:38:46.394 [24152] dbg: rules: __SEEK_FRAUD_HMVYSR merged duplicates: __SEEK_HMVYSR
Mar 23 12:38:46.394 [24152] dbg: rules: __SEEK_FRAUD_NN_XIN merged duplicates: __SEEK_NN_XIN
Mar 23 12:38:46.395 [24152] dbg: config: finish parsing
Mar 23 12:38:46.409 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::ReplaceTags=HASH(0x9b4b1ac) implements 'finish_parsing_end', priority 0
Mar 23 12:38:46.409 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x9e11304) implements 'finish_parsing_end', priority 0
Mar 23 12:38:46.409 [24152] dbg: replacetags: replacing tags
Mar 23 12:38:46.415 [24152] dbg: replacetags: done replacing tags
Mar 23 12:38:46.416 [24152] dbg: FreeMail: loaded freemail_domains entries: 23 normal, 1 wildcard
Mar 23 12:38:46.420 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::Bayes=HASH(0x9c23ef4) implements 'learner_new', priority 0
Mar 23 12:38:46.420 [24152] dbg: bayes: learner_new self=Mail::SpamAssassin::Plugin::Bayes=HASH(0x9c23ef4), bayes_store_module=Mail::SpamAssassin::BayesStore::DBM
Mar 23 12:38:46.448 [24152] dbg: bayes: learner_new: got store=Mail::SpamAssassin::BayesStore::DBM=HASH(0x97642a4)
Mar 23 12:38:46.449 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::Bayes=HASH(0x9c23ef4) implements 'learner_is_scan_available', priority 0
Mar 23 12:38:46.449 [24152] dbg: config: using "/root/.spamassassin" for user state dir
Mar 23 12:38:46.449 [24152] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_toks
Mar 23 12:38:46.451 [24152] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_seen
Mar 23 12:38:46.453 [24152] dbg: bayes: found bayes db version 3
Mar 23 12:38:46.454 [24152] dbg: bayes: DB journal sync: last sync: 0
Mar 23 12:38:46.454 [24152] dbg: config: using "/root/.spamassassin" for user state dir
Mar 23 12:38:46.454 [24152] dbg: bayes: not available for scanning, only 0 spam(s) in bayes DB < 200
Mar 23 12:38:46.455 [24152] dbg: bayes: untie-ing
Mar 23 12:38:46.455 [24152] dbg: config: score set 1 chosen.
Mar 23 12:38:46.460 [24152] dbg: message: main message type: multipart/alternative
Mar 23 12:38:46.460 [24152] dbg: config: time limit 300.0 s
Mar 23 12:38:46.461 [24152] dbg: check: pms new, time limit in 299.057 s
Mar 23 12:38:46.461 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::DNSEval=HASH(0x9ccead4) implements 'check_start', priority 0
Mar 23 12:38:46.463 [24152] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_toks
Mar 23 12:38:46.464 [24152] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_seen
Mar 23 12:38:46.466 [24152] dbg: bayes: found bayes db version 3
Mar 23 12:38:46.467 [24152] dbg: bayes: DB journal sync: last sync: 0
Mar 23 12:38:46.467 [24152] dbg: bayes: not available for scanning, only 0 spam(s) in bayes DB < 200
Mar 23 12:38:46.467 [24152] dbg: bayes: untie-ing
Mar 23 12:38:46.468 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x9bea784) implements 'check_main', priority 0
Mar 23 12:38:46.468 [24152] dbg: config: internal_networks not configured, using trusted_networks configuration for internal_networks; if you really want internal_networks to only contain the required 127/8 add 'internal_networks !0/0' to your configuration
Mar 23 12:38:46.469 [24152] dbg: received-header: parsed as [ ip=115.118.196.190 rdns= helo=arb1 by=firewall.akretio.be ident= envfrom= intl=0 id=E8387E0FFB auth= msa=0 ]
Mar 23 12:38:46.470 [24152] dbg: received-header: relay 115.118.196.190 trusted? no internal? no msa? no
Mar 23 12:38:46.471 [24152] dbg: metadata: X-Spam-Relays-Trusted:
Mar 23 12:38:46.471 [24152] dbg: metadata: X-Spam-Relays-Untrusted: [ ip=115.118.196.190 rdns= helo=arb1 by=firewall.akretio.be ident= envfrom= intl=0 id=E8387E0FFB auth= msa=0 ]
Mar 23 12:38:46.471 [24152] dbg: metadata: X-Spam-Relays-Internal:
Mar 23 12:38:46.472 [24152] dbg: metadata: X-Spam-Relays-External: [ ip=115.118.196.190 rdns= helo=arb1 by=firewall.akretio.be ident= envfrom= intl=0 id=E8387E0FFB auth= msa=0 ]
Mar 23 12:38:46.472 [24152] dbg: message: ---- MIME PARSER START ----
Mar 23 12:38:46.472 [24152] dbg: message: parsing multipart, got boundary: ----=_NextPart_000_002D_01CACAA4.978D0810
Mar 23 12:38:46.473 [24152] dbg: message: found part of type text/plain, boundary: ----=_NextPart_000_002D_01CACAA4.978D0810
Mar 23 12:38:46.473 [24152] dbg: message: added part, type: text/plain
Mar 23 12:38:46.475 [24152] dbg: message: found part of type text/html, boundary: ----=_NextPart_000_002D_01CACAA4.978D0810
Mar 23 12:38:46.475 [24152] dbg: message: added part, type: text/html
Mar 23 12:38:46.476 [24152] dbg: message: parsing normal part
Mar 23 12:38:46.476 [24152] dbg: message: parsing normal part
Mar 23 12:38:46.476 [24152] dbg: message: ---- MIME PARSER END ----
Mar 23 12:38:46.476 [24152] dbg: message: decoding other encoding type (7bit), ignoring
Mar 23 12:38:46.477 [24152] dbg: message: decoding quoted-printable
Mar 23 12:38:46.481 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x973dc4c) implements 'parsed_metadata', priority 0
Mar 23 12:38:46.481 [24152] dbg: dns: is_dns_available() last checked 1269344326.5 seconds ago; re-checking
Mar 23 12:38:46.483 [24152] dbg: dns: is Net::DNS::Resolver available? yes
Mar 23 12:38:46.483 [24152] dbg: dns: Net::DNS version: 0.65
Mar 23 12:38:46.484 [24152] dbg: dns: name server: 212.71.8.10, LocalAddr: 0.0.0.0
Mar 23 12:38:46.485 [24152] dbg: dns: resolver socket rx buffer size is 112640 bytes
Mar 23 12:38:46.485 [24152] dbg: dns: testing resolver nameservers: 212.71.8.10
Mar 23 12:38:46.485 [24152] dbg: dns: trying (3) w3.org...
Mar 23 12:38:46.485 [24152] dbg: dns: looking up NS for 'w3.org'
Mar 23 12:38:46.486 [24152] dbg: dns: providing a callback for id: 20662/w3.org/NS/IN
Mar 23 12:38:46.491 [24152] dbg: dns: NS lookup of w3.org using 212.71.8.10 succeeded => DNS available (set dns_available to override)
Mar 23 12:38:46.491 [24152] dbg: dns: name server: 212.71.8.10, LocalAddr: 0.0.0.0
Mar 23 12:38:46.492 [24152] dbg: dns: resolver socket rx buffer size is 112640 bytes
Mar 23 12:38:46.492 [24152] dbg: dns: NS list: 212.71.8.10
Mar 23 12:38:46.492 [24152] dbg: dns: name server: 212.71.8.10, LocalAddr: 0.0.0.0
Mar 23 12:38:46.493 [24152] dbg: dns: resolver socket rx buffer size is 112640 bytes
Mar 23 12:38:46.493 [24152] dbg: dns: is DNS available? 1
Mar 23 12:38:46.495 [24152] dbg: uridnsbl: domains to query: differhelp.com
Mar 23 12:38:46.496 [24152] dbg: check: check_main, time limit in 299.022 s
Mar 23 12:38:46.496 [24152] dbg: check: running tests for priority: 0
Mar 23 12:38:46.497 [24152] dbg: rules: running head tests; score so far=0
Mar 23 12:38:46.508 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 37857 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_1
Mar 23 12:38:46.520 [24152] dbg: rules: run_generic_tests - compiling eval code: head, priority 0
Mar 23 12:38:46.521 [24152] dbg: rules: compiled head tests
Mar 23 12:38:46.522 [24152] dbg: rules: running head_eval tests; score so far=0
Mar 23 12:38:46.522 [24152] dbg: rules: run_eval_tests - compiling eval code: 9, priority 0
Mar 23 12:38:46.524 [24152] dbg: FreeMail: RULE (FREEMAIL_REPLYTO) check_freemail_replyto
Mar 23 12:38:46.525 [24152] dbg: FreeMail: From address: bryanxf@worldatlas.com
Mar 23 12:38:46.525 [24152] dbg: FreeMail: Reply-To is not freemail, skipping check
Mar 23 12:38:46.525 [24152] dbg: FreeMail: RULE (FREEMAIL_FROM) check_freemail_from
Mar 23 12:38:46.526 [24152] dbg: eval: all '*From' addrs: bryanxF@worldatlas.com
Mar 23 12:38:46.526 [24152] dbg: FreeMail: all from-addresses: bryanxf@worldatlas.com
Mar 23 12:38:46.526 [24152] dbg: rules: running body tests; score so far=0
Mar 23 12:38:46.538 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60166 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_1
Mar 23 12:38:46.568 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60608 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_2
Mar 23 12:38:46.597 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60136 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_3
Mar 23 12:38:46.627 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60293 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_4
Mar 23 12:38:46.657 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60213 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_5
Mar 23 12:38:46.686 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60178 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_6
Mar 23 12:38:46.716 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60142 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_7
Mar 23 12:38:46.746 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60387 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_8
Mar 23 12:38:46.776 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60135 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_9
Mar 23 12:38:46.805 [24152] dbg: rules: flush_evalstr (add_evalstr) compiling 60395 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_10
Mar 23 12:38:46.828 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 25322 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_11
Mar 23 12:38:46.837 [24152] dbg: rules: run_generic_tests - compiling eval code: body, priority 0
Mar 23 12:38:46.838 [24152] dbg: rules: compiled body tests
Mar 23 12:38:46.845 [24152] dbg: rules: running uri tests; score so far=0
Mar 23 12:38:46.845 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 213 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_0_1
Mar 23 12:38:46.846 [24152] dbg: rules: run_generic_tests - compiling eval code: uri, priority 0
Mar 23 12:38:46.846 [24152] dbg: rules: compiled uri tests
Mar 23 12:38:46.847 [24152] dbg: rules: running rawbody tests; score so far=0
Mar 23 12:38:46.847 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 221 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_0_1
Mar 23 12:38:46.848 [24152] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 0
Mar 23 12:38:46.848 [24152] dbg: rules: compiled rawbody tests
Mar 23 12:38:46.848 [24152] dbg: rules: running full tests; score so far=0
Mar 23 12:38:46.849 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 250 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_0_1
Mar 23 12:38:46.849 [24152] dbg: rules: run_generic_tests - compiling eval code: full, priority 0
Mar 23 12:38:46.850 [24152] dbg: rules: compiled full tests
Mar 23 12:38:46.850 [24152] dbg: rules: running meta tests; score so far=0
Mar 23 12:38:46.850 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 275 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_0_1
Mar 23 12:38:46.851 [24152] dbg: rules: run_generic_tests - compiling eval code: meta, priority 0
Mar 23 12:38:46.851 [24152] dbg: rules: compiled meta tests
Mar 23 12:38:46.852 [24152] dbg: check: running tests for priority: 500
Mar 23 12:38:46.852 [24152] dbg: dns: harvest_dnsbl_queries
Mar 23 12:38:46.853 [24152] dbg: rules: running head tests; score so far=0
Mar 23 12:38:46.853 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 276 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_500_1
Mar 23 12:38:46.854 [24152] dbg: rules: run_generic_tests - compiling eval code: head, priority 500
Mar 23 12:38:46.854 [24152] dbg: rules: compiled head tests
Mar 23 12:38:46.855 [24152] dbg: rules: running body tests; score so far=0
Mar 23 12:38:46.855 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 219 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_500_1
Mar 23 12:38:46.856 [24152] dbg: rules: run_generic_tests - compiling eval code: body, priority 500
Mar 23 12:38:46.856 [24152] dbg: rules: compiled body tests
Mar 23 12:38:46.856 [24152] dbg: rules: running uri tests; score so far=0
Mar 23 12:38:46.857 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 217 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_500_1
Mar 23 12:38:46.857 [24152] dbg: rules: run_generic_tests - compiling eval code: uri, priority 500
Mar 23 12:38:46.857 [24152] dbg: rules: compiled uri tests
Mar 23 12:38:46.858 [24152] dbg: rules: running rawbody tests; score so far=0
Mar 23 12:38:46.858 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 225 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_500_1
Mar 23 12:38:46.859 [24152] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 500
Mar 23 12:38:46.859 [24152] dbg: rules: compiled rawbody tests
Mar 23 12:38:46.860 [24152] dbg: rules: running full tests; score so far=0
Mar 23 12:38:46.860 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 254 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_500_1
Mar 23 12:38:46.860 [24152] dbg: rules: run_generic_tests - compiling eval code: full, priority 500
Mar 23 12:38:46.861 [24152] dbg: rules: compiled full tests
Mar 23 12:38:46.861 [24152] dbg: rules: running meta tests; score so far=0
Mar 23 12:38:46.890 [24152] dbg: rules: flush_evalstr (run_generic_tests) compiling 41172 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_1
Mar 23 12:38:46.904 [24152] dbg: rules: run_generic_tests - compiling eval code: meta, priority 500
Mar 23 12:38:46.907 [24152] dbg: rules: compiled meta tests
Mar 23 12:38:46.908 [24152] dbg: check: is spam? score=0 required=5
Mar 23 12:38:46.910 [24152] dbg: check: tests=
Mar 23 12:38:46.910 [24152] dbg: check: subtests=
Mar 23 12:38:46.911 [24152] dbg: timing: total 1390 ms - init: 937 (67.4%), parse: 5 (0.4%), extract_message_metadata: 27 (2.0%), poll_dns_idle: 1.73 (0.1%), get_uri_detail_list: 1.12 (0.1%), tests_pri_0: 356 (25.6%), compile_gen: 217 (15.6%), compile_eval: 0.58 (0.0%), tests_pri_500: 56 (4.0%)
Mar 23 12:38:46.927 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::MIMEHeader=HASH(0x9b4191c) implements 'finish_tests', priority 0
Mar 23 12:38:46.927 [24152] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x9bea784) implements 'finish_tests', priority 0