Problem sending email through new email server

bigben747 · 01-25-2009, 04:48 PM

Hi,

I have done some google searching on a problem I am having with sending a test email from my new linux server.

I have a CentOS server. With Squirrelmail, postfix, dovecot, and saslauthd.

Here is a list of errors I get when I want to send to hotmail:

Code:

an 25 17:17:55 main dovecot: pop3-login: Disconnected: rip=::ffff:72.148.227.156, lip=::ffff:72.148.227.156, secured
Jan 25 17:18:01 main dovecot: pop3-login: Disconnected: rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:18:01 main postfix/smtpd[7137]: warning: dict_nis_init: NIS domain name not set - NIS lookups disabled
Jan 25 17:18:01 main postfix/smtpd[7137]: connect from localhost.localdomain[127.0.0.1]
Jan 25 17:18:01 main postfix/smtpd[7137]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 25 17:18:01 main postfix/smtpd[7137]: disconnect from localhost.localdomain[127.0.0.1]
Jan 25 17:18:02 main postfix/smtpd[7137]: connect from localhost.localdomain[127.0.0.1]
Jan 25 17:18:02 main postfix/smtpd[7137]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 25 17:18:02 main postfix/smtpd[7137]: disconnect from localhost.localdomain[127.0.0.1]
Jan 25 17:18:02 main dovecot: pop3-login: Disconnected: rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:18:09 main postfix/smtp[7129]: connect to mx3.hotmail.com[65.55.37.120]: Connection timed out (port 25)
Jan 25 17:18:39 main postfix/smtp[7129]: connect to mx4.hotmail.com[65.55.37.88]: Connection timed out (port 25)
Jan 25 17:19:09 main postfix/smtp[7129]: connect to mx2.hotmail.com[65.55.37.120]: Connection timed out (port 25)
Jan 25 17:19:38 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:19:38 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:19:39 main postfix/smtp[7129]: connect to mx3.hotmail.com[65.54.244.72]: Connection timed out (port 25)
Jan 25 17:19:39 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:19:39 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:19:39 main postfix/smtp[7129]: CFB9626C8076: to=<bjwalden898@hotmail.com>, relay=none, delay=150, delays=0.06/0.01/150/0, dsn=4.4.1, status=deferred (connect to mx3.hotmail.com[65.54.244.72]: Connection timed out)
Jan 25 17:19:39 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:19:39 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:19:49 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:19:49 main postfix/pickup[6962]: 3288D26C807D: uid=48 from=<tiger@localhost>
Jan 25 17:19:49 main postfix/cleanup[7243]: 3288D26C807D: message-id=<4095.192.168.1.64.1232921989.squirrel@main.benswebsite.org>
Jan 25 17:19:49 main postfix/qmgr[6963]: 3288D26C807D: from=<tiger@localhost.benswebsite.org>, size=703, nrcpt=1 (queue active)
Jan 25 17:19:49 main postfix/local[7247]: warning: dict_nis_init: NIS domain name not set - NIS lookups disabled
Jan 25 17:19:49 main postfix/local[7247]: 3288D26C807D: to=<ben@benswebsite.org>, relay=local, delay=0.08, delays=0.05/0.01/0/0.02, dsn=2.0.0, status=sent (delivered to mailbox)
Jan 25 17:19:49 main postfix/qmgr[6963]: 3288D26C807D: removed
Jan 25 17:19:49 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:19:49 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:19:49 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:19:50 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:19:50 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:20:37 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:20:37 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:22:44 main dovecot: pop3-login: Disconnected: rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:22:44 main postfix/smtpd[7311]: warning: dict_nis_init: NIS domain name not set - NIS lookups disabled
Jan 25 17:22:44 main postfix/smtpd[7311]: connect from localhost.localdomain[127.0.0.1]
Jan 25 17:22:44 main postfix/smtpd[7311]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 25 17:22:44 main postfix/smtpd[7311]: disconnect from localhost.localdomain[127.0.0.1]
Jan 25 17:23:18 main postfix/smtpd[7311]: connect from localhost.localdomain[127.0.0.1]
Jan 25 17:23:18 main postfix/smtpd[7311]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 25 17:23:18 main postfix/smtpd[7311]: disconnect from localhost.localdomain[127.0.0.1]
Jan 25 17:23:18 main dovecot: pop3-login: Disconnected: rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:23:56 main postfix/postfix-script: stopping the Postfix mail system
Jan 25 17:23:56 main postfix/master[6960]: terminating on signal 15
Jan 25 17:23:56 main dovecot: Killed with signal 15
Jan 25 17:25:38 main postfix/postfix-script: starting the Postfix mail system
Jan 25 17:25:38 main postfix/master[4418]: daemon started -- version 2.3.3, configuration /etc/postfix
Jan 25 17:26:54 main postfix/smtpd[5648]: warning: dict_nis_init: NIS domain name not set - NIS lookups disabled
Jan 25 17:26:54 main postfix/smtpd[5648]: connect from localhost.localdomain[127.0.0.1]
Jan 25 17:26:54 main postfix/smtpd[5648]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 25 17:26:54 main postfix/smtpd[5648]: disconnect from localhost.localdomain[127.0.0.1]
Jan 25 17:27:32 main postfix/postfix-script: fatal: the Postfix mail system is already running
Jan 25 17:27:51 main dovecot: Dovecot v1.0.7 starting up
Jan 25 17:27:57 main postfix/postfix-script: fatal: the Postfix mail system is already running
Jan 25 17:28:18 main postfix/postfix-script: stopping the Postfix mail system
Jan 25 17:28:18 main postfix/master[4418]: terminating on signal 15
Jan 25 17:28:20 main postfix/postfix-script: starting the Postfix mail system
Jan 25 17:28:20 main postfix/master[5824]: daemon started -- version 2.3.3, configuration /etc/postfix
Jan 25 17:28:42 main dovecot: pop3-login: Disconnected: rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:28:42 main postfix/smtpd[5903]: warning: dict_nis_init: NIS domain name not set - NIS lookups disabled
Jan 25 17:28:42 main postfix/smtpd[5903]: connect from localhost.localdomain[127.0.0.1]
Jan 25 17:28:42 main postfix/smtpd[5903]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 25 17:28:42 main postfix/smtpd[5903]: disconnect from localhost.localdomain[127.0.0.1]
Jan 25 17:28:53 main dovecot: imap-login: Login: user=<ben>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:28:53 main dovecot: IMAP(ben): mbox: Can't create root mail directory /home/ben/mail: Permission denied
Jan 25 17:28:53 main dovecot: IMAP(ben): mail_location not set and autodetection failed with home=/home/ben
Jan 25 17:28:53 main dovecot: child 5907 (imap) returned error 89
Jan 25 17:29:56 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:29:56 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:29:57 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:29:57 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:29:57 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:29:57 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:29:58 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:29:58 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:30:10 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:30:10 main postfix/pickup[5826]: A3C3526C807E: uid=48 from=<tiger@localhost>
Jan 25 17:30:10 main postfix/cleanup[5980]: A3C3526C807E: message-id=<4237.192.168.1.64.1232922610.squirrel@main.benswebsite.org>
Jan 25 17:30:10 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:30:10 main postfix/qmgr[5827]: A3C3526C807E: from=<tiger@localhost.benswebsite.org>, size=697, nrcpt=1 (queue active)
Jan 25 17:30:10 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:30:10 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:30:12 main dovecot: imap-login: Login: user=<tiger>, method=PLAIN, rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:30:12 main dovecot: IMAP(tiger): Disconnected: Logged out
Jan 25 17:30:41 main postfix/smtp[5984]: connect to mx4.hotmail.com[65.54.244.104]: Connection timed out (port 25)
Jan 25 17:31:11 main postfix/smtp[5984]: connect to mx4.hotmail.com[65.55.37.88]: Connection timed out (port 25)
Jan 25 17:31:41 main postfix/smtp[5984]: connect to mx2.hotmail.com[65.55.37.88]: Connection timed out (port 25)
Jan 25 17:32:11 main postfix/smtp[5984]: connect to mx1.hotmail.com[65.55.37.104]: Connection timed out (port 25)
Jan 25 17:32:41 main postfix/smtp[5984]: connect to mx4.hotmail.com[65.54.245.104]: Connection timed out (port 25)
Jan 25 17:32:41 main postfix/smtp[5984]: A3C3526C807E: to=<bjwalden898@hotmail.com>, relay=none, delay=150, delays=0.15/0.07/150/0, dsn=4.4.1, status=deferred (connect to mx4.hotmail.com[65.54.245.104]: Connection timed out)
Jan 25 17:35:51 main dovecot: pop3-login: Disconnected: rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:35:51 main postfix/smtpd[6180]: warning: dict_nis_init: NIS domain name not set - NIS lookups disabled
Jan 25 17:35:51 main postfix/smtpd[6180]: connect from localhost.localdomain[127.0.0.1]
Jan 25 17:35:51 main postfix/smtpd[6180]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 25 17:35:51 main postfix/smtpd[6180]: disconnect from localhost.localdomain[127.0.0.1]
Jan 25 17:35:52 main postfix/smtpd[6180]: connect from localhost.localdomain[127.0.0.1]
Jan 25 17:35:52 main postfix/smtpd[6180]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 25 17:35:52 main postfix/smtpd[6180]: disconnect from localhost.localdomain[127.0.0.1]
Jan 25 17:35:52 main dovecot: pop3-login: Disconnected: rip=::ffff:127.0.0.1, lip=::ffff:127.0.0.1, secured
Jan 25 17:38:36 main dovecot: pop3-login: Aborted login: rip=::ffff:72.148.227.156, lip=::ffff:72.148.227.156, secured
Jan 25 17:38:41 main postfix/smtpd[6224]: warning: dict_nis_init: NIS domain name not set - NIS lookups disabled
Jan 25 17:38:41 main postfix/smtpd[6224]: connect from phpmyadmin[72.148.227.156]
Jan 25 17:39:27 main postfix/smtpd[6224]: disconnect from phpmyadmin[72.148.227.156]
Jan 25 17:45:00 main postfix/qmgr[5827]: CFB9626C8076: from=<tiger@localhost.benswebsite.org>, size=709, nrcpt=1 (queue active)
Jan 25 17:45:30 main postfix/smtp[6321]: connect to mx1.hotmail.com[65.54.244.136]: Connection timed out (port 25)

