Oct 21 14:44:05.653 [7897] dbg: logger: adding facilities: all
Oct 21 14:44:05.653 [7897] dbg: logger: logging level is DBG
Oct 21 14:44:05.653 [7897] dbg: generic: SpamAssassin version 3.3.1
Oct 21 14:44:05.653 [7897] dbg: generic: Perl 5.010001, PREFIX=/usr/local, DEF_RULES_DIR=/usr/local/share/spamassassin, LOCAL_RULES_DIR=/usr/local/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/db/spamassassin
Oct 21 14:44:05.653 [7897] dbg: config: timing enabled
Oct 21 14:44:05.654 [7897] dbg: config: score set 0 chosen.
Oct 21 14:44:05.655 [7897] dbg: util: running in taint mode? yes
Oct 21 14:44:05.655 [7897] dbg: util: taint mode: deleting unsafe environment variables, resetting PATH
Oct 21 14:44:05.655 [7897] dbg: util: PATH included '/sbin', keeping
Oct 21 14:44:05.655 [7897] dbg: util: PATH included '/bin', keeping
Oct 21 14:44:05.655 [7897] dbg: util: PATH included '/usr/sbin', keeping
Oct 21 14:44:05.655 [7897] dbg: util: PATH included '/usr/bin', keeping
Oct 21 14:44:05.655 [7897] dbg: util: PATH included '/usr/games', keeping
Oct 21 14:44:05.655 [7897] dbg: util: PATH included '/usr/local/sbin', keeping
Oct 21 14:44:05.655 [7897] dbg: util: PATH included '/usr/local/bin', keeping
Oct 21 14:44:05.656 [7897] dbg: util: PATH included '/root/bin', which is unusable, dropping: No such file or directory
Oct 21 14:44:05.656 [7897] dbg: util: final PATH set to: /sbin:/bin:/usr/sbin:/usr/bin:/usr/games:/usr/local/sbin:/usr/local/bin
Oct 21 14:44:05.658 [7897] dbg: dns: is Net::DNS::Resolver available? yes
Oct 21 14:44:05.658 [7897] dbg: dns: Net::DNS version: 0.66
Oct 21 14:44:05.801 [7897] dbg: diag: perl platform: 5.010001 freebsd
Oct 21 14:44:05.801 [7897] dbg: diag: [...] module installed: Digest::SHA1, version 2.13
Oct 21 14:44:05.801 [7897] dbg: diag: [...] module installed: HTML::Parser, version 3.68
Oct 21 14:44:05.801 [7897] dbg: diag: [...] module installed: Net::DNS, version 0.66
Oct 21 14:44:05.801 [7897] dbg: diag: [...] module installed: NetAddr::IP, version 4.028
Oct 21 14:44:05.801 [7897] dbg: diag: [...] module installed: Time::HiRes, version 1.9721
Oct 21 14:44:05.801 [7897] dbg: diag: [...] module installed: Archive::Tar, version 1.52
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: IO::Zlib, version 1.09
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: Digest::SHA1, version 2.13
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: MIME::Base64, version 3.08
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: DB_File, version 1.82
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: Net::SMTP, version 2.31
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: Mail::SPF, version v2.007
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: IP::Country::Fast, version 604.001
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: Razor2::Client::Agent, version 2.84
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module not installed: Net::Ident ('require' failed)
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: IO::Socket::INET6, version 2.65
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: IO::Socket::SSL, version 1.33
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: Compress::Zlib, version 2.02
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: Mail::DKIM, version 0.38
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: DBI, version 1.615
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: Getopt::Long, version 2.38
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: LWP::UserAgent, version 5.835
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: HTTP::Date, version 5.831
Oct 21 14:44:05.802 [7897] dbg: diag: [...] module installed: Encode::Detect, version 1.01
Oct 21 14:44:05.802 [7897] dbg: ignore: using a test message to lint rules
Oct 21 14:44:05.802 [7897] dbg: config: using "/usr/local/etc/mail/spamassassin" for site rules pre files
Oct 21 14:44:05.803 [7897] dbg: config: read file /usr/local/etc/mail/spamassassin/init.pre
Oct 21 14:44:05.803 [7897] dbg: config: read file /usr/local/etc/mail/spamassassin/v310.pre
Oct 21 14:44:05.803 [7897] dbg: config: read file /usr/local/etc/mail/spamassassin/v312.pre
Oct 21 14:44:05.803 [7897] dbg: config: read file /usr/local/etc/mail/spamassassin/v320.pre
Oct 21 14:44:05.803 [7897] dbg: config: read file /usr/local/etc/mail/spamassassin/v330.pre
Oct 21 14:44:05.803 [7897] dbg: config: using "/var/db/spamassassin/3.003001" for sys rules pre files
Oct 21 14:44:05.803 [7897] dbg: config: using "/var/db/spamassassin/3.003001" for default rules dir
Oct 21 14:44:05.803 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org.cf
Oct 21 14:44:05.803 [7897] dbg: config: using "/usr/local/etc/mail/spamassassin" for site rules dir
Oct 21 14:44:05.804 [7897] dbg: config: read file /usr/local/etc/mail/spamassassin/KAM.cf
Oct 21 14:44:05.804 [7897] dbg: config: read file /usr/local/etc/mail/spamassassin/local.cf
Oct 21 14:44:05.806 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDNSBL from @INC
Oct 21 14:44:05.809 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::Hashcash from @INC
Oct 21 14:44:05.811 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::SPF from @INC
Oct 21 14:44:05.813 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::Pyzor from @INC
Oct 21 14:44:05.814 [7897] dbg: pyzor: local tests only, disabling Pyzor
Oct 21 14:44:05.814 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::Razor2 from @INC
Oct 21 14:44:05.816 [7897] dbg: razor2: local tests only, skipping Razor
Oct 21 14:44:05.816 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::SpamCop from @INC
Oct 21 14:44:05.818 [7897] dbg: reporter: local tests only, disabling SpamCop
Oct 21 14:44:05.818 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::AutoLearnThreshold from @INC
Oct 21 14:44:05.819 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::WhiteListSubject from @INC
Oct 21 14:44:05.819 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEHeader from @INC
Oct 21 14:44:05.820 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::ReplaceTags from @INC
Oct 21 14:44:05.821 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::DKIM from @INC
Oct 21 14:44:05.825 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::Check from @INC
Oct 21 14:44:05.829 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTTPSMismatch from @INC
Oct 21 14:44:05.830 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDetail from @INC
Oct 21 14:44:05.831 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::Bayes from @INC
Oct 21 14:44:05.837 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::BodyEval from @INC
Oct 21 14:44:05.838 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::DNSEval from @INC
Oct 21 14:44:05.840 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTMLEval from @INC
Oct 21 14:44:05.841 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::HeaderEval from @INC
Oct 21 14:44:05.846 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEEval from @INC
Oct 21 14:44:05.848 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::RelayEval from @INC
Oct 21 14:44:05.849 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIEval from @INC
Oct 21 14:44:05.850 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::WLBLEval from @INC
Oct 21 14:44:05.851 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::VBounce from @INC
Oct 21 14:44:05.852 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::Rule2XSBody from @INC
Oct 21 14:44:05.854 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::ImageInfo from @INC
Oct 21 14:44:05.856 [7897] dbg: plugin: loading Mail::SpamAssassin::Plugin::FreeMail from @INC
Oct 21 14:44:05.858 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/10_default_prefs.cf
Oct 21 14:44:05.858 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/10_default_prefs.cf" for included file
Oct 21 14:44:05.858 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/10_default_prefs.cf
Oct 21 14:44:05.860 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_advance_fee.cf
Oct 21 14:44:05.860 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_advance_fee.cf" for included file
Oct 21 14:44:05.860 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_advance_fee.cf
Oct 21 14:44:05.863 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_aux_tlds.cf
Oct 21 14:44:05.863 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_aux_tlds.cf" for included file
Oct 21 14:44:05.863 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_aux_tlds.cf
Oct 21 14:44:05.867 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_body_tests.cf
Oct 21 14:44:05.867 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_body_tests.cf" for included file
Oct 21 14:44:05.867 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_body_tests.cf
Oct 21 14:44:05.870 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_compensate.cf
Oct 21 14:44:05.870 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_compensate.cf" for included file
Oct 21 14:44:05.870 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_compensate.cf
Oct 21 14:44:05.871 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_dnsbl_tests.cf
Oct 21 14:44:05.871 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_dnsbl_tests.cf" for included file
Oct 21 14:44:05.871 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_dnsbl_tests.cf
Oct 21 14:44:05.874 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_drugs.cf
Oct 21 14:44:05.874 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_drugs.cf" for included file
Oct 21 14:44:05.874 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_drugs.cf
Oct 21 14:44:05.882 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_dynrdns.cf
Oct 21 14:44:05.882 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_dynrdns.cf" for included file
Oct 21 14:44:05.882 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_dynrdns.cf
Oct 21 14:44:05.886 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_fake_helo_tests.cf
Oct 21 14:44:05.886 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_fake_helo_tests.cf" for included file
Oct 21 14:44:05.886 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_fake_helo_tests.cf
Oct 21 14:44:05.889 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_freemail.cf
Oct 21 14:44:05.889 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_freemail.cf" for included file
Oct 21 14:44:05.889 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_freemail.cf
Oct 21 14:44:05.890 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_freemail_domains.cf
Oct 21 14:44:05.890 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_freemail_domains.cf" for included file
Oct 21 14:44:05.891 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_freemail_domains.cf
Oct 21 14:44:05.891 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x159f528) implements 'parse_config', priority 0
Oct 21 14:44:05.903 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_head_tests.cf
Oct 21 14:44:05.903 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_head_tests.cf" for included file
Oct 21 14:44:05.904 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_head_tests.cf
Oct 21 14:44:05.918 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_html_tests.cf
Oct 21 14:44:05.918 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_html_tests.cf" for included file
Oct 21 14:44:05.919 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_html_tests.cf
Oct 21 14:44:05.924 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_imageinfo.cf
Oct 21 14:44:05.924 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_imageinfo.cf" for included file
Oct 21 14:44:05.924 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_imageinfo.cf
Oct 21 14:44:05.926 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_meta_tests.cf
Oct 21 14:44:05.926 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_meta_tests.cf" for included file
Oct 21 14:44:05.926 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_meta_tests.cf
Oct 21 14:44:05.928 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_net_tests.cf
Oct 21 14:44:05.928 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_net_tests.cf" for included file
Oct 21 14:44:05.928 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_net_tests.cf
Oct 21 14:44:05.928 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_phrases.cf
Oct 21 14:44:05.928 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_phrases.cf" for included file
Oct 21 14:44:05.929 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_phrases.cf
Oct 21 14:44:05.934 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_porn.cf
Oct 21 14:44:05.934 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_porn.cf" for included file
Oct 21 14:44:05.934 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_porn.cf
Oct 21 14:44:05.935 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_ratware.cf
Oct 21 14:44:05.935 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_ratware.cf" for included file
Oct 21 14:44:05.935 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_ratware.cf
Oct 21 14:44:05.943 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_uri_tests.cf
Oct 21 14:44:05.943 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_uri_tests.cf" for included file
Oct 21 14:44:05.943 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_uri_tests.cf
Oct 21 14:44:05.946 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/20_vbounce.cf
Oct 21 14:44:05.946 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/20_vbounce.cf" for included file
Oct 21 14:44:05.946 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/20_vbounce.cf
Oct 21 14:44:05.956 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/23_bayes.cf
Oct 21 14:44:05.957 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/23_bayes.cf" for included file
Oct 21 14:44:05.957 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/23_bayes.cf
Oct 21 14:44:05.958 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_accessdb.cf
Oct 21 14:44:05.958 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_accessdb.cf" for included file
Oct 21 14:44:05.958 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_accessdb.cf
Oct 21 14:44:05.958 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_antivirus.cf
Oct 21 14:44:05.958 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_antivirus.cf" for included file
Oct 21 14:44:05.958 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_antivirus.cf
Oct 21 14:44:05.959 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_asn.cf
Oct 21 14:44:05.959 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_asn.cf" for included file
Oct 21 14:44:05.959 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_asn.cf
Oct 21 14:44:05.959 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_dcc.cf
Oct 21 14:44:05.959 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_dcc.cf" for included file
Oct 21 14:44:05.959 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_dcc.cf
Oct 21 14:44:05.960 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_dkim.cf
Oct 21 14:44:05.960 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_dkim.cf" for included file
Oct 21 14:44:05.960 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_dkim.cf
Oct 21 14:44:05.962 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_hashcash.cf
Oct 21 14:44:05.962 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_hashcash.cf" for included file
Oct 21 14:44:05.962 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_hashcash.cf
Oct 21 14:44:05.963 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_pyzor.cf
Oct 21 14:44:05.963 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_pyzor.cf" for included file
Oct 21 14:44:05.963 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_pyzor.cf
Oct 21 14:44:05.965 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_razor2.cf
Oct 21 14:44:05.965 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_razor2.cf" for included file
Oct 21 14:44:05.965 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_razor2.cf
Oct 21 14:44:05.966 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_replace.cf
Oct 21 14:44:05.966 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_replace.cf" for included file
Oct 21 14:44:05.966 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_replace.cf
Oct 21 14:44:05.971 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_spf.cf
Oct 21 14:44:05.971 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_spf.cf" for included file
Oct 21 14:44:05.971 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_spf.cf
Oct 21 14:44:05.972 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_textcat.cf
Oct 21 14:44:05.972 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_textcat.cf" for included file
Oct 21 14:44:05.972 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_textcat.cf
Oct 21 14:44:05.972 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/25_uribl.cf
Oct 21 14:44:05.972 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/25_uribl.cf" for included file
Oct 21 14:44:05.973 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/25_uribl.cf
Oct 21 14:44:05.976 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_de.cf
Oct 21 14:44:05.976 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_de.cf" for included file
Oct 21 14:44:05.976 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_de.cf
Oct 21 14:44:05.979 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_fr.cf
Oct 21 14:44:05.979 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_fr.cf" for included file
Oct 21 14:44:05.979 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_fr.cf
Oct 21 14:44:05.981 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_it.cf
Oct 21 14:44:05.981 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_it.cf" for included file
Oct 21 14:44:05.981 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_it.cf
Oct 21 14:44:05.981 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_nl.cf
Oct 21 14:44:05.981 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_nl.cf" for included file
Oct 21 14:44:05.981 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_nl.cf
Oct 21 14:44:05.983 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_pl.cf
Oct 21 14:44:05.983 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_pl.cf" for included file
Oct 21 14:44:05.983 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_pl.cf
Oct 21 14:44:05.985 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_pt_br.cf
Oct 21 14:44:05.985 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_pt_br.cf" for included file
Oct 21 14:44:05.985 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/30_text_pt_br.cf
Oct 21 14:44:05.986 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/50_scores.cf
Oct 21 14:44:05.986 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/50_scores.cf" for included file
Oct 21 14:44:05.986 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/50_scores.cf
Oct 21 14:44:06.017 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/60_adsp_override_dkim.cf
Oct 21 14:44:06.017 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/60_adsp_override_dkim.cf" for included file
Oct 21 14:44:06.017 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/60_adsp_override_dkim.cf
Oct 21 14:44:06.020 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/60_awl.cf
Oct 21 14:44:06.020 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/60_awl.cf" for included file
Oct 21 14:44:06.020 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/60_awl.cf
Oct 21 14:44:06.020 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/60_shortcircuit.cf
Oct 21 14:44:06.020 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/60_shortcircuit.cf" for included file
Oct 21 14:44:06.020 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/60_shortcircuit.cf
Oct 21 14:44:06.021 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist.cf
Oct 21 14:44:06.021 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist.cf" for included file
Oct 21 14:44:06.021 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist.cf
Oct 21 14:44:06.022 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_dkim.cf
Oct 21 14:44:06.022 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_dkim.cf" for included file
Oct 21 14:44:06.023 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_dkim.cf
Oct 21 14:44:06.025 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_spf.cf
Oct 21 14:44:06.025 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_spf.cf" for included file
Oct 21 14:44:06.026 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_spf.cf
Oct 21 14:44:06.027 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_subject.cf
Oct 21 14:44:06.027 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_subject.cf" for included file
Oct 21 14:44:06.027 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_subject.cf
Oct 21 14:44:06.027 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/72_active.cf
Oct 21 14:44:06.027 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/72_active.cf" for included file
Oct 21 14:44:06.028 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/72_active.cf
Oct 21 14:44:06.124 [7897] dbg: config: uri_detail adding (text =~ /(?-xism:(?i)\b(?:cli(?:quez\W|ck\Wa)ici\b|cli(?:cca\W|c\Wa|que\Wa)qu[^<.,a ]|klie?k(?:\Whi?er|ni(?:j|nite)\Wtu[tk]aj)\b))/) to T_KHOP_FOREIGN_CLICK
Oct 21 14:44:06.124 [7897] dbg: config: uri_detail added T_KHOP_FOREIGN_CLICK
Oct 21 14:44:06.186 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/72_scores.cf
Oct 21 14:44:06.186 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/72_scores.cf" for included file
Oct 21 14:44:06.186 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/72_scores.cf
Oct 21 14:44:06.188 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/73_sandbox_manual_scores.cf
Oct 21 14:44:06.189 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/73_sandbox_manual_scores.cf" for included file
Oct 21 14:44:06.189 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/73_sandbox_manual_scores.cf
Oct 21 14:44:06.189 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/local.cf
Oct 21 14:44:06.189 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/local.cf" for included file
Oct 21 14:44:06.189 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/local.cf
Oct 21 14:44:06.190 [7897] dbg: config: fixed relative path: /var/db/spamassassin/3.003001/updates_spamassassin_org/regression_tests.cf
Oct 21 14:44:06.190 [7897] dbg: config: using "/var/db/spamassassin/3.003001/updates_spamassassin_org/regression_tests.cf" for included file
Oct 21 14:44:06.190 [7897] dbg: config: read file /var/db/spamassassin/3.003001/updates_spamassassin_org/regression_tests.cf
Oct 21 14:44:06.268 [7897] dbg: config: not allowing user rules!
Oct 21 14:44:06.301 [7897] dbg: config: warning: score set for non-existent rule ADVANCE_FEE_3
Oct 21 14:44:06.301 [7897] dbg: config: warning: score set for non-existent rule SHORTCIRCUIT
Oct 21 14:44:06.301 [7897] dbg: config: warning: score set for non-existent rule SUBJ_RE_NUM
Oct 21 14:44:06.301 [7897] dbg: config: warning: score set for non-existent rule FM_VIAGRA_SPAM1114
Oct 21 14:44:06.301 [7897] dbg: config: warning: score set for non-existent rule ADVANCE_FEE_2
Oct 21 14:44:06.302 [7897] dbg: config: warning: score set for non-existent rule AXB_HELO_LH_HOME
Oct 21 14:44:06.302 [7897] dbg: config: warning: score set for non-existent rule HK_FAKENAME_MICROSOFT
Oct 21 14:44:06.302 [7897] dbg: config: warning: score set for non-existent rule ACCESSDB
Oct 21 14:44:06.302 [7897] dbg: config: warning: score set for non-existent rule ADVANCE_FEE_4
Oct 21 14:44:06.582 [7897] dbg: rules: __MO_OL_9B90B merged duplicates: __MO_OL_C65FA
Oct 21 14:44:06.582 [7897] dbg: rules: __XM_OL_22B61 merged duplicates: __XM_OL_A842E
Oct 21 14:44:06.582 [7897] dbg: rules: __MO_OL_07794 merged duplicates: __MO_OL_8627E __MO_OL_F3B05
Oct 21 14:44:06.582 [7897] dbg: rules: __XM_OL_07794 merged duplicates: __XM_OL_25340 __XM_OL_3857F __XM_OL_4F240 __XM_OL_58CB5 __XM_OL_6554A __XM_OL_812FF __XM_OL_C65FA __XM_OL_CF0C0 __XM_OL_F475E __XM_OL_F6D01
Oct 21 14:44:06.582 [7897] dbg: rules: FH_MSGID_01C67 merged duplicates: __MSGID_VGA
Oct 21 14:44:06.582 [7897] dbg: rules: FS_NEW_SOFT_UPLOAD merged duplicates: HS_SUBJ_NEW_SOFTWARE
Oct 21 14:44:06.582 [7897] dbg: rules: __MO_OL_91287 merged duplicates: __MO_OL_B30D1 __MO_OL_CF0C0
Oct 21 14:44:06.582 [7897] dbg: rules: KAM_STOCKOTC merged duplicates: KAM_STOCKTIP15 KAM_STOCKTIP20 KAM_STOCKTIP21 KAM_STOCKTIP4 KAM_STOCKTIP6
Oct 21 14:44:06.582 [7897] dbg: rules: __XM_OL_015D5 merged duplicates: __XM_OL_4BF4C __XM_OL_4EEDB __XM_OL_5B79A __XM_OL_9B90B __XM_OL_ADFF7 __XM_OL_B30D1 __XM_OL_B4B40 __XM_OL_BC7E6 __XM_OL_F3B05 __XM_OL_FF5C8
Oct 21 14:44:06.582 [7897] dbg: rules: __MO_OL_015D5 merged duplicates: __MO_OL_6554A
Oct 21 14:44:06.583 [7897] dbg: rules: __MO_OL_22B61 merged duplicates: __MO_OL_4F240 __MO_OL_ADFF7
Oct 21 14:44:06.583 [7897] dbg: rules: __MO_OL_812FF merged duplicates: __MO_OL_BC7E6
Oct 21 14:44:06.583 [7897] dbg: rules: __MO_OL_25340 merged duplicates: __MO_OL_4EEDB __MO_OL_7533E
Oct 21 14:44:06.583 [7897] dbg: rules: __DOS_HAS_MAILING_LIST merged duplicates: __ML4 __freemail_safe_ml2
Oct 21 14:44:06.583 [7897] dbg: rules: __ML2 merged duplicates: __freemail_safe_ml1
Oct 21 14:44:06.583 [7897] dbg: rules: __MO_OL_58CB5 merged duplicates: __MO_OL_B4B40
Oct 21 14:44:06.583 [7897] dbg: rules: __DOS_HAS_ANY_URI merged duplicates: __HAS_ANY_URI
Oct 21 14:44:06.583 [7897] dbg: rules: __FH_HAS_XMSMAIL merged duplicates: __HAS_MSMAIL_PRI
Oct 21 14:44:06.583 [7897] dbg: rules: CTYPE_001C_A merged duplicates: DATE_IN_FUTURE_96_XX
Oct 21 14:44:06.583 [7897] dbg: rules: FS_SILDENAFIL merged duplicates: __KAM_SILD1
Oct 21 14:44:06.583 [7897] dbg: rules: __MO_OL_72641 merged duplicates: __MO_OL_A842E
Oct 21 14:44:06.583 [7897] dbg: rules: __HAS_X_MAILING_LIST merged duplicates: __freemail_safe_ml3
Oct 21 14:44:06.583 [7897] dbg: rules: __MO_OL_4BF4C merged duplicates: __MO_OL_F6D01
Oct 21 14:44:06.583 [7897] dbg: rules: __MO_OL_F475E merged duplicates: __MO_OL_FF5C8
Oct 21 14:44:06.584 [7897] dbg: config: finish parsing
Oct 21 14:44:06.600 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::ReplaceTags=HASH(0x1465fe8) implements 'finish_parsing_end', priority 0
Oct 21 14:44:06.600 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x1581e08) implements 'finish_parsing_end', priority 0
Oct 21 14:44:06.600 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x159f528) implements 'finish_parsing_end', priority 0
Oct 21 14:44:06.600 [7897] dbg: replacetags: replacing tags
Oct 21 14:44:06.621 [7897] dbg: replacetags: done replacing tags
Oct 21 14:44:06.622 [7897] dbg: zoom: loading compiled ruleset from /var/db/spamassassin/compiled/5.010/3.003001
Oct 21 14:44:06.624 [7897] dbg: zoom: using compiled ruleset in /var/db/spamassassin/compiled/5.010/3.003001/Mail/SpamAssassin/CompiledRegexps/body_0.pm for Mail::SpamAssassin::CompiledRegexps::body_0
Oct 21 14:44:06.627 [7897] dbg: zoom: skipping rule __KAM_LOTTO3, code differs in compiled ruleset
Oct 21 14:44:06.627 [7897] dbg: zoom: skipping rule __KAM_LOTTO1, code differs in compiled ruleset
Oct 21 14:44:06.627 [7897] dbg: zoom: skipping rule __KAM_LOTTO5, code differs in compiled ruleset
Oct 21 14:44:06.628 [7897] dbg: zoom: skipping rule __KAM_LOTTO2, code differs in compiled ruleset
Oct 21 14:44:06.629 [7897] dbg: zoom: skipping rule __KAM_LOTTO6, code differs in compiled ruleset
Oct 21 14:44:06.629 [7897] dbg: zoom: skipping rule __KAM_LOTTO4, code differs in compiled ruleset
Oct 21 14:44:06.630 [7897] dbg: zoom: able to use 933/939 'body_0' compiled rules (99.361%)
Oct 21 14:44:06.630 [7897] dbg: FreeMail: loaded freemail_domains entries: 2109 normal, 24 wildcard
Oct 21 14:44:06.632 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::Bayes=HASH(0x14bf9b0) implements 'learner_new', priority 0
Oct 21 14:44:06.632 [7897] dbg: bayes: learner_new self=Mail::SpamAssassin::Plugin::Bayes=HASH(0x14bf9b0), bayes_store_module=Mail::SpamAssassin::BayesStore::DBM
Oct 21 14:44:06.640 [7897] dbg: bayes: learner_new: got store=Mail::SpamAssassin::BayesStore::DBM=HASH(0x17913d8)
Oct 21 14:44:06.641 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::Bayes=HASH(0x14bf9b0) implements 'learner_is_scan_available', priority 0
Oct 21 14:44:06.641 [7897] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_toks
Oct 21 14:44:06.641 [7897] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_seen
Oct 21 14:44:06.641 [7897] dbg: bayes: found bayes db version 3
Oct 21 14:44:06.641 [7897] dbg: bayes: DB journal sync: last sync: 1287664598
Oct 21 14:44:06.642 [7897] dbg: config: score set 2 chosen.
Oct 21 14:44:06.642 [7897] dbg: message: main message type: text/plain
Oct 21 14:44:06.642 [7897] dbg: message: ---- MIME PARSER START ----
Oct 21 14:44:06.642 [7897] dbg: message: parsing normal part
Oct 21 14:44:06.642 [7897] dbg: message: ---- MIME PARSER END ----
Oct 21 14:44:06.642 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::DNSEval=HASH(0x14ff060) implements 'check_start', priority 0
Oct 21 14:44:06.642 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x1581e08) implements 'check_start', priority 0
Oct 21 14:44:06.646 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x14aa5e8) implements 'check_main', priority 0
Oct 21 14:44:06.646 [7897] dbg: config: trusted_networks are not configured; it is recommended that you configure trusted_networks manually
Oct 21 14:44:06.646 [7897] dbg: metadata: X-Spam-Relays-Trusted:
Oct 21 14:44:06.646 [7897] dbg: metadata: X-Spam-Relays-Untrusted:
Oct 21 14:44:06.646 [7897] dbg: metadata: X-Spam-Relays-Internal:
Oct 21 14:44:06.646 [7897] dbg: metadata: X-Spam-Relays-External:
Oct 21 14:44:06.646 [7897] dbg: message: no encoding detected
Oct 21 14:44:06.646 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x1395f70) implements 'parsed_metadata', priority 0
Oct 21 14:44:06.647 [7897] dbg: dns: is_dns_available() last checked 1287665046.6 seconds ago; re-checking
Oct 21 14:44:06.647 [7897] dbg: dns: is DNS available? 0
Oct 21 14:44:06.647 [7897] dbg: rules: local tests only, ignoring RBL eval
Oct 21 14:44:06.648 [7897] dbg: check: running tests for priority: -1000
Oct 21 14:44:06.648 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x1581e08) implements 'check_rules_at_priority', priority 0
Oct 21 14:44:06.648 [7897] dbg: rules: running one_line_body tests; score so far=0
Oct 21 14:44:06.648 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 508 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg1000_1
Oct 21 14:44:06.648 [7897] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -1000
Oct 21 14:44:06.648 [7897] dbg: rules: compiled one_line_body tests
Oct 21 14:44:06.649 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x1581e08) implements 'run_body_fast_scan', priority 0
Oct 21 14:44:06.649 [7897] dbg: rules: running head tests; score so far=0
Oct 21 14:44:06.649 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 288 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg1000_1
Oct 21 14:44:06.649 [7897] dbg: rules: run_generic_tests - compiling eval code: head, priority -1000
Oct 21 14:44:06.649 [7897] dbg: rules: compiled head tests
Oct 21 14:44:06.649 [7897] dbg: rules: running head_eval tests; score so far=0
Oct 21 14:44:06.650 [7897] dbg: rules: run_eval_tests - compiling eval code: 9, priority -1000
Oct 21 14:44:06.650 [7897] dbg: eval: all '*From' addrs: ignore@compiling.spamassassin.taint.org
Oct 21 14:44:06.650 [7897] dbg: eval: all '*To' addrs:
Oct 21 14:44:06.651 [7897] dbg: rules: running body tests; score so far=0
Oct 21 14:44:06.651 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 231 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg1000_1
Oct 21 14:44:06.651 [7897] dbg: rules: run_generic_tests - compiling eval code: body, priority -1000
Oct 21 14:44:06.651 [7897] dbg: rules: compiled body tests
Oct 21 14:44:06.651 [7897] dbg: rules: running uri tests; score so far=0
Oct 21 14:44:06.651 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg1000_1
Oct 21 14:44:06.651 [7897] dbg: rules: run_generic_tests - compiling eval code: uri, priority -1000
Oct 21 14:44:06.652 [7897] dbg: rules: compiled uri tests
Oct 21 14:44:06.652 [7897] dbg: rules: running rawbody tests; score so far=0
Oct 21 14:44:06.652 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 237 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg1000_1
Oct 21 14:44:06.652 [7897] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -1000
Oct 21 14:44:06.652 [7897] dbg: rules: compiled rawbody tests
Oct 21 14:44:06.652 [7897] dbg: rules: running full tests; score so far=0
Oct 21 14:44:06.652 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 266 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg1000_1
Oct 21 14:44:06.652 [7897] dbg: rules: run_generic_tests - compiling eval code: full, priority -1000
Oct 21 14:44:06.652 [7897] dbg: rules: compiled full tests
Oct 21 14:44:06.653 [7897] dbg: rules: running meta tests; score so far=0
Oct 21 14:44:06.653 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 291 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg1000_1
Oct 21 14:44:06.653 [7897] dbg: rules: run_generic_tests - compiling eval code: meta, priority -1000
Oct 21 14:44:06.653 [7897] dbg: rules: compiled meta tests
Oct 21 14:44:06.653 [7897] dbg: check: running tests for priority: -950
Oct 21 14:44:06.653 [7897] dbg: rules: running one_line_body tests; score so far=0
Oct 21 14:44:06.653 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 505 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg950_1
Oct 21 14:44:06.654 [7897] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -950
Oct 21 14:44:06.654 [7897] dbg: rules: compiled one_line_body tests
Oct 21 14:44:06.654 [7897] dbg: rules: running head tests; score so far=0
Oct 21 14:44:06.654 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 286 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg950_1
Oct 21 14:44:06.654 [7897] dbg: rules: run_generic_tests - compiling eval code: head, priority -950
Oct 21 14:44:06.654 [7897] dbg: rules: compiled head tests
Oct 21 14:44:06.654 [7897] dbg: rules: running head_eval tests; score so far=0
Oct 21 14:44:06.654 [7897] dbg: rules: run_eval_tests - compiling eval code: 9, priority -950
Oct 21 14:44:06.655 [7897] dbg: rules: running body tests; score so far=0
Oct 21 14:44:06.655 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg950_1
Oct 21 14:44:06.655 [7897] dbg: rules: run_generic_tests - compiling eval code: body, priority -950
Oct 21 14:44:06.655 [7897] dbg: rules: compiled body tests
Oct 21 14:44:06.655 [7897] dbg: rules: running uri tests; score so far=0
Oct 21 14:44:06.655 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 227 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg950_1
Oct 21 14:44:06.655 [7897] dbg: rules: run_generic_tests - compiling eval code: uri, priority -950
Oct 21 14:44:06.656 [7897] dbg: rules: compiled uri tests
Oct 21 14:44:06.656 [7897] dbg: rules: running rawbody tests; score so far=0
Oct 21 14:44:06.656 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 235 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg950_1
Oct 21 14:44:06.656 [7897] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -950
Oct 21 14:44:06.656 [7897] dbg: rules: compiled rawbody tests
Oct 21 14:44:06.656 [7897] dbg: rules: running full tests; score so far=0
Oct 21 14:44:06.656 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 264 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg950_1
Oct 21 14:44:06.656 [7897] dbg: rules: run_generic_tests - compiling eval code: full, priority -950
Oct 21 14:44:06.656 [7897] dbg: rules: compiled full tests
Oct 21 14:44:06.657 [7897] dbg: rules: running meta tests; score so far=0
Oct 21 14:44:06.657 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 289 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg950_1
Oct 21 14:44:06.657 [7897] dbg: rules: run_generic_tests - compiling eval code: meta, priority -950
Oct 21 14:44:06.657 [7897] dbg: rules: compiled meta tests
Oct 21 14:44:06.657 [7897] dbg: check: running tests for priority: -900
Oct 21 14:44:06.657 [7897] dbg: rules: running one_line_body tests; score so far=0
Oct 21 14:44:06.657 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 505 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg900_1
Oct 21 14:44:06.657 [7897] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -900
Oct 21 14:44:06.658 [7897] dbg: rules: compiled one_line_body tests
Oct 21 14:44:06.658 [7897] dbg: rules: running head tests; score so far=0
Oct 21 14:44:06.658 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 286 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg900_1
Oct 21 14:44:06.658 [7897] dbg: rules: run_generic_tests - compiling eval code: head, priority -900
Oct 21 14:44:06.658 [7897] dbg: rules: compiled head tests
Oct 21 14:44:06.658 [7897] dbg: rules: running head_eval tests; score so far=0
Oct 21 14:44:06.658 [7897] dbg: rules: run_eval_tests - compiling eval code: 9, priority -900
Oct 21 14:44:06.659 [7897] dbg: rules: running body tests; score so far=0
Oct 21 14:44:06.659 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg900_1
Oct 21 14:44:06.659 [7897] dbg: rules: run_generic_tests - compiling eval code: body, priority -900
Oct 21 14:44:06.659 [7897] dbg: rules: compiled body tests
Oct 21 14:44:06.659 [7897] dbg: rules: running uri tests; score so far=0
Oct 21 14:44:06.659 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 227 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg900_1
Oct 21 14:44:06.660 [7897] dbg: rules: run_generic_tests - compiling eval code: uri, priority -900
Oct 21 14:44:06.660 [7897] dbg: rules: compiled uri tests
Oct 21 14:44:06.660 [7897] dbg: rules: running rawbody tests; score so far=0
Oct 21 14:44:06.660 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 235 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg900_1
Oct 21 14:44:06.660 [7897] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -900
Oct 21 14:44:06.660 [7897] dbg: rules: compiled rawbody tests
Oct 21 14:44:06.660 [7897] dbg: rules: running full tests; score so far=0
Oct 21 14:44:06.660 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 264 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg900_1
Oct 21 14:44:06.661 [7897] dbg: rules: run_generic_tests - compiling eval code: full, priority -900
Oct 21 14:44:06.661 [7897] dbg: rules: compiled full tests
Oct 21 14:44:06.661 [7897] dbg: rules: running meta tests; score so far=0
Oct 21 14:44:06.661 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 289 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg900_1
Oct 21 14:44:06.661 [7897] dbg: rules: run_generic_tests - compiling eval code: meta, priority -900
Oct 21 14:44:06.661 [7897] dbg: rules: compiled meta tests
Oct 21 14:44:06.661 [7897] dbg: check: running tests for priority: -400
Oct 21 14:44:06.661 [7897] dbg: rules: running one_line_body tests; score so far=0
Oct 21 14:44:06.661 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 505 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg400_1
Oct 21 14:44:06.662 [7897] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -400
Oct 21 14:44:06.662 [7897] dbg: rules: compiled one_line_body tests
Oct 21 14:44:06.662 [7897] dbg: rules: running head tests; score so far=0
Oct 21 14:44:06.662 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 286 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg400_1
Oct 21 14:44:06.662 [7897] dbg: rules: run_generic_tests - compiling eval code: head, priority -400
Oct 21 14:44:06.662 [7897] dbg: rules: compiled head tests
Oct 21 14:44:06.662 [7897] dbg: rules: running body tests; score so far=0
Oct 21 14:44:06.662 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg400_1
Oct 21 14:44:06.663 [7897] dbg: rules: run_generic_tests - compiling eval code: body, priority -400
Oct 21 14:44:06.663 [7897] dbg: rules: compiled body tests
Oct 21 14:44:06.663 [7897] dbg: rules: running uri tests; score so far=0
Oct 21 14:44:06.663 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 227 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg400_1
Oct 21 14:44:06.663 [7897] dbg: rules: run_generic_tests - compiling eval code: uri, priority -400
Oct 21 14:44:06.663 [7897] dbg: rules: compiled uri tests
Oct 21 14:44:06.663 [7897] dbg: rules: running body_eval tests; score so far=0
Oct 21 14:44:06.663 [7897] dbg: rules: run_eval_tests - compiling eval code: 11, priority -400
Oct 21 14:44:06.664 [7897] dbg: plugin: Mail::SpamAssassin::Plugin::WLBLEval=HASH(0x156c018) implements 'check_wb_list', priority 0
Oct 21 14:44:06.664 [7897] dbg: bayes: DB journal sync: last sync: 1287664598
Oct 21 14:44:06.664 [7897] dbg: bayes: corpus size: nspam = 2572, nham = 934
Oct 21 14:44:06.667 [7897] dbg: bayes: score = 0.806824898521941
Oct 21 14:44:06.668 [7897] dbg: bayes: DB journal sync: last sync: 1287664598
Oct 21 14:44:06.668 [7897] dbg: bayes: untie-ing
Oct 21 14:44:06.668 [7897] dbg: rules: running rawbody tests; score so far=0
Oct 21 14:44:06.668 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 235 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg400_1
Oct 21 14:44:06.668 [7897] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -400
Oct 21 14:44:06.668 [7897] dbg: rules: compiled rawbody tests
Oct 21 14:44:06.668 [7897] dbg: rules: running full tests; score so far=0
Oct 21 14:44:06.669 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 264 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg400_1
Oct 21 14:44:06.669 [7897] dbg: rules: run_generic_tests - compiling eval code: full, priority -400
Oct 21 14:44:06.669 [7897] dbg: rules: compiled full tests
Oct 21 14:44:06.669 [7897] dbg: rules: running meta tests; score so far=0
Oct 21 14:44:06.669 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 289 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg400_1
Oct 21 14:44:06.669 [7897] dbg: rules: run_generic_tests - compiling eval code: meta, priority -400
Oct 21 14:44:06.669 [7897] dbg: rules: compiled meta tests
Oct 21 14:44:06.669 [7897] dbg: check: running tests for priority: 0
Oct 21 14:44:06.670 [7897] dbg: rules: running one_line_body tests; score so far=0
Oct 21 14:44:06.690 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 494 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_0_1
Oct 21 14:44:06.691 [7897] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 0
Oct 21 14:44:06.736 [7897] dbg: rules: compiled one_line_body tests
Oct 21 14:44:06.736 [7897] dbg: zoom: run_body_fast_scan for body_0 start
Oct 21 14:44:06.737 [7897] dbg: zoom: run_body_fast_scan for body_0 done
Oct 21 14:44:06.737 [7897] dbg: rules: running head tests; score so far=0
Oct 21 14:44:06.753 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60019 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_1
Oct 21 14:44:06.760 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60324 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_2
Oct 21 14:44:06.766 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60314 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_3
Oct 21 14:44:06.773 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60107 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_4
Oct 21 14:44:06.779 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60227 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_5
Oct 21 14:44:06.786 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60422 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_6
Oct 21 14:44:06.793 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 51196 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_7
Oct 21 14:44:06.797 [7897] dbg: rules: run_generic_tests - compiling eval code: head, priority 0
Oct 21 14:44:06.797 [7897] dbg: rules: compiled head tests
Oct 21 14:44:06.797 [7897] dbg: rules: ran header rule __MISSING_REF ======> got hit: "UNSET"
Oct 21 14:44:06.797 [7897] dbg: rules: ran header rule __MISSING_REPLY ======> got hit: "UNSET"
Oct 21 14:44:06.798 [7897] dbg: rules: ran header rule __MSGID_OK_HOST ======> got hit: "@lint_rules>"
Oct 21 14:44:06.798 [7897] dbg: rules: ran header rule __MSGID_OK_DIGITS ======> got hit: "1287665045"
Oct 21 14:44:06.798 [7897] dbg: rules: ran header rule __HAS_MESSAGE_ID ======> got hit: "<YES>"
Oct 21 14:44:06.799 [7897] dbg: rules: ran header rule __HAS_SUBJECT ======> got hit: "<YES>"
Oct 21 14:44:06.799 [7897] dbg: rules: ran header rule __MSOE_MID_WRONG_CASE ======> got hit: "
Oct 21 14:44:06.799 [7897] dbg: rules: [...] Message-Id: "
Oct 21 14:44:06.799 [7897] dbg: rules: ran header rule __HAS_MSGID ======> got hit: "<"
Oct 21 14:44:06.799 [7897] dbg: rules: ran header rule __SANE_MSGID ======> got hit: "<1287665045@lint_rules>
Oct 21 14:44:06.800 [7897] dbg: rules: [...] "
Oct 21 14:44:06.800 [7897] dbg: rules: ran header rule __TO_NO_ARROWS_R ======> got hit: "negative match"
Oct 21 14:44:06.800 [7897] dbg: rules: ran header rule __KAM_UPS2 ======> got hit: "negative match"
Oct 21 14:44:06.801 [7897] dbg: rules: running head_eval tests; score so far=0
Oct 21 14:44:06.802 [7897] dbg: rules: run_eval_tests - compiling eval code: 9, priority 0
Oct 21 14:44:06.805 [7897] dbg: eval: no dates found in message
Oct 21 14:44:06.805 [7897] dbg: FreeMail: RULE (FREEMAIL_FROM) check_freemail_from
Oct 21 14:44:06.805 [7897] dbg: FreeMail: all from-addresses: ignore@compiling.spamassassin.taint.org
Oct 21 14:44:06.805 [7897] dbg: FreeMail: RULE (__freemail_reply) check_freemail_replyto
Oct 21 14:44:06.806 [7897] dbg: FreeMail: From address: ignore@compiling.spamassassin.taint.org
Oct 21 14:44:06.806 [7897] dbg: FreeMail: No Reply-To and From is not freemail, skipping check
Oct 21 14:44:06.806 [7897] dbg: rules: ran eval rule NO_RELAYS ======> got hit (1)
Oct 21 14:44:06.807 [7897] dbg: rules: ran eval rule __GATED_THROUGH_RCVD_REMOVER ======> got hit (1)
Oct 21 14:44:06.807 [7897] dbg: FreeMail: RULE (FREEMAIL_REPLYTO_END_DIGIT) check_freemail_header regex:\d@
Oct 21 14:44:06.807 [7897] dbg: FreeMail: header Reply-To not found from mail
Oct 21 14:44:06.807 [7897] dbg: FreeMail: RULE (__freemail_replyto) check_freemail_replyto
Oct 21 14:44:06.807 [7897] dbg: FreeMail: From address: ignore@compiling.spamassassin.taint.org
Oct 21 14:44:06.807 [7897] dbg: FreeMail: Reply-To is not freemail, skipping check
Oct 21 14:44:06.808 [7897] dbg: FreeMail: RULE (__freemail_hdr_replyto) check_freemail_header
Oct 21 14:44:06.808 [7897] dbg: FreeMail: header Reply-To not found from mail
Oct 21 14:44:06.808 [7897] dbg: spf: cannot get Envelope-From, cannot use SPF
Oct 21 14:44:06.808 [7897] dbg: spf: def_spf_whitelist_from: could not find useable envelope sender
Oct 21 14:44:06.808 [7897] dbg: FreeMail: RULE (FREEMAIL_ENVFROM_END_DIGIT) check_freemail_header regex:\d@
Oct 21 14:44:06.808 [7897] dbg: FreeMail: header EnvelopeFrom not found from mail
Oct 21 14:44:06.809 [7897] dbg: spf: spf_whitelist_from: could not find useable envelope sender
Oct 21 14:44:06.809 [7897] dbg: rules: ran eval rule MISSING_HEADERS ======> got hit (1)
Oct 21 14:44:06.809 [7897] dbg: rules: running body tests; score so far=1.203
Oct 21 14:44:06.812 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60382 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_1
Oct 21 14:44:06.821 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60216 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_2
Oct 21 14:44:06.829 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60476 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_3
Oct 21 14:44:06.838 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 62291 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_4
Oct 21 14:44:06.853 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60432 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_5
Oct 21 14:44:06.867 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 60316 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_6
Oct 21 14:44:06.879 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 59708 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_7
Oct 21 14:44:06.885 [7897] dbg: rules: run_generic_tests - compiling eval code: body, priority 0
Oct 21 14:44:06.885 [7897] dbg: rules: compiled body tests
Oct 21 14:44:06.969 [7897] dbg: rules: ran body rule __NONEMPTY_BODY ======> got hit: "I"
Oct 21 14:44:07.007 [7897] dbg: rules: running uri tests; score so far=1.203
Oct 21 14:44:07.008 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 28021 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_0_1
Oct 21 14:44:07.011 [7897] dbg: rules: run_generic_tests - compiling eval code: uri, priority 0
Oct 21 14:44:07.011 [7897] dbg: rules: compiled uri tests
Oct 21 14:44:07.011 [7897] dbg: rules: running body_eval tests; score so far=1.203
Oct 21 14:44:07.013 [7897] dbg: rules: run_eval_tests - compiling eval code: 11, priority 0
Oct 21 14:44:07.020 [7897] dbg: https_http_mismatch: anchors 0
Oct 21 14:44:07.021 [7897] dbg: rules: ran eval rule BAYES_80 ======> got hit (1)
Oct 21 14:44:07.026 [7897] dbg: rules: running rawbody tests; score so far=3.903
Oct 21 14:44:07.027 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 23005 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_0_1
Oct 21 14:44:07.029 [7897] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 0
Oct 21 14:44:07.029 [7897] dbg: rules: compiled rawbody tests
Oct 21 14:44:07.032 [7897] dbg: rules: running rawbody_eval tests; score so far=3.903
Oct 21 14:44:07.032 [7897] dbg: rules: run_eval_tests - compiling eval code: 15, priority 0
Oct 21 14:44:07.032 [7897] dbg: rules: running full tests; score so far=3.903
Oct 21 14:44:07.033 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 1171 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_0_1
Oct 21 14:44:07.033 [7897] dbg: rules: run_generic_tests - compiling eval code: full, priority 0
Oct 21 14:44:07.033 [7897] dbg: rules: compiled full tests
Oct 21 14:44:07.033 [7897] dbg: rules: running full_eval tests; score so far=3.903
Oct 21 14:44:07.033 [7897] dbg: rules: run_eval_tests - compiling eval code: 13, priority 0
Oct 21 14:44:07.034 [7897] dbg: dkim: signature verification disabled, DNS resolving not available
Oct 21 14:44:07.034 [7897] dbg: rules: running meta tests; score so far=3.903
Oct 21 14:44:07.034 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 281 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_0_1
Oct 21 14:44:07.034 [7897] dbg: rules: run_generic_tests - compiling eval code: meta, priority 0
Oct 21 14:44:07.034 [7897] dbg: rules: compiled meta tests
Oct 21 14:44:07.034 [7897] dbg: check: running tests for priority: 500
Oct 21 14:44:07.034 [7897] dbg: dns: harvest_dnsbl_queries
Oct 21 14:44:07.035 [7897] dbg: rules: running one_line_body tests; score so far=3.903
Oct 21 14:44:07.035 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 500 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_500_1
Oct 21 14:44:07.035 [7897] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 500
Oct 21 14:44:07.035 [7897] dbg: rules: compiled one_line_body tests
Oct 21 14:44:07.035 [7897] dbg: rules: running head tests; score so far=3.903
Oct 21 14:44:07.035 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 282 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_500_1
Oct 21 14:44:07.035 [7897] dbg: rules: run_generic_tests - compiling eval code: head, priority 500
Oct 21 14:44:07.036 [7897] dbg: rules: compiled head tests
Oct 21 14:44:07.036 [7897] dbg: rules: running body tests; score so far=3.903
Oct 21 14:44:07.036 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 225 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_500_1
Oct 21 14:44:07.036 [7897] dbg: rules: run_generic_tests - compiling eval code: body, priority 500
Oct 21 14:44:07.036 [7897] dbg: rules: compiled body tests
Oct 21 14:44:07.036 [7897] dbg: rules: running uri tests; score so far=3.903
Oct 21 14:44:07.036 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 223 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_500_1
Oct 21 14:44:07.036 [7897] dbg: rules: run_generic_tests - compiling eval code: uri, priority 500
Oct 21 14:44:07.037 [7897] dbg: rules: compiled uri tests
Oct 21 14:44:07.037 [7897] dbg: rules: running rawbody tests; score so far=3.903
Oct 21 14:44:07.037 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 231 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_500_1
Oct 21 14:44:07.037 [7897] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 500
Oct 21 14:44:07.037 [7897] dbg: rules: compiled rawbody tests
Oct 21 14:44:07.037 [7897] dbg: rules: running full tests; score so far=3.903
Oct 21 14:44:07.037 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 260 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_500_1
Oct 21 14:44:07.037 [7897] dbg: rules: run_generic_tests - compiling eval code: full, priority 500
Oct 21 14:44:07.038 [7897] dbg: rules: compiled full tests
Oct 21 14:44:07.038 [7897] dbg: rules: running meta tests; score so far=3.903
Oct 21 14:44:07.038 [7897] dbg: rules: meta test DIGEST_MULTIPLE has undefined dependency 'DCC_CHECK'
Oct 21 14:44:07.041 [7897] dbg: rules: meta test KAM_IFRAME3 has undefined dependency 'T_HTML_ATTACH'
Oct 21 14:44:07.048 [7897] dbg: rules: meta test KAM_BLANK01 has undefined dependency 'UNDISC_RECIPS'
Oct 21 14:44:07.048 [7897] dbg: rules: meta test KAM_BLANK01 has undefined dependency 'FM_NO_FROM_OR_TO'
Oct 21 14:44:07.048 [7897] dbg: rules: meta test KAM_BLANK01 has undefined dependency 'FM_NO_TO'
Oct 21 14:44:07.056 [7897] dbg: rules: meta test KAM_RPTR_PASSED has undefined dependency 'IN_BCUDA_RBL'
Oct 21 14:44:07.056 [7897] dbg: rules: meta test KAM_RPTR_PASSED has undefined dependency 'RCVD_IN_BCUDA_RELAY'
Oct 21 14:44:07.062 [7897] dbg: rules: meta test KAM_BLANK02 has undefined dependency 'MSGID_FROM_MTA_ID'
Oct 21 14:44:07.067 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 65990 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_1
Oct 21 14:44:07.075 [7897] dbg: rules: flush_evalstr (add_evalstr) compiling 62503 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_2
Oct 21 14:44:07.083 [7897] dbg: rules: flush_evalstr (run_generic_tests) compiling 56220 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_3
Oct 21 14:44:07.088 [7897] dbg: rules: run_generic_tests - compiling eval code: meta, priority 500
Oct 21 14:44:07.088 [7897] dbg: rules: compiled meta tests
Oct 21 14:44:07.090 [7897] dbg: check: is spam? score=5.702 required=5
Oct 21 14:44:07.090 [7897] dbg: check: tests=BAYES_80,MISSING_DATE,MISSING_HEADERS,NO_RECEIVED,NO_RELAYS
Oct 21 14:44:07.091 [7897] dbg: check: subtests=__GATED_THROUGH_RCVD_REMOVER,__HAS_MESSAGE_ID,__HAS_MSGID,__HAS_SUBJECT,__KAM_UPS2,__MISSING_REF,__MISSING_REPLY,__MSGID_OK_DIGITS,__MSGID_OK_HOST,__MSOE_MID_WRONG_CASE,__NONEMPTY_BODY,__NOT_SPOOFED,__SANE_MSGID,__TO_NO_ARROWS_R,__UNUSABLE_MSGID
Oct 21 14:44:07.091 [7897] dbg: timing: total 1288 ms - init: 839 (65.2%), parse: 0.51 (0.0%), extract_message_metadata: 0.91 (0.1%), get_uri_detail_list: 0.83 (0.1%), tests_pri_-1000: 5 (0.4%), compile_gen: 150 (11.7%), compile_eval: 11 (0.8%), tests_pri_-950: 4 (0.3%), tests_pri_-900: 4 (0.3%), tests_pri_-400: 8 (0.6%), check_bayes: 4 (0.3%), tests_pri_0: 365 (28.3%), tests_pri_500: 56 (4.3%)
Im using FreeBSD and I cant find this: /usr/share/doc/spamassassin/examples/sample-spam.txt