Op 29/12/2010 16:13, Jeroen Geilman schreef:
On 12/29/10 2:44 PM, Philip Van Pelt wrote:
I've set up a mailserver with postfix, dovecot, amavis and spamassassin.
Everything has been up and running for a year now until I noticed my
spamfilter wasn't performing as it should; spam mails sent to a normal
user were getting the right treatment and ended up in Spam-box, whereas
the same mail sent to an alias of that user weren't flagged as spam.
If you look at the logs, my spamfilter does recognise the mail as spam,
but no headers are inserted in the mail or they are removed afterwards.
Anyone knows where I should start to look for clues?
Please supply properly-formatted logs (i.e. not broken up into fake
lines by a lousy mail client), and the output from postconf -n, as
explained in the welcome message to this list:
http://www.postfix.org/DEBUG_README.html#mail
Hereby the logs and output from postconf -n. Same as in my previous
message; I sent 4 mails. The first two are normal mails directly to a
user and to his alias. The last two are spam mails to these same addresses.
Thank you for your help,
Philip
Logs:
Dec 29 13:48:29 test-services postfix/pickup[9435]: 5A4C34A4AC: uid=0
from=<root>
Dec 29 13:48:29 test-services postfix/cleanup[11571]: 5A4C34A4AC:
message-id=<20101229124829.5a4c34a...@test-services.doctorvinyl.be>
Dec 29 13:48:29 test-services postfix/qmgr[2304]: 5A4C34A4AC:
from=<r...@doctorvinyl.be>, size=323, nrcpt=1 (queue active)
Dec 29 13:48:29 test-services postfix/smtpd[11576]: connect from
localhost[127.0.0.1]
Dec 29 13:48:29 test-services postfix/smtpd[11576]: C9E0A4A4AB:
client=localhost[127.0.0.1]
Dec 29 13:48:29 test-services postfix/cleanup[11571]: C9E0A4A4AB:
message-id=<20101229124829.5a4c34a...@test-services.doctorvinyl.be>
Dec 29 13:48:29 test-services postfix/qmgr[2304]: C9E0A4A4AB:
from=<r...@doctorvinyl.be>, size=978, nrcpt=1 (queue active)
Dec 29 13:48:29 test-services amavis[11240]: (11240-01) Passed CLEAN,
<r...@doctorvinyl.be> -> <t...@example.com>, Message-ID:
<20101229124829.5a4c34a...@test-services.doctorvinyl.be>, mail_id:
Q7VOhybYx38B, Hits: 0.729, size: 323, queued_as: C9E0A4A4AB, 513 ms
Dec 29 13:48:29 test-services postfix/smtp[11573]: 5A4C34A4AC:
to=<t...@example.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.8,
delays=1.2/0.01/0.03/0.5, dsn=2.0.0, status=sent (250 2.0.0 Ok,
id=11240-01, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as
C9E0A4A4AB)
Dec 29 13:48:29 test-services postfix/qmgr[2304]: 5A4C34A4AC: removed
Dec 29 13:48:30 test-services dovecot: deliver(t...@example.com): sieve:
msgid=<20101229124829.5a4c34a...@test-services.doctorvinyl.be>: stored
mail into mailbox 'INBOX'
Dec 29 13:48:30 test-services postfix/pipe[11577]: C9E0A4A4AB:
to=<t...@example.com>, relay=dovecot, delay=0.2,
delays=0.05/0.03/0/0.11, dsn=2.0.0, status=sent (delivered via dovecot
service)
Dec 29 13:48:30 test-services postfix/qmgr[2304]: C9E0A4A4AB: removed
Dec 29 13:48:30 test-services postfix/pickup[9435]: 77C114A4AC: uid=0
from=<root>
Dec 29 13:48:30 test-services postfix/cleanup[11571]: 77C114A4AC:
message-id=<20101229124830.77c114a...@test-services.doctorvinyl.be>
Dec 29 13:48:30 test-services postfix/qmgr[2304]: 77C114A4AC:
from=<r...@doctorvinyl.be>, size=330, nrcpt=1 (queue active)
Dec 29 13:48:30 test-services postfix/smtpd[11593]: connect from
localhost[127.0.0.1]
Dec 29 13:48:30 test-services postfix/smtpd[11593]: C41EE4A4AB:
client=localhost[127.0.0.1]
Dec 29 13:48:30 test-services postfix/cleanup[11571]: C41EE4A4AB:
message-id=<20101229124830.77c114a...@test-services.doctorvinyl.be>
Dec 29 13:48:30 test-services postfix/qmgr[2304]: C41EE4A4AB:
from=<r...@doctorvinyl.be>, size=820, nrcpt=1 (queue active)
Dec 29 13:48:30 test-services postfix/smtpd[11593]: disconnect from
localhost[127.0.0.1]
Dec 29 13:48:30 test-services amavis[11239]: (11239-02) Passed CLEAN,
<r...@doctorvinyl.be> -> <al...@example.com>, Message-ID:
<20101229124830.77c114a...@test-services.doctorvinyl.be>, mail_id:
m-auTW37yQW6, Hits: -0.001, size: 330, queued_as: C41EE4A4AB, 348 ms
Dec 29 13:48:30 test-services postfix/smtp[11573]: 77C114A4AC:
to=<al...@example.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.38,
delays=0.02/0/0.02/0.34, dsn=2.0.0, status=sent (250 2.0.0 Ok,
id=11239-02, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as
C41EE4A4AB)
Dec 29 13:48:30 test-services postfix/qmgr[2304]: 77C114A4AC: removed
Dec 29 13:48:30 test-services dovecot: deliver(t...@example.com): sieve:
msgid=<20101229124830.77c114a...@test-services.doctorvinyl.be>: stored
mail into mailbox 'INBOX'
Dec 29 13:48:30 test-services postfix/pipe[11577]: C41EE4A4AB:
to=<t...@example.com>, orig_to=<al...@example.com>, relay=dovecot,
delay=0.07, delays=0.03/0/0/0.04, dsn=2.0.0, status=sent (delivered via
dovecot service)
Dec 29 13:48:30 test-services postfix/qmgr[2304]: C41EE4A4AB: removed
Dec 29 13:48:31 test-services postfix/pickup[9435]: 9DEF84A4AC: uid=0
from=<root>
Dec 29 13:48:31 test-services postfix/cleanup[11571]: 9DEF84A4AC:
message-id=<20101229124831.9def84a...@test-services.doctorvinyl.be>
Dec 29 13:48:31 test-services postfix/qmgr[2304]: 9DEF84A4AC:
from=<r...@doctorvinyl.be>, size=1136, nrcpt=1 (queue active)
Dec 29 13:48:31 test-services postfix/smtpd[11576]: BE5EC4A4AB:
client=localhost[127.0.0.1]
Dec 29 13:48:31 test-services postfix/cleanup[11571]: BE5EC4A4AB:
message-id=<20101229124831.9def84a...@test-services.doctorvinyl.be>
Dec 29 13:48:31 test-services postfix/qmgr[2304]: BE5EC4A4AB:
from=<r...@doctorvinyl.be>, size=1917, nrcpt=1 (queue active)
Dec 29 13:48:31 test-services amavis[11240]: (11240-02) Passed SPAM,
<r...@doctorvinyl.be> -> <t...@example.com>, quarantine:
k/spam-kEzi169drbKm.gz, Message-ID:
<20101229124831.9def84a...@test-services.doctorvinyl.be>, mail_id:
kEzi169drbKm, Hits: 1000.729, size: 1136, queued_as: BE5EC4A4AB, 178 ms
Dec 29 13:48:31 test-services postfix/smtp[11573]: 9DEF84A4AC:
to=<t...@example.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.23,
delays=0.04/0/0.01/0.18, dsn=2.0.0, status=sent (250 2.0.0 Ok,
id=11240-02, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as
BE5EC4A4AB)
Dec 29 13:48:31 test-services postfix/qmgr[2304]: 9DEF84A4AC: removed
Dec 29 13:48:31 test-services dovecot: deliver(t...@example.com): sieve:
msgid=<20101229124831.9def84a...@test-services.doctorvinyl.be>: stored
mail into mailbox 'Spam'
Dec 29 13:48:31 test-services postfix/pipe[11577]: BE5EC4A4AB:
to=<t...@example.com>, relay=dovecot, delay=0.17, delays=0.03/0/0/0.14,
dsn=2.0.0, status=sent (delivered via dovecot service)
Dec 29 13:48:31 test-services postfix/qmgr[2304]: BE5EC4A4AB: removed
Dec 29 13:48:32 test-services postfix/pickup[9435]: CA6334A4AC: uid=0
from=<root>
Dec 29 13:48:32 test-services postfix/cleanup[11571]: CA6334A4AC:
message-id=<20101229124832.ca6334a...@test-services.doctorvinyl.be>
Dec 29 13:48:32 test-services postfix/qmgr[2304]: CA6334A4AC:
from=<r...@doctorvinyl.be>, size=1148, nrcpt=1 (queue active)
Dec 29 13:48:32 test-services postfix/smtpd[11593]: connect from
localhost[127.0.0.1]
Dec 29 13:48:32 test-services postfix/smtpd[11593]: EC3BD4A4AB:
client=localhost[127.0.0.1]
Dec 29 13:48:32 test-services postfix/cleanup[11571]: EC3BD4A4AB:
message-id=<20101229124832.ca6334a...@test-services.doctorvinyl.be>
Dec 29 13:48:32 test-services postfix/qmgr[2304]: EC3BD4A4AB:
from=<r...@doctorvinyl.be>, size=1638, nrcpt=1 (queue active)
Dec 29 13:48:33 test-services amavis[11239]: (11239-03) Passed SPAM,
<r...@doctorvinyl.be> -> <al...@example.com>, quarantine:
L/spam-L9OJuBX5JIAS.gz, Message-ID:
<20101229124832.ca6334a...@test-services.doctorvinyl.be>, mail_id:
L9OJuBX5JIAS, Hits: 1000.729, size: 1148, queued_as: EC3BD4A4AB, 170 ms
Dec 29 13:48:33 test-services postfix/smtp[11573]: CA6334A4AC:
to=<al...@example.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.2,
delays=0.02/0/0.01/0.18, dsn=2.0.0, status=sent (250 2.0.0 Ok,
id=11239-03, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as
EC3BD4A4AB)
Dec 29 13:48:33 test-services postfix/qmgr[2304]: CA6334A4AC: removed
Dec 29 13:48:33 test-services dovecot: deliver(t...@example.com): sieve:
msgid=<20101229124832.ca6334a...@test-services.doctorvinyl.be>: stored
mail into mailbox 'INBOX'
Dec 29 13:48:33 test-services postfix/pipe[11577]: EC3BD4A4AB:
to=<t...@example.com>, orig_to=<al...@example.com>, relay=dovecot,
delay=0.08, delays=0.02/0/0/0.06, dsn=2.0.0, status=sent (delivered via
dovecot service)
Dec 29 13:48:33 test-services postfix/qmgr[2304]: EC3BD4A4AB: removed
postconf -n:
alias_database = hash:/etc/aliases
alias_maps = hash:/etc/aliases
append_dot_mydomain = no
biff = no
bounce_queue_lifetime = 5d
config_directory = /etc/postfix
content_filter = smtp-amavis:[127.0.0.1]:10024
delay_warning_time = 12h
disable_vrfy_command = yes
home_mailbox = Maildir/
inet_interfaces = all
local_recipient_maps =
mailbox_size_limit = 0
maximal_queue_lifetime = 5d
message_size_limit = 20480000
mydestination = localhost
myhostname = [EDITED]
mynetworks = 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 192.168.0.0/24
192.168.10.0/24
myorigin = [EDITED]
readme_directory = no
receive_override_options = no_address_mappings
recipient_delimiter =
smtpd_banner = $myhostname ESMTP $mail_name
smtpd_delay_reject = yes
smtpd_helo_required = yes
smtpd_recipient_restrictions = permit_mynetworks,
permit_sasl_authenticated, reject_unauth_destination,
reject_invalid_hostname, reject_non_fqdn_sender,
reject_non_fqdn_recipient, reject_unknown_sender_domain,
reject_unknown_recipient_domain, reject_unauth_pipelining,
reject_rbl_client cbl.abuseat.org, reject_rbl_client zen.spamhaus.org,
reject_rbl_client bl.spamcop.net, reject_rbl_client psbl.surriel.com,
reject_rhsbl_sender dsn.rfc-ignorant.org, reject_rbl_client
blackholes.easynet.nl, reject_rbl_client dnsbl.njabl.org,
permit_mx_backup, permit
smtpd_sasl_auth_enable = yes
smtpd_sasl_authenticated_header = yes
smtpd_sasl_path = private/auth
smtpd_sasl_type = dovecot
smtpd_tls_auth_only = yes
smtpd_tls_cert_file = /etc/ssl/certs/postfix.pem
smtpd_tls_key_file = /etc/ssl/private/postfix.pem
smtpd_use_tls = yes
strict_rfc821_envelopes = yes
unknown_address_reject_code = 554
unknown_client_reject_code = 554
unknown_hostname_reject_code = 554
virtual_alias_maps =
ldap:/etc/postfix/ldap-aliases.cf,ldap:/etc/postfix/ldap-mail2mail.cf
virtual_gid_maps = static:2002
virtual_mailbox_base = /home/vmail
virtual_mailbox_domains = ldap:/etc/postfix/ldap-domains.cf
virtual_mailbox_limit = 0
virtual_mailbox_maps = ldap:/etc/postfix/ldap-mailboxes.cf
virtual_transport = dovecot
virtual_uid_maps = static:2002