szacks · 01-26-2009, 12:28 AM

The only relevant lines in the log are the ones that say:
Jan 25 17:30:41 main postfix/smtp[5984]: connect to mx4.hotmail.com[65.54.244.104]: Connection timed out (port 25)

It seems that Hotmail (and a number of other mail servers) will not accept mail from a local (unknown) mail server. This is to protect their users from spam.
The easiest thing (and most reliable) is to use a smarthost.
See http://ubuntu.wordpress.com/2005/09/...st-in-postfix/
for details.

If you really want to send from your local server, you will have to setup MX and A records for your static IP address. Even with that, you will probably have problems with sending because if someone on your ISP gets on a black list they block off a whole segment of IPs, whcih you then have to go and remove yourself from.

Sim

bigben747 · 01-26-2009, 06:03 AM

I am now getting this when I edited the config in postfix.

Jan 26 06:55:13 main postfix/postfix-script: starting the Postfix mail system
Jan 26 06:55:13 main postfix/master[13742]: daemon started -- version 2.3.3, configuration /etc/postfix
Jan 26 06:56:50 main postfix/smtpd[13768]: warning: dict_nis_init: NIS domain name not set - NIS lookups disabled
Jan 26 06:56:50 main postfix/smtpd[13768]: connect from localhost.localdomain[127.0.0.1]
Jan 26 06:56:50 main postfix/smtpd[13768]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 26 06:56:50 main postfix/smtpd[13768]: disconnect from localhost.localdomain[127.0.0.1]
Jan 26 06:57:07 main dovecot: Dovecot v1.0.7 starting up
Jan 26 06:57:07 main dovecot: auth(default): dovecot-auth: error while loading shared libraries: libmysqlclient.so.15: cannot open shared object file: No such file or directory
Jan 26 06:57:07 main dovecot: Auth process died too early - shutting down
Jan 26 06:57:10 main postfix/smtpd[13768]: connect from localhost.localdomain[127.0.0.1]
Jan 26 06:57:10 main postfix/smtpd[13768]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 26 06:57:10 main postfix/smtpd[13768]: disconnect from localhost.localdomain[127.0.0.1]
Jan 26 06:57:12 main postfix/smtpd[13768]: connect from localhost.localdomain[127.0.0.1]
Jan 26 06:57:12 main postfix/smtpd[13768]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 26 06:57:12 main postfix/smtpd[13768]: disconnect from localhost.localdomain[127.0.0.1]
Jan 26 06:57:56 main postfix/smtpd[13768]: connect from localhost.localdomain[127.0.0.1]
Jan 26 06:57:56 main postfix/smtpd[13768]: lost connection after CONNECT from localhost.localdomain[127.0.0.1]
Jan 26 06:57:56 main postfix/smtpd[13768]: disconnect from localhost.localdomain[127.0.0.1]

