Unable to get my Postfix/Dovecot/Amavis/Spamassassin mailserver working
up vote
0
down vote
favorite
My mail server can't send or receive emails. I've been trying for months without success. None of the Google searches have helped either. Please have a look see and try to help me get this resolved.
For Postfix configuration, the output is:
root@domain:~# postconf -n
alias_database = hash:/etc/aliases
alias_maps = hash:/etc/aliases
body_checks = regexp:/etc/postfix/body_checks
broken_sasl_auth_clients = yes
command_directory = /usr/sbin
compatibility_level = 2
content_filter = smtp-amavis:[127.0.0.1]:10024
daemon_directory = /usr/lib/postfix/sbin
data_directory = /var/lib/postfix
debug_peer_level = 2
debug_peer_list = 127.0.0.1
debugger_command = PATH=/bin:/usr/bin:/usr/local/bin:/usr/X11R6/bin ddd $daemon_directory/$process_name $process_id & sleep 5
default_destination_concurrency_limit = 20
fast_flush_domains = $relay_domains
header_checks = pcre:/etc/postfix/header_checks.pcre
home_mailbox = maildir/
html_directory = no
in_flow_delay = 1s
inet_interfaces = all
inet_protocols = all
local_recipient_maps = unix:passwd.byname $alias_maps
mail_owner = postfix
mail_spool_directory = /var/mail
mailbox_command = procmail -a "$EXTENSION"
mailbox_size_limit = 0
mailbox_transport = lmtp:unix:/var/run/dovecot/lmtp
mailq_path = /usr/bin/mailq
manpage_directory = /usr/share/man
mydestination = mail.domain.co.za, localhost.localdomain, localhost
mydomain = domain.co.za
myhostname = mail.domain.co.za
mynetworks = 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 192.168.0.0/24
mynetworks_style = subnet
myorigin = /etc/mailname
newaliases_path = /usr/bin/newaliasess
queue_directory = /var/spool/postfix
readme_directory = no
recipient_delimiter = +
relay_domains = $mydestination
relayhost = smtp:[mail.domain.co.za]:465
sample_directory = /etc/postfix
sendmail_path = /usr/sbin/sendmail
setgid_group = postdrop
smtp_bind_address = 192.168.x.X
smtp_sasl_mechanism_filter = !gssapi, !login, static:all
smtp_tls_security_level = encrypt
smtp_tls_wrappermode = yes
smtpd_banner = $myhostname ESMTP $mail_name (Ubuntu)
smtpd_helo_restrictions = reject_invalid_helo_hostname reject_non_fqdn_helo_host
smtpd_recipient_restrictions = permit_my_networks permit_sasl_authenticated reject_unauth_destination reject_sender_login_mismatch
smtpd_relay_restrictions = permit_mynetworks permit_sasl_authenticated reject_unauth_destination
smtpd_sasl_auth_enable = yes
smtpd_sasl_local_domain = $mydomain
smtpd_sasl_path = private/auth
smtpd_sasl_security_options = noanonymous
smtpd_sasl_tls_security_options = $smtpd_sasl_security_options
smtpd_timeout = 220s
smtpd_tls_auth_only = yes
smtpd_tls_cert_file = /etc/ssl/pem/certificate.pem
smtpd_tls_ciphers = medium
smtpd_tls_key_file = /etc/ssl/pem/key.pem
smtpd_tls_mandatory_ciphers = medium
smtpd_tls_mandatory_protocols = TLSv1 TLSv1.1 TLSv1.2
smtpd_tls_security_level = may
smtpd_use_tls = yes
transport_maps = hash:/etc/postfix/transport
unknown_local_recipient_reject_code = 450
virtual_alias_maps = mysql:/etc/postfix/mysql-virtual-alias-maps.cf
virtual_mailbox_domains = mysql:/etc/postfix/mysql-virtual-mailbox-domains.cf
virtual_mailbox_maps = mysql:/etc/postfix/mysql-virtual-mailbox-maps.cf
For Dovecot configuration, the output is:
root@1ag:~# dovecot -n
2.2.33.2 (d6601f4ec): /etc/dovecot/dovecot.conf
Pigeonhole version 0.4.21 (92477967) OS: Linux 4.15.0-39-generic x86_64 Ubuntu 18.04.1 LTS
auth_mechanisms = plain login
auth_verbose = yes
base_dir = /var/run/dovecot/
login_greeting = Dovecot ready.
mail_location = maildir:~/Maildir
passdb {
args = /etc/dovecot/passwd
driver = passwd-file
}
passdb {
driver = pam
}
service auth {
user = root
}
userdb {
driver = passwd
}
userdb {
args = uid=vmail gid=vmail home=/home/vmail/%u
driver = passwd-file
}
protocol imap {
imap_client_workarounds = tb-extra-mailbox-sep
}
You will notice that my mail.log is quite extensive:
Nov 29 12:08:31 domain postfix/postfix-script[2066]: starting the Postfix mail system
Nov 29 12:08:32 domain postfix/master[2070]: daemon started -- version 3.3.0, configuration /etc/postfix
Nov 29 12:08:33 domain postfix/qmgr[2072]: C92FD80215: from=<root@domain.co.za>, size=138408, nrcpt=1 (queue active)
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: connect to mysql server 127.0.0.1: Can't connect to MySQL server on '127.0.0.1' (111)
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:08:36 domain postfix/qmgr[2072]: B78398022A: from=<root@domain.co.za>, size=138303, nrcpt=1 (queue active)
Nov 29 12:08:42 domain amavis[1807]: logging initialized, log level 2, syslog: amavis.mail
Nov 29 12:08:42 domain amavis[1807]: sd_notify (no socket): STATUS=Config files have been read, modules loaded.
Nov 29 12:08:42 domain amavis[1807]: starting. /usr/sbin/amavisd-new at mail.domain.co.zam amavisd-new-2.11.0 (20160426), Unicode aware, LC_ALL="C", LANG="en_US.UTF-8"
Nov 29 12:08:42 domain amavis[1807]: perl=5.026001, user=, EUID: 134 (134); group=, EGID: 142 142 (142 142)
Nov 29 12:08:45 domain amavis[1807]: INFO: no optional modules: unicore::lib::Nt::De.pl Unix::Getrusage
Nov 29 12:08:45 domain amavis[1807]: SpamControl: scanner SpamAssassin, module Amavis::SpamControl::SpamAssassin
Nov 29 12:08:50 domain amavis[1807]: INFO: SA version: 3.4.2, 3.004002, no optional modules: Encode::Detect Image::Info Image::Info::GIF Image::Info::JPEG Image::Info::PNG Image::Info::BMP Image::Info::TIFF
Nov 29 12:08:50 domain amavis[1807]: SpamControl: init_pre_chroot on SpamAssassin done
Nov 29 12:08:50 domain amavis[1807]: socket module IO::Socket::IP, protocol families available: INET, INET6
Nov 29 12:08:50 domain amavis[1807]: will bind to /var/lib/amavis/amavisd.sock|unix, 127.0.0.1:10024/tcp, [::1]:10024/tcp
Nov 29 12:08:50 domain amavis[1807]: sd_notify (no socket): STATUS=Transferring control to Net::Server.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Process Backgrounded
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): MAINPID=2839nSTATUS=Daemonized, preparing to bind sockets.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: 2018/11/29-12:08:50 Amavis (type Net::Server::PreForkSimple) starting! pid(2839)
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to UNIX socket file "/var/lib/amavis/amavisd.sock"
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1 with IPv4
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to TCP port 10024 on host ::1 with IPv6
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): STATUS=Sockets bound, checking user and group.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Group Not Defined. Defaulting to EGID '142 142'
Nov 29 12:08:50 domain amavis[2839]: Net::Server: User Not Defined. Defaulting to EUID '134'
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): STATUS=The rest of pre-fork init, finding helper programs.
Nov 29 12:08:50 domain amavis[2839]: config files read: /usr/share/amavis/conf.d/10-debian_scripts, /usr/share/amavis/conf.d/20-package, /etc/amavis/conf.d/01-debian, /etc/amavis/conf.d/05-domain_id, /etc/amavis/conf.d/05-node_id, /etc/amavis/conf.d/15-av_scanners, /etc/amavis/conf.d/15-content_filter_mode, /etc/amavis/conf.d/20-debian_defaults, /etc/amavis/conf.d/21-ubuntu_defaults, /etc/amavis/conf.d/25-amavis_helpers, /etc/amavis/conf.d/30-template_localization, /etc/amavis/conf.d/40-policy_banks, /etc/amavis/conf.d/50-user
Nov 29 12:08:50 domain amavis[2839]: Module Amavis::Conf 2.412
Nov 29 12:08:50 domain amavis[2839]: Module Archive::Zip 1.60
Nov 29 12:08:50 domain amavis[2839]: Module BerkeleyDB 0.55
Nov 29 12:08:50 domain amavis[2839]: Module Compress::Raw::Zlib 2.074
Nov 29 12:08:50 domain amavis[2839]: Module Compress::Zlib 2.074
Nov 29 12:08:50 domain amavis[2839]: Module Crypt::OpenSSL::RSA 0.28
Nov 29 12:08:50 domain amavis[2839]: Module DB_File 1.84
Nov 29 12:08:50 domain amavis[2839]: Module Digest::MD5 2.55
Nov 29 12:08:50 domain amavis[2839]: Module Digest::SHA 5.96
Nov 29 12:08:50 domain amavis[2839]: Module Encode 2.88
Nov 29 12:08:50 domain amavis[2839]: Module File::Temp 0.2304
Nov 29 12:08:50 domain amavis[2839]: Module IO::Socket::INET6 2.72
Nov 29 12:08:50 domain amavis[2839]: Module IO::Socket::IP 0.38
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Entity 5.509
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Parser 5.509
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Tools 5.509
Nov 29 12:08:50 domain amavis[2839]: Module Mail::DKIM::Signer 0.44
Nov 29 12:08:50 domain amavis[2839]: Module Mail::DKIM::Verifier 0.44
Nov 29 12:08:50 domain amavis[2839]: Module Mail::Header 2.18
Nov 29 12:08:50 domain amavis[2839]: Module Mail::Internet 2.18
Nov 29 12:08:50 domain amavis[2839]: Module Mail::SPF v2.009
Nov 29 12:08:50 domain amavis[2839]: Module Mail::SpamAssassin 3.004002
Nov 29 12:08:50 domain amavis[2839]: Module Net::DNS 1.1
Nov 29 12:08:50 domain amavis[2839]: Module Net::LibIDN 0.12
Nov 29 12:08:50 domain amavis[2839]: Module Net::Patricia 1.22
Nov 29 12:08:50 domain amavis[2839]: Module Net::Server 2.009
Nov 29 12:08:50 domain amavis[2839]: Module NetAddr::IP 4.079
Nov 29 12:08:50 domain amavis[2839]: Module Razor2::Client::Version 2.84
Nov 29 12:08:50 domain amavis[2839]: Module Scalar::Util 1.4602
Nov 29 12:08:50 domain amavis[2839]: Module Socket 2.020_03
Nov 29 12:08:50 domain amavis[2839]: Module Socket6 0.27
Nov 29 12:08:50 domain amavis[2839]: Module Time::HiRes 1.9741
Nov 29 12:08:50 domain amavis[2839]: Module URI 1.73
Nov 29 12:08:50 domain amavis[2839]: Module Unix::Syslog 1.1
Nov 29 12:08:50 domain amavis[2839]: Amavis::ZMQ code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Amavis::DB code loaded
Nov 29 12:08:50 domain amavis[2839]: SQL base code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SQL::Log code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SQL::Quarantine NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Lookup::SQL code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Lookup::LDAP code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: AM.PDP-in proto code loaded
Nov 29 12:08:50 domain amavis[2839]: SMTP-in proto code loaded
Nov 29 12:08:50 domain amavis[2839]: Courier proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SMTP-out proto code loaded
Nov 29 12:08:50 domain amavis[2839]: Pipe-out proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: BSMTP-out proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Local-out proto code loaded
Nov 29 12:08:50 domain amavis[2839]: OS_Fingerprint code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-VIRUS code loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM code loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-EXT code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-C code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-SA code loaded
Nov 29 12:08:50 domain amavis[2839]: Unpackers code loaded
Nov 29 12:08:50 domain amavis[2839]: DKIM code loaded
Nov 29 12:08:50 domain amavis[2839]: Tools code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Found $file at /usr/bin/file
Nov 29 12:08:50 domain amavis[2839]: No $altermime, not using it
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .mail
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .Z at /bin/uncompress
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .gz at /bin/gzip -d
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .gz (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .bz2 at /bin/bzip2 -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .xz at /usr/bin/xz -dc
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzma at /usr/bin/xz -dc --format=lzma
Nov 29 12:08:50 domain amavis[2839]: No ext program for .lrz, tried: lrzip -q -k -d -o -, lrzcat -q -k
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzo at /usr/bin/lzop -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lz4 at /usr/bin/lz4c -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rpm at /usr/bin/rpm2cpio
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cpio at /bin/pax
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .tar at /bin/pax
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .deb at /usr/bin/ar
Nov 29 12:08:50 domain amavis[2839]: No ext program for .rar, tried: unrar-free
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arj at /usr/bin/arj
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arc at /usr/bin/nomarch
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .zoo at /usr/bin/zoo
Nov 29 12:08:50 domain amavis[2839]: No ext program for .doc, tried: ripole
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cab at /usr/bin/cabextract
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .tnef
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .zip at /usr/bin/7za
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .kmz at /usr/bin/7za
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .zip (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .kmz (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .7z at /usr/bin/7zr
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .gz at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .bz2 at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .Z at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .tar at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .xz at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzma at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .jar at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cpio at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arj at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rar at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .swf at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lha at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .iso at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cab at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .deb at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rpm at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .exe at /usr/bin/arj
Nov 29 12:08:50 domain amavis[2839]: No decoder for .F
Nov 29 12:08:50 domain amavis[2839]: No decoder for .doc
Nov 29 12:08:50 domain amavis[2839]: No decoder for .lrz
Nov 29 12:08:50 domain amavis[2839]: Using primary internal av scanner code for ClamAV-clamd
Nov 29 12:08:50 domain amavis[2839]: Found secondary av scanner ClamAV-clamscan at /usr/bin/clamscan
Nov 29 12:08:50 domain amavis[2839]: Deleting db files snmp.db,nanny.db,__db.001,__db.003,__db.002 in /var/lib/amavis/db
Nov 29 12:08:50 domain amavis[2839]: Creating db in /var/lib/amavis/db/; BerkeleyDB 0.55, libdb 5.3
Nov 29 12:09:02 domain postfix/qmgr[2072]: 6299D80227: from=<root@domain.co.za>, size=468, nrcpt=1 (queue active)
Nov 29 12:09:03 domain postfix/qmgr[2072]: A41FC8022B: from=<root@mail.domain.co.za>, size=139510, nrcpt=1 (queue active)
Nov 29 12:09:03 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:09:03 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:09:03 domain postfix/qmgr[2072]: A94108022F: from=<root@mail.domain.co.za>, size=139447, nrcpt=1 (queue active)
Nov 29 12:09:18 domain postfix/error[2894]: 6299D80227: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=386996, delays=386980/0.4/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2075]: C92FD80215: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=443497, delays=443452/29/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2898]: A94108022F: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=83293, delays=83278/0.14/0/15, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2895]: A41FC8022B: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=214145, delays=214130/0.39/0/15, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/qmgr[2072]: C92FD80215: from=<root@domain.co.za>, status=expired, returned to sender
Nov 29 12:09:19 domain amavis[2839]: initializing Mail::SpamAssassin (0)
Nov 29 12:09:19 domain amavis[2839]: SpamAssassin debug facilities: info
Nov 29 12:09:19 domain postfix/error[2891]: B78398022A: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=302494, delays=302451/27/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:20 domain postfix/cleanup[3218]: warning: /etc/postfix/body_checks: logical line must not start with whitespace: " /^<iframe src=(3D)?cid:.* hei..."
Nov 29 12:09:21 domain postfix/cleanup[3218]: 4636980226: message-id=<20181129100920.4636980226@mail.domain.co.za>
Nov 29 10:09:23 domain postfix/bounce[2893]: C92FD80215: sender non-delivery notification: 4636980226
Nov 29 12:09:23 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:09:23 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:09:23 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:09:23 domain postfix/qmgr[2072]: C92FD80215: removed
Nov 29 12:09:23 domain amavis[2839]: SA info: config: failed to parse line, skipping, in "/etc/spamassassin/local.cf": use_dcc 0
Nov 29 12:09:23 domain postfix/error[2894]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=none, delay=4.5, delays=4/0.04/0/0.52, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:24 domain amavis[2839]: SpamAssassin loaded plugins: AskDNS, AutoLearnThreshold, Bayes, BodyEval, Check, DKIM, DNSEval, FreeMail, HTMLEval, HTTPSMismatch, Hashcash, HeaderEval, ImageInfo, MIMEEval, MIMEHeader, Pyzor, Razor2, RelayEval, ReplaceTags, Rule2XSBody, SPF, SpamCop, URIDNSBL, URIDetail, URIEval, VBounce, WLBLEval, WhiteListSubject
Nov 29 12:09:24 domain amavis[2839]: SpamControl: init_pre_fork on SpamAssassin done
Nov 29 12:09:24 domain amavis[2839]: extra modules loaded after daemonizing/chrooting: /etc/perl/Net/libnet.cfg, /usr/lib/x86_64-linux-gnu/perl5/5.26/auto/Net/SSLeay/autosplit.ix, /usr/lib/x86_64-linux-gnu/perl5/5.26/auto/Net/SSLeay/randomize.al, IO/Socket/SSL.pm, IO/Socket/SSL/PublicSuffix.pm, Mail/SpamAssassin/Plugin/FreeMail.pm, Mail/SpamAssassin/Plugin/SpamCop.pm, Net/Cmd.pm, Net/Config.pm, Net/SMTP.pm, Net/SSLeay.pm
Nov 29 12:09:24 domain amavis[2839]: sd_notify (no socket): READY=1nSTATUS=Initialization done.
Nov 29 12:09:24 domain amavis[2839]: sd_notify (no socket): STATUS=Starting child process(es), ready for work.
Nov 29 12:18:36 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:19:37 domain postfix/qmgr[2072]: warning: problem talking to service rewrite: Connection timed out
Nov 29 12:20:38 domain postfix/qmgr[2072]: warning: problem talking to service rewrite: Connection timed out
Nov 29 12:20:52 domain postfix/trivial-rewrite[4984]: warning: write resolver reply: Broken pipe
Nov 29 12:21:32 domain postfix/trivial-rewrite[5008]: warning: write resolver reply: Broken pipe
Nov 29 12:21:46 domain postfix/smtps/smtpd[5113]: connect from domain.co.za[192.168.1.7]
Nov 29 12:21:47 domain postfix/smtps/smtpd[5113]: warning: SASL: Connect to private/auth failed: Connection refused
Nov 29 12:21:47 domain postfix/smtps/smtpd[5113]: fatal: no SASL authentication mechanisms
Nov 29 12:21:48 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtpd pid 5113 exit status 1
Nov 29 12:21:48 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtpd: bad command startup -- throttling
Nov 29 12:22:42 domain postfix/smtp[5111]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=192.168.1.7[192.168.1.7]:465, delay=749, delays=558/185/6.2/0, dsn=4.4.2, status=deferred (lost connection with 192.168.1.7[192.168.1.7] while receiving the initial server greeting)
Nov 29 12:38:35 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: connect from domain.co.za[192.168.1.7]
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: warning: SASL: Connect to private/auth failed: Connection refused
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: fatal: no SASL authentication mechanisms
Nov 29 12:38:39 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtpd pid 6873 exit status 1
Nov 29 12:38:39 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtpd: bad command startup -- throttling
Nov 29 12:38:39 domain postfix/smtp[6872]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=192.168.1.7[192.168.1.7]:465, delay=1760, delays=1756/2.4/1.6/0, dsn=4.4.2, status=deferred (lost connection with 192.168.1.7[192.168.1.7] while receiving the initial server greeting)
Nov 29 12:41:06 domain postfix/cleanup[7099]: warning: /etc/postfix/body_checks: logical line must not start with whitespace: " /^<iframe src=(3D)?cid:.* hei..."
Nov 29 12:41:07 domain postfix/pickup[2071]: DF53A80229: uid=0 from=<root>
Nov 29 12:41:07 domain postfix/cleanup[7099]: DF53A80229: message-id=<20181129104106.DF53A80229@mail.domain.co.za>
Nov 29 12:41:07 domain postfix/qmgr[2072]: DF53A80229: from=<root@mail.domain.co.za>, size=138893, nrcpt=1 (queue active)
Nov 29 12:41:07 domain postfix/smtp[7102]: fatal: valid hostname or network address required in server description: smtp:[mail.domain.co.za]:465
Nov 29 12:41:08 domain postfix/qmgr[2072]: warning: private/smtp socket: malformed response
Nov 29 12:41:08 domain postfix/qmgr[2072]: warning: transport smtp failure -- see a previous warning/fatal/panic logfile record for the problem description
Nov 29 12:41:08 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtp pid 7102 exit status 1
Nov 29 12:41:08 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtp: bad command startup -- throttling
Nov 29 12:41:08 domain postfix/error[7103]: DF53A80229: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=2.2, delays=1/1.1/0/0.05, dsn=4.3.0, status=deferred (unknown mail transport error)
So, there's a couple of issues here. Any help would be greatly appreciated.
postfix
add a comment |
up vote
0
down vote
favorite
My mail server can't send or receive emails. I've been trying for months without success. None of the Google searches have helped either. Please have a look see and try to help me get this resolved.
For Postfix configuration, the output is:
root@domain:~# postconf -n
alias_database = hash:/etc/aliases
alias_maps = hash:/etc/aliases
body_checks = regexp:/etc/postfix/body_checks
broken_sasl_auth_clients = yes
command_directory = /usr/sbin
compatibility_level = 2
content_filter = smtp-amavis:[127.0.0.1]:10024
daemon_directory = /usr/lib/postfix/sbin
data_directory = /var/lib/postfix
debug_peer_level = 2
debug_peer_list = 127.0.0.1
debugger_command = PATH=/bin:/usr/bin:/usr/local/bin:/usr/X11R6/bin ddd $daemon_directory/$process_name $process_id & sleep 5
default_destination_concurrency_limit = 20
fast_flush_domains = $relay_domains
header_checks = pcre:/etc/postfix/header_checks.pcre
home_mailbox = maildir/
html_directory = no
in_flow_delay = 1s
inet_interfaces = all
inet_protocols = all
local_recipient_maps = unix:passwd.byname $alias_maps
mail_owner = postfix
mail_spool_directory = /var/mail
mailbox_command = procmail -a "$EXTENSION"
mailbox_size_limit = 0
mailbox_transport = lmtp:unix:/var/run/dovecot/lmtp
mailq_path = /usr/bin/mailq
manpage_directory = /usr/share/man
mydestination = mail.domain.co.za, localhost.localdomain, localhost
mydomain = domain.co.za
myhostname = mail.domain.co.za
mynetworks = 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 192.168.0.0/24
mynetworks_style = subnet
myorigin = /etc/mailname
newaliases_path = /usr/bin/newaliasess
queue_directory = /var/spool/postfix
readme_directory = no
recipient_delimiter = +
relay_domains = $mydestination
relayhost = smtp:[mail.domain.co.za]:465
sample_directory = /etc/postfix
sendmail_path = /usr/sbin/sendmail
setgid_group = postdrop
smtp_bind_address = 192.168.x.X
smtp_sasl_mechanism_filter = !gssapi, !login, static:all
smtp_tls_security_level = encrypt
smtp_tls_wrappermode = yes
smtpd_banner = $myhostname ESMTP $mail_name (Ubuntu)
smtpd_helo_restrictions = reject_invalid_helo_hostname reject_non_fqdn_helo_host
smtpd_recipient_restrictions = permit_my_networks permit_sasl_authenticated reject_unauth_destination reject_sender_login_mismatch
smtpd_relay_restrictions = permit_mynetworks permit_sasl_authenticated reject_unauth_destination
smtpd_sasl_auth_enable = yes
smtpd_sasl_local_domain = $mydomain
smtpd_sasl_path = private/auth
smtpd_sasl_security_options = noanonymous
smtpd_sasl_tls_security_options = $smtpd_sasl_security_options
smtpd_timeout = 220s
smtpd_tls_auth_only = yes
smtpd_tls_cert_file = /etc/ssl/pem/certificate.pem
smtpd_tls_ciphers = medium
smtpd_tls_key_file = /etc/ssl/pem/key.pem
smtpd_tls_mandatory_ciphers = medium
smtpd_tls_mandatory_protocols = TLSv1 TLSv1.1 TLSv1.2
smtpd_tls_security_level = may
smtpd_use_tls = yes
transport_maps = hash:/etc/postfix/transport
unknown_local_recipient_reject_code = 450
virtual_alias_maps = mysql:/etc/postfix/mysql-virtual-alias-maps.cf
virtual_mailbox_domains = mysql:/etc/postfix/mysql-virtual-mailbox-domains.cf
virtual_mailbox_maps = mysql:/etc/postfix/mysql-virtual-mailbox-maps.cf
For Dovecot configuration, the output is:
root@1ag:~# dovecot -n
2.2.33.2 (d6601f4ec): /etc/dovecot/dovecot.conf
Pigeonhole version 0.4.21 (92477967) OS: Linux 4.15.0-39-generic x86_64 Ubuntu 18.04.1 LTS
auth_mechanisms = plain login
auth_verbose = yes
base_dir = /var/run/dovecot/
login_greeting = Dovecot ready.
mail_location = maildir:~/Maildir
passdb {
args = /etc/dovecot/passwd
driver = passwd-file
}
passdb {
driver = pam
}
service auth {
user = root
}
userdb {
driver = passwd
}
userdb {
args = uid=vmail gid=vmail home=/home/vmail/%u
driver = passwd-file
}
protocol imap {
imap_client_workarounds = tb-extra-mailbox-sep
}
You will notice that my mail.log is quite extensive:
Nov 29 12:08:31 domain postfix/postfix-script[2066]: starting the Postfix mail system
Nov 29 12:08:32 domain postfix/master[2070]: daemon started -- version 3.3.0, configuration /etc/postfix
Nov 29 12:08:33 domain postfix/qmgr[2072]: C92FD80215: from=<root@domain.co.za>, size=138408, nrcpt=1 (queue active)
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: connect to mysql server 127.0.0.1: Can't connect to MySQL server on '127.0.0.1' (111)
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:08:36 domain postfix/qmgr[2072]: B78398022A: from=<root@domain.co.za>, size=138303, nrcpt=1 (queue active)
Nov 29 12:08:42 domain amavis[1807]: logging initialized, log level 2, syslog: amavis.mail
Nov 29 12:08:42 domain amavis[1807]: sd_notify (no socket): STATUS=Config files have been read, modules loaded.
Nov 29 12:08:42 domain amavis[1807]: starting. /usr/sbin/amavisd-new at mail.domain.co.zam amavisd-new-2.11.0 (20160426), Unicode aware, LC_ALL="C", LANG="en_US.UTF-8"
Nov 29 12:08:42 domain amavis[1807]: perl=5.026001, user=, EUID: 134 (134); group=, EGID: 142 142 (142 142)
Nov 29 12:08:45 domain amavis[1807]: INFO: no optional modules: unicore::lib::Nt::De.pl Unix::Getrusage
Nov 29 12:08:45 domain amavis[1807]: SpamControl: scanner SpamAssassin, module Amavis::SpamControl::SpamAssassin
Nov 29 12:08:50 domain amavis[1807]: INFO: SA version: 3.4.2, 3.004002, no optional modules: Encode::Detect Image::Info Image::Info::GIF Image::Info::JPEG Image::Info::PNG Image::Info::BMP Image::Info::TIFF
Nov 29 12:08:50 domain amavis[1807]: SpamControl: init_pre_chroot on SpamAssassin done
Nov 29 12:08:50 domain amavis[1807]: socket module IO::Socket::IP, protocol families available: INET, INET6
Nov 29 12:08:50 domain amavis[1807]: will bind to /var/lib/amavis/amavisd.sock|unix, 127.0.0.1:10024/tcp, [::1]:10024/tcp
Nov 29 12:08:50 domain amavis[1807]: sd_notify (no socket): STATUS=Transferring control to Net::Server.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Process Backgrounded
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): MAINPID=2839nSTATUS=Daemonized, preparing to bind sockets.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: 2018/11/29-12:08:50 Amavis (type Net::Server::PreForkSimple) starting! pid(2839)
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to UNIX socket file "/var/lib/amavis/amavisd.sock"
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1 with IPv4
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to TCP port 10024 on host ::1 with IPv6
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): STATUS=Sockets bound, checking user and group.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Group Not Defined. Defaulting to EGID '142 142'
Nov 29 12:08:50 domain amavis[2839]: Net::Server: User Not Defined. Defaulting to EUID '134'
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): STATUS=The rest of pre-fork init, finding helper programs.
Nov 29 12:08:50 domain amavis[2839]: config files read: /usr/share/amavis/conf.d/10-debian_scripts, /usr/share/amavis/conf.d/20-package, /etc/amavis/conf.d/01-debian, /etc/amavis/conf.d/05-domain_id, /etc/amavis/conf.d/05-node_id, /etc/amavis/conf.d/15-av_scanners, /etc/amavis/conf.d/15-content_filter_mode, /etc/amavis/conf.d/20-debian_defaults, /etc/amavis/conf.d/21-ubuntu_defaults, /etc/amavis/conf.d/25-amavis_helpers, /etc/amavis/conf.d/30-template_localization, /etc/amavis/conf.d/40-policy_banks, /etc/amavis/conf.d/50-user
Nov 29 12:08:50 domain amavis[2839]: Module Amavis::Conf 2.412
Nov 29 12:08:50 domain amavis[2839]: Module Archive::Zip 1.60
Nov 29 12:08:50 domain amavis[2839]: Module BerkeleyDB 0.55
Nov 29 12:08:50 domain amavis[2839]: Module Compress::Raw::Zlib 2.074
Nov 29 12:08:50 domain amavis[2839]: Module Compress::Zlib 2.074
Nov 29 12:08:50 domain amavis[2839]: Module Crypt::OpenSSL::RSA 0.28
Nov 29 12:08:50 domain amavis[2839]: Module DB_File 1.84
Nov 29 12:08:50 domain amavis[2839]: Module Digest::MD5 2.55
Nov 29 12:08:50 domain amavis[2839]: Module Digest::SHA 5.96
Nov 29 12:08:50 domain amavis[2839]: Module Encode 2.88
Nov 29 12:08:50 domain amavis[2839]: Module File::Temp 0.2304
Nov 29 12:08:50 domain amavis[2839]: Module IO::Socket::INET6 2.72
Nov 29 12:08:50 domain amavis[2839]: Module IO::Socket::IP 0.38
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Entity 5.509
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Parser 5.509
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Tools 5.509
Nov 29 12:08:50 domain amavis[2839]: Module Mail::DKIM::Signer 0.44
Nov 29 12:08:50 domain amavis[2839]: Module Mail::DKIM::Verifier 0.44
Nov 29 12:08:50 domain amavis[2839]: Module Mail::Header 2.18
Nov 29 12:08:50 domain amavis[2839]: Module Mail::Internet 2.18
Nov 29 12:08:50 domain amavis[2839]: Module Mail::SPF v2.009
Nov 29 12:08:50 domain amavis[2839]: Module Mail::SpamAssassin 3.004002
Nov 29 12:08:50 domain amavis[2839]: Module Net::DNS 1.1
Nov 29 12:08:50 domain amavis[2839]: Module Net::LibIDN 0.12
Nov 29 12:08:50 domain amavis[2839]: Module Net::Patricia 1.22
Nov 29 12:08:50 domain amavis[2839]: Module Net::Server 2.009
Nov 29 12:08:50 domain amavis[2839]: Module NetAddr::IP 4.079
Nov 29 12:08:50 domain amavis[2839]: Module Razor2::Client::Version 2.84
Nov 29 12:08:50 domain amavis[2839]: Module Scalar::Util 1.4602
Nov 29 12:08:50 domain amavis[2839]: Module Socket 2.020_03
Nov 29 12:08:50 domain amavis[2839]: Module Socket6 0.27
Nov 29 12:08:50 domain amavis[2839]: Module Time::HiRes 1.9741
Nov 29 12:08:50 domain amavis[2839]: Module URI 1.73
Nov 29 12:08:50 domain amavis[2839]: Module Unix::Syslog 1.1
Nov 29 12:08:50 domain amavis[2839]: Amavis::ZMQ code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Amavis::DB code loaded
Nov 29 12:08:50 domain amavis[2839]: SQL base code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SQL::Log code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SQL::Quarantine NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Lookup::SQL code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Lookup::LDAP code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: AM.PDP-in proto code loaded
Nov 29 12:08:50 domain amavis[2839]: SMTP-in proto code loaded
Nov 29 12:08:50 domain amavis[2839]: Courier proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SMTP-out proto code loaded
Nov 29 12:08:50 domain amavis[2839]: Pipe-out proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: BSMTP-out proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Local-out proto code loaded
Nov 29 12:08:50 domain amavis[2839]: OS_Fingerprint code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-VIRUS code loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM code loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-EXT code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-C code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-SA code loaded
Nov 29 12:08:50 domain amavis[2839]: Unpackers code loaded
Nov 29 12:08:50 domain amavis[2839]: DKIM code loaded
Nov 29 12:08:50 domain amavis[2839]: Tools code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Found $file at /usr/bin/file
Nov 29 12:08:50 domain amavis[2839]: No $altermime, not using it
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .mail
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .Z at /bin/uncompress
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .gz at /bin/gzip -d
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .gz (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .bz2 at /bin/bzip2 -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .xz at /usr/bin/xz -dc
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzma at /usr/bin/xz -dc --format=lzma
Nov 29 12:08:50 domain amavis[2839]: No ext program for .lrz, tried: lrzip -q -k -d -o -, lrzcat -q -k
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzo at /usr/bin/lzop -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lz4 at /usr/bin/lz4c -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rpm at /usr/bin/rpm2cpio
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cpio at /bin/pax
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .tar at /bin/pax
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .deb at /usr/bin/ar
Nov 29 12:08:50 domain amavis[2839]: No ext program for .rar, tried: unrar-free
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arj at /usr/bin/arj
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arc at /usr/bin/nomarch
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .zoo at /usr/bin/zoo
Nov 29 12:08:50 domain amavis[2839]: No ext program for .doc, tried: ripole
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cab at /usr/bin/cabextract
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .tnef
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .zip at /usr/bin/7za
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .kmz at /usr/bin/7za
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .zip (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .kmz (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .7z at /usr/bin/7zr
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .gz at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .bz2 at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .Z at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .tar at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .xz at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzma at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .jar at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cpio at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arj at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rar at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .swf at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lha at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .iso at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cab at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .deb at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rpm at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .exe at /usr/bin/arj
Nov 29 12:08:50 domain amavis[2839]: No decoder for .F
Nov 29 12:08:50 domain amavis[2839]: No decoder for .doc
Nov 29 12:08:50 domain amavis[2839]: No decoder for .lrz
Nov 29 12:08:50 domain amavis[2839]: Using primary internal av scanner code for ClamAV-clamd
Nov 29 12:08:50 domain amavis[2839]: Found secondary av scanner ClamAV-clamscan at /usr/bin/clamscan
Nov 29 12:08:50 domain amavis[2839]: Deleting db files snmp.db,nanny.db,__db.001,__db.003,__db.002 in /var/lib/amavis/db
Nov 29 12:08:50 domain amavis[2839]: Creating db in /var/lib/amavis/db/; BerkeleyDB 0.55, libdb 5.3
Nov 29 12:09:02 domain postfix/qmgr[2072]: 6299D80227: from=<root@domain.co.za>, size=468, nrcpt=1 (queue active)
Nov 29 12:09:03 domain postfix/qmgr[2072]: A41FC8022B: from=<root@mail.domain.co.za>, size=139510, nrcpt=1 (queue active)
Nov 29 12:09:03 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:09:03 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:09:03 domain postfix/qmgr[2072]: A94108022F: from=<root@mail.domain.co.za>, size=139447, nrcpt=1 (queue active)
Nov 29 12:09:18 domain postfix/error[2894]: 6299D80227: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=386996, delays=386980/0.4/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2075]: C92FD80215: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=443497, delays=443452/29/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2898]: A94108022F: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=83293, delays=83278/0.14/0/15, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2895]: A41FC8022B: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=214145, delays=214130/0.39/0/15, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/qmgr[2072]: C92FD80215: from=<root@domain.co.za>, status=expired, returned to sender
Nov 29 12:09:19 domain amavis[2839]: initializing Mail::SpamAssassin (0)
Nov 29 12:09:19 domain amavis[2839]: SpamAssassin debug facilities: info
Nov 29 12:09:19 domain postfix/error[2891]: B78398022A: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=302494, delays=302451/27/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:20 domain postfix/cleanup[3218]: warning: /etc/postfix/body_checks: logical line must not start with whitespace: " /^<iframe src=(3D)?cid:.* hei..."
Nov 29 12:09:21 domain postfix/cleanup[3218]: 4636980226: message-id=<20181129100920.4636980226@mail.domain.co.za>
Nov 29 10:09:23 domain postfix/bounce[2893]: C92FD80215: sender non-delivery notification: 4636980226
Nov 29 12:09:23 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:09:23 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:09:23 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:09:23 domain postfix/qmgr[2072]: C92FD80215: removed
Nov 29 12:09:23 domain amavis[2839]: SA info: config: failed to parse line, skipping, in "/etc/spamassassin/local.cf": use_dcc 0
Nov 29 12:09:23 domain postfix/error[2894]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=none, delay=4.5, delays=4/0.04/0/0.52, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:24 domain amavis[2839]: SpamAssassin loaded plugins: AskDNS, AutoLearnThreshold, Bayes, BodyEval, Check, DKIM, DNSEval, FreeMail, HTMLEval, HTTPSMismatch, Hashcash, HeaderEval, ImageInfo, MIMEEval, MIMEHeader, Pyzor, Razor2, RelayEval, ReplaceTags, Rule2XSBody, SPF, SpamCop, URIDNSBL, URIDetail, URIEval, VBounce, WLBLEval, WhiteListSubject
Nov 29 12:09:24 domain amavis[2839]: SpamControl: init_pre_fork on SpamAssassin done
Nov 29 12:09:24 domain amavis[2839]: extra modules loaded after daemonizing/chrooting: /etc/perl/Net/libnet.cfg, /usr/lib/x86_64-linux-gnu/perl5/5.26/auto/Net/SSLeay/autosplit.ix, /usr/lib/x86_64-linux-gnu/perl5/5.26/auto/Net/SSLeay/randomize.al, IO/Socket/SSL.pm, IO/Socket/SSL/PublicSuffix.pm, Mail/SpamAssassin/Plugin/FreeMail.pm, Mail/SpamAssassin/Plugin/SpamCop.pm, Net/Cmd.pm, Net/Config.pm, Net/SMTP.pm, Net/SSLeay.pm
Nov 29 12:09:24 domain amavis[2839]: sd_notify (no socket): READY=1nSTATUS=Initialization done.
Nov 29 12:09:24 domain amavis[2839]: sd_notify (no socket): STATUS=Starting child process(es), ready for work.
Nov 29 12:18:36 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:19:37 domain postfix/qmgr[2072]: warning: problem talking to service rewrite: Connection timed out
Nov 29 12:20:38 domain postfix/qmgr[2072]: warning: problem talking to service rewrite: Connection timed out
Nov 29 12:20:52 domain postfix/trivial-rewrite[4984]: warning: write resolver reply: Broken pipe
Nov 29 12:21:32 domain postfix/trivial-rewrite[5008]: warning: write resolver reply: Broken pipe
Nov 29 12:21:46 domain postfix/smtps/smtpd[5113]: connect from domain.co.za[192.168.1.7]
Nov 29 12:21:47 domain postfix/smtps/smtpd[5113]: warning: SASL: Connect to private/auth failed: Connection refused
Nov 29 12:21:47 domain postfix/smtps/smtpd[5113]: fatal: no SASL authentication mechanisms
Nov 29 12:21:48 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtpd pid 5113 exit status 1
Nov 29 12:21:48 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtpd: bad command startup -- throttling
Nov 29 12:22:42 domain postfix/smtp[5111]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=192.168.1.7[192.168.1.7]:465, delay=749, delays=558/185/6.2/0, dsn=4.4.2, status=deferred (lost connection with 192.168.1.7[192.168.1.7] while receiving the initial server greeting)
Nov 29 12:38:35 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: connect from domain.co.za[192.168.1.7]
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: warning: SASL: Connect to private/auth failed: Connection refused
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: fatal: no SASL authentication mechanisms
Nov 29 12:38:39 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtpd pid 6873 exit status 1
Nov 29 12:38:39 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtpd: bad command startup -- throttling
Nov 29 12:38:39 domain postfix/smtp[6872]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=192.168.1.7[192.168.1.7]:465, delay=1760, delays=1756/2.4/1.6/0, dsn=4.4.2, status=deferred (lost connection with 192.168.1.7[192.168.1.7] while receiving the initial server greeting)
Nov 29 12:41:06 domain postfix/cleanup[7099]: warning: /etc/postfix/body_checks: logical line must not start with whitespace: " /^<iframe src=(3D)?cid:.* hei..."
Nov 29 12:41:07 domain postfix/pickup[2071]: DF53A80229: uid=0 from=<root>
Nov 29 12:41:07 domain postfix/cleanup[7099]: DF53A80229: message-id=<20181129104106.DF53A80229@mail.domain.co.za>
Nov 29 12:41:07 domain postfix/qmgr[2072]: DF53A80229: from=<root@mail.domain.co.za>, size=138893, nrcpt=1 (queue active)
Nov 29 12:41:07 domain postfix/smtp[7102]: fatal: valid hostname or network address required in server description: smtp:[mail.domain.co.za]:465
Nov 29 12:41:08 domain postfix/qmgr[2072]: warning: private/smtp socket: malformed response
Nov 29 12:41:08 domain postfix/qmgr[2072]: warning: transport smtp failure -- see a previous warning/fatal/panic logfile record for the problem description
Nov 29 12:41:08 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtp pid 7102 exit status 1
Nov 29 12:41:08 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtp: bad command startup -- throttling
Nov 29 12:41:08 domain postfix/error[7103]: DF53A80229: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=2.2, delays=1/1.1/0/0.05, dsn=4.3.0, status=deferred (unknown mail transport error)
So, there's a couple of issues here. Any help would be greatly appreciated.
postfix
add a comment |
up vote
0
down vote
favorite
up vote
0
down vote
favorite
My mail server can't send or receive emails. I've been trying for months without success. None of the Google searches have helped either. Please have a look see and try to help me get this resolved.
For Postfix configuration, the output is:
root@domain:~# postconf -n
alias_database = hash:/etc/aliases
alias_maps = hash:/etc/aliases
body_checks = regexp:/etc/postfix/body_checks
broken_sasl_auth_clients = yes
command_directory = /usr/sbin
compatibility_level = 2
content_filter = smtp-amavis:[127.0.0.1]:10024
daemon_directory = /usr/lib/postfix/sbin
data_directory = /var/lib/postfix
debug_peer_level = 2
debug_peer_list = 127.0.0.1
debugger_command = PATH=/bin:/usr/bin:/usr/local/bin:/usr/X11R6/bin ddd $daemon_directory/$process_name $process_id & sleep 5
default_destination_concurrency_limit = 20
fast_flush_domains = $relay_domains
header_checks = pcre:/etc/postfix/header_checks.pcre
home_mailbox = maildir/
html_directory = no
in_flow_delay = 1s
inet_interfaces = all
inet_protocols = all
local_recipient_maps = unix:passwd.byname $alias_maps
mail_owner = postfix
mail_spool_directory = /var/mail
mailbox_command = procmail -a "$EXTENSION"
mailbox_size_limit = 0
mailbox_transport = lmtp:unix:/var/run/dovecot/lmtp
mailq_path = /usr/bin/mailq
manpage_directory = /usr/share/man
mydestination = mail.domain.co.za, localhost.localdomain, localhost
mydomain = domain.co.za
myhostname = mail.domain.co.za
mynetworks = 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 192.168.0.0/24
mynetworks_style = subnet
myorigin = /etc/mailname
newaliases_path = /usr/bin/newaliasess
queue_directory = /var/spool/postfix
readme_directory = no
recipient_delimiter = +
relay_domains = $mydestination
relayhost = smtp:[mail.domain.co.za]:465
sample_directory = /etc/postfix
sendmail_path = /usr/sbin/sendmail
setgid_group = postdrop
smtp_bind_address = 192.168.x.X
smtp_sasl_mechanism_filter = !gssapi, !login, static:all
smtp_tls_security_level = encrypt
smtp_tls_wrappermode = yes
smtpd_banner = $myhostname ESMTP $mail_name (Ubuntu)
smtpd_helo_restrictions = reject_invalid_helo_hostname reject_non_fqdn_helo_host
smtpd_recipient_restrictions = permit_my_networks permit_sasl_authenticated reject_unauth_destination reject_sender_login_mismatch
smtpd_relay_restrictions = permit_mynetworks permit_sasl_authenticated reject_unauth_destination
smtpd_sasl_auth_enable = yes
smtpd_sasl_local_domain = $mydomain
smtpd_sasl_path = private/auth
smtpd_sasl_security_options = noanonymous
smtpd_sasl_tls_security_options = $smtpd_sasl_security_options
smtpd_timeout = 220s
smtpd_tls_auth_only = yes
smtpd_tls_cert_file = /etc/ssl/pem/certificate.pem
smtpd_tls_ciphers = medium
smtpd_tls_key_file = /etc/ssl/pem/key.pem
smtpd_tls_mandatory_ciphers = medium
smtpd_tls_mandatory_protocols = TLSv1 TLSv1.1 TLSv1.2
smtpd_tls_security_level = may
smtpd_use_tls = yes
transport_maps = hash:/etc/postfix/transport
unknown_local_recipient_reject_code = 450
virtual_alias_maps = mysql:/etc/postfix/mysql-virtual-alias-maps.cf
virtual_mailbox_domains = mysql:/etc/postfix/mysql-virtual-mailbox-domains.cf
virtual_mailbox_maps = mysql:/etc/postfix/mysql-virtual-mailbox-maps.cf
For Dovecot configuration, the output is:
root@1ag:~# dovecot -n
2.2.33.2 (d6601f4ec): /etc/dovecot/dovecot.conf
Pigeonhole version 0.4.21 (92477967) OS: Linux 4.15.0-39-generic x86_64 Ubuntu 18.04.1 LTS
auth_mechanisms = plain login
auth_verbose = yes
base_dir = /var/run/dovecot/
login_greeting = Dovecot ready.
mail_location = maildir:~/Maildir
passdb {
args = /etc/dovecot/passwd
driver = passwd-file
}
passdb {
driver = pam
}
service auth {
user = root
}
userdb {
driver = passwd
}
userdb {
args = uid=vmail gid=vmail home=/home/vmail/%u
driver = passwd-file
}
protocol imap {
imap_client_workarounds = tb-extra-mailbox-sep
}
You will notice that my mail.log is quite extensive:
Nov 29 12:08:31 domain postfix/postfix-script[2066]: starting the Postfix mail system
Nov 29 12:08:32 domain postfix/master[2070]: daemon started -- version 3.3.0, configuration /etc/postfix
Nov 29 12:08:33 domain postfix/qmgr[2072]: C92FD80215: from=<root@domain.co.za>, size=138408, nrcpt=1 (queue active)
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: connect to mysql server 127.0.0.1: Can't connect to MySQL server on '127.0.0.1' (111)
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:08:36 domain postfix/qmgr[2072]: B78398022A: from=<root@domain.co.za>, size=138303, nrcpt=1 (queue active)
Nov 29 12:08:42 domain amavis[1807]: logging initialized, log level 2, syslog: amavis.mail
Nov 29 12:08:42 domain amavis[1807]: sd_notify (no socket): STATUS=Config files have been read, modules loaded.
Nov 29 12:08:42 domain amavis[1807]: starting. /usr/sbin/amavisd-new at mail.domain.co.zam amavisd-new-2.11.0 (20160426), Unicode aware, LC_ALL="C", LANG="en_US.UTF-8"
Nov 29 12:08:42 domain amavis[1807]: perl=5.026001, user=, EUID: 134 (134); group=, EGID: 142 142 (142 142)
Nov 29 12:08:45 domain amavis[1807]: INFO: no optional modules: unicore::lib::Nt::De.pl Unix::Getrusage
Nov 29 12:08:45 domain amavis[1807]: SpamControl: scanner SpamAssassin, module Amavis::SpamControl::SpamAssassin
Nov 29 12:08:50 domain amavis[1807]: INFO: SA version: 3.4.2, 3.004002, no optional modules: Encode::Detect Image::Info Image::Info::GIF Image::Info::JPEG Image::Info::PNG Image::Info::BMP Image::Info::TIFF
Nov 29 12:08:50 domain amavis[1807]: SpamControl: init_pre_chroot on SpamAssassin done
Nov 29 12:08:50 domain amavis[1807]: socket module IO::Socket::IP, protocol families available: INET, INET6
Nov 29 12:08:50 domain amavis[1807]: will bind to /var/lib/amavis/amavisd.sock|unix, 127.0.0.1:10024/tcp, [::1]:10024/tcp
Nov 29 12:08:50 domain amavis[1807]: sd_notify (no socket): STATUS=Transferring control to Net::Server.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Process Backgrounded
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): MAINPID=2839nSTATUS=Daemonized, preparing to bind sockets.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: 2018/11/29-12:08:50 Amavis (type Net::Server::PreForkSimple) starting! pid(2839)
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to UNIX socket file "/var/lib/amavis/amavisd.sock"
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1 with IPv4
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to TCP port 10024 on host ::1 with IPv6
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): STATUS=Sockets bound, checking user and group.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Group Not Defined. Defaulting to EGID '142 142'
Nov 29 12:08:50 domain amavis[2839]: Net::Server: User Not Defined. Defaulting to EUID '134'
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): STATUS=The rest of pre-fork init, finding helper programs.
Nov 29 12:08:50 domain amavis[2839]: config files read: /usr/share/amavis/conf.d/10-debian_scripts, /usr/share/amavis/conf.d/20-package, /etc/amavis/conf.d/01-debian, /etc/amavis/conf.d/05-domain_id, /etc/amavis/conf.d/05-node_id, /etc/amavis/conf.d/15-av_scanners, /etc/amavis/conf.d/15-content_filter_mode, /etc/amavis/conf.d/20-debian_defaults, /etc/amavis/conf.d/21-ubuntu_defaults, /etc/amavis/conf.d/25-amavis_helpers, /etc/amavis/conf.d/30-template_localization, /etc/amavis/conf.d/40-policy_banks, /etc/amavis/conf.d/50-user
Nov 29 12:08:50 domain amavis[2839]: Module Amavis::Conf 2.412
Nov 29 12:08:50 domain amavis[2839]: Module Archive::Zip 1.60
Nov 29 12:08:50 domain amavis[2839]: Module BerkeleyDB 0.55
Nov 29 12:08:50 domain amavis[2839]: Module Compress::Raw::Zlib 2.074
Nov 29 12:08:50 domain amavis[2839]: Module Compress::Zlib 2.074
Nov 29 12:08:50 domain amavis[2839]: Module Crypt::OpenSSL::RSA 0.28
Nov 29 12:08:50 domain amavis[2839]: Module DB_File 1.84
Nov 29 12:08:50 domain amavis[2839]: Module Digest::MD5 2.55
Nov 29 12:08:50 domain amavis[2839]: Module Digest::SHA 5.96
Nov 29 12:08:50 domain amavis[2839]: Module Encode 2.88
Nov 29 12:08:50 domain amavis[2839]: Module File::Temp 0.2304
Nov 29 12:08:50 domain amavis[2839]: Module IO::Socket::INET6 2.72
Nov 29 12:08:50 domain amavis[2839]: Module IO::Socket::IP 0.38
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Entity 5.509
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Parser 5.509
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Tools 5.509
Nov 29 12:08:50 domain amavis[2839]: Module Mail::DKIM::Signer 0.44
Nov 29 12:08:50 domain amavis[2839]: Module Mail::DKIM::Verifier 0.44
Nov 29 12:08:50 domain amavis[2839]: Module Mail::Header 2.18
Nov 29 12:08:50 domain amavis[2839]: Module Mail::Internet 2.18
Nov 29 12:08:50 domain amavis[2839]: Module Mail::SPF v2.009
Nov 29 12:08:50 domain amavis[2839]: Module Mail::SpamAssassin 3.004002
Nov 29 12:08:50 domain amavis[2839]: Module Net::DNS 1.1
Nov 29 12:08:50 domain amavis[2839]: Module Net::LibIDN 0.12
Nov 29 12:08:50 domain amavis[2839]: Module Net::Patricia 1.22
Nov 29 12:08:50 domain amavis[2839]: Module Net::Server 2.009
Nov 29 12:08:50 domain amavis[2839]: Module NetAddr::IP 4.079
Nov 29 12:08:50 domain amavis[2839]: Module Razor2::Client::Version 2.84
Nov 29 12:08:50 domain amavis[2839]: Module Scalar::Util 1.4602
Nov 29 12:08:50 domain amavis[2839]: Module Socket 2.020_03
Nov 29 12:08:50 domain amavis[2839]: Module Socket6 0.27
Nov 29 12:08:50 domain amavis[2839]: Module Time::HiRes 1.9741
Nov 29 12:08:50 domain amavis[2839]: Module URI 1.73
Nov 29 12:08:50 domain amavis[2839]: Module Unix::Syslog 1.1
Nov 29 12:08:50 domain amavis[2839]: Amavis::ZMQ code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Amavis::DB code loaded
Nov 29 12:08:50 domain amavis[2839]: SQL base code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SQL::Log code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SQL::Quarantine NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Lookup::SQL code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Lookup::LDAP code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: AM.PDP-in proto code loaded
Nov 29 12:08:50 domain amavis[2839]: SMTP-in proto code loaded
Nov 29 12:08:50 domain amavis[2839]: Courier proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SMTP-out proto code loaded
Nov 29 12:08:50 domain amavis[2839]: Pipe-out proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: BSMTP-out proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Local-out proto code loaded
Nov 29 12:08:50 domain amavis[2839]: OS_Fingerprint code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-VIRUS code loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM code loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-EXT code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-C code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-SA code loaded
Nov 29 12:08:50 domain amavis[2839]: Unpackers code loaded
Nov 29 12:08:50 domain amavis[2839]: DKIM code loaded
Nov 29 12:08:50 domain amavis[2839]: Tools code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Found $file at /usr/bin/file
Nov 29 12:08:50 domain amavis[2839]: No $altermime, not using it
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .mail
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .Z at /bin/uncompress
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .gz at /bin/gzip -d
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .gz (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .bz2 at /bin/bzip2 -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .xz at /usr/bin/xz -dc
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzma at /usr/bin/xz -dc --format=lzma
Nov 29 12:08:50 domain amavis[2839]: No ext program for .lrz, tried: lrzip -q -k -d -o -, lrzcat -q -k
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzo at /usr/bin/lzop -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lz4 at /usr/bin/lz4c -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rpm at /usr/bin/rpm2cpio
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cpio at /bin/pax
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .tar at /bin/pax
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .deb at /usr/bin/ar
Nov 29 12:08:50 domain amavis[2839]: No ext program for .rar, tried: unrar-free
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arj at /usr/bin/arj
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arc at /usr/bin/nomarch
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .zoo at /usr/bin/zoo
Nov 29 12:08:50 domain amavis[2839]: No ext program for .doc, tried: ripole
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cab at /usr/bin/cabextract
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .tnef
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .zip at /usr/bin/7za
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .kmz at /usr/bin/7za
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .zip (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .kmz (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .7z at /usr/bin/7zr
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .gz at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .bz2 at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .Z at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .tar at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .xz at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzma at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .jar at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cpio at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arj at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rar at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .swf at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lha at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .iso at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cab at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .deb at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rpm at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .exe at /usr/bin/arj
Nov 29 12:08:50 domain amavis[2839]: No decoder for .F
Nov 29 12:08:50 domain amavis[2839]: No decoder for .doc
Nov 29 12:08:50 domain amavis[2839]: No decoder for .lrz
Nov 29 12:08:50 domain amavis[2839]: Using primary internal av scanner code for ClamAV-clamd
Nov 29 12:08:50 domain amavis[2839]: Found secondary av scanner ClamAV-clamscan at /usr/bin/clamscan
Nov 29 12:08:50 domain amavis[2839]: Deleting db files snmp.db,nanny.db,__db.001,__db.003,__db.002 in /var/lib/amavis/db
Nov 29 12:08:50 domain amavis[2839]: Creating db in /var/lib/amavis/db/; BerkeleyDB 0.55, libdb 5.3
Nov 29 12:09:02 domain postfix/qmgr[2072]: 6299D80227: from=<root@domain.co.za>, size=468, nrcpt=1 (queue active)
Nov 29 12:09:03 domain postfix/qmgr[2072]: A41FC8022B: from=<root@mail.domain.co.za>, size=139510, nrcpt=1 (queue active)
Nov 29 12:09:03 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:09:03 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:09:03 domain postfix/qmgr[2072]: A94108022F: from=<root@mail.domain.co.za>, size=139447, nrcpt=1 (queue active)
Nov 29 12:09:18 domain postfix/error[2894]: 6299D80227: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=386996, delays=386980/0.4/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2075]: C92FD80215: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=443497, delays=443452/29/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2898]: A94108022F: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=83293, delays=83278/0.14/0/15, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2895]: A41FC8022B: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=214145, delays=214130/0.39/0/15, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/qmgr[2072]: C92FD80215: from=<root@domain.co.za>, status=expired, returned to sender
Nov 29 12:09:19 domain amavis[2839]: initializing Mail::SpamAssassin (0)
Nov 29 12:09:19 domain amavis[2839]: SpamAssassin debug facilities: info
Nov 29 12:09:19 domain postfix/error[2891]: B78398022A: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=302494, delays=302451/27/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:20 domain postfix/cleanup[3218]: warning: /etc/postfix/body_checks: logical line must not start with whitespace: " /^<iframe src=(3D)?cid:.* hei..."
Nov 29 12:09:21 domain postfix/cleanup[3218]: 4636980226: message-id=<20181129100920.4636980226@mail.domain.co.za>
Nov 29 10:09:23 domain postfix/bounce[2893]: C92FD80215: sender non-delivery notification: 4636980226
Nov 29 12:09:23 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:09:23 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:09:23 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:09:23 domain postfix/qmgr[2072]: C92FD80215: removed
Nov 29 12:09:23 domain amavis[2839]: SA info: config: failed to parse line, skipping, in "/etc/spamassassin/local.cf": use_dcc 0
Nov 29 12:09:23 domain postfix/error[2894]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=none, delay=4.5, delays=4/0.04/0/0.52, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:24 domain amavis[2839]: SpamAssassin loaded plugins: AskDNS, AutoLearnThreshold, Bayes, BodyEval, Check, DKIM, DNSEval, FreeMail, HTMLEval, HTTPSMismatch, Hashcash, HeaderEval, ImageInfo, MIMEEval, MIMEHeader, Pyzor, Razor2, RelayEval, ReplaceTags, Rule2XSBody, SPF, SpamCop, URIDNSBL, URIDetail, URIEval, VBounce, WLBLEval, WhiteListSubject
Nov 29 12:09:24 domain amavis[2839]: SpamControl: init_pre_fork on SpamAssassin done
Nov 29 12:09:24 domain amavis[2839]: extra modules loaded after daemonizing/chrooting: /etc/perl/Net/libnet.cfg, /usr/lib/x86_64-linux-gnu/perl5/5.26/auto/Net/SSLeay/autosplit.ix, /usr/lib/x86_64-linux-gnu/perl5/5.26/auto/Net/SSLeay/randomize.al, IO/Socket/SSL.pm, IO/Socket/SSL/PublicSuffix.pm, Mail/SpamAssassin/Plugin/FreeMail.pm, Mail/SpamAssassin/Plugin/SpamCop.pm, Net/Cmd.pm, Net/Config.pm, Net/SMTP.pm, Net/SSLeay.pm
Nov 29 12:09:24 domain amavis[2839]: sd_notify (no socket): READY=1nSTATUS=Initialization done.
Nov 29 12:09:24 domain amavis[2839]: sd_notify (no socket): STATUS=Starting child process(es), ready for work.
Nov 29 12:18:36 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:19:37 domain postfix/qmgr[2072]: warning: problem talking to service rewrite: Connection timed out
Nov 29 12:20:38 domain postfix/qmgr[2072]: warning: problem talking to service rewrite: Connection timed out
Nov 29 12:20:52 domain postfix/trivial-rewrite[4984]: warning: write resolver reply: Broken pipe
Nov 29 12:21:32 domain postfix/trivial-rewrite[5008]: warning: write resolver reply: Broken pipe
Nov 29 12:21:46 domain postfix/smtps/smtpd[5113]: connect from domain.co.za[192.168.1.7]
Nov 29 12:21:47 domain postfix/smtps/smtpd[5113]: warning: SASL: Connect to private/auth failed: Connection refused
Nov 29 12:21:47 domain postfix/smtps/smtpd[5113]: fatal: no SASL authentication mechanisms
Nov 29 12:21:48 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtpd pid 5113 exit status 1
Nov 29 12:21:48 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtpd: bad command startup -- throttling
Nov 29 12:22:42 domain postfix/smtp[5111]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=192.168.1.7[192.168.1.7]:465, delay=749, delays=558/185/6.2/0, dsn=4.4.2, status=deferred (lost connection with 192.168.1.7[192.168.1.7] while receiving the initial server greeting)
Nov 29 12:38:35 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: connect from domain.co.za[192.168.1.7]
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: warning: SASL: Connect to private/auth failed: Connection refused
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: fatal: no SASL authentication mechanisms
Nov 29 12:38:39 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtpd pid 6873 exit status 1
Nov 29 12:38:39 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtpd: bad command startup -- throttling
Nov 29 12:38:39 domain postfix/smtp[6872]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=192.168.1.7[192.168.1.7]:465, delay=1760, delays=1756/2.4/1.6/0, dsn=4.4.2, status=deferred (lost connection with 192.168.1.7[192.168.1.7] while receiving the initial server greeting)
Nov 29 12:41:06 domain postfix/cleanup[7099]: warning: /etc/postfix/body_checks: logical line must not start with whitespace: " /^<iframe src=(3D)?cid:.* hei..."
Nov 29 12:41:07 domain postfix/pickup[2071]: DF53A80229: uid=0 from=<root>
Nov 29 12:41:07 domain postfix/cleanup[7099]: DF53A80229: message-id=<20181129104106.DF53A80229@mail.domain.co.za>
Nov 29 12:41:07 domain postfix/qmgr[2072]: DF53A80229: from=<root@mail.domain.co.za>, size=138893, nrcpt=1 (queue active)
Nov 29 12:41:07 domain postfix/smtp[7102]: fatal: valid hostname or network address required in server description: smtp:[mail.domain.co.za]:465
Nov 29 12:41:08 domain postfix/qmgr[2072]: warning: private/smtp socket: malformed response
Nov 29 12:41:08 domain postfix/qmgr[2072]: warning: transport smtp failure -- see a previous warning/fatal/panic logfile record for the problem description
Nov 29 12:41:08 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtp pid 7102 exit status 1
Nov 29 12:41:08 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtp: bad command startup -- throttling
Nov 29 12:41:08 domain postfix/error[7103]: DF53A80229: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=2.2, delays=1/1.1/0/0.05, dsn=4.3.0, status=deferred (unknown mail transport error)
So, there's a couple of issues here. Any help would be greatly appreciated.
postfix
My mail server can't send or receive emails. I've been trying for months without success. None of the Google searches have helped either. Please have a look see and try to help me get this resolved.
For Postfix configuration, the output is:
root@domain:~# postconf -n
alias_database = hash:/etc/aliases
alias_maps = hash:/etc/aliases
body_checks = regexp:/etc/postfix/body_checks
broken_sasl_auth_clients = yes
command_directory = /usr/sbin
compatibility_level = 2
content_filter = smtp-amavis:[127.0.0.1]:10024
daemon_directory = /usr/lib/postfix/sbin
data_directory = /var/lib/postfix
debug_peer_level = 2
debug_peer_list = 127.0.0.1
debugger_command = PATH=/bin:/usr/bin:/usr/local/bin:/usr/X11R6/bin ddd $daemon_directory/$process_name $process_id & sleep 5
default_destination_concurrency_limit = 20
fast_flush_domains = $relay_domains
header_checks = pcre:/etc/postfix/header_checks.pcre
home_mailbox = maildir/
html_directory = no
in_flow_delay = 1s
inet_interfaces = all
inet_protocols = all
local_recipient_maps = unix:passwd.byname $alias_maps
mail_owner = postfix
mail_spool_directory = /var/mail
mailbox_command = procmail -a "$EXTENSION"
mailbox_size_limit = 0
mailbox_transport = lmtp:unix:/var/run/dovecot/lmtp
mailq_path = /usr/bin/mailq
manpage_directory = /usr/share/man
mydestination = mail.domain.co.za, localhost.localdomain, localhost
mydomain = domain.co.za
myhostname = mail.domain.co.za
mynetworks = 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 192.168.0.0/24
mynetworks_style = subnet
myorigin = /etc/mailname
newaliases_path = /usr/bin/newaliasess
queue_directory = /var/spool/postfix
readme_directory = no
recipient_delimiter = +
relay_domains = $mydestination
relayhost = smtp:[mail.domain.co.za]:465
sample_directory = /etc/postfix
sendmail_path = /usr/sbin/sendmail
setgid_group = postdrop
smtp_bind_address = 192.168.x.X
smtp_sasl_mechanism_filter = !gssapi, !login, static:all
smtp_tls_security_level = encrypt
smtp_tls_wrappermode = yes
smtpd_banner = $myhostname ESMTP $mail_name (Ubuntu)
smtpd_helo_restrictions = reject_invalid_helo_hostname reject_non_fqdn_helo_host
smtpd_recipient_restrictions = permit_my_networks permit_sasl_authenticated reject_unauth_destination reject_sender_login_mismatch
smtpd_relay_restrictions = permit_mynetworks permit_sasl_authenticated reject_unauth_destination
smtpd_sasl_auth_enable = yes
smtpd_sasl_local_domain = $mydomain
smtpd_sasl_path = private/auth
smtpd_sasl_security_options = noanonymous
smtpd_sasl_tls_security_options = $smtpd_sasl_security_options
smtpd_timeout = 220s
smtpd_tls_auth_only = yes
smtpd_tls_cert_file = /etc/ssl/pem/certificate.pem
smtpd_tls_ciphers = medium
smtpd_tls_key_file = /etc/ssl/pem/key.pem
smtpd_tls_mandatory_ciphers = medium
smtpd_tls_mandatory_protocols = TLSv1 TLSv1.1 TLSv1.2
smtpd_tls_security_level = may
smtpd_use_tls = yes
transport_maps = hash:/etc/postfix/transport
unknown_local_recipient_reject_code = 450
virtual_alias_maps = mysql:/etc/postfix/mysql-virtual-alias-maps.cf
virtual_mailbox_domains = mysql:/etc/postfix/mysql-virtual-mailbox-domains.cf
virtual_mailbox_maps = mysql:/etc/postfix/mysql-virtual-mailbox-maps.cf
For Dovecot configuration, the output is:
root@1ag:~# dovecot -n
2.2.33.2 (d6601f4ec): /etc/dovecot/dovecot.conf
Pigeonhole version 0.4.21 (92477967) OS: Linux 4.15.0-39-generic x86_64 Ubuntu 18.04.1 LTS
auth_mechanisms = plain login
auth_verbose = yes
base_dir = /var/run/dovecot/
login_greeting = Dovecot ready.
mail_location = maildir:~/Maildir
passdb {
args = /etc/dovecot/passwd
driver = passwd-file
}
passdb {
driver = pam
}
service auth {
user = root
}
userdb {
driver = passwd
}
userdb {
args = uid=vmail gid=vmail home=/home/vmail/%u
driver = passwd-file
}
protocol imap {
imap_client_workarounds = tb-extra-mailbox-sep
}
You will notice that my mail.log is quite extensive:
Nov 29 12:08:31 domain postfix/postfix-script[2066]: starting the Postfix mail system
Nov 29 12:08:32 domain postfix/master[2070]: daemon started -- version 3.3.0, configuration /etc/postfix
Nov 29 12:08:33 domain postfix/qmgr[2072]: C92FD80215: from=<root@domain.co.za>, size=138408, nrcpt=1 (queue active)
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: connect to mysql server 127.0.0.1: Can't connect to MySQL server on '127.0.0.1' (111)
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:08:35 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:08:36 domain postfix/qmgr[2072]: B78398022A: from=<root@domain.co.za>, size=138303, nrcpt=1 (queue active)
Nov 29 12:08:42 domain amavis[1807]: logging initialized, log level 2, syslog: amavis.mail
Nov 29 12:08:42 domain amavis[1807]: sd_notify (no socket): STATUS=Config files have been read, modules loaded.
Nov 29 12:08:42 domain amavis[1807]: starting. /usr/sbin/amavisd-new at mail.domain.co.zam amavisd-new-2.11.0 (20160426), Unicode aware, LC_ALL="C", LANG="en_US.UTF-8"
Nov 29 12:08:42 domain amavis[1807]: perl=5.026001, user=, EUID: 134 (134); group=, EGID: 142 142 (142 142)
Nov 29 12:08:45 domain amavis[1807]: INFO: no optional modules: unicore::lib::Nt::De.pl Unix::Getrusage
Nov 29 12:08:45 domain amavis[1807]: SpamControl: scanner SpamAssassin, module Amavis::SpamControl::SpamAssassin
Nov 29 12:08:50 domain amavis[1807]: INFO: SA version: 3.4.2, 3.004002, no optional modules: Encode::Detect Image::Info Image::Info::GIF Image::Info::JPEG Image::Info::PNG Image::Info::BMP Image::Info::TIFF
Nov 29 12:08:50 domain amavis[1807]: SpamControl: init_pre_chroot on SpamAssassin done
Nov 29 12:08:50 domain amavis[1807]: socket module IO::Socket::IP, protocol families available: INET, INET6
Nov 29 12:08:50 domain amavis[1807]: will bind to /var/lib/amavis/amavisd.sock|unix, 127.0.0.1:10024/tcp, [::1]:10024/tcp
Nov 29 12:08:50 domain amavis[1807]: sd_notify (no socket): STATUS=Transferring control to Net::Server.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Process Backgrounded
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): MAINPID=2839nSTATUS=Daemonized, preparing to bind sockets.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: 2018/11/29-12:08:50 Amavis (type Net::Server::PreForkSimple) starting! pid(2839)
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to UNIX socket file "/var/lib/amavis/amavisd.sock"
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1 with IPv4
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Binding to TCP port 10024 on host ::1 with IPv6
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): STATUS=Sockets bound, checking user and group.
Nov 29 12:08:50 domain amavis[2839]: Net::Server: Group Not Defined. Defaulting to EGID '142 142'
Nov 29 12:08:50 domain amavis[2839]: Net::Server: User Not Defined. Defaulting to EUID '134'
Nov 29 12:08:50 domain amavis[2839]: sd_notify (no socket): STATUS=The rest of pre-fork init, finding helper programs.
Nov 29 12:08:50 domain amavis[2839]: config files read: /usr/share/amavis/conf.d/10-debian_scripts, /usr/share/amavis/conf.d/20-package, /etc/amavis/conf.d/01-debian, /etc/amavis/conf.d/05-domain_id, /etc/amavis/conf.d/05-node_id, /etc/amavis/conf.d/15-av_scanners, /etc/amavis/conf.d/15-content_filter_mode, /etc/amavis/conf.d/20-debian_defaults, /etc/amavis/conf.d/21-ubuntu_defaults, /etc/amavis/conf.d/25-amavis_helpers, /etc/amavis/conf.d/30-template_localization, /etc/amavis/conf.d/40-policy_banks, /etc/amavis/conf.d/50-user
Nov 29 12:08:50 domain amavis[2839]: Module Amavis::Conf 2.412
Nov 29 12:08:50 domain amavis[2839]: Module Archive::Zip 1.60
Nov 29 12:08:50 domain amavis[2839]: Module BerkeleyDB 0.55
Nov 29 12:08:50 domain amavis[2839]: Module Compress::Raw::Zlib 2.074
Nov 29 12:08:50 domain amavis[2839]: Module Compress::Zlib 2.074
Nov 29 12:08:50 domain amavis[2839]: Module Crypt::OpenSSL::RSA 0.28
Nov 29 12:08:50 domain amavis[2839]: Module DB_File 1.84
Nov 29 12:08:50 domain amavis[2839]: Module Digest::MD5 2.55
Nov 29 12:08:50 domain amavis[2839]: Module Digest::SHA 5.96
Nov 29 12:08:50 domain amavis[2839]: Module Encode 2.88
Nov 29 12:08:50 domain amavis[2839]: Module File::Temp 0.2304
Nov 29 12:08:50 domain amavis[2839]: Module IO::Socket::INET6 2.72
Nov 29 12:08:50 domain amavis[2839]: Module IO::Socket::IP 0.38
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Entity 5.509
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Parser 5.509
Nov 29 12:08:50 domain amavis[2839]: Module MIME::Tools 5.509
Nov 29 12:08:50 domain amavis[2839]: Module Mail::DKIM::Signer 0.44
Nov 29 12:08:50 domain amavis[2839]: Module Mail::DKIM::Verifier 0.44
Nov 29 12:08:50 domain amavis[2839]: Module Mail::Header 2.18
Nov 29 12:08:50 domain amavis[2839]: Module Mail::Internet 2.18
Nov 29 12:08:50 domain amavis[2839]: Module Mail::SPF v2.009
Nov 29 12:08:50 domain amavis[2839]: Module Mail::SpamAssassin 3.004002
Nov 29 12:08:50 domain amavis[2839]: Module Net::DNS 1.1
Nov 29 12:08:50 domain amavis[2839]: Module Net::LibIDN 0.12
Nov 29 12:08:50 domain amavis[2839]: Module Net::Patricia 1.22
Nov 29 12:08:50 domain amavis[2839]: Module Net::Server 2.009
Nov 29 12:08:50 domain amavis[2839]: Module NetAddr::IP 4.079
Nov 29 12:08:50 domain amavis[2839]: Module Razor2::Client::Version 2.84
Nov 29 12:08:50 domain amavis[2839]: Module Scalar::Util 1.4602
Nov 29 12:08:50 domain amavis[2839]: Module Socket 2.020_03
Nov 29 12:08:50 domain amavis[2839]: Module Socket6 0.27
Nov 29 12:08:50 domain amavis[2839]: Module Time::HiRes 1.9741
Nov 29 12:08:50 domain amavis[2839]: Module URI 1.73
Nov 29 12:08:50 domain amavis[2839]: Module Unix::Syslog 1.1
Nov 29 12:08:50 domain amavis[2839]: Amavis::ZMQ code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Amavis::DB code loaded
Nov 29 12:08:50 domain amavis[2839]: SQL base code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SQL::Log code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SQL::Quarantine NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Lookup::SQL code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Lookup::LDAP code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: AM.PDP-in proto code loaded
Nov 29 12:08:50 domain amavis[2839]: SMTP-in proto code loaded
Nov 29 12:08:50 domain amavis[2839]: Courier proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: SMTP-out proto code loaded
Nov 29 12:08:50 domain amavis[2839]: Pipe-out proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: BSMTP-out proto code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Local-out proto code loaded
Nov 29 12:08:50 domain amavis[2839]: OS_Fingerprint code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-VIRUS code loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM code loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-EXT code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-C code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: ANTI-SPAM-SA code loaded
Nov 29 12:08:50 domain amavis[2839]: Unpackers code loaded
Nov 29 12:08:50 domain amavis[2839]: DKIM code loaded
Nov 29 12:08:50 domain amavis[2839]: Tools code NOT loaded
Nov 29 12:08:50 domain amavis[2839]: Found $file at /usr/bin/file
Nov 29 12:08:50 domain amavis[2839]: No $altermime, not using it
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .mail
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .Z at /bin/uncompress
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .gz at /bin/gzip -d
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .gz (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .bz2 at /bin/bzip2 -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .xz at /usr/bin/xz -dc
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzma at /usr/bin/xz -dc --format=lzma
Nov 29 12:08:50 domain amavis[2839]: No ext program for .lrz, tried: lrzip -q -k -d -o -, lrzcat -q -k
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzo at /usr/bin/lzop -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lz4 at /usr/bin/lz4c -d
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rpm at /usr/bin/rpm2cpio
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cpio at /bin/pax
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .tar at /bin/pax
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .deb at /usr/bin/ar
Nov 29 12:08:50 domain amavis[2839]: No ext program for .rar, tried: unrar-free
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arj at /usr/bin/arj
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arc at /usr/bin/nomarch
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .zoo at /usr/bin/zoo
Nov 29 12:08:50 domain amavis[2839]: No ext program for .doc, tried: ripole
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cab at /usr/bin/cabextract
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .tnef
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .zip at /usr/bin/7za
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .kmz at /usr/bin/7za
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .zip (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Internal decoder for .kmz (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .7z at /usr/bin/7zr
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .gz at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .bz2 at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .Z at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .tar at /usr/bin/7za (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .xz at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lzma at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .jar at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cpio at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .arj at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rar at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .swf at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .lha at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .iso at /usr/bin/7z
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .cab at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .deb at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .rpm at /usr/bin/7z (backup, not used)
Nov 29 12:08:50 domain amavis[2839]: Found decoder for .exe at /usr/bin/arj
Nov 29 12:08:50 domain amavis[2839]: No decoder for .F
Nov 29 12:08:50 domain amavis[2839]: No decoder for .doc
Nov 29 12:08:50 domain amavis[2839]: No decoder for .lrz
Nov 29 12:08:50 domain amavis[2839]: Using primary internal av scanner code for ClamAV-clamd
Nov 29 12:08:50 domain amavis[2839]: Found secondary av scanner ClamAV-clamscan at /usr/bin/clamscan
Nov 29 12:08:50 domain amavis[2839]: Deleting db files snmp.db,nanny.db,__db.001,__db.003,__db.002 in /var/lib/amavis/db
Nov 29 12:08:50 domain amavis[2839]: Creating db in /var/lib/amavis/db/; BerkeleyDB 0.55, libdb 5.3
Nov 29 12:09:02 domain postfix/qmgr[2072]: 6299D80227: from=<root@domain.co.za>, size=468, nrcpt=1 (queue active)
Nov 29 12:09:03 domain postfix/qmgr[2072]: A41FC8022B: from=<root@mail.domain.co.za>, size=139510, nrcpt=1 (queue active)
Nov 29 12:09:03 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:09:03 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:09:03 domain postfix/qmgr[2072]: A94108022F: from=<root@mail.domain.co.za>, size=139447, nrcpt=1 (queue active)
Nov 29 12:09:18 domain postfix/error[2894]: 6299D80227: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=386996, delays=386980/0.4/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2075]: C92FD80215: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=443497, delays=443452/29/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2898]: A94108022F: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=83293, delays=83278/0.14/0/15, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/error[2895]: A41FC8022B: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=214145, delays=214130/0.39/0/15, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:18 domain postfix/qmgr[2072]: C92FD80215: from=<root@domain.co.za>, status=expired, returned to sender
Nov 29 12:09:19 domain amavis[2839]: initializing Mail::SpamAssassin (0)
Nov 29 12:09:19 domain amavis[2839]: SpamAssassin debug facilities: info
Nov 29 12:09:19 domain postfix/error[2891]: B78398022A: to=<root@domain.co.za>, orig_to=<root>, relay=none, delay=302494, delays=302451/27/0/16, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:20 domain postfix/cleanup[3218]: warning: /etc/postfix/body_checks: logical line must not start with whitespace: " /^<iframe src=(3D)?cid:.* hei..."
Nov 29 12:09:21 domain postfix/cleanup[3218]: 4636980226: message-id=<20181129100920.4636980226@mail.domain.co.za>
Nov 29 10:09:23 domain postfix/bounce[2893]: C92FD80215: sender non-delivery notification: 4636980226
Nov 29 12:09:23 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:09:23 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains: mysql:/etc/postfix/mysql-virtual-alias-maps.cf: table lookup problem
Nov 29 12:09:23 domain postfix/trivial-rewrite[2074]: warning: virtual_alias_domains lookup failure
Nov 29 12:09:23 domain postfix/qmgr[2072]: C92FD80215: removed
Nov 29 12:09:23 domain amavis[2839]: SA info: config: failed to parse line, skipping, in "/etc/spamassassin/local.cf": use_dcc 0
Nov 29 12:09:23 domain postfix/error[2894]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=none, delay=4.5, delays=4/0.04/0/0.52, dsn=4.3.0, status=deferred (address resolver failure)
Nov 29 12:09:24 domain amavis[2839]: SpamAssassin loaded plugins: AskDNS, AutoLearnThreshold, Bayes, BodyEval, Check, DKIM, DNSEval, FreeMail, HTMLEval, HTTPSMismatch, Hashcash, HeaderEval, ImageInfo, MIMEEval, MIMEHeader, Pyzor, Razor2, RelayEval, ReplaceTags, Rule2XSBody, SPF, SpamCop, URIDNSBL, URIDetail, URIEval, VBounce, WLBLEval, WhiteListSubject
Nov 29 12:09:24 domain amavis[2839]: SpamControl: init_pre_fork on SpamAssassin done
Nov 29 12:09:24 domain amavis[2839]: extra modules loaded after daemonizing/chrooting: /etc/perl/Net/libnet.cfg, /usr/lib/x86_64-linux-gnu/perl5/5.26/auto/Net/SSLeay/autosplit.ix, /usr/lib/x86_64-linux-gnu/perl5/5.26/auto/Net/SSLeay/randomize.al, IO/Socket/SSL.pm, IO/Socket/SSL/PublicSuffix.pm, Mail/SpamAssassin/Plugin/FreeMail.pm, Mail/SpamAssassin/Plugin/SpamCop.pm, Net/Cmd.pm, Net/Config.pm, Net/SMTP.pm, Net/SSLeay.pm
Nov 29 12:09:24 domain amavis[2839]: sd_notify (no socket): READY=1nSTATUS=Initialization done.
Nov 29 12:09:24 domain amavis[2839]: sd_notify (no socket): STATUS=Starting child process(es), ready for work.
Nov 29 12:18:36 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:19:37 domain postfix/qmgr[2072]: warning: problem talking to service rewrite: Connection timed out
Nov 29 12:20:38 domain postfix/qmgr[2072]: warning: problem talking to service rewrite: Connection timed out
Nov 29 12:20:52 domain postfix/trivial-rewrite[4984]: warning: write resolver reply: Broken pipe
Nov 29 12:21:32 domain postfix/trivial-rewrite[5008]: warning: write resolver reply: Broken pipe
Nov 29 12:21:46 domain postfix/smtps/smtpd[5113]: connect from domain.co.za[192.168.1.7]
Nov 29 12:21:47 domain postfix/smtps/smtpd[5113]: warning: SASL: Connect to private/auth failed: Connection refused
Nov 29 12:21:47 domain postfix/smtps/smtpd[5113]: fatal: no SASL authentication mechanisms
Nov 29 12:21:48 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtpd pid 5113 exit status 1
Nov 29 12:21:48 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtpd: bad command startup -- throttling
Nov 29 12:22:42 domain postfix/smtp[5111]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=192.168.1.7[192.168.1.7]:465, delay=749, delays=558/185/6.2/0, dsn=4.4.2, status=deferred (lost connection with 192.168.1.7[192.168.1.7] while receiving the initial server greeting)
Nov 29 12:38:35 domain postfix/qmgr[2072]: 4636980226: from=<>, size=2209, nrcpt=1 (queue active)
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: connect from domain.co.za[192.168.1.7]
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: warning: SASL: Connect to private/auth failed: Connection refused
Nov 29 12:38:38 domain postfix/smtps/smtpd[6873]: fatal: no SASL authentication mechanisms
Nov 29 12:38:39 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtpd pid 6873 exit status 1
Nov 29 12:38:39 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtpd: bad command startup -- throttling
Nov 29 12:38:39 domain postfix/smtp[6872]: 4636980226: to=<carel@domain.co.za>, orig_to=<root@domain.co.za>, relay=192.168.1.7[192.168.1.7]:465, delay=1760, delays=1756/2.4/1.6/0, dsn=4.4.2, status=deferred (lost connection with 192.168.1.7[192.168.1.7] while receiving the initial server greeting)
Nov 29 12:41:06 domain postfix/cleanup[7099]: warning: /etc/postfix/body_checks: logical line must not start with whitespace: " /^<iframe src=(3D)?cid:.* hei..."
Nov 29 12:41:07 domain postfix/pickup[2071]: DF53A80229: uid=0 from=<root>
Nov 29 12:41:07 domain postfix/cleanup[7099]: DF53A80229: message-id=<20181129104106.DF53A80229@mail.domain.co.za>
Nov 29 12:41:07 domain postfix/qmgr[2072]: DF53A80229: from=<root@mail.domain.co.za>, size=138893, nrcpt=1 (queue active)
Nov 29 12:41:07 domain postfix/smtp[7102]: fatal: valid hostname or network address required in server description: smtp:[mail.domain.co.za]:465
Nov 29 12:41:08 domain postfix/qmgr[2072]: warning: private/smtp socket: malformed response
Nov 29 12:41:08 domain postfix/qmgr[2072]: warning: transport smtp failure -- see a previous warning/fatal/panic logfile record for the problem description
Nov 29 12:41:08 domain postfix/master[2070]: warning: process /usr/lib/postfix/sbin/smtp pid 7102 exit status 1
Nov 29 12:41:08 domain postfix/master[2070]: warning: /usr/lib/postfix/sbin/smtp: bad command startup -- throttling
Nov 29 12:41:08 domain postfix/error[7103]: DF53A80229: to=<root@mail.domain.co.za>, orig_to=<root>, relay=none, delay=2.2, delays=1/1.1/0/0.05, dsn=4.3.0, status=deferred (unknown mail transport error)
So, there's a couple of issues here. Any help would be greatly appreciated.
postfix
postfix
edited Nov 29 at 16:20
asked Nov 29 at 10:55
Carel de Lange
12
12
add a comment |
add a comment |
active
oldest
votes
active
oldest
votes
active
oldest
votes
active
oldest
votes
active
oldest
votes
Thanks for contributing an answer to Ask Ubuntu!
- Please be sure to answer the question. Provide details and share your research!
But avoid …
- Asking for help, clarification, or responding to other answers.
- Making statements based on opinion; back them up with references or personal experience.
To learn more, see our tips on writing great answers.
Some of your past answers have not been well-received, and you're in danger of being blocked from answering.
Please pay close attention to the following guidance:
- Please be sure to answer the question. Provide details and share your research!
But avoid …
- Asking for help, clarification, or responding to other answers.
- Making statements based on opinion; back them up with references or personal experience.
To learn more, see our tips on writing great answers.
Sign up or log in
StackExchange.ready(function () {
StackExchange.helpers.onClickDraftSave('#login-link');
});
Sign up using Google
Sign up using Facebook
Sign up using Email and Password
Post as a guest
Required, but never shown
StackExchange.ready(
function () {
StackExchange.openid.initPostLogin('.new-post-login', 'https%3a%2f%2faskubuntu.com%2fquestions%2f1097079%2funable-to-get-my-postfix-dovecot-amavis-spamassassin-mailserver-working%23new-answer', 'question_page');
}
);
Post as a guest
Required, but never shown
Sign up or log in
StackExchange.ready(function () {
StackExchange.helpers.onClickDraftSave('#login-link');
});
Sign up using Google
Sign up using Facebook
Sign up using Email and Password
Post as a guest
Required, but never shown
Sign up or log in
StackExchange.ready(function () {
StackExchange.helpers.onClickDraftSave('#login-link');
});
Sign up using Google
Sign up using Facebook
Sign up using Email and Password
Post as a guest
Required, but never shown
Sign up or log in
StackExchange.ready(function () {
StackExchange.helpers.onClickDraftSave('#login-link');
});
Sign up using Google
Sign up using Facebook
Sign up using Email and Password
Sign up using Google
Sign up using Facebook
Sign up using Email and Password
Post as a guest
Required, but never shown
Required, but never shown
Required, but never shown
Required, but never shown
Required, but never shown
Required, but never shown
Required, but never shown
Required, but never shown
Required, but never shown