[Date Prev][Date Next] [Thread Prev][Thread Next] [Date Index] [Thread Index]

Spamassassin und amavisd-new funktioniert scheinbar nicht



Hallo debian,

gemäß dem Howto: http://workaround.org/articles/ispmail-sarge/ habe
ich postfix, amavis und spamassassin installiert.
Doch leider arbeitet letzteres scheinbar nicht.
Der Betreff wird nicht geändert, im Header erscheint auch nichts...

Wenn man amavis-new im debug Modus startet kommt folgendes zum
Vorschein:

debug: Pyzor is not available: pyzor not found
debug: DCCifd is not available: no r/w dccifd socket found.
debug: DCC is not available: no executable dccproc found.
debug: all '*From' addrs: user3@virtual.test
debug: all '*To' addrs: user3@virtual.test
debug: running meta tests; score so far=10.291
debug: auto-learn? ham=0.1, spam=12, body-hits=5.874, head-hits=4.417
debug: auto-learn: currently using scoreset 1.  no need to recompute.
debug: auto-learn? no: inside auto-learn thresholds
debug: is spam? score=11.122 required=5 tests=ADULT_SITE,GAPPY_SUBJECT,HOT_NASTY
,LESBIAN,NO_REAL_NAME,PORN_MEMBERSHIP,PRIORITY_NO_NAME,SUBJ_VIAGRA
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) RETURNED FROM NoMailAudit::c
heck, time left: 300 s
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) prolong_timer after spam_sca
n_SA: remaining time = 300 s
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) spam_scan: hits=11.122 tests
=ADULT_SITE,GAPPY_SUBJECT,HOT_NASTY,LESBIAN,NO_REAL_NAME,PORN_MEMBERSHIP,PRIORIT
Y_NO_NAME,SUBJ_VIAGRA
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) prolong_timer after spam_sca
n: remaining time = 300 s
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) lookup: (scalar) matches, re
sult="-1000"
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) lookup: (scalar) matches, re
sult="5"
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) do_spam: looking for a quara
ntine address
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) lookup: (scalar) matches, re
sult="spam-quarantine"
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) header: X-Quarantine-id: <sp
am-5ae8eed76e0f6269df0c98e451abe4f7-20040826-160930-09519-01>\n
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) header: X-Spam-Status: Yes,
hits=11.1 tag1=-1000.0 tag2=5.0 kill=0.0 tests=ADULT_SITE,\n\tGAPPY_SUBJECT, HOT
_NASTY, LESBIAN, NO_REAL_NAME, PORN_MEMBERSHIP,\n\tPRIORITY_NO_NAME, SUBJ_VIAGRA
\n
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) header: X-Spam-Level: ******
*****\n
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) header: X-Envelope-From: <us
er3@virtual.test>\n
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) header: X-Envelope-To: <user
3@virtual.test>\n
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) DO_QUARANTINE, sender:
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) local delivery: <> -> <spam-
quarantine>, mbx=/var/lib/amavis/virusmails/spam-5ae8eed76e0f6269df0c98e451abe4f
7-20040826-160930-09519-01.gz
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) header: Delivered-To: spam-q
uarantine\n
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) header: Return-Path: <>\n
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) one_response_for_all <>: suc
cess, dsn_needed=0, '250 2.6.0 Ok, delivered to /var/lib/amavis/virusmails/spam-
5ae8eed76e0f6269df0c98e451abe4f7-20040826-160930-09519-01.gz, id=09519-01'
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) DO_QUARANTINE done
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) SPAM, <user3@virtual.test> -
> <user3@virtual.test>, Yes, hits=11.1 tag1=-1000.0 tag2=5.0 kill=0.0 tests=ADUL
T_SITE, GAPPY_SUBJECT, HOT_NASTY, LESBIAN, NO_REAL_NAME, PORN_MEMBERSHIP, PRIORI
TY_NO_NAME, SUBJ_VIAGRA, quarantine spam-5ae8eed76e0f6269df0c98e451abe4f7-200408
26-160930-09519-01 (spam-quarantine)
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) Skip spam_admin notification
 for <user3@virtual.test>, no admin specified
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) DO_SPAM DONE
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) header: Received: from torog
.cysys.de ([127.0.0.1])\n\tby localhost (torog [127.0.0.1]) (amavisd-new, port 1
0024) with ESMTP\n\tid 09519-01 for <user3@virtual.test>;\n\tThu, 26 Aug 2004 16
:09:30 +0200 (CEST)\n
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) header: X-Virus-Scanned: by
amavisd-new-20030616-p10 (Debian) at localhost, virtual.test\n
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) lookup_acl: key="user3@virtu
al.test", no match
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) lookup_acl: key="user3@virtu
al.test", no match
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) lookup: (scalar) matches, re
sult="-1000"
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) lookup: (scalar) matches, re
sult="5"
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) headers CLUSTERING: NEW CLUS
TER <user3@virtual.test>: hits=11.1, tag=0, tag2=0, subj=0, subj_u=0, local=, bl
=
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) headers CLUSTERING: done all
 1 recips in one go