bigben747 · 01-26-2009, 05:16 PM

*UPDATE*

I just noticed this in my log file:

Jan 26 07:11:53 main postfix/smtp[14099]: warning: relayhost configuration problem
Jan 26 07:11:53 main postfix/smtp[14099]: A3C3526C807E: to=<bjwalden898@hotmail.com>, relay=none, delay=49303, delays=49303/0.04/0.15/0, dsn=4.3.5, status=deferred (mail for email.benswebsite.org loops back to myself)
Jan 26 07:11:53 main postfix/smtp[14100]: warning: relayhost configuration problem
Jan 26 07:11:53 main postfix/smtp[14100]: 958B726C8082: to=<bjwalden898@hotmail.com>, relay=none, delay=44523, delays=44523/0.04/0.17/0, dsn=4.3.5, status=deferred (mail for email.benswebsite.org loops back to myself)
Jan 26 07:45:13 main postfix/qmgr[13745]: CFB9626C8076: from=<tiger@localhost.benswebsite.org>, size=709, nrcpt=1 (queue active)
Jan 26 07:45:14 main postfix/smtp[14420]: warning: relayhost configuration problem
Jan 26 07:45:14 main postfix/smtp[14420]: CFB9626C8076: to=<bjwalden898@hotmail.com>, relay=none, delay=52085, delays=52085/0.02/0.23/0, dsn=4.3.5, status=deferred (mail for email.benswebsite.org loops back to myself)
Jan 26 08:18:33 main postfix/qmgr[13745]: A3C3526C807E: from=<tiger@localhost.benswebsite.org>, size=697, nrcpt=1 (queue active)
Jan 26 08:18:33 main postfix/qmgr[13745]: 958B726C8082: from=<tiger@localhost.benswebsite.org>, size=705, nrcpt=1 (queue active)

I went to that website link the last person posted, and followed those steps, but not these are coming up.
And now I get through webmail:
Error connecting to IMAP server: localhost.
111 : Connection refused

I restated dovecot, postfix, and saslauthd.