hi am using qmailtoaster, centos 6 - 64 bit with spamassassin, dovecot, vpopmail, spamdyke, squirrelmail
dell server : intel hexcore 2.2 ghz proc, 16 gb ram i have several such servers. on one of my servers all of a sudden there was a high cpu utilization which continued the whole day -- all 12 cpu cores close to 100 percent continuously. the following checks were done. 1) incoming smtp connections -- were normal - around 10 -20 simultaneous connections -- which is normal 2) turned of clamd - but not a significant impact 3) turned of spamassassin - cpu usage reduced a lot. 4) spamassassin -- service spamd stop -- works quickly. service spamd start takes over a minute to start. normally it does not take more than 10 seconds to start. also checked dmesg, httpd, maillog, /var/log/messages, restarted bind, httpd ... but nothing wrong in this area. the problem got resolved automatically in the night. spamassassin starts in around 10 seconds. The same problem took place happened around 3 months ago -- again got automatically resolved. **** could someone please give me pointers as to where to trouble shoot to find the root cause. **** i have posted below spammassassin --debug --lint information. spammassassin debug lint normally takes just 3 seconds to execute however it took over a minute during the time this problem was taking place. also it was getting stuck for over 5 seconds under Net::DNS as seen below Mar 1 00:43:38.475 [4437] dbg: logger: adding facilities: all Mar 1 00:43:38.477 [4437] dbg: logger: logging level is DBG Mar 1 00:43:38.480 [4437] dbg: generic: SpamAssassin version 3.3.2 Mar 1 00:43:38.482 [4437] dbg: generic: Perl 5.010001, PREFIX=/usr, DEF_RULES_DIR=/usr/share/spamassassin, LOCAL_RULES_DIR=/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin Mar 1 00:43:38.484 [4437] dbg: config: timing enabled Mar 1 00:43:38.500 [4437] dbg: config: score set 0 chosen. Mar 1 00:43:38.535 [4437] dbg: util: running in taint mode? yes Mar 1 00:43:38.537 [4437] dbg: util: taint mode: deleting unsafe environment variables, resetting PATH Mar 1 00:43:38.541 [4437] dbg: util: PATH included '/usr/lib64/qt-3.3/bin', keeping Mar 1 00:43:38.543 [4437] dbg: util: PATH included '/usr/local/sbin', keeping Mar 1 00:43:38.546 [4437] dbg: util: PATH included '/usr/local/bin', keeping Mar 1 00:43:38.548 [4437] dbg: util: PATH included '/sbin', keeping Mar 1 00:43:38.551 [4437] dbg: util: PATH included '/bin', keeping Mar 1 00:43:38.553 [4437] dbg: util: PATH included '/usr/sbin', keeping Mar 1 00:43:38.556 [4437] dbg: util: PATH included '/usr/bin', keeping Mar 1 00:43:38.561 [4437] dbg: util: PATH included '/root/bin', which is unusable, dropping: No such file or directory Mar 1 00:43:38.564 [4437] dbg: util: final PATH set to: /usr/lib64/qt-3.3/bin:/usr/local/sbin:/usr/local/bin:/sbin:/bin:/usr/sbin:/usr/bin Mar 1 00:43:38.663 [4437] dbg: dns: is Net::DNS::Resolver available? yes Mar 1 00:43:38.665 [4437] dbg: dns: Net::DNS version: 0.65 Mar 1 00:43:43.266 [4437] dbg: diag: perl platform: 5.010001 linux Mar 1 00:43:43.268 [4437] dbg: diag: [...] module installed: Digest::SHA1, version 2.12 Mar 1 00:43:43.269 [4437] dbg: diag: [...] module installed: HTML::Parser, version 3.64 Mar 1 00:43:43.271 [4437] dbg: diag: [...] module installed: Net::DNS, version 0.65 Mar 1 00:43:43.272 [4437] dbg: diag: [...] module installed: NetAddr::IP, version 4.027 Mar 1 00:43:43.273 [4437] dbg: diag: [...] module installed: Time::HiRes, version 1.9721 Mar 1 00:43:43.274 [4437] dbg: diag: [...] module installed: Archive::Tar, version 1.58 Mar 1 00:43:43.276 [4437] dbg: diag: [...] module installed: IO::Zlib, version 1.09 Mar 1 00:43:43.277 [4437] dbg: diag: [...] module installed: Digest::SHA1, version 2.12 Mar 1 00:43:43.278 [4437] dbg: diag: [...] module installed: MIME::Base64, version 3.08 Mar 1 00:43:43.279 [4437] dbg: diag: [...] module installed: DB_File, version 1.82 Mar 1 00:43:43.281 [4437] dbg: diag: [...] module installed: Net::SMTP, version 2.31 Mar 1 00:43:43.282 [4437] dbg: diag: [...] module not installed: Mail::SPF ('require' failed) Mar 1 00:43:43.283 [4437] dbg: diag: [...] module not installed: IP::Country::Fast ('require' failed) Mar 1 00:43:43.284 [4437] dbg: diag: [...] module installed: Razor2::Client::Agent, version 2.84 Mar 1 00:43:43.285 [4437] dbg: diag: [...] module installed: Net::Ident, version 1.23 Mar 1 00:43:43.287 [4437] dbg: diag: [...] module installed: IO::Socket::INET6, version 2.56 Mar 1 00:43:43.288 [4437] dbg: diag: [...] module installed: IO::Socket::SSL, version 1.31 Mar 1 00:43:43.289 [4437] dbg: diag: [...] module installed: Compress::Zlib, version 2.021 Mar 1 00:43:43.290 [4437] dbg: diag: [...] module installed: Mail::DKIM, version 0.37 Mar 1 00:43:43.291 [4437] dbg: diag: [...] module installed: DBI, version 1.609 Mar 1 00:43:43.293 [4437] dbg: diag: [...] module installed: Getopt::Long, version 2.38 Mar 1 00:43:43.294 [4437] dbg: diag: [...] module installed: LWP::UserAgent, version 5.833 Mar 1 00:43:43.295 [4437] dbg: diag: [...] module installed: HTTP::Date, version 5.831 Mar 1 00:43:43.296 [4437] dbg: diag: [...] module installed: Encode::Detect, version 1.01 Mar 1 00:43:43.298 [4437] dbg: ignore: using a test message to lint rules Mar 1 00:43:43.304 [4437] dbg: config: using "/etc/mail/spamassassin" for site rules pre files Mar 1 00:43:43.310 [4437] dbg: config: read file /etc/mail/spamassassin/v310.pre Mar 1 00:43:43.314 [4437] dbg: config: read file /etc/mail/spamassassin/v312.pre Mar 1 00:43:43.317 [4437] dbg: config: read file /etc/mail/spamassassin/v320.pre Mar 1 00:43:43.320 [4437] dbg: config: read file /etc/mail/spamassassin/v330.pre Mar 1 00:43:43.323 [4437] dbg: config: using "/var/lib/spamassassin/3.003002" for sys rules pre files Mar 1 00:43:43.326 [4437] dbg: config: using "/var/lib/spamassassin/3.003002" for default rules dir Mar 1 00:43:43.330 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org.cf Mar 1 00:43:43.336 [4437] dbg: config: using "/etc/mail/spamassassin" for site rules dir Mar 1 00:43:43.341 [4437] dbg: config: read file /etc/mail/spamassassin/25_uribl.cf Mar 1 00:43:43.347 [4437] dbg: config: read file /etc/mail/spamassassin/50_scores.cf Mar 1 00:43:43.351 [4437] dbg: config: read file /etc/mail/spamassassin/60_whitelist.cf Mar 1 00:43:43.357 [4437] dbg: config: read file /etc/mail/spamassassin/local.cf Mar 1 00:43:43.371 [4437] dbg: config: using "/root/.spamassassin/user_prefs" for user prefs file Mar 1 00:43:43.374 [4437] dbg: config: read file /root/.spamassassin/user_prefs Mar 1 00:43:43.495 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::Pyzor from @INC Mar 1 00:43:43.552 [4437] dbg: pyzor: local tests only, disabling Pyzor Mar 1 00:43:43.559 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::Razor2 from @INC Mar 1 00:43:43.612 [4437] dbg: razor2: local tests only, skipping Razor Mar 1 00:43:43.619 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::AutoLearnThreshold from @INC Mar 1 00:43:43.646 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::WhiteListSubject from @INC Mar 1 00:43:43.671 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEHeader from @INC Mar 1 00:43:43.701 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::ReplaceTags from @INC Mar 1 00:43:43.738 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::DKIM from @INC Mar 1 00:43:43.861 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::Check from @INC Mar 1 00:43:44.036 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTTPSMismatch from @INC Mar 1 00:43:44.060 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDetail from @INC Mar 1 00:43:44.102 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::Bayes from @INC Mar 1 00:43:44.326 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::BodyEval from @INC Mar 1 00:43:44.376 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::DNSEval from @INC Mar 1 00:43:44.435 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTMLEval from @INC Mar 1 00:43:44.486 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::HeaderEval from @INC Mar 1 00:43:44.642 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEEval from @INC Mar 1 00:43:44.718 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::RelayEval from @INC Mar 1 00:43:44.775 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIEval from @INC Mar 1 00:43:44.797 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::WLBLEval from @INC Mar 1 00:43:44.850 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::VBounce from @INC Mar 1 00:43:44.878 [4437] dbg: plugin: loading Mail::SpamAssassin::Plugin::ImageInfo from @INC Mar 1 00:43:44.944 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/10_default_prefs.cf Mar 1 00:43:44.946 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/10_default_prefs.cf" for included file Mar 1 00:43:44.950 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/10_default_prefs.cf Mar 1 00:43:45.018 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/10_hasbase.cf Mar 1 00:43:45.020 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/10_hasbase.cf" for included file Mar 1 00:43:45.023 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/10_hasbase.cf Mar 1 00:43:45.083 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_advance_fee.cf Mar 1 00:43:45.086 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_advance_fee.cf" for included file Mar 1 00:43:45.089 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_advance_fee.cf Mar 1 00:43:45.205 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_aux_tlds.cf Mar 1 00:43:45.207 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_aux_tlds.cf" for included file Mar 1 00:43:45.211 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_aux_tlds.cf Mar 1 00:43:45.387 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_body_tests.cf Mar 1 00:43:45.390 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_body_tests.cf" for included file Mar 1 00:43:45.393 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_body_tests.cf Mar 1 00:43:45.505 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_compensate.cf Mar 1 00:43:45.507 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_compensate.cf" for included file Mar 1 00:43:45.510 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_compensate.cf Mar 1 00:43:45.536 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_dnsbl_tests.cf Mar 1 00:43:45.538 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_dnsbl_tests.cf" for included file Mar 1 00:43:45.542 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_dnsbl_tests.cf Mar 1 00:43:45.654 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_drugs.cf Mar 1 00:43:45.656 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_drugs.cf" for included file Mar 1 00:43:45.660 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_drugs.cf Mar 1 00:43:45.950 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_dynrdns.cf Mar 1 00:43:45.953 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_dynrdns.cf" for included file Mar 1 00:43:45.957 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_dynrdns.cf Mar 1 00:43:46.120 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_fake_helo_tests.cf Mar 1 00:43:46.122 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_fake_helo_tests.cf" for included file Mar 1 00:43:46.126 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_fake_helo_tests.cf Mar 1 00:43:46.211 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_freemail.cf Mar 1 00:43:46.213 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_freemail.cf" for included file Mar 1 00:43:46.217 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_freemail.cf Mar 1 00:43:46.235 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_freemail_domains.cf Mar 1 00:43:46.238 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_freemail_domains.cf" for included file Mar 1 00:43:46.243 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_freemail_domains.cf Mar 1 00:43:46.378 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_freemail_mailcom_domains.cf Mar 1 00:43:46.380 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_freemail_mailcom_domains.cf" for included file Mar 1 00:43:46.384 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_freemail_mailcom_domains.cf Mar 1 00:43:46.403 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_head_tests.cf Mar 1 00:43:46.405 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_head_tests.cf" for included file Mar 1 00:43:46.409 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_head_tests.cf Mar 1 00:43:46.998 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_html_tests.cf Mar 1 00:43:47.001 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_html_tests.cf" for included file Mar 1 00:43:47.005 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_html_tests.cf Mar 1 00:43:47.220 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_imageinfo.cf Mar 1 00:43:47.223 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_imageinfo.cf" for included file Mar 1 00:43:47.226 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_imageinfo.cf Mar 1 00:43:47.293 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_mailspike.cf Mar 1 00:43:47.295 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_mailspike.cf" for included file Mar 1 00:43:47.298 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_mailspike.cf Mar 1 00:43:47.323 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_meta_tests.cf Mar 1 00:43:47.326 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_meta_tests.cf" for included file Mar 1 00:43:47.329 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_meta_tests.cf Mar 1 00:43:47.400 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_net_tests.cf Mar 1 00:43:47.403 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_net_tests.cf" for included file Mar 1 00:43:47.406 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_net_tests.cf Mar 1 00:43:47.430 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_pdfinfo.cf Mar 1 00:43:47.432 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_pdfinfo.cf" for included file Mar 1 00:43:47.436 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_pdfinfo.cf Mar 1 00:43:47.484 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_phrases.cf Mar 1 00:43:47.486 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_phrases.cf" for included file Mar 1 00:43:47.489 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_phrases.cf Mar 1 00:43:47.697 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_porn.cf Mar 1 00:43:47.700 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_porn.cf" for included file Mar 1 00:43:47.703 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_porn.cf Mar 1 00:43:47.731 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_ratware.cf Mar 1 00:43:47.733 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_ratware.cf" for included file Mar 1 00:43:47.737 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_ratware.cf Mar 1 00:43:48.065 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_uri_tests.cf Mar 1 00:43:48.068 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_uri_tests.cf" for included file Mar 1 00:43:48.071 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_uri_tests.cf Mar 1 00:43:48.180 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_vbounce.cf Mar 1 00:43:48.183 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/20_vbounce.cf" for included file Mar 1 00:43:48.186 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/20_vbounce.cf Mar 1 00:43:48.603 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/23_bayes.cf Mar 1 00:43:48.606 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/23_bayes.cf" for included file Mar 1 00:43:48.609 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/23_bayes.cf Mar 1 00:43:48.660 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_accessdb.cf Mar 1 00:43:48.662 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_accessdb.cf" for included file Mar 1 00:43:48.665 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_accessdb.cf Mar 1 00:43:48.679 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_antivirus.cf Mar 1 00:43:48.681 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_antivirus.cf" for included file Mar 1 00:43:48.684 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_antivirus.cf Mar 1 00:43:48.697 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_asn.cf Mar 1 00:43:48.699 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_asn.cf" for included file Mar 1 00:43:48.702 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_asn.cf Mar 1 00:43:48.714 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_dcc.cf Mar 1 00:43:48.716 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_dcc.cf" for included file Mar 1 00:43:48.719 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_dcc.cf Mar 1 00:43:48.736 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_dkim.cf Mar 1 00:43:48.738 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_dkim.cf" for included file Mar 1 00:43:48.741 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_dkim.cf Mar 1 00:43:48.816 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_hashcash.cf Mar 1 00:43:48.818 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_hashcash.cf" for included file Mar 1 00:43:48.821 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_hashcash.cf Mar 1 00:43:48.839 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_pyzor.cf Mar 1 00:43:48.841 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_pyzor.cf" for included file Mar 1 00:43:48.844 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_pyzor.cf Mar 1 00:43:48.860 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_razor2.cf Mar 1 00:43:48.862 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_razor2.cf" for included file Mar 1 00:43:48.865 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_razor2.cf Mar 1 00:43:48.898 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_replace.cf Mar 1 00:43:48.900 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_replace.cf" for included file Mar 1 00:43:48.904 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_replace.cf Mar 1 00:43:49.100 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_spf.cf Mar 1 00:43:49.103 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_spf.cf" for included file Mar 1 00:43:49.106 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_spf.cf Mar 1 00:43:49.149 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_textcat.cf Mar 1 00:43:49.151 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_textcat.cf" for included file Mar 1 00:43:49.154 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_textcat.cf Mar 1 00:43:49.169 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_uribl.cf Mar 1 00:43:49.171 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/25_uribl.cf" for included file Mar 1 00:43:49.174 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/25_uribl.cf Mar 1 00:43:49.244 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_de.cf Mar 1 00:43:49.246 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_de.cf" for included file Mar 1 00:43:49.251 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_de.cf Mar 1 00:43:49.358 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_fr.cf Mar 1 00:43:49.361 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_fr.cf" for included file Mar 1 00:43:49.364 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_fr.cf Mar 1 00:43:49.440 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_it.cf Mar 1 00:43:49.442 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_it.cf" for included file Mar 1 00:43:49.446 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_it.cf Mar 1 00:43:49.456 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_nl.cf Mar 1 00:43:49.458 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_nl.cf" for included file Mar 1 00:43:49.461 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_nl.cf Mar 1 00:43:49.537 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_pl.cf Mar 1 00:43:49.539 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_pl.cf" for included file Mar 1 00:43:49.543 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_pl.cf Mar 1 00:43:49.615 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_pt_br.cf Mar 1 00:43:49.617 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_pt_br.cf" for included file Mar 1 00:43:49.621 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/30_text_pt_br.cf Mar 1 00:43:49.782 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/50_scores.cf Mar 1 00:43:49.785 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/50_scores.cf" for included file Mar 1 00:43:49.789 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/50_scores.cf Mar 1 00:43:50.622 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_adsp_override_dkim.cf Mar 1 00:43:50.624 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/60_adsp_override_dkim.cf" for included file Mar 1 00:43:50.627 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_adsp_override_dkim.cf Mar 1 00:43:50.705 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_awl.cf Mar 1 00:43:50.708 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/60_awl.cf" for included file Mar 1 00:43:50.711 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_awl.cf Mar 1 00:43:50.723 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_shortcircuit.cf Mar 1 00:43:50.725 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/60_shortcircuit.cf" for included file Mar 1 00:43:50.728 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_shortcircuit.cf Mar 1 00:43:50.746 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist.cf Mar 1 00:43:50.748 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist.cf" for included file Mar 1 00:43:50.751 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist.cf Mar 1 00:43:50.818 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist_dkim.cf Mar 1 00:43:50.820 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist_dkim.cf" for included file Mar 1 00:43:50.824 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist_dkim.cf Mar 1 00:43:50.944 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist_spf.cf Mar 1 00:43:50.947 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist_spf.cf" for included file Mar 1 00:43:50.950 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist_spf.cf Mar 1 00:43:50.971 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist_subject.cf Mar 1 00:43:50.973 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist_subject.cf" for included file Mar 1 00:43:50.977 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/60_whitelist_subject.cf Mar 1 00:43:50.996 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/72_active.cf Mar 1 00:43:50.999 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/72_active.cf" for included file Mar 1 00:43:51.010 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/72_active.cf Mar 1 00:43:56.222 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/72_scores.cf Mar 1 00:43:56.225 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/72_scores.cf" for included file Mar 1 00:43:56.228 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/72_scores.cf Mar 1 00:43:56.452 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/73_sandbox_manual_scores.cf Mar 1 00:43:56.455 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/73_sandbox_manual_scores.cf" for included file Mar 1 00:43:56.458 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/73_sandbox_manual_scores.cf Mar 1 00:43:56.476 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/local.cf Mar 1 00:43:56.478 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/local.cf" for included file Mar 1 00:43:56.481 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/local.cf Mar 1 00:43:56.498 [4437] dbg: config: fixed relative path: /var/lib/spamassassin/3.003002/updates_spamassassin_org/regression_tests.cf Mar 1 00:43:56.500 [4437] dbg: config: using "/var/lib/spamassassin/3.003002/updates_spamassassin_org/regression_tests.cf" for included file Mar 1 00:43:56.503 [4437] dbg: config: read file /var/lib/spamassassin/3.003002/updates_spamassassin_org/regression_tests.cf Mar 1 00:43:57.659 [4437] dbg: plugin: loading FromNotReplyTo from /etc/mail/spamassassin/FromNotReplyTo.pm Mar 1 00:44:01.347 [4437] dbg: config: warning: score set for non-existent rule FREEMAIL_FROM Mar 1 00:44:01.350 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_H4 Mar 1 00:44:01.352 [4437] dbg: config: warning: score set for non-existent rule FREEMAIL_REPLY Mar 1 00:44:01.355 [4437] dbg: config: warning: score set for non-existent rule TO_EQ_FM_SPF_FAIL Mar 1 00:44:01.357 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_WL Mar 1 00:44:01.359 [4437] dbg: config: warning: score set for non-existent rule HK_NAME_FM_MR_MRS Mar 1 00:44:01.361 [4437] dbg: config: warning: score set for non-existent rule FREEMAIL_FORGED_FROMDOMAIN Mar 1 00:44:01.364 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_L5 Mar 1 00:44:01.367 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_H3 Mar 1 00:44:01.369 [4437] dbg: config: warning: score set for non-existent rule PDS_FROM_2_EMAILS Mar 1 00:44:01.376 [4437] dbg: config: warning: score set for non-existent rule PP_TOO_MUCH_UNICODE02 Mar 1 00:44:01.377 [4437] dbg: config: warning: score set for non-existent rule HEADER_HOST_IN_WHITELIST Mar 1 00:44:01.380 [4437] dbg: config: warning: score set for non-existent rule FREEMAIL_REPLYTO_END_DIGIT Mar 1 00:44:01.382 [4437] dbg: config: warning: score set for non-existent rule HK_NAME_FM_FROM Mar 1 00:44:01.384 [4437] dbg: config: warning: score set for non-existent rule URI_HOST_IN_BLACKLIST Mar 1 00:44:01.386 [4437] dbg: config: warning: score set for non-existent rule FSL_GEO_ABUSE Mar 1 00:44:01.388 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_H2 Mar 1 00:44:01.390 [4437] dbg: config: warning: score set for non-existent rule FROM_MISSP_SPF_FAIL Mar 1 00:44:01.393 [4437] dbg: config: warning: score set for non-existent rule FSL_YG_ABUSE Mar 1 00:44:01.395 [4437] dbg: config: warning: score set for non-existent rule HEADER_FROM_DIFFERENT_DOMAINS Mar 1 00:44:01.397 [4437] dbg: config: warning: score set for non-existent rule URI_HOST_IN_WHITELIST Mar 1 00:44:01.399 [4437] dbg: config: warning: score set for non-existent rule FREEMAIL_FORGED_REPLYTO Mar 1 00:44:01.401 [4437] dbg: config: warning: score set for non-existent rule HEADER_HOST_IN_BLACKLIST Mar 1 00:44:01.405 [4437] dbg: config: warning: score set for non-existent rule FREEMAIL_ENVFROM_END_DIGIT Mar 1 00:44:01.407 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_ZBI Mar 1 00:44:01.409 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_L2 Mar 1 00:44:01.411 [4437] dbg: config: warning: score set for non-existent rule TO_EQ_FM_DOM_SPF_FAIL Mar 1 00:44:01.414 [4437] dbg: config: warning: score set for non-existent rule __KAM_ipad Mar 1 00:44:01.416 [4437] dbg: config: warning: score set for non-existent rule HK_NAME_MR_MRS Mar 1 00:44:01.418 [4437] dbg: config: warning: score set for non-existent rule HK_NAME_FROM Mar 1 00:44:01.420 [4437] dbg: config: warning: score set for non-existent rule FILL_THIS_FORM_FRAUD_PHISH Mar 1 00:44:01.422 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_BL Mar 1 00:44:01.425 [4437] dbg: config: warning: score set for non-existent rule PP_TOO_MUCH_UNICODE05 Mar 1 00:44:01.429 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_L4 Mar 1 00:44:01.432 [4437] dbg: config: warning: score set for non-existent rule FROM_MISSP_FREEMAIL Mar 1 00:44:01.436 [4437] dbg: config: warning: score set for non-existent rule FREEMAIL_DOC_PDF_BCC Mar 1 00:44:01.439 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_H5 Mar 1 00:44:01.442 [4437] dbg: config: warning: score set for non-existent rule PP_MIME_FAKE_ASCII_TEXT Mar 1 00:44:01.444 [4437] dbg: config: warning: score set for non-existent rule FSL_FAKE_GMAIL_RCVD Mar 1 00:44:01.447 [4437] dbg: config: warning: score set for non-existent rule HK_NAME_FM_DR Mar 1 00:44:01.451 [4437] dbg: config: warning: score set for non-existent rule RCVD_IN_MSPIKE_L3 Mar 1 00:44:01.455 [4437] dbg: config: warning: score set for non-existent rule VANITY Mar 1 00:44:01.457 [4437] dbg: config: warning: score set for non-existent rule FREEMAIL_REPLYTO Mar 1 00:44:27.236 [4437] dbg: rules: __body13a merged duplicates: __body21a __body22a __body26a Mar 1 00:44:27.240 [4437] dbg: rules: __SAMP1a merged duplicates: __SAMP2a __SAMP3a __SAMP4a Mar 1 00:44:27.243 [4437] dbg: rules: __JM_REACTOR_DATE merged duplicates: __RATWARE_0_TZ_DATE Mar 1 00:44:27.245 [4437] dbg: rules: __HAS_REPLY_TO merged duplicates: __REPLYTO_EXISTS Mar 1 00:44:27.248 [4437] dbg: rules: __HAS_XMAIL merged duplicates: __HAS_X_MAILER Mar 1 00:44:27.251 [4437] dbg: rules: __body33a merged duplicates: __body34a Mar 1 00:44:27.253 [4437] dbg: rules: __GLOBAL2b merged duplicates: __SPFIntB Mar 1 00:44:27.256 [4437] dbg: rules: __QUES1a merged duplicates: __QUES2a __QUES3a Mar 1 00:44:27.258 [4437] dbg: rules: NAME_EMAIL_DIFF merged duplicates: __NAME_EMAIL_DIFF Mar 1 00:44:27.261 [4437] dbg: rules: __GLOBAL3b merged duplicates: __headerSPFIMPb headerSPFPASS Mar 1 00:44:27.264 [4437] dbg: rules: __body33b merged duplicates: __body34b Mar 1 00:44:27.266 [4437] dbg: rules: __DOS_HAS_MAILING_LIST merged duplicates: __ML4 Mar 1 00:44:27.269 [4437] dbg: rules: __HAS_LIST_ID merged duplicates: __ML2 Mar 1 00:44:27.271 [4437] dbg: rules: __AXB_XM_OL_024C2 merged duplicates: __AXB_XM_OL_2600 Mar 1 00:44:27.274 [4437] dbg: rules: __QUES1b merged duplicates: __SAMP1b Mar 1 00:44:27.276 [4437] dbg: rules: __QUES3b merged duplicates: __SAMP3b Mar 1 00:44:27.279 [4437] dbg: rules: __DOS_HAS_ANY_URI merged duplicates: __HAS_ANY_URI __HAS_URI Mar 1 00:44:27.281 [4437] dbg: rules: CTYPE_001C_A merged duplicates: DATE_IN_FUTURE_96_XX Mar 1 00:44:27.284 [4437] dbg: rules: __QUES2b merged duplicates: __SAMP2b Mar 1 00:44:27.286 [4437] dbg: rules: __THEBAT_MUA merged duplicates: __XM_THEBAT Mar 1 00:44:27.289 [4437] dbg: rules: __AXB_MO_OL_024C2 merged duplicates: __AXB_MO_OL_2600 Mar 1 00:44:27.293 [4437] dbg: rules: __FROM_41_FREEMAIL merged duplicates: __FROM_MISSP_FREEMAIL __LCL__KAM_BODY_LENGTH_LT_1024 __LCL__KAM_BODY_LENGTH_LT_512 __MIME_CTYPE_IN_BODY __MIME_MALF __SPF_FULL_PASS __SPF_RANDOM_SENDER __TO_EQ_FM_DOM_SPF_FAIL __TO_EQ_FM_SPF_FAIL __TO_NO_BRKTS_FREEMAIL Mar 1 00:44:27.295 [4437] dbg: rules: __header51a merged duplicates: __header53a Mar 1 00:44:27.298 [4437] dbg: rules: __body16c merged duplicates: __body25b Mar 1 00:44:27.300 [4437] dbg: rules: __DOS_HAS_LIST_UNSUB merged duplicates: headerlist Mar 1 00:44:27.310 [4437] dbg: config: finish parsing Mar 1 00:44:27.803 [4437] dbg: plugin: Mail::SpamAssassin::Plugin::ReplaceTags=HASH(0x11cad90) implements 'finish_parsing_end', priority 0 Mar 1 00:44:27.808 [4437] dbg: replacetags: replacing tags Mar 1 00:44:28.311 [4437] dbg: replacetags: done replacing tags Mar 1 00:44:28.339 [4437] dbg: config: score set 0 chosen. Mar 1 00:44:28.343 [4437] dbg: config: time limit 300.0 s Mar 1 00:44:28.356 [4437] dbg: message: main message type: text/plain Mar 1 00:44:28.358 [4437] dbg: message: ---- MIME PARSER START ---- Mar 1 00:44:28.360 [4437] dbg: message: parsing normal part Mar 1 00:44:28.363 [4437] dbg: message: ---- MIME PARSER END ---- Mar 1 00:44:28.369 [4437] dbg: check: pms new, time limit in 299.973 s Mar 1 00:44:28.376 [4437] dbg: plugin: Mail::SpamAssassin::Plugin::DNSEval=HASH(0x3080790) implements 'check_start', priority 0 Mar 1 00:44:28.396 [4437] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x2f6a398) implements 'check_main', priority 0 Mar 1 00:44:28.401 [4437] 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 1 00:44:28.407 [4437] dbg: metadata: X-Spam-Relays-Trusted: Mar 1 00:44:28.409 [4437] dbg: metadata: X-Spam-Relays-Untrusted: Mar 1 00:44:28.411 [4437] dbg: metadata: X-Spam-Relays-Internal: Mar 1 00:44:28.412 [4437] dbg: metadata: X-Spam-Relays-External: Mar 1 00:44:28.420 [4437] dbg: message: no encoding detected Mar 1 00:44:28.426 [4437] dbg: rules: local tests only, ignoring RBL eval Mar 1 00:44:28.430 [4437] dbg: check: check_main, time limit in 299.913 s Mar 1 00:44:28.461 [4437] dbg: check: running tests for priority: -1000 Mar 1 00:44:28.467 [4437] dbg: rules: running head tests; score so far=0 Mar 1 00:44:28.473 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 288 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg1000_1 Mar 1 00:44:28.480 [4437] dbg: rules: run_generic_tests - compiling eval code: head, priority -1000 Mar 1 00:44:28.484 [4437] dbg: rules: compiled head tests Mar 1 00:44:28.490 [4437] dbg: rules: running head_eval tests; score so far=0 Mar 1 00:44:28.497 [4437] dbg: rules: run_eval_tests - compiling eval code: 9, priority -1000 Mar 1 00:44:28.519 [4437] dbg: eval: all '*From' addrs: ign...@compiling.spamassassin.taint.org Mar 1 00:44:28.967 [4437] dbg: eval: all '*To' addrs: Mar 1 00:44:28.979 [4437] dbg: rules: running body tests; score so far=0 Mar 1 00:44:28.983 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 231 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg1000_1 Mar 1 00:44:28.989 [4437] dbg: rules: run_generic_tests - compiling eval code: body, priority -1000 Mar 1 00:44:28.993 [4437] dbg: rules: compiled body tests Mar 1 00:44:28.999 [4437] dbg: rules: running uri tests; score so far=0 Mar 1 00:44:29.003 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg1000_1 Mar 1 00:44:29.008 [4437] dbg: rules: run_generic_tests - compiling eval code: uri, priority -1000 Mar 1 00:44:29.012 [4437] dbg: rules: compiled uri tests Mar 1 00:44:29.018 [4437] dbg: rules: running rawbody tests; score so far=0 Mar 1 00:44:29.022 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 237 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg1000_1 Mar 1 00:44:29.027 [4437] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -1000 Mar 1 00:44:29.031 [4437] dbg: rules: compiled rawbody tests Mar 1 00:44:29.037 [4437] dbg: rules: running full tests; score so far=0 Mar 1 00:44:29.041 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 266 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg1000_1 Mar 1 00:44:29.046 [4437] dbg: rules: run_generic_tests - compiling eval code: full, priority -1000 Mar 1 00:44:29.050 [4437] dbg: rules: compiled full tests Mar 1 00:44:29.055 [4437] dbg: rules: running meta tests; score so far=0 Mar 1 00:44:29.060 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 291 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg1000_1 Mar 1 00:44:29.066 [4437] dbg: rules: run_generic_tests - compiling eval code: meta, priority -1000 Mar 1 00:44:29.070 [4437] dbg: rules: compiled meta tests Mar 1 00:44:29.078 [4437] dbg: check: running tests for priority: -950 Mar 1 00:44:29.082 [4437] dbg: rules: running head tests; score so far=0 Mar 1 00:44:29.086 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 286 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg950_1 Mar 1 00:44:29.092 [4437] dbg: rules: run_generic_tests - compiling eval code: head, priority -950 Mar 1 00:44:29.096 [4437] dbg: rules: compiled head tests Mar 1 00:44:29.101 [4437] dbg: rules: running head_eval tests; score so far=0 Mar 1 00:44:29.105 [4437] dbg: rules: run_eval_tests - compiling eval code: 9, priority -950 Mar 1 00:44:29.118 [4437] dbg: rules: running body tests; score so far=0 Mar 1 00:44:29.121 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg950_1 Mar 1 00:44:29.127 [4437] dbg: rules: run_generic_tests - compiling eval code: body, priority -950 Mar 1 00:44:29.131 [4437] dbg: rules: compiled body tests Mar 1 00:44:29.135 [4437] dbg: rules: running uri tests; score so far=0 Mar 1 00:44:29.139 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 227 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg950_1 Mar 1 00:44:29.144 [4437] dbg: rules: run_generic_tests - compiling eval code: uri, priority -950 Mar 1 00:44:29.148 [4437] dbg: rules: compiled uri tests Mar 1 00:44:29.153 [4437] dbg: rules: running rawbody tests; score so far=0 Mar 1 00:44:29.157 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 235 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg950_1 Mar 1 00:44:29.162 [4437] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -950 Mar 1 00:44:29.166 [4437] dbg: rules: compiled rawbody tests Mar 1 00:44:29.171 [4437] dbg: rules: running full tests; score so far=0 Mar 1 00:44:29.175 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 264 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg950_1 Mar 1 00:44:29.181 [4437] dbg: rules: run_generic_tests - compiling eval code: full, priority -950 Mar 1 00:44:29.184 [4437] dbg: rules: compiled full tests Mar 1 00:44:29.190 [4437] dbg: rules: running meta tests; score so far=0 Mar 1 00:44:29.194 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 289 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg950_1 Mar 1 00:44:29.199 [4437] dbg: rules: run_generic_tests - compiling eval code: meta, priority -950 Mar 1 00:44:29.203 [4437] dbg: rules: compiled meta tests Mar 1 00:44:29.209 [4437] dbg: check: running tests for priority: -900 Mar 1 00:44:29.212 [4437] dbg: rules: running head tests; score so far=0 Mar 1 00:44:29.216 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 286 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg900_1 Mar 1 00:44:29.222 [4437] dbg: rules: run_generic_tests - compiling eval code: head, priority -900 Mar 1 00:44:29.226 [4437] dbg: rules: compiled head tests Mar 1 00:44:29.231 [4437] dbg: rules: running head_eval tests; score so far=0 Mar 1 00:44:29.236 [4437] dbg: rules: run_eval_tests - compiling eval code: 9, priority -900 Mar 1 00:44:29.258 [4437] dbg: rules: running body tests; score so far=0 Mar 1 00:44:29.262 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg900_1 Mar 1 00:44:29.267 [4437] dbg: rules: run_generic_tests - compiling eval code: body, priority -900 Mar 1 00:44:29.271 [4437] dbg: rules: compiled body tests Mar 1 00:44:29.276 [4437] dbg: rules: running uri tests; score so far=0 Mar 1 00:44:29.279 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 227 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg900_1 Mar 1 00:44:29.284 [4437] dbg: rules: run_generic_tests - compiling eval code: uri, priority -900 Mar 1 00:44:29.288 [4437] dbg: rules: compiled uri tests Mar 1 00:44:29.293 [4437] dbg: rules: running rawbody tests; score so far=0 Mar 1 00:44:29.297 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 235 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg900_1 Mar 1 00:44:29.302 [4437] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -900 Mar 1 00:44:29.306 [4437] dbg: rules: compiled rawbody tests Mar 1 00:44:29.312 [4437] dbg: rules: running full tests; score so far=0 Mar 1 00:44:29.315 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 264 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg900_1 Mar 1 00:44:29.321 [4437] dbg: rules: run_generic_tests - compiling eval code: full, priority -900 Mar 1 00:44:29.324 [4437] dbg: rules: compiled full tests Mar 1 00:44:29.330 [4437] dbg: rules: running meta tests; score so far=0 Mar 1 00:44:29.334 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 289 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg900_1 Mar 1 00:44:29.339 [4437] dbg: rules: run_generic_tests - compiling eval code: meta, priority -900 Mar 1 00:44:29.343 [4437] dbg: rules: compiled meta tests Mar 1 00:44:29.349 [4437] dbg: check: running tests for priority: -400 Mar 1 00:44:29.353 [4437] dbg: rules: running head tests; score so far=0 Mar 1 00:44:29.357 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 286 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg400_1 Mar 1 00:44:29.363 [4437] dbg: rules: run_generic_tests - compiling eval code: head, priority -400 Mar 1 00:44:29.367 [4437] dbg: rules: compiled head tests Mar 1 00:44:29.373 [4437] dbg: rules: running body tests; score so far=0 Mar 1 00:44:29.376 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg400_1 Mar 1 00:44:29.381 [4437] dbg: rules: run_generic_tests - compiling eval code: body, priority -400 Mar 1 00:44:29.385 [4437] dbg: rules: compiled body tests Mar 1 00:44:29.390 [4437] dbg: rules: running uri tests; score so far=0 Mar 1 00:44:29.394 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 227 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg400_1 Mar 1 00:44:29.399 [4437] dbg: rules: run_generic_tests - compiling eval code: uri, priority -400 Mar 1 00:44:29.403 [4437] dbg: rules: compiled uri tests Mar 1 00:44:29.407 [4437] dbg: rules: running body_eval tests; score so far=0 Mar 1 00:44:29.411 [4437] dbg: rules: run_eval_tests - compiling eval code: 11, priority -400 Mar 1 00:44:29.419 [4437] dbg: rules: running rawbody tests; score so far=0 Mar 1 00:44:29.423 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 235 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg400_1 Mar 1 00:44:29.428 [4437] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -400 Mar 1 00:44:29.432 [4437] dbg: rules: compiled rawbody tests Mar 1 00:44:29.437 [4437] dbg: rules: running full tests; score so far=0 Mar 1 00:44:29.441 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 264 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg400_1 Mar 1 00:44:29.446 [4437] dbg: rules: run_generic_tests - compiling eval code: full, priority -400 Mar 1 00:44:29.450 [4437] dbg: rules: compiled full tests Mar 1 00:44:29.456 [4437] dbg: rules: running meta tests; score so far=0 Mar 1 00:44:29.460 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 289 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg400_1 Mar 1 00:44:29.466 [4437] dbg: rules: run_generic_tests - compiling eval code: meta, priority -400 Mar 1 00:44:29.469 [4437] dbg: rules: compiled meta tests Mar 1 00:44:29.476 [4437] dbg: check: running tests for priority: 0 Mar 1 00:44:29.479 [4437] dbg: rules: running head tests; score so far=0 Mar 1 00:44:30.053 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60262 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_1 Mar 1 00:44:30.317 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60291 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_2 Mar 1 00:44:30.575 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60367 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_3 Mar 1 00:44:30.825 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60203 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_4 Mar 1 00:44:31.069 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60166 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_5 Mar 1 00:44:31.337 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60143 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_6 Mar 1 00:44:31.515 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 16409 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_7 Mar 1 00:44:31.567 [4437] dbg: rules: run_generic_tests - compiling eval code: head, priority 0 Mar 1 00:44:31.574 [4437] dbg: rules: compiled head tests Mar 1 00:44:31.594 [4437] dbg: rules: ran header rule __MISSING_REF ======> got hit: "UNSET" Mar 1 00:44:31.599 [4437] dbg: rules: ran header rule __MISSING_REPLY ======> got hit: "UNSET" Mar 1 00:44:31.614 [4437] dbg: rules: ran header rule __MSGID_OK_HOST ======> got hit: "@lint_rules>" Mar 1 00:44:31.619 [4437] dbg: rules: ran header rule __MSGID_OK_DIGITS ======> got hit: "1425150823" Mar 1 00:44:31.627 [4437] dbg: rules: ran header rule __HAS_MESSAGE_ID ======> got hit: "<YES>" Mar 1 00:44:31.650 [4437] dbg: rules: ran header rule __HAS_SUBJECT ======> got hit: "<YES>" Mar 1 00:44:31.663 [4437] dbg: rules: ran header rule __MSOE_MID_WRONG_CASE ======> got hit: " Mar 1 00:44:31.665 [4437] dbg: rules: [...] Message-Id: " Mar 1 00:44:31.675 [4437] dbg: rules: ran header rule __HAS_MSGID ======> got hit: "<" Mar 1 00:44:31.680 [4437] dbg: rules: ran header rule __SANE_MSGID ======> got hit: "<1425150823@lint_rules> Mar 1 00:44:31.681 [4437] dbg: rules: [...] " Mar 1 00:44:31.686 [4437] dbg: rules: ran header rule __TO_NO_ARROWS_R ======> got hit: "negative match" Mar 1 00:44:31.698 [4437] dbg: rules: ran header rule __GLOBAL2b ======> got hit: "negative match" Mar 1 00:44:31.710 [4437] dbg: rules: ran header rule __HAS_FROM ======> got hit: "<YES>" Mar 1 00:44:31.735 [4437] dbg: rules: running head_eval tests; score so far=0 Mar 1 00:44:31.763 [4437] dbg: rules: run_eval_tests - compiling eval code: 9, priority 0 Mar 1 00:44:31.868 [4437] dbg: rules: ran eval rule __GATED_THROUGH_RCVD_REMOVER ======> got hit (1) Mar 1 00:44:31.925 [4437] dbg: rules: ran eval rule NO_RELAYS ======> got hit (1) Mar 1 00:44:31.952 [4437] dbg: rules: ran eval rule MISSING_HEADERS ======> got hit (1) Mar 1 00:44:31.957 [4437] dbg: rules: running body tests; score so far=0.914 Mar 1 00:44:32.060 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60425 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_1 Mar 1 00:44:32.363 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60025 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_2 Mar 1 00:44:32.676 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60533 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_3 Mar 1 00:44:32.999 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60021 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_4 Mar 1 00:44:33.294 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60312 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_5 Mar 1 00:44:33.604 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60063 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_6 Mar 1 00:44:33.911 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60029 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_7 Mar 1 00:44:34.173 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 25158 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_8 Mar 1 00:44:34.274 [4437] dbg: rules: run_generic_tests - compiling eval code: body, priority 0 Mar 1 00:44:34.282 [4437] dbg: rules: compiled body tests Mar 1 00:44:35.206 [4437] dbg: rules: ran body rule __NONEMPTY_BODY ======> got hit: "I" Mar 1 00:44:35.972 [4437] dbg: rules: ran body rule __BODY_TEXT_LINE ======> got hit: "I" Mar 1 00:44:36.712 [4437] dbg: rules: running uri tests; score so far=0.914 Mar 1 00:44:36.797 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 39479 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_0_1 Mar 1 00:44:36.938 [4437] dbg: rules: run_generic_tests - compiling eval code: uri, priority 0 Mar 1 00:44:36.942 [4437] dbg: rules: compiled uri tests Mar 1 00:44:36.950 [4437] dbg: rules: running body_eval tests; score so far=0.914 Mar 1 00:44:37.010 [4437] dbg: rules: run_eval_tests - compiling eval code: 11, priority 0 Mar 1 00:44:37.341 [4437] dbg: https_http_mismatch: anchors 0 Mar 1 00:44:37.550 [4437] dbg: rules: running rawbody tests; score so far=0.914 Mar 1 00:44:37.605 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 27580 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_0_1 Mar 1 00:44:37.700 [4437] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 0 Mar 1 00:44:37.705 [4437] dbg: rules: compiled rawbody tests Mar 1 00:44:37.777 [4437] dbg: rules: running rawbody_eval tests; score so far=0.914 Mar 1 00:44:37.784 [4437] dbg: rules: run_eval_tests - compiling eval code: 15, priority 0 Mar 1 00:44:37.806 [4437] dbg: rules: running full tests; score so far=0.914 Mar 1 00:44:37.812 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 1173 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_0_1 Mar 1 00:44:37.821 [4437] dbg: rules: run_generic_tests - compiling eval code: full, priority 0 Mar 1 00:44:37.825 [4437] dbg: rules: compiled full tests Mar 1 00:44:37.830 [4437] dbg: rules: running full_eval tests; score so far=0.914 Mar 1 00:44:37.835 [4437] dbg: rules: run_eval_tests - compiling eval code: 13, priority 0 Mar 1 00:44:37.848 [4437] dbg: dns: is_dns_available() last checked 1425150877.8 seconds ago; re-checking Mar 1 00:44:37.850 [4437] dbg: dns: is DNS available? 0 Mar 1 00:44:37.852 [4437] dbg: dkim: signature verification disabled, DNS resolving not available Mar 1 00:44:37.857 [4437] dbg: rules: running meta tests; score so far=0.914 Mar 1 00:44:37.861 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 281 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_0_1 Mar 1 00:44:37.867 [4437] dbg: rules: run_generic_tests - compiling eval code: meta, priority 0 Mar 1 00:44:37.871 [4437] dbg: rules: compiled meta tests Mar 1 00:44:37.877 [4437] dbg: check: running tests for priority: 500 Mar 1 00:44:37.879 [4437] dbg: dns: harvest_dnsbl_queries Mar 1 00:44:37.887 [4437] dbg: rules: running head tests; score so far=0.914 Mar 1 00:44:37.891 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 282 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_500_1 Mar 1 00:44:37.897 [4437] dbg: rules: run_generic_tests - compiling eval code: head, priority 500 Mar 1 00:44:37.902 [4437] dbg: rules: compiled head tests Mar 1 00:44:37.908 [4437] dbg: rules: running body tests; score so far=0.914 Mar 1 00:44:37.912 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 225 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_500_1 Mar 1 00:44:37.917 [4437] dbg: rules: run_generic_tests - compiling eval code: body, priority 500 Mar 1 00:44:37.921 [4437] dbg: rules: compiled body tests Mar 1 00:44:37.926 [4437] dbg: rules: running uri tests; score so far=0.914 Mar 1 00:44:37.930 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 223 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_500_1 Mar 1 00:44:37.935 [4437] dbg: rules: run_generic_tests - compiling eval code: uri, priority 500 Mar 1 00:44:37.939 [4437] dbg: rules: compiled uri tests Mar 1 00:44:37.944 [4437] dbg: rules: running rawbody tests; score so far=0.914 Mar 1 00:44:37.948 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 231 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_500_1 Mar 1 00:44:37.953 [4437] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 500 Mar 1 00:44:37.957 [4437] dbg: rules: compiled rawbody tests Mar 1 00:44:37.962 [4437] dbg: rules: running full tests; score so far=0.914 Mar 1 00:44:37.966 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 260 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_500_1 Mar 1 00:44:37.971 [4437] dbg: rules: run_generic_tests - compiling eval code: full, priority 500 Mar 1 00:44:37.975 [4437] dbg: rules: compiled full tests Mar 1 00:44:37.980 [4437] dbg: rules: running meta tests; score so far=0.914 Mar 1 00:44:38.002 [4437] dbg: rules: meta test DIGEST_MULTIPLE has undefined dependency 'DCC_CHECK' Mar 1 00:44:38.008 [4437] info: rules: meta test TO_NO_BRKTS_HTML_ONLY has dependency 'RDNS_NONE' with a zero score Mar 1 00:44:38.111 [4437] dbg: rules: meta test KAM_INSURE2 has undefined dependency 'CBJ_GiveMeABreak' Mar 1 00:44:38.130 [4437] info: rules: meta test __TO_NO_BRKTS_NORDNS_HTML has dependency 'RDNS_NONE' with a zero score Mar 1 00:44:38.340 [4437] info: rules: meta test FROM_MISSP_DYNIP has dependency 'RDNS_DYNAMIC' with a zero score Mar 1 00:44:38.353 [4437] dbg: rules: meta test GOOG_REDIR_SHORT has undefined dependency '__KAM_BODY_LENGTH_LT_512' Mar 1 00:44:38.441 [4437] dbg: rules: meta test DOTLLINK has undefined dependency '__DOTLLINK1' Mar 1 00:44:38.475 [4437] dbg: rules: meta test KAM_INSURE has undefined dependency 'CBJ_GiveMeABreak' Mar 1 00:44:38.536 [4437] info: rules: meta test DYN_RDNS_SHORT_HELO_IMAGE has dependency 'RDNS_DYNAMIC' with a zero score Mar 1 00:44:38.729 [4437] info: rules: meta test DYN_RDNS_SHORT_HELO_HTML has dependency 'RDNS_DYNAMIC' with a zero score Mar 1 00:44:38.930 [4437] info: rules: meta test DYN_RDNS_AND_INLINE_IMAGE has dependency 'RDNS_DYNAMIC' with a zero score Mar 1 00:44:39.134 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60087 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_1 Mar 1 00:44:39.468 [4437] dbg: rules: flush_evalstr (add_evalstr) compiling 60772 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_2 Mar 1 00:44:39.849 [4437] dbg: rules: flush_evalstr (run_generic_tests) compiling 54063 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_3 Mar 1 00:44:40.040 [4437] dbg: rules: run_generic_tests - compiling eval code: meta, priority 500 Mar 1 00:44:40.046 [4437] dbg: rules: compiled meta tests Mar 1 00:44:40.103 [4437] dbg: check: is spam? score=50.913 required=5 Mar 1 00:44:40.106 [4437] dbg: check: tests=MISSING_DATE,MISSING_HEADERS,NO_RECEIVED,NO_RELAYS Mar 1 00:44:40.108 [4437] dbg: check: subtests=__BODY_TEXT_LINE,__EMPTY_BODY,__GATED_THROUGH_RCVD_REMOVER,__GLOBAL2b,__HAS_FROM,__HAS_MESSAGE_ID,__HAS_MSGID,__HAS_SUBJECT,__KHOP_NO_FULL_NAME,__MISSING_REF,__MISSING_REPLY,__MSGID_OK_DIGITS,__MSGID_OK_HOST,__MSOE_MID_WRONG_CASE,__NONEMPTY_BODY,__NOT_SPOOFED,__SANE_MSGID,__SPFIntB,__TO_NO_ARROWS_R,__UNUSABLE_MSGID Mar 1 00:44:40.121 [4437] dbg: timing: total 56795 ms - init: 45041 (79.3%), parse: 25 (0.0%), extract_message_metadata: 26 (0.0%), get_uri_detail_list: 25 (0.0%), tests_pri_-1000: 617 (1.1%), compile_gen: 3504 (6.2%), compile_eval: 441 (0.8%), tests_pri_-950: 130 (0.2%), tests_pri_-900: 140 (0.2%), tests_pri_-400: 126 (0.2%), tests_pri_0: 8401 (14.8%), tests_pri_500: 2219 (3.9%)