
admin at kilnar
Aug 14, 2012, 9:04 PM
Post #3 of 17
(765 views)
Permalink
|
|
Re: SpamAssassin Hanging on RTF Attachments
[In reply to]
|
|
On 2012-08-14 20:50, Kevin A. McGrail wrote: > On 8/14/2012 11:47 PM, admin wrote: >> >> PS: I can't share my problematic RTF file since it contains a legal >> contract I'm not allowed to share with the public. > Are you able to share the problematic file off-list? > > Can you share the Output of spamassassin -D -t on the file? I'll have to get permission from the person that I'm involved with in the contract since it contains some of her personal information (address, name, etc.) I'm sure she'll be fine with it if it becomes necessary. Here's the output of -D -t on the file. I let it run for about 10 minutes before giving up and killing the process. # spamassassin -D -t < bad Aug 14 21:57:24.258 [3883] dbg: logger: adding facilities: all Aug 14 21:57:24.258 [3883] dbg: logger: logging level is DBG Aug 14 21:57:24.258 [3883] dbg: generic: SpamAssassin version 3.3.1 Aug 14 21:57:24.258 [3883] dbg: generic: Perl 5.010001, PREFIX=/usr, DEF_RULES_DIR=/usr/share/spamassassin, LOCAL_RULES_DIR=/etc/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin Aug 14 21:57:24.258 [3883] dbg: config: timing enabled Aug 14 21:57:24.259 [3883] dbg: config: score set 0 chosen. Aug 14 21:57:24.260 [3883] dbg: util: running in taint mode? yes Aug 14 21:57:24.260 [3883] dbg: util: taint mode: deleting unsafe environment variables, resetting PATH Aug 14 21:57:24.260 [3883] dbg: util: PATH included '/usr/local/sbin', keeping Aug 14 21:57:24.260 [3883] dbg: util: PATH included '/usr/local/bin', keeping Aug 14 21:57:24.260 [3883] dbg: util: PATH included '/usr/sbin', keeping Aug 14 21:57:24.260 [3883] dbg: util: PATH included '/usr/bin', keeping Aug 14 21:57:24.260 [3883] dbg: util: PATH included '/sbin', keeping Aug 14 21:57:24.260 [3883] dbg: util: PATH included '/bin', keeping Aug 14 21:57:24.261 [3883] dbg: util: PATH included '/opt/dell/srvadmin/bin', keeping Aug 14 21:57:24.261 [3883] dbg: util: PATH included '/opt/dell/srvadmin/sbin', keeping Aug 14 21:57:24.261 [3883] dbg: util: PATH included '/root/bin', keeping Aug 14 21:57:24.261 [3883] dbg: util: PATH included '.', which is not absolute, dropping Aug 14 21:57:24.261 [3883] dbg: util: PATH included '/root/bin', keeping Aug 14 21:57:24.261 [3883] dbg: util: PATH included '.', which is not absolute, dropping Aug 14 21:57:24.261 [3883] dbg: util: final PATH set to: /usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/opt/dell/srvadmin/bin:/opt/dell/srvadmin/sbin:/root/bin:/root/bin Aug 14 21:57:24.264 [3883] dbg: dns: is Net::DNS::Resolver available? yes Aug 14 21:57:24.265 [3883] dbg: dns: Net::DNS version: 0.65 Aug 14 21:57:24.266 [3883] dbg: config: using "/etc/spamassassin" for site rules pre files Aug 14 21:57:24.267 [3883] dbg: config: read file /etc/spamassassin/init.pre Aug 14 21:57:24.267 [3883] dbg: config: read file /etc/spamassassin/v310.pre Aug 14 21:57:24.267 [3883] dbg: config: read file /etc/spamassassin/v312.pre Aug 14 21:57:24.267 [3883] dbg: config: read file /etc/spamassassin/v320.pre Aug 14 21:57:24.267 [3883] dbg: config: read file /etc/spamassassin/v330.pre Aug 14 21:57:24.267 [3883] dbg: config: using "/var/lib/spamassassin/3.003001" for sys rules pre files Aug 14 21:57:24.267 [3883] dbg: config: using "/var/lib/spamassassin/3.003001" for default rules dir Aug 14 21:57:24.267 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org.cf Aug 14 21:57:24.267 [3883] dbg: config: using "/etc/spamassassin" for site rules dir Aug 14 21:57:24.267 [3883] dbg: config: read file /etc/spamassassin/65_debian.cf Aug 14 21:57:24.267 [3883] dbg: config: read file /etc/spamassassin/blacklist.cf Aug 14 21:57:24.268 [3883] dbg: config: read file /etc/spamassassin/local.cf Aug 14 21:57:24.268 [3883] dbg: config: read file /etc/spamassassin/regex.cf Aug 14 21:57:24.268 [3883] dbg: config: read file /etc/spamassassin/whitelist.cf Aug 14 21:57:24.268 [3883] dbg: config: using "/root/.spamassassin" for user state dir Aug 14 21:57:24.268 [3883] dbg: config: using "/root/.spamassassin/user_prefs" for user prefs file Aug 14 21:57:24.268 [3883] dbg: config: read file /root/.spamassassin/user_prefs Aug 14 21:57:24.269 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDNSBL from @INC Aug 14 21:57:24.273 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::Hashcash from @INC Aug 14 21:57:24.280 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::SPF from @INC Aug 14 21:57:24.283 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::Pyzor from @INC Aug 14 21:57:24.285 [3883] dbg: pyzor: network tests on, attempting Pyzor Aug 14 21:57:24.285 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::Razor2 from @INC Aug 14 21:57:24.326 [3883] dbg: razor2: razor2 is available, version 2.84 Aug 14 21:57:24.327 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::SpamCop from @INC Aug 14 21:57:24.336 [3883] dbg: reporter: network tests on, attempting SpamCop Aug 14 21:57:24.336 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::AutoLearnThreshold from @INC Aug 14 21:57:24.337 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::WhiteListSubject from @INC Aug 14 21:57:24.338 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEHeader from @INC Aug 14 21:57:24.339 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::ReplaceTags from @INC Aug 14 21:57:24.340 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::DKIM from @INC Aug 14 21:57:24.345 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::Check from @INC Aug 14 21:57:24.351 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTTPSMismatch from @INC Aug 14 21:57:24.352 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDetail from @INC Aug 14 21:57:24.353 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::Bayes from @INC Aug 14 21:57:24.360 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::BodyEval from @INC Aug 14 21:57:24.362 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::DNSEval from @INC Aug 14 21:57:24.364 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTMLEval from @INC Aug 14 21:57:24.365 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::HeaderEval from @INC Aug 14 21:57:24.370 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEEval from @INC Aug 14 21:57:24.373 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::RelayEval from @INC Aug 14 21:57:24.375 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIEval from @INC Aug 14 21:57:24.376 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::WLBLEval from @INC Aug 14 21:57:24.377 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::VBounce from @INC Aug 14 21:57:24.378 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::ImageInfo from @INC Aug 14 21:57:24.380 [3883] dbg: plugin: loading Mail::SpamAssassin::Plugin::FreeMail from @INC Aug 14 21:57:24.383 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/10_default_prefs.cf Aug 14 21:57:24.383 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/10_default_prefs.cf" for included file Aug 14 21:57:24.383 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/10_default_prefs.cf Aug 14 21:57:24.385 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/10_hasbase.cf Aug 14 21:57:24.385 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/10_hasbase.cf" for included file Aug 14 21:57:24.386 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/10_hasbase.cf Aug 14 21:57:24.387 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_advance_fee.cf Aug 14 21:57:24.387 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_advance_fee.cf" for included file Aug 14 21:57:24.387 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_advance_fee.cf Aug 14 21:57:24.391 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_aux_tlds.cf Aug 14 21:57:24.391 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_aux_tlds.cf" for included file Aug 14 21:57:24.391 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_aux_tlds.cf Aug 14 21:57:24.396 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_body_tests.cf Aug 14 21:57:24.396 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_body_tests.cf" for included file Aug 14 21:57:24.396 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_body_tests.cf Aug 14 21:57:24.400 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_compensate.cf Aug 14 21:57:24.400 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_compensate.cf" for included file Aug 14 21:57:24.400 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_compensate.cf Aug 14 21:57:24.401 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_dnsbl_tests.cf Aug 14 21:57:24.401 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_dnsbl_tests.cf" for included file Aug 14 21:57:24.401 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_dnsbl_tests.cf Aug 14 21:57:24.405 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_drugs.cf Aug 14 21:57:24.405 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_drugs.cf" for included file Aug 14 21:57:24.405 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_drugs.cf Aug 14 21:57:24.414 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_dynrdns.cf Aug 14 21:57:24.414 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_dynrdns.cf" for included file Aug 14 21:57:24.414 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_dynrdns.cf Aug 14 21:57:24.419 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_fake_helo_tests.cf Aug 14 21:57:24.419 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_fake_helo_tests.cf" for included file Aug 14 21:57:24.419 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_fake_helo_tests.cf Aug 14 21:57:24.422 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_freemail.cf Aug 14 21:57:24.422 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_freemail.cf" for included file Aug 14 21:57:24.422 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_freemail.cf Aug 14 21:57:24.423 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_freemail_domains.cf Aug 14 21:57:24.423 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_freemail_domains.cf" for included file Aug 14 21:57:24.424 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_freemail_domains.cf Aug 14 21:57:24.424 [3883] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x3f3d658) implements 'parse_config', priority 0 Aug 14 21:57:24.441 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_head_tests.cf Aug 14 21:57:24.441 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_head_tests.cf" for included file Aug 14 21:57:24.442 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_head_tests.cf Aug 14 21:57:24.459 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_html_tests.cf Aug 14 21:57:24.459 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_html_tests.cf" for included file Aug 14 21:57:24.459 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_html_tests.cf Aug 14 21:57:24.466 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_imageinfo.cf Aug 14 21:57:24.466 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_imageinfo.cf" for included file Aug 14 21:57:24.466 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_imageinfo.cf Aug 14 21:57:24.468 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_mailspike.cf Aug 14 21:57:24.468 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_mailspike.cf" for included file Aug 14 21:57:24.468 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_mailspike.cf Aug 14 21:57:24.468 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_meta_tests.cf Aug 14 21:57:24.468 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_meta_tests.cf" for included file Aug 14 21:57:24.469 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_meta_tests.cf Aug 14 21:57:24.471 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_net_tests.cf Aug 14 21:57:24.471 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_net_tests.cf" for included file Aug 14 21:57:24.471 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_net_tests.cf Aug 14 21:57:24.472 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_phrases.cf Aug 14 21:57:24.472 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_phrases.cf" for included file Aug 14 21:57:24.472 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_phrases.cf Aug 14 21:57:24.478 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_porn.cf Aug 14 21:57:24.478 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_porn.cf" for included file Aug 14 21:57:24.478 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_porn.cf Aug 14 21:57:24.479 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_ratware.cf Aug 14 21:57:24.479 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_ratware.cf" for included file Aug 14 21:57:24.479 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_ratware.cf Aug 14 21:57:24.489 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_uri_tests.cf Aug 14 21:57:24.489 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_uri_tests.cf" for included file Aug 14 21:57:24.489 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_uri_tests.cf Aug 14 21:57:24.492 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_vbounce.cf Aug 14 21:57:24.492 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/20_vbounce.cf" for included file Aug 14 21:57:24.492 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/20_vbounce.cf Aug 14 21:57:24.504 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/23_bayes.cf Aug 14 21:57:24.504 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/23_bayes.cf" for included file Aug 14 21:57:24.504 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/23_bayes.cf Aug 14 21:57:24.505 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_accessdb.cf Aug 14 21:57:24.505 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_accessdb.cf" for included file Aug 14 21:57:24.506 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_accessdb.cf Aug 14 21:57:24.506 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_antivirus.cf Aug 14 21:57:24.506 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_antivirus.cf" for included file Aug 14 21:57:24.506 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_antivirus.cf Aug 14 21:57:24.506 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_asn.cf Aug 14 21:57:24.506 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_asn.cf" for included file Aug 14 21:57:24.507 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_asn.cf Aug 14 21:57:24.507 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_dcc.cf Aug 14 21:57:24.507 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_dcc.cf" for included file Aug 14 21:57:24.507 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_dcc.cf Aug 14 21:57:24.508 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_dkim.cf Aug 14 21:57:24.508 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_dkim.cf" for included file Aug 14 21:57:24.508 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_dkim.cf Aug 14 21:57:24.510 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_hashcash.cf Aug 14 21:57:24.510 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_hashcash.cf" for included file Aug 14 21:57:24.510 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_hashcash.cf Aug 14 21:57:24.512 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_pyzor.cf Aug 14 21:57:24.512 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_pyzor.cf" for included file Aug 14 21:57:24.512 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_pyzor.cf Aug 14 21:57:24.512 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_razor2.cf Aug 14 21:57:24.512 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_razor2.cf" for included file Aug 14 21:57:24.512 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_razor2.cf Aug 14 21:57:24.513 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_replace.cf Aug 14 21:57:24.513 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_replace.cf" for included file Aug 14 21:57:24.513 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_replace.cf Aug 14 21:57:24.519 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_spf.cf Aug 14 21:57:24.519 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_spf.cf" for included file Aug 14 21:57:24.519 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_spf.cf Aug 14 21:57:24.521 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_textcat.cf Aug 14 21:57:24.521 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_textcat.cf" for included file Aug 14 21:57:24.521 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_textcat.cf Aug 14 21:57:24.522 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_uribl.cf Aug 14 21:57:24.522 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/25_uribl.cf" for included file Aug 14 21:57:24.522 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/25_uribl.cf Aug 14 21:57:24.526 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_de.cf Aug 14 21:57:24.526 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_de.cf" for included file Aug 14 21:57:24.526 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_de.cf Aug 14 21:57:24.530 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_fr.cf Aug 14 21:57:24.530 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_fr.cf" for included file Aug 14 21:57:24.530 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_fr.cf Aug 14 21:57:24.532 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_it.cf Aug 14 21:57:24.533 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_it.cf" for included file Aug 14 21:57:24.533 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_it.cf Aug 14 21:57:24.533 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_nl.cf Aug 14 21:57:24.533 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_nl.cf" for included file Aug 14 21:57:24.533 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_nl.cf Aug 14 21:57:24.535 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_pl.cf Aug 14 21:57:24.535 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_pl.cf" for included file Aug 14 21:57:24.536 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_pl.cf Aug 14 21:57:24.538 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_pt_br.cf Aug 14 21:57:24.538 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_pt_br.cf" for included file Aug 14 21:57:24.538 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/30_text_pt_br.cf Aug 14 21:57:24.543 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/50_scores.cf Aug 14 21:57:24.543 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/50_scores.cf" for included file Aug 14 21:57:24.543 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/50_scores.cf Aug 14 21:57:24.578 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_adsp_override_dkim.cf Aug 14 21:57:24.578 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/60_adsp_override_dkim.cf" for included file Aug 14 21:57:24.578 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_adsp_override_dkim.cf Aug 14 21:57:24.580 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_awl.cf Aug 14 21:57:24.580 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/60_awl.cf" for included file Aug 14 21:57:24.581 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_awl.cf Aug 14 21:57:24.581 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_shortcircuit.cf Aug 14 21:57:24.581 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/60_shortcircuit.cf" for included file Aug 14 21:57:24.581 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_shortcircuit.cf Aug 14 21:57:24.582 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist.cf Aug 14 21:57:24.582 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist.cf" for included file Aug 14 21:57:24.582 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist.cf Aug 14 21:57:24.584 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_dkim.cf Aug 14 21:57:24.584 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_dkim.cf" for included file Aug 14 21:57:24.584 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_dkim.cf Aug 14 21:57:24.587 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_spf.cf Aug 14 21:57:24.587 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_spf.cf" for included file Aug 14 21:57:24.588 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_spf.cf Aug 14 21:57:24.589 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_subject.cf Aug 14 21:57:24.589 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_subject.cf" for included file Aug 14 21:57:24.589 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/60_whitelist_subject.cf Aug 14 21:57:24.590 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/72_active.cf Aug 14 21:57:24.590 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/72_active.cf" for included file Aug 14 21:57:24.591 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/72_active.cf Aug 14 21:57:24.690 [3883] 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 Aug 14 21:57:24.690 [3883] dbg: config: uri_detail added T_KHOP_FOREIGN_CLICK Aug 14 21:57:24.750 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/72_scores.cf Aug 14 21:57:24.750 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/72_scores.cf" for included file Aug 14 21:57:24.750 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/72_scores.cf Aug 14 21:57:24.757 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/73_sandbox_manual_scores.cf Aug 14 21:57:24.757 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/73_sandbox_manual_scores.cf" for included file Aug 14 21:57:24.757 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/73_sandbox_manual_scores.cf Aug 14 21:57:24.758 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/local.cf Aug 14 21:57:24.758 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/local.cf" for included file Aug 14 21:57:24.758 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/local.cf Aug 14 21:57:24.758 [3883] dbg: config: fixed relative path: /var/lib/spamassassin/3.003001/updates_spamassassin_org/regression_tests.cf Aug 14 21:57:24.758 [3883] dbg: config: using "/var/lib/spamassassin/3.003001/updates_spamassassin_org/regression_tests.cf" for included file Aug 14 21:57:24.758 [3883] dbg: config: read file /var/lib/spamassassin/3.003001/updates_spamassassin_org/regression_tests.cf Aug 14 21:57:25.326 [3883] dbg: rules: __AXB_MO_OL_44FE0 merged duplicates: __AXB_MO_OL_4CBE5 Aug 14 21:57:25.326 [3883] dbg: rules: __JM_REACTOR_DATE merged duplicates: __RATWARE_0_TZ_DATE Aug 14 21:57:25.327 [3883] dbg: rules: __AXB_MO_OL_2E645 merged duplicates: __AXB_MO_OL_5A31E __AXB_MO_OL_A7B9C Aug 14 21:57:25.327 [3883] dbg: rules: __AXB_XM_OL_07794 merged duplicates: __AXB_XM_OL_0A08A __AXB_XM_OL_2E645 __AXB_XM_OL_35FFA __AXB_XM_OL_3857F __AXB_XM_OL_4CBE5 __AXB_XM_OL_4F240 __AXB_XM_OL_58CB5 __AXB_XM_OL_5933D __AXB_XM_OL_6554A __AXB_XM_OL_812FF __AXB_XM_OL_8B970 __AXB_XM_OL_8E871 __AXB_XM_OL_C0C83 __AXB_XM_OL_C65FA __AXB_XM_OL_CC6B7 __AXB_XM_OL_CF0C0 __AXB_XM_OL_F475E __AXB_XM_OL_F6D01 Aug 14 21:57:25.327 [3883] dbg: rules: __HAS_REPLY_TO merged duplicates: __REPLYTO_EXISTS Aug 14 21:57:25.327 [3883] dbg: rules: __FH_HAS_XPRIORITY merged duplicates: __XPRIO Aug 14 21:57:25.327 [3883] dbg: rules: __HAS_XMAIL merged duplicates: __HAS_X_MAILER Aug 14 21:57:25.327 [3883] dbg: rules: FH_MSGID_01C67 merged duplicates: __MSGID_VGA Aug 14 21:57:25.327 [3883] dbg: rules: NAME_EMAIL_DIFF merged duplicates: __NAME_EMAIL_DIFF Aug 14 21:57:25.327 [3883] dbg: rules: __AXB_MO_OL_22B61 merged duplicates: __AXB_MO_OL_4F240 __AXB_MO_OL_ADFF7 Aug 14 21:57:25.327 [3883] dbg: rules: __AXB_MO_OL_812FF merged duplicates: __AXB_MO_OL_BC7E6 Aug 14 21:57:25.327 [3883] dbg: rules: __DOS_HAS_MAILING_LIST merged duplicates: __ML4 Aug 14 21:57:25.327 [3883] dbg: rules: __AXB_XM_OL_024C2 merged duplicates: __AXB_XM_OL_6237B Aug 14 21:57:25.327 [3883] dbg: rules: __AXB_XM_OL_448E3 merged duplicates: __AXB_XM_OL_5A31E Aug 14 21:57:25.327 [3883] dbg: rules: __AXB_MO_OL_37431 merged duplicates: __AXB_MO_OL_3857F Aug 14 21:57:25.327 [3883] dbg: rules: __AXB_MO_OL_5933D merged duplicates: __AXB_MO_OL_79A9A Aug 14 21:57:25.327 [3883] dbg: rules: __AXB_MO_OL_12495 merged duplicates: __AXB_MO_OL_4BF4C __AXB_MO_OL_F6D01 Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_9B90B merged duplicates: __AXB_MO_OL_C65FA __AXB_MO_OL_FB17C Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_07794 merged duplicates: __AXB_MO_OL_8627E __AXB_MO_OL_F3B05 Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_57545 merged duplicates: __AXB_MO_OL_A275F __AXB_MO_OL_CC6B7 Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_XM_OL_1ECD5 merged duplicates: __AXB_XM_OL_B292B Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_XM_OL_37431 merged duplicates: __AXB_XM_OL_44FE0 __AXB_XM_OL_4BF4C __AXB_XM_OL_4EEDB __AXB_XM_OL_57545 __AXB_XM_OL_7C3E5 __AXB_XM_OL_7F4F5 __AXB_XM_OL_9B90B __AXB_XM_OL_ADFF7 __AXB_XM_OL_B30D1 __AXB_XM_OL_B4B40 __AXB_XM_OL_BC7E6 __AXB_XM_OL_D2603 __AXB_XM_OL_DDE5D __AXB_XM_OL_F3B05 __AXB_XM_OL_FF5C8 Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_6554A merged duplicates: __AXB_MO_OL_C95DC Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_35FFA merged duplicates: __AXB_MO_OL_D2603 Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_B30D1 merged duplicates: __AXB_MO_OL_CF0C0 Aug 14 21:57:25.328 [3883] dbg: rules: __HAS_LIST_ID merged duplicates: __ML2 Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_787D6 merged duplicates: __AXB_MO_OL_7F4F5 __AXB_MO_OL_C0C83 Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_58CB5 merged duplicates: __AXB_MO_OL_B4B40 Aug 14 21:57:25.328 [3883] dbg: rules: __DOS_HAS_ANY_URI merged duplicates: __HAS_ANY_URI __HAS_URI Aug 14 21:57:25.328 [3883] dbg: rules: __FH_HAS_XMSMAIL merged duplicates: __HAS_MSMAIL_PRI Aug 14 21:57:25.328 [3883] dbg: rules: CTYPE_001C_A merged duplicates: DATE_IN_FUTURE_96_XX Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_7C3E5 merged duplicates: __AXB_MO_OL_8E871 __AXB_MO_OL_964DE Aug 14 21:57:25.328 [3883] dbg: rules: __AXB_MO_OL_C9CC0 merged duplicates: __AXB_MO_OL_F475E __AXB_MO_OL_FF5C8 Aug 14 21:57:25.329 [3883] dbg: config: finish parsing Aug 14 21:57:25.345 [3883] dbg: plugin: Mail::SpamAssassin::Plugin::ReplaceTags=HASH(0x3b41d30) implements 'finish_parsing_end', priority 0 Aug 14 21:57:25.345 [3883] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x3f3d658) implements 'finish_parsing_end', priority 0 Aug 14 21:57:25.345 [3883] dbg: replacetags: replacing tags Aug 14 21:57:25.367 [3883] dbg: replacetags: done replacing tags Aug 14 21:57:25.367 [3883] dbg: FreeMail: loaded freemail_domains entries: 2110 normal, 26 wildcard Aug 14 21:57:25.369 [3883] dbg: plugin: Mail::SpamAssassin::Plugin::Bayes=HASH(0x3c7b9a0) implements 'learner_new', priority 0 Aug 14 21:57:25.369 [3883] dbg: bayes: learner_new self=Mail::SpamAssassin::Plugin::Bayes=HASH(0x3c7b9a0), bayes_store_module=Mail::SpamAssassin::BayesStore::DBM Aug 14 21:57:25.380 [3883] dbg: bayes: learner_new: got store=Mail::SpamAssassin::BayesStore::DBM=HASH(0x3f61638) Aug 14 21:57:25.380 [3883] dbg: plugin: Mail::SpamAssassin::Plugin::Bayes=HASH(0x3c7b9a0) implements 'learner_is_scan_available', priority 0 Aug 14 21:57:25.380 [3883] dbg: config: using "/root/.spamassassin" for user state dir Aug 14 21:57:25.380 [3883] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_toks Aug 14 21:57:25.383 [3883] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_seen Aug 14 21:57:25.387 [3883] dbg: bayes: found bayes db version 3 Aug 14 21:57:25.387 [3883] dbg: bayes: DB journal sync: last sync: 0 Aug 14 21:57:25.387 [3883] dbg: config: using "/root/.spamassassin" for user state dir Aug 14 21:57:25.387 [3883] dbg: bayes: not available for scanning, only 2 spam(s) in bayes DB < 200 Aug 14 21:57:25.387 [3883] dbg: bayes: untie-ing Aug 14 21:57:25.387 [3883] dbg: config: score set 1 chosen. Aug 14 21:57:25.387 [3883] dbg: config: time limit 30.0 s Aug 14 21:57:25.391 [3883] dbg: message: main message type: multipart/mixed Aug 14 21:57:25.391 [3883] dbg: check: pms new, time limit in 28.875 s Aug 14 21:57:25.392 [3883] dbg: plugin: Mail::SpamAssassin::Plugin::DNSEval=HASH(0x3d682f8) implements 'check_start', priority 0 Aug 14 21:57:25.392 [3883] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_toks Aug 14 21:57:25.395 [3883] dbg: bayes: tie-ing to DB file R/O /root/.spamassassin/bayes_seen Aug 14 21:57:25.398 [3883] dbg: bayes: found bayes db version 3 Aug 14 21:57:25.399 [3883] dbg: bayes: DB journal sync: last sync: 0 Aug 14 21:57:25.399 [3883] dbg: bayes: not available for scanning, only 2 spam(s) in bayes DB < 200 Aug 14 21:57:25.399 [3883] dbg: bayes: untie-ing Aug 14 21:57:25.399 [3883] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x2722dd8) implements 'check_main', priority 0 Aug 14 21:57:25.399 [3883] 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 Aug 14 21:57:25.400 [3883] dbg: received-header: parsed as [. ip=65.55.116.91 rdns=blu0-omc3-s16.blu0.hotmail.com helo=blu0-omc3-s16.blu0.hotmail.com by=kilnar.com ident= envfrom= intl=0 id=30434200283 auth= msa=0 ] Aug 14 21:57:25.400 [3883] dbg: received-header: relay 65.55.116.91 trusted? no internal? no msa? no Aug 14 21:57:25.401 [3883] dbg: received-header: parsed as [. ip=65.55.116.72 rdns= helo=BLU166-W35 by=blu0-omc3-s16.blu0.hotmail.com ident= envfrom= intl=0 id= auth= msa=0 ] Aug 14 21:57:25.401 [3883] dbg: received-header: relay 65.55.116.72 trusted? no internal? no msa? no Aug 14 21:57:25.408 [3883] dbg: received-header: parsed as [. ip=75.71.202.179 rdns= helo= by= ident= envfrom= intl=0 id= auth= msa=0 ] Aug 14 21:57:25.408 [3883] dbg: received-header: relay 75.71.202.179 trusted? no internal? no msa? no Aug 14 21:57:25.408 [3883] dbg: metadata: X-Spam-Relays-Trusted: Aug 14 21:57:25.408 [3883] dbg: metadata: X-Spam-Relays-Untrusted: [. ip=65.55.116.91 rdns=blu0-omc3-s16.blu0.hotmail.com helo=blu0-omc3-s16.blu0.hotmail.com by=kilnar.com ident= envfrom= intl=0 id=30434200283 auth= msa=0 ] [. ip=65.55.116.72 rdns= helo=BLU166-W35 by=blu0-omc3-s16.blu0.hotmail.com ident= envfrom= intl=0 id= auth= msa=0 ] [. ip=75.71.202.179 rdns= helo= by= ident= envfrom= intl=0 id= auth= msa=0 ] Aug 14 21:57:25.408 [3883] dbg: metadata: X-Spam-Relays-Internal: Aug 14 21:57:25.408 [3883] dbg: metadata: X-Spam-Relays-External: [. ip=65.55.116.91 rdns=blu0-omc3-s16.blu0.hotmail.com helo=blu0-omc3-s16.blu0.hotmail.com by=kilnar.com ident= envfrom= intl=0 id=30434200283 auth= msa=0 ] [. ip=65.55.116.72 rdns= helo=BLU166-W35 by=blu0-omc3-s16.blu0.hotmail.com ident= envfrom= intl=0 id= auth= msa=0 ] [. ip=75.71.202.179 rdns= helo= by= ident= envfrom= intl=0 id= auth= msa=0 ] Aug 14 21:57:25.408 [3883] dbg: message: ---- MIME PARSER START ---- Aug 14 21:57:25.408 [3883] dbg: message: parsing multipart, got boundary: _eb78356d-6d12-4a21-8c50-edd440caf9ed_ Aug 14 21:57:25.409 [3883] dbg: message: found part of type multipart/alternative, boundary: _19d354d1-dd2f-4b50-8e0c-dc5c61e7c41b_ Aug 14 21:57:25.409 [3883] dbg: message: added part, type: multipart/alternative Aug 14 21:57:25.412 [3883] dbg: message: found part of type text/plain, boundary: _eb78356d-6d12-4a21-8c50-edd440caf9ed_ Aug 14 21:57:25.412 [3883] dbg: message: added part, type: text/plain Aug 14 21:57:25.412 [3883] dbg: message: parsing multipart, got boundary: _19d354d1-dd2f-4b50-8e0c-dc5c61e7c41b_ Aug 14 21:57:25.412 [3883] dbg: message: found part of type text/plain, boundary: _19d354d1-dd2f-4b50-8e0c-dc5c61e7c41b_ Aug 14 21:57:25.412 [3883] dbg: message: added part, type: text/plain Aug 14 21:57:25.412 [3883] dbg: message: found part of type text/html, boundary: _19d354d1-dd2f-4b50-8e0c-dc5c61e7c41b_ Aug 14 21:57:25.412 [3883] dbg: message: added part, type: text/html Aug 14 21:57:25.413 [3883] dbg: message: parsing normal part Aug 14 21:57:25.413 [3883] dbg: message: parsing normal part Aug 14 21:57:25.413 [3883] dbg: message: parsing normal part Aug 14 21:57:25.413 [3883] dbg: message: ---- MIME PARSER END ---- Aug 14 21:57:25.413 [3883] dbg: message: decoding quoted-printable Aug 14 21:57:25.413 [3883] dbg: message: decoding quoted-printable Aug 14 21:57:25.415 [3883] dbg: message: decoding base64 Aug 14 21:57:25.417 [3883] dbg: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x3521630) implements 'parsed_metadata', priority 0 Aug 14 21:57:25.417 [3883] dbg: dns: is_dns_available() last checked 1345003045.4 seconds ago; re-checking Aug 14 21:57:25.418 [3883] dbg: dns: is Net::DNS::Resolver available? yes Aug 14 21:57:25.418 [3883] dbg: dns: Net::DNS version: 0.65 Aug 14 21:57:25.418 [3883] dbg: dns: name server: 127.0.0.1, LocalAddr: 0.0.0.0 Aug 14 21:57:25.419 [3883] dbg: dns: resolver socket rx buffer size is 124928 bytes Aug 14 21:57:25.419 [3883] dbg: dns: testing resolver nameservers: 127.0.0.1, 64.111.18.230 Aug 14 21:57:25.419 [3883] dbg: dns: trying (3) linux.org... Aug 14 21:57:25.419 [3883] dbg: dns: looking up NS for 'linux.org' Aug 14 21:57:25.419 [3883] dbg: dns: providing a callback for id: 21280/linux.org/NS/IN Aug 14 21:57:25.421 [3883] dbg: dns: NS lookup of linux.org using 127.0.0.1 succeeded => DNS available (set dns_available to override) Aug 14 21:57:25.421 [3883] dbg: dns: name server: 64.111.18.230, LocalAddr: 0.0.0.0 Aug 14 21:57:25.421 [3883] dbg: dns: resolver socket rx buffer size is 124928 bytes Aug 14 21:57:25.421 [3883] dbg: dns: trying (3) sun.com... Aug 14 21:57:25.421 [3883] dbg: dns: looking up NS for 'sun.com' Aug 14 21:57:25.421 [3883] dbg: dns: providing a callback for id: 13073/sun.com/NS/IN Aug 14 21:57:25.422 [3883] dbg: dns: NS lookup of sun.com using 64.111.18.230 succeeded => DNS available (set dns_available to override) Aug 14 21:57:25.422 [3883] dbg: dns: name server: 64.111.18.230, LocalAddr: 0.0.0.0 Aug 14 21:57:25.422 [3883] dbg: dns: resolver socket rx buffer size is 124928 bytes Aug 14 21:57:25.422 [3883] dbg: dns: NS list: 127.0.0.1, 64.111.18.230 Aug 14 21:57:25.422 [3883] dbg: dns: name server: 127.0.0.1, LocalAddr: 0.0.0.0 Aug 14 21:57:25.423 [3883] dbg: dns: resolver socket rx buffer size is 124928 bytes Aug 14 21:57:25.423 [3883] dbg: dns: is DNS available? 1 Aug 14 21:57:25.448 [3883] dbg: uridnsbl: domain microsoft.com in skip list Aug 14 21:57:25.448 [3883] dbg: uridnsbl: domain hotmail.com in skip list Aug 14 21:57:25.448 [3883] dbg: uridnsbl: domains to query: csfwg.org Aug 14 21:57:25.448 [3883] dbg: dns: providing a callback for id: 60508/csfwg.org.multi.surbl.org/A/IN Aug 14 21:57:25.448 [3883] dbg: async: starting: URI-DNSBL, DNSBL:multi.surbl.org.:csfwg.org (timeout 15.0s, min 3.0s) Aug 14 21:57:25.448 [3883] dbg: dns: URIBL_PH_SURBL lookup start Aug 14 21:57:25.449 [3883] dbg: dns: providing a callback for id: 61365/csfwg.org.multi.uribl.com/A/IN Aug 14 21:57:25.449 [3883] dbg: async: starting: URI-DNSBL, DNSBL:multi.uribl.com.:csfwg.org (timeout 15.0s, min 3.0s) Aug 14 21:57:25.449 [3883] dbg: dns: URIBL_BLACK lookup start Aug 14 21:57:25.449 [3883] dbg: dns: URIBL_RED lookup start Aug 14 21:57:25.449 [3883] dbg: dns: URIBL_GREY lookup start Aug 14 21:57:25.449 [3883] dbg: dns: providing a callback for id: 35902/csfwg.org.dob.sibl.support-intelligence.net/A/IN Aug 14 21:57:25.450 [3883] dbg: async: starting: URI-DNSBL, DNSBL:dob.sibl.support-intelligence.net:csfwg.org (timeout 15.0s, min 3.0s) Aug 14 21:57:25.450 [3883] dbg: dns: URIBL_RHS_DOB lookup start Aug 14 21:57:25.450 [3883] dbg: dns: URIBL_SC_SURBL lookup start Aug 14 21:57:25.450 [3883] dbg: dns: URIBL_JP_SURBL lookup start Aug 14 21:57:25.450 [3883] dbg: dns: URIBL_AB_SURBL lookup start Aug 14 21:57:25.450 [3883] dbg: dns: URIBL_WS_SURBL lookup start Aug 14 21:57:25.450 [3883] dbg: dns: URIBL_OB_SURBL lookup start Aug 14 21:57:25.450 [3883] dbg: dns: URIBL_BLOCKED lookup start Aug 14 21:57:25.450 [3883] dbg: dns: providing a callback for id: 61694/csfwg.org.dbl.spamhaus.org/A/IN Aug 14 21:57:25.450 [3883] dbg: async: starting: URI-DNSBL, DNSBL:dbl.spamhaus.org.:csfwg.org (timeout 15.0s, min 3.0s) Aug 14 21:57:25.450 [3883] dbg: dns: URIBL_DBL_ERROR lookup start Aug 14 21:57:25.450 [3883] dbg: dns: URIBL_DBL_SPAM lookup start Aug 14 21:57:25.451 [3883] dbg: dns: URIBL_DBL_REDIR lookup start Aug 14 21:57:25.451 [3883] dbg: dns: providing a callback for id: 13595/csfwg.org/NS/IN Aug 14 21:57:25.451 [3883] dbg: async: starting: URI-NS, NS:csfwg.org (timeout 15.0s, min 3.0s) Aug 14 21:57:25.451 [3883] dbg: dns: URIBL_SBL lookup start Aug 14 21:57:25.451 [3883] dbg: dns: checking RBL combined.njabl.org., set njabl Aug 14 21:57:25.451 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.452 [3883] dbg: dns: only inspecting the following IPs: 75.71.202.179, 65.55.116.72, 65.55.116.91 Aug 14 21:57:25.452 [3883] dbg: dns: launching DNS A query for 179.202.71.75.combined.njabl.org. in background Aug 14 21:57:25.452 [3883] dbg: dns: providing a callback for id: 42605/179.202.71.75.combined.njabl.org/A/IN Aug 14 21:57:25.452 [3883] dbg: async: starting: DNSBL-A, dns:A:179.202.71.75.combined.njabl.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.453 [3883] dbg: dns: launching DNS A query for 72.116.55.65.combined.njabl.org. in background Aug 14 21:57:25.453 [3883] dbg: dns: providing a callback for id: 36290/72.116.55.65.combined.njabl.org/A/IN Aug 14 21:57:25.453 [3883] dbg: async: starting: DNSBL-A, dns:A:72.116.55.65.combined.njabl.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.453 [3883] dbg: dns: launching DNS A query for 91.116.55.65.combined.njabl.org. in background Aug 14 21:57:25.453 [3883] dbg: dns: providing a callback for id: 51086/91.116.55.65.combined.njabl.org/A/IN Aug 14 21:57:25.454 [3883] dbg: async: starting: DNSBL-A, dns:A:91.116.55.65.combined.njabl.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.454 [3883] dbg: dns: checking RBL bl.spamcop.net., set spamcop Aug 14 21:57:25.454 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.454 [3883] dbg: dns: only inspecting the following IPs: 75.71.202.179, 65.55.116.72, 65.55.116.91 Aug 14 21:57:25.454 [3883] dbg: dns: launching DNS TXT query for 179.202.71.75.bl.spamcop.net. in background Aug 14 21:57:25.455 [3883] dbg: dns: providing a callback for id: 20813/179.202.71.75.bl.spamcop.net/TXT/IN Aug 14 21:57:25.455 [3883] dbg: async: starting: DNSBL-TXT, dns:TXT:179.202.71.75.bl.spamcop.net. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.455 [3883] dbg: dns: launching DNS TXT query for 72.116.55.65.bl.spamcop.net. in background Aug 14 21:57:25.455 [3883] dbg: dns: providing a callback for id: 19568/72.116.55.65.bl.spamcop.net/TXT/IN Aug 14 21:57:25.455 [3883] dbg: async: starting: DNSBL-TXT, dns:TXT:72.116.55.65.bl.spamcop.net. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.455 [3883] dbg: dns: launching DNS TXT query for 91.116.55.65.bl.spamcop.net. in background Aug 14 21:57:25.456 [3883] dbg: dns: providing a callback for id: 20233/91.116.55.65.bl.spamcop.net/TXT/IN Aug 14 21:57:25.456 [3883] dbg: async: starting: DNSBL-TXT, dns:TXT:91.116.55.65.bl.spamcop.net. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.456 [3883] dbg: dns: checking RBL zen.spamhaus.org., set zen-lastexternal Aug 14 21:57:25.456 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.456 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.456 [3883] dbg: dns: launching DNS A query for 91.116.55.65.zen.spamhaus.org. in background Aug 14 21:57:25.457 [3883] dbg: dns: providing a callback for id: 6614/91.116.55.65.zen.spamhaus.org/A/IN Aug 14 21:57:25.457 [3883] dbg: async: starting: DNSBL-A, dns:A:91.116.55.65.zen.spamhaus.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.457 [3883] dbg: dns: checking RBL dnsbl.sorbs.net., set sorbs-lastexternal Aug 14 21:57:25.457 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.457 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.457 [3883] dbg: dns: launching DNS A query for 91.116.55.65.dnsbl.sorbs.net. in background Aug 14 21:57:25.458 [3883] dbg: dns: providing a callback for id: 27447/91.116.55.65.dnsbl.sorbs.net/A/IN Aug 14 21:57:25.458 [3883] dbg: async: starting: DNSBL-A, dns:A:91.116.55.65.dnsbl.sorbs.net. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.458 [3883] dbg: dns: checking RBL dnsbl.sorbs.net., set sorbs Aug 14 21:57:25.458 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.458 [3883] dbg: dns: only inspecting the following IPs: 75.71.202.179, 65.55.116.72, 65.55.116.91 Aug 14 21:57:25.458 [3883] dbg: dns: launching DNS A query for 179.202.71.75.dnsbl.sorbs.net. in background Aug 14 21:57:25.459 [3883] dbg: dns: providing a callback for id: 61481/179.202.71.75.dnsbl.sorbs.net/A/IN Aug 14 21:57:25.459 [3883] dbg: async: starting: DNSBL-A, dns:A:179.202.71.75.dnsbl.sorbs.net. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.459 [3883] dbg: dns: launching DNS A query for 72.116.55.65.dnsbl.sorbs.net. in background Aug 14 21:57:25.459 [3883] dbg: dns: providing a callback for id: 40546/72.116.55.65.dnsbl.sorbs.net/A/IN Aug 14 21:57:25.459 [3883] dbg: async: starting: DNSBL-A, dns:A:72.116.55.65.dnsbl.sorbs.net. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.460 [3883] dbg: dns: checking RBL bl.score.senderscore.com., set rnbl-lastexternal Aug 14 21:57:25.460 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.461 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.461 [3883] dbg: dns: launching DNS A query for 91.116.55.65.bl.score.senderscore.com. in background Aug 14 21:57:25.461 [3883] dbg: dns: providing a callback for id: 23154/91.116.55.65.bl.score.senderscore.com/A/IN Aug 14 21:57:25.461 [3883] dbg: async: starting: DNSBL-A, dns:A:91.116.55.65.bl.score.senderscore.com. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.461 [3883] dbg: dns: checking RBL zen.spamhaus.org., set zen-lastexternal Aug 14 21:57:25.461 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.462 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.462 [3883] dbg: dns: checking RBL psbl.surriel.com., set psbl-lastexternal Aug 14 21:57:25.462 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.462 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.462 [3883] dbg: dns: launching DNS A query for 91.116.55.65.psbl.surriel.com. in background Aug 14 21:57:25.462 [3883] dbg: dns: providing a callback for id: 52536/91.116.55.65.psbl.surriel.com/A/IN Aug 14 21:57:25.463 [3883] dbg: async: starting: DNSBL-A, dns:A:91.116.55.65.psbl.surriel.com. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.463 [3883] dbg: dns: checking RBL list.dnswl.org., set dnswl-firsttrusted Aug 14 21:57:25.463 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.463 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.463 [3883] dbg: dns: launching DNS A query for 91.116.55.65.list.dnswl.org. in background Aug 14 21:57:25.463 [3883] dbg: dns: providing a callback for id: 8538/91.116.55.65.list.dnswl.org/A/IN Aug 14 21:57:25.464 [3883] dbg: async: starting: DNSBL-A, dns:A:91.116.55.65.list.dnswl.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.464 [3883] dbg: dns: checking RBL bb.barracudacentral.org., set brbl-lastexternal Aug 14 21:57:25.464 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.464 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.464 [3883] dbg: dns: launching DNS A query for 91.116.55.65.bb.barracudacentral.org. in background Aug 14 21:57:25.464 [3883] dbg: dns: providing a callback for id: 24162/91.116.55.65.bb.barracudacentral.org/A/IN Aug 14 21:57:25.464 [3883] dbg: async: starting: DNSBL-A, dns:A:91.116.55.65.bb.barracudacentral.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.465 [3883] dbg: dns: checking RBL sa-trusted.bondedsender.org., set ssc-firsttrusted Aug 14 21:57:25.465 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.465 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.465 [3883] dbg: dns: launching DNS TXT query for 91.116.55.65.sa-trusted.bondedsender.org. in background Aug 14 21:57:25.465 [3883] dbg: dns: providing a callback for id: 45027/91.116.55.65.sa-trusted.bondedsender.org/TXT/IN Aug 14 21:57:25.466 [3883] dbg: async: starting: DNSBL-TXT, dns:TXT:91.116.55.65.sa-trusted.bondedsender.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.466 [3883] dbg: dns: checking RBL zen.spamhaus.org., set zen Aug 14 21:57:25.466 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.466 [3883] dbg: dns: only inspecting the following IPs: 75.71.202.179, 65.55.116.72, 65.55.116.91 Aug 14 21:57:25.466 [3883] dbg: dns: launching DNS A query for 179.202.71.75.zen.spamhaus.org. in background Aug 14 21:57:25.467 [3883] dbg: dns: providing a callback for id: 18049/179.202.71.75.zen.spamhaus.org/A/IN Aug 14 21:57:25.467 [3883] dbg: async: starting: DNSBL-A, dns:A:179.202.71.75.zen.spamhaus.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.467 [3883] dbg: dns: launching DNS A query for 72.116.55.65.zen.spamhaus.org. in background Aug 14 21:57:25.467 [3883] dbg: dns: providing a callback for id: 7906/72.116.55.65.zen.spamhaus.org/A/IN Aug 14 21:57:25.467 [3883] dbg: async: starting: DNSBL-A, dns:A:72.116.55.65.zen.spamhaus.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.467 [3883] dbg: dns: checking RBL sa-accredit.habeas.com., set ssc-firsttrusted Aug 14 21:57:25.467 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.468 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.468 [3883] dbg: dns: launching DNS TXT query for 91.116.55.65.sa-accredit.habeas.com. in background Aug 14 21:57:25.468 [3883] dbg: dns: providing a callback for id: 4294/91.116.55.65.sa-accredit.habeas.com/TXT/IN Aug 14 21:57:25.468 [3883] dbg: async: starting: DNSBL-TXT, dns:TXT:91.116.55.65.sa-accredit.habeas.com. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.468 [3883] dbg: dns: checking RBL iadb.isipp.com., set iadb-firsttrusted Aug 14 21:57:25.470 [3883] dbg: dns: IPs found: full-external: 65.55.116.91, 65.55.116.72, 75.71.202.179 untrusted: 65.55.116.91, 65.55.116.72, 75.71.202.179 originating: 75.71.202.179 Aug 14 21:57:25.470 [3883] dbg: dns: only inspecting the following IPs: 65.55.116.91 Aug 14 21:57:25.470 [3883] dbg: dns: launching DNS A query for 91.116.55.65.iadb.isipp.com. in background Aug 14 21:57:25.471 [3883] dbg: dns: providing a callback for id: 13136/91.116.55.65.iadb.isipp.com/A/IN Aug 14 21:57:25.471 [3883] dbg: async: starting: DNSBL-A, dns:A:91.116.55.65.iadb.isipp.com. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.472 [3883] dbg: check: check_main, time limit in 28.795 s Aug 14 21:57:25.472 [3883] dbg: check: running tests for priority: -1000 Aug 14 21:57:25.474 [3883] dbg: dns: hit <dns:179.202.71.75.dnsbl.sorbs.net> 127.0.0.10 Aug 14 21:57:25.475 [3883] dbg: dns: hit <dns:91.116.55.65.list.dnswl.org> 127.0.5.0 Aug 14 21:57:25.475 [3883] dbg: async: select found 7 responses ready (t.o.=0.0) Aug 14 21:57:25.475 [3883] dbg: async: completed in 0.004 s: DNSBL-A, dns:A:91.116.55.65.iadb.isipp.com. Aug 14 21:57:25.476 [3883] dbg: async: completed in 0.013 s: DNSBL-A, dns:A:179.202.71.75.dnsbl.sorbs.net. Aug 14 21:57:25.476 [3883] dbg: async: completed in 0.011 s: DNSBL-A, dns:A:91.116.55.65.list.dnswl.org. Aug 14 21:57:25.476 [3883] dbg: async: completed in 0.021 s: URI-NS, NS:csfwg.org Aug 14 21:57:25.476 [3883] dbg: dns: providing a callback for id: 40125/dns2.csfwg.org/A/IN Aug 14 21:57:25.476 [3883] dbg: async: starting: URI-A, A:dns2.csfwg.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.476 [3883] dbg: dns: providing a callback for id: 53606/dns1.csfwg.org/A/IN Aug 14 21:57:25.477 [3883] dbg: async: starting: URI-A, A:dns1.csfwg.org. (timeout 15.0s, min 3.0s) Aug 14 21:57:25.477 [3883] dbg: async: completed in 0.014 s: DNSBL-A, dns:A:91.116.55.65.dnsbl.sorbs.net. Aug 14 21:57:25.477 [3883] dbg: async: completed in 0.015 s: DNSBL-A, dns:A:72.116.55.65.dnsbl.sorbs.net. Aug 14 21:57:25.477 [3883] dbg: async: completed in 0.013 s: DNSBL-A, dns:A:91.116.55.65.bl.score.senderscore.com. Aug 14 21:57:25.477 [3883] dbg: async: queries completed: 7, started: 2 Aug 14 21:57:25.477 [3883] dbg: async: queries active: DNSBL-A=8 DNSBL-TXT=5 URI-A=2 URI-DNSBL=4 at Tue Aug 14 21:57:25 2012 Aug 14 21:57:25.477 [3883] dbg: dns: harvested completed queries Aug 14 21:57:25.477 [3883] dbg: rules: running head tests; score so far=-0.0001 Aug 14 21:57:25.477 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 282 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg1000_1 Aug 14 21:57:25.478 [3883] dbg: rules: run_generic_tests - compiling eval code: head, priority -1000 Aug 14 21:57:25.478 [3883] dbg: rules: compiled head tests Aug 14 21:57:25.478 [3883] dbg: rules: running head_eval tests; score so far=-0.0001 Aug 14 21:57:25.478 [3883] dbg: rules: run_eval_tests - compiling eval code: 9, priority -1000 Aug 14 21:57:25.479 [3883] dbg: eval: all '*From' addrs: mel_kary [at] hotmail Aug 14 21:57:25.483 [3883] dbg: eval: all '*To' addrs: anthology [at] csfwg Aug 14 21:57:25.483 [3883] dbg: rules: running body tests; score so far=-0.0001 Aug 14 21:57:25.484 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 225 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg1000_1 Aug 14 21:57:25.484 [3883] dbg: rules: run_generic_tests - compiling eval code: body, priority -1000 Aug 14 21:57:25.484 [3883] dbg: rules: compiled body tests Aug 14 21:57:25.484 [3883] dbg: rules: running uri tests; score so far=-0.0001 Aug 14 21:57:25.484 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 223 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg1000_1 Aug 14 21:57:25.484 [3883] dbg: rules: run_generic_tests - compiling eval code: uri, priority -1000 Aug 14 21:57:25.484 [3883] dbg: rules: compiled uri tests Aug 14 21:57:25.484 [3883] dbg: rules: running body_eval tests; score so far=-0.0001 Aug 14 21:57:25.485 [3883] dbg: rules: run_eval_tests - compiling eval code: 11, priority -1000 Aug 14 21:57:25.485 [3883] dbg: rules: running rawbody tests; score so far=-0.0001 Aug 14 21:57:25.485 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 231 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg1000_1 Aug 14 21:57:25.485 [3883] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -1000 Aug 14 21:57:25.485 [3883] dbg: rules: compiled rawbody tests Aug 14 21:57:25.485 [3883] dbg: rules: running full tests; score so far=-0.0001 Aug 14 21:57:25.485 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 260 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg1000_1 Aug 14 21:57:25.486 [3883] dbg: rules: run_generic_tests - compiling eval code: full, priority -1000 Aug 14 21:57:25.486 [3883] dbg: rules: compiled full tests Aug 14 21:57:25.486 [3883] dbg: rules: running meta tests; score so far=-0.0001 Aug 14 21:57:25.486 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 285 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg1000_1 Aug 14 21:57:25.486 [3883] dbg: rules: run_generic_tests - compiling eval code: meta, priority -1000 Aug 14 21:57:25.486 [3883] dbg: rules: compiled meta tests Aug 14 21:57:25.487 [3883] dbg: check: running tests for priority: -950 Aug 14 21:57:25.487 [3883] dbg: rules: running head tests; score so far=-0.0001 Aug 14 21:57:25.487 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 280 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg950_1 Aug 14 21:57:25.487 [3883] dbg: rules: run_generic_tests - compiling eval code: head, priority -950 Aug 14 21:57:25.487 [3883] dbg: rules: compiled head tests Aug 14 21:57:25.487 [3883] dbg: rules: running head_eval tests; score so far=-0.0001 Aug 14 21:57:25.487 [3883] dbg: rules: run_eval_tests - compiling eval code: 9, priority -950 Aug 14 21:57:25.488 [3883] dbg: rules: running body tests; score so far=-0.0001 Aug 14 21:57:25.488 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 223 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg950_1 Aug 14 21:57:25.488 [3883] dbg: rules: run_generic_tests - compiling eval code: body, priority -950 Aug 14 21:57:25.488 [3883] dbg: rules: compiled body tests Aug 14 21:57:25.488 [3883] dbg: rules: running uri tests; score so far=-0.0001 Aug 14 21:57:25.488 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 221 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg950_1 Aug 14 21:57:25.489 [3883] dbg: rules: run_generic_tests - compiling eval code: uri, priority -950 Aug 14 21:57:25.489 [3883] dbg: rules: compiled uri tests Aug 14 21:57:25.489 [3883] dbg: rules: running body_eval tests; score so far=-0.0001 Aug 14 21:57:25.489 [3883] dbg: rules: run_eval_tests - compiling eval code: 11, priority -950 Aug 14 21:57:25.489 [3883] dbg: rules: running rawbody tests; score so far=-0.0001 Aug 14 21:57:25.489 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg950_1 Aug 14 21:57:25.489 [3883] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -950 Aug 14 21:57:25.489 [3883] dbg: rules: compiled rawbody tests Aug 14 21:57:25.490 [3883] dbg: rules: running full tests; score so far=-0.0001 Aug 14 21:57:25.490 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 258 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg950_1 Aug 14 21:57:25.490 [3883] dbg: rules: run_generic_tests - compiling eval code: full, priority -950 Aug 14 21:57:25.490 [3883] dbg: rules: compiled full tests Aug 14 21:57:25.490 [3883] dbg: rules: running meta tests; score so far=-0.0001 Aug 14 21:57:25.490 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 283 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg950_1 Aug 14 21:57:25.490 [3883] dbg: rules: run_generic_tests - compiling eval code: meta, priority -950 Aug 14 21:57:25.491 [3883] dbg: rules: compiled meta tests Aug 14 21:57:25.491 [3883] dbg: check: running tests for priority: -900 Aug 14 21:57:25.491 [3883] dbg: rules: running head tests; score so far=-0.0001 Aug 14 21:57:25.491 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 280 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg900_1 Aug 14 21:57:25.491 [3883] dbg: rules: run_generic_tests - compiling eval code: head, priority -900 Aug 14 21:57:25.491 [3883] dbg: rules: compiled head tests Aug 14 21:57:25.491 [3883] dbg: rules: running head_eval tests; score so far=-0.0001 Aug 14 21:57:25.492 [3883] dbg: rules: run_eval_tests - compiling eval code: 9, priority -900 Aug 14 21:57:25.494 [3883] dbg: rules: running body tests; score so far=-0.0001 Aug 14 21:57:25.494 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 223 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg900_1 Aug 14 21:57:25.494 [3883] dbg: rules: run_generic_tests - compiling eval code: body, priority -900 Aug 14 21:57:25.494 [3883] dbg: rules: compiled body tests Aug 14 21:57:25.494 [3883] dbg: rules: running uri tests; score so far=-0.0001 Aug 14 21:57:25.494 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 221 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg900_1 Aug 14 21:57:25.494 [3883] dbg: rules: run_generic_tests - compiling eval code: uri, priority -900 Aug 14 21:57:25.494 [3883] dbg: rules: compiled uri tests Aug 14 21:57:25.495 [3883] dbg: rules: running body_eval tests; score so far=-0.0001 Aug 14 21:57:25.495 [3883] dbg: rules: run_eval_tests - compiling eval code: 11, priority -900 Aug 14 21:57:25.495 [3883] dbg: rules: running rawbody tests; score so far=-0.0001 Aug 14 21:57:25.495 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg900_1 Aug 14 21:57:25.495 [3883] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -900 Aug 14 21:57:25.495 [3883] dbg: rules: compiled rawbody tests Aug 14 21:57:25.495 [3883] dbg: rules: running full tests; score so far=-0.0001 Aug 14 21:57:25.496 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 258 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg900_1 Aug 14 21:57:25.496 [3883] dbg: rules: run_generic_tests - compiling eval code: full, priority -900 Aug 14 21:57:25.496 [3883] dbg: rules: compiled full tests Aug 14 21:57:25.496 [3883] dbg: rules: running meta tests; score so far=-0.0001 Aug 14 21:57:25.496 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 283 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg900_1 Aug 14 21:57:25.496 [3883] dbg: rules: run_generic_tests - compiling eval code: meta, priority -900 Aug 14 21:57:25.496 [3883] dbg: rules: compiled meta tests Aug 14 21:57:25.496 [3883] dbg: check: running tests for priority: -400 Aug 14 21:57:25.497 [3883] dbg: rules: running head tests; score so far=-0.0001 Aug 14 21:57:25.497 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 280 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg400_1 Aug 14 21:57:25.497 [3883] dbg: rules: run_generic_tests - compiling eval code: head, priority -400 Aug 14 21:57:25.497 [3883] dbg: rules: compiled head tests Aug 14 21:57:25.497 [3883] dbg: rules: running body tests; score so far=-0.0001 Aug 14 21:57:25.497 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 223 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg400_1 Aug 14 21:57:25.497 [3883] dbg: rules: run_generic_tests - compiling eval code: body, priority -400 Aug 14 21:57:25.498 [3883] dbg: rules: compiled body tests Aug 14 21:57:25.498 [3883] dbg: rules: running uri tests; score so far=-0.0001 Aug 14 21:57:25.498 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 221 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg400_1 Aug 14 21:57:25.498 [3883] dbg: rules: run_generic_tests - compiling eval code: uri, priority -400 Aug 14 21:57:25.498 [3883] dbg: rules: compiled uri tests Aug 14 21:57:25.498 [3883] dbg: rules: running body_eval tests; score so far=-0.0001 Aug 14 21:57:25.498 [3883] dbg: rules: run_eval_tests - compiling eval code: 11, priority -400 Aug 14 21:57:25.499 [3883] dbg: rules: running rawbody tests; score so far=-0.0001 Aug 14 21:57:25.499 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 229 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg400_1 Aug 14 21:57:25.499 [3883] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -400 Aug 14 21:57:25.499 [3883] dbg: rules: compiled rawbody tests Aug 14 21:57:25.499 [3883] dbg: rules: running full tests; score so far=-0.0001 Aug 14 21:57:25.499 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 258 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg400_1 Aug 14 21:57:25.499 [3883] dbg: rules: run_generic_tests - compiling eval code: full, priority -400 Aug 14 21:57:25.499 [3883] dbg: rules: compiled full tests Aug 14 21:57:25.500 [3883] dbg: rules: running meta tests; score so far=-0.0001 Aug 14 21:57:25.500 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 283 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg400_1 Aug 14 21:57:25.500 [3883] dbg: rules: run_generic_tests - compiling eval code: meta, priority -400 Aug 14 21:57:25.500 [3883] dbg: rules: compiled meta tests Aug 14 21:57:25.500 [3883] dbg: check: running tests for priority: 0 Aug 14 21:57:25.500 [3883] dbg: rules: running head tests; score so far=-0.0001 Aug 14 21:57:25.518 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60279 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_1 Aug 14 21:57:25.527 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60481 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_2 Aug 14 21:57:25.535 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60404 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_3 Aug 14 21:57:25.542 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60257 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_4 Aug 14 21:57:25.550 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60504 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_5 Aug 14 21:57:25.558 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 58923 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_6 Aug 14 21:57:25.564 [3883] dbg: rules: run_generic_tests - compiling eval code: head, priority 0 Aug 14 21:57:25.564 [3883] dbg: rules: compiled head tests Aug 14 21:57:25.565 [3883] dbg: rules: ran header rule __LAST_EXTERNAL_RELAY_NO_AUTH ======> got hit: "[. ip=65.55.116.91 rdns=blu0-omc3-s16.blu0.hotmail.com helo=blu0-omc3-s16.blu0.hotmail.com by=kilnar.com ident= envfrom= intl=0 id=30434200283 auth= " Aug 14 21:57:25.565 [3883] dbg: rules: ran header rule __HOST_HOTMAIL ======> got hit: "[ ip=65.55.116.91 rdns=blu0-omc3-s16.blu0.hotmail.com " Aug 14 21:57:25.565 [3883] dbg: rules: ran header rule __RCD_RDNS_MAIL_MESSY ======> got hit: "[ ip=65.55.116.91 rdns=blu0-omc3-s16.blu0.hotmail" Aug 14 21:57:25.566 [3883] dbg: rules: ran header rule __DOS_RELAYED_EXT ======> got hit: "Received: from blu0-omc3-s16.blu0.hotmail.com (blu0-omc3-s16.blu0.hotmail.com [65.55.116.91]) Aug 14 21:57:25.566 [3883] dbg: rules: [...] Aug 14 21:57:25.566 [3883] dbg: rules: [...] by kilnar.com (Postfix) with ESMTP id 30434200283 Aug 14 21:57:25.566 [3883] dbg: rules: [...] Aug 14 21:57:25.566 [3883] dbg: rules: [...] for <anthology [at] csfwg>; Tue, 14 Aug 2012 17:23:25 -0600 (MDT) Aug 14 21:57:25.566 [3883] dbg: rules: [...] Aug 14 21:57:25.566 [3883] dbg: rules: [...] Received: " Aug 14 21:57:25.566 [3883] dbg: rules: ran header rule __CTYPE_HAS_BOUNDARY ======> got hit: "boundary" Aug 14 21:57:25.566 [3883] dbg: rules: ran header rule __CT ======> got hit: "<YES>" Aug 14 21:57:25.566 [3883] dbg: rules: ran header rule __CTYPE_MULTIPART_ANY ======> got hit: "multipart/mixed" Aug 14 21:57:25.566 [3883] dbg: rules: ran header rule __HAS_DATE ======> got hit: "<YES>" Aug 14 21:57:25.567 [3883] dbg: rules: ran header rule __LAST_UNTRUSTED_RELAY_NO_AUTH ======> got hit: "[. ip=65.55.116.91 rdns=blu0-omc3-s16.blu0.hotmail.com helo=blu0-omc3-s16.blu0.hotmail.com by=kilnar.com ident= envfrom= intl=0 id=30434200283 auth= " Aug 14 21:57:25.567 [3883] dbg: rules: ran header rule __MSGID_OK_HOST ======> got hit: "@phx.gbl>" Aug 14 21:57:25.567 [3883] dbg: rules: ran header rule __HAS_MESSAGE_ID ======> got hit: "<YES>" Aug 14 21:57:25.568 [3883] dbg: rules: ran header rule __MIME_VERSION ======> got hit: "<YES>" Aug 14 21:57:25.568 [3883] dbg: rules: ran header rule __TOCC_EXISTS ======> got hit: "<YES>" Aug 14 21:57:25.568 [3883] dbg: rules: ran header rule __HAS_RCVD ======> got hit: "<YES>" Aug 14 21:57:25.568 [3883] dbg: rules: ran header rule __DOS_RCVD_TUE ======> got hit: " Tue, " Aug 14 21:57:25.568 [3883] dbg: rules: ran header rule __HS_SUBJ_RE_FW ======> got hit: "RE:" Aug 14 21:57:25.569 [3883] dbg: rules: ran header rule __HAS_SUBJECT ======> got hit: "<YES>" Aug 14 21:57:25.569 [3883] dbg: rules: ran header rule __SUBJ_RE ======> got hit: "RE:" Aug 14 21:57:25.570 [3883] dbg: rules: ran header rule __HAS_MSGID ======> got hit: "<" Aug 14 21:57:25.570 [3883] dbg: rules: ran header rule __SANE_MSGID ======> got hit: "<BLU166-W3502167A19EB605F932121F5B70 [at] phx> Aug 14 21:57:25.570 [3883] dbg: rules: [...] " Aug 14 21:57:25.571 [3883] dbg: rules: ran header rule __HAS_TO ======> got hit: "<YES>" Aug 14 21:57:25.571 [3883] dbg: rules: ran header rule __HAS_IN_REPLY_TO ======> got hit: "<YES>" Aug 14 21:57:25.571 [3883] dbg: rules: ran header rule __HAS_X_REF ======> got hit: "<YES>" Aug 14 21:57:25.571 [3883] dbg: rules: ran header rule __HAS_FROM ======> got hit: "<YES>" Aug 14 21:57:25.571 [3883] dbg: rules: ran header rule __FROM_FREEMAIL ======> got hit: "@hotmail." Aug 14 21:57:25.571 [3883] dbg: rules: ran header rule __FROM_HOTMAIL_COM ======> got hit: "@hotmail.com" Aug 14 21:57:25.575 [3883] dbg: async: select found 14 responses ready (t.o.=0.0) Aug 14 21:57:25.575 [3883] dbg: async: completed in 0.124 s: URI-DNSBL, DNSBL:multi.uribl.com.:csfwg.org Aug 14 21:57:25.575 [3883] dbg: async: completed in 0.110 s: DNSBL-A, dns:A:91.116.55.65.bb.barracudacentral.org. Aug 14 21:57:25.575 [3883] dbg: async: completed in 0.121 s: DNSBL-A, dns:A:179.202.71.75.combined.njabl.org. Aug 14 21:57:25.575 [3883] dbg: async: completed in 0.096 s: URI-A, A:dns1.csfwg.org. Aug 14 21:57:25.576 [3883] dbg: dns: providing a callback for id: 6662/230.18.111.64.zen.spamhaus.org/A/IN Aug 14 21:57:25.576 [3883] dbg: async: starting: URI-DNSBL, DNSBL:zen.spamhaus.org.:230.18.111.64 (timeout 15.0s, min 3.0s) Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.096 s: URI-A, A:dns2.csfwg.org. Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.120 s: DNSBL-A, dns:A:91.116.55.65.combined.njabl.org. Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.107 s: DNSBL-A, dns:A:72.116.55.65.zen.spamhaus.org. Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.104 s: DNSBL-TXT, dns:TXT:91.116.55.65.sa-accredit.habeas.com. Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.119 s: DNSBL-TXT, dns:TXT:72.116.55.65.bl.spamcop.net. Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.119 s: DNSBL-TXT, dns:TXT:179.202.71.75.bl.spamcop.net. Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.108 s: DNSBL-TXT, dns:TXT:91.116.55.65.sa-trusted.bondedsender.org. Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.126 s: URI-DNSBL, DNSBL:multi.surbl.org.:csfwg.org Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.120 s: DNSBL-A, dns:A:72.116.55.65.combined.njabl.org. Aug 14 21:57:25.576 [3883] dbg: async: completed in 0.116 s: DNSBL-A, dns:A:91.116.55.65.zen.spamhaus.org. Aug 14 21:57:25.576 [3883] dbg: async: queries completed: 14, started: 1 Aug 14 21:57:25.577 [3883] dbg: async: queries active: DNSBL-A=2 DNSBL-TXT=1 URI-DNSBL=3 at Tue Aug 14 21:57:25 2012 Aug 14 21:57:25.577 [3883] dbg: dns: harvested completed queries Aug 14 21:57:25.577 [3883] dbg: rules: running head_eval tests; score so far=-0.0001 Aug 14 21:57:25.578 [3883] dbg: rules: run_eval_tests - compiling eval code: 9, priority 0 Aug 14 21:57:25.584 [3883] dbg: FreeMail: RULE (FREEMAIL_FROM) check_freemail_from Aug 14 21:57:25.584 [3883] dbg: FreeMail: all from-addresses: mel_kary [at] hotmail Aug 14 21:57:25.584 [3883] dbg: FreeMail: HIT! mel_kary [at] hotmail is freemail Aug 14 21:57:25.585 [3883] dbg: rules: ran eval rule FREEMAIL_FROM ======> got hit (1) Aug 14 21:57:25.606 [3883] dbg: dkim: using Mail::DKIM version 0.38 Aug 14 21:57:25.608 [3883] dbg: dkim: performing public key lookup and signature verification Aug 14 21:57:25.608 [3883] dbg: dkim: signature verification result: none Aug 14 21:57:25.608 [3883] dbg: dkim: adsp: performing lookup on _adsp._domainkey.hotmail.com Aug 14 21:57:25.643 [3883] dbg: dkim: adsp result: U/unknown (dns: unknown), author domain 'hotmail.com' Aug 14 21:57:25.644 [3883] dbg: spf: checking to see if the message has a Received-SPF header that we can use Aug 14 21:57:25.673 [3883] dbg: spf: using Mail::SPF for SPF checks Aug 14 21:57:25.673 [3883] dbg: spf: checking HELO (helo=blu0-omc3-s16.blu0.hotmail.com, ip=65.55.116.91) Aug 14 21:57:25.674 [3883] dbg: dns: providing a callback for id: 36800/blu0-omc3-s16.blu0.hotmail.com/SPF/IN Aug 14 21:57:25.675 [3883] dbg: dns: hit <dns:179.202.71.75.zen.spamhaus.org> 127.0.0.10 Aug 14 21:57:25.676 [3883] dbg: dns: providing a callback for id: 19877/blu0-omc3-s16.blu0.hotmail.com/TXT/IN Aug 14 21:57:25.677 [3883] dbg: spf: query for /65.55.116.91/blu0-omc3-s16.blu0.hotmail.com: result: none, comment: , text: No applicable sender policy available Aug 14 21:57:25.679 [3883] dbg: dkim: author mel_kary [at] hotmail, not in any dkim whitelist Aug 14 21:57:25.679 [3883] dbg: spf: already checked for Received-SPF headers, proceeding with DNS based checks Aug 14 21:57:25.679 [3883] dbg: spf: cannot get Envelope-From, cannot use SPF Aug 14 21:57:25.680 [3883] dbg: FreeMail: RULE (__freemail_reply) check_freemail_replyto Aug 14 21:57:25.680 [3883] dbg: FreeMail: From address: mel_kary [at] hotmail Aug 14 21:57:25.728 [3883] dbg: FreeMail: RULE (FREEMAIL_REPLYTO_END_DIGIT) check_freemail_header regex:\d@ Aug 14 21:57:25.728 [3883] dbg: FreeMail: header Reply-To not found from mail Aug 14 21:57:25.729 [3883] dbg: FreeMail: RULE (__freemail_replyto) check_freemail_replyto Aug 14 21:57:25.729 [3883] dbg: FreeMail: From address: mel_kary [at] hotmail Aug 14 21:57:25.729 [3883] dbg: FreeMail: Reply-To is not freemail, skipping check Aug 14 21:57:25.729 [3883] dbg: FreeMail: RULE (__freemail_hdr_replyto) check_freemail_header Aug 14 21:57:25.729 [3883] dbg: FreeMail: header Reply-To not found from mail Aug 14 21:57:25.730 [3883] dbg: spf: def_spf_whitelist_from: already checked spf and didn't get pass, skipping whitelist check Aug 14 21:57:25.730 [3883] dbg: FreeMail: RULE (FREEMAIL_ENVFROM_END_DIGIT) check_freemail_header regex:\d@ Aug 14 21:57:25.730 [3883] dbg: FreeMail: header EnvelopeFrom not found from mail Aug 14 21:57:25.730 [3883] dbg: spf: whitelist_from_spf: already checked spf and didn't get pass, skipping whitelist check Aug 14 21:57:25.731 [3883] dbg: async: select found no responses ready (t.o.=0.0) Aug 14 21:57:25.731 [3883] dbg: async: completed in 0.208 s: DNSBL-A, dns:A:179.202.71.75.zen.spamhaus.org. Aug 14 21:57:25.731 [3883] dbg: async: completed in 0.099 s: URI-DNSBL, DNSBL:zen.spamhaus.org.:230.18.111.64 Aug 14 21:57:25.731 [3883] dbg: async: completed in 0.225 s: URI-DNSBL, DNSBL:dbl.spamhaus.org.:csfwg.org Aug 14 21:57:25.731 [3883] dbg: async: completed in 0.220 s: DNSBL-TXT, dns:TXT:91.116.55.65.bl.spamcop.net. Aug 14 21:57:25.731 [3883] dbg: async: queries completed: 4, started: 0 Aug 14 21:57:25.731 [3883] dbg: async: queries active: DNSBL-A=1 URI-DNSBL=1 at Tue Aug 14 21:57:25 2012 Aug 14 21:57:25.731 [3883] dbg: dns: harvested completed queries Aug 14 21:57:25.731 [3883] dbg: rules: running body tests; score so far=0.0009 Aug 14 21:57:25.735 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60166 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_1 Aug 14 21:57:25.746 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60299 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_2 Aug 14 21:57:25.758 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60330 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_3 Aug 14 21:57:25.768 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60195 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_4 Aug 14 21:57:25.779 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60455 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_5 Aug 14 21:57:25.791 [3883] dbg: rules: flush_evalstr (add_evalstr) compiling 60430 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_6 Aug 14 21:57:25.799 [3883] dbg: rules: flush_evalstr (run_generic_tests) compiling 8457 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_7 Aug 14 21:57:25.801 [3883] dbg: rules: run_generic_tests - compiling eval code: body, priority 0 Aug 14 21:57:25.801 [3883] dbg: rules: compiled body tests Aug 14 21:57:25.975 [3883] dbg: rules: ran body rule __COMPENSATION ======> got hit: "Compensation" Aug 14 21:57:26.186 [3883] dbg: rules: ran body rule __APPROVALFVGT ======> got hit: "approval" Aug 14 21:57:26.327 [3883] dbg: rules: ran body rule __HAS_ANY_EMAIL ======> got hit: "y [at] csfwg" Aug 14 21:57:26.396 [3883] dbg: rules: ran body rule __NONEMPTY_BODY ======> got hit: "R" Aug 14 21:57:26.483 [3883] dbg: rules: ran body rule __LONGWORDS_A ======> got hit: "ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff fffffffffffffffffdfffffffeffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff " Aug 14 21:57:26.658 [3883] dbg: rules: ran body rule T_FRT_CONTACT ======> got hit: "cont ract"
|