kvTK0NPe

1Dec  2 21:09:33.185 [17476] dbg: logger: adding facilities: all
2Dec  2 21:09:33.186 [17476] dbg: logger: logging level is DBG
3Dec  2 21:09:33.186 [17476] dbg: generic: SpamAssassin version 3.4.2
4Dec  2 21:09:33.187 [17476] dbg: generic: Perl 5.024001, PREFIX=/usr/local, DEF_RULES_DIR=/usr/local/share/spamassassin, LOCAL_RULES_DIR=/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin
5Dec  2 21:09:33.187 [17476] dbg: config: timing enabled
6Dec  2 21:09:33.203 [17476] dbg: config: score set 0 chosen.
7Dec  2 21:09:33.232 [17476] dbg: util: running in taint mode? yes
8Dec  2 21:09:33.233 [17476] dbg: util: taint mode: deleting unsafe environment variables, resetting PATH
9Dec  2 21:09:33.234 [17476] dbg: util: PATH included '/home/jarif/bin', keeping
10Dec  2 21:09:33.234 [17476] dbg: util: PATH included '/usr/local/sbin', keeping
11Dec  2 21:09:33.235 [17476] dbg: util: PATH included '/usr/local/bin', keeping
12Dec  2 21:09:33.235 [17476] dbg: util: PATH included '/usr/sbin', keeping
13Dec  2 21:09:33.236 [17476] dbg: util: PATH included '/usr/bin', keeping
14Dec  2 21:09:33.236 [17476] dbg: util: PATH included '/sbin', keeping
15Dec  2 21:09:33.237 [17476] dbg: util: PATH included '/bin', keeping
16Dec  2 21:09:33.237 [17476] dbg: util: PATH included '/usr/local/games', keeping
17Dec  2 21:09:33.237 [17476] dbg: util: PATH included '/usr/games', keeping
18Dec  2 21:09:33.238 [17476] dbg: util: final PATH set to: /home/jarif/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/games:/usr/games
19Dec  2 21:09:33.259 [17476] dbg: util: secure_tmpfile created a temporary file /tmp/.spamassassin17476cbol9Wtmp
20Dec  2 21:09:33.261 [17476] dbg: archive-iterator: _set_default_message_selection_opts After: Scanprob[1], want_date[0], cache[0], from_regex[^From \S+ ?(\S\S\S \S\S\S .?\d .?\d:\d\d:\d\d \d{4}|.?\d-\d\d-\d{4}_\d\d:\d\d:\d\d_)]
21Dec  2 21:09:33.263 [17476] warn: config: path "/etc/mail/spamassassin" is inaccessible: Permission denied
22Dec  2 21:09:33.264 [17476] warn: config: path "/etc/mail/spamassassin" is inaccessible: Permission denied
23Dec  2 21:09:33.265 [17476] dbg: config: using "/etc/spamassassin" for site rules pre files
24Dec  2 21:09:33.268 [17476] dbg: config: read file /etc/spamassassin/ExtractText.pre
25Dec  2 21:09:33.269 [17476] dbg: config: read file /etc/spamassassin/init.pre
26Dec  2 21:09:33.269 [17476] dbg: config: read file /etc/spamassassin/sa-compile.pre
27Dec  2 21:09:33.270 [17476] dbg: config: read file /etc/spamassassin/v310.pre
28Dec  2 21:09:33.271 [17476] dbg: config: read file /etc/spamassassin/v312.pre
29Dec  2 21:09:33.271 [17476] dbg: config: read file /etc/spamassassin/v320.pre
30Dec  2 21:09:33.272 [17476] dbg: config: read file /etc/spamassassin/v330.pre
31Dec  2 21:09:33.272 [17476] dbg: config: read file /etc/spamassassin/v340.pre
32Dec  2 21:09:33.273 [17476] dbg: config: read file /etc/spamassassin/v341.pre
33Dec  2 21:09:33.274 [17476] dbg: config: read file /etc/spamassassin/v342.pre
34Dec  2 21:09:33.274 [17476] dbg: config: using "/var/lib/spamassassin/3.004002" for sys rules pre files
35Dec  2 21:09:33.275 [17476] dbg: config: using "/var/lib/spamassassin/3.004002" for default rules dir
36Dec  2 21:09:33.276 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org.cf
37Dec  2 21:09:33.277 [17476] dbg: config: using "/etc/spamassassin" for site rules dir
38Dec  2 21:09:33.280 [17476] dbg: config: read file /etc/spamassassin/60_txreputation.cf
39Dec  2 21:09:33.281 [17476] dbg: config: read file /etc/spamassassin/65_debian.cf
40Dec  2 21:09:33.282 [17476] dbg: config: read file /etc/spamassassin/90_axb_phish.cf
41Dec  2 21:09:33.283 [17476] dbg: config: read file /etc/spamassassin/90_rulegen_fraud.cf
42Dec  2 21:09:33.284 [17476] dbg: config: read file /etc/spamassassin/90_rulegen_phish.cf
43Dec  2 21:09:33.285 [17476] dbg: config: read file /etc/spamassassin/DecodeShortURLs.cf
44Dec  2 21:09:33.286 [17476] dbg: config: read file /etc/spamassassin/ExtractText.cf
45Dec  2 21:09:33.291 [17476] dbg: config: read file /etc/spamassassin/KAM.cf
46Dec  2 21:09:33.294 [17476] dbg: config: read file /etc/spamassassin/baduris.cf
47Dec  2 21:09:33.299 [17476] dbg: config: read file /etc/spamassassin/btcabuse.cf
48Dec  2 21:09:33.303 [17476] dbg: config: read file /etc/spamassassin/clamav.cf
49Dec  2 21:09:33.304 [17476] dbg: config: read file /etc/spamassassin/emailbl_lemfreemail.cf
50Dec  2 21:09:33.304 [17476] dbg: config: read file /etc/spamassassin/hashbl.cf
51Dec  2 21:09:33.305 [17476] dbg: config: read file /etc/spamassassin/local-blacklists.cf
52Dec  2 21:09:33.306 [17476] dbg: config: read file /etc/spamassassin/local-docusign.cf
53Dec  2 21:09:33.306 [17476] dbg: config: read file /etc/spamassassin/local-jboss.cf
54Dec  2 21:09:33.307 [17476] dbg: config: read file /etc/spamassassin/local-rules.cf
55Dec  2 21:09:33.308 [17476] dbg: config: read file /etc/spamassassin/local-whitelists.cf
56Dec  2 21:09:33.309 [17476] dbg: config: read file /etc/spamassassin/local.cf
57Dec  2 21:09:33.309 [17476] dbg: config: read file /etc/spamassassin/local_rbls.cf
58Dec  2 21:09:33.310 [17476] dbg: config: read file /etc/spamassassin/mxpf.cf
59Dec  2 21:09:33.311 [17476] dbg: config: read file /etc/spamassassin/postcards.cf
60Dec  2 21:09:33.317 [17476] dbg: config: using "/home/jarif/.spamassassin" for user state dir
61Dec  2 21:09:33.319 [17476] dbg: config: using "/home/jarif/.spamassassin/user_prefs" for user prefs file
62Dec  2 21:09:33.321 [17476] dbg: config: read file /home/jarif/.spamassassin/user_prefs
63Dec  2 21:09:33.374 [17476] dbg: config: fixed relative path: /etc/spamassassin/ExtractText.pm
64Dec  2 21:09:33.375 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::ExtractText from /etc/spamassassin/ExtractText.pm
65Dec  2 21:09:33.548 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::RelayCountry from @INC
66Dec  2 21:09:33.561 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDNSBL from @INC
67Dec  2 21:09:33.598 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::Hashcash from @INC
68Dec  2 21:09:33.637 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::SPF from @INC
69Dec  2 21:09:33.668 [17476] dbg: config: fixed relative path: /etc/spamassassin/sender-checks.pm
70Dec  2 21:09:33.669 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::SenderChecks from /etc/spamassassin/sender-checks.pm
71Dec  2 21:09:33.673 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::Rule2XSBody from @INC
72Dec  2 21:09:33.692 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::Pyzor from @INC
73Dec  2 21:09:33.708 [17476] dbg: pyzor: network tests on, attempting Pyzor
74Dec  2 21:09:33.709 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::Razor2 from @INC
75Dec  2 21:09:34.043 [17476] dbg: razor2: razor2 is available, version 2.84
76Dec  2 21:09:34.045 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::SpamCop from @INC
77Dec  2 21:09:34.369 [17476] dbg: reporter: network tests on, attempting SpamCop
78Dec  2 21:09:34.370 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::AutoLearnThreshold from @INC
79Dec  2 21:09:34.379 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::TextCat from @INC
80Dec  2 21:09:34.393 [17476] dbg: textcat: loading languages file /usr/local/share/spamassassin/languages
81Dec  2 21:09:34.604 [17476] dbg: textcat: loaded 73 language models
82Dec  2 21:09:34.644 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::WhiteListSubject from @INC
83Dec  2 21:09:34.652 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEHeader from @INC
84Dec  2 21:09:34.661 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::ReplaceTags from @INC
85Dec  2 21:09:34.671 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::DKIM from @INC
86Dec  2 21:09:34.709 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::Check from @INC
87Dec  2 21:09:34.759 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTTPSMismatch from @INC
88Dec  2 21:09:34.766 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIDetail from @INC
89Dec  2 21:09:34.777 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::Bayes from @INC
90Dec  2 21:09:34.847 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::BodyEval from @INC
91Dec  2 21:09:34.861 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::DNSEval from @INC
92Dec  2 21:09:34.878 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::HTMLEval from @INC
93Dec  2 21:09:34.892 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::HeaderEval from @INC
94Dec  2 21:09:34.941 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::MIMEEval from @INC
95Dec  2 21:09:34.966 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::RelayEval from @INC
96Dec  2 21:09:34.984 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::URIEval from @INC
97Dec  2 21:09:34.990 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::WLBLEval from @INC
98Dec  2 21:09:35.012 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::VBounce from @INC
99Dec  2 21:09:35.020 [17476] dbg: plugin: did not register Mail::SpamAssassin::Plugin::Rule2XSBody, already registered
100Dec  2 21:09:35.021 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::ASN from @INC
101Dec  2 21:09:35.035 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::ImageInfo from @INC
102Dec  2 21:09:35.053 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::FreeMail from @INC
103Dec  2 21:09:35.088 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::AskDNS from @INC
104Dec  2 21:09:35.112 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::TxRep from @INC
105Dec  2 21:09:35.156 [17476] dbg: TxRep: new object created
106Dec  2 21:09:35.157 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::PDFInfo from @INC
107Dec  2 21:09:35.189 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::HashBL from @INC
108Dec  2 21:09:35.213 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::ResourceLimits from @INC
109Dec  2 21:09:35.229 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::FromNameSpoof from @INC
110Dec  2 21:09:35.246 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::Phishing from @INC
111Dec  2 21:09:35.256 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/10_default_prefs.cf
112Dec  2 21:09:35.256 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/10_default_prefs.cf" for included file
113Dec  2 21:09:35.257 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/10_default_prefs.cf
114Dec  2 21:09:35.389 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/10_hasbase.cf
115Dec  2 21:09:35.389 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/10_hasbase.cf" for included file
116Dec  2 21:09:35.390 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/10_hasbase.cf
117Dec  2 21:09:35.407 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_advance_fee.cf
118Dec  2 21:09:35.407 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_advance_fee.cf" for included file
119Dec  2 21:09:35.408 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_advance_fee.cf
120Dec  2 21:09:35.441 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_aux_tlds.cf
121Dec  2 21:09:35.442 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_aux_tlds.cf" for included file
122Dec  2 21:09:35.443 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_aux_tlds.cf
123Dec  2 21:09:35.455 [17476] dbg: config: cleared tld lists
124Dec  2 21:09:35.458 [17476] dbg: config: added tld list - xn--11b4c3d xn--1ck2e1b xn--1qqw23a xn--2scrj9c xn--30rr7y xn--3bst00m
125Dec  2 21:09:35.459 [17476] dbg: config: added tld list - xn--3ds443g xn--3e0b707e xn--3hcrj9c xn--3oq18vl8pn36a xn--3pxu8k xn--42c2d9a
126Dec  2 21:09:35.459 [17476] dbg: config: added tld list - xn--45br5cyl xn--45brj9c xn--45q11c xn--4gbrim xn--54b7fta0cc xn--55qw42g
127Dec  2 21:09:35.460 [17476] dbg: config: added tld list - xn--55qx5d xn--5su34j936bgsg xn--5tzm5g xn--6frz82g xn--6qq986b3xl xn--80adxhks
128Dec  2 21:09:35.461 [17476] dbg: config: added tld list - xn--80ao21a xn--80aqecdr1a xn--80asehdb xn--80aswg xn--8y0a063a xn--90a3ac
129Dec  2 21:09:35.461 [17476] dbg: config: added tld list - xn--90ae xn--90ais xn--9dbq2a xn--9et52u xn--9krt00a xn--b4w605ferd
130Dec  2 21:09:35.462 [17476] dbg: config: added tld list - xn--bck1b9a5dre4c xn--c1avg xn--c2br7g xn--cck2b3b xn--cg4bki
131Dec  2 21:09:35.463 [17476] dbg: config: added tld list - xn--clchc0ea0b2g2a9gcd xn--czr694b xn--czrs0t xn--czru2d xn--d1acj3b xn--d1alf
132Dec  2 21:09:35.463 [17476] dbg: config: added tld list - xn--e1a4c xn--eckvdtc9d xn--efvy88h xn--estv75g xn--fct429k xn--fhbei
133Dec  2 21:09:35.464 [17476] dbg: config: added tld list - xn--fiq228c5hs xn--fiq64b xn--fiqs8s xn--fiqz9s xn--fjq720a xn--flw351e
134Dec  2 21:09:35.464 [17476] dbg: config: added tld list - xn--fpcrj9c3d xn--fzc2c9e2c xn--fzys8d69uvgm xn--g2xx48c xn--gckr3f0f
135Dec  2 21:09:35.465 [17476] dbg: config: added tld list - xn--gecrj9c xn--gk3at1e xn--h2breg3eve xn--h2brj9c xn--h2brj9c8c xn--hxt814e
136Dec  2 21:09:35.466 [17476] dbg: config: added tld list - xn--i1b6b1a6a2e xn--imr513n xn--io0a7i xn--j1aef xn--j1amh xn--j6w193g
137Dec  2 21:09:35.466 [17476] dbg: config: added tld list - xn--jlq61u9w7b xn--jvr189m xn--kcrx77d1x4a xn--kprw13d xn--kpry57d xn--kpu716f
138Dec  2 21:09:35.467 [17476] dbg: config: added tld list - xn--kput3i xn--l1acc xn--lgbbat1ad8j xn--mgb9awbf xn--mgba3a3ejt
139Dec  2 21:09:35.468 [17476] dbg: config: added tld list - xn--mgba3a4f16a xn--mgba7c0bbn0a xn--mgbaakc7dvf xn--mgbaam7a8h xn--mgbab2bd
140Dec  2 21:09:35.468 [17476] dbg: config: added tld list - xn--mgbai9azgqp6j xn--mgbayh7gpa xn--mgbb9fbpob xn--mgbbh1a xn--mgbbh1a71e
141Dec  2 21:09:35.469 [17476] dbg: config: added tld list - xn--mgbc0a9azcg xn--mgbca7dzdo xn--mgberp4a5d4ar xn--mgbgu82a xn--mgbi4ecexp
142Dec  2 21:09:35.469 [17476] dbg: config: added tld list - xn--mgbpl2fh xn--mgbt3dhd xn--mgbtx2b xn--mgbx4cd0ab xn--mix891f xn--mk1bu44c
143Dec  2 21:09:35.470 [17476] dbg: config: added tld list - xn--mxtq1m xn--ngbc5azd xn--ngbe9e0a xn--ngbrx xn--node xn--nqv7f
144Dec  2 21:09:35.471 [17476] dbg: config: added tld list - xn--nqv7fs00ema xn--nyqy26a xn--o3cw4h xn--ogbpf8fl xn--otu796d xn--p1acf
145Dec  2 21:09:35.471 [17476] dbg: config: added tld list - xn--p1ai xn--pbt977c xn--pgbs0dh xn--pssy2u xn--q9jyb4c xn--qcka1pmc xn--qxam
146Dec  2 21:09:35.472 [17476] dbg: config: added tld list - xn--rhqv96g xn--rovu88b xn--rvc1e0am3e xn--s9brj9c xn--ses554g xn--t60b56a
147Dec  2 21:09:35.473 [17476] dbg: config: added tld list - xn--tckwe xn--tiq49xqyj xn--unup4y xn--vermgensberater-ctb
148Dec  2 21:09:35.473 [17476] dbg: config: added tld list - xn--vermgensberatung-pwb xn--vhquv xn--vuq861b xn--w4r85el8fhu5dnra xn--w4rs40l
149Dec  2 21:09:35.474 [17476] dbg: config: added tld list - xn--wgbh1c xn--wgbl6a xn--xhq521b xn--xkc2al3hye2a xn--xkc2dl3a5ee0h xn--y9a3aq
150Dec  2 21:09:35.474 [17476] dbg: config: added tld list - xn--yfro4i67o xn--ygbi2ammx xn--zfr164b
151Dec  2 21:09:35.475 [17476] dbg: config: added tld list - aaa aarp abarth abb abbott abbvie abc able abogado abudhabi ac academy
152Dec  2 21:09:35.476 [17476] dbg: config: added tld list - accenture accountant accountants aco active actor ad adac ads adult ae aeg aero
153Dec  2 21:09:35.477 [17476] dbg: config: added tld list - aetna af afamilycompany afl africa ag agakhan agency ai aig aigo airbus
154Dec  2 21:09:35.477 [17476] dbg: config: added tld list - airforce airtel akdn al alfaromeo alibaba alipay allfinanz allstate ally alsace
155Dec  2 21:09:35.478 [17476] dbg: config: added tld list - alstom am americanexpress americanfamily amex amfam amica amsterdam analytics
156Dec  2 21:09:35.479 [17476] dbg: config: added tld list - android anquan anz ao aol apartments app apple aq aquarelle ar arab aramco
157Dec  2 21:09:35.480 [17476] dbg: config: added tld list - archi army arpa art arte as asda asia associates at athleta attorney au auction
158Dec  2 21:09:35.480 [17476] dbg: config: added tld list - audi audible audio auspost author auto autos avianca aw aws ax axa az azure ba
159Dec  2 21:09:35.481 [17476] dbg: config: added tld list - baby baidu banamex bananarepublic band bank bar barcelona barclaycard barclays
160Dec  2 21:09:35.482 [17476] dbg: config: added tld list - barefoot bargains baseball basketball bauhaus bayern bb bbc bbt bbva bcg bcn bd
161Dec  2 21:09:35.483 [17476] dbg: config: added tld list - be beats beauty beer bentley berlin best bestbuy bet bf bg bh bharti bi bible
162Dec  2 21:09:35.483 [17476] dbg: config: added tld list - bid bike bing bingo bio biz bj black blackfriday blanco blockbuster blog
163Dec  2 21:09:35.484 [17476] dbg: config: added tld list - bloomberg blue bm bms bmw bn bnl bnpparibas bo boats boehringer bofa bom bond
164Dec  2 21:09:35.485 [17476] dbg: config: added tld list - boo book booking bosch bostik boston bot boutique box br bradesco bridgestone
165Dec  2 21:09:35.485 [17476] dbg: config: added tld list - broadway broker brother brussels bs bt budapest bugatti build builders business
166Dec  2 21:09:35.486 [17476] dbg: config: added tld list - buy buzz bv bw by bz bzh ca cab cafe cal call calvinklein cam camera camp
167Dec  2 21:09:35.487 [17476] dbg: config: added tld list - cancerresearch canon capetown capital capitalone car caravan cards care career
168Dec  2 21:09:35.488 [17476] dbg: config: added tld list - careers cars cartier casa case caseih cash casino cat catering catholic cba cbn
169Dec  2 21:09:35.488 [17476] dbg: config: added tld list - cbre cbs cc cd ceb center ceo cern cf cfa cfd cg ch chanel channel charity
170Dec  2 21:09:35.489 [17476] dbg: config: added tld list - chase chat cheap chintai christmas chrome chrysler church ci cipriani circle
171Dec  2 21:09:35.490 [17476] dbg: config: added tld list - cisco citadel citi citic city cityeats ck cl claims cleaning click clinic
172Dec  2 21:09:35.491 [17476] dbg: config: added tld list - clinique clothing cloud club clubmed cm cn co coach codes coffee college
173Dec  2 21:09:35.491 [17476] dbg: config: added tld list - cologne com comcast commbank community company compare computer comsec condos
174Dec  2 21:09:35.492 [17476] dbg: config: added tld list - construction consulting contact contractors cooking cookingchannel cool coop
175Dec  2 21:09:35.493 [17476] dbg: config: added tld list - corsica country coupon coupons courses cr credit creditcard creditunion cricket
176Dec  2 21:09:35.493 [17476] dbg: config: added tld list - crown crs cruise cruises csc cu cuisinella cv cw cx cy cymru cyou cz dabur dad
177Dec  2 21:09:35.494 [17476] dbg: config: added tld list - dance data date dating datsun day dclk dds de deal dealer deals degree delivery
178Dec  2 21:09:35.495 [17476] dbg: config: added tld list - dell deloitte delta democrat dental dentist desi design dev dhl diamonds diet
179Dec  2 21:09:35.495 [17476] dbg: config: added tld list - digital direct directory discount discover dish diy dj dk dm dnp do docs doctor
180Dec  2 21:09:35.496 [17476] dbg: config: added tld list - dodge dog doha domains dot download drive dtv dubai duck dunlop duns dupont
181Dec  2 21:09:35.497 [17476] dbg: config: added tld list - durban dvag dvr dz earth eat ec eco edeka edu education ee eg email emerck
182Dec  2 21:09:35.498 [17476] dbg: config: added tld list - energy engineer engineering enterprises epost epson equipment er ericsson erni
183Dec  2 21:09:35.499 [17476] dbg: config: added tld list - es esq estate esurance et etisalat eu eurovision eus events everbank exchange
184Dec  2 21:09:35.499 [17476] dbg: config: added tld list - expert exposed express extraspace fage fail fairwinds faith family fan fans
185Dec  2 21:09:35.500 [17476] dbg: config: added tld list - farm farmers fashion fast fedex feedback ferrari ferrero fi fiat fidelity fido
186Dec  2 21:09:35.501 [17476] dbg: config: added tld list - film final finance financial fire firestone firmdale fish fishing fit fitness
187Dec  2 21:09:35.501 [17476] dbg: config: added tld list - fj fk flickr flights flir florist flowers fly fm fo foo food foodnetwork
188Dec  2 21:09:35.502 [17476] dbg: config: added tld list - football ford forex forsale forum foundation fox fr free fresenius frl frogans
189Dec  2 21:09:35.503 [17476] dbg: config: added tld list - frontdoor frontier ftr fujitsu fujixerox fun fund furniture futbol fyi ga gal
190Dec  2 21:09:35.504 [17476] dbg: config: added tld list - gallery gallo gallup game games gap garden gb gbiz gd gdn ge gea gent genting
191Dec  2 21:09:35.504 [17476] dbg: config: added tld list - george gf gg ggee gh gi gift gifts gives giving gl glade glass gle global globo
192Dec  2 21:09:35.505 [17476] dbg: config: added tld list - gm gmail gmbh gmo gmx gn godaddy gold goldpoint golf goo goodhands goodyear
193Dec  2 21:09:35.506 [17476] dbg: config: added tld list - goog google gop got gov gp gq gr grainger graphics gratis green gripe grocery
194Dec  2 21:09:35.506 [17476] dbg: config: added tld list - group gs gt gu guardian gucci guge guide guitars guru gw gy hair hamburg
195Dec  2 21:09:35.507 [17476] dbg: config: added tld list - hangout haus hbo hdfc hdfcbank health healthcare help helsinki here hermes hgtv
196Dec  2 21:09:35.508 [17476] dbg: config: added tld list - hiphop hisamitsu hitachi hiv hk hkt hm hn hockey holdings holiday homedepot
197Dec  2 21:09:35.509 [17476] dbg: config: added tld list - homegoods homes homesense honda honeywell horse hospital host hosting hot
198Dec  2 21:09:35.509 [17476] dbg: config: added tld list - hoteles hotels hotmail house how hr hsbc ht hu hughes hyatt hyundai ibm icbc
199Dec  2 21:09:35.510 [17476] dbg: config: added tld list - ice icu id ie ieee ifm ikano il im imamat imdb immo immobilien in inc
200Dec  2 21:09:35.511 [17476] dbg: config: added tld list - industries infiniti info ing ink institute insurance insure int intel
201Dec  2 21:09:35.511 [17476] dbg: config: added tld list - international intuit investments io ipiranga iq ir irish is iselect ismaili ist
202Dec  2 21:09:35.512 [17476] dbg: config: added tld list - istanbul it itau itv iveco jaguar java jcb jcp je jeep jetzt jewelry jio jlc
203Dec  2 21:09:35.513 [17476] dbg: config: added tld list - jll jm jmp jnj jo jobs joburg jot joy jp jpmorgan jprs juegos juniper kaufen
204Dec  2 21:09:35.514 [17476] dbg: config: added tld list - kddi ke kerryhotels kerrylogistics kerryproperties kfh kg kh ki kia kim kinder
205Dec  2 21:09:35.514 [17476] dbg: config: added tld list - kindle kitchen kiwi km kn koeln komatsu kosher kp kpmg kpn kr krd kred
206Dec  2 21:09:35.515 [17476] dbg: config: added tld list - kuokgroup kw ky kyoto kz la lacaixa ladbrokes lamborghini lamer lancaster
207Dec  2 21:09:35.516 [17476] dbg: config: added tld list - lancia lancome land landrover lanxess lasalle lat latino latrobe law lawyer lb
208Dec  2 21:09:35.516 [17476] dbg: config: added tld list - lc lds lease leclerc lefrak legal lego lexus lgbt li liaison lidl life
209Dec  2 21:09:35.517 [17476] dbg: config: added tld list - lifeinsurance lifestyle lighting like lilly limited limo lincoln linde link
210Dec  2 21:09:35.518 [17476] dbg: config: added tld list - lipsy live living lixil lk llc loan loans locker locus loft lol london lotte
211Dec  2 21:09:35.519 [17476] dbg: config: added tld list - lotto love lpl lplfinancial lr ls lt ltd ltda lu lundbeck lupin luxe luxury lv
212Dec  2 21:09:35.519 [17476] dbg: config: added tld list - ly ma macys madrid maif maison makeup man management mango map market marketing
213Dec  2 21:09:35.520 [17476] dbg: config: added tld list - markets marriott marshalls maserati mattel mba mc mckinsey md me med media meet
214Dec  2 21:09:35.521 [17476] dbg: config: added tld list - melbourne meme memorial men menu merckmsd metlife mg mh miami microsoft mil
215Dec  2 21:09:35.522 [17476] dbg: config: added tld list - mini mint mit mitsubishi mk ml mlb mls mm mma mn mo mobi mobile mobily moda moe
216Dec  2 21:09:35.522 [17476] dbg: config: added tld list - moi mom monash money monster mopar mormon mortgage moscow moto motorcycles mov
217Dec  2 21:09:35.523 [17476] dbg: config: added tld list - movie movistar mp mq mr ms msd mt mtn mtr mu museum mutual mv mw mx my mz na
218Dec  2 21:09:35.524 [17476] dbg: config: added tld list - nab nadex nagoya name nationwide natura navy nba nc ne nec net netbank netflix
219Dec  2 21:09:35.525 [17476] dbg: config: added tld list - network neustar new newholland news next nextdirect nexus nf nfl ng ngo nhk ni
220Dec  2 21:09:35.526 [17476] dbg: config: added tld list - nico nike nikon ninja nissan nissay nl no nokia northwesternmutual norton now
221Dec  2 21:09:35.526 [17476] dbg: config: added tld list - nowruz nowtv np nr nra nrw ntt nu nyc nz obi observer off office okinawa olayan
222Dec  2 21:09:35.527 [17476] dbg: config: added tld list - olayangroup oldnavy ollo om omega one ong onl online onyourside ooo open oracle
223Dec  2 21:09:35.528 [17476] dbg: config: added tld list - orange org organic origins osaka otsuka ott ovh pa page panasonic panerai paris
224Dec  2 21:09:35.529 [17476] dbg: config: added tld list - pars partners parts party passagens pay pccw pe pet pf pfizer pg ph pharmacy
225Dec  2 21:09:35.529 [17476] dbg: config: added tld list - phd philips phone photo photography photos physio piaget pics pictet pictures
226Dec  2 21:09:35.530 [17476] dbg: config: added tld list - pid pin ping pink pioneer pizza pk pl place play playstation plumbing plus pm
227Dec  2 21:09:35.531 [17476] dbg: config: added tld list - pn pnc pohl poker politie porn post pr pramerica praxi press prime pro prod
228Dec  2 21:09:35.532 [17476] dbg: config: added tld list - productions prof progressive promo properties property protection pru
229Dec  2 21:09:35.533 [17476] dbg: config: added tld list - prudential ps pt pub pw pwc py qa qpon quebec quest qvc racing radio raid re
230Dec  2 21:09:35.533 [17476] dbg: config: added tld list - read realestate realtor realty recipes red redstone redumbrella rehab reise
231Dec  2 21:09:35.534 [17476] dbg: config: added tld list - reisen reit reliance ren rent rentals repair report republican rest restaurant
232Dec  2 21:09:35.535 [17476] dbg: config: added tld list - review reviews rexroth rich richardli ricoh rightathome ril rio rip rmit ro
233Dec  2 21:09:35.535 [17476] dbg: config: added tld list - rocher rocks rodeo rogers room rs rsvp ru rugby ruhr run rw rwe ryukyu sa
234Dec  2 21:09:35.536 [17476] dbg: config: added tld list - saarland safe safety sakura sale salon samsclub samsung sandvik sandvikcoromant
235Dec  2 21:09:35.537 [17476] dbg: config: added tld list - sanofi sap sarl sas save saxo sb sbi sbs sc sca scb schaeffler schmidt
236Dec  2 21:09:35.538 [17476] dbg: config: added tld list - scholarships school schule schwarz science scjohnson scor scot sd se search
237Dec  2 21:09:35.538 [17476] dbg: config: added tld list - seat secure security seek select sener services ses seven sew sex sexy sfr sg
238Dec  2 21:09:35.539 [17476] dbg: config: added tld list - sh shangrila sharp shaw shell shia shiksha shoes shop shopping shouji show
239Dec  2 21:09:35.540 [17476] dbg: config: added tld list - showtime shriram si silk sina singles site sj sk ski skin sky skype sl sling sm
240Dec  2 21:09:35.541 [17476] dbg: config: added tld list - smart smile sn sncf so soccer social softbank software sohu solar solutions
241Dec  2 21:09:35.541 [17476] dbg: config: added tld list - song sony soy space spiegel sport spot spreadbetting sr srl srt st stada
242Dec  2 21:09:35.542 [17476] dbg: config: added tld list - staples star starhub statebank statefarm statoil stc stcgroup stockholm storage
243Dec  2 21:09:35.543 [17476] dbg: config: added tld list - store stream studio study style su sucks supplies supply support surf surgery
244Dec  2 21:09:35.543 [17476] dbg: config: added tld list - suzuki sv swatch swiftcover swiss sx sy sydney symantec systems sz tab taipei
245Dec  2 21:09:35.544 [17476] dbg: config: added tld list - talk taobao target tatamotors tatar tattoo tax taxi tc tci td tdk team tech
246Dec  2 21:09:35.545 [17476] dbg: config: added tld list - technology tel telefonica temasek tennis teva tf tg th thd theater theatre tiaa
247Dec  2 21:09:35.546 [17476] dbg: config: added tld list - tickets tienda tiffany tips tires tirol tj tjmaxx tjx tk tkmaxx tl tm tmall tn
248Dec  2 21:09:35.546 [17476] dbg: config: added tld list - to today tokyo tools top toray toshiba total tours town toyota toys tr trade
249Dec  2 21:09:35.547 [17476] dbg: config: added tld list - trading training travel travelchannel travelers travelersinsurance trust trv tt
250Dec  2 21:09:35.548 [17476] dbg: config: added tld list - tube tui tunes tushu tv tvs tw tz ua ubank ubs uconnect ug uk unicom university
251Dec  2 21:09:35.549 [17476] dbg: config: added tld list - uno uol ups us uy uz va vacations vana vanguard vc ve vegas ventures verisign
252Dec  2 21:09:35.549 [17476] dbg: config: added tld list - versicherung vet vg vi viajes video vig viking villas vin vip virgin visa
253Dec  2 21:09:35.550 [17476] dbg: config: added tld list - vision vista vistaprint viva vivo vlaanderen vn vodka volkswagen volvo vote
254Dec  2 21:09:35.551 [17476] dbg: config: added tld list - voting voto voyage vu vuelos wales walmart walter wang wanggou warman watch
255Dec  2 21:09:35.552 [17476] dbg: config: added tld list - watches weather weatherchannel webcam weber website wed wedding weibo weir wf
256Dec  2 21:09:35.552 [17476] dbg: config: added tld list - whoswho wien wiki williamhill win windows wine winners wme wolterskluwer
257Dec  2 21:09:35.553 [17476] dbg: config: added tld list - woodside work works world wow ws wtc wtf xbox xerox xfinity xihuan xin xxx xyz
258Dec  2 21:09:35.554 [17476] dbg: config: added tld list - yachts yahoo yamaxun yandex ye yodobashi yoga yokohama you youtube yt yun za
259Dec  2 21:09:35.554 [17476] dbg: config: added tld list - zappos zara zero zip zippo zm zone zuerich zw
260Dec  2 21:09:35.647 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_body_tests.cf
261Dec  2 21:09:35.648 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_body_tests.cf" for included file
262Dec  2 21:09:35.649 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_body_tests.cf
263Dec  2 21:09:35.664 [17476] dbg: config: body eval rule name is MPART_ALT_DIFF function is multipart_alternative_difference('99', '100')
264Dec  2 21:09:35.665 [17476] dbg: config: body eval rule name is MPART_ALT_DIFF_COUNT function is multipart_alternative_difference_count('3', '1')
265Dec  2 21:09:35.667 [17476] dbg: config: body eval rule name is BLANK_LINES_80_90 function is check_blank_line_ratio('80','90','4')
266Dec  2 21:09:35.669 [17476] dbg: config: body eval rule name is __TVD_SPACE_RATIO function is tvd_vertical_words('0','10')
267Dec  2 21:09:35.671 [17476] dbg: config: body eval rule name is MULTIPART_ALT_NON_TEXT function is check_ma_non_text()
268Dec  2 21:09:35.672 [17476] dbg: config: body eval rule name is CHARSET_FARAWAY function is check_for_faraway_charset()
269Dec  2 21:09:35.676 [17476] dbg: config: body eval rule name is MISSING_MIME_HB_SEP function is check_msg_parse_flags('missing_mime_head_body_separator')
270Dec  2 21:09:35.678 [17476] dbg: config: body eval rule name is MIME_HTML_MOSTLY function is check_mime_multipart_ratio('0.00','0.01')
271Dec  2 21:09:35.679 [17476] dbg: config: body eval rule name is MIME_HTML_ONLY function is check_for_mime_html_only()
272Dec  2 21:09:35.681 [17476] dbg: config: body eval rule name is MIME_BAD_ISO_CHARSET function is check_for_mime('mime_bad_iso_charset')
273Dec  2 21:09:35.683 [17476] dbg: config: body eval rule name is HTTPS_IP_MISMATCH function is check_https_ip_mismatch()
274Dec  2 21:09:35.684 [17476] dbg: config: body eval rule name is URI_TRUNCATED function is check_uri_truncated()
275Dec  2 21:09:35.686 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_compensate.cf
276Dec  2 21:09:35.687 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_compensate.cf" for included file
277Dec  2 21:09:35.687 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_compensate.cf
278Dec  2 21:09:35.693 [17476] dbg: config: header eval rule name is ALL_TRUSTED function is check_all_trusted()
279Dec  2 21:09:35.694 [17476] dbg: config: header eval rule name is NO_RELAYS function is check_no_relays()
280Dec  2 21:09:35.696 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_dnsbl_tests.cf
281Dec  2 21:09:35.697 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_dnsbl_tests.cf" for included file
282Dec  2 21:09:35.698 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_dnsbl_tests.cf
283Dec  2 21:09:35.703 [17476] dbg: config: header eval rule name is __RCVD_IN_SORBS function is check_rbl('sorbs', 'dnsbl.sorbs.net.')
284Dec  2 21:09:35.704 [17476] dbg: config: header eval rule name is RCVD_IN_SORBS_HTTP function is check_rbl_sub('sorbs', '127.0.0.2')
285Dec  2 21:09:35.706 [17476] dbg: config: header eval rule name is RCVD_IN_SORBS_SOCKS function is check_rbl_sub('sorbs', '127.0.0.3')
286Dec  2 21:09:35.708 [17476] dbg: config: header eval rule name is RCVD_IN_SORBS_MISC function is check_rbl_sub('sorbs', '127.0.0.4')
287Dec  2 21:09:35.709 [17476] dbg: config: header eval rule name is RCVD_IN_SORBS_SMTP function is check_rbl_sub('sorbs', '127.0.0.5')
288Dec  2 21:09:35.711 [17476] dbg: config: header eval rule name is RCVD_IN_SORBS_WEB function is check_rbl_sub('sorbs', '127.0.0.7')
289Dec  2 21:09:35.713 [17476] dbg: config: header eval rule name is RCVD_IN_SORBS_BLOCK function is check_rbl_sub('sorbs', '127.0.0.8')
290Dec  2 21:09:35.714 [17476] dbg: config: header eval rule name is RCVD_IN_SORBS_ZOMBIE function is check_rbl_sub('sorbs', '127.0.0.9')
291Dec  2 21:09:35.716 [17476] dbg: config: header eval rule name is RCVD_IN_SORBS_DUL function is check_rbl('sorbs-lastexternal', 'dnsbl.sorbs.net.', '127.0.0.10')
292Dec  2 21:09:35.717 [17476] dbg: config: header eval rule name is __RCVD_IN_ZEN function is check_rbl('zen', 'zen.spamhaus.org.')
293Dec  2 21:09:35.719 [17476] dbg: config: header eval rule name is RCVD_IN_SBL function is check_rbl_sub('zen', '127.0.0.2')
294Dec  2 21:09:35.721 [17476] dbg: config: header eval rule name is RCVD_IN_XBL function is check_rbl('zen-lastexternal', 'zen.spamhaus.org.', '^127\.0\.0\.[45678]$')
295Dec  2 21:09:35.722 [17476] dbg: config: header eval rule name is RCVD_IN_PBL function is check_rbl('zen-lastexternal', 'zen.spamhaus.org.', '^127\.0\.0\.1[01]$')
296Dec  2 21:09:35.724 [17476] dbg: config: header eval rule name is RCVD_IN_SBL_CSS function is check_rbl_sub('zen', '127.0.0.3')
297Dec  2 21:09:35.725 [17476] dbg: config: header eval rule name is RCVD_IN_BL_SPAMCOP_NET function is check_rbl_txt('spamcop', 'bl.spamcop.net.', '(?i:spamcop)')
298Dec  2 21:09:35.727 [17476] dbg: config: header eval rule name is RCVD_IN_MAPS_RBL function is check_rbl('rblplus', 'activationcode.r.mail-abuse.com.', '1')
299Dec  2 21:09:35.729 [17476] dbg: config: header eval rule name is RCVD_IN_MAPS_DUL function is check_rbl('rblplus-lastexternal', 'activationcode.r.mail-abuse.com.', '2')
300Dec  2 21:09:35.730 [17476] dbg: config: header eval rule name is RCVD_IN_MAPS_RSS function is check_rbl_sub('rblplus', '4')
301Dec  2 21:09:35.732 [17476] dbg: config: header eval rule name is RCVD_IN_MAPS_OPS function is check_rbl_sub('rblplus', '8')
302Dec  2 21:09:35.733 [17476] dbg: config: header eval rule name is RCVD_IN_MAPS_NML function is check_rbl('nml', 'nonconfirm.mail-abuse.com.')
303Dec  2 21:09:35.735 [17476] dbg: config: header eval rule name is __RCVD_IN_IADB function is check_rbl('iadb-firsttrusted', 'iadb.isipp.com.')
304Dec  2 21:09:35.736 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_VOUCHED function is check_rbl_sub('iadb-firsttrusted', '127.0.1.255')
305Dec  2 21:09:35.738 [17476] dbg: config: header eval rule name is RCVD_IN_RP_CERTIFIED function is check_rbl_txt('ssc-firsttrusted', 'sa-trusted.bondedsender.org.')
306Dec  2 21:09:35.739 [17476] dbg: config: header eval rule name is RCVD_IN_RP_SAFE function is check_rbl_txt('ssc-firsttrusted','sa-accredit.habeas.com.')
307Dec  2 21:09:35.741 [17476] dbg: config: header eval rule name is RCVD_IN_RP_RNBL function is check_rbl('rnbl-lastexternal','bl.score.senderscore.com.')
308Dec  2 21:09:35.748 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_drugs.cf
309Dec  2 21:09:35.749 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_drugs.cf" for included file
310Dec  2 21:09:35.750 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_drugs.cf
311Dec  2 21:09:35.852 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_dynrdns.cf
312Dec  2 21:09:35.853 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_dynrdns.cf" for included file
313Dec  2 21:09:35.854 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_dynrdns.cf
314Dec  2 21:09:35.897 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_fake_helo_tests.cf
315Dec  2 21:09:35.898 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_fake_helo_tests.cf" for included file
316Dec  2 21:09:35.899 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_fake_helo_tests.cf
317Dec  2 21:09:35.926 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_freemail.cf
318Dec  2 21:09:35.926 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_freemail.cf" for included file
319Dec  2 21:09:35.927 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_freemail.cf
320Dec  2 21:09:35.932 [17476] dbg: config: header eval rule name is __freemail_replyto function is check_freemail_replyto('replyto')
321Dec  2 21:09:35.936 [17476] dbg: config: header eval rule name is __freemail_reply function is check_freemail_replyto('reply')
322Dec  2 21:09:35.939 [17476] dbg: config: header eval rule name is FREEMAIL_FROM function is check_freemail_from()
323Dec  2 21:09:35.941 [17476] dbg: config: header eval rule name is FREEMAIL_ENVFROM_END_DIGIT function is check_freemail_header('EnvelopeFrom', '\d@')
324Dec  2 21:09:35.942 [17476] dbg: config: header eval rule name is FREEMAIL_REPLYTO_END_DIGIT function is check_freemail_header('Reply-To', '\d@')
325Dec  2 21:09:35.944 [17476] dbg: config: header eval rule name is __freemail_hdr_replyto function is check_freemail_header('Reply-To')
326Dec  2 21:09:35.947 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_freemail_domains.cf
327Dec  2 21:09:35.947 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_freemail_domains.cf" for included file
328Dec  2 21:09:35.949 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_freemail_domains.cf
329Dec  2 21:09:35.956 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::ExtractText=HASH(0x1d943d0) implements 'parse_config', priority 0
330Dec  2 21:09:35.958 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x1a97900) implements 'parse_config', priority 0
331Dec  2 21:09:35.958 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::HashBL=HASH(0x1a98080) implements 'parse_config', priority 0
332Dec  2 21:09:36.119 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_freemail_mailcom_domains.cf
333Dec  2 21:09:36.120 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_freemail_mailcom_domains.cf" for included file
334Dec  2 21:09:36.128 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_freemail_mailcom_domains.cf
335Dec  2 21:09:36.144 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_head_tests.cf
336Dec  2 21:09:36.144 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_head_tests.cf" for included file
337Dec  2 21:09:36.146 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_head_tests.cf
338Dec  2 21:09:36.273 [17476] dbg: config: header eval rule name is __FORGED_AOL_RCVD function is check_for_fake_aol_relay_in_rcvd()
339Dec  2 21:09:36.274 [17476] dbg: config: header eval rule name is CHARSET_FARAWAY_HEADER function is check_for_faraway_charset_in_headers()
340Dec  2 21:09:36.276 [17476] dbg: config: header eval rule name is __SUBJ_ILLEGAL_CHARS function is check_illegal_chars('Subject','0.00','2')
341Dec  2 21:09:36.278 [17476] dbg: config: header eval rule name is FROM_ILLEGAL_CHARS function is check_illegal_chars('From','0.20','2')
342Dec  2 21:09:36.280 [17476] dbg: config: header eval rule name is __HEAD_ILLEGAL_CHARS function is check_illegal_chars('ALL','0.010','2')
343Dec  2 21:09:36.282 [17476] dbg: config: header eval rule name is __FORGED_HOTMAIL_RCVD function is check_for_forged_hotmail_received_headers()
344Dec  2 21:09:36.283 [17476] dbg: config: header eval rule name is FORGED_HOTMAIL_RCVD2 function is check_for_no_hotmail_received_headers()
345Dec  2 21:09:36.284 [17476] dbg: config: header eval rule name is __FORGED_EUDORAMAIL_RCVD function is check_for_forged_eudoramail_received_headers()
346Dec  2 21:09:36.285 [17476] dbg: config: header eval rule name is FORGED_YAHOO_RCVD function is check_for_forged_yahoo_received_headers()
347Dec  2 21:09:36.287 [17476] dbg: config: header eval rule name is FORGED_GMAIL_RCVD function is check_for_forged_gmail_received_headers()
348Dec  2 21:09:36.289 [17476] dbg: config: header eval rule name is __FORGED_JUNO_RCVD function is check_for_forged_juno_received_headers()
349Dec  2 21:09:36.289 [17476] dbg: config: header eval rule name is SORTED_RECIPS function is sorted_recipients()
350Dec  2 21:09:36.291 [17476] dbg: config: header eval rule name is SUSPICIOUS_RECIPS function is similar_recipients('0.65','undef')
351Dec  2 21:09:36.292 [17476] dbg: config: header eval rule name is MISSING_HEADERS function is check_for_missing_to_header()
352Dec  2 21:09:36.294 [17476] dbg: config: header eval rule name is DATE_IN_PAST_03_06 function is check_for_shifted_date('-6', '-3')
353Dec  2 21:09:36.295 [17476] dbg: config: header eval rule name is DATE_IN_PAST_06_12 function is check_for_shifted_date('-12', '-6')
354Dec  2 21:09:36.296 [17476] dbg: config: header eval rule name is DATE_IN_PAST_12_24 function is check_for_shifted_date('-24', '-12')
355Dec  2 21:09:36.298 [17476] dbg: config: header eval rule name is DATE_IN_PAST_24_48 function is check_for_shifted_date('-48', '-24')
356Dec  2 21:09:36.299 [17476] dbg: config: header eval rule name is DATE_IN_PAST_96_XX function is check_for_shifted_date('undef', '-96')
357Dec  2 21:09:36.301 [17476] dbg: config: header eval rule name is DATE_IN_FUTURE_03_06 function is check_for_shifted_date('3', '6')
358Dec  2 21:09:36.302 [17476] dbg: config: header eval rule name is DATE_IN_FUTURE_06_12 function is check_for_shifted_date('6', '12')
359Dec  2 21:09:36.303 [17476] dbg: config: header eval rule name is DATE_IN_FUTURE_12_24 function is check_for_shifted_date('12', '24')
360Dec  2 21:09:36.305 [17476] dbg: config: header eval rule name is DATE_IN_FUTURE_24_48 function is check_for_shifted_date('24', '48')
361Dec  2 21:09:36.306 [17476] dbg: config: header eval rule name is DATE_IN_FUTURE_48_96 function is check_for_shifted_date('48', '96')
362Dec  2 21:09:36.309 [17476] dbg: config: header eval rule name is UNRESOLVED_TEMPLATE function is check_unresolved_template()
363Dec  2 21:09:36.310 [17476] dbg: config: header eval rule name is SUBJ_ALL_CAPS function is subject_is_all_caps()
364Dec  2 21:09:36.312 [17476] dbg: config: header eval rule name is LOCALPART_IN_SUBJECT function is check_for_to_in_subject('user')
365Dec  2 21:09:36.313 [17476] dbg: config: header eval rule name is MSGID_OUTLOOK_INVALID function is check_outlook_message_id()
366Dec  2 21:09:36.315 [17476] dbg: config: header eval rule name is HEADER_COUNT_CTYPE function is check_header_count_range('Content-Type','2','999')
367Dec  2 21:09:36.317 [17476] dbg: config: header eval rule name is HEAD_LONG function is check_msg_parse_flags('truncated_header')
368Dec  2 21:09:36.319 [17476] dbg: config: header eval rule name is MISSING_HB_SEP function is check_msg_parse_flags('missing_head_body_separator')
369Dec  2 21:09:36.321 [17476] dbg: config: header eval rule name is __UNPARSEABLE_RELAY_COUNT function is check_relays_unparseable()
370Dec  2 21:09:36.324 [17476] dbg: config: header eval rule name is RCVD_HELO_IP_MISMATCH function is helo_ip_mismatch()
371Dec  2 21:09:36.325 [17476] dbg: config: header eval rule name is __FORGED_RCVD_TRAIL function is check_for_forged_received_trail()
372Dec  2 21:09:36.326 [17476] dbg: config: header eval rule name is NO_RDNS_DOTCOM_HELO function is check_for_no_rdns_dotcom_helo()
373Dec  2 21:09:36.328 [17476] dbg: config: header eval rule name is __ENV_AND_HDR_FROM_MATCH function is check_for_matching_env_and_hdr_from()
374Dec  2 21:09:36.330 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_html_tests.cf
375Dec  2 21:09:36.330 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_html_tests.cf" for included file
376Dec  2 21:09:36.331 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_html_tests.cf
377Dec  2 21:09:36.353 [17476] dbg: config: body eval rule name is HTML_MESSAGE function is html_test('html')
378Dec  2 21:09:36.355 [17476] dbg: config: body eval rule name is HTML_COMMENT_SHORT function is html_text_match('comment', '<!(?!-).{0,6}>')
379Dec  2 21:09:36.356 [17476] dbg: config: body eval rule name is HTML_COMMENT_SAVED_URL function is html_text_match('comment', '<!-- saved from url=\(\d{4}\)')
380Dec  2 21:09:36.358 [17476] dbg: config: body eval rule name is HTML_EMBEDS function is html_test('embeds')
381Dec  2 21:09:36.359 [17476] dbg: config: body eval rule name is HTML_EXTRA_CLOSE function is html_range('closed_extra_ratio', '0.09', 'inf')
382Dec  2 21:09:36.361 [17476] dbg: config: body eval rule name is HTML_FONT_SIZE_LARGE function is html_range('max_size', '5', '6')
383Dec  2 21:09:36.362 [17476] dbg: config: body eval rule name is HTML_FONT_SIZE_HUGE function is html_range('max_size', '6', 'inf')
384Dec  2 21:09:36.364 [17476] dbg: config: body eval rule name is HTML_FONT_LOW_CONTRAST function is html_test('font_low_contrast')
385Dec  2 21:09:36.365 [17476] dbg: config: body eval rule name is HTML_FONT_FACE_BAD function is html_test('font_face_bad')
386Dec  2 21:09:36.366 [17476] dbg: config: body eval rule name is HTML_FORMACTION_MAILTO function is html_test('form_action_mailto')
387Dec  2 21:09:36.368 [17476] dbg: config: body eval rule name is HTML_IMAGE_ONLY_04 function is html_image_only('0000','0400')
388Dec  2 21:09:36.369 [17476] dbg: config: body eval rule name is HTML_IMAGE_ONLY_08 function is html_image_only('0400','0800')
389Dec  2 21:09:36.369 [17476] dbg: config: body eval rule name is HTML_IMAGE_ONLY_12 function is html_image_only('0800','1200')
390Dec  2 21:09:36.370 [17476] dbg: config: body eval rule name is HTML_IMAGE_ONLY_16 function is html_image_only('1200','1600')
391Dec  2 21:09:36.371 [17476] dbg: config: body eval rule name is HTML_IMAGE_ONLY_20 function is html_image_only('1600','2000')
392Dec  2 21:09:36.371 [17476] dbg: config: body eval rule name is HTML_IMAGE_ONLY_24 function is html_image_only('2000','2400')
393Dec  2 21:09:36.372 [17476] dbg: config: body eval rule name is HTML_IMAGE_ONLY_28 function is html_image_only('2400','2800')
394Dec  2 21:09:36.372 [17476] dbg: config: body eval rule name is HTML_IMAGE_ONLY_32 function is html_image_only('2800','3200')
395Dec  2 21:09:36.378 [17476] dbg: config: body eval rule name is HTML_IMAGE_RATIO_02 function is html_image_ratio('0.000','0.002')
396Dec  2 21:09:36.379 [17476] dbg: config: body eval rule name is HTML_IMAGE_RATIO_04 function is html_image_ratio('0.002','0.004')
397Dec  2 21:09:36.379 [17476] dbg: config: body eval rule name is HTML_IMAGE_RATIO_06 function is html_image_ratio('0.004','0.006')
398Dec  2 21:09:36.380 [17476] dbg: config: body eval rule name is HTML_IMAGE_RATIO_08 function is html_image_ratio('0.006','0.008')
399Dec  2 21:09:36.383 [17476] dbg: config: body eval rule name is HTML_OBFUSCATE_05_10 function is html_range('obfuscation_ratio','.05','.1')
400Dec  2 21:09:36.384 [17476] dbg: config: body eval rule name is HTML_OBFUSCATE_10_20 function is html_range('obfuscation_ratio','.1','.2')
401Dec  2 21:09:36.385 [17476] dbg: config: body eval rule name is HTML_OBFUSCATE_20_30 function is html_range('obfuscation_ratio','.2','.3')
402Dec  2 21:09:36.385 [17476] dbg: config: body eval rule name is HTML_OBFUSCATE_30_40 function is html_range('obfuscation_ratio','.3','.4')
403Dec  2 21:09:36.386 [17476] dbg: config: body eval rule name is HTML_OBFUSCATE_50_60 function is html_range('obfuscation_ratio','.5','.6')
404Dec  2 21:09:36.387 [17476] dbg: config: body eval rule name is HTML_OBFUSCATE_70_80 function is html_range('obfuscation_ratio','.7','.8')
405Dec  2 21:09:36.387 [17476] dbg: config: body eval rule name is HTML_OBFUSCATE_90_100 function is html_range('obfuscation_ratio','.9','1.0')
406Dec  2 21:09:36.392 [17476] dbg: config: body eval rule name is HTML_TAG_BALANCE_BODY function is html_tag_balance('body', '!= 0')
407Dec  2 21:09:36.394 [17476] dbg: config: body eval rule name is HTML_TAG_BALANCE_HEAD function is html_tag_balance('head', '!= 0')
408Dec  2 21:09:36.395 [17476] dbg: config: body eval rule name is HTML_TAG_EXIST_BGSOUND function is html_tag_exists('bgsound')
409Dec  2 21:09:36.397 [17476] dbg: config: body eval rule name is HTML_BADTAG_40_50 function is html_range('bad_tag_ratio','0.40','0.50')
410Dec  2 21:09:36.398 [17476] dbg: config: body eval rule name is HTML_BADTAG_50_60 function is html_range('bad_tag_ratio','0.50','0.60')
411Dec  2 21:09:36.398 [17476] dbg: config: body eval rule name is HTML_BADTAG_60_70 function is html_range('bad_tag_ratio','0.60','0.70')
412Dec  2 21:09:36.399 [17476] dbg: config: body eval rule name is HTML_BADTAG_90_100 function is html_range('bad_tag_ratio','0.90','1.00')
413Dec  2 21:09:36.402 [17476] dbg: config: body eval rule name is HTML_NONELEMENT_30_40 function is html_range('non_element_ratio','0.30','0.40')
414Dec  2 21:09:36.403 [17476] dbg: config: body eval rule name is HTML_NONELEMENT_40_50 function is html_range('non_element_ratio','0.40','0.50')
415Dec  2 21:09:36.404 [17476] dbg: config: body eval rule name is HTML_NONELEMENT_60_70 function is html_range('non_element_ratio','0.60','0.70')
416Dec  2 21:09:36.404 [17476] dbg: config: body eval rule name is HTML_NONELEMENT_80_90 function is html_range('non_element_ratio','0.80','0.90')
417Dec  2 21:09:36.408 [17476] dbg: config: body eval rule name is __HTML_LINK_IMAGE function is html_text_match('anchor', '<img>')
418Dec  2 21:09:36.409 [17476] dbg: config: body eval rule name is __HTML_LENGTH_0000_1024 function is html_range('length', '0', '1024')
419Dec  2 21:09:36.409 [17476] dbg: config: body eval rule name is __HTML_LENGTH_1024_1536 function is html_range('length', '1024', '1536')
420Dec  2 21:09:36.410 [17476] dbg: config: body eval rule name is __HTML_LENGTH_1536_2048 function is html_range('length', '1536', '2048')
421Dec  2 21:09:36.411 [17476] dbg: config: body eval rule name is __HTML_LENGTH_512 function is html_eval('length', '< 512')
422Dec  2 21:09:36.411 [17476] dbg: config: body eval rule name is __COMMENT_EXISTS function is html_text_match('comment', '<!.*?>')
423Dec  2 21:09:36.412 [17476] dbg: config: body eval rule name is __HTML_LENGTH_384 function is html_eval('length', '< 384')
424Dec  2 21:09:36.412 [17476] dbg: config: body eval rule name is __TAG_EXISTS_CENTER function is html_tag_exists('center')
425Dec  2 21:09:36.413 [17476] dbg: config: body eval rule name is __HTML_TITLE_120 function is html_text_match('title', '.{120}')
426Dec  2 21:09:36.414 [17476] dbg: config: body eval rule name is __HTML_TITLE_SUBJ_DIFF function is html_title_subject_ratio('3.5')
427Dec  2 21:09:36.415 [17476] dbg: config: body eval rule name is __HTML_CHARSET_FARAWAY function is html_charset_faraway()
428Dec  2 21:09:36.416 [17476] dbg: config: body eval rule name is HTML_IFRAME_SRC function is check_iframe_src()
429Dec  2 21:09:36.418 [17476] dbg: config: body eval rule name is __MIME_ATTACHMENT function is check_for_mime('mime_attachment')
430Dec  2 21:09:36.419 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_imageinfo.cf
431Dec  2 21:09:36.420 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_imageinfo.cf" for included file
432Dec  2 21:09:36.421 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_imageinfo.cf
433Dec  2 21:09:36.425 [17476] dbg: config: body eval rule name is __DC_IMG_TEXT_RATIO function is image_to_text_ratio('all', '0.000', '0.008')
434Dec  2 21:09:36.428 [17476] dbg: config: body eval rule name is __GIF_ATTACH_1 function is image_count('gif','1','1')
435Dec  2 21:09:36.429 [17476] dbg: config: body eval rule name is __GIF_ATTACH_2P function is image_count('gif','2')
436Dec  2 21:09:36.430 [17476] dbg: config: body eval rule name is __PNG_ATTACH_1 function is image_count('png','1','1')
437Dec  2 21:09:36.430 [17476] dbg: config: body eval rule name is __PNG_ATTACH_2P function is image_count('png','2')
438Dec  2 21:09:36.431 [17476] dbg: config: body eval rule name is __JPEG_ATTACH_1 function is image_count('jpeg',1,1)
439Dec  2 21:09:36.432 [17476] dbg: config: body eval rule name is __JPEG_ATTACH_2P function is image_count('jpeg',2)
440Dec  2 21:09:36.432 [17476] dbg: config: body eval rule name is __GIF_AREA_180K function is pixel_coverage('gif','180000','475000')
441Dec  2 21:09:36.433 [17476] dbg: config: body eval rule name is __PNG_AREA_180K function is pixel_coverage('png','180000','475000')
442Dec  2 21:09:36.444 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_mailspike.cf
443Dec  2 21:09:36.444 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_mailspike.cf" for included file
444Dec  2 21:09:36.445 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_mailspike.cf
445Dec  2 21:09:36.448 [17476] dbg: config: header eval rule name is __RCVD_IN_MSPIKE_B function is check_rbl('mspikeb-lastexternal', 'bl.mailspike.net.')
446Dec  2 21:09:36.449 [17476] dbg: config: header eval rule name is __RCVD_IN_MSPIKE_L function is check_rbl('mspikeg-firsttrusted', 'wl.mailspike.net.')
447Dec  2 21:09:36.450 [17476] dbg: config: header eval rule name is __RCVD_IN_MSPIKE_Z function is check_rbl_sub('mspikeb-lastexternal', '127.0.0.2')
448Dec  2 21:09:36.452 [17476] dbg: config: header eval rule name is RCVD_IN_MSPIKE_L5 function is check_rbl_sub('mspikeb-lastexternal', '127.0.0.10')
449Dec  2 21:09:36.454 [17476] dbg: config: header eval rule name is RCVD_IN_MSPIKE_L4 function is check_rbl_sub('mspikeb-lastexternal', '127.0.0.11')
450Dec  2 21:09:36.456 [17476] dbg: config: header eval rule name is RCVD_IN_MSPIKE_L3 function is check_rbl_sub('mspikeb-lastexternal', '127.0.0.12')
451Dec  2 21:09:36.458 [17476] dbg: config: header eval rule name is RCVD_IN_MSPIKE_L2 function is check_rbl_sub('mspikeb-lastexternal', '127.0.0.13')
452Dec  2 21:09:36.460 [17476] dbg: config: header eval rule name is RCVD_IN_MSPIKE_H5 function is check_rbl_sub('mspikeg-firsttrusted', '127.0.0.20')
453Dec  2 21:09:36.462 [17476] dbg: config: header eval rule name is RCVD_IN_MSPIKE_H4 function is check_rbl_sub('mspikeg-firsttrusted', '127.0.0.19')
454Dec  2 21:09:36.463 [17476] dbg: config: header eval rule name is RCVD_IN_MSPIKE_H3 function is check_rbl_sub('mspikeg-firsttrusted', '127.0.0.18')
455Dec  2 21:09:36.465 [17476] dbg: config: header eval rule name is RCVD_IN_MSPIKE_H2 function is check_rbl_sub('mspikeg-firsttrusted', '127.0.0.17')
456Dec  2 21:09:36.472 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_meta_tests.cf
457Dec  2 21:09:36.473 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_meta_tests.cf" for included file
458Dec  2 21:09:36.474 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_meta_tests.cf
459Dec  2 21:09:36.492 [17476] dbg: config: body eval rule name is __UPPERCASE_25_50 function is check_for_uppercase('25', '50')
460Dec  2 21:09:36.493 [17476] dbg: config: body eval rule name is __UPPERCASE_50_75 function is check_for_uppercase('50', '75')
461Dec  2 21:09:36.494 [17476] dbg: config: body eval rule name is __UPPERCASE_75_100 function is check_for_uppercase('75', '100')
462Dec  2 21:09:36.495 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_net_tests.cf
463Dec  2 21:09:36.496 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_net_tests.cf" for included file
464Dec  2 21:09:36.496 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_net_tests.cf
465Dec  2 21:09:36.502 [17476] dbg: config: header eval rule name is NO_DNS_FOR_FROM function is check_dns_sender()
466Dec  2 21:09:36.504 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_pdfinfo.cf
467Dec  2 21:09:36.505 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_pdfinfo.cf" for included file
468Dec  2 21:09:36.505 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_pdfinfo.cf
469Dec  2 21:09:36.515 [17476] dbg: config: body eval rule name is GMD_PDF_HORIZ function is pdf_image_size_range(100, 450, 240, 800)
470Dec  2 21:09:36.518 [17476] dbg: config: body eval rule name is GMD_PDF_SQUARE function is pdf_image_size_range(180, 180, 360, 360)
471Dec  2 21:09:36.520 [17476] dbg: config: body eval rule name is GMD_PDF_VERT function is pdf_image_size_range(450, 100, 800, 240)
472Dec  2 21:09:36.523 [17476] dbg: config: body eval rule name is GMD_PRODUCER_GPL function is pdf_match_details('producer','/^(?:gnu|gpl) ghostscript/i')
473Dec  2 21:09:36.525 [17476] dbg: config: body eval rule name is GMD_PRODUCER_POWERPDF function is pdf_match_details('producer','/^PowerPdf 0\./')
474Dec  2 21:09:36.527 [17476] dbg: config: body eval rule name is GMD_PRODUCER_EASYPDF function is pdf_match_details('producer','/^BCL easyPDF/')
475Dec  2 21:09:36.529 [17476] dbg: config: body eval rule name is GMD_PDF_ENCRYPTED function is pdf_is_encrypted()
476Dec  2 21:09:36.531 [17476] dbg: config: body eval rule name is GMD_PDF_EMPTY_BODY function is pdf_is_empty_body()
477Dec  2 21:09:36.535 [17476] dbg: config: body eval rule name is __GMD_PDF_NO_TXT function is pdf_image_to_text_ratio(0.000, 0.005)
478Dec  2 21:09:36.537 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_phrases.cf
479Dec  2 21:09:36.538 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_phrases.cf" for included file
480Dec  2 21:09:36.538 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_phrases.cf
481Dec  2 21:09:36.599 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_porn.cf
482Dec  2 21:09:36.599 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_porn.cf" for included file
483Dec  2 21:09:36.600 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_porn.cf
484Dec  2 21:09:36.609 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_ratware.cf
485Dec  2 21:09:36.610 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_ratware.cf" for included file
486Dec  2 21:09:36.611 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_ratware.cf
487Dec  2 21:09:36.697 [17476] dbg: config: header eval rule name is __GATED_THROUGH_RCVD_REMOVER function is gated_through_received_hdr_remover()
488Dec  2 21:09:36.698 [17476] dbg: config: header eval rule name is __RATWARE_NAME_ID function is check_ratware_name_id()
489Dec  2 21:09:36.700 [17476] dbg: config: header eval rule name is RATWARE_EFROM function is check_ratware_envelope_from()
490Dec  2 21:09:36.703 [17476] dbg: config: body eval rule name is __MIME_HTML function is check_for_mime_html()
491Dec  2 21:09:36.704 [17476] dbg: config: body eval rule name is __TAG_EXISTS_BODY function is html_tag_exists('body')
492Dec  2 21:09:36.705 [17476] dbg: config: body eval rule name is __TAG_EXISTS_HEAD function is html_tag_exists('head')
493Dec  2 21:09:36.706 [17476] dbg: config: body eval rule name is __TAG_EXISTS_HTML function is html_tag_exists('html')
494Dec  2 21:09:36.706 [17476] dbg: config: body eval rule name is __TAG_EXISTS_META function is html_tag_exists('meta')
495Dec  2 21:09:36.707 [17476] dbg: config: body eval rule name is __TAG_EXISTS_STYLE function is html_tag_exists('style')
496Dec  2 21:09:36.708 [17476] dbg: config: body eval rule name is __TAG_EXISTS_SCRIPT function is html_tag_exists('script')
497Dec  2 21:09:36.709 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_uri_tests.cf
498Dec  2 21:09:36.709 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_uri_tests.cf" for included file
499Dec  2 21:09:36.710 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_uri_tests.cf
500Dec  2 21:09:36.742 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_vbounce.cf
501Dec  2 21:09:36.743 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/20_vbounce.cf" for included file
502Dec  2 21:09:36.744 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/20_vbounce.cf
503Dec  2 21:09:36.750 [17476] dbg: config: body eval rule name is __MY_SERVERS_FOUND function is check_whitelist_bounce_relays()
504Dec  2 21:09:36.751 [17476] dbg: config: body eval rule name is __HAVE_BOUNCE_RELAYS function is have_any_bounce_relays()
505Dec  2 21:09:36.845 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/23_bayes.cf
506Dec  2 21:09:36.845 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/23_bayes.cf" for included file
507Dec  2 21:09:36.846 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/23_bayes.cf
508Dec  2 21:09:36.850 [17476] dbg: config: body eval rule name is BAYES_00 function is check_bayes('0.00', '0.01')
509Dec  2 21:09:36.850 [17476] dbg: config: body eval rule name is BAYES_05 function is check_bayes('0.01', '0.05')
510Dec  2 21:09:36.851 [17476] dbg: config: body eval rule name is BAYES_20 function is check_bayes('0.05', '0.20')
511Dec  2 21:09:36.852 [17476] dbg: config: body eval rule name is BAYES_40 function is check_bayes('0.20', '0.40')
512Dec  2 21:09:36.852 [17476] dbg: config: body eval rule name is BAYES_50 function is check_bayes('0.40', '0.60')
513Dec  2 21:09:36.853 [17476] dbg: config: body eval rule name is BAYES_60 function is check_bayes('0.60', '0.80')
514Dec  2 21:09:36.854 [17476] dbg: config: body eval rule name is BAYES_80 function is check_bayes('0.80', '0.95')
515Dec  2 21:09:36.854 [17476] dbg: config: body eval rule name is BAYES_95 function is check_bayes('0.95', '0.99')
516Dec  2 21:09:36.855 [17476] dbg: config: body eval rule name is BAYES_99 function is check_bayes('0.99', '1.00')
517Dec  2 21:09:36.856 [17476] dbg: config: body eval rule name is BAYES_999 function is check_bayes('0.999', '1.00')
518Dec  2 21:09:36.868 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_accessdb.cf
519Dec  2 21:09:36.869 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_accessdb.cf" for included file
520Dec  2 21:09:36.869 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_accessdb.cf
521Dec  2 21:09:36.873 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_antivirus.cf
522Dec  2 21:09:36.873 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_antivirus.cf" for included file
523Dec  2 21:09:36.874 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_antivirus.cf
524Dec  2 21:09:36.878 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_asn.cf
525Dec  2 21:09:36.878 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_asn.cf" for included file
526Dec  2 21:09:36.879 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_asn.cf
527Dec  2 21:09:36.883 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_dcc.cf
528Dec  2 21:09:36.883 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_dcc.cf" for included file
529Dec  2 21:09:36.884 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_dcc.cf
530Dec  2 21:09:36.890 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_dkim.cf
531Dec  2 21:09:36.891 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_dkim.cf" for included file
532Dec  2 21:09:36.892 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_dkim.cf
533Dec  2 21:09:36.904 [17476] dbg: config: header eval rule name is DKIM_ADSP_NXDOMAIN function is check_dkim_adsp('N')
534Dec  2 21:09:36.906 [17476] dbg: config: header eval rule name is DKIM_ADSP_DISCARD function is check_dkim_adsp('D')
535Dec  2 21:09:36.908 [17476] dbg: config: header eval rule name is DKIM_ADSP_ALL function is check_dkim_adsp('A')
536Dec  2 21:09:36.910 [17476] dbg: config: header eval rule name is DKIM_ADSP_CUSTOM_LOW function is check_dkim_adsp('1')
537Dec  2 21:09:36.912 [17476] dbg: config: header eval rule name is DKIM_ADSP_CUSTOM_MED function is check_dkim_adsp('2')
538Dec  2 21:09:36.914 [17476] dbg: config: header eval rule name is DKIM_ADSP_CUSTOM_HIGH function is check_dkim_adsp('3')
539Dec  2 21:09:36.923 [17476] dbg: config: header eval rule name is DKIM_POLICY_TESTING function is check_dkim_testing()
540Dec  2 21:09:36.924 [17476] dbg: config: header eval rule name is DKIM_POLICY_SIGNSOME function is check_dkim_signsome()
541Dec  2 21:09:36.925 [17476] dbg: config: header eval rule name is DKIM_POLICY_SIGNALL function is check_dkim_signall()
542Dec  2 21:09:36.927 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_dnswl.cf
543Dec  2 21:09:36.927 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_dnswl.cf" for included file
544Dec  2 21:09:36.928 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_dnswl.cf
545Dec  2 21:09:36.931 [17476] dbg: config: header eval rule name is __RCVD_IN_DNSWL function is check_rbl('dnswl-firsttrusted', 'list.dnswl.org.')
546Dec  2 21:09:36.932 [17476] dbg: config: header eval rule name is RCVD_IN_DNSWL_NONE function is check_rbl_sub('dnswl-firsttrusted', '^127\.0\.\d+\.0$')
547Dec  2 21:09:36.934 [17476] dbg: config: header eval rule name is RCVD_IN_DNSWL_LOW function is check_rbl_sub('dnswl-firsttrusted', '^127\.0\.\d+\.1$')
548Dec  2 21:09:36.936 [17476] dbg: config: header eval rule name is RCVD_IN_DNSWL_MED function is check_rbl_sub('dnswl-firsttrusted', '^127\.0\.\d+\.2$')
549Dec  2 21:09:36.938 [17476] dbg: config: header eval rule name is RCVD_IN_DNSWL_HI function is check_rbl_sub('dnswl-firsttrusted', '^127\.0\.\d+\.3$')
550Dec  2 21:09:36.940 [17476] dbg: config: header eval rule name is RCVD_IN_DNSWL_BLOCKED function is check_rbl_sub('dnswl-firsttrusted', '^127\.0\.\d+\.255$')
551Dec  2 21:09:36.943 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_hashcash.cf
552Dec  2 21:09:36.944 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_hashcash.cf" for included file
553Dec  2 21:09:36.945 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_hashcash.cf
554Dec  2 21:09:36.948 [17476] dbg: config: header eval rule name is HASHCASH_20 function is check_hashcash_value('20', '21')
555Dec  2 21:09:36.949 [17476] dbg: config: header eval rule name is HASHCASH_21 function is check_hashcash_value('21', '22')
556Dec  2 21:09:36.949 [17476] dbg: config: header eval rule name is HASHCASH_22 function is check_hashcash_value('22', '23')
557Dec  2 21:09:36.950 [17476] dbg: config: header eval rule name is HASHCASH_23 function is check_hashcash_value('23', '24')
558Dec  2 21:09:36.951 [17476] dbg: config: header eval rule name is HASHCASH_24 function is check_hashcash_value('24', '25')
559Dec  2 21:09:36.951 [17476] dbg: config: header eval rule name is HASHCASH_25 function is check_hashcash_value('25', '26')
560Dec  2 21:09:36.952 [17476] dbg: config: header eval rule name is HASHCASH_HIGH function is check_hashcash_value('26', '9999')
561Dec  2 21:09:36.960 [17476] dbg: config: header eval rule name is HASHCASH_2SPEND function is check_hashcash_double_spend()
562Dec  2 21:09:36.962 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_pyzor.cf
563Dec  2 21:09:36.963 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_pyzor.cf" for included file
564Dec  2 21:09:36.963 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_pyzor.cf
565Dec  2 21:09:36.969 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_razor2.cf
566Dec  2 21:09:36.969 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_razor2.cf" for included file
567Dec  2 21:09:36.970 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_razor2.cf
568Dec  2 21:09:36.978 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_replace.cf
569Dec  2 21:09:36.979 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_replace.cf" for included file
570Dec  2 21:09:36.980 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_replace.cf
571Dec  2 21:09:37.035 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_spf.cf
572Dec  2 21:09:37.036 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_spf.cf" for included file
573Dec  2 21:09:37.037 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_spf.cf
574Dec  2 21:09:37.040 [17476] dbg: config: header eval rule name is SPF_PASS function is check_for_spf_pass()
575Dec  2 21:09:37.043 [17476] dbg: config: header eval rule name is SPF_NEUTRAL function is check_for_spf_neutral()
576Dec  2 21:09:37.045 [17476] dbg: config: header eval rule name is SPF_FAIL function is check_for_spf_fail()
577Dec  2 21:09:37.047 [17476] dbg: config: header eval rule name is SPF_SOFTFAIL function is check_for_spf_softfail()
578Dec  2 21:09:37.049 [17476] dbg: config: header eval rule name is SPF_HELO_PASS function is check_for_spf_helo_pass()
579Dec  2 21:09:37.051 [17476] dbg: config: header eval rule name is SPF_HELO_NEUTRAL function is check_for_spf_helo_neutral()
580Dec  2 21:09:37.053 [17476] dbg: config: header eval rule name is SPF_HELO_FAIL function is check_for_spf_helo_fail()
581Dec  2 21:09:37.055 [17476] dbg: config: header eval rule name is SPF_HELO_SOFTFAIL function is check_for_spf_helo_softfail()
582Dec  2 21:09:37.057 [17476] dbg: config: header eval rule name is SPF_NONE function is check_for_spf_none()
583Dec  2 21:09:37.059 [17476] dbg: config: header eval rule name is SPF_HELO_NONE function is check_for_spf_helo_none()
584Dec  2 21:09:37.062 [17476] dbg: config: header eval rule name is T_SPF_PERMERROR function is check_for_spf_permerror()
585Dec  2 21:09:37.064 [17476] dbg: config: header eval rule name is T_SPF_TEMPERROR function is check_for_spf_temperror()
586Dec  2 21:09:37.066 [17476] dbg: config: header eval rule name is T_SPF_HELO_PERMERROR function is check_for_spf_helo_permerror()
587Dec  2 21:09:37.068 [17476] dbg: config: header eval rule name is T_SPF_HELO_TEMPERROR function is check_for_spf_helo_temperror()
588Dec  2 21:09:37.070 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_textcat.cf
589Dec  2 21:09:37.071 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_textcat.cf" for included file
590Dec  2 21:09:37.072 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_textcat.cf
591Dec  2 21:09:37.075 [17476] dbg: config: body eval rule name is UNWANTED_LANGUAGE_BODY function is check_language()
592Dec  2 21:09:37.076 [17476] dbg: config: body eval rule name is BODY_8BITS function is check_body_8bits()
593Dec  2 21:09:37.079 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_uribl.cf
594Dec  2 21:09:37.079 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/25_uribl.cf" for included file
595Dec  2 21:09:37.080 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/25_uribl.cf
596Dec  2 21:09:37.086 [17476] dbg: config: body eval rule name is URIBL_SBL function is check_uridnsbl('URIBL_SBL')
597Dec  2 21:09:37.089 [17476] dbg: config: body eval rule name is URIBL_CSS function is check_uridnsbl('URIBL_CSS')
598Dec  2 21:09:37.092 [17476] dbg: config: body eval rule name is URIBL_SBL_A function is check_uridnsbl('URIBL_SBL_A')
599Dec  2 21:09:37.095 [17476] dbg: config: body eval rule name is URIBL_CSS_A function is check_uridnsbl('URIBL_CSS_A')
600Dec  2 21:09:37.099 [17476] dbg: config: body eval rule name is URIBL_DBL_SPAM function is check_uridnsbl('URIBL_DBL_SPAM')
601Dec  2 21:09:37.102 [17476] dbg: config: body eval rule name is URIBL_DBL_PHISH function is check_uridnsbl('URIBL_DBL_PHISH')
602Dec  2 21:09:37.104 [17476] dbg: config: body eval rule name is URIBL_DBL_MALWARE function is check_uridnsbl('URIBL_DBL_MALWARE')
603Dec  2 21:09:37.107 [17476] dbg: config: body eval rule name is URIBL_DBL_BOTNETCC function is check_uridnsbl('URIBL_DBL_BOTNETCC')
604Dec  2 21:09:37.109 [17476] dbg: config: body eval rule name is URIBL_DBL_ABUSE_SPAM function is check_uridnsbl('URIBL_DBL_ABUSE_SPAM')
605Dec  2 21:09:37.112 [17476] dbg: config: body eval rule name is URIBL_DBL_ABUSE_REDIR function is check_uridnsbl('URIBL_DBL_ABUSE_REDIR')
606Dec  2 21:09:37.114 [17476] dbg: config: body eval rule name is URIBL_DBL_ABUSE_PHISH function is check_uridnsbl('URIBL_DBL_ABUSE_PHISH')
607Dec  2 21:09:37.116 [17476] dbg: config: body eval rule name is URIBL_DBL_ABUSE_MALW function is check_uridnsbl('URIBL_DBL_ABUSE_MALW')
608Dec  2 21:09:37.119 [17476] dbg: config: body eval rule name is URIBL_DBL_ABUSE_BOTCC function is check_uridnsbl('URIBL_DBL_ABUSE_BOTCC')
609Dec  2 21:09:37.121 [17476] dbg: config: body eval rule name is URIBL_DBL_ERROR function is check_uridnsbl('URIBL_DBL_ERROR')
610Dec  2 21:09:37.124 [17476] dbg: config: body eval rule name is URIBL_WS_SURBL function is check_uridnsbl('URIBL_WS_SURBL')
611Dec  2 21:09:37.127 [17476] dbg: config: body eval rule name is URIBL_PH_SURBL function is check_uridnsbl('URIBL_PH_SURBL')
612Dec  2 21:09:37.129 [17476] dbg: config: body eval rule name is URIBL_MW_SURBL function is check_uridnsbl('URIBL_MW_SURBL')
613Dec  2 21:09:37.131 [17476] dbg: config: body eval rule name is URIBL_CR_SURBL function is check_uridnsbl('URIBL_CR_SURBL')
614Dec  2 21:09:37.134 [17476] dbg: config: body eval rule name is URIBL_ABUSE_SURBL function is check_uridnsbl('URIBL_ABUSE_SURBL')
615Dec  2 21:09:37.136 [17476] dbg: config: body eval rule name is SURBL_BLOCKED function is check_uridnsbl('SURBL_BLOCKED')
616Dec  2 21:09:37.140 [17476] dbg: config: body eval rule name is URIBL_BLACK function is check_uridnsbl('URIBL_BLACK')
617Dec  2 21:09:37.143 [17476] dbg: config: body eval rule name is URIBL_GREY function is check_uridnsbl('URIBL_GREY')
618Dec  2 21:09:37.146 [17476] dbg: config: body eval rule name is URIBL_RED function is check_uridnsbl('URIBL_RED')
619Dec  2 21:09:37.149 [17476] dbg: config: body eval rule name is URIBL_BLOCKED function is check_uridnsbl('URIBL_BLOCKED')
620Dec  2 21:09:37.166 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_de.cf
621Dec  2 21:09:37.166 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_de.cf" for included file
622Dec  2 21:09:37.168 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_de.cf
623Dec  2 21:09:37.202 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_fr.cf
624Dec  2 21:09:37.203 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_fr.cf" for included file
625Dec  2 21:09:37.204 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_fr.cf
626Dec  2 21:09:37.228 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_it.cf
627Dec  2 21:09:37.229 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_it.cf" for included file
628Dec  2 21:09:37.230 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_it.cf
629Dec  2 21:09:37.232 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_nl.cf
630Dec  2 21:09:37.233 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_nl.cf" for included file
631Dec  2 21:09:37.234 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_nl.cf
632Dec  2 21:09:37.258 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_pl.cf
633Dec  2 21:09:37.258 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_pl.cf" for included file
634Dec  2 21:09:37.259 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_pl.cf
635Dec  2 21:09:37.282 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_pt_br.cf
636Dec  2 21:09:37.283 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_pt_br.cf" for included file
637Dec  2 21:09:37.284 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/30_text_pt_br.cf
638Dec  2 21:09:37.338 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/50_scores.cf
639Dec  2 21:09:37.339 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/50_scores.cf" for included file
640Dec  2 21:09:37.340 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/50_scores.cf
641Dec  2 21:09:37.562 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_adsp_override_dkim.cf
642Dec  2 21:09:37.563 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/60_adsp_override_dkim.cf" for included file
643Dec  2 21:09:37.564 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_adsp_override_dkim.cf
644Dec  2 21:09:37.586 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_awl.cf
645Dec  2 21:09:37.587 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/60_awl.cf" for included file
646Dec  2 21:09:37.588 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_awl.cf
647Dec  2 21:09:37.591 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_shortcircuit.cf
648Dec  2 21:09:37.592 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/60_shortcircuit.cf" for included file
649Dec  2 21:09:37.592 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_shortcircuit.cf
650Dec  2 21:09:37.598 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_txrep.cf
651Dec  2 21:09:37.598 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/60_txrep.cf" for included file
652Dec  2 21:09:37.599 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_txrep.cf
653Dec  2 21:09:37.601 [17476] dbg: config: header eval rule name is TXREP function is check_senders_reputation()
654Dec  2 21:09:37.604 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist.cf
655Dec  2 21:09:37.605 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist.cf" for included file
656Dec  2 21:09:37.605 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist.cf
657Dec  2 21:09:37.609 [17476] dbg: config: header eval rule name is USER_IN_BLACKLIST function is check_from_in_blacklist()
658Dec  2 21:09:37.611 [17476] dbg: config: header eval rule name is USER_IN_WHITELIST function is check_from_in_whitelist()
659Dec  2 21:09:37.613 [17476] dbg: config: header eval rule name is USER_IN_DEF_WHITELIST function is check_from_in_default_whitelist()
660Dec  2 21:09:37.615 [17476] dbg: config: header eval rule name is USER_IN_BLACKLIST_TO function is check_to_in_blacklist()
661Dec  2 21:09:37.617 [17476] dbg: config: header eval rule name is USER_IN_WHITELIST_TO function is check_to_in_whitelist()
662Dec  2 21:09:37.619 [17476] dbg: config: header eval rule name is USER_IN_MORE_SPAM_TO function is check_to_in_more_spam()
663Dec  2 21:09:37.621 [17476] dbg: config: header eval rule name is USER_IN_ALL_SPAM_TO function is check_to_in_all_spam()
664Dec  2 21:09:37.623 [17476] dbg: config: body eval rule name is URI_HOST_IN_BLACKLIST function is check_uri_host_in_blacklist()
665Dec  2 21:09:37.625 [17476] dbg: config: body eval rule name is URI_HOST_IN_WHITELIST function is check_uri_host_in_whitelist()
666Dec  2 21:09:37.634 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_auth.cf
667Dec  2 21:09:37.635 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_auth.cf" for included file
668Dec  2 21:09:37.636 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_auth.cf
669Dec  2 21:09:37.849 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_dkim.cf
670Dec  2 21:09:37.849 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_dkim.cf" for included file
671Dec  2 21:09:37.850 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_dkim.cf
672Dec  2 21:09:37.854 [17476] dbg: config: header eval rule name is USER_IN_DKIM_WHITELIST function is check_for_dkim_whitelist_from()
673Dec  2 21:09:37.856 [17476] dbg: config: header eval rule name is USER_IN_DEF_DKIM_WL function is check_for_def_dkim_whitelist_from()
674Dec  2 21:09:37.888 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_spf.cf
675Dec  2 21:09:37.889 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_spf.cf" for included file
676Dec  2 21:09:37.889 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_spf.cf
677Dec  2 21:09:37.893 [17476] dbg: config: header eval rule name is USER_IN_SPF_WHITELIST function is check_for_spf_whitelist_from()
678Dec  2 21:09:37.895 [17476] dbg: config: header eval rule name is USER_IN_DEF_SPF_WL function is check_for_def_spf_whitelist_from()
679Dec  2 21:09:37.906 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_subject.cf
680Dec  2 21:09:37.906 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_subject.cf" for included file
681Dec  2 21:09:37.907 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/60_whitelist_subject.cf
682Dec  2 21:09:37.910 [17476] dbg: config: header eval rule name is SUBJECT_IN_WHITELIST function is check_subject_in_whitelist()
683Dec  2 21:09:37.912 [17476] dbg: config: header eval rule name is SUBJECT_IN_BLACKLIST function is check_subject_in_blacklist()
684Dec  2 21:09:37.915 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/72_active.cf
685Dec  2 21:09:37.915 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/72_active.cf" for included file
686Dec  2 21:09:37.918 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/72_active.cf
687Dec  2 21:09:38.027 [17476] dbg: config: body eval rule name is BASE64_LENGTH_78_79 function is check_base64_length('78','79')
688Dec  2 21:09:38.030 [17476] dbg: config: body eval rule name is BASE64_LENGTH_79_INF function is check_base64_length('79')
689Dec  2 21:09:38.240 [17476] dbg: config: header eval rule name is HEADER_COUNT_SUBJECT function is check_header_count_range('Subject','2','999')
690Dec  2 21:09:38.244 [17476] dbg: config: header eval rule name is HEADER_FROM_DIFFERENT_DOMAINS function is check_equal_from_domains()
691Dec  2 21:09:38.270 [17476] dbg: config: body eval rule name is HTTPS_HTTP_MISMATCH function is check_https_http_mismatch('1','10')
692Dec  2 21:09:38.359 [17476] dbg: config: body eval rule name is PP_MIME_FAKE_ASCII_TEXT function is check_for_ascii_text_illegal()
693Dec  2 21:09:38.363 [17476] dbg: config: body eval rule name is PP_TOO_MUCH_UNICODE02 function is check_abundant_unicode_ratio(0.02)
694Dec  2 21:09:38.366 [17476] dbg: config: body eval rule name is PP_TOO_MUCH_UNICODE05 function is check_abundant_unicode_ratio(0.05)
695Dec  2 21:09:38.386 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_DK function is check_rbl_sub('iadb-firsttrusted', '127.2.255.3')
696Dec  2 21:09:38.389 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_DOPTIN function is check_rbl_sub('iadb-firsttrusted', '127.3.100.10')
697Dec  2 21:09:38.391 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_DOPTIN_GT50 function is check_rbl_sub('iadb-firsttrusted', '127.3.100.9')
698Dec  2 21:09:38.394 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_DOPTIN_LT50 function is check_rbl_sub('iadb-firsttrusted', '127.3.100.8')
699Dec  2 21:09:38.397 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_EDDB function is check_rbl_sub('iadb-firsttrusted', '127.0.2.1')
700Dec  2 21:09:38.400 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_EPIA function is check_rbl_sub('iadb-firsttrusted', '127.0.2.2')
701Dec  2 21:09:38.403 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_GOODMAIL function is check_rbl_sub('iadb-firsttrusted', '127.2.255.103')
702Dec  2 21:09:38.405 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_LISTED function is check_rbl_sub('iadb-firsttrusted', '^127\.0\.0\.[12]$')
703Dec  2 21:09:38.408 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_LOOSE function is check_rbl_sub('iadb-firsttrusted', '127.3.100.4')
704Dec  2 21:09:38.411 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_MI_CPEAR function is check_rbl_sub('iadb-firsttrusted', '127.101.1.10')
705Dec  2 21:09:38.414 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_MI_CPR_30 function is check_rbl_sub('iadb-firsttrusted', '127.101.101.10')
706Dec  2 21:09:38.416 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_MI_CPR_MAT function is check_rbl_sub('iadb-firsttrusted', '127.101.201.10')
707Dec  2 21:09:38.419 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_ML_DOPTIN function is check_rbl_sub('iadb-firsttrusted', '127.3.100.100')
708Dec  2 21:09:38.422 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_NOCONTROL function is check_rbl_sub('iadb-firsttrusted', '127.3.100.0')
709Dec  2 21:09:38.425 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_OOO function is check_rbl_sub('iadb-firsttrusted', '127.3.100.200')
710Dec  2 21:09:38.428 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_OPTIN function is check_rbl_sub('iadb-firsttrusted', '127.3.100.7')
711Dec  2 21:09:38.430 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_OPTIN_GT50 function is check_rbl_sub('iadb-firsttrusted', '127.3.100.6')
712Dec  2 21:09:38.433 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_OPTIN_LT50 function is check_rbl_sub('iadb-firsttrusted', '127.3.100.5')
713Dec  2 21:09:38.436 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_OPTOUTONLY function is check_rbl_sub('iadb-firsttrusted', '127.3.100.1')
714Dec  2 21:09:38.439 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_RDNS function is check_rbl_sub('iadb-firsttrusted', '127.2.255.4')
715Dec  2 21:09:38.441 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_SENDERID function is check_rbl_sub('iadb-firsttrusted', '127.2.255.2')
716Dec  2 21:09:38.444 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_SPF function is check_rbl_sub('iadb-firsttrusted', '127.2.255.1')
717Dec  2 21:09:38.447 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_UNVERIFIED_1 function is check_rbl_sub('iadb-firsttrusted', '127.3.100.2')
718Dec  2 21:09:38.450 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_UNVERIFIED_2 function is check_rbl_sub('iadb-firsttrusted', '127.3.100.3')
719Dec  2 21:09:38.453 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_UT_CPEAR function is check_rbl_sub('iadb-firsttrusted', '127.101.2.10')
720Dec  2 21:09:38.455 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_UT_CPR_30 function is check_rbl_sub('iadb-firsttrusted', '127.101.102.10')
721Dec  2 21:09:38.458 [17476] dbg: config: header eval rule name is RCVD_IN_IADB_UT_CPR_MAT function is check_rbl_sub('iadb-firsttrusted', '127.101.202.10')
722Dec  2 21:09:38.461 [17476] dbg: config: header eval rule name is RCVD_IN_PSBL function is check_rbl('psbl-lastexternal', 'psbl.surriel.com.')
723Dec  2 21:09:38.612 [17476] dbg: config: body eval rule name is TVD_STOCK1 function is check_stock_info('2')
724Dec  2 21:09:38.646 [17476] dbg: config: header eval rule name is T_DATE_IN_FUTURE_96_Q function is check_for_shifted_date('96', '2920')
725Dec  2 21:09:38.649 [17476] dbg: config: header eval rule name is T_DATE_IN_FUTURE_Q_PLUS function is check_for_shifted_date('2920', 'undef')
726Dec  2 21:09:38.713 [17476] dbg: config: body eval rule name is T_KAM_HTML_FONT_INVALID function is html_test('font_invalid_color')
727Dec  2 21:09:38.791 [17476] dbg: config: body eval rule name is T_TVD_MIME_EPI function is check_msg_parse_flags('mime_epilogue_exists')
728Dec  2 21:09:38.793 [17476] dbg: config: body eval rule name is T_TVD_MIME_NO_HEADERS function is check_msg_parse_flags('missing_mime_headers')
729Dec  2 21:09:38.809 [17476] dbg: config: body eval rule name is URIBL_RHS_DOB function is check_uridnsbl('URIBL_RHS_DOB')
730Dec  2 21:09:39.240 [17476] dbg: config: body eval rule name is __HTML_COMMENT_10000 function is html_text_match('comment', '(?s)^(?=.{10000})')
731Dec  2 21:09:39.242 [17476] dbg: config: body eval rule name is __HTML_COMMENT_20000 function is html_text_match('comment', '(?s)^(?=.{20000})')
732Dec  2 21:09:39.243 [17476] dbg: config: body eval rule name is __HTML_COMMENT_30000 function is html_text_match('comment', '(?s)^(?=.{30000})')
733Dec  2 21:09:39.244 [17476] dbg: config: body eval rule name is __HTML_COMMENT_50000 function is html_text_match('comment', '(?s)^(?=(?:.{25000}){2})')
734Dec  2 21:09:39.255 [17476] dbg: config: body eval rule name is __HTML_TAG_BALANCE_CENTER function is html_tag_balance('center', '!= 0')
735Dec  2 21:09:39.260 [17476] dbg: config: body eval rule name is __IMG_LE_300K function is pixel_coverage('all',62500,300000)
736Dec  2 21:09:39.276 [17476] dbg: config: body eval rule name is __KAM_BODY_LENGTH_LT_1024 function is check_body_length('1024')
737Dec  2 21:09:39.280 [17476] dbg: config: body eval rule name is __KAM_BODY_LENGTH_LT_128 function is check_body_length('128')
738Dec  2 21:09:39.284 [17476] dbg: config: body eval rule name is __KAM_BODY_LENGTH_LT_256 function is check_body_length('256')
739Dec  2 21:09:39.287 [17476] dbg: config: body eval rule name is __KAM_BODY_LENGTH_LT_512 function is check_body_length('512')
740Dec  2 21:09:39.424 [17476] dbg: config: body eval rule name is __ONE_IMG function is image_count('all',1,1)
741Dec  2 21:09:39.512 [17476] dbg: config: header eval rule name is __RP_MATCHES_RCVD function is check_mailfrom_matches_rcvd()
742Dec  2 21:09:39.699 [17476] dbg: config: header eval rule name is __freemail_dispto function is check_freemail_header('Disposition-Notification-To')
743Dec  2 21:09:39.702 [17476] dbg: config: header eval rule name is __smf_freemail_hdr_replyto function is check_freemail_header('Reply-To:addr')
744Dec  2 21:09:39.703 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/72_scores.cf
745Dec  2 21:09:39.704 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/72_scores.cf" for included file
746Dec  2 21:09:39.705 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/72_scores.cf
747Dec  2 21:09:39.762 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/73_sandbox_manual_scores.cf
748Dec  2 21:09:39.763 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/73_sandbox_manual_scores.cf" for included file
749Dec  2 21:09:39.764 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/73_sandbox_manual_scores.cf
750Dec  2 21:09:39.770 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/local.cf
751Dec  2 21:09:39.770 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/local.cf" for included file
752Dec  2 21:09:39.771 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/local.cf
753Dec  2 21:09:39.777 [17476] dbg: config: fixed relative path: /var/lib/spamassassin/3.004002/updates_spamassassin_org/regression_tests.cf
754Dec  2 21:09:39.778 [17476] dbg: config: using "/var/lib/spamassassin/3.004002/updates_spamassassin_org/regression_tests.cf" for included file
755Dec  2 21:09:39.779 [17476] dbg: config: read file /var/lib/spamassassin/3.004002/updates_spamassassin_org/regression_tests.cf
756Dec  2 21:09:39.784 [17476] dbg: config: header eval rule name is TXREP function is check_senders_reputation()
757Dec  2 21:09:40.091 [17476] dbg: config: fixed relative path: /etc/spamassassin/DecodeShortURLs.pm
758Dec  2 21:09:40.092 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::DecodeShortURLs from /etc/spamassassin/DecodeShortURLs.pm
759Dec  2 21:09:40.321 [17476] dbg: config: body eval rule name is HAS_SHORT_URL function is short_url_tests()
760Dec  2 21:09:40.324 [17476] dbg: config: body eval rule name is SHORT_URL_CHAINED function is short_url_tests()
761Dec  2 21:09:40.327 [17476] dbg: config: body eval rule name is SHORT_URL_MAXCHAIN function is short_url_tests()
762Dec  2 21:09:40.329 [17476] dbg: config: body eval rule name is SHORT_URL_LOOP function is short_url_tests()
763Dec  2 21:09:40.332 [17476] dbg: config: body eval rule name is SHORT_URL_404 function is short_url_tests()
764Dec  2 21:09:40.335 [17476] dbg: config: body eval rule name is SHORT_T_CO_200 function is short_url_tests()
765Dec  2 21:09:40.446 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::ExtractText=HASH(0x1d943d0) implements 'parse_config', priority 0
766Dec  2 21:09:40.447 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x1a97900) implements 'parse_config', priority 0
767Dec  2 21:09:40.448 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::HashBL=HASH(0x1a98080) implements 'parse_config', priority 0
768Dec  2 21:09:40.449 [17476] dbg: extracttext: set: magic=1
769Dec  2 21:09:40.452 [17476] dbg: extracttext: external: antiword "/usr/bin/antiword","-t","-w","0","-m","UTF-8.txt","-"
770Dec  2 21:09:40.453 [17476] dbg: extracttext: use: antiword name .*\.doc
771Dec  2 21:09:40.454 [17476] dbg: extracttext: use: antiword name .*\.dot
772Dec  2 21:09:40.454 [17476] dbg: extracttext: use: antiword type application/(?:vnd\.?)?ms-?word.*
773Dec  2 21:09:40.456 [17476] dbg: extracttext: external: unrtf "/usr/bin/unrtf","-t","ExtractText.tags","--nopict"
774Dec  2 21:09:40.458 [17476] dbg: extracttext: use: unrtf name .*\.doc
775Dec  2 21:09:40.458 [17476] dbg: extracttext: use: unrtf name .*\.rtf
776Dec  2 21:09:40.459 [17476] dbg: extracttext: use: unrtf type application/rtf
777Dec  2 21:09:40.459 [17476] dbg: extracttext: use: unrtf type text/rtf
778Dec  2 21:09:40.461 [17476] dbg: extracttext: external: odt2txt "/usr/bin/odt2txt","--encoding=UTF-8","${file}"
779Dec  2 21:09:40.462 [17476] dbg: extracttext: use: odt2txt name .*\.odt
780Dec  2 21:09:40.463 [17476] dbg: extracttext: use: odt2txt name .*\.ott
781Dec  2 21:09:40.463 [17476] dbg: extracttext: use: odt2txt type application/.*?opendocument.*text
782Dec  2 21:09:40.465 [17476] dbg: extracttext: use: odt2txt name .*\.sdw
783Dec  2 21:09:40.465 [17476] dbg: extracttext: use: odt2txt name .*\.stw
784Dec  2 21:09:40.466 [17476] dbg: extracttext: use: odt2txt type application/(?:x-)?soffice
785Dec  2 21:09:40.466 [17476] dbg: extracttext: use: odt2txt type application/(?:x-)?starwriter
786Dec  2 21:09:40.468 [17476] dbg: extracttext: external: pdftohtml "/usr/bin/pdftohtml","-i","-xml","-stdout","-noframes","${file}"
787Dec  2 21:09:40.470 [17476] dbg: extracttext: external: pdftotext "/usr/bin/pdftotext","-q","-nopgbrk","-enc","UTF-8","${file}","-"
788Dec  2 21:09:40.471 [17476] dbg: extracttext: use: pdftotext name .*\.pdf
789Dec  2 21:09:40.472 [17476] dbg: extracttext: use: pdftotext type application/pdf
790Dec  2 21:09:41.198 [17476] dbg: config: body eval rule name is KAM_BODY_COMPROMISED_URIBL_PCCC function is check_uridnsbl('KAM_URIBL2_PCCC')
791Dec  2 21:09:42.778 [17476] dbg: config: header eval rule name is __KAM_SPF_NONE function is check_for_spf_none()
792Dec  2 21:09:43.262 [17476] dbg: config: body eval rule name is URIBL_IVMURI function is check_uridnsbl('URIBL_IVMURI')
793Dec  2 21:09:43.268 [17476] dbg: config: header eval rule name is RCVD_IN_IVMBL function is check_rbl('ivmbl-lastexternal','sip.invaluement.com')
794Dec  2 21:09:43.269 [17476] dbg: config: header eval rule name is RCVD_IN_IVM24BL function is check_rbl('ivm24bl-lastexternal','sip24.invaluement.com')
795Dec  2 21:09:50.068 [17476] dbg: config: fixed relative path: /etc/spamassassin/HashBL.pm
796Dec  2 21:09:50.068 [17476] dbg: plugin: did not register Mail::SpamAssassin::Plugin::HashBL, already registered
797Dec  2 21:09:50.070 [17476] dbg: config: header eval rule name is HASHBL_EMAIL function is check_hashbl_emails('ebl.msbl.org')
798Dec  2 21:09:50.245 [17476] dbg: config: header eval rule name is L_RCVD_IN_VIRBL function is check_rbl_txt('virbl','virbl.dnsbl.bit.nl')
799Dec  2 21:09:50.264 [17476] dbg: config: header eval rule name is __FROM_EQ_TO function is check_for_from_equals_to()
800Dec  2 21:09:50.269 [17476] dbg: config: header eval rule name is __FROM_V_REPLY function is check_for_from_v_replyto_dom()
801Dec  2 21:09:50.351 [17476] dbg: config: header eval rule name is RCVD_IN_LASHBACK function is check_rbl('LASHBACK', 'ubl.unsubscore.com')
802Dec  2 21:09:50.373 [17476] dbg: config: uri_detail adding (text =~ /(?^:(?i)\.pdf\b)/) to L_FAKE_URL_FILE_TYPE
803Dec  2 21:09:50.374 [17476] dbg: config: uri_detail adding (cleaned =~ /(?^:(?i)\.(zip|docx)\b)/) to L_FAKE_URL_FILE_TYPE
804Dec  2 21:09:50.375 [17476] dbg: config: uri_detail added L_FAKE_URL_FILE_TYPE
805Dec  2 21:09:50.652 [17476] dbg: config: header eval rule name is L_SUOMISPAM function is check_rbl_txt('suomispam', 'bl.suomispam.net')
806Dec  2 21:09:50.659 [17476] dbg: config: fixed relative path: /etc/spamassassin/mxpf.pm
807Dec  2 21:09:50.660 [17476] dbg: plugin: loading Mail::SpamAssassin::Plugin::mxpf from /etc/spamassassin/mxpf.pm
808Dec  2 21:09:50.669 [17476] dbg: config: header eval rule name is MXPF_PASS function is check_pf()
809Dec  2 21:09:50.798 [17476] dbg: config: warning: no description set for DKIM_POLICY_SIGNSOME
810Dec  2 21:09:50.809 [17476] dbg: config: warning: no description set for MSOE_MID_WRONG_CASE
811Dec  2 21:09:50.817 [17476] dbg: config: warning: no description set for RCVD_FORGED_WROTE2
812Dec  2 21:09:50.823 [17476] dbg: config: warning: no description set for MIME_BOUND_EQ_REL
813Dec  2 21:09:50.825 [17476] dbg: config: warning: no description set for HK_SCAM_N2
814Dec  2 21:09:50.837 [17476] dbg: config: warning: no description set for KB_RATWARE_OUTLOOK_12
815Dec  2 21:09:50.840 [17476] dbg: config: warning: no description set for FROM_MISSP_SPF_FAIL
816Dec  2 21:09:50.842 [17476] dbg: config: warning: no description set for FAKE_REPLY_C
817Dec  2 21:09:50.846 [17476] dbg: config: warning: no description set for KB_DATE_CONTAINS_TAB
818Dec  2 21:09:50.934 [17476] dbg: config: warning: no description set for HELO_FRIEND
819Dec  2 21:09:50.940 [17476] dbg: config: warning: no description set for HK_SCAM_S7
820Dec  2 21:09:50.990 [17476] dbg: config: warning: no description set for TVD_FINGER_02
821Dec  2 21:09:51.089 [17476] dbg: config: warning: no description set for KAM_RAPTOR
822Dec  2 21:09:51.164 [17476] dbg: config: warning: no description set for STOX_AND_PRICE
823Dec  2 21:09:51.201 [17476] dbg: config: warning: no description set for L_UNNECESSARY_STRCONCAT
824Dec  2 21:09:51.210 [17476] dbg: config: warning: no description set for KAM_RPTR_SUSPECT
825Dec  2 21:09:51.255 [17476] dbg: config: warning: no description set for STOX_REPLY_TYPE_WITHOUT_QUOTES
826Dec  2 21:09:51.273 [17476] dbg: config: warning: no description set for TVD_SPACE_RATIO
827Dec  2 21:09:51.278 [17476] dbg: config: warning: no description set for TVD_RCVD_SPACE_BRACKET
828Dec  2 21:09:51.321 [17476] dbg: config: warning: no description set for L_HIDE_FROMCHARCODE
829Dec  2 21:09:51.325 [17476] dbg: config: warning: no description set for KAM_RPTR_FAILED
830Dec  2 21:09:51.345 [17476] dbg: config: warning: no description set for FSL_INTERIA_ABUSE
831Dec  2 21:09:51.371 [17476] dbg: config: warning: no description set for SB_GIF_AND_NO_URIS
832Dec  2 21:09:51.378 [17476] dbg: config: warning: no description set for FSL_HELO_SETUP
833Dec  2 21:09:51.391 [17476] dbg: config: warning: no description set for HTTPS_HTTP_MISMATCH
834Dec  2 21:09:51.421 [17476] dbg: config: warning: no description set for L_UNVERIFIED_YAHOO
835Dec  2 21:09:51.442 [17476] dbg: config: warning: no description set for SHORT_TERM_PRICE
836Dec  2 21:09:51.471 [17476] dbg: config: warning: no description set for HK_LOTTO
837Dec  2 21:09:51.486 [17476] dbg: config: warning: no description set for CBJ_GiveMeABreak
838Dec  2 21:09:51.495 [17476] dbg: config: warning: no description set for DKIM_POLICY_TESTING
839Dec  2 21:09:51.497 [17476] dbg: config: warning: no description set for GEO_QUERY_STRING
840Dec  2 21:09:51.529 [17476] dbg: config: warning: no description set for FSL_HELO_DEVICE
841Dec  2 21:09:51.583 [17476] dbg: config: warning: no description set for FSL_HELO_BARE_IP_1
842Dec  2 21:09:51.608 [17476] dbg: config: warning: no description set for FSL_HELO_FAKE
843Dec  2 21:09:51.630 [17476] dbg: config: warning: no description set for STOX_REPLY_TYPE
844Dec  2 21:09:51.678 [17476] dbg: config: warning: no description set for L_SPAM_TOOL_13
845Dec  2 21:09:51.685 [17476] dbg: config: warning: no description set for HELO_LH_LD
846Dec  2 21:09:51.702 [17476] dbg: config: warning: no description set for KB_RATWARE_OUTLOOK_MID
847Dec  2 21:09:51.710 [17476] dbg: config: warning: no description set for KB_RATWARE_OUTLOOK_16
848Dec  2 21:09:51.782 [17476] dbg: config: warning: no description set for KAM_RPTR_PASSED
849Dec  2 21:09:51.819 [17476] dbg: config: warning: no description set for STOCK_PRICES
850Dec  2 21:09:51.858 [17476] dbg: config: warning: no description set for X_MAILER_CME_6543_MSN
851Dec  2 21:09:51.872 [17476] dbg: config: warning: no description set for MSGID_DOLLARS_RANDOM
852Dec  2 21:09:51.891 [17476] dbg: config: warning: no description set for CURR_PRICE
853Dec  2 21:09:51.917 [17476] dbg: config: warning: no description set for AXB_URI_MLW_DROPBOX
854Dec  2 21:09:51.984 [17476] dbg: config: warning: no description set for LOTTERY_1
855Dec  2 21:09:51.990 [17476] dbg: config: warning: no description set for CTYPE_001C_B
856Dec  2 21:09:52.004 [17476] dbg: config: warning: no description set for L_UNNECESSARY_UNESCAPE
857Dec  2 21:09:52.020 [17476] dbg: config: warning: no description set for LOCAL_SEXTORTION
858Dec  2 21:09:52.110 [17476] dbg: config: warning: no description set for HK_NAME_FM_MR_MRS
859Dec  2 21:09:52.122 [17476] dbg: config: warning: no description set for LIVEFILESTORE
860Dec  2 21:09:52.127 [17476] dbg: config: warning: no description set for L_UNVERIFIED_GMAIL
861Dec  2 21:09:52.202 [17476] dbg: config: warning: no description set for L_FAKE_URL_FILE_TYPE
862Dec  2 21:09:52.204 [17476] dbg: config: warning: no description set for JM_I_FEEL_LUCKY
863Dec  2 21:09:52.215 [17476] dbg: config: warning: no description set for RCVD_IN_MSPIKE_ZBI
864Dec  2 21:09:52.236 [17476] dbg: config: warning: no description set for REPLYTO_WITHOUT_TO_CC
865Dec  2 21:09:52.246 [17476] dbg: config: warning: no description set for JM_TORA_XM
866Dec  2 21:09:52.278 [17476] dbg: config: warning: no description set for FSL_FAKE_HOTMAIL_RVCD
867Dec  2 21:09:52.337 [17476] dbg: config: warning: no description set for RCVD_IN_IVMBL
868Dec  2 21:09:52.365 [17476] dbg: config: warning: no description set for DKIM_POLICY_SIGNALL
869Dec  2 21:09:52.370 [17476] dbg: config: warning: no description set for JM_RCVD_QMAILV1
870Dec  2 21:09:52.388 [17476] dbg: config: warning: no description set for BASE64_LENGTH_78_79
871Dec  2 21:09:52.492 [17476] dbg: config: warning: no description set for RH_URI_MLW_GOOGLEBOX1
872Dec  2 21:09:52.559 [17476] dbg: config: warning: no description set for FSL_HELO_NON_FQDN_1
873Dec  2 21:09:52.576 [17476] dbg: config: warning: no description set for DOS_STOCK_BAT2
874Dec  2 21:09:52.580 [17476] dbg: config: warning: no description set for HELO_LOCALHOST
875Dec  2 21:09:52.628 [17476] dbg: config: warning: no description set for DKIM_VERIFIED
876Dec  2 21:09:52.635 [17476] dbg: config: warning: no description set for L_HIDE_URL
877Dec  2 21:09:52.684 [17476] dbg: config: warning: no description set for HIGH_CODEPAGE_URI
878Dec  2 21:09:52.722 [17476] dbg: config: warning: no description set for MID_DEGREES
879Dec  2 21:09:52.803 [17476] dbg: config: warning: no description set for LOCAL_BITCOIN
880Dec  2 21:09:52.909 [17476] dbg: config: warning: no description set for KAM_IFRAME
881Dec  2 21:09:52.920 [17476] dbg: config: warning: no description set for RCVD_IN_IVM24BL
882Dec  2 21:09:52.930 [17476] dbg: config: warning: no description set for LONG_TERM_PRICE
883Dec  2 21:09:52.938 [17476] dbg: config: warning: no description set for KB_RATWARE_OUTLOOK_08
884Dec  2 21:09:52.947 [17476] dbg: config: warning: no description set for MULTIPART_ALT_NON_TEXT
885Dec  2 21:09:52.955 [17476] dbg: config: warning: no description set for KB_FAKED_THE_BAT
886Dec  2 21:09:52.972 [17476] dbg: config: warning: no description set for KB_RATWARE_BOUNDARY
887Dec  2 21:09:52.988 [17476] dbg: config: warning: no description set for BUG6152_INVALID_DATE_TZ_ABSURD
888Dec  2 21:09:53.017 [17476] dbg: config: warning: no description set for CTYPE_001C_A
889Dec  2 21:09:53.040 [17476] dbg: config: warning: no description set for KB_RATWARE_MSGID
890Dec  2 21:09:53.103 [17476] dbg: config: warning: no description set for HTML_TITLE_SUBJ_DIFF
891Dec  2 21:09:53.155 [17476] dbg: config: warning: no description set for LOTTERY_PH_004470
892Dec  2 21:09:53.179 [17476] dbg: config: warning: no description set for TVD_EB_PHISH
893Dec  2 21:09:53.196 [17476] dbg: config: warning: no description set for HELO_OEM
894Dec  2 21:09:53.223 [17476] dbg: config: warning: no description set for TVD_PP_PHISH
895Dec  2 21:09:53.251 [17476] dbg: config: warning: no description set for THEBAT_UNREG
896Dec  2 21:09:58.595 [17476] dbg: rules: __AXB_PHISH_LAMDZR merged duplicates: __RULEGEN_PHISH_LAMDZR
897Dec  2 21:09:58.596 [17476] dbg: rules: __AXB_PHISH_WPFANU merged duplicates: __RULEGEN_PHISH_WPFANU
898Dec  2 21:09:58.596 [17476] dbg: rules: __AXB_PHISH_UAQVZX merged duplicates: __RULEGEN_PHISH_UAQVZX
899Dec  2 21:09:58.597 [17476] dbg: rules: __DOS_HAS_MAILING_LIST merged duplicates: __L_ML4 __ML4
900Dec  2 21:09:58.597 [17476] dbg: rules: __JM_REACTOR_DATE merged duplicates: __RATWARE_0_TZ_DATE
901Dec  2 21:09:58.598 [17476] dbg: rules: __HAS_URI merged duplicates: __KAM_SEO7
902Dec  2 21:09:58.598 [17476] dbg: rules: __HAS_LIST_ID merged duplicates: __L_ML2 __ML2
903Dec  2 21:09:58.599 [17476] dbg: rules: __AXB_PHISH_LXAAP0 merged duplicates: __RULEGEN_PHISH_LXAAP0
904Dec  2 21:09:58.599 [17476] dbg: rules: __AXB_PHISH_YNORJW merged duplicates: __RULEGEN_PHISH_YNORJW
905Dec  2 21:09:58.600 [17476] dbg: rules: __AXB_PHISH_STDR6I merged duplicates: __RULEGEN_PHISH_STDR6I
906Dec  2 21:09:58.600 [17476] dbg: rules: __AXB_PHISH_WDSRFR merged duplicates: __RULEGEN_PHISH_WDSRFR
907Dec  2 21:09:58.601 [17476] dbg: rules: __L_ML3 merged duplicates: __ML3
908Dec  2 21:09:58.601 [17476] dbg: rules: __AXB_PHISH_CCRMGZ merged duplicates: __RULEGEN_PHISH_CCRMGZ
909Dec  2 21:09:58.602 [17476] dbg: rules: __AXB_MO_OL_024C2 merged duplicates: __AXB_MO_OL_2600
910Dec  2 21:09:58.602 [17476] dbg: rules: __DOS_HAS_LIST_UNSUB merged duplicates: __FSL_HAS_LIST_UNSUB
911Dec  2 21:09:58.603 [17476] dbg: rules: __DOS_HAS_ANY_URI merged duplicates: __HAS_ANY_URI
912Dec  2 21:09:58.603 [17476] dbg: rules: __HAS_XMAIL merged duplicates: __HAS_X_MAILER
913Dec  2 21:09:58.604 [17476] dbg: rules: __THEBAT_MUA merged duplicates: __XM_THEBAT
914Dec  2 21:09:58.604 [17476] dbg: rules: __AXB_XM_OL_024C2 merged duplicates: __AXB_XM_OL_2600
915Dec  2 21:09:58.605 [17476] dbg: rules: __AXB_PHISH_J2WY09 merged duplicates: __RULEGEN_PHISH_J2WY09
916Dec  2 21:09:58.605 [17476] dbg: rules: CTYPE_001C_A merged duplicates: DATE_IN_FUTURE_96_XX
917Dec  2 21:09:58.606 [17476] dbg: rules: __AXB_PHISH_LDENVZ merged duplicates: __RULEGEN_PHISH_LDENVZ
918Dec  2 21:09:58.606 [17476] dbg: rules: __AXB_PHISH_6WXDQV merged duplicates: __RULEGEN_PHISH_6WXDQV
919Dec  2 21:09:58.607 [17476] dbg: rules: __L_ML1 merged duplicates: __ML1
920Dec  2 21:09:58.607 [17476] dbg: rules: CBJ_GiveMeABreak merged duplicates: KAM_IFRAME KAM_RAPTOR KAM_RPTR_FAILED KAM_RPTR_PASSED KAM_RPTR_SUSPECT __BOUNCE_RPATH_NULL
921Dec  2 21:09:58.608 [17476] dbg: rules: __HAS_REPLY_TO merged duplicates: __REPLYTO_EXISTS
922Dec  2 21:09:58.608 [17476] dbg: rules: __HAS_SENDER merged duplicates: __L_HAS_SNDR
923Dec  2 21:09:58.622 [17476] dbg: config: finish parsing
924Dec  2 21:09:58.895 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::ExtractText=HASH(0x1d943d0) implements 'finish_parsing_end', priority 0
925Dec  2 21:09:58.895 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x1f3c378) implements 'finish_parsing_end', priority 0
926Dec  2 21:09:58.896 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::ReplaceTags=HASH(0x2501f90) implements 'finish_parsing_end', priority 0
927Dec  2 21:09:58.897 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::FreeMail=HASH(0x1a97900) implements 'finish_parsing_end', priority 0
928Dec  2 21:09:58.898 [17476] dbg: extracttext: MIME database: /usr/share/mime
929Dec  2 21:09:59.200 [17476] dbg: zoom: loading compiled ruleset from /var/lib/spamassassin/compiled/5.024/3.004002
930Dec  2 21:09:59.255 [17476] dbg: zoom: using compiled ruleset in /var/lib/spamassassin/compiled/5.024/3.004002/Mail/SpamAssassin/CompiledRegexps/body_0.pm for Mail::SpamAssassin::CompiledRegexps::body_0
931Dec  2 21:09:59.298 [17476] dbg: zoom: skipping rule __KAM_COMPROMISED3, code differs in compiled ruleset
932Dec  2 21:09:59.322 [17476] dbg: zoom: able to use 1654/1655 'body_0' compiled rules (99.939%)
933Dec  2 21:09:59.383 [17476] dbg: zoom: using compiled ruleset in /var/lib/spamassassin/compiled/5.024/3.004002/Mail/SpamAssassin/CompiledRegexps/body_2.pm for Mail::SpamAssassin::CompiledRegexps::body_2
934Dec  2 21:09:59.455 [17476] dbg: zoom: able to use 1919/1919 'body_2' compiled rules (100%)
935Dec  2 21:09:59.457 [17476] dbg: replacetags: replacing tags
936Dec  2 21:09:59.669 [17476] dbg: replacetags: done replacing tags
937Dec  2 21:09:59.674 [17476] dbg: FreeMail: loaded freemail_domains entries: 2557 normal, 30 wildcard
938Dec  2 21:09:59.710 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::Bayes=HASH(0x1a7c078) implements 'learner_new', priority 0
939Dec  2 21:09:59.711 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::TxRep=HASH(0x1a97d80) implements 'learner_new', priority 0
940Dec  2 21:09:59.712 [17476] dbg: bayes: learner_new self=Mail::SpamAssassin::Plugin::Bayes=HASH(0x1a7c078), bayes_store_module=Mail::SpamAssassin::BayesStore::Redis
941Dec  2 21:09:59.782 [17476] dbg: bayes: learner_new: got store=Mail::SpamAssassin::BayesStore::Redis=HASH(0x1b5a3a0)
942Dec  2 21:09:59.783 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::Bayes=HASH(0x1a7c078) implements 'learner_is_scan_available', priority 0
943Dec  2 21:09:59.784 [17476] dbg: bayes: _open_db(not yet connected)
944Dec  2 21:09:59.791 [17476] dbg: bayes: Redis on-connect, db_id 2
945Dec  2 21:09:59.796 [17476] dbg: bayes: redis server version 3.2.12, memory used 55.1 MiB, Lua is available
946Dec  2 21:09:59.798 [17476] dbg: bayes: found bayes db version 3
947Dec  2 21:09:59.799 [17476] dbg: bayes: defining Lua scripts
948Dec  2 21:09:59.802 [17476] dbg: bayes: nspam_nham_get nspam=159920, nham=991425
949Dec  2 21:09:59.803 [17476] dbg: config: score set 3 chosen.
950Dec  2 21:09:59.809 [17476] dbg: dns: EDNS, UDP payload size 4096
951Dec  2 21:09:59.809 [17476] dbg: dns: servers set by config to: [192.168.1.122]:53, [192.168.1.121]:53, [192.168.1.120]:53
952Dec  2 21:09:59.810 [17476] dbg: dns: nameservers set to 192.168.1.122, 192.168.1.121, 192.168.1.120
953Dec  2 21:09:59.811 [17476] dbg: dns: using socket module: IO::Socket::IP version 0.39
954Dec  2 21:09:59.811 [17476] dbg: dns: is Net::DNS::Resolver available? yes
955Dec  2 21:09:59.812 [17476] dbg: dns: Net::DNS version: 1.18
956Dec  2 21:09:59.812 [17476] dbg: config: time limit 300.0 s
957Dec  2 21:09:59.814 [17476] dbg: message: main message type: text/plain
958Dec  2 21:09:59.815 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::ExtractText=HASH(0x1d943d0) implements 'post_message_parse', priority -1
959Dec  2 21:09:59.816 [17476] dbg: message: ---- MIME PARSER START ----
960Dec  2 21:09:59.817 [17476] dbg: message: parsing normal part
961Dec  2 21:09:59.818 [17476] dbg: message: storing a body to memory
962Dec  2 21:09:59.818 [17476] dbg: message: ---- MIME PARSER END ----
963Dec  2 21:09:59.819 [17476] dbg: message: no encoding detected
964Dec  2 21:09:59.819 [17476] dbg: message: kept, charset is US-ASCII as declared
965Dec  2 21:09:59.820 [17476] dbg: extracttext: X-ExtractText-Words: 0
966Dec  2 21:09:59.820 [17476] dbg: extracttext: X-ExtractText-Chars: 0
967Dec  2 21:09:59.821 [17476] dbg: check: pms new, time limit in 273.441 s
968Dec  2 21:09:59.822 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x1f3c378) implements 'check_start', priority 0
969Dec  2 21:09:59.823 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::DNSEval=HASH(0x25ac468) implements 'check_start', priority 0
970Dec  2 21:09:59.824 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::Phishing=HASH(0x26dca50) implements 'check_start', priority 0
971Dec  2 21:09:59.889 [17476] dbg: check: using scoreset 3 in M:S:Pms
972Dec  2 21:09:59.890 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x1a7c000) implements 'check_main', priority 0
973Dec  2 21:09:59.893 [17476] dbg: metadata: X-Spam-Relays-Trusted: 
974Dec  2 21:09:59.893 [17476] dbg: metadata: X-Spam-Relays-Untrusted: 
975Dec  2 21:09:59.893 [17476] dbg: metadata: X-Spam-Relays-Internal: 
976Dec  2 21:09:59.894 [17476] dbg: metadata: X-Spam-Relays-External: 
977Dec  2 21:09:59.894 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::RelayCountry=HASH(0x1ceb308) implements 'extract_metadata', priority 0
978Dec  2 21:09:59.895 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::TextCat=HASH(0x1f7c398) implements 'extract_metadata', priority 0
979Dec  2 21:09:59.896 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::AskDNS=HASH(0x1a97b70) implements 'extract_metadata', priority 0
980Dec  2 21:10:00.103 [17476] dbg: metadata: RelayCountry: GeoIP.dat not found, IP::Country::Fast enabled as fallback
981Dec  2 21:10:00.121 [17476] dbg: metadata: RelayCountry: Using database: IP::Country::Fast Wed May 15 18:29:48 2013
982Dec  2 21:10:00.122 [17476] dbg: metadata: X-Relay-Countries: 
983Dec  2 21:10:00.123 [17476] dbg: textcat: classifying, skipping: eo rm lv sa ga lt bs cy la fy yi sl gd sco et is eu
984Dec  2 21:10:00.209 [17476] dbg: check: tagrun - tag TEXTCATRESULTS is now ready, value: en:129706(1.00) ro:130361(1.01) id:131942(1.02) ms:131962(1.02) nl:132053(1.02) sv:132230(1.02) ca:132529(1.02) da:132567(1.02) fr:133210(1.03) it:133317(1.03) sr.us-ascii:133570(1.03) sk.us-ascii:133805(1.03) af:133814(1.03) es:134178(1.03) no:134550(1.04) pt:134661(1.04) hr.us-ascii:134670(1.04) de:134702(1.04) cs.iso-8859-2:135081(1.04) tr.unknown:135640(1.05)
985Dec  2 21:10:00.210 [17476] dbg: textcat: can't determine language uniquely enough
986Dec  2 21:10:00.211 [17476] dbg: textcat: X-Languages: "", X-Languages-Length: 1429
987Dec  2 21:10:00.212 [17476] dbg: dns: clear_resolver
988Dec  2 21:10:00.215 [17476] dbg: dns: EDNS, UDP payload size 4096
989Dec  2 21:10:00.215 [17476] dbg: dns: nameservers set to 192.168.1.122, 192.168.1.121, 192.168.1.120
990Dec  2 21:10:00.216 [17476] dbg: dns: using socket module: IO::Socket::IP version 0.39
991Dec  2 21:10:00.217 [17476] dbg: dns: is Net::DNS::Resolver available? yes
992Dec  2 21:10:00.217 [17476] dbg: dns: Net::DNS version: 1.18
993Dec  2 21:10:00.218 [17476] dbg: dns: dns_available set to yes in config file, skipping test
994Dec  2 21:10:00.218 [17476] dbg: askdns: depend on tags DKIMDOMAIN, rules: __DKIMDOMAIN_IN_DWL_ANY, DKIMDOMAIN_IN_DWL 
995Dec  2 21:10:00.219 [17476] dbg: askdns: depend on tags DKIMDOMAIN, rules: __DKIMWL_WL_HI, __DKIMWL_WL_MED, DKIMWL_BL 
996Dec  2 21:10:00.219 [17476] dbg: check: tagrun - action 0 blocking on tags DKIMDOMAIN
997Dec  2 21:10:00.220 [17476] dbg: askdns: depend on tags SENDERDOMAIN, rules: JMQ_SPF_NEUTRAL_ALL 
998Dec  2 21:10:00.220 [17476] dbg: check: tagrun - action 1 blocking on tags SENDERDOMAIN
999Dec  2 21:10:00.222 [17476] dbg: check: tagrun - tag RELAYSTRUSTED is now ready, value: 
1000Dec  2 21:10:00.222 [17476] dbg: check: tagrun - tag RELAYSUNTRUSTED is now ready, value: 
1001Dec  2 21:10:00.222 [17476] dbg: check: tagrun - tag RELAYSINTERNAL is now ready, value: 
1002Dec  2 21:10:00.223 [17476] dbg: check: tagrun - tag RELAYSEXTERNAL is now ready, value: 
1003Dec  2 21:10:00.223 [17476] dbg: check: tagrun - tag LANGUAGES is now ready, value: 
1004Dec  2 21:10:00.224 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::ExtractText=HASH(0x1d943d0) implements 'parsed_metadata', priority 0
1005Dec  2 21:10:00.224 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::RelayCountry=HASH(0x1ceb308) implements 'parsed_metadata', priority 0
1006Dec  2 21:10:00.226 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::URIDNSBL=HASH(0x1e58790) implements 'parsed_metadata', priority 0
1007Dec  2 21:10:00.227 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::ASN=HASH(0x1a7c2b8) implements 'parsed_metadata', priority 0
1008Dec  2 21:10:00.227 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::FromNameSpoof=HASH(0x26cb8f8) implements 'parsed_metadata', priority 0
1009Dec  2 21:10:00.228 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::DecodeShortURLs=HASH(0x309d0f0) implements 'parsed_metadata', priority -1
1010Dec  2 21:10:00.259 [17476] dbg: check: tagrun - tag EXTRACTTEXTWORDS is now ready, value: 0
1011Dec  2 21:10:00.260 [17476] dbg: check: tagrun - tag EXTRACTTEXTCHARS is now ready, value: 0
1012Dec  2 21:10:00.260 [17476] dbg: check: tagrun - tag EXTRACTTEXTTOOLS is now ready, value: 
1013Dec  2 21:10:00.261 [17476] dbg: check: tagrun - tag EXTRACTTEXTTYPES is now ready, value: 
1014Dec  2 21:10:00.261 [17476] dbg: check: tagrun - tag EXTRACTTEXTEXTENSIONS is now ready, value: 
1015Dec  2 21:10:00.262 [17476] dbg: check: tagrun - tag EXTRACTTEXTFLAGS is now ready, value: 
1016Dec  2 21:10:00.262 [17476] dbg: check: tagrun - tag RELAYCOUNTRY is now ready, value: ARY:[]
1017Dec  2 21:10:00.266 [17476] dbg: asn: no first external relay IP available, skipping ASN check
1018Dec  2 21:10:00.266 [17476] dbg: check: tagrun - action 2 blocking on tags DKIMDOMAIN
1019Dec  2 21:10:00.267 [17476] dbg: dns: checking RBL zen.spamhaus.org., set zen-lastexternal
1020Dec  2 21:10:00.269 [17476] dbg: dns: checking RBL wl.mailspike.net., set mspikeg-firsttrusted
1021Dec  2 21:10:00.270 [17476] dbg: dns: checking RBL bl.spamcop.net., set spamcop
1022Dec  2 21:10:00.271 [17476] dbg: dns: checking RBL bl.mailspike.net., set mspikeb-lastexternal
1023Dec  2 21:10:00.272 [17476] dbg: dns: checking RBL bl.suomispam.net., set suomispam
1024Dec  2 21:10:00.273 [17476] dbg: dns: checking RBL zen.spamhaus.org., set zen-lastexternal
1025Dec  2 21:10:00.274 [17476] dbg: dns: checking RBL virbl.dnsbl.bit.nl., set virbl
1026Dec  2 21:10:00.275 [17476] dbg: dns: checking RBL list.dnswl.org., set dnswl-firsttrusted
1027Dec  2 21:10:00.276 [17476] dbg: dns: checking RBL iadb.isipp.com., set iadb-firsttrusted
1028Dec  2 21:10:00.276 [17476] dbg: dns: checking RBL sa-accredit.habeas.com., set ssc-firsttrusted
1029Dec  2 21:10:00.278 [17476] dbg: dns: checking RBL zen.spamhaus.org., set zen
1030Dec  2 21:10:00.279 [17476] dbg: dns: checking RBL bl.score.senderscore.com., set rnbl-lastexternal
1031Dec  2 21:10:00.280 [17476] dbg: dns: checking RBL ubl.unsubscore.com., set LASHBACK
1032Dec  2 21:10:00.281 [17476] dbg: dns: checking RBL psbl.surriel.com., set psbl-lastexternal
1033Dec  2 21:10:00.282 [17476] dbg: dns: checking RBL dnsbl.sorbs.net., set sorbs
1034Dec  2 21:10:00.283 [17476] dbg: dns: checking RBL sip.invaluement.com., set ivmbl-lastexternal
1035Dec  2 21:10:00.283 [17476] dbg: dns: checking RBL sa-trusted.bondedsender.org., set ssc-firsttrusted
1036Dec  2 21:10:00.284 [17476] dbg: dns: checking RBL dnsbl.sorbs.net., set sorbs-lastexternal
1037Dec  2 21:10:00.285 [17476] dbg: dns: checking RBL sip24.invaluement.com., set ivm24bl-lastexternal
1038Dec  2 21:10:00.286 [17476] dbg: check: check_main, time limit in 272.976 s
1039Dec  2 21:10:00.288 [17476] dbg: check: running tests for priority: -1000
1040Dec  2 21:10:00.289 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x1f3c378) implements 'check_rules_at_priority', priority 0
1041Dec  2 21:10:00.290 [17476] dbg: rules: running one_line_body tests; score so far=0
1042Dec  2 21:10:00.292 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 524 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg1000_1
1043Dec  2 21:10:00.294 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -1000
1044Dec  2 21:10:00.295 [17476] dbg: rules: compiled one_line_body tests
1045Dec  2 21:10:00.296 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::Rule2XSBody=HASH(0x1f3c378) implements 'run_body_fast_scan', priority 0
1046Dec  2 21:10:00.298 [17476] dbg: rules: running head tests; score so far=0
1047Dec  2 21:10:00.299 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 304 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg1000_1
1048Dec  2 21:10:00.301 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority -1000
1049Dec  2 21:10:00.302 [17476] dbg: rules: compiled head tests
1050Dec  2 21:10:00.303 [17476] dbg: rules: running head_eval tests; score so far=0
1051Dec  2 21:10:00.306 [17476] dbg: rules: run_eval_tests - compiling eval code: 9, priority -1000
1052Dec  2 21:10:00.314 [17476] dbg: eval: all '*To' addrs: 
1053Dec  2 21:10:00.316 [17476] dbg: eval: all '*From' addrs: 
1054Dec  2 21:10:00.318 [17476] dbg: rules: running body tests; score so far=0
1055Dec  2 21:10:00.319 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 247 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg1000_1
1056Dec  2 21:10:00.321 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority -1000
1057Dec  2 21:10:00.322 [17476] dbg: rules: compiled body tests
1058Dec  2 21:10:00.323 [17476] dbg: rules: running uri tests; score so far=0
1059Dec  2 21:10:00.324 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 245 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg1000_1
1060Dec  2 21:10:00.325 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority -1000
1061Dec  2 21:10:00.326 [17476] dbg: rules: compiled uri tests
1062Dec  2 21:10:00.328 [17476] dbg: rules: running body_eval tests; score so far=0
1063Dec  2 21:10:00.328 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority -1000
1064Dec  2 21:10:00.331 [17476] dbg: rules: running rawbody tests; score so far=0
1065Dec  2 21:10:00.332 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 253 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg1000_1
1066Dec  2 21:10:00.333 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -1000
1067Dec  2 21:10:00.334 [17476] dbg: rules: compiled rawbody tests
1068Dec  2 21:10:00.335 [17476] dbg: rules: running full tests; score so far=0
1069Dec  2 21:10:00.336 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 282 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg1000_1
1070Dec  2 21:10:00.338 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority -1000
1071Dec  2 21:10:00.339 [17476] dbg: rules: compiled full tests
1072Dec  2 21:10:00.340 [17476] dbg: rules: running meta tests; score so far=0
1073Dec  2 21:10:00.341 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 307 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg1000_1
1074Dec  2 21:10:00.342 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority -1000
1075Dec  2 21:10:00.343 [17476] dbg: rules: compiled meta tests
1076Dec  2 21:10:00.346 [17476] dbg: check: running tests for priority: -950
1077Dec  2 21:10:00.346 [17476] dbg: rules: running one_line_body tests; score so far=0
1078Dec  2 21:10:00.347 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 521 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg950_1
1079Dec  2 21:10:00.349 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -950
1080Dec  2 21:10:00.350 [17476] dbg: rules: compiled one_line_body tests
1081Dec  2 21:10:00.352 [17476] dbg: rules: running head tests; score so far=0
1082Dec  2 21:10:00.353 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 302 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg950_1
1083Dec  2 21:10:00.354 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority -950
1084Dec  2 21:10:00.355 [17476] dbg: rules: compiled head tests
1085Dec  2 21:10:00.357 [17476] dbg: rules: running head_eval tests; score so far=0
1086Dec  2 21:10:00.358 [17476] dbg: rules: run_eval_tests - compiling eval code: 9, priority -950
1087Dec  2 21:10:00.362 [17476] dbg: rules: running body tests; score so far=0
1088Dec  2 21:10:00.363 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 245 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg950_1
1089Dec  2 21:10:00.364 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority -950
1090Dec  2 21:10:00.365 [17476] dbg: rules: compiled body tests
1091Dec  2 21:10:00.366 [17476] dbg: rules: running uri tests; score so far=0
1092Dec  2 21:10:00.367 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 243 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg950_1
1093Dec  2 21:10:00.369 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority -950
1094Dec  2 21:10:00.370 [17476] dbg: rules: compiled uri tests
1095Dec  2 21:10:00.371 [17476] dbg: rules: running body_eval tests; score so far=0
1096Dec  2 21:10:00.372 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority -950
1097Dec  2 21:10:00.374 [17476] dbg: rules: running rawbody tests; score so far=0
1098Dec  2 21:10:00.374 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 251 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg950_1
1099Dec  2 21:10:00.376 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -950
1100Dec  2 21:10:00.377 [17476] dbg: rules: compiled rawbody tests
1101Dec  2 21:10:00.378 [17476] dbg: rules: running full tests; score so far=0
1102Dec  2 21:10:00.379 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 280 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg950_1
1103Dec  2 21:10:00.381 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority -950
1104Dec  2 21:10:00.381 [17476] dbg: rules: compiled full tests
1105Dec  2 21:10:00.383 [17476] dbg: rules: running meta tests; score so far=0
1106Dec  2 21:10:00.384 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 305 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg950_1
1107Dec  2 21:10:00.385 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority -950
1108Dec  2 21:10:00.386 [17476] dbg: rules: compiled meta tests
1109Dec  2 21:10:00.388 [17476] dbg: check: running tests for priority: -900
1110Dec  2 21:10:00.389 [17476] dbg: rules: running one_line_body tests; score so far=0
1111Dec  2 21:10:00.389 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 521 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg900_1
1112Dec  2 21:10:00.391 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -900
1113Dec  2 21:10:00.392 [17476] dbg: rules: compiled one_line_body tests
1114Dec  2 21:10:00.394 [17476] dbg: rules: running head tests; score so far=0
1115Dec  2 21:10:00.394 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 302 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg900_1
1116Dec  2 21:10:00.396 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority -900
1117Dec  2 21:10:00.397 [17476] dbg: rules: compiled head tests
1118Dec  2 21:10:00.399 [17476] dbg: rules: running head_eval tests; score so far=0
1119Dec  2 21:10:00.400 [17476] dbg: rules: run_eval_tests - compiling eval code: 9, priority -900
1120Dec  2 21:10:00.406 [17476] dbg: rules: running body tests; score so far=0
1121Dec  2 21:10:00.407 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 245 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg900_1
1122Dec  2 21:10:00.409 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority -900
1123Dec  2 21:10:00.410 [17476] dbg: rules: compiled body tests
1124Dec  2 21:10:00.411 [17476] dbg: rules: running uri tests; score so far=0
1125Dec  2 21:10:00.412 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 243 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg900_1
1126Dec  2 21:10:00.414 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority -900
1127Dec  2 21:10:00.415 [17476] dbg: rules: compiled uri tests
1128Dec  2 21:10:00.416 [17476] dbg: rules: running body_eval tests; score so far=0
1129Dec  2 21:10:00.417 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority -900
1130Dec  2 21:10:00.419 [17476] dbg: rules: running rawbody tests; score so far=0
1131Dec  2 21:10:00.420 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 251 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg900_1
1132Dec  2 21:10:00.421 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -900
1133Dec  2 21:10:00.422 [17476] dbg: rules: compiled rawbody tests
1134Dec  2 21:10:00.423 [17476] dbg: rules: running full tests; score so far=0
1135Dec  2 21:10:00.424 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 280 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg900_1
1136Dec  2 21:10:00.426 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority -900
1137Dec  2 21:10:00.426 [17476] dbg: rules: compiled full tests
1138Dec  2 21:10:00.428 [17476] dbg: rules: running meta tests; score so far=0
1139Dec  2 21:10:00.429 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 305 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg900_1
1140Dec  2 21:10:00.430 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority -900
1141Dec  2 21:10:00.431 [17476] dbg: rules: compiled meta tests
1142Dec  2 21:10:00.433 [17476] dbg: check: running tests for priority: -90
1143Dec  2 21:10:00.434 [17476] dbg: rules: running one_line_body tests; score so far=0
1144Dec  2 21:10:00.434 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 518 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_neg90_1
1145Dec  2 21:10:00.436 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority -90
1146Dec  2 21:10:00.437 [17476] dbg: rules: compiled one_line_body tests
1147Dec  2 21:10:00.438 [17476] dbg: rules: running head tests; score so far=0
1148Dec  2 21:10:00.439 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 300 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_neg90_1
1149Dec  2 21:10:00.441 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority -90
1150Dec  2 21:10:00.442 [17476] dbg: rules: compiled head tests
1151Dec  2 21:10:00.444 [17476] dbg: rules: running body tests; score so far=0
1152Dec  2 21:10:00.445 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 243 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_neg90_1
1153Dec  2 21:10:00.446 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority -90
1154Dec  2 21:10:00.447 [17476] dbg: rules: compiled body tests
1155Dec  2 21:10:00.448 [17476] dbg: rules: running uri tests; score so far=0
1156Dec  2 21:10:00.449 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 241 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_neg90_1
1157Dec  2 21:10:00.450 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority -90
1158Dec  2 21:10:00.451 [17476] dbg: rules: compiled uri tests
1159Dec  2 21:10:00.453 [17476] dbg: rules: running body_eval tests; score so far=0
1160Dec  2 21:10:00.454 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority -90
1161Dec  2 21:10:00.466 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::WLBLEval=HASH(0x2612498) implements 'check_wb_list', priority 0
1162Dec  2 21:10:00.469 [17476] dbg: bayes: nspam_nham_get nspam=159920, nham=991425
1163Dec  2 21:10:00.471 [17476] dbg: bayes: nspam_nham_get nspam=159920, nham=991425
1164Dec  2 21:10:00.472 [17476] dbg: bayes: corpus size: nspam = 159920, nham = 991425
1165Dec  2 21:10:00.491 [17476] dbg: bayes: tokenized body: 237 tokens
1166Dec  2 21:10:00.493 [17476] dbg: bayes: tokenized uri: 0 tokens
1167Dec  2 21:10:00.493 [17476] dbg: bayes: tokenized invisible: 0 tokens
1168Dec  2 21:10:00.504 [17476] dbg: bayes: tokenized header: 21 tokens
1169Dec  2 21:10:00.521 [17476] dbg: bayes: tok_get_all found 45 tokens out of 91
1170Dec  2 21:10:00.529 [17476] dbg: bayes: score = 5.55111512312578e-17
1171Dec  2 21:10:00.530 [17476] dbg: bayes: tok_touch_all setting expire to 1814400 on 37 tokens
1172Dec  2 21:10:00.535 [17476] dbg: check: tagrun - tag BAYESTCHAMMY is now ready, value: 37
1173Dec  2 21:10:00.536 [17476] dbg: check: tagrun - tag BAYESTCSPAMMY is now ready, value: 0
1174Dec  2 21:10:00.536 [17476] dbg: check: tagrun - tag BAYESTCLEARNED is now ready, value: 45
1175Dec  2 21:10:00.537 [17476] dbg: check: tagrun - tag BAYESTC is now ready, value: 91
1176Dec  2 21:10:00.537 [17476] dbg: check: tagrun - tag HAMMYTOKENS is now ready, value: CODE(0x1bb07a0)
1177Dec  2 21:10:00.538 [17476] dbg: check: tagrun - tag SPAMMYTOKENS is now ready, value: CODE(0x3149ff0)
1178Dec  2 21:10:00.538 [17476] dbg: check: tagrun - tag TOKENSUMMARY is now ready, value: CODE(0x256a9c0)
1179Dec  2 21:10:00.544 [17476] dbg: rules: ran eval rule BAYES_00 ======> got hit (1)
1180Dec  2 21:10:00.545 [17476] dbg: rules: running rawbody tests; score so far=-1.9
1181Dec  2 21:10:00.546 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 249 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_neg90_1
1182Dec  2 21:10:00.548 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority -90
1183Dec  2 21:10:00.549 [17476] dbg: rules: compiled rawbody tests
1184Dec  2 21:10:00.550 [17476] dbg: rules: running full tests; score so far=-1.9
1185Dec  2 21:10:00.551 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 278 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_neg90_1
1186Dec  2 21:10:00.553 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority -90
1187Dec  2 21:10:00.554 [17476] dbg: rules: compiled full tests
1188Dec  2 21:10:00.555 [17476] dbg: rules: running meta tests; score so far=-1.9
1189Dec  2 21:10:00.556 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 303 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_neg90_1
1190Dec  2 21:10:00.557 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority -90
1191Dec  2 21:10:00.558 [17476] dbg: rules: compiled meta tests
1192Dec  2 21:10:00.560 [17476] dbg: check: running tests for priority: 0
1193Dec  2 21:10:00.561 [17476] dbg: rules: running one_line_body tests; score so far=-1.9
1194Dec  2 21:10:00.880 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 510 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_0_1
1195Dec  2 21:10:00.892 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 0
1196Dec  2 21:10:02.317 [17476] dbg: rules: compiled one_line_body tests
1197Dec  2 21:10:02.318 [17476] dbg: zoom: run_body_fast_scan for body_0 start
1198Dec  2 21:10:02.365 [17476] dbg: zoom: run_body_fast_scan for body_0 done
1199Dec  2 21:10:02.366 [17476] dbg: rules: running head tests; score so far=-1.9
1200Dec  2 21:10:02.590 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60537 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_1
1201Dec  2 21:10:02.669 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60340 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_2
1202Dec  2 21:10:02.752 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60460 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_3
1203Dec  2 21:10:02.829 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60212 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_4
1204Dec  2 21:10:02.924 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60418 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_5
1205Dec  2 21:10:03.024 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60093 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_6
1206Dec  2 21:10:03.121 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60316 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_7
1207Dec  2 21:10:03.222 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60454 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_8
1208Dec  2 21:10:03.309 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60436 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_9
1209Dec  2 21:10:03.396 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60136 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_10
1210Dec  2 21:10:03.484 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 53883 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_0_11
1211Dec  2 21:10:03.554 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority 0
1212Dec  2 21:10:03.558 [17476] dbg: rules: compiled head tests
1213Dec  2 21:10:03.562 [17476] dbg: rules: ran header rule __SUBJECT_EMPTY ======> got hit: "negative match"
1214Dec  2 21:10:03.570 [17476] dbg: rules: ran header rule __KAM_WU1 ======> got hit: "negative match"
1215Dec  2 21:10:03.574 [17476] dbg: rules: ran header rule __MISSING_REF ======> got hit: "UNSET"
1216Dec  2 21:10:03.579 [17476] dbg: rules: ran header rule __SUBJ_SHORT ======> got hit: "negative match"
1217Dec  2 21:10:03.585 [17476] dbg: rules: ran header rule __TO_NO_ARROWS_R ======> got hit: "negative match"
1218Dec  2 21:10:03.588 [17476] dbg: rules: ran header rule __MISSING_REPLY ======> got hit: "UNSET"
1219Dec  2 21:10:03.592 [17476] dbg: rules: ran header rule __KAM_DROPBOX2 ======> got hit: "negative match"
1220Dec  2 21:10:03.595 [17476] dbg: rules: ran header rule __KAM_HARP3 ======> got hit: "negative match"
1221Dec  2 21:10:03.598 [17476] dbg: rules: ran header rule __KAM_FAKEDELIVER4 ======> got hit: "negative match"
1222Dec  2 21:10:03.600 [17476] dbg: rules: ran header rule __KAM_PAYPAL3B ======> got hit: "negative match"
1223Dec  2 21:10:03.602 [17476] dbg: rules: ran header rule __KAM_FAKEDELIVER12 ======> got hit: "negative match"
1224Dec  2 21:10:03.604 [17476] dbg: rules: ran header rule __KAM_FAKEDELIVER6 ======> got hit: "negative match"
1225Dec  2 21:10:03.606 [17476] dbg: rules: ran header rule __KAM_FAKEDELIVER8 ======> got hit: "negative match"
1226Dec  2 21:10:03.610 [17476] dbg: rules: ran header rule __KAM_JURY3 ======> got hit: "negative match"
1227Dec  2 21:10:03.612 [17476] dbg: rules: ran header rule __KAM_GOOGLE2_2 ======> got hit: "negative match"
1228Dec  2 21:10:03.614 [17476] dbg: rules: ran header rule __KAM_UPS2 ======> got hit: "negative match"
1229Dec  2 21:10:03.622 [17476] dbg: rules: running head_eval tests; score so far=-1.9
1230Dec  2 21:10:03.633 [17476] dbg: rules: run_eval_tests - compiling eval code: 9, priority 0
1231Dec  2 21:10:03.714 [17476] dbg: spf: checking to see if the message has a Received-SPF header that we can use
1232Dec  2 21:10:03.855 [17476] dbg: spf: using Mail::SPF for SPF checks
1233Dec  2 21:10:03.856 [17476] dbg: spf: no suitable relay for spf use found, skipping SPF check
1234Dec  2 21:10:03.860 [17476] dbg: rules: ran eval rule __ENV_AND_HDR_FROM_MATCH ======> got hit (1)
1235Dec  2 21:10:03.862 [17476] dbg: spf: already checked for Received-SPF headers, proceeding with DNS based checks
1236Dec  2 21:10:03.863 [17476] dbg: spf: no suitable relay for spf use found, skipping SPF-helo check
1237Dec  2 21:10:03.867 [17476] dbg: rules: ran eval rule __GATED_THROUGH_RCVD_REMOVER ======> got hit (1)
1238Dec  2 21:10:04.059 [17476] dbg: dkim: using Mail::DKIM version 0.53
1239Dec  2 21:10:04.060 [17476] dbg: dkim: providing our own resolver: Mail::SpamAssassin::DnsResolver
1240Dec  2 21:10:04.064 [17476] dbg: dkim: performing public key lookup and signature verification
1241Dec  2 21:10:04.065 [17476] dbg: dkim: signature verification result: none
1242Dec  2 21:10:04.065 [17476] dbg: dkim: adsp not retrieved, no author f.q. domain name
1243Dec  2 21:10:04.067 [17476] dbg: dkim: check_dkim_whitelist: could not find author address
1244Dec  2 21:10:04.071 [17476] dbg: FreeMail: RULE (__freemail_dispto) check_freemail_header
1245Dec  2 21:10:04.072 [17476] dbg: FreeMail: header Disposition-Notification-To not found from mail
1246Dec  2 21:10:04.076 [17476] dbg: FreeMail: RULE (FREEMAIL_FROM) check_freemail_from
1247Dec  2 21:10:04.077 [17476] dbg: FreeMail: no from-addresses found to check
1248Dec  2 21:10:04.081 [17476] dbg: spf: def_spf_whitelist_from: already checked spf and didn't get pass, skipping whitelist check
1249Dec  2 21:10:04.084 [17476] dbg: spf: whitelist_from_spf: already checked spf and didn't get pass, skipping whitelist check
1250Dec  2 21:10:04.087 [17476] dbg: rules: ran eval rule MISSING_HEADERS ======> got hit (1)
1251Dec  2 21:10:04.088 [17476] dbg: FreeMail: RULE (__smf_freemail_hdr_replyto) check_freemail_header
1252Dec  2 21:10:04.089 [17476] dbg: FreeMail: header Reply-To:addr not found from mail
1253Dec  2 21:10:04.091 [17476] dbg: FreeMail: RULE (__freemail_hdr_replyto) check_freemail_header
1254Dec  2 21:10:04.092 [17476] dbg: FreeMail: header Reply-To not found from mail
1255Dec  2 21:10:04.093 [17476] dbg: SenderChecks: matching from/replyto: /
1256Dec  2 21:10:04.094 [17476] dbg: FreeMail: RULE (FREEMAIL_ENVFROM_END_DIGIT) check_freemail_header regex:\d@
1257Dec  2 21:10:04.094 [17476] dbg: FreeMail: header EnvelopeFrom not found from mail
1258Dec  2 21:10:04.112 [17476] dbg: rules: ran eval rule NO_RELAYS ======> got hit (1)
1259Dec  2 21:10:04.113 [17476] dbg: FreeMail: RULE (FREEMAIL_REPLYTO_END_DIGIT) check_freemail_header regex:\d@
1260Dec  2 21:10:04.113 [17476] dbg: FreeMail: header Reply-To not found from mail
1261Dec  2 21:10:04.115 [17476] dbg: FreeMail: RULE (__freemail_replyto) check_freemail_replyto
1262Dec  2 21:10:04.115 [17476] dbg: FreeMail: Reply-To is not freemail, skipping check
1263Dec  2 21:10:04.118 [17476] dbg: FreeMail: RULE (__freemail_reply) check_freemail_replyto
1264Dec  2 21:10:04.118 [17476] dbg: FreeMail: No Reply-To and From is not freemail, skipping check
1265Dec  2 21:10:04.123 [17476] dbg: SenderChecks: matching from/to: /
1266Dec  2 21:10:04.125 [17476] dbg: rules: running body tests; score so far=-0.88
1267Dec  2 21:10:04.140 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 61835 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_1
1268Dec  2 21:10:04.282 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60397 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_2
1269Dec  2 21:10:04.404 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60085 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_3
1270Dec  2 21:10:04.536 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60112 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_4
1271Dec  2 21:10:04.651 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 7616 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_0_5
1272Dec  2 21:10:04.670 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority 0
1273Dec  2 21:10:04.672 [17476] dbg: rules: compiled body tests
1274Dec  2 21:10:04.678 [17476] dbg: rules: ran body rule __BODY_TEXT_LINE ======> got hit: "D"
1275Dec  2 21:10:04.853 [17476] dbg: rules: ran body rule __NONEMPTY_BODY ======> got hit: "D"
1276Dec  2 21:10:04.982 [17476] dbg: rules: ran body rule __hk_body_over_400b ======> got hit: "Dec 2 21:09:33.187 [17476] dbg: generic: Perl 5.024001, PREFIX=/usr/local, DEF_RULES_DIR=/usr/local/share/spamassassin, LOCAL_RULES_DIR=/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin Dec 2 21:09:33.187 [17476] dbg: config: timing enabled Dec 2 21:09:33.203 [17476] dbg: config: score set 0 chosen. Dec 2 21:09:33.232 [17476] dbg: util: running in taint mode? yes Dec 2 21:09:33.233 [17"
1277Dec  2 21:10:05.100 [17476] dbg: rules: running uri tests; score so far=-0.88
1278Dec  2 21:10:05.127 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 57170 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_0_1
1279Dec  2 21:10:05.204 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority 0
1280Dec  2 21:10:05.206 [17476] dbg: rules: compiled uri tests
1281Dec  2 21:10:05.208 [17476] dbg: rules: running body_eval tests; score so far=-0.88
1282Dec  2 21:10:05.227 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority 0
1283Dec  2 21:10:05.420 [17476] dbg: https_http_mismatch: anchors 0
1284Dec  2 21:10:05.424 [17476] dbg: eval: body_length - 1443 - check for min of 256
1285Dec  2 21:10:05.427 [17476] dbg: pdfinfo: Identified 0 possible mime parts that need checked for PDF content
1286Dec  2 21:10:05.428 [17476] dbg: pdfinfo: set_tag called for PDFCOUNT 0
1287Dec  2 21:10:05.428 [17476] dbg: pdfinfo: set_tag called for PDFIMGCOUNT 0
1288Dec  2 21:10:05.430 [17476] dbg: eval: body_length - 1443 - check for min of 128
1289Dec  2 21:10:05.436 [17476] dbg: eval: tvd_vertical_words value: 13 / min: 0 / max: 10 - value must be >= min and < max
1290Dec  2 21:10:05.438 [17476] dbg: eval: body_length - 1443 - check for min of 1024
1291Dec  2 21:10:05.459 [17476] dbg: rules: ran eval rule __HAVE_BOUNCE_RELAYS ======> got hit (1)
1292Dec  2 21:10:05.483 [17476] dbg: eval: body_length - 1443 - check for min of 512
1293Dec  2 21:10:05.492 [17476] dbg: rules: running rawbody tests; score so far=-0.88
1294Dec  2 21:10:05.519 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60146 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_0_1
1295Dec  2 21:10:05.613 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 1368 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_0_2
1296Dec  2 21:10:05.617 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 0
1297Dec  2 21:10:05.618 [17476] dbg: rules: compiled rawbody tests
1298Dec  2 21:10:05.624 [17476] dbg: rules: ran rawbody rule __RB_GT_200 ======> got hit: "Dec 2 21:09:33.187 [17476] dbg: generic: Perl 5.024001, PREFIX=/usr/local, DEF_RULES_DIR=/usr/local/share/spamassassin, LOCAL_RULES_DIR=/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin
1299Dec  2 21:10:05.625 [17476] dbg: rules: [...] De"
1300Dec  2 21:10:05.660 [17476] dbg: rules: running rawbody_eval tests; score so far=-0.88
1301Dec  2 21:10:05.662 [17476] dbg: rules: run_eval_tests - compiling eval code: 15, priority 0
1302Dec  2 21:10:05.672 [17476] dbg: rules: running full tests; score so far=-0.88
1303Dec  2 21:10:05.674 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 2599 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_0_1
1304Dec  2 21:10:05.679 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority 0
1305Dec  2 21:10:05.680 [17476] dbg: rules: compiled full tests
1306Dec  2 21:10:05.681 [17476] dbg: rules-all: running full rule __BASE64_MDAW
1307Dec  2 21:10:05.681 [17476] dbg: rules-all: running full rule __FROM_NAME_IN_MSG
1308Dec  2 21:10:05.682 [17476] dbg: rules-all: running full rule __RW_BAD_UTF8_3
1309Dec  2 21:10:05.682 [17476] dbg: rules-all: running full rule NULL_IN_BODY
1310Dec  2 21:10:05.683 [17476] dbg: rules: running full_eval tests; score so far=-0.88
1311Dec  2 21:10:05.684 [17476] dbg: rules: run_eval_tests - compiling eval code: 13, priority 0
1312Dec  2 21:10:05.695 [17476] dbg: rules: ran eval rule __DKIM_DEPENDABLE ======> got hit (1)
1313Dec  2 21:10:05.698 [17476] dbg: rules: running meta tests; score so far=-0.88
1314Dec  2 21:10:05.699 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 297 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_0_1
1315Dec  2 21:10:05.700 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority 0
1316Dec  2 21:10:05.701 [17476] dbg: rules: compiled meta tests
1317Dec  2 21:10:05.703 [17476] dbg: check: running tests for priority: 2
1318Dec  2 21:10:05.704 [17476] dbg: rules: running one_line_body tests; score so far=-0.88
1319Dec  2 21:10:06.080 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 510 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_2_1
1320Dec  2 21:10:06.089 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 2
1321Dec  2 21:10:07.447 [17476] dbg: rules: compiled one_line_body tests
1322Dec  2 21:10:07.448 [17476] dbg: zoom: run_body_fast_scan for body_2 start
1323Dec  2 21:10:07.450 [17476] dbg: zoom: run_body_fast_scan for body_2 done
1324Dec  2 21:10:07.451 [17476] dbg: rules: running head tests; score so far=-0.88
1325Dec  2 21:10:07.452 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 294 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_2_1
1326Dec  2 21:10:07.454 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority 2
1327Dec  2 21:10:07.455 [17476] dbg: rules: compiled head tests
1328Dec  2 21:10:07.456 [17476] dbg: rules: running body tests; score so far=-0.88
1329Dec  2 21:10:07.457 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 237 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_2_1
1330Dec  2 21:10:07.459 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority 2
1331Dec  2 21:10:07.460 [17476] dbg: rules: compiled body tests
1332Dec  2 21:10:07.461 [17476] dbg: rules: running uri tests; score so far=-0.88
1333Dec  2 21:10:07.462 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 235 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_2_1
1334Dec  2 21:10:07.464 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority 2
1335Dec  2 21:10:07.465 [17476] dbg: rules: compiled uri tests
1336Dec  2 21:10:07.466 [17476] dbg: rules: running body_eval tests; score so far=-0.88
1337Dec  2 21:10:07.467 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority 2
1338Dec  2 21:10:07.469 [17476] dbg: rules: running rawbody tests; score so far=-0.88
1339Dec  2 21:10:07.470 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 243 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_2_1
1340Dec  2 21:10:07.471 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 2
1341Dec  2 21:10:07.472 [17476] dbg: rules: compiled rawbody tests
1342Dec  2 21:10:07.474 [17476] dbg: rules: running full tests; score so far=-0.88
1343Dec  2 21:10:07.475 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 272 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_2_1
1344Dec  2 21:10:07.476 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority 2
1345Dec  2 21:10:07.477 [17476] dbg: rules: compiled full tests
1346Dec  2 21:10:07.478 [17476] dbg: rules: running meta tests; score so far=-0.88
1347Dec  2 21:10:07.479 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 297 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_2_1
1348Dec  2 21:10:07.481 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority 2
1349Dec  2 21:10:07.482 [17476] dbg: rules: compiled meta tests
1350Dec  2 21:10:07.483 [17476] dbg: check: running tests for priority: 20
1351Dec  2 21:10:07.484 [17476] dbg: rules: running one_line_body tests; score so far=-0.88
1352Dec  2 21:10:07.485 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 513 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_20_1
1353Dec  2 21:10:07.487 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 20
1354Dec  2 21:10:07.488 [17476] dbg: rules: compiled one_line_body tests
1355Dec  2 21:10:07.489 [17476] dbg: rules: running head tests; score so far=-0.88
1356Dec  2 21:10:07.490 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 296 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_20_1
1357Dec  2 21:10:07.492 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority 20
1358Dec  2 21:10:07.493 [17476] dbg: rules: compiled head tests
1359Dec  2 21:10:07.495 [17476] dbg: rules: running body tests; score so far=-0.88
1360Dec  2 21:10:07.496 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 239 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_20_1
1361Dec  2 21:10:07.497 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority 20
1362Dec  2 21:10:07.498 [17476] dbg: rules: compiled body tests
1363Dec  2 21:10:07.499 [17476] dbg: rules: running uri tests; score so far=-0.88
1364Dec  2 21:10:07.500 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 237 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_20_1
1365Dec  2 21:10:07.502 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority 20
1366Dec  2 21:10:07.503 [17476] dbg: rules: compiled uri tests
1367Dec  2 21:10:07.504 [17476] dbg: rules: running body_eval tests; score so far=-0.88
1368Dec  2 21:10:07.505 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority 20
1369Dec  2 21:10:07.507 [17476] dbg: rules: running rawbody tests; score so far=-0.88
1370Dec  2 21:10:07.508 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 245 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_20_1
1371Dec  2 21:10:07.509 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 20
1372Dec  2 21:10:07.510 [17476] dbg: rules: compiled rawbody tests
1373Dec  2 21:10:07.512 [17476] dbg: rules: running full tests; score so far=-0.88
1374Dec  2 21:10:07.513 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 274 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_20_1
1375Dec  2 21:10:07.514 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority 20
1376Dec  2 21:10:07.515 [17476] dbg: rules: compiled full tests
1377Dec  2 21:10:07.516 [17476] dbg: rules: running full_eval tests; score so far=-0.88
1378Dec  2 21:10:07.517 [17476] dbg: rules: run_eval_tests - compiling eval code: 13, priority 20
1379Dec  2 21:10:07.522 [17476] dbg: dns: entering helper-app run mode
1380Dec  2 21:10:09.114 [17476] dbg: dns: leaving helper-app run mode
1381Dec  2 21:10:09.118 [17476] dbg: razor2: part=0 noresponse
1382Dec  2 21:10:09.118 [17476] dbg: razor2: results: spam? 0
1383Dec  2 21:10:09.119 [17476] dbg: razor2: results: engine 4, highest cf score: 0
1384Dec  2 21:10:09.119 [17476] dbg: razor2: results: engine 8, highest cf score: 0
1385Dec  2 21:10:09.122 [17476] dbg: rules: running meta tests; score so far=-0.88
1386Dec  2 21:10:09.124 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 299 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_20_1
1387Dec  2 21:10:09.126 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority 20
1388Dec  2 21:10:09.128 [17476] dbg: rules: compiled meta tests
1389Dec  2 21:10:09.130 [17476] dbg: check: running tests for priority: 30
1390Dec  2 21:10:09.131 [17476] dbg: rules: running one_line_body tests; score so far=-0.88
1391Dec  2 21:10:09.132 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 513 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_30_1
1392Dec  2 21:10:09.135 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 30
1393Dec  2 21:10:09.136 [17476] dbg: rules: compiled one_line_body tests
1394Dec  2 21:10:09.138 [17476] dbg: rules: running head tests; score so far=-0.88
1395Dec  2 21:10:09.140 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 296 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_30_1
1396Dec  2 21:10:09.142 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority 30
1397Dec  2 21:10:09.143 [17476] dbg: rules: compiled head tests
1398Dec  2 21:10:09.146 [17476] dbg: rules: running body tests; score so far=-0.88
1399Dec  2 21:10:09.147 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 239 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_30_1
1400Dec  2 21:10:09.149 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority 30
1401Dec  2 21:10:09.150 [17476] dbg: rules: compiled body tests
1402Dec  2 21:10:09.152 [17476] dbg: rules: running uri tests; score so far=-0.88
1403Dec  2 21:10:09.154 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 237 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_30_1
1404Dec  2 21:10:09.155 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority 30
1405Dec  2 21:10:09.157 [17476] dbg: rules: compiled uri tests
1406Dec  2 21:10:09.159 [17476] dbg: rules: running body_eval tests; score so far=-0.88
1407Dec  2 21:10:09.160 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority 30
1408Dec  2 21:10:09.163 [17476] dbg: rules: running rawbody tests; score so far=-0.88
1409Dec  2 21:10:09.164 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 245 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_30_1
1410Dec  2 21:10:09.166 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 30
1411Dec  2 21:10:09.167 [17476] dbg: rules: compiled rawbody tests
1412Dec  2 21:10:09.169 [17476] dbg: rules: running full tests; score so far=-0.88
1413Dec  2 21:10:09.171 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 274 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_30_1
1414Dec  2 21:10:09.173 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority 30
1415Dec  2 21:10:09.174 [17476] dbg: rules: compiled full tests
1416Dec  2 21:10:09.176 [17476] dbg: rules: running full_eval tests; score so far=-0.88
1417Dec  2 21:10:09.178 [17476] dbg: rules: run_eval_tests - compiling eval code: 13, priority 30
1418Dec  2 21:10:09.183 [17476] dbg: util: current PATH is: /home/jarif/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/games:/usr/games
1419Dec  2 21:10:09.184 [17476] dbg: util: executable for pyzor was found at /usr/bin/pyzor
1420Dec  2 21:10:09.185 [17476] dbg: pyzor: pyzor is available: /usr/bin/pyzor
1421Dec  2 21:10:09.187 [17476] dbg: util: secure_tmpfile created a temporary file /tmp/.spamassassin174766aMXt7tmp
1422Dec  2 21:10:09.188 [17476] dbg: check: create_fulltext_tmpfile, written 1638 bytes to file /tmp/.spamassassin174766aMXt7tmp
1423Dec  2 21:10:09.189 [17476] dbg: dns: entering helper-app run mode
1424Dec  2 21:10:09.191 [17476] dbg: pyzor: opening pipe: /usr/bin/pyzor check < /tmp/.spamassassin174766aMXt7tmp
1425Dec  2 21:10:09.208 [17504] dbg: get_user_groups: uid is 1002
1426Dec  2 21:10:09.213 [17504] dbg: get_user_groups: added 105 (netdev) to group list which is now: 1000 105 
1427Dec  2 21:10:09.216 [17504] info: util: setuid: ruid=1002 euid=1002 rgid=1000 105 1000 egid=1000 105 1000 
1428Dec  2 21:10:09.775 [17476] dbg: pyzor: [17504] finished: exit 1
1429Dec  2 21:10:09.776 [17476] dbg: pyzor: got response: public.pyzor.org:24441 (200, 'OK') 0 0
1430Dec  2 21:10:09.777 [17476] dbg: dns: leaving helper-app run mode
1431Dec  2 21:10:09.779 [17476] dbg: check: tagrun - tag PYZOR is now ready, value: Reported 0 times.
1432Dec  2 21:10:09.780 [17476] dbg: rules: running meta tests; score so far=-0.88
1433Dec  2 21:10:09.782 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 299 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_30_1
1434Dec  2 21:10:09.784 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority 30
1435Dec  2 21:10:09.785 [17476] dbg: rules: compiled meta tests
1436Dec  2 21:10:09.787 [17476] dbg: check: running tests for priority: 500
1437Dec  2 21:10:09.787 [17476] dbg: dns: harvest_dnsbl_queries
1438Dec  2 21:10:09.790 [17476] dbg: rules: running one_line_body tests; score so far=-0.88
1439Dec  2 21:10:09.792 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 516 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_500_1
1440Dec  2 21:10:09.793 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 500
1441Dec  2 21:10:09.794 [17476] dbg: rules: compiled one_line_body tests
1442Dec  2 21:10:09.796 [17476] dbg: rules: running head tests; score so far=-0.88
1443Dec  2 21:10:09.797 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 298 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_500_1
1444Dec  2 21:10:09.799 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority 500
1445Dec  2 21:10:09.800 [17476] dbg: rules: compiled head tests
1446Dec  2 21:10:09.802 [17476] dbg: rules: running body tests; score so far=-0.88
1447Dec  2 21:10:09.803 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 241 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_500_1
1448Dec  2 21:10:09.805 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority 500
1449Dec  2 21:10:09.806 [17476] dbg: rules: compiled body tests
1450Dec  2 21:10:09.807 [17476] dbg: rules: running uri tests; score so far=-0.88
1451Dec  2 21:10:09.808 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 239 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_500_1
1452Dec  2 21:10:09.810 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority 500
1453Dec  2 21:10:09.811 [17476] dbg: rules: compiled uri tests
1454Dec  2 21:10:09.813 [17476] dbg: rules: running body_eval tests; score so far=-0.88
1455Dec  2 21:10:09.813 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority 500
1456Dec  2 21:10:09.816 [17476] dbg: rules: running rawbody tests; score so far=-0.88
1457Dec  2 21:10:09.817 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 247 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_500_1
1458Dec  2 21:10:09.818 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 500
1459Dec  2 21:10:09.819 [17476] dbg: rules: compiled rawbody tests
1460Dec  2 21:10:09.821 [17476] dbg: rules: running full tests; score so far=-0.88
1461Dec  2 21:10:09.822 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 276 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_500_1
1462Dec  2 21:10:09.823 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority 500
1463Dec  2 21:10:09.824 [17476] dbg: rules: compiled full tests
1464Dec  2 21:10:09.826 [17476] dbg: rules: running meta tests; score so far=-0.88
1465Dec  2 21:10:09.838 [17476] info: rules: meta test KAM_WARRANTY has dependency 'CBJ_GiveMeABreak' with a zero score
1466Dec  2 21:10:09.842 [17476] dbg: rules: meta test KAM_BAD_DNSWL has undefined dependency 'IN_BRBL'
1467Dec  2 21:10:09.842 [17476] dbg: rules: meta test KAM_BAD_DNSWL has undefined dependency 'RCVD_IN_BRBL_RELAY'
1468Dec  2 21:10:09.843 [17476] dbg: rules: meta test KAM_BAD_DNSWL has undefined dependency '__KAM_URIBL_PCCC'
1469Dec  2 21:10:09.843 [17476] dbg: rules: meta test KAM_BAD_DNSWL has undefined dependency 'KAM_MESSAGE_EMAILBL_PCCC'
1470Dec  2 21:10:09.843 [17476] dbg: rules: meta test KAM_BAD_DNSWL has undefined dependency 'RCVD_IN_HOSTKARMA_W'
1471Dec  2 21:10:09.861 [17476] dbg: rules: meta test KAM_COLLEGE has undefined dependency '__KAM_URIBL_PCCC'
1472Dec  2 21:10:09.891 [17476] dbg: rules: meta test KAM_GOOGLE2 has undefined dependency 'HK_SPAMMY_FILENAME'
1473Dec  2 21:10:09.895 [17476] dbg: rules: meta test FSL_BULK_SIG has undefined dependency 'DCC_CHECK'
1474Dec  2 21:10:09.904 [17476] info: rules: meta test KAM_PHISHY_DOLLARS has dependency 'KAM_RAPTOR' with a zero score
1475Dec  2 21:10:09.907 [17476] info: rules: meta test KAM_REALLY_FAKE_DELIVER has dependency 'KAM_RPTR_PASSED' with a zero score
1476Dec  2 21:10:09.909 [17476] info: rules: meta test KAM_WARRANTY3 has dependency 'CBJ_GiveMeABreak' with a zero score
1477Dec  2 21:10:09.945 [17476] info: rules: meta test KAM_VOICEMAIL has dependency 'KAM_RAPTOR' with a zero score
1478Dec  2 21:10:09.950 [17476] info: rules: meta test KAM_PAYPAL2 has dependency 'KAM_RAPTOR' with a zero score
1479Dec  2 21:10:09.954 [17476] dbg: rules: meta test SHORT_URIBL has undefined dependency 'URIBL_AB_SURBL'
1480Dec  2 21:10:09.955 [17476] dbg: rules: meta test SHORT_URIBL has undefined dependency 'URIBL_JP_SURBL'
1481Dec  2 21:10:09.955 [17476] dbg: rules: meta test SHORT_URIBL has undefined dependency 'URIBL_SC_SURBL'
1482Dec  2 21:10:09.959 [17476] info: rules: meta test KAM_BADPDF2 has dependency 'KAM_RPTR_SUSPECT' with a zero score
1483Dec  2 21:10:09.961 [17476] dbg: rules: meta test KAM_CREDIT2 has undefined dependency '__KAM_URIBL_PCCC'
1484Dec  2 21:10:09.972 [17476] dbg: rules: meta test KAM_PHISH2 has undefined dependency '__KAM_URIBL_PCCC'
1485Dec  2 21:10:09.985 [17476] dbg: rules: meta test DIGEST_MULTIPLE has undefined dependency 'DCC_CHECK'
1486Dec  2 21:10:09.997 [17476] dbg: rules: meta test KAM_WU has undefined dependency '__LOTS_OF_MONEY'
1487Dec  2 21:10:10.008 [17476] info: rules: meta test KAM_AUTO has dependency 'CBJ_GiveMeABreak' with a zero score
1488Dec  2 21:10:10.024 [17476] info: rules: meta test KAM_NOTIFY2 has dependency 'KAM_IFRAME' with a zero score
1489Dec  2 21:10:10.038 [17476] info: rules: meta test KAM_BBB has dependency 'KAM_RAPTOR' with a zero score
1490Dec  2 21:10:10.043 [17476] info: rules: meta test KAM_EVICTION has dependency 'KAM_RAPTOR' with a zero score
1491Dec  2 21:10:10.048 [17476] info: rules: meta test KAM_FAKE_DELIVER has dependency 'KAM_RAPTOR' with a zero score
1492Dec  2 21:10:10.051 [17476] info: rules: meta test KAM_CARD has dependency 'KAM_RPTR_SUSPECT' with a zero score
1493Dec  2 21:10:10.061 [17476] info: rules: meta test KAM_VERY_MALWARE has dependency 'KAM_RAPTOR' with a zero score
1494Dec  2 21:10:10.090 [17476] info: rules: meta test KAM_AMAZON has dependency 'KAM_RAPTOR' with a zero score
1495Dec  2 21:10:10.098 [17476] info: rules: meta test JMQ_CONGRAT has dependency 'KAM_RAPTOR' with a zero score
1496Dec  2 21:10:10.099 [17476] dbg: rules: meta test JMQ_CONGRAT has undefined dependency 'HK_SPAMMY_FILENAME'
1497Dec  2 21:10:10.115 [17476] info: rules: meta test KAM_JURY has dependency 'KAM_RAPTOR' with a zero score
1498Dec  2 21:10:10.151 [17476] info: rules: meta test KAM_FORGED_ATTACHED has dependency 'KAM_RAPTOR' with a zero score
1499Dec  2 21:10:10.173 [17476] info: rules: meta test KAM_INSURE has dependency 'CBJ_GiveMeABreak' with a zero score
1500Dec  2 21:10:10.185 [17476] dbg: rules: meta test KAM_GRABBAG9 has undefined dependency 'MALFORMED_FREEMAIL'
1501Dec  2 21:10:10.210 [17476] info: rules: meta test KAM_INSURE2 has dependency 'CBJ_GiveMeABreak' with a zero score
1502Dec  2 21:10:10.291 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60032 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_1
1503Dec  2 21:10:10.378 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60011 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_2
1504Dec  2 21:10:10.465 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60389 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_3
1505Dec  2 21:10:10.563 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60277 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_4
1506Dec  2 21:10:10.680 [17476] dbg: rules: flush_evalstr (add_evalstr) compiling 60697 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_5
1507Dec  2 21:10:10.819 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 38160 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_500_6
1508Dec  2 21:10:10.871 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority 500
1509Dec  2 21:10:10.873 [17476] dbg: rules: compiled meta tests
1510Dec  2 21:10:10.910 [17476] dbg: check: running tests for priority: 1000
1511Dec  2 21:10:10.911 [17476] dbg: rules: running one_line_body tests; score so far=3.776
1512Dec  2 21:10:10.913 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 519 chars of Mail::SpamAssassin::Plugin::Check::_one_line_body_tests_1000_1
1513Dec  2 21:10:10.914 [17476] dbg: rules: run_generic_tests - compiling eval code: one_line_body, priority 1000
1514Dec  2 21:10:10.916 [17476] dbg: rules: compiled one_line_body tests
1515Dec  2 21:10:10.917 [17476] dbg: rules: running head tests; score so far=3.776
1516Dec  2 21:10:10.918 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 300 chars of Mail::SpamAssassin::Plugin::Check::_head_tests_1000_1
1517Dec  2 21:10:10.920 [17476] dbg: rules: run_generic_tests - compiling eval code: head, priority 1000
1518Dec  2 21:10:10.921 [17476] dbg: rules: compiled head tests
1519Dec  2 21:10:10.923 [17476] dbg: rules: running head_eval tests; score so far=3.776
1520Dec  2 21:10:10.924 [17476] dbg: rules: run_eval_tests - compiling eval code: 9, priority 1000
1521Dec  2 21:10:10.927 [17476] dbg: learn: auto-learn: currently using scoreset 3, recomputing score based on scoreset 1
1522Dec  2 21:10:10.928 [17476] dbg: learn: auto-learn: adding head_only points 1.207
1523Dec  2 21:10:10.929 [17476] dbg: learn: auto-learn: adding head_only points 1.767
1524Dec  2 21:10:10.929 [17476] dbg: learn: auto-learn: adding head_only points 1
1525Dec  2 21:10:10.930 [17476] dbg: learn: auto-learn: adding head_only points 0.14
1526Dec  2 21:10:10.930 [17476] dbg: learn: auto-learn: adding head_only points 1.396
1527Dec  2 21:10:10.931 [17476] dbg: learn: auto-learn: adding head_only points 0.001
1528Dec  2 21:10:10.931 [17476] dbg: learn: auto-learn: message score: 3.776, computed score for autolearn: 5.511
1529Dec  2 21:10:10.934 [17476] dbg: rules: running body tests; score so far=3.776
1530Dec  2 21:10:10.935 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 243 chars of Mail::SpamAssassin::Plugin::Check::_body_tests_1000_1
1531Dec  2 21:10:10.936 [17476] dbg: rules: run_generic_tests - compiling eval code: body, priority 1000
1532Dec  2 21:10:10.937 [17476] dbg: rules: compiled body tests
1533Dec  2 21:10:10.939 [17476] dbg: rules: running uri tests; score so far=3.776
1534Dec  2 21:10:10.940 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 241 chars of Mail::SpamAssassin::Plugin::Check::_uri_tests_1000_1
1535Dec  2 21:10:10.941 [17476] dbg: rules: run_generic_tests - compiling eval code: uri, priority 1000
1536Dec  2 21:10:10.942 [17476] dbg: rules: compiled uri tests
1537Dec  2 21:10:10.943 [17476] dbg: rules: running body_eval tests; score so far=3.776
1538Dec  2 21:10:10.944 [17476] dbg: rules: run_eval_tests - compiling eval code: 11, priority 1000
1539Dec  2 21:10:10.946 [17476] dbg: rules: running rawbody tests; score so far=3.776
1540Dec  2 21:10:10.948 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 249 chars of Mail::SpamAssassin::Plugin::Check::_rawbody_tests_1000_1
1541Dec  2 21:10:10.949 [17476] dbg: rules: run_generic_tests - compiling eval code: rawbody, priority 1000
1542Dec  2 21:10:10.950 [17476] dbg: rules: compiled rawbody tests
1543Dec  2 21:10:10.951 [17476] dbg: rules: running full tests; score so far=3.776
1544Dec  2 21:10:10.952 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 278 chars of Mail::SpamAssassin::Plugin::Check::_full_tests_1000_1
1545Dec  2 21:10:10.954 [17476] dbg: rules: run_generic_tests - compiling eval code: full, priority 1000
1546Dec  2 21:10:10.955 [17476] dbg: rules: compiled full tests
1547Dec  2 21:10:10.956 [17476] dbg: rules: running meta tests; score so far=3.776
1548Dec  2 21:10:10.957 [17476] dbg: rules: flush_evalstr (run_generic_tests) compiling 303 chars of Mail::SpamAssassin::Plugin::Check::_meta_tests_1000_1
1549Dec  2 21:10:10.959 [17476] dbg: rules: run_generic_tests - compiling eval code: meta, priority 1000
1550Dec  2 21:10:10.960 [17476] dbg: rules: compiled meta tests
1551Dec  2 21:10:10.962 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::AutoLearnThreshold=HASH(0x1a7b850) implements 'autolearn_discriminator', priority 0
1552Dec  2 21:10:10.964 [17476] dbg: learn: auto-learn? ham=0.1, spam=12, body-points=0, head-points=5.511, learned-points=-1.9
1553Dec  2 21:10:10.964 [17476] dbg: learn: auto-learn? no: inside auto-learn thresholds, not considered ham or spam
1554Dec  2 21:10:10.967 [17476] dbg: check: is spam? score=3.776 required=5
1555Dec  2 21:10:10.968 [17476] dbg: check: tests=BAYES_00,MISSING_DATE,MISSING_FROM,MISSING_HEADERS,MISSING_MID,MISSING_SUBJECT,NO_HEADERS_MESSAGE,NO_RECEIVED,NO_RELAYS
1556Dec  2 21:10:10.968 [17476] dbg: check: subtests=__BODY_TEXT_LINE,__DKIM_DEPENDABLE,__EMPTY_BODY,__ENV_AND_HDR_FROM_MATCH,__GATED_THROUGH_RCVD_REMOVER,__HAVE_BOUNCE_RELAYS,__KAM_DROPBOX2,__KAM_FAKEDELIVER12,__KAM_FAKEDELIVER4,__KAM_FAKEDELIVER6,__KAM_FAKEDELIVER8,__KAM_GOOGLE2_2,__KAM_HARP3,__KAM_HAS_0_URIS,__KAM_JURY3,__KAM_PAYPAL3B,__KAM_UPS2,__KAM_WU1,__KHOP_NO_FULL_NAME,__LCL__ENV_AND_HDR_FROM_MATCH,__MISSING_REF,__MISSING_REPLY,__NONEMPTY_BODY,__NOT_SPOOFED,__RB_GT_200,__SUBJECT_EMPTY,__SUBJ_SHORT,__TO_NO_ARROWS_R,__UNUSABLE_MSGID,__hk_body_over_400b
1557Dec  2 21:10:10.972 [17476] dbg: timing: total 37699 ms - init: 26549 (70.4%), parse: 9 (0.0%), extract_message_metadata: 376 (1.0%), get_uri_detail_list: 30 (0.1%), tests_pri_-1000: 57 (0.2%), compile_gen: 4643 (12.3%), compile_eval: 295 (0.8%), tests_pri_-950: 42 (0.1%), tests_pri_-900: 45 (0.1%), tests_pri_-90: 127 (0.3%), check_bayes: 75 (0.2%), b_tokenize: 39 (0.1%), b_tok_get_all: 10 (0.0%), b_comp_prob: 8 (0.0%), b_tok_touch_all: 3.9 (0.0%), b_finish: 4.6 (0.0%), tests_pri_0: 5143 (13.6%), check_spf: 144 (0.4%), dkim_load_modules: 191 (0.5%), check_dkim_signature: 4.3 (0.0%), tests_pri_2: 1781 (4.7%), tests_pri_20: 1646 (4.4%), check_razor2: 1598 (4.2%), tests_pri_30: 657 (1.7%), check_pyzor: 597 (1.6%), tests_pri_500: 1123 (3.0%), tests_pri_1000: 52 (0.1%), total_txrep: 6 (0.0%)
1558Dec  2 21:10:10.981 [17476] dbg: check: tagrun - tag DKIMDOMAIN is still blocking action 0, 2
1559Dec  2 21:10:10.982 [17476] dbg: check: tagrun - tag SENDERDOMAIN is still blocking action 1
1560Dec  2 21:10:10.986 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::MIMEHeader=HASH(0x1a7baa8) implements 'finish_tests', priority 0
1561Dec  2 21:10:10.986 [17476] dbg: plugin: Mail::SpamAssassin::Plugin::Check=HASH(0x1a7c000) implements 'finish_tests', priority 0
1562Dec  2 21:10:11.369 [17476] dbg: bayes: Redis destroy
1563X-Spam-Checker-Version: SpamAssassin 3.4.2 (2018-09-13) on
1564	gamecock.fredriksson.dy.fi
1565X-Spam-Level: ***
1566X-Spam-Status: No, score=3.8 required=5.0 tests=BAYES_00,MISSING_DATE,
1567	MISSING_FROM,MISSING_HEADERS,MISSING_MID,MISSING_SUBJECT,
1568	NO_HEADERS_MESSAGE,NO_RECEIVED,NO_RELAYS autolearn=no
1569	autolearn_force=no version=3.4.2
1570X-Spam-Relays-Untrusted: 
1571X-Spam-Relays-External: 
1572X-Spam-Report: 
1573	* -1.9 BAYES_00 BODY: Bayes spam probability is 0 to 1%
1574	*      [score: 0.0000]
1575	*  1.0 MISSING_HEADERS Missing To: header
1576	* -0.0 NO_RELAYS Informational: message was not relayed via SMTP
1577	*  1.8 MISSING_SUBJECT Missing Subject: header
1578	*  1.0 MISSING_FROM Missing From: header
1579	* -0.0 NO_RECEIVED Informational: message has no Received headers
1580	*  0.5 MISSING_MID Missing Message-Id: header
1581	*  1.4 MISSING_DATE Missing Date: header
1582	*  0.0 NO_HEADERS_MESSAGE Message appears to be missing most RFC-822
1583	*      headers
1584X-Spam-X-SpamAssassin-Fred: gamecock
1585X-Spam-ASN:  
1586Dec  2 21:09:33.185 [17476] dbg: logger: adding facilities: all
1587Dec  2 21:09:33.186 [17476] dbg: logger: logging level is DBG
1588Dec  2 21:09:33.186 [17476] dbg: generic: SpamAssassin version 3.4.2
1589Dec  2 21:09:33.187 [17476] dbg: generic: Perl 5.024001, PREFIX=/usr/local, DEF_RULES_DIR=/usr/local/share/spamassassin, LOCAL_RULES_DIR=/etc/mail/spamassassin, LOCAL_STATE_DIR=/var/lib/spamassassin
1590Dec  2 21:09:33.187 [17476] dbg: config: timing enabled
1591Dec  2 21:09:33.203 [17476] dbg: config: score set 0 chosen.
1592Dec  2 21:09:33.232 [17476] dbg: util: running in taint mode? yes
1593Dec  2 21:09:33.233 [17476] dbg: util: taint mode: deleting unsafe environment variables, resetting PATH
1594Dec  2 21:09:33.234 [17476] dbg: util: PATH included '/home/jarif/bin', keeping
1595Dec  2 21:09:33.234 [17476] dbg: util: PATH included '/usr/local/sbin', keeping
1596Dec  2 21:09:33.235 [17476] dbg: util: PATH included '/usr/local/bin', keeping
1597Dec  2 21:09:33.235 [17476] dbg: util: PATH included '/usr/sbin', keeping
1598Dec  2 21:09:33.236 [17476] dbg: util: PATH included '/usr/bin', keeping
1599Dec  2 21:09:33.236 [17476] dbg: util: PATH included '/sbin', keeping
1600Dec  2 21:09:33.237 [17476] dbg: util: PATH included '/bin', keeping
1601Dec  2 21:09:33.237 [17476] dbg: util: PATH included '/usr/local/games', keeping
1602Dec  2 21:09:33.237 [17476] dbg: util: PATH included '/usr/games', keeping
1603Dec  2 21:09:33.238 [17476] dbg: util: final PATH set to: /home/jarif/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/games:/usr/games
1604Dec  2 21:09:33.259 [17476] dbg: util: secure_tmpfile created a temporary file /tmp/.spamassassin17476cbol9Wtmp