Postfix/Courier SMTP Problem
I'm running Ubuntu 10.04, and I'm trying to set up Postfix and Courier as a mailserver. I am able to connect to a POP account under Courier with no problems. I followed the postfix/courier tutorial on the linode library, and I am using mySQL for everything. My website is
I just ran a tail -50 /etc/postfix/mail.log and got this:
Jun 22 23:43:41 trinity postfix/qmgr[9758]: 305F3E5CC: from=<ben@trinity.benstevinson.com>, size=476, nrcpt=1 (queue active)
Jun 22 23:43:41 trinity postfix/smtp[9767]: 305F3E5CC: to=<techy158@gmail.com>, relay=gmail-smtp-in.l.google.com[74.125.91.27]:25, delay=0.72, delays=0.03/0.01/0.14/0.54, dsn=2.0.0, status=sent (250 2.0.0 OK 1277271821 my14si11416313qcb.92)
Jun 22 23:43:41 trinity postfix/qmgr[9758]: 305F3E5CC: removed
Jun 22 23:44:41 trinity postfix/master[9755]: terminating on signal 15
Jun 22 23:44:41 trinity postfix/master[9875]: daemon started -- version 2.7.0, configuration /etc/postfix
Jun 22 23:44:55 trinity postfix/pickup[9877]: E5C7FE5CB: uid=1000 from= <ben>Jun 22 23:44:55 trinity postfix/cleanup[9882]: E5C7FE5CB: message-id=<20100623054455.E5C7FE5CB@benstevinson.com>
Jun 22 23:44:55 trinity postfix/qmgr[9878]: E5C7FE5CB: from=<ben@trinity.benstevinson.com>, size=448, nrcpt=1 (queue active)
Jun 22 23:44:56 trinity postfix/smtp[9885]: E5C7FE5CB: to=<techy158@gmail.com>, relay=gmail-smtp-in.l.google.com[74.125.91.27]:25, delay=0.73, delays=0.03/0.01/0.12/0.57, dsn=2.0.0, status=sent (250 2.0.0 OK 1277271896 w40si11413077qce.108)
Jun 22 23:44:56 trinity postfix/qmgr[9878]: E5C7FE5CB: removed
Jun 23 06:25:02 trinity postfix/pickup[10087]: 925CCE5CB: uid=0 from= <root>Jun 23 06:25:02 trinity postfix/cleanup[10192]: 925CCE5CB: message-id=<20100623122502.925CCE5CB@benstevinson.com>
Jun 23 06:25:02 trinity postfix/qmgr[9878]: 925CCE5CB: from=<root@trinity.benstevinson.com>, size=840, nrcpt=1 (queue active)
Jun 23 06:25:02 trinity postfix/local[10195]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jun 23 06:25:02 trinity postfix/local[10195]: 925CCE5CB: to=<root@trinity.benstevinson.com>, orig_to=<root>, relay=local, delay=0.22, delays=0.21/0.01/0/0, dsn=2.0.0, status=sent (delivered to mailbox)
Jun 23 06:25:02 trinity postfix/qmgr[9878]: 925CCE5CB: removed
Jun 23 12:13:56 trinity postfix/master[9875]: terminating on signal 15
Jun 23 12:13:56 trinity postfix/master[10480]: daemon started -- version 2.7.0, configuration /etc/postfix
Jun 23 12:15:19 trinity authdaemond: modules="authmysql", daemons=5
Jun 23 12:15:19 trinity authdaemond: Installing libauthmysql
Jun 23 12:15:19 trinity authdaemond: Installation complete: authmysql
Jun 23 12:15:20 trinity postfix/master[2257]: daemon started -- version 2.7.0, configuration /etc/postfix
Jun 23 12:15:33 trinity dovecot: Dovecot v1.2.9 starting up (core dumps disabled)
Jun 23 14:22:02 trinity imapd: Connection, ip=[::ffff:63.224.65.82]
Jun 23 14:22:02 trinity imapd: LOGOUT, ip=[::ffff:63.224.65.82], rcvd=24, sent=464
Jun 23 14:22:52 trinity imapd: Connection, ip=[::ffff:63.224.65.82]
Jun 23 14:22:57 trinity imapd: Connection, ip=[::ffff:63.224.65.82]
Jun 23 14:22:57 trinity imapd: LOGIN FAILED, method=PLAIN, ip=[::ffff:63.224.65.82]
Jun 23 14:23:02 trinity imapd: LOGIN FAILED, user=ben, ip=[::ffff:63.224.65.82]
Jun 23 14:23:12 trinity imapd: Disconnected, ip=[::ffff:63.224.65.82], time=15, starttls=1
Jun 23 14:28:51 trinity postfix/pickup[2487]: AA5E5E5CB: uid=1000 from= <ben>Jun 23 14:28:51 trinity postfix/cleanup[2546]: AA5E5E5CB: message-id=<20100623202851.AA5E5E5CB@benstevinson.com>
Jun 23 14:28:51 trinity postfix/qmgr[2266]: AA5E5E5CB: from=<ben@trinity.benstevinson.com>, size=442, nrcpt=1 (queue active)
Jun 23 14:28:52 trinity postfix/smtp[2551]: AA5E5E5CB: to=<techy158@gmail.com>, relay=gmail-smtp-in.l.google.com[74.125.91.27]:25, delay=1.2, delays=0.11/0.04/0.36/0.73, dsn=2.0.0, status=sent (250 2.0.0 OK 1277324932 d21si12302180qcs.132)
Jun 23 14:28:52 trinity postfix/qmgr[2266]: AA5E5E5CB: removed
Jun 23 16:12:20 trinity imapd: Connection, ip=[::ffff:63.224.65.82]
Jun 23 16:12:21 trinity imapd: LOGIN FAILED, method=PLAIN, ip=[::ffff:63.224.65.82]
Jun 23 16:12:26 trinity imapd: LOGIN FAILED, user=ben, ip=[::ffff:63.224.65.82]
Jun 23 16:12:46 trinity imapd: LOGIN FAILED, method=PLAIN, ip=[::ffff:63.224.65.82]
Jun 23 16:12:51 trinity imapd: LOGIN FAILED, user=ben, ip=[::ffff:63.224.65.82]
Jun 23 16:12:58 trinity imapd: Disconnected, ip=[::ffff:63.224.65.82], time=38, starttls=1
Jun 23 16:16:14 trinity imapd: Connection, ip=[::ffff:63.224.65.82]
Jun 23 16:16:17 trinity imapd: Disconnected, ip=[::ffff:63.224.65.82], time=3, starttls=1
Jun 23 16:16:40 trinity imapd: Connection, ip=[::ffff:63.224.65.82]
Jun 23 16:16:45 trinity imapd: Connection, ip=[::ffff:63.224.65.82]
Jun 23 16:16:53 trinity imapd: LOGIN, user=ben@benstevinson.com, ip=[::ffff:63.224.65.82], port=[1056], protocol=IMAP
Jun 23 16:17:15 trinity imapd: Connection, ip=[::ffff:63.224.65.82]
Jun 23 16:17:15 trinity imapd: LOGIN, user=ben@benstevinson.com, ip=[::ffff:63.224.65.82], port=[1439], protocol=IMAP
Jun 23 16:17:15 trinity imapd: Connection, ip=[::ffff:63.224.65.82]
Jun 23 16:17:15 trinity imapd: LOGIN, user=ben@benstevinson.com, ip=[::ffff:63.224.65.82], port=[1440], protocol=IMAP</techy158@gmail.com></ben@trinity.benstevinson.com></ben></root></root@trinity.benstevinson.com></root@trinity.benstevinson.com></root></techy158@gmail.com></ben@trinity.benstevinson.com></ben></techy158@gmail.com></ben@trinity.benstevinson.com>
I looked at this and noticed that saslauthd was not started, so I started it. Then it just timed out when I tried to use Thunderbird to send an email. I can still receive mail, however.
I am putting my account as
Here is my /etc/aliases file:
# See man 5 aliases for format
postmaster: root@benstevinson.com
ben: ben@benstevinson.com
And here is my main.cf file:
smtpd_banner = $myhostname ESMTP $mail_name (Ubuntu)
biff = no
# appending .domain is the MUA's job.
append_dot_mydomain = no
# Uncomment the next line to generate "delayed mail" warnings
#delay_warning_time = 4h
readme_directory = /usr/share/doc/postfix
# TLS parameters
smtpd_tls_cert_file = /etc/postfix/smtpd.cert
smtpd_tls_key_file = /etc/postfix/smtpd.key
smtpd_use_tls = yes
smtpd_tls_session_cache_database = btree:${data_directory}/smtpd_scache
smtp_tls_session_cache_database = btree:${data_directory}/smtp_scache
# See /usr/share/doc/postfix/TLS_README.gz in the postfix-doc package for
# information on enabling SSL in the smtp client.
myhostname = benstevinson.com
alias_maps = hash:/etc/aliases
alias_database = hash:/etc/aliases
myorigin = /etc/mailname
mydestination = benstevinson.com, localhost.benstevinson.com
relayhost =
mynetworks = 127.0.0.0/8
mailbox_size_limit = 0
recipient_delimiter = +
inet_interfaces = all
html_directory = /usr/share/doc/postfix/html
message_size_limit = 30720000
virtual_alias_domains =
virtual_alias_maps = proxy:mysql:/etc/postfix/mysql-virtual_forwardings.cf, mysql:/etc/postfix/mysql-virtual_email2email.cf
virtual_mailbox_domains = proxy:mysql:/etc/postfix/mysql-virtual_domains.cf
virtual_mailbox_maps = proxy:mysql:/etc/postfix/mysql-virtual_mailboxes.cf
virtual_mailbox_base = /home/vmail
virtual_uid_maps = static:5000
virtual_gid_maps = static:5000
smtpd_sasl_auth_enable = yes
broken_sasl_auth_clients = yes
smtpd_sasl_authenticated_header = yes
smtpd_recipient_restrictions = permit_mynetworks, permit_sasl_authenticated, reject_unauth_destination
virtual_create_maildirsize = yes
virtual_maildir_extended = yes
proxy_read_maps = $local_recipient_maps $mydestination $virtual_alias_maps $virtual_alias_domains $virtual_mailbox_maps $virtual_mailbox_domains $relay_recipient_maps $relay_domains $canonical_maps $sender_canonical_maps $recipient_canonical_maps $relocated_maps $transport_maps $mynetworks $virtual_mailbox_limit_maps
What do I have wrong here? I cannot figure it out.
Thanks in advance!
5 Replies
$ telnet mail.benstevinson.com 25
Trying 69.164.196.103…
Connected to mail.benstevinson.com.
Escape character is '^]'.
220 benstevinson.com ESMTP Postfix (Ubuntu)
EHLO testing
250-benstevinson.com
250-PIPELINING
250-SIZE 30720000
250-VRFY
250-ETRN
250-STARTTLS
250-AUTH PLAIN LOGIN
250-AUTH=PLAIN LOGIN
250-ENHANCEDSTATUSCODES
250-8BITMIME
250 DSN
````
Are you sure your ISP is not firewalling your smtp port?
Try the above telnet command from your external host, and also try it from your server.
@Captain Briney:
My FQDN is trinity.benstevinson.com, and I can use mailx to send out to another place, but it says my email address is
ben@trinity.benstevinson.com . I am trying to change that.
This is controlled by the "myorigin" line in your main.cf.
If you want the locally generated mail to come from
I'm at home now, I was at work when I generated those logs.
Trying it from both my PC and my Server results in the exact same telnet message that you posted, yet I still cannot connect.
Here's another log file. It still says login incorrect and asks for my password which it will then reject:
Jun 23 17:50:32 trinity postfix/smtpd[2930]: warning: cannot get RSA private key from file /etc/postfix/smtpd.key: disabling TLS support
Jun 23 17:50:32 trinity postfix/smtpd[2930]: warning: TLS library problem: 2930:error:0B080074:x509 certificate routines:X509_check_private_key:key values mismatch:x509_cmp.c:406:
Jun 23 17:50:32 trinity postfix/smtpd[2930]: connect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:50:32 trinity postfix/smtpd[2930]: disconnect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:50:33 trinity postfix/smtpd[2930]: connect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:50:33 trinity postfix/smtpd[2930]: disconnect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:50:39 trinity imapd: Connection, ip=[::ffff:71.56.233.72]
Jun 23 17:50:39 trinity imapd: Disconnected, ip=[::ffff:71.56.233.72], time=0
Jun 23 17:50:42 trinity imapd: Connection, ip=[::ffff:71.56.233.72]
Jun 23 17:50:42 trinity imapd: LOGIN FAILED, method=PLAIN, ip=[::ffff:71.56.233.72]
Jun 23 17:50:47 trinity imapd: LOGIN FAILED, user=ben, ip=[::ffff:71.56.233.72]
Jun 23 17:50:52 trinity imapd: LOGIN FAILED, method=PLAIN, ip=[::ffff:71.56.233.72]
Jun 23 17:50:56 trinity imapd: Connection, ip=[::ffff:71.56.233.72]
Jun 23 17:50:56 trinity imapd: LOGOUT, ip=[::ffff:71.56.233.72], rcvd=24, sent=464
Jun 23 17:50:57 trinity imapd: LOGIN FAILED, user=ben, ip=[::ffff:71.56.233.72]
Jun 23 17:51:01 trinity imapd: Connection, ip=[::ffff:71.56.233.72]
Jun 23 17:51:01 trinity imapd: LOGIN, user=ben@benstevinson.com, ip=[::ffff:71.56.233.72], port=[2344], protocol=IMAP
Jun 23 17:51:02 trinity imapd: Connection, ip=[::ffff:71.56.233.72]
Jun 23 17:51:02 trinity imapd: LOGOUT, user=ben@benstevinson.com, ip=[::ffff:71.56.233.72], headers=0, body=0, rcvd=10, sent=80, time=1, starttls=1
Jun 23 17:51:02 trinity imapd: Disconnected, ip=[::ffff:71.56.233.72], time=20, starttls=1
Jun 23 17:51:02 trinity imapd: LOGIN, user=ben@benstevinson.com, ip=[::ffff:71.56.233.72], port=[2345], protocol=IMAP
Jun 23 17:51:11 trinity postfix/smtpd[2930]: connect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:51:12 trinity postfix/smtpd[2930]: warning: SASL authentication failure: Password verification failed
Jun 23 17:51:12 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL PLAIN authentication failed: authentication failure
Jun 23 17:51:12 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL LOGIN authentication failed: authentication failure
Jun 23 17:51:26 trinity postfix/smtpd[2930]: warning: SASL authentication failure: Password verification failed
Jun 23 17:51:26 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL PLAIN authentication failed: authentication failure
Jun 23 17:51:26 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL LOGIN authentication failed: authentication failure
Jun 23 17:51:29 trinity postfix/smtpd[2930]: warning: SASL authentication failure: Password verification failed
Jun 23 17:51:29 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL PLAIN authentication failed: authentication failure
Jun 23 17:51:29 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL LOGIN authentication failed: authentication failure
Jun 23 17:51:34 trinity postfix/smtpd[2930]: warning: SASL authentication failure: Password verification failed
Jun 23 17:51:34 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL PLAIN authentication failed: authentication failure
Jun 23 17:51:34 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL LOGIN authentication failed: authentication failure
Jun 23 17:51:38 trinity postfix/smtpd[2930]: warning: SASL authentication failure: Password verification failed
Jun 23 17:51:38 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL PLAIN authentication failed: authentication failure
Jun 23 17:51:38 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL LOGIN authentication failed: authentication failure
Jun 23 17:51:42 trinity postfix/smtpd[2930]: disconnect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:52:42 trinity postfix/smtpd[2930]: connect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:52:47 trinity postfix/smtpd[2930]: warning: SASL authentication failure: Password verification failed
Jun 23 17:52:47 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL PLAIN authentication failed: authentication failure
Jun 23 17:52:47 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL LOGIN authentication failed: authentication failure
Jun 23 17:52:52 trinity postfix/smtpd[2930]: warning: SASL authentication failure: Password verification failed
Jun 23 17:52:52 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL PLAIN authentication failed: authentication failure
Jun 23 17:52:52 trinity postfix/smtpd[2930]: warning: c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]: SASL LOGIN authentication failed: authentication failure
Jun 23 17:52:53 trinity postfix/smtpd[2930]: disconnect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:53:26 trinity postfix/smtpd[2930]: connect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:53:48 trinity postfix/smtpd[2979]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jun 23 17:53:48 trinity postfix/smtpd[2979]: warning: cannot get RSA private key from file /etc/postfix/smtpd.key: disabling TLS support
Jun 23 17:53:48 trinity postfix/smtpd[2979]: warning: TLS library problem: 2979:error:0B080074:x509 certificate routines:X509_check_private_key:key values mismatch:x509_cmp.c:406:
Jun 23 17:53:48 trinity postfix/smtpd[2979]: connect from trinity.benstevinson.com[69.164.196.103]
Jun 23 17:54:00 trinity postfix/smtpd[2930]: lost connection after EHLO from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:54:00 trinity postfix/smtpd[2930]: disconnect from c-71-56-233-72.hsd1.co.comcast.net[71.56.233.72]
Jun 23 17:54:09 trinity postfix/smtpd[2979]: disconnect from trinity.benstevinson.com[69.164.196.103]
Jun 23 17:57:29 trinity postfix/anvil[2933]: statistics: max connection rate 3/60s for (smtp:71.56.233.72) at Jun 23 17:51:11
Jun 23 17:57:29 trinity postfix/anvil[2933]: statistics: max connection count 1 for (smtp:71.56.233.72) at Jun 23 17:50:32
Jun 23 17:57:29 trinity postfix/anvil[2933]: statistics: max cache size 2 at Jun 23 17:53:48
Jun 23 17:58:03 trinity postfix/pickup[2874]: 18A36E5D7: uid=1000 from= <ben>Jun 23 17:58:03 trinity postfix/cleanup[2988]: 18A36E5D7: message-id=<20100623235803.18A36E5D7@benstevinson.com>
Jun 23 17:58:03 trinity postfix/qmgr[2875]: 18A36E5D7: from=<ben@benstevinson.com>, size=443, nrcpt=1 (queue active)
Jun 23 17:58:03 trinity postfix/trivial-rewrite[2990]: warning: do not list domain benstevinson.com in BOTH mydestination and virtual_mailbox_domains
Jun 23 17:58:03 trinity postfix/local[2991]: 18A36E5D7: to=<holland@benstevinson.com>, relay=local, delay=0.08, delays=0.03/0.04/0/0.01, dsn=5.1.1, status=bounced (unknown user: "holland")
Jun 23 17:58:03 trinity postfix/cleanup[2988]: 290B3E5D9: message-id=<20100623235803.290B3E5D9@benstevinson.com>
Jun 23 17:58:03 trinity postfix/bounce[2992]: 18A36E5D7: sender non-delivery notification: 290B3E5D9
Jun 23 17:58:03 trinity postfix/qmgr[2875]: 290B3E5D9: from=<>, size=2174, nrcpt=1 (queue active)
Jun 23 17:58:03 trinity postfix/trivial-rewrite[2990]: warning: do not list domain benstevinson.com in BOTH mydestination and virtual_mailbox_domains
Jun 23 17:58:03 trinity postfix/qmgr[2875]: 18A36E5D7: removed
Jun 23 17:58:03 trinity postfix/local[2991]: 290B3E5D9: to=<ben@benstevinson.com>, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to mailbox)
Jun 23 17:58:03 trinity postfix/qmgr[2875]: 290B3E5D9: removed
Jun 23 17:58:14 trinity postfix/master[2872]: terminating on signal 15
Jun 23 17:58:15 trinity postfix/master[3098]: daemon started -- version 2.7.0, configuration /etc/postfix
Jun 23 17:58:25 trinity authdaemond: stopping authdaemond children
Jun 23 17:58:25 trinity authdaemond: modules="authmysql", daemons=5
Jun 23 17:58:25 trinity authdaemond: Installing libauthmysql
Jun 23 17:58:25 trinity authdaemond: Installation complete: authmysql
Jun 23 18:00:00 trinity imapd: Connection, ip=[::ffff:71.56.233.72]
Jun 23 18:00:00 trinity imapd: LOGOUT, ip=[::ffff:71.56.233.72], rcvd=24, sent=464
Jun 23 18:00:02 trinity postfix/smtpd[3255]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jun 23 18:00:02 trinity postfix/smtpd[3255]: warning: cannot get RSA private key from file /etc/postfix/smtpd.key: disabling TLS support</ben@benstevinson.com></holland@benstevinson.com></ben@benstevinson.com></ben>
When I sent a mail out using mailx it shows up as