• Willkommen im Linux Club - dem deutschsprachigen Supportforum für GNU/Linux. Registriere dich kostenlos, um alle Inhalte zu sehen und Fragen zu stellen.

amavis-new erkennt Spam, kennzeichnet sie aber nicht

Status
Für weitere Antworten geschlossen.
K

Knappe

Habe in den HowTo´s unter http://www.linux-club.de/viewtopic.php?t=34704 diese Beschreibung gefunden und entsprechend umgesetzt (d.h. alles installiert und die amavisd.conf-Datei gedownloaded und nur den "mydomain"-Parameter angepasst; natürlich auch die /etc/mail/spamassassin/local.cf).

Anhand des Mail-Protokolls kann ich erkennen, das amavis-new den Test-Spam aus obigem Thread erkennt ("Passed SPAM") und auch einen Eintrag in "/var/spool/amavis/virusmails" vornimmt.

Allerdings werden keine Mails im Subject-Feld gekennzeichnet.

Woran könnte das liegen ?
 
OP
K

Knappe

Code: 
@local_domains_maps

Ja, in der amavis.conf habe ich folgenden Eintrag :

Code: 
@local_domain_maps = ( [".$mydomain", "localhost"] );

Die Variable "$mydomain" ist gem. den HowTo´s richtig gesetzt.

Soll ich mal eine amavis.conf ohne Kommentare posten ?
 
OP
K

Knappe

Code: 
debug auf 5 stellen, mail senden, log posten.

Habe den Debug-Level in der "main.cf" gestzt und postfix neu gestartet.

Hier der Ausdruck der "/var/log/mail" :

Code: 
Oct  4 23:07:42 asterix postfix/master[10534]: terminating on signal 15
Oct  4 23:07:45 asterix postfix/postfix-script: warning: group or other writable: /etc/postfix/./body_checks
Oct  4 23:07:45 asterix postfix/postfix-script: warning: group or other writable: /etc/postfix/./header_checks
Oct  4 23:07:45 asterix postfix/postfix-script: warning: group or other writable: /etc/postfix/./mime_header_checks
Oct  4 23:07:45 asterix postfix/postfix-script: starting the Postfix mail system
Oct  4 23:07:45 asterix postfix/master[10792]: daemon started -- version 2.2.1, configuration /etc/postfix
Oct  4 23:09:34 asterix postfix/smtpd[10813]: connect from MyTestName[192.168.xxx.xx]
Oct  4 23:09:34 asterix postfix/smtpd[10813]: 75CAC1B0FF: client=MyTestName[192.168.xxx.xx]
Oct  4 23:09:34 asterix postfix/cleanup[10816]: 75CAC1B0FF: message-id=<43430BA2.18503.A2BB8A1@localhost>
Oct  4 23:09:34 asterix postfix/qmgr[10804]: 75CAC1B0FF: from=<info@mydomain>, size=1203, nrcpt=1 (queue active)
Oct  4 23:09:34 asterix postfix/smtpd[10813]: disconnect from MyTestName[192.168.xxx.xx]
Oct  4 23:09:38 asterix postfix/smtpd[10821]: connect from localhost[127.0.0.1]
Oct  4 23:09:38 asterix postfix/smtpd[10821]: C60521B135: client=localhost[127.0.0.1]
Oct  4 23:09:38 asterix postfix/cleanup[10816]: C60521B135: message-id=<43430BA2.18503.A2BB8A1@localhost>
Oct  4 23:09:38 asterix postfix/qmgr[10804]: C60521B135: from=<info@mydomain>, size=1666, nrcpt=1 (queue active)
Oct  4 23:09:38 asterix postfix/smtpd[10821]: disconnect from localhost[127.0.0.1]
Oct  4 23:09:39 asterix postfix/local[10822]: C60521B135: to=<MyTestName@mydomainby.dyndns.org>, relay=local, delay=1, status=sent (delivered to maildir)
Oct  4 23:09:39 asterix postfix/qmgr[10804]: C60521B135: removed
Oct  4 23:09:39 asterix amavis[9943]: (09943-05) Passed SPAM, [192.168.xxx.xx] <info@mydomain> -> <MyTestName@mydomainby.dyndns.org>, quarantine: spam-0671f1400147e4bbaa6992eeb86e961d-20051004-230934-09943-05, Message-ID: <43430BA2.18503.A2BB8A1@localhost>, Hits: 997.399, 4249 ms
Oct  4 23:09:39 asterix postfix/smtp[10817]: 75CAC1B0FF: to=<MyTestName@mydomainby.dyndns.org>, relay=127.0.0.1[127.0.0.1], delay=5, status=sent (250 2.6.0 Ok, id=09943-05, from MTA: 250 Ok: queued as C60521B135)
Oct  4 23:09:39 asterix postfix/qmgr[10804]: 75CAC1B0FF: removed
 
OP
K

Knappe

Code: 
im amavisd den debuglevel hochstellen.
So gemacht.


