Help, mail will not send/receive

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

  1. rlischer

    rlischer Member

    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

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

    rlischer Member

    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

    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([email protected]): 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([email protected]): 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([email protected]): 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([email protected]): 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([email protected]): 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

    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([email protected]): sieve: msgid=<[email protected]>: 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, [email protected]
    Oct 3 17:43:33 server postfix/cleanup[7141]: 67A6A224E8: message-id=<[email protected]>
    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=<[email protected]>
    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: <[email protected]>, 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([email protected]): sieve: msgid=<[email protected]>: 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([email protected]): 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([email protected]): 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([email protected]): 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([email protected]): 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([email protected]): 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

    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

    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

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

    rlischer Member

    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([email protected]): Disconnected: Logged out bytes=535/3743
    Oct 5 12:57:29 server dovecot: imap([email protected]): 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

    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

    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

    Thanks for looking!
     

Share This Page