Jump to content
Froxlor Forum

tobm

Members
  • Content Count

    10
  • Joined

  • Last visited

Community Reputation

0 Neutral

About tobm

  • Rank
    Froxie
  1. @d00p das ist, sagen wir mal, "historisch bedingt". Bevor auf dem System Froxlor eingesetzt wurde, war es per Hand verwaltet. Noch ohne PHP-FPM sondern mit dem PHP Modul vom Apache etc aber zeitgleich mit Logins die per chroot eingeschränkt waren. Da wurde überall bei den Usern die Gruppe www-data eingesetzt. Das ganze ist dann immer mal wieder hin- und hergezogen zwischen Servern, SysCP und Froxlor-Versionen. Und offenbar hat den Part bei einigen Usern nie einer aufgeräumt. Froxlor (bzw deren Vorgänger SysCP) waren nie schuld daran ;)
  2. Oh man! Auf sowas muss man auch erstmal kommen..... Anscheinend schleppe ich da seit Ewigkeiten einen "BUG" in meiner Froxlor Userdatenbank mit mir rum. Folgendes: kundeftp1:x:10379:33:Froxlor User:/customers/webs/kunde/www/:/bin/false Die Gruppe steht bei allen Usern die nicht erkannt wird auf 33. Das ist die default www-data Gruppe. Wenn ich die Gruppe ändere auf etwas, das nicht www-data ist funktioniert es 1a.
  3. Irgendwie wird es immer spannender... getent passwd löst nicht alles auf. getent shadow hingegen kann es: root@web:/etc# getent shadow kundeftp3 kundeftp3:$ZENSIERT:17912:0:99999:7::: root@web:/etc# getent shadow kundeftp1 kundeftp1:$6ZENSIERT:0:99999:7::: root@web:/etc# getent passwd kundeftp1 root@web:/etc# getent passwd kundeftp3 kundeftp3:x:10379:10379:Froxlor User:/customers/webs/kunde/:/bin/false
  4. Interessant ist noch, dass ein "getent passwd" nicht alle User auflistet die in der /var/lib/extrausers drinstehen sondern nur einige.
  5. Auf einem Debian9 System habe ich das Froxlor auf libnss-extrausers mit Dateien im User eingestellt. Die shadow, passwd und group Dateien in /var/lib/extrausers werden generiert und auch die nsswitch.conf ist wie im Froxlor Backend vorgegeben konfiguriert. Einige User werden auch korrekt mit "id username" aufgelöst. Andere hingegen nicht. root@web:~# id kundeftp1 id: 'kundeftp1': no such user root@web:~# id kundeftp3 uid=10379(kundeftp3) gid=10379(kunde) groups=10379(kunde) wenn man in der /var/lib/extrausers/shadow jetzt aber nach kundeftp1 sucht, dann gibt es diesen Eintrag auch: kundeftp1:$zensiert:17912:0:99999:7::: Außerdem fällt auf, dass alle User mit einem "-" im Namen, also bspw "web-kunde" nicht aufgelöst werden können. Mir fehlt ein wenig der Ansatz, wo der Fehler sein könnte. Da einige User aufgelöst werden und andere eben nicht. Auch ein Neustart vom nscd hilft nicht. Es kommt die aktuelle Froxlor Version 0.9.40.1 zum Einsatz. Das Debian ist ein Debian 9.6 ii libnss-extrausers 0.6-4 amd64 nss module to have an additional passwd, shadow and group file ii nscd 2.24-11+deb9u3 amd64 GNU C Library: Name Service Cache Daemon Ich habe in der nscd.conf den Loglevel mal sehr hoch gesetzt. Dadurch kriege ich ein wenig Infos raus. Im Beispiel von kundeftp1 Thu 17 Jan 2019 04:07:54 PM CET - 4027: GETPWBYNAME (kundeftp1) Thu 17 Jan 2019 04:07:54 PM CET - 4027: Haven't found "kundeftp1" in password cache! Thu 17 Jan 2019 04:07:54 PM CET - 4027: add new entry "kundeftp1" of type GETPWBYNAME for passwd to cache (first) Thu 17 Jan 2019 04:08:04 PM CET - 4027: considering GETPWBYNAME entry "kundeftp1", timeout 1547737694 Thu 17 Jan 2019 04:08:19 PM CET - 4027: considering GETPWBYNAME entry "kundeftp1", timeout 1547737694 Thu 17 Jan 2019 04:08:19 PM CET - 4027: remove GETPWBYNAME entry "kundeftp1" Direkt nach dem Neustart von nscd kommt Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file /etc/passwd for database passwd Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file `/etc/passwd` (1) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring directory `/etc` (2) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file /etc/group for database group Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file `/etc/group` (3) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring directory `/etc` (2) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file /etc/hosts for database hosts Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file `/etc/hosts` (4) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring directory `/etc` (2) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file /etc/resolv.conf for database hosts Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file `/etc/resolv.conf` (5) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring directory `/etc` (2) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file /etc/services for database services Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file `/etc/services` (6) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring directory `/etc` (2) Thu 17 Jan 2019 04:07:34 PM CET - 4027: monitoring file /etc/netgroup for database netgroup Thu 17 Jan 2019 04:07:34 PM CET - 4027: disabled inotify-based monitoring for file `/etc/netgroup': No such file or directory Thu 17 Jan 2019 04:07:34 PM CET - 4027: stat failed for file `/etc/netgroup'; will try again later: No such file or directory Thu 17 Jan 2019 04:07:36 PM CET - 4027: handle_request: request received (Version = 2) from PID 4054 Thu 17 Jan 2019 04:07:36 PM CET - 4027: GETFDPW Thu 17 Jan 2019 04:07:36 PM CET - 4027: provide access to FD 7, for passwd Thu 17 Jan 2019 04:07:36 PM CET - 4027: handle_request: request received (Version = 2) from PID 4054 Thu 17 Jan 2019 04:07:36 PM CET - 4027: GETPWBYUID (100) Thu 17 Jan 2019 04:07:36 PM CET - 4027: Haven't found "100" in password cache! Thu 17 Jan 2019 04:07:36 PM CET - 4027: add new entry "100" of type GETPWBYUID for passwd to cache (first) Thu 17 Jan 2019 04:07:36 PM CET - 4027: add new entry "systemd-timesync" of type GETPWBYNAME for passwd to cache Thu 17 Jan 2019 04:07:36 PM CET - 4027: handle_request: request received (Version = 2) from PID 4054 Thu 17 Jan 2019 04:07:36 PM CET - 4027: GETPWBYUID (105) Thu 17 Jan 2019 04:07:36 PM CET - 4027: Haven't found "105" in password cache! Thu 17 Jan 2019 04:07:36 PM CET - 4027: add new entry "105" of type GETPWBYUID for passwd to cache (first) Thu 17 Jan 2019 04:07:36 PM CET - 4027: add new entry "messagebus" of type GETPWBYNAME for passwd to cache Thu 17 Jan 2019 04:07:36 PM CET - 4027: handle_request: request received (Version = 2) from PID 4054 Thu 17 Jan 2019 04:07:36 PM CET - 4027: GETPWBYUID (107) Thu 17 Jan 2019 04:07:36 PM CET - 4027: Haven't found "107" in password cache! Thu 17 Jan 2019 04:07:36 PM CET - 4027: add new entry "107" of type GETPWBYUID for passwd to cache (first) Thu 17 Jan 2019 04:07:36 PM CET - 4027: add new entry "proftpd" of type GETPWBYNAME for passwd to cache Thu 17 Jan 2019 04:07:49 PM CET - 4027: pruning passwd cache; time 1547737669 Thu 17 Jan 2019 04:07:49 PM CET - 4027: considering GETPWBYUID entry "0", timeout 1547737702 Hat da jemand einen Rat für mich?
  6. Sorry. Und danke für deinen Hilfeversuch!
  7. Ich hab es gefunden! Die Config wird bei mir von Puppet geschrieben und ich habe es ergänz um die Froxlor-Definitionen. Allerdings dabei offenbar immer und immer wieder diese Zeile überlesen: receive_override_options = no_address_mappings Sobald die aus der main.cf rausgenommen ist läuft es!
  8. Hab ich gerade... Interessant ist, dass Postfix eigentlich meint es zu finden. Die Mail aber dann dennoch bounced. Mar 20 08:45:15 mail01 postfix/smtpd[14585]: maps_find: virtual_alias_maps: mysql:/etc/postfix/mysql-virtual_alias_maps.cf(0,lock|fold_fix): @testdomain.tld = test@testdomain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: mail_addr_find: sfdouhsg@testdomain.tld -> test@testdomain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: report recipient to all milters (flags=0x0) Hier das ganze Log: Mar 20 08:45:14 mail01 postfix/smtpd[14585]: name_mask: all Mar 20 08:45:14 mail01 postfix/smtpd[14585]: inet_addr_local: configured 2 IPv4 addresses Mar 20 08:45:14 mail01 postfix/smtpd[14585]: inet_addr_local: configured 2 IPv6 addresses Mar 20 08:45:14 mail01 postfix/smtpd[14585]: process generation: 3 (3) Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: mynetworks ~? debug_peer_list Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: mynetworks ~? fast_flush_domains Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: mynetworks ~? mynetworks Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: relay_domains ~? debug_peer_list Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: relay_domains ~? fast_flush_domains Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: relay_domains ~? mynetworks Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: relay_domains ~? permit_mx_backup_networks Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: relay_domains ~? qmqpd_authorized_clients Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: relay_domains ~? relay_domains Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: permit_mx_backup_networks ~? debug_peer_list Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: permit_mx_backup_networks ~? fast_flush_domains Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: permit_mx_backup_networks ~? mynetworks Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: permit_mx_backup_networks ~? permit_mx_backup_networks Mar 20 08:45:14 mail01 postfix/smtpd[14585]: connect to subsystem private/proxymap Mar 20 08:45:14 mail01 postfix/smtpd[14585]: send attr request = open Mar 20 08:45:14 mail01 postfix/smtpd[14585]: send attr table = unix:passwd.byname Mar 20 08:45:14 mail01 postfix/smtpd[14585]: send attr flags = 0 Mar 20 08:45:14 mail01 postfix/smtpd[14585]: private/proxymap socket: wanted attribute: status Mar 20 08:45:14 mail01 postfix/smtpd[14585]: input attribute name: status Mar 20 08:45:14 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:14 mail01 postfix/smtpd[14585]: private/proxymap socket: wanted attribute: flags Mar 20 08:45:14 mail01 postfix/smtpd[14585]: input attribute name: flags Mar 20 08:45:14 mail01 postfix/smtpd[14585]: input attribute value: 16 Mar 20 08:45:14 mail01 postfix/smtpd[14585]: private/proxymap socket: wanted attribute: (list terminator) Mar 20 08:45:14 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:14 mail01 postfix/smtpd[14585]: dict_proxy_open: connect to map=unix:passwd.byname status=0 server_flags=fixed Mar 20 08:45:14 mail01 postfix/smtpd[14585]: dict_open: proxy:unix:passwd.byname Mar 20 08:45:14 mail01 postfix/smtpd[14585]: Compiled against Berkeley DB: 5.3.28? Mar 20 08:45:14 mail01 postfix/smtpd[14585]: Run-time linked against Berkeley DB: 5.3.28? Mar 20 08:45:14 mail01 postfix/smtpd[14585]: dict_open: hash:/etc/aliases Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: user = froxlor Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: password = Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: dbname = config Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: result_format = %s Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: option_file = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: option_group = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: tls_key_file = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: tls_cert_file = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: tls_CAfile = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: tls_CApath = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: tls_ciphers = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_bool: /etc/postfix/mysql-virtual_alias_maps.cf: tls_verify_cert = on Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_int: /etc/postfix/mysql-virtual_alias_maps.cf: expansion_limit = 0 Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: query = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: table = mail_virtual Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: select_field = destination Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: where_field = email Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: additional_conditions = and TRIM(destination) <> '' Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: domain = Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_alias_maps.cf: hosts = mysql.doain Mar 20 08:45:14 mail01 postfix/smtpd[14585]: dict_open: mysql:/etc/postfix/mysql-virtual_alias_maps.cf Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: user = froxlor Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: password = Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: dbname = config Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: result_format = %s Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: option_file = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: option_group = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: tls_key_file = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: tls_cert_file = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: tls_CAfile = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: tls_CApath = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: tls_ciphers = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_bool: /etc/postfix/mysql-virtual_mailbox_maps.cf: tls_verify_cert = on Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_int: /etc/postfix/mysql-virtual_mailbox_maps.cf: expansion_limit = 0 Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: query = SELECT CONCAT(homedir,maildir) FROM mail_users WHERE email = '%s' Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: domain = Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_mailbox_maps.cf: hosts = mysql.doain Mar 20 08:45:14 mail01 postfix/smtpd[14585]: dict_open: mysql:/etc/postfix/mysql-virtual_mailbox_maps.cf Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: smtpd_access_maps ~? debug_peer_list Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: smtpd_access_maps ~? fast_flush_domains Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: smtpd_access_maps ~? mynetworks Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: smtpd_access_maps ~? permit_mx_backup_networks Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: smtpd_access_maps ~? qmqpd_authorized_clients Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: smtpd_access_maps ~? relay_domains Mar 20 08:45:14 mail01 postfix/smtpd[14585]: match_string: smtpd_access_maps ~? smtpd_access_maps Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: user = froxlor Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: password = Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: dbname = config Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: result_format = %s Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: option_file = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: option_group = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: tls_key_file = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: tls_cert_file = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: tls_CAfile = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: tls_CApath = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: tls_ciphers = <NULL> Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_bool: /etc/postfix/mysql-virtual_sender_permissions.cf: tls_verify_cert = on Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_int: /etc/postfix/mysql-virtual_sender_permissions.cf: expansion_limit = 0 Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: query = SELECT DISTINCT username FROM mail_users WHERE email in ((SELECT mail_virtual.email_full FROM mail_virtual WHERE mail_virtual.email = '%s' UNION SELECT mail_virtual.destination FROM mail_virtual WHERE mail_virtual.email = '%s')); Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: domain = Mar 20 08:45:14 mail01 postfix/smtpd[14585]: cfg_get_str: /etc/postfix/mysql-virtual_sender_permissions.cf: hosts = mysql.doain Mar 20 08:45:14 mail01 postfix/smtpd[14585]: dict_open: mysql:/etc/postfix/mysql-virtual_sender_permissions.cf Mar 20 08:45:14 mail01 postfix/smtpd[14585]: unknown_helo_hostname_tempfail_action = defer_if_permit Mar 20 08:45:14 mail01 postfix/smtpd[14585]: unknown_address_tempfail_action = defer_if_permit Mar 20 08:45:14 mail01 postfix/smtpd[14585]: unverified_recipient_tempfail_action = defer_if_permit Mar 20 08:45:14 mail01 postfix/smtpd[14585]: unverified_sender_tempfail_action = defer_if_permit Mar 20 08:45:14 mail01 postfix/smtpd[14585]: name_mask: 1 Mar 20 08:45:14 mail01 postfix/smtpd[14585]: auto_clnt_create: transport=local endpoint=private/tlsmgr Mar 20 08:45:14 mail01 postfix/smtpd[14585]: auto_clnt_open: connected to private/tlsmgr Mar 20 08:45:14 mail01 postfix/smtpd[14585]: send attr request = seed Mar 20 08:45:14 mail01 postfix/smtpd[14585]: send attr size = 32 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: seed Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: seed Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: fUiBGqnHTbWjPCdch4RCQNGKuPAzK8UC5Z/dgnzaA8Y= Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr request = policy Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr cache_type = smtpd Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: cachable Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: cachable Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 1 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: timeout Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: timeout Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 3600 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_string: fast_flush_domains ~? debug_peer_list Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_string: fast_flush_domains ~? fast_flush_domains Mar 20 08:45:15 mail01 postfix/smtpd[14585]: name_mask: no_address_mappings Mar 20 08:45:15 mail01 postfix/smtpd[14585]: auto_clnt_create: transport=local endpoint=private/anvil Mar 20 08:45:15 mail01 postfix/smtpd[14585]: connection established Mar 20 08:45:15 mail01 postfix/smtpd[14585]: master_notify: status 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: name_mask: resource Mar 20 08:45:15 mail01 postfix/smtpd[14585]: name_mask: software Mar 20 08:45:15 mail01 postfix/smtpd[14585]: connect from mout.web.de[212.227.17.12] Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: mout.web.de: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: 212.227.17.12: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: mout.web.de: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: 212.227.17.12: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: smtp_stream_setup: maxtime=300 enable_deadline=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? 127.0.0.0/8 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? 127.0.0.0/8 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? [::ffff:127.0.0.0]/104 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? [::ffff:127.0.0.0]/104 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? [::1]/128 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? [::1]/128 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? 10.2.19.0/24 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? 10.2.19.0/24 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: mout.web.de: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: 212.227.17.12: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: auto_clnt_open: connected to private/anvil Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr request = connect Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr ident = smtp:212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/anvil: wanted attribute: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/anvil: wanted attribute: count Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: count Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 1 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/anvil: wanted attribute: rate Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: rate Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 1 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/anvil: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: report connect to all milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "j" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "mail01.endil.net" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{daemon_name}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "mail01.endil.net" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "v" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "Postfix 2.11.3" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_connect: non-protocol events for protocol version 6: Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_connect: transport=inet endpoint=localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: trying... [::1] Mar 20 08:45:15 mail01 postfix/smtpd[14585]: vstream_tweak_tcp: TCP_MAXSEG 21845 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: fd=19: stream buffer size old=0 new=43690 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_connect: my_version=0x6 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_connect: my_actions=0x1ff SMFIF_ADDHDRS SMFIF_CHGBODY SMFIF_ADDRCPT SMFIF_DELRCPT SMFIF_CHGHDRS SMFIF_QUARANTINE SMFIF_CHGFROM SMFIF_ADDRCPT_PAR SMFIF_SETSYMLIST Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_connect: my_events=0x1fffff SMFIP_NOCONNECT SMFIP_NOHELO SMFIP_NOMAIL SMFIP_NORCPT SMFIP_NOBODY SMFIP_NOHDRS SMFIP_NOEOH SMFIP_NR_HDR SMFIP_NOUNKNOWN SMFIP_NODATA SMFIP_SKIP SMFIP_RCPT_REJ SMFIP_NR_CONN SMFIP_NR_HELO SMFIP_NR_MAIL SMFIP_NR_RCPT SMFIP_NR_DATA SMFIP_NR_UNKN SMFIP_NR_EOH SMFIP_NR_BODY SMFIP_HDR_LEADSPC Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_connect: milter inet:localhost:11332 version 6 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_connect: events SMFIP_NR_HDR SMFIP_NR_CONN SMFIP_NR_HELO SMFIP_NR_MAIL SMFIP_NR_RCPT SMFIP_NR_DATA SMFIP_NR_UNKN SMFIP_NR_EOH SMFIP_NR_BODY Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_connect: requests SMFIF_ADDHDRS SMFIF_CHGBODY SMFIF_ADDRCPT SMFIF_DELRCPT SMFIF_CHGHDRS SMFIF_QUARANTINE SMFIF_CHGFROM SMFIF_ADDRCPT_PAR SMFIF_SETSYMLIST Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_conn_event: milter inet:localhost:11332: connect mout.web.de/212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: event: SMFIC_CONNECT; macros: j=mail01.endil.net {daemon_name}=mail01.endil.net v=Postfix 2.11.3 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: skipping reply for event SMFIC_CONNECT from milter inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 220 mail01.endil.net ESMTP Postfix (Debian/GNU) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_create: SASL service=smtp, realm=(null) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: name_mask: noanonymous Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_connect: Connecting Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_connect: auth reply: VERSION?1?1 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_connect: auth reply: MECH?PLAIN?plaintext Mar 20 08:45:15 mail01 postfix/smtpd[14585]: name_mask: plaintext Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_connect: auth reply: SPID?13703 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_connect: auth reply: CUID?2 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_connect: auth reply: COOKIE?915f5d0bb58ac183c3e7e40de02ea579 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_connect: auth reply: DONE Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_mech_filter: keep mechanism: PLAIN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: < mout.web.de[212.227.17.12]: EHLO mout.web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: report helo to all milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{tls_version}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{cipher}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{cipher_bits}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{cert_subject}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{cert_issuer}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_helo_event: milter inet:localhost:11332: helo mout.web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: event: SMFIC_HELO; macros: (none) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: skipping reply for event SMFIC_HELO from milter inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: mout.web.de: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: 212.227.17.12: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-mail01.endil.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-PIPELINING Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-SIZE 10240000 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-VRFY Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-ETRN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-STARTTLS Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-AUTH PLAIN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-AUTH=PLAIN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-ENHANCEDSTATUSCODES Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-8BITMIME Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250 DSN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: < mout.web.de[212.227.17.12]: STARTTLS Mar 20 08:45:15 mail01 postfix/smtpd[14585]: query milter states for other event Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_other_event: milter inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 220 2.0.0 Ready to start TLS Mar 20 08:45:15 mail01 postfix/smtpd[14585]: abort all milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_abort: abort milter inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr request = seed Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr size = 32 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: seed Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: seed Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: T2GFwOv8vpmiOkEPNUCaqBdfg4bSMMPyBxCOc03hd6A= Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr request = update Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr cache_type = smtpd Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr cache_id = 4D85636153460065DAF6A2996A76A34CBD20618CF96C23360F13E9DC3B35F616&s=smtp&l=268439887 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr session = [data 148 bytes] Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/tlsmgr: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: Anonymous TLS connection established from mout.web.de[212.227.17.12]: TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 (128/128 bits) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_create: SASL service=smtp, realm=(null) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: name_mask: noanonymous Mar 20 08:45:15 mail01 postfix/smtpd[14585]: xsasl_dovecot_server_mech_filter: keep mechanism: PLAIN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: < mout.web.de[212.227.17.12]: EHLO mout.web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: report helo to all milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{tls_version}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "TLSv1.2" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{cipher}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "ECDHE-RSA-AES128-GCM-SHA256" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{cipher_bits}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "128" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{cert_subject}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{cert_issuer}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_helo_event: milter inet:localhost:11332: helo mout.web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: event: SMFIC_HELO; macros: {tls_version}=TLSv1.2 {cipher}=ECDHE-RSA-AES128-GCM-SHA256 {cipher_bits}=128 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: skipping reply for event SMFIC_HELO from milter inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: mout.web.de: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: 212.227.17.12: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-mail01.endil.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-PIPELINING Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-SIZE 10240000 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-VRFY Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-ETRN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-AUTH PLAIN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-AUTH=PLAIN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-ENHANCEDSTATUSCODES Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250-8BITMIME Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250 DSN Mar 20 08:45:15 mail01 postfix/smtpd[14585]: < mout.web.de[212.227.17.12]: MAIL FROM:<extern@web.de> SIZE=1593 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: extract_addr: input: <extern@web.de> Mar 20 08:45:15 mail01 postfix/smtpd[14585]: smtpd_check_addr: addr=extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: connect to subsystem private/rewrite Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr request = rewrite Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr rule = local Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr address = extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: address Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: address Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: rewrite_clnt: local: extern@web.de -> extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr request = resolve Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr sender = Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr address = extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: transport Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: transport Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: smtp Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: nexthop Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: nexthop Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: recipient Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: recipient Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 4096 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: resolve_clnt: `' -> `extern@web.de' -> transp=`smtp' host=`web.de' rcpt=`extern@web.de' flags= class=default Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: install entry key extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: extract_addr: in: <extern@web.de>, result: extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr request = rewrite Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr rule = local Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr address = double-bounce Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: address Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: address Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: double-bounce@mail01.endil.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: rewrite_clnt: local: double-bounce -> double-bounce@mail01.endil.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: report sender to all milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "i" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{auth_type}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{auth_authen}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{auth_author}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{mail_addr}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: leave existing entry key extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "extern@web.de" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{mail_host}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: leave existing entry key extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "web.de" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{mail_mailer}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: leave existing entry key extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "smtp" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_mail_event: milter inet:localhost:11332: mail <extern@web.de> SIZE=1593 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: event: SMFIC_MAIL; macros: {mail_addr}=extern@web.de {mail_host}=web.de {mail_mailer}=smtp Mar 20 08:45:15 mail01 postfix/smtpd[14585]: skipping reply for event SMFIC_MAIL from milter inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: smtpd_check_rewrite: trying: permit_inet_interfaces Mar 20 08:45:15 mail01 postfix/smtpd[14585]: permit_inet_interfaces: mout.web.de 212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: fsspace: .: block size 4096, blocks free 3454184 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: smtpd_check_queue: blocks 4096 avail 3454184 min_free 0 msg_size_limit 10240000 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250 2.1.0 Ok Mar 20 08:45:15 mail01 postfix/smtpd[14585]: < mout.web.de[212.227.17.12]: RCPT TO:<sfdouhsg@domain.tld> Mar 20 08:45:15 mail01 postfix/smtpd[14585]: extract_addr: input: <sfdouhsg@domain.tld> Mar 20 08:45:15 mail01 postfix/smtpd[14585]: smtpd_check_addr: addr=sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr request = rewrite Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr rule = local Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr address = sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: address Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: address Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: rewrite_clnt: local: sfdouhsg@domain.tld -> sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr request = resolve Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr sender = Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr address = sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: transport Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: transport Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: dovecot Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: nexthop Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: nexthop Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: recipient Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: recipient Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: flags Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 1024 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: private/rewrite socket: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: resolve_clnt: `' -> `sfdouhsg@domain.tld' -> transp=`dovecot' host=`domain.tld' rcpt=`sfdouhsg@domain.tld' flags= class=virtual Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: install entry key sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: extract_addr: in: <sfdouhsg@domain.tld>, result: sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: >>> START Recipient address RESTRICTIONS <<< Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=permit_mynetworks Mar 20 08:45:15 mail01 postfix/smtpd[14585]: permit_mynetworks: mout.web.de 212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? 127.0.0.0/8 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? 127.0.0.0/8 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? [::ffff:127.0.0.0]/104 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? [::ffff:127.0.0.0]/104 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? [::1]/128 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? [::1]/128 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? 10.2.19.0/24 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? 10.2.19.0/24 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: mout.web.de: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: 212.227.17.12: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=permit_mynetworks status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=permit_sasl_authenticated Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=permit_sasl_authenticated status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=defer_unauth_destination Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_unauth_destination: sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: permit_auth_destination: sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: leave existing entry key sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=defer_unauth_destination status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: >>> END Recipient address RESTRICTIONS <<< Mar 20 08:45:15 mail01 postfix/smtpd[14585]: >>> START Recipient address RESTRICTIONS <<< Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=permit_sasl_authenticated Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=permit_sasl_authenticated status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=permit_mynetworks Mar 20 08:45:15 mail01 postfix/smtpd[14585]: permit_mynetworks: mout.web.de 212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? 127.0.0.0/8 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? 127.0.0.0/8 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? [::ffff:127.0.0.0]/104 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? [::ffff:127.0.0.0]/104 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? [::1]/128 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? [::1]/128 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? 10.2.19.0/24 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? 10.2.19.0/24 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: mout.web.de: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: 212.227.17.12: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=permit_mynetworks status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_unauth_destination Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_unauth_destination: sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: permit_auth_destination: sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: leave existing entry key sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_unauth_destination status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_unauth_pipelining Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_unauth_pipelining: RCPT Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_unauth_pipelining status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_invalid_hostname Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_invalid_hostname: mout.web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_invalid_hostname status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_non_fqdn_sender Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_non_fqdn_address: extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_non_fqdn_sender status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_non_fqdn_recipient Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_non_fqdn_address: sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_non_fqdn_recipient status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_unknown_sender_domain Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_unknown_address: extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: move existing entry key extern@web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_unknown_mailhost: web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: lookup web.de type MX flags 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dns_query: web.de (MX): OK Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dns_get_answer: type MX for web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dns_get_answer: type MX for web.de Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_unknown_sender_domain status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_rbl_addr: Client host 212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dns_query: 12.17.227.212.zen.spamhaus.org (A): Host not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: install entry key 12.17.227.212.zen.spamhaus.org Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_rbl_addr: Client host 212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dns_query: 12.17.227.212.bl.spamcop.net (A): Host not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: install entry key 12.17.227.212.bl.spamcop.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_rbl_addr: Client host 212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dns_query: 12.17.227.212.cbl.abuseat.org (A): Host not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: install entry key 12.17.227.212.cbl.abuseat.org Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_rbl_addr: Client host 212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dns_query: 12.17.227.212.ix.dnsbl.manitu.net (A): Host not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: install entry key 12.17.227.212.ix.dnsbl.manitu.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client Mar 20 08:45:15 mail01 postfix/smtpd[14585]: reject_rbl_addr: Client host 212.227.17.12 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dns_query: 12.17.227.212.combined.rbl.msrbl.net (A): Host not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: install entry key 12.17.227.212.combined.rbl.msrbl.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: generic_checks: name=reject_rbl_client status=0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: >>> END Recipient address RESTRICTIONS <<< Mar 20 08:45:15 mail01 postfix/smtpd[14585]: >>> CHECKING RECIPIENT MAPS <<< Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: move existing entry key sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: maps_find: recipient_canonical_maps: sfdouhsg@domain.tld: not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_string: domain.tld ~? mail01.endil.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: domain.tld: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: maps_find: recipient_canonical_maps: @domain.tld: not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: mail_addr_find: sfdouhsg@domain.tld -> (not found) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: maps_find: canonical_maps: sfdouhsg@domain.tld: not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_string: domain.tld ~? mail01.endil.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: domain.tld: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: maps_find: canonical_maps: @domain.tld: not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: mail_addr_find: sfdouhsg@domain.tld -> (not found) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dict_mysql_get_active: attempting to connect to host mysql.doain Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dict_mysql: successful connection to host mysql.doain Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dict_mysql: successful query from host mysql.doain Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dict_mysql_lookup: retrieved 0 rows Mar 20 08:45:15 mail01 postfix/smtpd[14585]: maps_find: virtual_alias_maps: sfdouhsg@domain.tld: not found Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_string: domain.tld ~? mail01.endil.net Mar 20 08:45:15 mail01 postfix/smtpd[14585]: match_list_match: domain.tld: no match Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dict_mysql_get_active: found active connection to host mysql.doain Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dict_mysql: successful query from host mysql.doain Mar 20 08:45:15 mail01 postfix/smtpd[14585]: dict_mysql_lookup: retrieved 1 rows Mar 20 08:45:15 mail01 postfix/smtpd[14585]: maps_find: virtual_alias_maps: mysql:/etc/postfix/mysql-virtual_alias_maps.cf(0,lock|fold_fix): @domain.tld = test@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: mail_addr_find: sfdouhsg@domain.tld -> test@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: report recipient to all milters (flags=0x0) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "i" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{rcpt_addr}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: leave existing entry key sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "sfdouhsg@domain.tld" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{rcpt_host}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: leave existing entry key sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "domain.tld" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "{rcpt_mailer}" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: ctable_locate: leave existing entry key sfdouhsg@domain.tld Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "dovecot" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_rcpt_event: milter inet:localhost:11332: rcpt <sfdouhsg@domain.tld> Mar 20 08:45:15 mail01 postfix/smtpd[14585]: event: SMFIC_RCPT; macros: {rcpt_addr}=sfdouhsg@domain.tld {rcpt_host}=domain.tld {rcpt_mailer}=dovecot Mar 20 08:45:15 mail01 postfix/smtpd[14585]: skipping reply for event SMFIC_RCPT from milter inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: before input_transp_cleanup: cleanup flags = enable_header_body_filter enable_automatic_bcc enable_address_mapping enable_milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: after input_transp_cleanup: cleanup flags = enable_header_body_filter enable_milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: connect to subsystem public/cleanup Mar 20 08:45:15 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: queue_id Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: queue_id Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 604049F92A Mar 20 08:45:15 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr flags = 194 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send 0 milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: 604049F92A: client=mout.web.de[212.227.17.12] Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250 2.1.5 Ok Mar 20 08:45:15 mail01 postfix/smtpd[14585]: < mout.web.de[212.227.17.12]: DATA Mar 20 08:45:15 mail01 postfix/smtpd[14585]: report data to all milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: "i" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter_macro_lookup: result "604049F92A" Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_data_event: milter inet:localhost:11332: data command Mar 20 08:45:15 mail01 postfix/smtpd[14585]: event: SMFIC_DATA; macros: i=604049F92A Mar 20 08:45:15 mail01 postfix/smtpd[14585]: skipping reply for event SMFIC_DATA from milter inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send 1 milters Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr conn_macros = j {daemon_name} v Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr helo_macros = {tls_version} {cipher} {cipher_bits} {cert_subject} {cert_issuer} Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr mail_macros = i {auth_type} {auth_authen} {auth_author} {mail_addr} {mail_host} {mail_mailer} Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr rcpt_macros = i {rcpt_addr} {rcpt_host} {rcpt_mailer} Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr data_macros = i Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr eoh_macros = i Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr eod_macros = i Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr unk_macros = Mar 20 08:45:15 mail01 postfix/smtpd[14585]: milter8_send: milter inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_name = inet:localhost:11332 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_version = 6 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_actions = 511 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_events = 1044608 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_non_events = 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_state = 4 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_conn_timeout = 30 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_cmd_timeout = 30 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_msg_timeout = 300 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_action = accept Mar 20 08:45:15 mail01 postfix/smtpd[14585]: send attr milter_macro_list = 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: dummy Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: dummy Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: dummy Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: dummy Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: status Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:15 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: (list terminator) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:15 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 354 End data with <CR><LF>.<CR><LF> Mar 20 08:45:15 mail01 postfix/cleanup[14592]: 604049F92A: message-id=<trinity-57f386d0-ef29-41fa-b5a9-671598a22719-1521531912174@3c-app-webde-bap45> Mar 20 08:45:18 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: status Mar 20 08:45:18 mail01 postfix/smtpd[14585]: input attribute name: status Mar 20 08:45:18 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: reason Mar 20 08:45:18 mail01 postfix/smtpd[14585]: input attribute name: reason Mar 20 08:45:18 mail01 postfix/smtpd[14585]: input attribute value: (end) Mar 20 08:45:18 mail01 postfix/smtpd[14585]: public/cleanup socket: wanted attribute: (list terminator) Mar 20 08:45:18 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:18 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 250 2.0.0 Ok: queued as 604049F92A Mar 20 08:45:18 mail01 postfix/smtpd[14585]: abort all milters Mar 20 08:45:18 mail01 postfix/smtpd[14585]: milter8_abort: abort milter inet:localhost:11332 Mar 20 08:45:18 mail01 postfix/qmgr[14572]: 604049F92A: from=<extern@web.de>, size=1928, nrcpt=1 (queue active) Mar 20 08:45:18 mail01 postfix/smtpd[14585]: < mout.web.de[212.227.17.12]: QUIT Mar 20 08:45:18 mail01 postfix/smtpd[14585]: > mout.web.de[212.227.17.12]: 221 2.0.0 Bye Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? 127.0.0.0/8 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? 127.0.0.0/8 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? [::ffff:127.0.0.0]/104 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? [::ffff:127.0.0.0]/104 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? [::1]/128 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? [::1]/128 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_hostname: mout.web.de ~? 10.2.19.0/24 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_hostaddr: 212.227.17.12 ~? 10.2.19.0/24 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_list_match: mout.web.de: no match Mar 20 08:45:18 mail01 postfix/smtpd[14585]: match_list_match: 212.227.17.12: no match Mar 20 08:45:18 mail01 postfix/smtpd[14585]: send attr request = disconnect Mar 20 08:45:18 mail01 postfix/smtpd[14585]: send attr ident = smtp:212.227.17.12 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: private/anvil: wanted attribute: status Mar 20 08:45:18 mail01 postfix/smtpd[14585]: input attribute name: status Mar 20 08:45:18 mail01 postfix/smtpd[14585]: input attribute value: 0 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: private/anvil: wanted attribute: (list terminator) Mar 20 08:45:18 mail01 postfix/smtpd[14585]: input attribute name: (end) Mar 20 08:45:18 mail01 postfix/smtpd[14585]: abort all milters Mar 20 08:45:18 mail01 postfix/smtpd[14585]: milter8_abort: abort milter inet:localhost:11332 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: disconnect event to all milters Mar 20 08:45:18 mail01 postfix/smtpd[14585]: milter8_disc_event: quit milter inet:localhost:11332 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: disconnect from mout.web.de[212.227.17.12] Mar 20 08:45:18 mail01 postfix/smtpd[14585]: master_notify: status 1 Mar 20 08:45:18 mail01 postfix/smtpd[14585]: connection closed Mar 20 08:45:18 mail01 postfix/pipe[14593]: 604049F92A: to=<sfdouhsg@domain.tld>, relay=dovecot, delay=3.4, delays=3.1/0.03/0/0.24, dsn=5.1.1, status=bounced (user unknown) Mar 20 08:45:18 mail01 postfix/cleanup[14592]: 93EC59FF97: message-id=<20180320074518.93EC59FF97@mail01.endil.net> Mar 20 08:45:18 mail01 postfix/qmgr[14572]: 93EC59FF97: from=<>, size=3664, nrcpt=1 (queue active) Mar 20 08:45:18 mail01 postfix/bounce[14597]: 604049F92A: sender non-delivery notification: 93EC59FF97 Mar 20 08:45:18 mail01 postfix/qmgr[14572]: 604049F92A: removed Mar 20 08:45:18 mail01 postfix/smtp[14600]: 93EC59FF97: to=<extern@web.de>, relay=mx-ha03.web.de[212.227.15.17]:25, delay=0.19, delays=0.04/0.01/0.08/0.06, dsn=2.0.0, status=sent (250 Requested mail action okay, completed: id=1MejrN-1eQEFV1OTd-00aVTR) Mar 20 08:45:18 mail01 postfix/qmgr[14572]: 93EC59FF97: removed Mar 20 08:45:19 mail01 postfix/smtpd[14585]: proxymap stream disconnect Mar 20 08:45:20 mail01 postfix/smtpd[14585]: auto_clnt_close: disconnect private/tlsmgr stream Mar 20 08:45:20 mail01 postfix/smtpd[14585]: rewrite stream disconnect
  9. Welche Versionen hast du so im Einsatz? Dasselbe Problem habe ich hier auch. ii postfix 2.11.3-1+deb8u2 amd64 High-performance mail transport agent ii postfix-mysql 2.11.3-1+deb8u2 amd64 MySQL map support for Postfix ii dovecot-core 1:2.2.13-12~deb8u4 amd64 secure POP3/IMAP server - core files
×
×
  • Create New...