Help, mail will not send/receive

Discussion in 'Installation/Configuration' started by rlischer, Sep 29, 2012.

  1. rlischer

    rlischer Member HowtoForge Supporter

    I am running Ubuntu 12.04 on Amazon ec2 and everything seems to work except mail. Here is my log:

    Code:
    Sep 29 20:45:01 ip-10-243-150-85 dovecot: pop3-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Sep 29 20:45:01 ip-10-243-150-85 dovecot: imap-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Sep 29 20:45:02 ip-10-243-150-85 postfix/smtps/smtpd[6862]: connect from localhost[127.0.0.1]
    Sep 29 20:45:02 ip-10-243-150-85 postfix/smtps/smtpd[6862]: SSL_accept error from localhost[127.0.0.1]: lost connection
    Sep 29 20:45:02 ip-10-243-150-85 postfix/smtps/smtpd[6862]: lost connection after CONNECT from localhost[127.0.0.1]
    Sep 29 20:45:02 ip-10-243-150-85 postfix/smtps/smtpd[6862]: disconnect from localhost[127.0.0.1]
    Sep 29 20:49:38 ip-10-243-150-85 postfix/smtps/smtpd[6945]: connect from localhost[127.0.0.1]
    Sep 29 20:50:01 ip-10-243-150-85 postfix/smtps/smtpd[6973]: connect from localhost[127.0.0.1]
    Sep 29 20:50:01 ip-10-243-150-85 postfix/smtps/smtpd[6973]: SSL_accept error from localhost[127.0.0.1]: lost connection
    Sep 29 20:50:01 ip-10-243-150-85 postfix/smtps/smtpd[6973]: lost connection after CONNECT from localhost[127.0.0.1]
    Sep 29 20:50:01 ip-10-243-150-85 postfix/smtps/smtpd[6973]: disconnect from localhost[127.0.0.1]
    Sep 29 20:50:02 ip-10-243-150-85 dovecot: pop3-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Sep 29 20:50:02 ip-10-243-150-85 dovecot: imap-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Sep 29 20:51:36 ip-10-243-150-85 postfix/smtps/smtpd[6973]: connect from mail-wg0-f44.google.com[74.125.82.44]
    
     
  2. falko

    falko Super Moderator Howtoforge Staff Moderator HowtoForge Supporter ISPConfig Developer

    There seems to be a problem with your SSL cert. Have you tried to recreate it with the default values?
     
  3. rlischer

    rlischer Member HowtoForge Supporter

    If it's the same SSL cert I make when installing PureFTP I get this error on this line: "sudo echo 1 > /etc/pure-ftpd/conf/TLS" then I get Permission Denied every time. Would this cause my SSL problem?

    thanks
     
  4. rlischer

    rlischer Member HowtoForge Supporter

    I recreated my SSL Cert. Here is my new log:

    Code:
    Oct 1 19:08:54 ip-10-245-83-208 postfix/smtps/smtpd[2617]: lost connection after CONNECT from localhost[127.0.0.1]
    Oct 1 19:08:54 ip-10-245-83-208 postfix/smtps/smtpd[2617]: disconnect from localhost[127.0.0.1]
    Oct 1 19:08:54 ip-10-245-83-208 dovecot: auth-worker: mysql(localhost): Connected to database dbispconfig
    Oct 1 19:08:54 ip-10-245-83-208 dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=2707, secured
    Oct 1 19:08:54 ip-10-245-83-208 dovecot: imap(rob@fatbikes.org): Disconnected: Logged out bytes=79/687
    Oct 1 19:10:02 ip-10-245-83-208 postfix/smtps/smtpd[2617]: connect from localhost[127.0.0.1]
    Oct 1 19:10:02 ip-10-245-83-208 postfix/smtps/smtpd[2617]: SSL_accept error from localhost[127.0.0.1]: lost connection
    Oct 1 19:10:02 ip-10-245-83-208 postfix/smtps/smtpd[2617]: lost connection after CONNECT from localhost[127.0.0.1]
    Oct 1 19:10:02 ip-10-245-83-208 postfix/smtps/smtpd[2617]: disconnect from localhost[127.0.0.1]
    Oct 1 19:10:02 ip-10-245-83-208 dovecot: pop3-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Oct 1 19:10:02 ip-10-245-83-208 dovecot: imap-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Oct 1 19:14:35 ip-10-245-83-208 dovecot: pop3-login: Disconnected: Inactivity (no auth attempts): rip=54.243.225.199, lip=10.245.83.208, TLS
    Oct 1 19:14:46 ip-10-245-83-208 dovecot: auth-worker: mysql(localhost): Connected to database dbispconfig
    Oct 1 19:14:46 ip-10-245-83-208 dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=2807, secured
    Oct 1 19:14:46 ip-10-245-83-208 dovecot: imap(rlischer@fatbikes.org): Disconnected: Logged out bytes=44/709
    Oct 1 19:14:46 ip-10-245-83-208 dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=2809, secured
    Oct 1 19:14:46 ip-10-245-83-208 dovecot: imap(rlischer@fatbikes.org): Disconnected: Logged out bytes=386/1275
    Oct 1 19:14:46 ip-10-245-83-208 dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=2811, secured
    Oct 1 19:14:46 ip-10-245-83-208 dovecot: imap(rlischer@fatbikes.org): Disconnected: Logged out bytes=117/1401
    Oct 1 19:14:48 ip-10-245-83-208 dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=2813, secured
    Oct 1 19:14:48 ip-10-245-83-208 dovecot: imap(rlischer@fatbikes.org): Disconnected: Logged out bytes=79/687
    Oct 1 19:14:58 ip-10-245-83-208 postfix/smtps/smtpd[2814]: connect from localhost[127.0.0.1]
    Oct 1 19:15:01 ip-10-245-83-208 dovecot: pop3-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    
     
  5. rlischer

    rlischer Member HowtoForge Supporter

    update. It appears that I can send/receive email to myself using Outlook with SSL turned on. I can also send email to my gmail account, but if I reply in gmail it never makes it back to me.

    Any ideas?

    New log:
    Code:
    Oct 3 17:43:24 server postfix/smtp[7142]: 7BC62224E8: to=, relay=127.0.0.1[127.0.0.1]:10024, delay=0.41, delays=0.14/0/0.03/0.24, dsn=2.0.0, status=sent (250 2.0.0 from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as D09B522557)
    Oct 3 17:43:24 server postfix/qmgr[1633]: 7BC62224E8: removed
    Oct 3 17:43:25 server dovecot: lda(rob@fatbikes.org): sieve: msgid=<000d01cda18e$e13c3620$a3b4a260$@fatbikes.org>: stored mail into mailbox 'INBOX'
    Oct 3 17:43:25 server postfix/pipe[7165]: D09B522557: to=, relay=dovecot, delay=0.15, delays=0.01/0.04/0/0.1, dsn=2.0.0, status=sent (delivered via dovecot service)
    Oct 3 17:43:25 server postfix/qmgr[1633]: D09B522557: removed
    Oct 3 17:43:27 server postfix/smtps/smtpd[7162]: disconnect from unknown[66.161.136.106]
    Oct 3 17:43:33 server postfix/smtps/smtpd[7162]: warning: hostname Target-Marketing.STATIC.fuse.net does not resolve to address 66.161.136.106: Name or service not known
    Oct 3 17:43:33 server postfix/smtps/smtpd[7162]: connect from unknown[66.161.136.106]
    Oct 3 17:43:33 server postfix/smtps/smtpd[7162]: 67A6A224E8: client=unknown[66.161.136.106], sasl_method=LOGIN, sasl_username=rob@fatbikes.org
    Oct 3 17:43:33 server postfix/cleanup[7141]: 67A6A224E8: message-id=<001d01cda18e$e68f4770$b3add650$@fatbikes.org>
    Oct 3 17:43:33 server postfix/qmgr[1633]: 67A6A224E8: from=, size=3694, nrcpt=1 (queue active)
    Oct 3 17:43:33 server amavis[1337]: (01337-03) (!!)file(1) utility (/usr/bin/file) FAILED: run_command: can't fork: Cannot allocate memory at /usr/sbin/amavisd-new line 3081, line 277.
    Oct 3 17:43:34 server postfix/smtpd[7116]: connect from localhost.localdomain[127.0.0.1]
    Oct 3 17:43:34 server postfix/smtpd[7116]: 27E8822557: client=localhost.localdomain[127.0.0.1]
    Oct 3 17:43:34 server postfix/cleanup[7141]: 27E8822557: message-id=<001d01cda18e$e68f4770$b3add650$@fatbikes.org>
    Oct 3 17:43:34 server postfix/qmgr[1633]: 27E8822557: from=, size=4158, nrcpt=1 (queue active)
    Oct 3 17:43:34 server postfix/smtpd[7116]: disconnect from localhost.localdomain[127.0.0.1]
    Oct 3 17:43:34 server amavis[1337]: (01337-03) Passed CLEAN, [66.161.136.106] [66.161.136.106] -> , Message-ID: <001d01cda18e$e68f4770$b3add650$@fatbikes.org>, mail_id: PNZBsyB9U94K, Hits: -0.999, size: 3694, queued_as: 27E8822557, 685 ms
    Oct 3 17:43:34 server postfix/smtp[7142]: 67A6A224E8: to=, relay=127.0.0.1[127.0.0.1]:10024, delay=0.82, delays=0.12/0/0/0.7, dsn=2.0.0, status=sent (250 2.0.0 from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 27E8822557)
    Oct 3 17:43:34 server postfix/qmgr[1633]: 67A6A224E8: removed
    Oct 3 17:43:34 server dovecot: lda(rob@fatbikes.org): sieve: msgid=<001d01cda18e$e68f4770$b3add650$@fatbikes.org>: stored mail into mailbox 'INBOX'
    Oct 3 17:43:34 server postfix/pipe[7165]: 27E8822557: to=, relay=dovecot, delay=0.12, delays=0.02/0/0/0.1, dsn=2.0.0, status=sent (delivered via dovecot service)
    Oct 3 17:43:34 server postfix/qmgr[1633]: 27E8822557: removed
    Oct 3 17:43:36 server postfix/smtps/smtpd[7162]: disconnect from unknown[66.161.136.106]
    Oct 3 17:43:49 server dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=7170, secured
    Oct 3 17:43:49 server dovecot: imap(rob@fatbikes.org): Disconnected: Logged out bytes=44/709
    Oct 3 17:43:49 server dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=7172, secured
    Oct 3 17:43:50 server dovecot: imap(rob@fatbikes.org): Disconnected: Logged out bytes=449/4107
    Oct 3 17:43:50 server dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=7174, secured
    Oct 3 17:43:50 server dovecot: imap(rob@fatbikes.org): Disconnected: Logged out bytes=300/1395
    Oct 3 17:43:56 server dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=7176, secured
    Oct 3 17:43:56 server dovecot: imap(rob@fatbikes.org): Disconnected: Logged out bytes=143/2566
    Oct 3 17:44:00 server dovecot: imap-login: Login: user=, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=7178, secured
    Oct 3 17:44:00 server dovecot: imap(rob@fatbikes.org): Disconnected: Logged out bytes=143/2566
    Oct 3 17:44:12 server postfix/smtps/smtpd[7162]: connect from localhost.localdomain[127.0.0.1]
    
     
  6. falko

    falko Super Moderator Howtoforge Staff Moderator HowtoForge Supporter ISPConfig Developer

    Please check if the MX record of your domain is pointing to the correct server. You can check that as follows:
    Code:
    dig mx yourdomain.com
     
  7. rlischer

    rlischer Member HowtoForge Supporter

    Here is what I get:

    Code:
    Roberts-iMac:~ rlischer$ dig mx fatbikes.org
    
    ; <<>> DiG 9.8.3-P1 <<>> mx fatbikes.org
    ;; global options: +cmd
    ;; Got answer:
    ;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 16129
    ;; flags: qr rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 0, ADDITIONAL: 0
    
    ;; QUESTION SECTION:
    ;fatbikes.org.			IN	MX
    
    ;; ANSWER SECTION:
    fatbikes.org.		300	IN	MX	10 mail.fatbikes.org.
    
    ;; Query time: 108 msec
    ;; SERVER: 192.168.1.1#53(192.168.1.1)
    ;; WHEN: Thu Oct  4 06:42:58 2012
    ;; MSG SIZE  rcvd: 51
    
     
  8. falko

    falko Super Moderator Howtoforge Staff Moderator HowtoForge Supporter ISPConfig Developer

    Does the A record of mail.fatbikes.org point to the correct IP?
     
  9. rlischer

    rlischer Member HowtoForge Supporter

    yes. If you want to log into my EC2 instance and look around I'll send you my key. I am just using ec2 to try to learn my way around. I have never had any problems with ISPConfig 3, so I know if has something to do with Amazon. Either a port of something with SSL.

    More from the mail log:
    Code:
    Oct 5 12:55:05 server postfix/smtps/smtpd[2229]: lost connection after CONNECT from server70.appriver.com[69.20.119.203]
    Oct 5 12:55:05 server postfix/smtps/smtpd[2229]: disconnect from server70.appriver.com[69.20.119.203]
    Oct 5 12:56:52 server dovecot: auth-worker: mysql(localhost): Connected to database dbispconfig
    Oct 5 12:56:52 server dovecot: imap-login: Login: user=, method=PLAIN, rip=66.161.136.106, lip=10.158.26.160, mpid=2338, TLS
    Oct 5 12:56:52 server dovecot: imap-login: Login: user=, method=PLAIN, rip=66.161.136.106, lip=10.158.26.160, mpid=2340, TLS
    Oct 5 12:57:29 server dovecot: imap(rob@fatbikes.org): Disconnected: Logged out bytes=535/3743
    Oct 5 12:57:29 server dovecot: imap(rob@fatbikes.org): Disconnected: Logged out bytes=63/556
    Oct 5 12:57:29 server postfix/smtps/smtpd[2348]: connect from localhost.localdomain[127.0.0.1]
    Oct 5 13:00:02 server dovecot: imap-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Oct 5 13:00:02 server dovecot: pop3-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Oct 5 13:00:02 server postfix/smtps/smtpd[2528]: connect from localhost.localdomain[127.0.0.1]
    Oct 5 13:00:02 server postfix/smtps/smtpd[2528]: SSL_accept error from localhost.localdomain[127.0.0.1]: lost connection
    Oct 5 13:00:02 server postfix/smtps/smtpd[2528]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
    Oct 5 13:00:02 server postfix/smtps/smtpd[2528]: disconnect from localhost.localdomain[127.0.0.1]
    Oct 5 13:00:05 server postfix/smtps/smtpd[2528]: connect from server70.appriver.com[69.20.119.203]
    Oct 5 13:02:29 server postfix/smtps/smtpd[2348]: SSL_accept error from localhost.localdomain[127.0.0.1]: Connection timed out
    Oct 5 13:02:29 server postfix/smtps/smtpd[2348]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
    Oct 5 13:02:29 server postfix/smtps/smtpd[2348]: disconnect from localhost.localdomain[127.0.0.1]
    Oct 5 13:05:02 server dovecot: imap-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Oct 5 13:05:02 server dovecot: pop3-login: Disconnected (no auth attempts): rip=127.0.0.1, lip=127.0.0.1, secured
    Oct 5 13:05:02 server postfix/smtps/smtpd[2793]: connect from localhost.localdomain[127.0.0.1]
    Oct 5 13:05:02 server postfix/smtps/smtpd[2793]: SSL_accept error from localhost.localdomain[127.0.0.1]: lost connection
    Oct 5 13:05:02 server postfix/smtps/smtpd[2793]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
    Oct 5 13:05:02 server postfix/smtps/smtpd[2793]: disconnect from localhost.localdomain[127.0.0.1]
    Oct 5 13:05:05 server postfix/smtps/smtpd[2528]: SSL_accept error from server70.appriver.com[69.20.119.203]: lost connection
    Oct 5 13:05:05 server postfix/smtps/smtpd[2528]: lost connection after CONNECT from server70.appriver.com[69.20.119.203]
    Oct 5 13:05:05 server postfix/smtps/smtpd[2528]: disconnect from server70.appriver.com[69.20.119.203]
    
     
    Last edited: Oct 5, 2012
  10. pititis

    pititis Member

    Hello,

    Can you post the ouput of:

    Code:
     postconf
    Cheers
     
    Last edited: Oct 5, 2012
  11. rlischer

    rlischer Member HowtoForge Supporter

    sure:
    Code:
    ubuntu@server:~$ postconf |grep smtpd_tls_security_level
    postscreen_tls_security_level = $smtpd_tls_security_level
    smtpd_tls_security_level = may
    tlsproxy_tls_security_level = $smtpd_tls_security_level
    postconf: warning: /etc/postfix/master.cf: unused parameter: smtpd_bind_address=                   127.0.0.1
    ubuntu@server:~$
    
     
  12. pititis

    pititis Member

    and:

    Code:
    postconf |grep smtpd |grep tls
    ?
     
  13. rlischer

    rlischer Member HowtoForge Supporter

    oops, sorry:
    Code:
    ubuntu@server:~$ postconf |grep smtpd |grep tls
    postconf: warning: /etc/postfix/master.cf: unused parameter: smtpd_bind_address=127.0.0.1
    postscreen_enforce_tls = $smtpd_enforce_tls
    postscreen_tls_security_level = $smtpd_tls_security_level
    postscreen_use_tls = $smtpd_use_tls
    smtpd_client_new_tls_session_rate_limit = 0
    smtpd_enforce_tls = no
    smtpd_sasl_tls_security_options = $smtpd_sasl_security_options
    smtpd_starttls_timeout = ${stress?10}${stress:300}s
    smtpd_tls_CAfile =
    smtpd_tls_CApath =
    smtpd_tls_always_issue_session_ids = yes
    smtpd_tls_ask_ccert = no
    smtpd_tls_auth_only = no
    smtpd_tls_ccert_verifydepth = 9
    smtpd_tls_cert_file = /etc/postfix/smtpd.cert
    smtpd_tls_ciphers = export
    smtpd_tls_dcert_file =
    smtpd_tls_dh1024_param_file =
    smtpd_tls_dh512_param_file =
    smtpd_tls_dkey_file = $smtpd_tls_dcert_file
    smtpd_tls_eccert_file =
    smtpd_tls_eckey_file = $smtpd_tls_eccert_file
    smtpd_tls_eecdh_grade = strong
    smtpd_tls_exclude_ciphers =
    smtpd_tls_fingerprint_digest = md5
    smtpd_tls_key_file = /etc/postfix/smtpd.key
    smtpd_tls_loglevel = 0
    smtpd_tls_mandatory_ciphers = medium
    smtpd_tls_mandatory_exclude_ciphers =
    smtpd_tls_mandatory_protocols = !SSLv2
    smtpd_tls_protocols =
    smtpd_tls_received_header = no
    smtpd_tls_req_ccert = no
    smtpd_tls_security_level = may
    smtpd_tls_session_cache_database = btree:${data_directory}/smtpd_scache
    smtpd_tls_session_cache_timeout = 3600s
    smtpd_tls_wrappermode = no
    smtpd_use_tls = yes
    tlsproxy_enforce_tls = $smtpd_enforce_tls
    tlsproxy_tls_CAfile = $smtpd_tls_CAfile
    tlsproxy_tls_CApath = $smtpd_tls_CApath
    tlsproxy_tls_always_issue_session_ids = $smtpd_tls_always_issue_session_ids
    tlsproxy_tls_ask_ccert = $smtpd_tls_ask_ccert
    tlsproxy_tls_ccert_verifydepth = $smtpd_tls_ccert_verifydepth
    tlsproxy_tls_cert_file = $smtpd_tls_cert_file
    tlsproxy_tls_ciphers = $smtpd_tls_ciphers
    tlsproxy_tls_dcert_file = $smtpd_tls_dcert_file
    tlsproxy_tls_dh1024_param_file = $smtpd_tls_dh1024_param_file
    tlsproxy_tls_dh512_param_file = $smtpd_tls_dh512_param_file
    tlsproxy_tls_dkey_file = $smtpd_tls_dkey_file
    tlsproxy_tls_eccert_file = $smtpd_tls_eccert_file
    tlsproxy_tls_eckey_file = $smtpd_tls_eckey_file
    tlsproxy_tls_eecdh_grade = $smtpd_tls_eecdh_grade
    tlsproxy_tls_exclude_ciphers = $smtpd_tls_exclude_ciphers
    tlsproxy_tls_fingerprint_digest = $smtpd_tls_fingerprint_digest
    tlsproxy_tls_key_file = $smtpd_tls_key_file
    tlsproxy_tls_loglevel = $smtpd_tls_loglevel
    tlsproxy_tls_mandatory_ciphers = $smtpd_tls_mandatory_ciphers
    tlsproxy_tls_mandatory_exclude_ciphers = $smtpd_tls_mandatory_exclude_ciphers
    tlsproxy_tls_mandatory_protocols = $smtpd_tls_mandatory_protocols
    tlsproxy_tls_protocols = $smtpd_tls_protocols
    tlsproxy_tls_req_ccert = $smtpd_tls_req_ccert
    tlsproxy_tls_security_level = $smtpd_tls_security_level
    tlsproxy_tls_session_cache_timeout = $smtpd_tls_session_cache_timeout
    tlsproxy_use_tls = $smtpd_use_tls
    ubuntu@server:~$
    
     
  14. pititis

    pititis Member

  15. rlischer

    rlischer Member HowtoForge Supporter

    Thanks for looking!
     

Share This Page