When I send an e-mail with the character "ç" in
the subject from my
Yahoo e-mail, Amavis scrambles the hole e-mail with
confusing
characters. For example "teste de formatação"
turns "teste de
formatação" in the subject and in the body also.
I'm using Posrfix 2.3.4 with Amavisd-new 2.4.4
I tryied to bypass the header_checks [ bypass_header_checks_maps
=
(1);] but don't resolve the problem.
Here is the postfix log
Feb 27 08:43:49 spam postfix/smtpd[18310]: 1CBD3466FA5:
client=web53912.mail.yahoo.com[206.190.38.161]
Feb 27 08:43:49 spam postfix/cleanup[18336]: 1CBD3466FA5:
message-id=<53266.96758.qm web53912.mail.yahoo.com>
Feb 27 08:43:49 spam postfix/qmgr[18301]: 1CBD3466FA5:
from=<mrodrigox yahoo.com>, size=2170, nrcpt=1 (queue
active)
Feb 27 08:43:52 spam postfix/smtpd[18317]: 5D5DB466FA6:
client=localhost.localdomain[127.0.0.1]
Feb 27 08:43:52 spam postfix/cleanup[18329]: 5D5DB466FA6:
message-id=<53266.96758.qm web53912.mail.yahoo.com>
Feb 27 08:43:52 spam postfix/qmgr[18301]: 5D5DB466FA6:
from=<mrodrigox yahoo.com>, size=2637, nrcpt=1 (queue
active)
Feb 27 08:43:52 spam amavis[18314]: (18314-04) response to
data end:
"250 2.0.0 Ok: queued as 5D5DB466FA6"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) FWD via
SMTP:
<mrodrigox yahoo.com> -> <rodrigo ceara.gov.br>, BODY=8BITMIME 250
2.6.0 Ok, id=18314-04, from MTA([127.0.0.1]:10025): 250
2.0.0 Ok:
queued as 5D5DB466FA6
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
one_response_for_all
<mrodrigox yahoo.com>: success, r=0,b=0,d=0,
ndn_needed=0, '250 2.6.0
Ok, id=18314-04, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok:
queued as
5D5DB466FA6'
Feb 27 08:43:52 spam amavis[18314]: (18314-04) ndn_needed=0,
exit=0,
250 2.6.0 Ok, id=18314-04, from MTA([127.0.0.1]:10025): 250
2.0.0 Ok:
queued as 5D5DB466FA6
Feb 27 08:43:52 spam amavis[18314]: (18314-04) Passed
CLEAN,
[200.164.107.12] <mrodrigox yahoo.com> ->
<rodrigo ceara.gov.br>,
Message-ID: <53266.96758.qm web53912.mail.yahoo.com>, mail_id:
YauwY6wIK6gJ, Hits: -94.897, queued_as: 5D5DB466FA6, 2707
ms
Feb 27 08:43:52 spam amavis[18314]: (18314-04) sending SMTP
response:
"250 2.6.0 Ok, id=18314-04, from
MTA([127.0.0.1]:10025): 250 2.0.0 Ok:
queued as 5D5DB466FA6"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) ESMTP> 250
2.6.0 Ok,
id=18314-04, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok:
queued as
5D5DB466FA6
Feb 27 08:43:52 spam postfix/smtp[18306]: 1CBD3466FA5:
to=<rodrigo ceara.gov.br>,
relay=amavis.localhost[127.0.0.1]:10024,
delay=5.7, delays=3/0/0.01/2.7, dsn=2.6.0, status=sent (250
2.6.0 Ok,
id=18314-04, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok:
queued as
5D5DB466FA6)
Feb 27 08:43:52 spam postfix/qmgr[18301]: 1CBD3466FA5:
removed
Feb 27 08:43:52 spam postfix/smtp[18343]: 5D5DB466FA6:
to=<rodrigo ceara.gov.br>,
relay=172.26.2.26[172.26.2.26]:25,
delay=0.1, delays=0.05/0.01/0.01/0.03, dsn=2.0.0,
status=sent (250 ok
1172576632 qp 10726)
Feb 27 08:43:52 spam postfix/qmgr[18301]: 5D5DB466FA6:
removed
Here is the full amavis log
Feb 27 08:43:49 spam amavis[18314]: (18314-04) SMTP> 220
[127.0.0.1]
ESMTP amavisd-new service ready
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_client_time
480 s, smtp response sent
Feb 27 08:43:49 spam amavis[18314]: (18314-04) idle_proc, 4:
was busy,
3.3 ms, total idle 12.872 s, busy 8.648 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) idle_proc, 5:
was idle,
0.3 ms, total idle 12.872 s, busy 8.648 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) SMTP<
EHLO
spam.sead.ce.gov.brrn
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_my_time
480 s, SMTP EHLO received
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP>
250-[127.0.0.1]
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP>
250-VRFY
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP>
250-PIPELINING
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP>
250-SIZE
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP>
250-ENHANCEDSTATUSCODES
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP>
250-8BITMIME
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP>
250-DSN
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP> 250
XFORWARD
NAME ADDR PROTO HELO
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_client_time
480 s, smtp response sent
Feb 27 08:43:49 spam amavis[18314]: (18314-04) idle_proc, 6:
was busy,
2.1 ms, total idle 12.872 s, busy 8.650 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) idle_proc, 5:
was idle,
0.2 ms, total idle 12.873 s, busy 8.650 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP<
MAIL
FROM:<mrodrigox yahoo.com> SIZE=2170 BODY=8BITMIMErn
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_my_time
480 s, SMTP MAIL received
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
check_mail_begin_task:
task_count=4
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(debug_sender)
=> undef, "mrodrigox yahoo.com" does not
match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP> 250
2.1.0 Sender
<mrodrigox yahoo.com> OK
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_client_time
480 s, smtp response sent
Feb 27 08:43:49 spam amavis[18314]: (18314-04) idle_proc, 6:
was busy,
2.2 ms, total idle 12.873 s, busy 8.652 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) idle_proc, 5:
was idle,
0.2 ms, total idle 12.873 s, busy 8.652 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP<
RCPT
TO:<rodrigo ceara.gov.br> ORCPT=rfc822;rodrigo ceara.gov.brrn
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_my_time
480 s, SMTP RCPT received
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP> 250
2.1.5
Recipient <rodrigo ceara.gov.br> OK
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_client_time
480 s, smtp response sent
Feb 27 08:43:49 spam amavis[18314]: (18314-04) idle_proc, 6:
was busy,
1.3 ms, total idle 12.873 s, busy 8.653 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) idle_proc, 5:
was idle,
0.2 ms, total idle 12.873 s, busy 8.653 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP<
DATArn
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_my_time
480 s, SMTP DATA received
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP::10024
/var/amavis/tmp/amavis-20070227T084328-18314:
<mrodrigox yahoo.com> ->
<rodrigo ceara.gov.br> SIZE=2170 BODY=8BITMIME Received:
from
spam.sead.ce.gov.br ([127.0.0.1]) by localhost
(spam.sead.ce.gov.br
[127.0.0.1]) (amavisd-new, port 10024) with ESMTP for
<rodrigo ceara.gov.br>; Tue, 27 Feb 2007 08:43:49 -0300
(BRT)
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP> 354
End data
with <CR><LF>.<CR><LF>
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_client_time
480 s, smtp response sent
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_client_time
480 s, receiving data
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
switch_to_my_time
480 s, data-end received
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ESMTP<
.<CR><LF>
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Actual
message size
2166 B, declared 2170 B
Feb 27 08:43:49 spam amavis[18314]: (18314-04) body hash:
edc9c8416ad840ef4ce974ad1d8b3d90
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Original mail
size:
2166; quota set to: 1083000 bytes
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Checking:
YauwY6wIK6gJ
<mrodrigox yahoo.com> -> <rodrigo ceara.gov.br>
Feb 27 08:43:49 spam amavis[18314]: (18314-04) query_keys:
rodrigo ceara.gov.br, rodrigo , ceara.gov.br,
.ceara.gov.br, .gov.br,
.br, .
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_hash(rodrigo ceara.gov.br), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(bypass_virus_checks) => undef, "rodrigo ceara.gov.br" does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Extracting
mime components
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Issued a new
file name: p001
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Issued a new
file name: p002
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Issued a new
pseudo part: p003
Feb 27 08:43:49 spam amavis[18314]: (18314-04) p003 1
Content-Type:
multipart/alternative
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Charging 142
bytes to
remaining quota 1083000 (out of 1083000, (0%)) - by
mime_decode
Feb 27 08:43:49 spam amavis[18314]: (18314-04) p001 1/1
Content-Type:
text/plain, size: 142 B, name:
Feb 27 08:43:49 spam amavis[18314]: (18314-04) reparenting
p001 from
p000 to p003
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Charging 450
bytes to
remaining quota 1082858 (out of 1083000, (0%)) - by
mime_decode
Feb 27 08:43:49 spam amavis[18314]: (18314-04) p002 1/2
Content-Type:
text/html, size: 450 B, name:
Feb 27 08:43:49 spam amavis[18314]: (18314-04) reparenting
p002 from
p000 to p003
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
prolong_timer
mime_decode-1: remaining time = 480 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) decode_parts:
level=1,
#parts=3 : p001, p002, p003
Feb 27 08:43:49 spam amavis[18314]: (18314-04) run_command:
[18342]
/usr/bin/file p001 p002 </dev/null 2>&1
Feb 27 08:43:49 spam amavis[18342]: (18314-04)
open_on_specific_fd:
target fd0 closing, to become < /dev/null
Feb 27 08:43:49 spam amavis[18342]: (18314-04)
open_on_specific_fd:
target fd2 closing, to become > &1
Feb 27 08:43:49 spam amavis[18342]: (18314-04)
open_on_specific_fd:
target fd2 dup2 from fd1 > &1
Feb 27 08:43:49 spam amavis[18314]: (18314-04) result line
from
file(1): p001: ISO-8859 English textn
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_re("ISO-8859
English text") matches key
"(?-xism:^ISO-8859.*btextb)",
result="txt"
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(map_full_type_to_short_type) => true, "ISO-8859
English text"
matches, result="txt",
matching_key="(?-xism:^ISO-8859.*\btext\b)"
Feb 27 08:43:49 spam amavis[18314]: (18314-04) File-type of
p001:
ISO-8859 English text; (txt)
Feb 27 08:43:49 spam amavis[18314]: (18314-04) result line
from
file(1): p002: ISO-8859 textn
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_re("ISO-8859
text") matches key
"(?-xism:^ISO-8859.*btextb)",
result="txt"
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(map_full_type_to_short_type) => true, "ISO-8859
text" matches,
result="txt",
matching_key="(?-xism:^ISO-8859.*\btext\b)"
Feb 27 08:43:49 spam amavis[18314]: (18314-04) File-type of
p002:
ISO-8859 text; (txt)
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
decompose_part: p001 - atomic
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
decompose_part: p002 - atomic
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
prolong_timer
parts_decode: remaining time = 480 s
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup:
(scalar)
matches, result="1"
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(bypass_header_checks) => true, "rodrigo ceara.gov.br" matches,
result="1", matching_key="(constant:1)"
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Checking for
banned
types and filenames
Feb 27 08:43:49 spam amavis[18314]: (18314-04) query_keys:
rodrigo ceara.gov.br, rodrigo , ceara.gov.br,
.ceara.gov.br, .gov.br,
.br, .
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_hash(rodrigo ceara.gov.br), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(bypass_banned_checks) => undef, "rodrigo ceara.gov.br" does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup:
(scalar)
matches, result="DEFAULT"
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(banned_filename), 1 matches for "rodrigo ceara.gov.br", results:
"(constant EFAULT)&
quot;=>"DEFAULT"
Feb 27 08:43:49 spam amavis[18314]: (18314-04) collect
banned
table[0]: rodrigo ceara.gov.br, tables:
DEFAULT=>Amavis::Lookup::RE=ARRAY(0x114eb390)
Feb 27 08:43:49 spam amavis[18314]: (18314-04) starting
banned checks
- traversing message structure tree
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
check_for_banned
(p003,p001) multipart/alternative | text/plain,.txt
Feb 27 08:43:49 spam amavis[18314]: (18314-04) doing banned
check for
rodrigo ceara.gov.br on multipart/alternative |
text/plain,.txt
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_re(["multipart/alternative","text/plai
n",".txt"]), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(check_bann:rodrigo ceara.gov.br) => undef,
["multipart/alternative","text/plain",&q
uot;.txt"] does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) p.path
rodrigo ceara.gov.br:
"P=p003,L=1,M=multipart/alternative |
P=p001,L=1/1,M=text/plain,T=txt"
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
check_for_banned
(p003,p002) multipart/alternative | text/html,.txt
Feb 27 08:43:49 spam amavis[18314]: (18314-04) doing banned
check for
rodrigo ceara.gov.br on multipart/alternative |
text/html,.txt
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_re(["multipart/alternative","text/html
",".txt"]), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(check_bann:rodrigo ceara.gov.br) => undef,
["multipart/alternative","text/html",&qu
ot;.txt"] does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) p.path
rodrigo ceara.gov.br:
"P=p003,L=1,M=multipart/alternative |
P=p002,L=1/2,M=text/html,T=txt"
Feb 27 08:43:49 spam amavis[18314]: (18314-04) banned check:
any=0, all=N (1)
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_re("MAIL"), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(keep_decoded_original) => undef, "MAIL" does
not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Using
ClamAV-clamd:
(built-in interface)
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ask_av
(ClamAV-clamd):
query template1: CONTSCAN {}n
Feb 27 08:43:49 spam amavis[18314]: (18314-04) Using
(ClamAV-clamd) on
dir: CONTSCAN
/var/amavis/tmp/amavis-20070227T084328-18314/partsn
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
ClamAV-clamd:
Connecting to socket /tmp/clamd
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ClamAV-clamd:
Sending
CONTSCAN
/var/amavis/tmp/amavis-20070227T084328-18314/partsn to
UNIX
socket /tmp/clamd
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ask_av
(ClamAV-clamd)
result: /var/amavis/tmp/amavis-20070227T084328-18314/parts:
OKn
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ask_av
(ClamAV-clamd):
/var/amavis/tmp/amavis-20070227T084328-18314/parts CLEAN
Feb 27 08:43:49 spam amavis[18314]: (18314-04) ClamAV-clamd
result: clean
Feb 27 08:43:49 spam amavis[18314]: (18314-04) query_keys:
rodrigo ceara.gov.br, rodrigo , ceara.gov.br,
.ceara.gov.br, .gov.br,
.br, .
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_hash(rodrigo ceara.gov.br), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(bypass_virus_checks) => undef, "rodrigo ceara.gov.br" does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) query_keys:
rodrigo ceara.gov.br, rodrigo , ceara.gov.br,
.ceara.gov.br, .gov.br,
.br, .
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_hash(rodrigo ceara.gov.br), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(bypass_spam_checks) => undef, "rodrigo ceara.gov.br" does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) wbl: checking
sender
<mrodrigox yahoo.com>
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(blacklist_recip<rodrigo ceara.gov.br>) =>
undef,
"rodrigo ceara.gov.br" does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) query_keys:
mrodrigox yahoo.com, mrodrigox , yahoo.com, .yahoo.com,
.com, .
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_hash(mrodrigox yahoo.com), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(blacklist_sender) => undef, "mrodrigox yahoo.com" does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(whitelist_recip<rodrigo ceara.gov.br>) =>
undef,
"rodrigo ceara.gov.br" does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) query_keys:
mrodrigox yahoo.com, mrodrigox , yahoo.com, .yahoo.com,
.com, .
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_hash(mrodrigox yahoo.com), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(whitelist_sender) => undef, "mrodrigox yahoo.com" does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) query_keys:
rodrigo ceara.gov.br, rodrigo , ceara.gov.br,
.ceara.gov.br, .gov.br,
.br, .
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_hash(rodrigo ceara.gov.br) matches keys:
"."=>ARRAY(0x114eb8f0)
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(score_sender),
1 matches for "rodrigo ceara.gov.br",
results:
"."=>[Amavis::Lookup::RE=ARRAY(0x114eb630),HASH
(0x114eb6c0)]
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_re("mrodrigox yahoo.com"), no
matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) query_keys:
mrodrigox yahoo.com, mrodrigox , yahoo.com, .yahoo.com,
.com, .
Feb 27 08:43:49 spam amavis[18314]: (18314-04)
lookup_hash(mrodrigox yahoo.com), no matches
Feb 27 08:43:49 spam amavis[18314]: (18314-04) lookup
(score_sender<mrodrigox yahoo.com>) => undef,
"mrodrigox yahoo.com"
does not match
Feb 27 08:43:49 spam amavis[18314]: (18314-04) SpamControl:
calling spam scanner
Feb 27 08:43:49 spam amavis[18314]: (18314-04) spam_scan:
DSPAM not
available, skipping it
Feb 27 08:43:49 spam amavis[18314]: (18314-04) timer set to
320 s for
SA (was 480 s)
Feb 27 08:43:49 spam amavis[18314]: (18314-04) calling SA
parse, SA
version 3.1.7
Feb 27 08:43:49 spam amavis[18314]: (18314-04) CALLING SA
check
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
spam_scan_sa_finish: timer set to = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) spam_scan:
score=-94.897
tests=[AWL=0.067,BAYES_00=-2.599,DNS_FROM_RFC_ABUSE=0.2,DNS_
FROM_RFC_POST=1.708,DNS_FROM_RFC_WHOIS=1.447,HTML_MESSAGE=0.
001,SUBJ_ILLEGAL_CHARS=4.279,USER_IN_WHITELIST=-100]
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
spam_scan: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) enqueue: stat
is not numeric: ""
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup:
(scalar)
matches, result="2"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(spam_tag_level)
=> true, "rodrigo ceara.gov.br" matches,
result="2",
matching_key="(constant:2)"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup:
(scalar)
matches, result="6.31"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(spam_tag2_level) => true, "rodrigo ceara.gov.br" matches,
result="6.31",
matching_key="(constant:6.31)"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(spam_tag3_level) => undef, "rodrigo ceara.gov.br" does not match
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup:
(scalar)
matches, result="6.31"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(spam_kill_level) => true, "rodrigo ceara.gov.br" matches,
result="6.31",
matching_key="(constant:6.31)"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) query_keys:
rodrigo ceara.gov.br, rodrigo , ceara.gov.br,
.ceara.gov.br, .gov.br,
.br, .
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
lookup_hash(rodrigo ceara.gov.br), no matches
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(bypass_spam_checks) => undef, "rodrigo ceara.gov.br" does not match
Feb 27 08:43:52 spam amavis[18314]: (18314-04) final_destiny
PASS,
recip rodrigo ceara.gov.br
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
do_notify_and_quar:
ccat=Clean (1,0) ("1":Clean,
"0":CatchAll), q_mth=, qar_mth=
Feb 27 08:43:52 spam amavis[18314]: (18314-04) skip admin
notification, no administrators
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
do_notify_and_quarantine - done
Feb 27 08:43:52 spam amavis[18314]: (18314-04) defang? ccat
"0":
Feb 27 08:43:52 spam amavis[18314]: (18314-04) header:
Received: from
spam.sead.ce.gov.br ([127.0.0.1])ntby localhost
(spam.sead.ce.gov.br
[127.0.0.1]) (amavisd-new, port 10024)ntwith ESMTP id
YauwY6wIK6gJ
for <rodrigo ceara.gov.br>;ntTue, 27 Feb 2007
08:43:49 -0300 (BRT)n
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
lookup_acl(rodrigo ceara.gov.br), no match
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(local_domains)
=> undef, "rodrigo ceara.gov.br" does not
match
Feb 27 08:43:52 spam amavis[18314]: (18314-04) query_keys:
rodrigo ceara.gov.br, rodrigo , ceara.gov.br,
.ceara.gov.br, .gov.br,
.br, .
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
lookup_hash(rodrigo ceara.gov.br), no matches
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(bypass_spam_checks) => undef, "rodrigo ceara.gov.br" does not match
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup:
(scalar)
matches, result="2"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(spam_tag_level)
=> true, "rodrigo ceara.gov.br" matches,
result="2",
matching_key="(constant:2)"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup:
(scalar)
matches, result="6.31"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(spam_tag2_level) => true, "rodrigo ceara.gov.br" matches,
result="6.31",
matching_key="(constant:6.31)"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) headers
CLUSTERING: NEW
CLUSTER <rodrigo ceara.gov.br>: score=-94.897, tag=0,
tag2=0, local=0,
bl=, s=
Feb 27 08:43:52 spam amavis[18314]: (18314-04) header:
X-Virus-Scanned: amavisd-new at sead.ce.gov.brn
Feb 27 08:43:52 spam amavis[18314]: (18314-04) headers
CLUSTERING:
done all 1 recips in one go
Feb 27 08:43:52 spam amavis[18314]: (18314-04) (about to
connect to
[127.0.0.1]:10025) FWD via SMTP: <mrodrigox yahoo.com> ->
<rodrigo ceara.gov.br>
Feb 27 08:43:52 spam amavis[18314]: (18314-04) Remote host
presents
itself as: spam.sead.ce.gov.br, handles DSN, ORCPT
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
fwd-connect: timer set to = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) AUTH not
needed,
user='', MTA offers ''
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
fwd-mail-from: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) sending RCPT
TO:<rodrigo ceara.gov.br> ORCPT=rfc822;rodrigo ceara.gov.br
Feb 27 08:43:52 spam amavis[18314]: (18314-04) response to
RCPT TO for
<rodrigo ceara.gov.br>: "250 2.1.5 Ok"
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
fwd-rcpt-to: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
fwd-data-cmd: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) response to
DATA: "354
End data with
<CR><LF>.<CR><LF>"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) write_header:
0,
Amavis::Out::SMTP=HASH(0x1447c650)
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
fwd-data-contents: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
fwd-data-end: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) response to
data end:
"250 2.0.0 Ok: queued as 5D5DB466FA6"
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
fwd-rundown-1: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) FWD via
SMTP:
<mrodrigox yahoo.com> -> <rodrigo ceara.gov.br>, BODY=8BITMIME 250
2.6.0 Ok, id=18314-04, from MTA([127.0.0.1]:10025): 250
2.0.0 Ok:
queued as 5D5DB466FA6
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
forwarding: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
one_response_for_all
<mrodrigox yahoo.com>: success, r=0,b=0,d=0,
ndn_needed=0, '250 2.6.0
Ok, id=18314-04, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok:
queued as
5D5DB466FA6'
Feb 27 08:43:52 spam amavis[18314]: (18314-04) ndn_needed=0,
exit=0,
250 2.6.0 Ok, id=18314-04, from MTA([127.0.0.1]:10025): 250
2.0.0 Ok:
queued as 5D5DB466FA6
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup:
(scalar)
matches, result="10"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) lookup
(spam_dsn_cutoff_level_bysender) => true,
"mrodrigox yahoo.com"
matches, result="10",
matching_key="(constant:10)"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) dsn: from MTA
250 Clean
<mrodrigox yahoo.com> -> <rodrigo ceara.gov.br>: on_succ=0, on_dly=1,
on_fail=1, never=0, warn_sender=, DSN_passed_on=1
Feb 27 08:43:52 spam amavis[18314]: (18314-04) DSN: SUCC
from MTA 250
Clean, no DSN requested: <mrodrigox yahoo.com> ->
<rodrigo ceara.gov.br>
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
delivery-notification: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
parse_received: from =
[200.164.107.12] /[200.164.107.12]//
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
parse_received: by =
web53912.mail.yahoo.com /web53912.mail.yahoo.com//
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
parse_received: via = HTTP/HTTP//
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
parse_received: ; =
Tue, 27 Feb 2007 03:43:44 PST/Tue, 27 Feb 2007 03:43:44
PST//
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
fish_out_ip_from_received: 200.164.107.12, [200.164.107.12]
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
lookup_ip_acl
(publicnetworks): key="200.164.107.12" matches
"::FFFF:0:0/96",
result=1
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
best_try_originator_ip:
200.164.107.12
Feb 27 08:43:52 spam amavis[18314]: (18314-04) Passed
CLEAN,
[200.164.107.12] <mrodrigox yahoo.com> ->
<rodrigo ceara.gov.br>,
Message-ID: <53266.96758.qm web53912.mail.yahoo.com>, mail_id:
YauwY6wIK6gJ, Hits: -94.897, queued_as: 5D5DB466FA6, 2707
ms
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
prolong_timer
main_log_entry: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) updating snmp
variables
Feb 27 08:43:52 spam amavis[18314]: (18314-04) prolong_timer
check
done: remaining time = 477 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) sending SMTP
response:
"250 2.6.0 Ok, id=18314-04, from
MTA([127.0.0.1]:10025): 250 2.0.0 Ok:
queued as 5D5DB466FA6"
Feb 27 08:43:52 spam amavis[18314]: (18314-04) ESMTP> 250
2.6.0 Ok,
id=18314-04, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok:
queued as
5D5DB466FA6
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
switch_to_client_time
480 s, smtp response sent
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
TempDir::strip:
/var/amavis/tmp/amavis-20070227T084328-18314
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
rmdir_recursively:
/var/amavis/tmp/amavis-20070227T084328-18314/parts, excl=1
Feb 27 08:43:52 spam amavis[18314]: (18314-04) TIMING [total
2713 ms]
- SMTP greeting: 3 (0%)0, SMTP EHLO: 1 (0%)0, SMTP pre-MAIL:
2 (0%)0,
SMTP pre-DATA-flush: 5 (0%)0, SMTP DATA: 37 (1%)2,
check_init: 1
(0%)2, digest_hdr: 1 (0%)2, digest_body: 0 (0%)2,
gen_mail_id: 1
(0%)2, mime_decode: 17 (1%)2, get-file-type2: 28 (1%)4,
parts_decode:
1 (0%)4, AV-scan-1: 13 (0%)4, spam-wb-list: 6 (0%)4, SA msg
read: 1
(0%)4, SA parse: 3 (0%)4, SA check: 2500 (92%)97, SA finish:
4 (0%)97,
update_cache: 2 (0%)97, decide_mail_destiny: 3 (0%)97,
fwd-connect: 9
(0%)97, fwd-mail-from: 1 (0%)97, fwd-rcpt-to: 3 (0%)97,
fwd-data-cmd:
1 (0%)97, write-header: 1 (0%)97, fwd-data-contents: 1
(0%)97,
fwd-data-end: 48 (2%)99, fwd-rundown: 2 (0%)99, prepare-dsn:
2 (0%)99,
main_log_entry: 13 (0%)100, update_snmp: 2 (0%)100, SMTP
pre-response:
1 (0%)100, SMTP response: 1 (0%)100, unlink-2-files: 1
(0%)100,
rundown: 0 (0%)100
Feb 27 08:43:52 spam amavis[18314]: (18314-04) idle_proc, 6:
was busy,
2704.4 ms, total idle 12.873 s, busy 11.358 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) idle_proc, 5:
was idle,
0.2 ms, total idle 12.873 s, busy 11.358 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) ESMTP<
QUITrn
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
switch_to_my_time
480 s, SMTP QUIT received
Feb 27 08:43:52 spam amavis[18314]: (18314-04) ESMTP> 221
2.0.0
[127.0.0.1] amavisd-new closing transmission channel
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
switch_to_client_time
480 s, smtp response sent
Feb 27 08:43:52 spam amavis[18314]: (18314-04) SMTP session
over, timer stopped
Feb 27 08:43:52 spam amavis[18314]: (18314-04) exiting
process_request
Feb 27 08:43:52 spam amavis[18314]: (18314-04)
post_process_request_hook: timer was not running
Feb 27 08:43:52 spam amavis[18314]: (18314-04) idle_proc,
bye: was
busy, 3.0 ms, total idle 12.873 s, busy 11.361 s
Feb 27 08:43:52 spam amavis[18314]: (18314-04) load: 47 %,
total idle
12.873 s, busy 11.361 s
Feb 27 08:43:53 spam amavis[18314]: (18314-04) idle_proc, hi
: was
idle, 1441.3 ms, total idle 14.314 s, busy 11.361 s
Feb 27 08:43:53 spam amavis[18314]: (18314-04) loaded base
policy bank
Feb 27 08:43:53 spam amavis[18314]: (18314-04)
lookup_ip_acl
(inet_acl): key="127.0.0.1" matches
"127.0.0.1", result=1
Feb 27 08:43:53 spam amavis[18314]: (18314-04)
process_request: fileno
sock=11, STDIN=0, STDOUT=1
Feb 27 08:43:53 spam amavis[18314]: (18314-04)
switch_to_my_time
480 s, new request
Feb 27 08:43:53 spam amavis[18314]: (18314-04)
process_request:
suggested_protocol="" on TCP
Hope that someone know what's going on...
(It's something related to the RFC 2822?)
Thanks in advance,
Rodrigo.
------------------------------------------------------------
-------------
Take Surveys. Earn Cash. Influence the Future of IT
Join SourceForge.net's Techsay panel and you'll get the
chance to share your
opinions on IT & business topics through brief
surveys-and earn cash
http://www.techsay.com/default.
php?page=join.php&p=sourceforge&CID=DEVDEV
_______________________________________________
AMaViS-user mailing list
AMaViS-user lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/amavis-user
AMaViS-FAQ:http://www.amav
is.org/amavis-faq.php3
AMaViS-HowTos:http://www.amavis.org/ho
wto/
|