Hier das Ergebnis :
Code: 
Oct  4 23:24:11 asterix amavis[10903]: starting.  /usr/sbin/amavisd at asterix amavisd-new-2.2.1 (20041222), Unicode aware, LANG=de_DE.UTF-8
Oct  4 23:24:11 asterix amavis[10903]: user=, EUID: 0 (0);  group=, EGID: 0 0 (0 0)
Oct  4 23:24:11 asterix amavis[10903]: Perl version               5.008006
Oct  4 23:24:14 asterix amavis[10903]: INFO: no optional modules: Sys::Hostname::Long Mail::SPF::Query Razor2::Client Net::CIDR::Lite
Oct  4 23:24:14 asterix amavis[10904]: Net::Server: Process Backgrounded
Oct  4 23:24:14 asterix amavis[10903]: at the END handler: invoking DESTROY methods
Oct  4 23:24:14 asterix amavis[10904]: Net::Server: 2005/10/04-23:24:14 Amavis (type Net::Server::PreForkSimple) starting! pid(10904)
Oct  4 23:24:14 asterix amavis[10904]: Net::Server: Binding to UNIX socket file /var/spool/amavis/amavisd.sock using SOCK_STREAM
Oct  4 23:24:14 asterix amavis[10904]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1
Oct  4 23:24:14 asterix amavis[10904]: Net::Server: Setting gid to "108 108"
Oct  4 23:24:14 asterix amavis[10904]: Net::Server: Setting uid to "65"
Oct  4 23:24:14 asterix amavis[10904]: Module Amavis::Conf        2.034
Oct  4 23:24:14 asterix amavis[10904]: Module Archive::Tar        1.08
Oct  4 23:24:14 asterix amavis[10904]: Module Archive::Zip        1.09
Oct  4 23:24:14 asterix amavis[10904]: Module BerkeleyDB          0.26
Oct  4 23:24:14 asterix amavis[10904]: Module Compress::Zlib      1.34
Oct  4 23:24:14 asterix amavis[10904]: Module Convert::TNEF       0.17
Oct  4 23:24:14 asterix amavis[10904]: Module Convert::UUlib      1.0
Oct  4 23:24:14 asterix amavis[10904]: Module DBI                 1.47
Oct  4 23:24:14 asterix amavis[10904]: Module DB_File             1.810
Oct  4 23:24:14 asterix amavis[10904]: Module MIME::Entity        5.415
Oct  4 23:24:14 asterix amavis[10904]: Module MIME::Parser        5.415
Oct  4 23:24:14 asterix amavis[10904]: Module MIME::Tools         5.415
Oct  4 23:24:14 asterix amavis[10904]: Module Mail::Header        1.60
Oct  4 23:24:14 asterix amavis[10904]: Module Mail::Internet      1.60
Oct  4 23:24:14 asterix amavis[10904]: Module Mail::SpamAssassin  3.000004
Oct  4 23:24:14 asterix amavis[10904]: Module Net::Cmd            2.26
Oct  4 23:24:14 asterix amavis[10904]: Module Net::DNS            0.48
Oct  4 23:24:14 asterix amavis[10904]: Module Net::SMTP           2.29
Oct  4 23:24:14 asterix amavis[10904]: Module Net::Server         0.87
Oct  4 23:24:14 asterix amavis[10904]: Module Time::HiRes         1.65
Oct  4 23:24:14 asterix amavis[10904]: Module Unix::Syslog        0.100
Oct  4 23:24:14 asterix amavis[10904]: Amavis::DB code        loaded
Oct  4 23:24:14 asterix amavis[10904]: Amavis::Cache code     loaded
Oct  4 23:24:14 asterix amavis[10904]: Lookup::SQL code       NOT loaded
Oct  4 23:24:14 asterix amavis[10904]: Lookup::LDAP code      NOT loaded
Oct  4 23:24:14 asterix amavis[10904]: AMCL-in protocol code  loaded
Oct  4 23:24:14 asterix amavis[10904]: SMTP-in protocol code  loaded
Oct  4 23:24:14 asterix amavis[10904]: ANTI-VIRUS code        loaded
Oct  4 23:24:14 asterix amavis[10904]: ANTI-SPAM  code        loaded
Oct  4 23:24:14 asterix amavis[10904]: Unpackers  code        loaded
Oct  4 23:24:14 asterix amavis[10904]: Found $file       at /usr/bin/file
Oct  4 23:24:14 asterix amavis[10904]: No $arc,          not using it
Oct  4 23:24:14 asterix amavis[10904]: Found $gzip       at /usr/bin/gzip
Oct  4 23:24:14 asterix amavis[10904]: Found $bzip2      at /usr/bin/bzip2
Oct  4 23:24:14 asterix amavis[10904]: No $lzop,         not using it
Oct  4 23:24:14 asterix amavis[10904]: Found $lha        at /usr/bin/lha
Oct  4 23:24:14 asterix amavis[10904]: Found $unarj      at /usr/bin/unarj
Oct  4 23:24:14 asterix amavis[10904]: Found $uncompress at /usr/bin/uncompress
Oct  4 23:24:14 asterix amavis[10904]: No $unfreeze,     not using it
Oct  4 23:24:14 asterix amavis[10904]: Found $unrar      at /usr/bin/unrar
Oct  4 23:24:14 asterix amavis[10904]: Found $zoo        at /usr/bin/zoo
Oct  4 23:24:14 asterix amavis[10904]: Found $pax        at /usr/bin/pax
Oct  4 23:24:14 asterix amavis[10904]: Found $cpio       at /usr/bin/cpio
Oct  4 23:24:14 asterix amavis[10904]: Found $ar         at /usr/bin/ar
Oct  4 23:24:14 asterix amavis[10904]: Found $rpm2cpio   at /usr/bin/rpm2cpio
Oct  4 23:24:14 asterix amavis[10904]: Found $cabextract at /usr/bin/cabextract
Oct  4 23:24:14 asterix amavis[10904]: No $ripole,       not using it
Oct  4 23:24:14 asterix amavis[10904]: No $dspam,        not using it
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: KasperskyLab AVP - aveclient
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: KasperskyLab AntiViral Toolkit Pro (AVP)
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: KasperskyLab AVPDaemonClient
Oct  4 23:24:14 asterix amavis[10904]: Found primary av scanner H+BEDV AntiVir or CentralCommand Vexira Antivirus at /usr/bin/antivir
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: Command AntiVirus for Linux
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: Symantec CarrierScan via Symantec CommandLineScanner
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: Symantec AntiVirus Scan Engine
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: F-Secure Antivirus
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: CAI InoculateIT
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: CAI eTrust Antivirus
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: MkS_Vir for Linux (beta)
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: MkS_Vir daemon
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: ESET Software NOD32
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: ESET Software NOD32 - Client/Server Version
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: Norman Virus Control v5 / Linux
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: Panda Antivirus for Linux
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: NAI McAfee AntiVirus (uvscan)
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: VirusBuster
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: CyberSoft VFind
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: Ikarus AntiVirus for Linux
Oct  4 23:24:14 asterix amavis[10904]: No primary av scanner: BitDefender
Oct  4 23:24:14 asterix amavis[10904]: Found secondary av scanner ClamAV-clamscan at /usr/bin/clamscan
Oct  4 23:24:14 asterix amavis[10904]: No secondary av scanner: FRISK F-Prot Antivirus
Oct  4 23:24:14 asterix amavis[10904]: No secondary av scanner: Trend Micro FileScanner
Oct  4 23:24:14 asterix amavis[10904]: No secondary av scanner: drweb - DrWeb Antivirus
Oct  4 23:24:14 asterix amavis[10904]: No secondary av scanner: KasperskyLab kavscanner
Oct  4 23:24:14 asterix amavis[10904]: Creating db in /var/spool/amavis/db/; BerkeleyDB 0.26, libdb 4.3
Oct  4 23:24:14 asterix amavis[10904]: SpamControl: initializing Mail::SpamAssassin
Oct  4 23:24:23 asterix amavis[10904]: SpamControl: done
Oct  4 23:24:23 asterix amavis[10905]: TIMING [total 88 ms] - bdb-open: 88 (100%), rundown: 0 (0%)
Oct  4 23:24:23 asterix amavis[10906]: TIMING [total 92 ms] - bdb-open: 91 (100%), rundown: 0 (0%)
Oct  4 23:25:04 asterix postfix/smtpd[10907]: connect from MyTestName[192.168.xxx.xx]
Oct  4 23:25:04 asterix postfix/smtpd[10907]: C67F81B10C: client=MyTestName[192.168.xxx.xx]
Oct  4 23:25:04 asterix postfix/cleanup[10910]: C67F81B10C: message-id=<43430F45.20234.A39EA87@localhost>
Oct  4 23:25:05 asterix postfix/qmgr[10804]: C67F81B10C: from=<info@mydomain>, size=1199, nrcpt=1 (queue active)
Oct  4 23:25:05 asterix postfix/smtpd[10907]: disconnect from MyTestName[192.168.xxx.xx]
Oct  4 23:25:05 asterix amavis[10905]: loaded base policy bank
Oct  4 23:25:05 asterix amavis[10905]: lookup_ip_acl: key="127.0.0.1" matches "127.0.0.1", result=1
Oct  4 23:25:05 asterix amavis[10905]: prolong_timer after new request - timer reset: remaining time = 480 s
Oct  4 23:25:05 asterix amavis[10905]: process_request: suggested_protocol="" on TCP
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) SMTP> 220 [127.0.0.1] ESMTP amavisd-new service ready
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) idle_proc, 4: was busy, 48.0 ms, total idle 0.000 s, busy 0.048 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) idle_proc, 5: was idle, 2.1 ms, total idle 0.002 s, busy 0.048 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prolong_timer after reading SMTP command: remaining time = 480 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) SMTP< EHLO Asterix.My_Local_Domain_Im.Lan\r\n
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP> 250-[127.0.0.1]
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP> 250-PIPELINING
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP> 250-SIZE
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP> 250-8BITMIME
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP> 250-ENHANCEDSTATUSCODES
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP> 250 XFORWARD NAME ADDR PROTO HELO
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) idle_proc, 6: was busy, 11.5 ms, total idle 0.002 s, busy 0.059 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) idle_proc, 5: was idle, 1.3 ms, total idle 0.003 s, busy 0.059 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prolong_timer after reading SMTP command: remaining time = 480 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP< MAIL FROM:<info@mydomain> SIZE=1199\r\n
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prolong_timer after MAIL FROM received - timer reset: remaining time = 480 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prepare_tempdir: creating directory /var/spool/amavis/tmp/amavis-20051004T232505-10905
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prepare_tempdir: creating file /var/spool/amavis/tmp/amavis-20051004T232505-10905/email.txt
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (debug_sender) => undef, "info@mydomain" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP> 250 2.1.0 Sender info@mydomain OK
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) idle_proc, 6: was busy, 22.5 ms, total idle 0.003 s, busy 0.082 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) idle_proc, 5: was idle, 1.3 ms, total idle 0.005 s, busy 0.082 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prolong_timer after reading SMTP command: remaining time = 480 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP< RCPT TO:<MyTestName@mydomainby.dyndns.org>\r\n
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP> 250 2.1.5 Recipient MyTestName@mydomainby.dyndns.org OK
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) idle_proc, 6: was busy, 6.4 ms, total idle 0.005 s, busy 0.088 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) idle_proc, 5: was idle, 1.1 ms, total idle 0.006 s, busy 0.088 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prolong_timer after reading SMTP command: remaining time = 480 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP< DATA\r\n
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prolong_timer after DATA received - timer reset: remaining time = 480 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP::10024 /var/spool/amavis/tmp/amavis-20051004T232505-10905: <info@mydomain> -> <MyTestName@mydomainby.dyndns.org> Received: SIZE=1199 from Asterix.My_Local_Domain_Im.Lan ([127.0.0.1]) by localhost (asterix [127.0.0.1]) (amavisd-new, port 10024) with ESMTP id 10905-01 for <MyTestName@mydomainby.dyndns.org>; Tue,  4 Oct 2005 23:25:05 +0200 (CEST)
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP> 354 End data with <CR><LF>.<CR><LF>
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) ESMTP< .\r\n
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Actual message size 1198 B, declared 1199 B
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) body hash: afccda7c210233922c32b191fafc3d5e
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Original mail size: 1198; quota set to: 599000 bytes
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Checking: <info@mydomain> -> <MyTestName@mydomainby.dyndns.org>
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) query_keys: MyTestName@mydomainby.dyndns.org, MyTestName@, My_Registered_Domain.dyndns.org, .My_Registered_Domain.dyndns.org, .dyndns.org, .org, .
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_hash(MyTestName@mydomainby.dyndns.org), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (bypass_virus_checks) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) query_keys: MyTestName@mydomainby.dyndns.org, MyTestName@, My_Registered_Domain.dyndns.org, .My_Registered_Domain.dyndns.org, .dyndns.org, .org, .
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_hash(MyTestName@mydomainby.dyndns.org), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (bypass_banned_checks) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Extracting mime components
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Issued a new file name: p001
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Issued a new file name: p002
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Issued a new pseudo part: p003
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) p003 1 Content-Type: multipart/alternative
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Charging 69 bytes to remaining quota 599000 (out of 599000, (0%)) - by mime_decode
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) p001 1/1 Content-Type: text/plain, size: 69 B, name: 
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) reparenting p001 from p000 to p003
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Charging 258 bytes to remaining quota 598931 (out of 599000, (0%)) - by mime_decode
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) p002 1/2 Content-Type: text/html, size: 258 B, name: 
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) reparenting p002 from p000 to p003
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prolong_timer after mime_decode-1: remaining time = 480 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) decode_parts: level=1, #parts=3 : p001, p002, p003
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) run_command: [10912] /usr/bin/file p001 p002 </dev/null 2>&1
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) result line from file(1): p001: ASCII text
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_re(ASCII text) matches key "(?i-xsm:^(ASCII|text)\b)", result=asc
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (map_full_type_to_short_type) => true,  "ASCII text" matches, result="asc", matching_key="(?i-xsm:^(ASCII|text)\\b)"
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) File-type of p001: ASCII text; (asc)
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) result line from file(1): p002: XML document text
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_re(XML document text) matches key "(?-xism:^XML document text\b)", result=xml
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (map_full_type_to_short_type) => true,  "XML document text" matches, result="xml", matching_key="(?-xism:^XML document text\\b)"
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) File-type of p002: XML document text; (xml)
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) do_ascii: Decoding part p001 (0 items), uulib V0.5pl19
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) decompose_part: p001 - atomic
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) decompose_part: p002 - atomic
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) prolong_timer after parts_decode: remaining time = 480 s
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) query_keys: MyTestName@mydomainby.dyndns.org, MyTestName@, My_Registered_Domain.dyndns.org, .My_Registered_Domain.dyndns.org, .dyndns.org, .org, .
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_hash(MyTestName@mydomainby.dyndns.org), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (bypass_header_checks) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Checking for banned types and filenames
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) check_for_banned (p003) M=multipart/alternative
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_re(multipart/alternative), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (banned_filename) => undef, "multipart/alternative" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) check_for_banned (p001) M=text/plain
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_re(text/plain), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (banned_filename) => undef, "text/plain" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) check_for_banned (p001) T=.asc
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_re(.asc), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (banned_filename) => undef, ".asc" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (banned_namepath_re) => undef, "P=p003\tL=1\tM=multipart/alternative\nP=p001\tL=1/1\tM=text/plain\tT=asc" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) p.path: "P=p003,L=1,M=multipart/alternative | P=p001,L=1/1,M=text/plain,T=asc"
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) check_for_banned (p003) M=multipart/alternative
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_re(multipart/alternative), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (banned_filename) => undef, "multipart/alternative" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) check_for_banned (p002) M=text/html
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_re(text/html), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (banned_filename) => undef, "text/html" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) check_for_banned (p002) T=.xml
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_re(.xml), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (banned_filename) => undef, ".xml" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (banned_namepath_re) => undef, "P=p003\tL=1\tM=multipart/alternative\nP=p002\tL=1/2\tM=text/html\tT=xml" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) p.path: "P=p003,L=1,M=multipart/alternative | P=p002,L=1/2,M=text/html,T=xml"
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) query_keys: MyTestName@mydomainby.dyndns.org, MyTestName@, My_Registered_Domain.dyndns.org, .My_Registered_Domain.dyndns.org, .dyndns.org, .org, .
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_hash(MyTestName@mydomainby.dyndns.org), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (bypass_virus_checks) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup_re(MAIL), no matches
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) lookup (keep_decoded_original) => undef, "MAIL" does not match
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) Using (H+BEDV AntiVir or CentralCommand Vexira Antivirus): /usr/bin/antivir --allfiles -noboot -nombr -rs -s -z /var/spool/amavis/tmp/amavis-20051004T232505-10905/parts
Oct  4 23:25:05 asterix amavis[10905]: (10905-01) run_command: [10913] /usr/bin/antivir --allfiles -noboot -nombr -rs -s -z /var/spool/amavis/tmp/amavis-20051004T232505-10905/parts </dev/null 2>&1
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) run_av: /usr/bin/antivir exit 0, AntiVir / Linux Version 2.1.3-16 +gui\nCopyright (c) 1994-2005 by H+BEDV Datentechnik GmbH.\nAll rights reserved.\n\nLoading /usr/lib/AntiVir/antivir.vdf ...\n\nWarnung: Die Datei "antivir.vdf" ist \344lter als 14 Tage.\n\007\nVDF-Version: 6.30.0.3 vom 21 Feb 2005\n\nAntiVir-Lizenz: 149999 f\374r Evaluation License for SuSE Linux\n\nPr\374fe Laufwerk/Pfad (list): /var/spool/amavis/tmp/amavis-20051004T232505-10905/parts\n\n--------- Suchergebnisse ---------\n...Verzeichnisse: ...1\n...Gescannte Dateien: ...2\n...Alarme: ...0\n...Verd\344chtig: ...0\n...Ben\366tigte Zeit: 00:00:01\n----------------------------------\nVielen Dank f\374r den Einsatz von AntiVir.
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) run_av (H+BEDV AntiVir or CentralCommand Vexira Antivirus): clean
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) prolong_timer after virus_scan: remaining time = 480 s
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) query_keys: MyTestName@mydomainby.dyndns.org, MyTestName@, My_Registered_Domain.dyndns.org, .My_Registered_Domain.dyndns.org, .dyndns.org, .org, .
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup_hash(MyTestName@mydomainby.dyndns.org), no matches
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup (bypass_spam_checks) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) wbl: checking sender <info@mydomain>
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup (blacklist_recip<MyTestName@mydomainby.dyndns.org>) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) query_keys: info@mydomain, info@, My_Registered_Domain.de, .My_Registered_Domain.de, .de, .
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup_hash(info@mydomain), no matches
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup (blacklist_sender) => undef, "info@mydomain" does not match
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup (whitelist_recip<MyTestName@mydomainby.dyndns.org>) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) query_keys: info@mydomain, info@, My_Registered_Domain.de, .My_Registered_Domain.de, .de, .
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup_hash(info@mydomain), no matches
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup (whitelist_sender) => undef, "info@mydomain" does not match
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) query_keys: MyTestName@mydomainby.dyndns.org, MyTestName@, My_Registered_Domain.dyndns.org, .My_Registered_Domain.dyndns.org, .dyndns.org, .org, .
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup_hash(MyTestName@mydomainby.dyndns.org) matches keys: "."=>ARRAY(0x8b4fa0c)
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup (score_sender), 1 matches for "MyTestName@mydomainby.dyndns.org", results: "."=>(Amavis::Lookup::RE=ARRAY(0x8b4f814),HASH(0x8b4f880))
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup_re(info@mydomain), no matches
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) query_keys: info@mydomain, info@, My_Registered_Domain.de, .My_Registered_Domain.de, .de, .
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup_hash(info@mydomain), no matches
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) lookup (score_sender<info@mydomain>) => undef, "info@mydomain" does not match
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) spam_scan: DSPAM not available, skipping it
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) calling SA parse, SA version 3.0.4
Oct  4 23:25:08 asterix amavis[10905]: (10905-01) CALLING SA check
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) RETURNED FROM SA check, time left: 29 s
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after spam_scan_SA: remaining time = 480 s
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) spam_scan: hits=997.4 tests=ALL_TRUSTED,AWL,GTUBE,HTML_MESSAGE,HTML_TITLE_EMPTY,NO_REAL_NAME
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after spam_scan: remaining time = 480 s
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup: (scalar) matches, result="4.5"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_kill_level) => true,  "MyTestName@mydomainby.dyndns.org" matches, result="4.5", matching_key="(constant:4.5)"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup: (scalar) matches, result="3"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_tag_level) => true,  "MyTestName@mydomainby.dyndns.org" matches, result="3", matching_key="(constant:3)"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup: (scalar) matches, result="4.5"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_tag2_level) => true,  "MyTestName@mydomainby.dyndns.org" matches, result="4.5", matching_key="(constant:4.5)"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup: (scalar) matches, result="4.5"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_kill_level) => true,  "MyTestName@mydomainby.dyndns.org" matches, result="4.5", matching_key="(constant:4.5)"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) do_spam: looking for a quarantine address
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_quarantine_bysender_to) => undef, "info@mydomain" does not match
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup: (scalar) matches, result="spam-quarantine"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_quarantine_to) => true,  "MyTestName@mydomainby.dyndns.org" matches, result="spam-quarantine", matching_key="(constant:spam-quarantine)"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) query_keys: MyTestName@mydomainby.dyndns.org, MyTestName@, My_Registered_Domain.dyndns.org, .My_Registered_Domain.dyndns.org, .dyndns.org, .org, .
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup_hash(MyTestName@mydomainby.dyndns.org), no matches
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_admin) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) header: X-Quarantine-Id: <spam-afccda7c210233922c32b191fafc3d5e-20051004-232505-10905-01>\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) header: X-Spam-Status: Yes, hits=997.4 tag=3 tag2=4.5 kill=4.5 tests=ALL_TRUSTED, AWL,\n GTUBE, HTML_MESSAGE, HTML_TITLE_EMPTY, NO_REAL_NAME\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) header: X-Spam-Level: ****************************************************************\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) header: X-Envelope-To: <MyTestName@mydomainby.dyndns.org>\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) header: X-Envelope-From: <info@mydomain>\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) DO_QUARANTINE, sender: 
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) local delivery: <> -> <spam-quarantine>, mbx=/var/spool/amavis/virusmails/spam-afccda7c210233922c32b191fafc3d5e-20051004-232505-10905-01.gz
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) run_command_consumer: [10914] /usr/bin/gzip >/var/spool/amavis/virusmails/spam-afccda7c210233922c32b191fafc3d5e-20051004-232505-10905-01.gz
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) header: Delivered-To: spam-quarantine\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) header: Return-Path: <>\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) one_response_for_all <>: success, dsn_needed=0, '250 2.6.0 Ok, delivered to /var/spool/amavis/virusmails/spam-afccda7c210233922c32b191fafc3d5e-20051004-232505-10905-01.gz, id=10905-01'
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) DO_QUARANTINE done
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) SPAM, <info@mydomain> -> <MyTestName@mydomainby.dyndns.org>, Yes, hits=997.4 tag=3 tag2=4.5 kill=4.5 tests=ALL_TRUSTED, AWL, GTUBE, HTML_MESSAGE, HTML_TITLE_EMPTY, NO_REAL_NAME, quarantine spam-afccda7c210233922c32b191fafc3d5e-20051004-232505-10905-01 (spam-quarantine)
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) Skip spam admin notification, no administrators
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) DO_SPAM DONE
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) header: Received: from Asterix.My_Local_Domain_Im.Lan ([127.0.0.1])\n by localhost (asterix [127.0.0.1]) (amavisd-new, port 10024) with ESMTP\n id 10905-01 for <MyTestName@mydomainby.dyndns.org>;\n Tue,  4 Oct 2005 23:25:05 +0200 (CEST)\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup_acl(MyTestName@mydomainby.dyndns.org), no match
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (local_domains) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) query_keys: MyTestName@mydomainby.dyndns.org, MyTestName@, My_Registered_Domain.dyndns.org, .My_Registered_Domain.dyndns.org, .dyndns.org, .org, .
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup_hash(MyTestName@mydomainby.dyndns.org), no matches
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (bypass_virus_checks) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) query_keys: MyTestName@mydomainby.dyndns.org, MyTestName@, My_Registered_Domain.dyndns.org, .My_Registered_Domain.dyndns.org, .dyndns.org, .org, .
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup_hash(MyTestName@mydomainby.dyndns.org), no matches
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (bypass_spam_checks) => undef, "MyTestName@mydomainby.dyndns.org" does not match
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup: (scalar) matches, result="3"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_tag_level) => true,  "MyTestName@mydomainby.dyndns.org" matches, result="3", matching_key="(constant:3)"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup: (scalar) matches, result="4.5"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_tag2_level) => true,  "MyTestName@mydomainby.dyndns.org" matches, result="4.5", matching_key="(constant:4.5)"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) headers CLUSTERING: NEW CLUSTER <MyTestName@mydomainby.dyndns.org>: hits=997.4, tag=0, tag2=0, subj=0, subj_u=0, local=0, bl=
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) header: X-Virus-Scanned: amavisd-new at My_Local_Domain_Im.Lan\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) headers CLUSTERING: done all 1 recips in one go
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) FWD via SMTP: [127.0.0.1]:10025 <info@mydomain> -> <MyTestName@mydomainby.dyndns.org>
Oct  4 23:25:09 asterix postfix/smtpd[10915]: connect from localhost[127.0.0.1]
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) Remote host presents itself as: Asterix.My_Local_Domain_Im.Lan
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after fwd-connect: remaining time = 480 s
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) AUTH not needed, user='', MTA offers ''
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after fwd-mail-from: remaining time = 480 s
Oct  4 23:25:09 asterix postfix/smtpd[10915]: 8F7EB1B12F: client=localhost[127.0.0.1]
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after fwd-rcpt-to: remaining time = 480 s
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) response to DATA: "354 End data with <CR><LF>.<CR><LF>"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after fwd-data: remaining time = 480 s
Oct  4 23:25:09 asterix postfix/cleanup[10910]: 8F7EB1B12F: message-id=<43430F45.20234.A39EA87@localhost>
Oct  4 23:25:09 asterix postfix/qmgr[10804]: 8F7EB1B12F: from=<info@mydomain>, size=1662, nrcpt=1 (queue active)
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after fwd-data-end: remaining time = 480 s
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) response to data end: "250 Ok: queued as 8F7EB1B12F"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after fwd-rundown-1: remaining time = 480 s
Oct  4 23:25:09 asterix postfix/smtpd[10915]: disconnect from localhost[127.0.0.1]
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) mail_via_smtp: 250 2.6.0 Ok, id=10905-01, from MTA: 250 Ok: queued as 8F7EB1B12F
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after forwarding: remaining time = 480 s
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) one_response_for_all <info@mydomain>: success, dsn_needed=0, '250 2.6.0 Ok, id=10905-01, from MTA: 250 Ok: queued as 8F7EB1B12F'
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) warnsender_with_pass=0 (,,,), dsn_needed=0, exit=0, 250 2.6.0 Ok, id=10905-01, from MTA: 250 Ok: queued as 8F7EB1B12F
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after delivery-notification: remaining time = 480 s
Oct  4 23:25:09 asterix postfix/local[10916]: 8F7EB1B12F: to=<MyTestName@mydomainby.dyndns.org>, relay=local, delay=0, status=sent (delivered to maildir)
Oct  4 23:25:09 asterix postfix/qmgr[10804]: 8F7EB1B12F: removed
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup: (scalar) matches, result="4.5"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup (spam_tag2_level) => true,  "MyTestName@mydomainby.dyndns.org" matches, result="4.5", matching_key="(constant:4.5)"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: from = papa (MyTestName [192.168.xxx.xx])\t/papa/MyTestName/192.168.xxx.xx
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: by = Asterix.My_Local_Domain_Im.Lan /Asterix.My_Local_Domain_Im.Lan//
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: with = ESMTP /ESMTP //
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: id = C67F81B10C\t/C67F81B10C\t//
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: for = <MyTestName@mydomainby.dyndns.org>/<MyTestName@mydomainby.dyndns.org>//
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: ; = Tue,  4 Oct 2005 23:25:04 +0200 (CEST)/Tue,  4 Oct 2005 23:25:04 +0200 (CEST)//
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) fish_out_ip_from_received: 192.168.xxx.xx, papa (MyTestName [192.168.xxx.xx])\t
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup_ip_acl: key="192.168.xxx.xx" matches "!192.168.0.0/16", result=0
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) best_try_originator_ip: 192.168.xxx.xx
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: from = papa (MyTestName [192.168.xxx.xx])\t/papa/MyTestName/192.168.xxx.xx
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: by = Asterix.My_Local_Domain_Im.Lan /Asterix.My_Local_Domain_Im.Lan//
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: with = ESMTP /ESMTP //
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: id = C67F81B10C\t/C67F81B10C\t//
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: for = <MyTestName@mydomainby.dyndns.org>/<MyTestName@mydomainby.dyndns.org>//
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) parse_received: ; = Tue,  4 Oct 2005 23:25:04 +0200 (CEST)/Tue,  4 Oct 2005 23:25:04 +0200 (CEST)//
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) fish_out_ip_from_received: 192.168.xxx.xx, papa (MyTestName [192.168.xxx.xx])\t
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) lookup_ip_acl: key="192.168.xxx.xx" matches "!192.168.0.0/16", result=0
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) best_try_originator_ip: 192.168.xxx.xx
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) Passed SPAM, [192.168.xxx.xx] <info@mydomain> -> <MyTestName@mydomainby.dyndns.org>, quarantine: spam-afccda7c210233922c32b191fafc3d5e-20051004-232505-10905-01, Message-ID: <43430F45.20234.A39EA87@localhost>, Hits: 997.4, 4721 ms
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) sending SMTP response: "250 2.6.0 Ok, id=10905-01, from MTA: 250 Ok: queued as 8F7EB1B12F"
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) timer stopped after DATA end
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) strip_tempdir: /var/spool/amavis/tmp/amavis-20051004T232505-10905
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) rmdir_recursively: /var/spool/amavis/tmp/amavis-20051004T232505-10905/parts, excl=1
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) TIMING [total 4765 ms] - SMTP EHLO: 56 (1%), SMTP pre-MAIL: 11 (0%), mkdir tempdir: 3 (0%), create email.txt: 4 (0%), SMTP pre-DATA-flush: 33 (1%), SMTP DATA: 24 (1%), body_hash: 9 (0%), mkdir parts: 9 (0%), mime_decode: 173 (4%), get-file-type2: 88 (2%), decompose_part: 7 (0%), parts_decode: 3 (0%), AV-scan-1: 2879 (60%), spam-wb-list: 62 (1%), SA msg read: 6 (0%), SA parse: 18 (0%), SA check: 751 (16%), update_cache: 13 (0%), write-header: 93 (2%), save-to-local-mailbox: 7 (0%), post-do_spam: 10 (0%), fwd-connect: 134 (3%), fwd-mail-from: 9 (0%), fwd-rcpt-to: 19 (0%), write-header: 21 (0%), fwd-data: 2 (0%), fwd-data-end: 136 (3%), fwd-rundown: 12 (0%), main_log_entry: 149 (3%), update_snmp: 9 (0%), unlink-2-files: 11 (0%), rundown: 2 (0%)
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) ESMTP> 250 2.6.0 Ok, id=10905-01, from MTA: 250 Ok: queued as 8F7EB1B12F
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) idle_proc, 6: was busy, 4678.2 ms, total idle 0.006 s, busy 4.767 s
Oct  4 23:25:09 asterix postfix/smtp[10911]: C67F81B10C: to=<MyTestName@mydomainby.dyndns.org>, relay=127.0.0.1[127.0.0.1], delay=5, status=sent (250 2.6.0 Ok, id=10905-01, from MTA: 250 Ok: queued as 8F7EB1B12F)
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) idle_proc, 5: was idle, 1.6 ms, total idle 0.007 s, busy 4.767 s
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) prolong_timer after reading SMTP command: remaining time = 0 s
Oct  4 23:25:09 asterix postfix/qmgr[10804]: C67F81B10C: removed
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) ESMTP< QUIT\r\n
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) ESMTP> 221 2.0.0 [127.0.0.1] amavisd-new closing transmission channel
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) post_process_request_hook: timer stopped
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) idle_proc, bye: was busy, 16.8 ms, total idle 0.007 s, busy 4.783 s
Oct  4 23:25:09 asterix amavis[10905]: (10905-01) load: 100 %, total idle 0.007 s, busy 4.783 s
Oct  4 23:25:10 asterix imapd: Connection, ip=[::ffff:192.168.xxx.xx]
Oct  4 23:25:10 asterix imapd: LOGIN, user=MyTestName, ip=[::ffff:192.168.xxx.xx], protocol=IMAP
Oct  4 23:25:10 asterix imapd: LOGOUT, user=MyTestName, ip=[::ffff:192.168.xxx.xx], headers=0, body=0, time=231
Oct  4 23:25:11 asterix imapd: Connection, ip=[::ffff:192.168.xxx.xx]
Oct  4 23:25:11 asterix imapd: LOGIN, user=MyTestName, ip=[::ffff:192.168.xxx.xx], protocol=IMAP
Oct  4 23:25:11 asterix imapd: LOGOUT, user=MyTestName, ip=[::ffff:192.168.xxx.xx], headers=0, body=0, time=1

