Can send Mail but cannot recieve anything

Hi All

As part of my school of webmastership I am trying to run a webserver also. To simplify matters I followed the recommended setup of Postfix, Dovecot, and MySQL. Sooooo I am now at the last step where you are supposed up a mail client and send email to and from the account. I was able to execute all the steps proceding this successfully.

My problem is when I send email to myself I get the following activity in the log

Jan 2 11:50:15 www postfix/qmgr[3517]: 4712016DA7: from=[email protected]>, size=12204, nrcpt=1 (queue$

Jan 2 11:50:15 www postfix/qmgr[3517]: 633F116DA8: from=[email protected]>, size=15002, nrcpt=1 (queue$

Jan 2 11:50:15 www postfix/lmtp[4784]: 4712016DA7: to=<[email protected]>, relay=none, delay=345, delays=345/0.04/0/0, dsn=4.4.1, sta$

Jan 2 11:50:15 www postfix/lmtp[4785]: 633F116DA8: to=<[email protected]>, relay=none, delay=345, delays=345/0.03/0/0, dsn=4.4.1, sta$

Jan 2 11:50:41 www postfix/anvil[4749]: statistics: max connection rate 1/60s for (smtp:199.59.150.97) at Jan 2 11:44:29

Jan 2 11:50:41 www postfix/anvil[4749]: statistics: max connection count 1 for (smtp:199.59.150.97) at Jan 2 11:44:29

Jan 2 11:50:41 www postfix/anvil[4749]: statistics: max cache size 2 at Jan 2 11:44:30

The email is setup on Ubuntu 12.04 LTS-> Thunderbird. I am using my laptop for the client setup to connect to the mail server

I am using the following settings

server type

IMAP

Server

mail.STEMSharp.com

Username

SSharp_Admin

port

993

Security Setting

SSL/TLS

Outgoing

server

mail.STEMSharp.com

Username

SSharp_Admin

I am pretty sure I have the ports opened properly any ideas?admin=admin=

6 Replies

One problem I can see is you have an MX entry in your DNS pointing to mailserver.stemsharp.com, which does not resolve to an IP address. You should remove this entry. The other MX, mail.stemsharp.com, is fine.

Unfortunately, the log you posted has the end of the lines cut off which provide vital information. Use less to view it and copy/paste.

I tried sending mail to [email protected] and it seemed to go through OK; in addition, connecting directly to mail.stemsharp.com and sending mail succeeded:

$ nc mail.stemsharp.com 25                                       
220 www.STEMSharp.com ESMTP Postfix (Ubuntu)                                    
HELO core-bltm-69-72-61-101.dynamic-dialup.coretel.net                          
250 www.STEMSharp.com                                                           
MAIL FROM:<>                                                                    
250 2.1.0 Ok                                                                    
RCPT TO: <[email protected]>250 2.1.5 Ok                                                                    
DATA                                                                            
354 End data with <cr><lf>. <cr><lf>Subject: Test 2                                                                 

This is another test.
.
250 2.0.0 Ok: queued as 953A316DC4
QUIT
221 2.0.0 Bye</lf></cr></lf></cr></[email protected]>

thanks for taking a look

Jan  2 11:50:15 www postfix/qmgr[3517]: 4712016DA7: from=<[email protected]>, size=12204, nrcpt=1 (queue 
active)
Jan  2 11:50:15 www postfix/qmgr[3517]: 633F116DA8: from=<[email protected]>, size=15002, nrcpt=1 (queue 
active)
Jan  2 11:50:15 www postfix/lmtp[4784]: 4712016DA7: to=<[email protected]>, relay=none, delay=345, delays=345/0.04/0/0, dsn=4.4.1, stat
us=deferred (connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory)
Jan  2 11:50:15 www postfix/lmtp[4785]: 633F116DA8: to=<[email protected]>, relay=none, delay=345, delays=345/0.03/0/0, dsn=4.4.1, stat
us=deferred (connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory)
Jan  2 11:50:41 www postfix/anvil[4749]: statistics: max connection rate 1/60s for (smtp:199.59.150.97) at Jan  2 11:44:29
Jan  2 11:50:41 www postfix/anvil[4749]: statistics: max connection count 1 for (smtp:199.59.150.97) at Jan  2 11:44:29
Jan  2 11:50:41 www postfix/anvil[4749]: statistics: max cache size 2 at Jan  2 11:44:30
Jan  2 11:50:52 www postfix/smtpd[4790]: connect from mail-lb0-f179.google.com[209.85.217.179]
Jan  2 11:50:53 www postfix/smtpd[4790]: 738A516DAF: client=mail-lb0-f179.google.com[209.85.217.179]
Jan  2 11:50:53 www postfix/cleanup[4796]: 738A516DAF: message-id= <[email protected]om>Jan  2 11:50:54 www postfix/qmgr[3517]: 738A516DAF: from=<[email protected]>, size=126260, nrcpt=1 (queue active)
Jan  2 11:50:54 www postfix/lmtp[4784]: 738A516DAF: to=<[email protected]>, relay=none, delay=1.1, delays=1.1/0.01/0/0, dsn=4.4.1, stat
us=deferred (connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory)
Jan  2 11:50:54 www postfix/smtpd[4790]: disconnect from mail-lb0-f179.google.com[209.85.217.179]</[email protected]></[email protected]></[email protected]om></[email protected]></[email protected]></[email protected]></[email protected]> 

above is that same section viewed in less

I also just swtiched my port from 143 to 993 so it is secured reviewing the log at this point

Jan  2 14:23:01 www dovecot: auth-worker: mysql(127.0.0.1): Connected to database mailserver
Jan  2 14:23:01 www dovecot: imap-login: Login: user=<[email protected]>, method=PLAIN, rip=75.189.152.160, lip=74.207.235.39, mpid=5413, TLS
Jan  2 14:23:31 www dovecot: imap-login: Login: user=<[email protected]>, method=PLAIN, rip=75.189.152.160, lip=74.207.235.39, mpid=5415, TLS
Jan  2 14:25:15 www postfix/qmgr[3517]: 9375316DBC: from=<[email protected]>, size=2621, nrcpt=1 (queue active)
Jan  2 14:25:15 www postfix/lmtp[5421]: 9375316DBC: to=<[email protected]>, relay=none, delay=4506, delays=4506/0.02/0/0, dsn=4.4.1, status=deferred (connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory)</[email protected]></[email protected]></[email protected]></[email protected]>

i think its taht no such file or directory is the issue not sure what it means or how to fix

Thanks in advance.

I turned on verbose output and it gives the following

Jan  2 17:04:51 www postfix/qmgr[6481]: 1CD0216DB3: from=<[email protected]>, size=2567, nrcpt=1 (queue active)
Jan  2 17:04:51 www postfix/qmgr[6481]: C115E16DD5: from=<[email protected]>, size=1744, nrcpt=1 (queue active)
Jan  2 17:04:51 www postfix/qmgr[6481]: DE09816DD2: from=<[email protected]>, size=2580, nrcpt=1 (queue active)
Jan  2 17:04:51 www postfix/qmgr[6481]: 3183A16DD7: from=<[email protected]>, size=2550, nrcpt=1 (queue active)
Jan  2 17:04:51 www postfix/lmtp[6514]: 1CD0216DB3: to=<[email protected]>, relay=none, delay=17278, delays=17278/0.07/0/0, dsn=4.4.1, status=deferred (connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory)
Jan  2 17:04:51 www postfix/lmtp[6515]: C115E16DD5: to=<[email protected]>, relay=none, delay=1048, delays=1048/0.06/0/0, dsn=4.4.1, status=deferred (connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory)
Jan  2 17:04:51 www postfix/lmtp[6515]: 3183A16DD7: to=<[email protected]>, relay=none, delay=339, delays=339/0.07/0.02/0, dsn=4.4.1, status=deferred (connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory)
Jan  2 17:04:51 www postfix/lmtp[6514]: DE09816DD2: to=<[email protected]>, relay=none, delay=2107, delays=2107/0.07/0.02/0, dsn=4.4.1, status=deferred (connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory)
Jan  2 17:05:33 www postfix/smtpd[6523]: name_mask: all
Jan  2 17:05:33 www postfix/smtpd[6523]: inet_addr_local: configured 2 IPv4 addresses
Jan  2 17:05:33 www postfix/smtpd[6523]: inet_addr_local: configured 3 IPv6 addresses
Jan  2 17:05:33 www postfix/smtpd[6523]: process generation: 31 (31)
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: mynetworks ~? debug_peer_list
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: mynetworks ~? fast_flush_domains
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: mynetworks ~? mynetworks
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: relay_domains ~? debug_peer_list
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: relay_domains ~? fast_flush_domains
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: relay_domains ~? mynetworks
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: relay_domains ~? permit_mx_backup_networks
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: relay_domains ~? qmqpd_authorized_clients
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: relay_domains ~? smtpd_access_maps
Jan  2 17:05:33 www postfix/smtpd[6523]: match_list_match: relay_domains: no match
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: permit_mx_backup_networks ~? debug_peer_list
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: permit_mx_backup_networks ~? fast_flush_domains
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: permit_mx_backup_networks ~? mynetworks
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: permit_mx_backup_networks ~? permit_mx_backup_networks
Jan  2 17:05:33 www postfix/smtpd[6523]: connect to subsystem private/proxymap
Jan  2 17:05:33 www postfix/smtpd[6523]: send attr request = open
Jan  2 17:05:33 www postfix/smtpd[6523]: send attr table = unix:passwd.byname
Jan  2 17:05:33 www postfix/smtpd[6523]: send attr flags = 0
Jan  2 17:05:33 www postfix/smtpd[6523]: private/proxymap socket: wanted attribute: status
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: status
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute value: 0
Jan  2 17:05:33 www postfix/smtpd[6523]: private/proxymap socket: wanted attribute: flags
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: flags
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute value: 16
Jan  2 17:05:33 www postfix/smtpd[6523]: private/proxymap socket: wanted attribute: (list terminator)
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: (end)
Jan  2 17:05:33 www postfix/smtpd[6523]: dict_proxy_open: connect to map=unix:passwd.byname status=0 server_flags=fixed
Jan  2 17:05:33 www postfix/smtpd[6523]: dict_open: proxy:unix:passwd.byname
Jan  2 17:05:33 www postfix/smtpd[6523]: Compiled against Berkeley DB: 5.1.25?
Jan  2 17:05:33 www postfix/smtpd[6523]: Run-time linked against Berkeley DB: 5.1.25?
Jan  2 17:05:33 www postfix/smtpd[6523]: dict_open: hash:/etc/aliases
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-alias-maps.cf: user = mailadmin
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-alias-maps.cf: password = 
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-alias-maps.cf: dbname = mailserver
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-alias-maps.cf: result_format = %s
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_int: /etc/postfix/mysql-virtual-alias-maps.cf: expansion_limit = 0
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-alias-maps.cf: query = SELECT destination FROM virtual_aliases WHERE source='%s'
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-alias-maps.cf: domain = 
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-alias-maps.cf: hosts = 127.0.0.1
Jan  2 17:05:33 www postfix/smtpd[6523]: dict_open: mysql:/etc/postfix/mysql-virtual-alias-maps.cf
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-mailbox-maps.cf: user = mailadmin
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-mailbox-maps.cf: password = 
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-mailbox-maps.cf: dbname = mailserver
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-mailbox-maps.cf: result_format = %s
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_int: /etc/postfix/mysql-virtual-mailbox-maps.cf: expansion_limit = 0
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-mailbox-maps.cf: query = SELECT 1 FROM virtual_users WHERE email='%s'
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-mailbox-maps.cf: domain = 
Jan  2 17:05:33 www postfix/smtpd[6523]: cfg_get_str: /etc/postfix/mysql-virtual-mailbox-maps.cf: hosts = 127.0.0.1
Jan  2 17:05:33 www postfix/smtpd[6523]: dict_open: mysql:/etc/postfix/mysql-virtual-mailbox-maps.cf
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: smtpd_access_maps ~? debug_peer_list
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: smtpd_access_maps ~? fast_flush_domains
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: smtpd_access_maps ~? mynetworks
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: smtpd_access_maps ~? permit_mx_backup_networks
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: smtpd_access_maps ~? qmqpd_authorized_clients
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: smtpd_access_maps ~? smtpd_access_maps
Jan  2 17:05:33 www postfix/smtpd[6523]: unknown_helo_hostname_tempfail_action = defer_if_permit
Jan  2 17:05:33 www postfix/smtpd[6523]: unknown_address_tempfail_action = defer_if_permit
Jan  2 17:05:33 www postfix/smtpd[6523]: unverified_recipient_tempfail_action = defer_if_permit
Jan  2 17:05:33 www postfix/smtpd[6523]: unverified_sender_tempfail_action = defer_if_permit
Jan  2 17:05:33 www postfix/smtpd[6523]: name_mask: 0
Jan  2 17:05:33 www postfix/smtpd[6523]: auto_clnt_create: transport=local endpoint=private/tlsmgr
Jan  2 17:05:33 www postfix/smtpd[6523]: auto_clnt_open: connected to private/tlsmgr
Jan  2 17:05:33 www postfix/smtpd[6523]: send attr request = seed
Jan  2 17:05:33 www postfix/smtpd[6523]: send attr size = 32
Jan  2 17:05:33 www postfix/smtpd[6523]: private/tlsmgr: wanted attribute: status
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: status
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute value: 0
Jan  2 17:05:33 www postfix/smtpd[6523]: private/tlsmgr: wanted attribute: seed
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: seed
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute value: atTeYk8jTC0hEjk4BNp4KlnL4eG4WlCRMR+/BbVf9Qw=
Jan  2 17:05:33 www postfix/smtpd[6523]: private/tlsmgr: wanted attribute: (list terminator)
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: (end)
Jan  2 17:05:33 www postfix/smtpd[6523]: send attr request = policy
Jan  2 17:05:33 www postfix/smtpd[6523]: send attr cache_type = smtpd
Jan  2 17:05:33 www postfix/smtpd[6523]: private/tlsmgr: wanted attribute: status
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: status
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute value: 0
Jan  2 17:05:33 www postfix/smtpd[6523]: private/tlsmgr: wanted attribute: cachable
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: cachable
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute value: 0
Jan  2 17:05:33 www postfix/smtpd[6523]: private/tlsmgr: wanted attribute: (list terminator)
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: (end)
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: fast_flush_domains ~? debug_peer_list
Jan  2 17:05:33 www postfix/smtpd[6523]: match_string: fast_flush_domains ~? fast_flush_domains
Jan  2 17:05:33 www postfix/smtpd[6523]: auto_clnt_create: transport=local endpoint=private/anvil
Jan  2 17:05:33 www postfix/smtpd[6523]: connection established
Jan  2 17:05:33 www postfix/smtpd[6523]: master_notify: status 0
Jan  2 17:05:33 www postfix/smtpd[6523]: name_mask: resource
Jan  2 17:05:33 www postfix/smtpd[6523]: name_mask: software
Jan  2 17:05:33 www postfix/smtpd[6523]: connect from mail-lb0-f180.google.com[209.85.217.180]
Jan  2 17:05:33 www postfix/smtpd[6523]: match_list_match: mail-lb0-f180.google.com: no match
Jan  2 17:05:33 www postfix/smtpd[6523]: match_list_match: 209.85.217.180: no match
Jan  2 17:05:33 www postfix/smtpd[6523]: match_list_match: mail-lb0-f180.google.com: no match
Jan  2 17:05:33 www postfix/smtpd[6523]: match_list_match: 209.85.217.180: no match
Jan  2 17:05:33 www postfix/smtpd[6523]: smtp_stream_setup: maxtime=300 enable_deadline=0
Jan  2 17:05:33 www postfix/smtpd[6523]: match_hostname: mail-lb0-f180.google.com ~? 127.0.0.0/8
Jan  2 17:05:33 www postfix/smtpd[6523]: match_hostaddr: 209.85.217.180 ~? 127.0.0.0/8
Jan  2 17:05:33 www postfix/smtpd[6523]: match_hostname: mail-lb0-f180.google.com ~? [::ffff:127.0.0.0]/104
Jan  2 17:05:33 www postfix/smtpd[6523]: match_hostaddr: 209.85.217.180 ~? [::ffff:127.0.0.0]/104
Jan  2 17:05:33 www postfix/smtpd[6523]: match_hostname: mail-lb0-f180.google.com ~? [::1]/128
Jan  2 17:05:33 www postfix/smtpd[6523]: match_hostaddr: 209.85.217.180 ~? [::1]/128
Jan  2 17:05:33 www postfix/smtpd[6523]: match_list_match: mail-lb0-f180.google.com: no match
Jan  2 17:05:33 www postfix/smtpd[6523]: match_list_match: 209.85.217.180: no match
Jan  2 17:05:33 www postfix/smtpd[6523]: auto_clnt_open: connected to private/anvil
Jan  2 17:05:33 www postfix/smtpd[6523]: send attr request = connect
Jan  2 17:05:33 www postfix/smtpd[6523]: send attr ident = smtp:209.85.217.180
Jan  2 17:05:33 www postfix/smtpd[6523]: private/anvil: wanted attribute: status
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: status
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute value: 0
Jan  2 17:05:33 www postfix/smtpd[6523]: private/anvil: wanted attribute: count
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: count
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute value: 1
Jan  2 17:05:33 www postfix/smtpd[6523]: private/anvil: wanted attribute: rate
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: rate
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute value: 1
Jan  2 17:05:33 www postfix/smtpd[6523]: private/anvil: wanted attribute: (list terminator)
Jan  2 17:05:33 www postfix/smtpd[6523]: input attribute name: (end)
Jan  2 17:05:33 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 220 www.STEMSharp.com ESMTP Postfix (Ubuntu)
Jan  2 17:05:34 www postfix/smtpd[6523]: < mail-lb0-f180.google.com[209.85.217.180]: EHLO mail-lb0-f180.google.com
Jan  2 17:05:34 www postfix/smtpd[6523]: match_list_match: mail-lb0-f180.google.com: no match
Jan  2 17:05:34 www postfix/smtpd[6523]: match_list_match: 209.85.217.180: no match
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-www.STEMSharp.com
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-PIPELINING
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-SIZE 10240000
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-VRFY
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-ETRN
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-STARTTLS
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-ENHANCEDSTATUSCODES
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-8BITMIME
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250 DSN
Jan  2 17:05:34 www postfix/smtpd[6523]: < mail-lb0-f180.google.com[209.85.217.180]: STARTTLS
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 220 2.0.0 Ready to start TLS
Jan  2 17:05:34 www postfix/smtpd[6523]: send attr request = seed
Jan  2 17:05:34 www postfix/smtpd[6523]: send attr size = 32
Jan  2 17:05:34 www postfix/smtpd[6523]: private/tlsmgr: wanted attribute: status
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute name: status
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute value: 0
Jan  2 17:05:34 www postfix/smtpd[6523]: private/tlsmgr: wanted attribute: seed
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute name: seed
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute value: ssfkFHQKs5nqoNDwltmJ8cO4LwPaDfgUDqiwex85wLc=
Jan  2 17:05:34 www postfix/smtpd[6523]: private/tlsmgr: wanted attribute: (list terminator)
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute name: (end)
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_create: SASL service=smtp, realm=(null)
Jan  2 17:05:34 www postfix/smtpd[6523]: name_mask: noanonymous
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_connect: Connecting
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_connect: auth reply: VERSION?1?1
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_connect: auth reply: MECH?PLAIN?plaintext
Jan  2 17:05:34 www postfix/smtpd[6523]: name_mask: plaintext
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_connect: auth reply: MECH?LOGIN?plaintext
Jan  2 17:05:34 www postfix/smtpd[6523]: name_mask: plaintext
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_connect: auth reply: SPID?6331
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_connect: auth reply: CUID?9
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_connect: auth reply: COOKIE?d2bcf52c88b2f735720bd1100244cdf6
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_connect: auth reply: DONE
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_mech_filter: keep mechanism: PLAIN
Jan  2 17:05:34 www postfix/smtpd[6523]: xsasl_dovecot_server_mech_filter: keep mechanism: LOGIN
Jan  2 17:05:34 www postfix/smtpd[6523]: < mail-lb0-f180.google.com[209.85.217.180]: EHLO mail-lb0-f180.google.com
Jan  2 17:05:34 www postfix/smtpd[6523]: match_list_match: mail-lb0-f180.google.com: no match
Jan  2 17:05:34 www postfix/smtpd[6523]: match_list_match: 209.85.217.180: no match
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-www.STEMSharp.com
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-PIPELINING
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-SIZE 10240000
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-VRFY
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-ETRN
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-AUTH PLAIN LOGIN
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-ENHANCEDSTATUSCODES
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250-8BITMIME
Jan  2 17:05:34 www postfix/smtpd[6523]: > mail-lb0-f180.google.com[209.85.217.180]: 250 DSN
Jan  2 17:05:34 www postfix/smtpd[6523]: < mail-lb0-f180.google.com[209.85.217.180]: MAIL FROM: <[email protected]>Jan  2 17:05:34 www postfix/smtpd[6523]: extract_addr: input: <[email protected]>Jan  2 17:05:34 www postfix/smtpd[6523]: smtpd_check_addr: [email protected]
Jan  2 17:05:34 www postfix/smtpd[6523]: connect to subsystem private/rewrite
Jan  2 17:05:34 www postfix/smtpd[6523]: send attr request = rewrite
Jan  2 17:05:34 www postfix/smtpd[6523]: send attr rule = local
Jan  2 17:05:34 www postfix/smtpd[6523]: send attr address = [email protected]
Jan  2 17:05:34 www postfix/smtpd[6523]: private/rewrite socket: wanted attribute: flags
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute name: flags
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute value: 0
Jan  2 17:05:34 www postfix/smtpd[6523]: private/rewrite socket: wanted attribute: address
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute name: address
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute value: [email protected]
Jan  2 17:05:34 www postfix/smtpd[6523]: private/rewrite socket: wanted attribute: (list terminator)
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute name: (end)
Jan  2 17:05:34 www postfix/smtpd[6523]: rewrite_clnt: local: [email protected] -> [email protected]
Jan  2 17:05:34 www postfix/smtpd[6523]: send attr request = resolve
Jan  2 17:05:34 www postfix/smtpd[6523]: send attr sender = 
Jan  2 17:05:34 www postfix/smtpd[6523]: send attr address = [email protected]
Jan  2 17:05:34 www postfix/smtpd[6523]: private/rewrite socket: wanted attribute: flags
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute name: flags
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute value: 0
Jan  2 17:05:34 www postfix/smtpd[6523]: private/rewrite socket: wanted attribute: transport
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute name: transport
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute value: smtp
Jan  2 17:05:34 www postfix/smtpd[6523]: private/rewrite socket: wanted attribute: nexthop
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute name: nexthop
Jan  2 17:05:34 www postfix/smtpd[6523]: input attribute value: gmail.com
Jan  2 17:05:35 www postfix/cleanup[6526]: D9A3816DEE: message-id= <[email protected]om>Jan  2 17:05:35 www postfix/qmgr[6481]: D9A3816DEE: from=<[email protected]>, size=2575, nrcpt=1 (queue active)
Jan  2 17:05:35 www postfix/error[6528]: D9A3816DEE: to=<[email protected]>, relay=none, delay=0.44, delays=0.43/0.01/0/0, dsn=4.4.1, status=deferred (delivery temporarily suspended: connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory)
Jan  2 17:05:39 www postfix/smtpd[6523]: auto_clnt_close: disconnect private/tlsmgr stream
Jan  2 17:05:39 www postfix/smtpd[6523]: rewrite stream disconnect</[email protected]></[email protected]></[email protected]om></[email protected]></[email protected]></[email protected]></[email protected]></[email protected]></[email protected]></[email protected]></[email protected]></[email protected]></[email protected]> 

> Jan 2 17:05:35 www postfix/error[6528]: D9A3816DEE: to=<[email protected]>, relay=none, delay=0.44, delays=0.43/0.01/0/0, dsn=4.4.1, status=deferred (delivery temporarily suspended: connect to www.STEMSharp.com[private/dovecot-lmtp]: No such file or directory) You've configured postfix to use dovecot for local delivery but haven't configured it properly.

I redid some of the config files again and it appears to be working now. I do have one follow up question. How do I get the postfix and dovecot logs to output to the same file. I was comparing the output of both systems in two seperate logs

postfix

/var/log/mail.log

dovecot

/var/log/dovecot.log

what a chore! thanks for all that contributed to the thread!

I found this thread searching for a solution to the exact same problem. I poked around some more in 10-master.cf and figured out that I had set up the unix_listener for lmtp incorrectly.

Mine was:

service lmtp {
  unix_listener lmtp {
    mode = 0600
    user = postfix
    group = postfix
   }
  }

When it should have been:

service lmtp {
  unix_listener /var/spool/postfix/private/dovecot-lmtp {
    mode = 0600
    user = postfix
    group = postfix
   }
  }

The error codes started changing after that, and I ran into the issue described in the Linode guide (~~[https://www.linode.com/docs/email/postfix/email-with-postfix-dovecot-and-mysql" target="_blank">](https://www.linode.com/docs/email/postf … -and-mysql">https://www.linode.com/docs/email/postfix/email-with-postfix-dovecot-and-mysql]() regarding the Postmaster address.

Hope this helps someone!

Reply

Please enter an answer
Tips:

You can mention users to notify them: @username

You can use Markdown to format your question. For more examples see the Markdown Cheatsheet.

> I’m a blockquote.

I’m a blockquote.

[I'm a link] (https://www.google.com)

I'm a link

**I am bold** I am bold

*I am italicized* I am italicized

Community Code of Conduct