Aug 26 16:09:30 torog amavisd-new[9519]: (09519-01) FWD via SMTP: [127.0.0.1]:10
025 <user3@virtual.test> -> <user3@virtual.test>
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) Remote host introduces itsel
f as: torog.cysys.de
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) prolong_timer after fwd-conn
ect: remaining time = 300 s
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) prolong_timer after fwd-mail
-from: remaining time = 300 s
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) prolong_timer after fwd-rcpt
-to: remaining time = 300 s
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) response to DATA: "354 End d
ata with <CR><LF>.<CR><LF>"
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) prolong_timer after fwd-data
: remaining time = 300 s
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) prolong_timer after fwd-data
-end: remaining time = 300 s
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) response to data end: "250 O
k: queued as 621C747BE3"
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) prolong_timer after fwd-rund
own-1: remaining time = 300 s
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) mail_via_smtp: 250 2.6.0 Ok,
 id=09519-01, from MTA: 250 Ok: queued as 621C747BE3
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) prolong_timer after forwardi
ng: remaining time = 300 s
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) one_response_for_all <user3@
virtual.test>: success, dsn_needed=0, '250 2.6.0 Ok, id=09519-01, from MTA: 250
Ok: queued as 621C747BE3'
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) warnsender_with_pass=(,,,),
dsn_needed=0, exit=0, 250 2.6.0 Ok, id=09519-01, from MTA: 250 Ok: queued as 621
C747BE3
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) Passed, <user3@virtual.test>
 -> <user3@virtual.test>, quarantine spam-5ae8eed76e0f6269df0c98e451abe4f7-20040
826-160930-09519-01, Message-ID: <3523914140.20040826140929@virtual.test>, Hits:
 11.122
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) sending SMTP response: "250
2.6.0 Ok, id=09519-01, from MTA: 250 Ok: queued as 621C747BE3"
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) timer stopped after DATA end
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) rmdir_recursively: /var/lib/
amavis/amavis-20040826T160930-09519/parts, excl=1
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) TIMING [total 1485 ms] - SMT
P EHLO: 105 (7%), SMTP pre-MAIL: 15 (1%), mkdir tempdir: 4 (0%), create email.tx
t: 16 (1%), SMTP pre-DATA-flush: 20 (1%), SMTP DATA: 26 (2%), body hash: 6 (0%),
 mkdir parts: 3 (0%), mime_decode: 70 (5%), get-file-type: 68 (5%), decompose_pa
rt: 10 (1%), parts: 0 (0%), AV-scan-1: 17 (1%), SA msg read: 12 (1%), SA parse:
5 (0%), SA check: 294 (20%), write-header: 96 (6%), save-to-local-mailbox: 17 (1
%), fwd-connect: 231 (16%), fwd-mail-from: 48 (3%), fwd-rcpt-to: 157 (11%), writ
e-header: 88 (6%), fwd-data: 0 (0%), fwd-data-end: 109 (7%), fwd-rundown: 36 (2%
), unlink-1-files: 32 (2%), rundown: 1 (0%)
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) ESMTP> 250 2.6.0 Ok, id=0951
9-01, from MTA: 250 Ok: queued as 621C747BE3
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) prolong_timer after reading
SMTP command: remaining time = 0 s
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) ESMTP< QUIT\r\n
Aug 26 16:09:31 torog amavisd-new[9519]: (09519-01) ESMTP> 221 2.0.0 [127.0.0.1]
 (amavisd) closing transmission channel