Hoffe es sind jetzt die richtigen Infos.
 
OP
K

Knappe

Tja, tatsächlich gibt es aber
Code: 
...@mydomainby.dyndns.org

Ich habe das gleiche mit meiner "echten Domain" durchgespielt : Auch hier ersetzt amavis nicht das Subject.

Vielleicht noch ein Hinweis :

Die Zeile
Code: 
X-Virus-Scanned: amavisd-new at home.xxxxxxxx.de
wird dagegen sehr wohl in die Kopfeinträge der Nachricht eingefügt !
 
dermichel

dermichel

das "X-Virus-Scanned" wird immer gesetzt.

es liegt definitiv an "@local_domain_maps", weil amavis nur den header umschreibt oder ueber einen virus informiert wenn diese variable trifft.
 
OP
K

Knappe

Habe amavis.conf und main.cf noch einmal verglichen :

die Variable "mydomain" in main.cf stimmte NICHT mit der "$mydomain" in der amavis.conf überein.

Nach Korrektur läuft alles Bestens !

Noch einmal herzlichen Dank.
 
dermichel

dermichel

weil mydomain in beiden configs definiert werden muss - und beide variablen sind nicht global und nur zufaellig vom namen her gleich.
das sind zwei softwareprodukte die ihre eigenen variablen und configs haben.
 
Status
Für weitere Antworten geschlossen.
Oben