Aug 26 16:10:14 torog amavisd-new[9518]: Net::Server: 2004/08/26-16:10:14 Server closing!
Aug 26 16:10:14 torog amavisd-new[9519]: (09519-01) tempdir being removed: /var/lib/amavis/amavis-20040826T160930-09519
Aug 26 16:10:14 torog amavisd-new[9519]: (09519-01) rmdir_recursively: /var/lib/amavis/amavis-20040826T160930-09519, excl=
Aug 26 16:10:14 torog amavisd-new[9519]: (09519-01) rmdir_recursively: /var/lib/amavis/amavis-20040826T160930-09519/parts, excl=0
torog:/etc/amavis# clear
torog:/etc/amavis# amavisd-new debug
Aug 26 16:10:19 torog amavisd-new[9543]: starting.  amavisd-new at torog amavisd-new-20030616-p10, Unicode aware
Aug 26 16:10:19 torog amavisd-new[9543]: Perl version               5.008004
Aug 26 16:10:19 torog amavisd-new[9543]: Module Amavis::Conf        1.15
Aug 26 16:10:19 torog amavisd-new[9543]: Module Archive::Tar        1.08
Aug 26 16:10:19 torog amavisd-new[9543]: Module Archive::Zip        1.12
Aug 26 16:10:19 torog amavisd-new[9543]: Module Compress::Zlib      1.33
Aug 26 16:10:19 torog amavisd-new[9543]: Module Convert::TNEF       0.17
Aug 26 16:10:19 torog amavisd-new[9543]: Module Convert::UUlib      1.01
Aug 26 16:10:19 torog amavisd-new[9543]: Module DB_File             1.808
Aug 26 16:10:19 torog amavisd-new[9543]: Module MIME::Entity        5.404
Aug 26 16:10:19 torog amavisd-new[9543]: Module MIME::Parser        5.406
Aug 26 16:10:19 torog amavisd-new[9543]: Module MIME::Tools         5.411
Aug 26 16:10:19 torog amavisd-new[9543]: Module Mail::Header        1.62
Aug 26 16:10:19 torog amavisd-new[9543]: Module Mail::Internet      1.62
Aug 26 16:10:19 torog amavisd-new[9543]: Module Mail::SpamAssassin  2.64
Aug 26 16:10:19 torog amavisd-new[9543]: Module Net::Cmd            2.26
Aug 26 16:10:19 torog amavisd-new[9543]: Module Net::SMTP           2.29
Aug 26 16:10:19 torog amavisd-new[9543]: Module Net::Server         0.85
Aug 26 16:10:19 torog amavisd-new[9543]: Module Time::HiRes         1.59
Aug 26 16:10:19 torog amavisd-new[9543]: Module Unix::Syslog        0.100
Aug 26 16:10:19 torog amavisd-new[9543]: Found myself: /usr/sbin/amavisd-new -c /etc/amavis/amavisd.conf
Aug 26 16:10:19 torog amavisd-new[9543]: Lookup::SQL code       NOT loaded
Aug 26 16:10:19 torog amavisd-new[9543]: Lookup::LDAP code      NOT loaded
Aug 26 16:10:19 torog amavisd-new[9543]: AMCL-in protocol code  NOT loaded
Aug 26 16:10:19 torog amavisd-new[9543]: SMTP-in protocol code  loaded
Aug 26 16:10:19 torog amavisd-new[9543]: ANTI-VIRUS code        loaded
Aug 26 16:10:19 torog amavisd-new[9543]: ANTI-SPAM  code        loaded
Aug 26 16:10:19 torog amavisd-new[9543]: Net::Server: 2004/08/26-16:10:19 Amavis (type Net::Server::PreForkSimple) starting! pid(9543)
Aug 26 16:10:19 torog amavisd-new[9543]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1
Aug 26 16:10:19 torog amavisd-new[9543]: Net::Server: Setting gid to "105 105"
Aug 26 16:10:19 torog amavisd-new[9543]: Net::Server: Setting uid to "103"
Aug 26 16:10:19 torog amavisd-new[9543]: Net::Server: Couldn't POSIX::setuid to "103" []
Aug 26 16:10:19 torog amavisd-new[9543]: Net::Server: Setting up serialization via flock
Aug 26 16:10:19 torog amavisd-new[9543]: Found $file       at /usr/bin/file
Aug 26 16:10:19 torog amavisd-new[9543]: No $arc,          not using it
Aug 26 16:10:19 torog amavisd-new[9543]: Found $gzip       at /bin/gzip
Aug 26 16:10:19 torog amavisd-new[9543]: No $bzip2,        not using it
Aug 26 16:10:20 torog amavisd-new[9543]: No $lzop,         not using it
Aug 26 16:10:20 torog amavisd-new[9543]: Found $lha        at /usr/bin/lha
Aug 26 16:10:20 torog amavisd-new[9543]: Found $unarj      at /usr/bin/arj
Aug 26 16:10:20 torog amavisd-new[9543]: Found $uncompress at /bin/uncompress
Aug 26 16:10:20 torog amavisd-new[9543]: No $unfreeze,     not using it
Aug 26 16:10:20 torog amavisd-new[9543]: No $unrar,        not using it
Aug 26 16:10:20 torog amavisd-new[9543]: Found $zoo        at /usr/bin/zoo
Aug 26 16:10:20 torog amavisd-new[9543]: Found $cpio       at /bin/cpio
Aug 26 16:10:20 torog amavisd-new[9543]: Using internal av scanner code for (primary) Clam Antivirus-clamd
Aug 26 16:10:20 torog amavisd-new[9543]: Found secondary av scanner Clam Antivirus - clamscan at /usr/bin/clamscan
Aug 26 16:10:20 torog amavisd-new[9543]: SpamControl: initializing Mail::SpamAssassin
debug: Score set 0 chosen.
debug: running in taint mode? yes
debug: Running in taint mode, removing unsafe env vars, and resetting PATH
debug: PATH included '/usr/local/sbin', keeping.
debug: PATH included '/usr/local/bin', keeping.
debug: PATH included '/usr/sbin', keeping.
debug: PATH included '/sbin', keeping.
debug: PATH included '/usr/bin', keeping.
debug: PATH included '/bin', keeping.
debug: Final PATH set to: /usr/local/sbin:/usr/local/bin:/usr/sbin:/sbin:/usr/bin:/bin
debug: ignore: test message to precompile patterns and load modules
debug: using "/usr/share/spamassassin" for default rules dir
debug: using "/etc/mail/spamassassin" for site rules dir
debug: using "/var/lib/amavis/.spamassassin/user_prefs" for user prefs file
debug: bayes: 9543 tie-ing to DB file R/O /var/lib/amavis/.spamassassin/bayes_toks
debug: bayes: 9543 tie-ing to DB file R/O /var/lib/amavis/.spamassassin/bayes_seen
debug: bayes: found bayes db version 2
debug: bayes: Not available for scanning, only 2 spam(s) in Bayes DB < 200
debug: bayes: 9543 untie-ing
debug: bayes: 9543 untie-ing db_toks
debug: bayes: 9543 untie-ing db_seen
debug: Score set 1 chosen.
debug: Initialising learner
debug: bayes: 9543 tie-ing to DB file R/O /var/lib/amavis/.spamassassin/bayes_toks
debug: bayes: 9543 tie-ing to DB file R/O /var/lib/amavis/.spamassassin/bayes_seen
debug: bayes: found bayes db version 2
debug: bayes: Not available for scanning, only 2 spam(s) in Bayes DB < 200
debug: bayes: 9543 untie-ing
debug: bayes: 9543 untie-ing db_toks
debug: bayes: 9543 untie-ing db_seen
debug: is Net::DNS::Resolver available? no
debug: is DNS available? 0
debug: running header regexp tests; score so far=0
debug: running body-text per-line regexp tests; score so far=1.27
debug: Razor2 is not available
debug: running raw-body-text per-line regexp tests; score so far=1.27
debug: running uri tests; score so far=1.27
debug: uri tests: Done uriRE
debug: running full-text regexp tests; score so far=1.27
debug: Razor2 is not available
debug: Current PATH is: /usr/local/sbin:/usr/local/bin:/usr/sbin:/sbin:/usr/bin:/bin
debug: Pyzor is not available: pyzor not found
debug: DCCifd is not available: no r/w dccifd socket found.
debug: DCC is not available: no executable dccproc found.
debug: all '*From' addrs: ignore@compiling.spamassassin.taint.org
debug: all '*To' addrs:
debug: running meta tests; score so far=1.27
debug: is spam? score=1.27 required=5 tests=DATE_MISSING,NO_REAL_NAME
Aug 26 16:10:21 torog amavisd-new[9543]: SpamControl: done
Aug 26 16:10:21 torog amavisd-new[9543]: Net::Server: Beginning prefork (2 processes)
Aug 26 16:10:21 torog amavisd-new[9543]: Net::Server: Starting "2" children
Aug 26 16:10:21 torog amavisd-new[9545]: Net::Server: Child Preforked (9545)
Aug 26 16:10:21 torog amavisd-new[9544]: Net::Server: Child Preforked (9544)
Aug 26 16:10:21 torog amavisd-new[9543]: Net::Server: Parent ready for children.




Hat jemand eine Idee??



-- 
Bis denn,


 Tobias Matthaeus                            mailto:t.matthaeus@cysys.de


Leg dich mit den Besten an, und du stirbst wie alle dann. (Hackers)



Reply to: