HowtoForge Forums | HowtoForge - Linux Howtos and Tutorials

HowtoForge Forums | HowtoForge - Linux Howtos and Tutorials (http://www.howtoforge.com/forums/index.php)
-   HOWTO-Related Questions (http://www.howtoforge.com/forums/forumdisplay.php?f=2)
-   -   Postfix fails to receive mail (http://www.howtoforge.com/forums/showthread.php?t=56084)

satimis 7th February 2012 08:37

Postfix fails to receive mail
 
Hi all,

postfix can send mail but fails to receive mail.

server runs on a VM of Oracle VirtualBox
fixed ip address
hostname - ser01.mydomain.com
On router - ports 25/443/995/80/8080/etc. pointing to 192.168.0.218 (local ip of the server)

I was following;
Virtual Users And Domains With Postfix, Courier, MySQL And SquirrelMail (Ubuntu 11.10)
http://www.howtoforge.com/virtual-us...l-ubuntu-11.10

building this server on ubuntu-10.04 (LTS)


1)
sent 1st mail to server on yahoo mail.
sales@mydomain.com

Failed

# tail /var/log/mail.log
Code:

Feb  7 13:40:11 ser01 amavis[1106]: (01106-02) Passed CLEAN, [98.139.91.228] [xxx.xxx.xxx.xxx] <somebody@yahoo.com> -> <sales@mydomain.com>, Message-ID: <1328593199.63314.YahooMailNeo@web113203.mail.gq1.yahoo.com>, mail_id: c5+qVqqIhNZV, Hits: 0.992, size: 2971, queued_as: 8D257A009E, dkim_id=@yahoo.com,somebody@yahoo.com, 9518 ms
Feb  7 13:40:11 ser01 postfix/smtp[1954]: 78712A0018: to=<sales@mydomain.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=10, delays=0.78/0/0/9.5, dsn=2.0.0, status=sent (250 2.0.0 Ok, id=01106-02, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 8D257A009E)
Feb  7 13:40:11 ser01 postfix/qmgr[1837]: 78712A0018: removed
Feb  7 13:40:11 ser01 postfix/smtp[1960]: 8D257A009E: to=<sales@mydomain.com>, relay=none, delay=0.06, delays=0.02/0/0.04/0, dsn=5.4.4, status=bounced (Host or domain name not found. Name service error for name=mail.mydomain.com type=A: Host not found)
Feb  7 13:40:11 ser01 postfix/cleanup[1953]: 9DD18A009F: message-id=<20120207054011.9DD18A009F@ser01.mydomain.com>
Feb  7 13:40:11 ser01 postfix/bounce[1961]: 8D257A009E: sender non-delivery notification: 9DD18A009F
Feb  7 13:40:11 ser01 postfix/qmgr[1837]: 9DD18A009F: from=<>, size=5501, nrcpt=1 (queue active)
Feb  7 13:40:11 ser01 postfix/qmgr[1837]: 8D257A009E: removed
Feb  7 13:40:14 ser01 postfix/smtp[1960]: 9DD18A009F: to=<somebody@yahoo.com>, relay=mta6.am0.yahoodns.net[66.94.236.34]:25, delay=2.7, delays=0/0/1.1/1.7, dsn=2.0.0, status=sent (250 ok dirdel)
Feb  7 13:40:14 ser01 postfix/qmgr[1837]: 9DD18A009F: removed

2)
sent 2nd mail to server on yahoo mail.
sales@ser01.mydomain.com

# tail /var/log/mail.log
Code:

Feb  7 13:28:06 ser01 postfix/smtpd[1931]: warning: cannot get RSA private key from file /etc/postfix/smtpd.key: disabling TLS support
Feb  7 13:28:06 ser01 postfix/smtpd[1931]: warning: TLS library problem: 1931:error:0906D06C:PEM routines:PEM_read_bio:no start line:pem_lib.c:650:Expecting: ANY PRIVATE KEY:
Feb  7 13:28:06 ser01 postfix/smtpd[1931]: warning: TLS library problem: 1931:error:140B0009:SSL routines:SSL_CTX_use_PrivateKey_file:PEM lib:ssl_rsa.c:669:
Feb  7 13:28:09 ser01 postfix/smtpd[1931]: warning: 122.179.144.143: hostname ABTS-mum-Dynamic-143.144.179.122.airtelbroadband.in verification failed: Name or service not known
Feb  7 13:28:09 ser01 postfix/smtpd[1931]: connect from unknown[122.179.144.143]
Feb  7 13:28:10 ser01 postfix/smtpd[1931]: NOQUEUE: reject: RCPT from unknown[122.179.144.143]: 550 5.1.1 <mydomain@mydomain.com>: Recipient address rejected: User unknown in virtual mailbox table; from=<kphrfysejngwdu@angelpuss.org> to=<mydomain@mydomain.com> proto=SMTP helo=<angelpuss.org>
Feb  7 13:28:10 ser01 postfix/smtpd[1931]: disconnect from unknown[122.179.144.143]
Feb  7 13:31:30 ser01 postfix/anvil[1934]: statistics: max connection rate 1/60s for (smtp:122.179.144.143) at Feb  7 13:28:09
Feb  7 13:31:30 ser01 postfix/anvil[1934]: statistics: max connection count 1 for (smtp:122.179.144.143) at Feb  7 13:28:09
Feb  7 13:31:30 ser01 postfix/anvil[1934]: statistics: max cache size 1 at Feb  7 13:28:09

Pls help. TIA


B.R.
satimis

falko 8th February 2012 20:41

Quote:

Feb 7 13:40:11 ser01 postfix/smtp[1960]: 8D257A009E: to=<sales@mydomain.com>, relay=none, delay=0.06, delays=0.02/0/0.04/0, dsn=5.4.4, status=bounced (Host or domain name not found. Name service error for name=mail.mydomain.com type=A: Host not found)
Please create an A record for mail.mydomain.com.

satimis 9th February 2012 04:34

Quote:

Originally Posted by falko (Post 273208)
Please create an A record for mail.mydomain.com.

Hi,

According to
Code:

13 Populate The Database And Test
If you want to make entries in the other two tables, that would look like this:

in your Howto, I already did;

Code:

INSERT INTO `transport` (`domain`, `transport`) VALUES ('mydomain.com', 'smtp:mail.mydomain.com');
creating the record.

mysql> SELECT * from transport;
Code:

+-------------+-----------------------+
| domain      | transport            |
+-------------+-----------------------+
| mydomain.com | smtp:mail.mydomain.com |
+-------------+-----------------------+
1 row in set (0.00 sec)

B.R.
satimis

falko 9th February 2012 13:40

No, I mean a DNS record (an A record).

satimis 9th February 2012 13:52

Quote:

Originally Posted by falko (Post 273248)
No, I mean a DNS record (an A record).

On domain register website
Code:

Host        Points to
@        xxx.xxx.xxx.xxx (fixed ip)
ser01        xxx.xxx.xxx.xxx (fixed ip)

CNAME (Alias)
Host        Points to
e        ser01.mydomain.com
email        ser01.mydomain.com
imap        imap.secureserver.net
pop        ser01.mydomain.com
smtp        ser01.mydomain.com
webmail        ser01.mydomain.com
www        @

MX (Mail Exchanger)
Priority        Host        Points
30                @        mailstore1.secureserver.net
20                @        smtp.secureserver.net
10                @        ser01.mydomain.com

Whether change
Code:

email        ser01.mydomain.com
to
Code:

email        mail.mydomain.com

OR
Code:

smtp        ser01.mydomain.com
to
Code:

smtp        mail.mydomain.com
?

Thanks


Edit:

Performed following step on Register's website
Under A(Host)
--> Quick Add

Host - mail.mydomain.com
Points to - xxx.xxx.xxx.xxx (fixed ip)

-> Save Zone File

After saving "mail.mydomain.com" becomes "mail" (mydomain.com hidden)

Now under "A(Host)"
Host Points to
Code:

@        xxx.xxx.xxx.xxx (fixed ip)
mail        xxx.xxx.xxx.xxx (fixed ip)
ser01        xxx.xxx.xxx.xxx (fixed ip)

I do hope that I understand your advice correctly A record = A(Host) on my Register's website. If I'm wrong please correct me. Thanks.

Now I'm waiting the change to propagate.

B.R.
satimis

falko 10th February 2012 17:24

Quote:

Originally Posted by satimis (Post 273249)
I do hope that I understand your advice correctly A record = A(Host) on my Register's website.

Yes, that's correct.

satimis 10th February 2012 18:42

Quote:

Originally Posted by falko (Post 273335)
Yes, that's correct.

Still no hope. Mail came but disconnected from unknown (xxx.xxx.xxx.xxx) (fixed IP). Why?

# tail /var/log/mail.log
Code:

Feb 11 00:28:05 ser01 postfix/smtp[1766]: warning: host mail.mydomain.com[xxx.xxx.xxx.xxx]:25 greeted me with my own hostname ser01.mydomain.com
Feb 11 00:28:05 ser01 postfix/smtp[1766]: warning: host mail.mydomain.com[xxx.xxx.xxx.xxx]:25 replied to HELO/EHLO with my own hostname ser01.mydomain.com
Feb 11 00:28:05 ser01 postfix/smtp[1766]: 2935FA00E2: to=<sales@mydomain.com>, relay=mail.mydomain.com[xxx.xxx.xxx.xxx]:25, delay=5.5, delays=0.01/0.01/5.5/0, dsn=5.4.6, status=bounced (mail for mail.mydomain.com loops back to myself)
Feb 11 00:28:05 ser01 postfix/smtpd[1749]: disconnect from unknown[xxx.xxx.xxx.xxx]
Feb 11 00:28:05 ser01 postfix/cleanup[1758]: B040FA00E3: message-id=<20120210162805.B040FA00E3@ser01.mydomain.com>
Feb 11 00:28:05 ser01 postfix/bounce[1767]: 2935FA00E2: sender non-delivery notification: B040FA00E3
Feb 11 00:28:05 ser01 postfix/qmgr[1584]: B040FA00E3: from=<>, size=5396, nrcpt=1 (queue active)
Feb 11 00:28:05 ser01 postfix/qmgr[1584]: 2935FA00E2: removed
Feb 11 00:28:08 ser01 postfix/smtp[1766]: B040FA00E3: to=<somebody@yahoo.com>, relay=mta6.am0.yahoodns.net[67.195.168.230]:25, delay=2.7, delays=0.01/0/0.95/1.7, dsn=2.0.0, status=sent (250 ok dirdel)
Feb 11 00:28:08 ser01 postfix/qmgr[1584]: B040FA00E3: removed

How to fix the problem? TIA


Edit:

on /etc/postfix/main.cf
mydestination = localhost.$mydomain, localhost, mail.mydomain.com

reload postfix

Now mail arrived without problem.

# tail /var/log/mail.log
Code:

Feb 11 00:59:55 ser01 postfix/qmgr[2188]: 301EAA00D8: removed
Feb 11 01:02:12 ser01 postfix/master[2135]: reload -- version 2.7.0, configuration /etc/postfix
Feb 11 01:02:12 ser01 postfix/anvil[2192]: statistics: max connection rate 1/60s for (smtp:98.139.91.248) at Feb 11 00:59:30
Feb 11 01:02:12 ser01 postfix/anvil[2192]: statistics: max connection count 1 for (smtp:98.139.91.248) at Feb 11 00:59:30
Feb 11 01:02:12 ser01 postfix/anvil[2192]: statistics: max cache size 2 at Feb 11 00:59:52
Feb 11 01:02:47 ser01 postfix/smtpd[2224]: connect from nm7-vm4.bullet.mail.ne1.yahoo.com[98.138.91.167]
Feb 11 01:02:48 ser01 postfix/smtpd[2224]: 4E0F7A00B9: client=nm7-vm4.bullet.mail.ne1.yahoo.com[98.138.91.167]
Feb 11 01:02:49 ser01 postfix/cleanup[2229]: 4E0F7A00B9: message-id=<1328893365.50292.YahooMailNeo@web113215.mail.gq1.yahoo.com>
Feb 11 01:02:49 ser01 postfix/qmgr[2221]: 4E0F7A00B9: from=<somebody@yahoo.com>, size=2979, nrcpt=1 (queue active)
Feb 11 01:02:49 ser01 postfix/smtpd[2224]: disconnect from nm7-vm4.bullet.mail.ne1.yahoo.com[98.138.91.167]


# ls /home/vmail/
nothing

Where is the mail?


B.R.
satimis

falko 11th February 2012 13:37

Are there any errors in your mail log (in the /var/log/ directory)?

satimis 11th February 2012 16:58

Quote:

Originally Posted by falko (Post 273367)
Are there any errors in your mail log (in the /var/log/ directory)?


# ls -al /var/log/
Code:

total 10460
drwxr-xr-x 14 root      root      4096 2012-02-11 22:16 .
drwxr-xr-x 16 root      root      4096 2012-02-06 23:06 ..
drwxr-x---  2 root      adm      4096 2012-02-04 11:59 apache2
drwxr-xr-x  2 root      root      4096 2011-01-21 01:40 apparmor
drwxr-xr-x  2 root      root      4096 2012-02-02 19:51 apt
-rw-r--r--  1 root      root    15984 2012-02-11 18:41 aptitude
-rw-r-----  1 syslog    adm    135095 2012-02-11 22:17 auth.log
-rw-r-----  1 root      adm        31 2012-02-02 19:50 boot
-rw-r--r--  1 root      root      1970 2012-02-11 22:16 boot.log
-rw-rw-r--  1 root      utmp      384 2012-02-05 23:44 btmp
drwxr-xr-x  2 clamav    clamav    4096 2012-02-06 15:28 clamav
-rw-r-----  1 syslog    adm      68199 2012-02-11 22:16 daemon.log
drwxr-xr-x  2 root      root      4096 2012-02-04 11:59 dbconfig-common
-rw-r-----  1 syslog    adm    369428 2012-02-11 22:16 debug
drwxr-xr-x  2 root      root      4096 2010-10-14 14:48 dist-upgrade
-rw-r-----  1 root      adm      25668 2012-02-11 22:16 dmesg
-rw-r-----  1 root      adm      25286 2012-02-11 18:36 dmesg.0
-rw-r-----  1 root      adm      8171 2012-02-11 11:24 dmesg.1.gz
-rw-r-----  1 root      adm      8180 2012-02-11 10:49 dmesg.2.gz
-rw-r-----  1 root      adm      8139 2012-02-11 00:21 dmesg.3.gz
-rw-r-----  1 root      adm      8244 2012-02-10 23:45 dmesg.4.gz
-rw-r--r--  1 root      root    454868 2012-02-11 18:42 dpkg.log
-rw-r--r--  1 root      root    160032 2012-02-07 17:13 faillog
drwxr-xr-x  2 root      root      4096 2012-02-02 19:50 fsck
drwxr-xr-x  3 root      root      4096 2012-02-02 19:57 installer
-rw-r-----  1 syslog    adm    2353155 2012-02-11 22:16 kern.log
drwxr-xr-x  2 landscape root      4096 2012-02-02 19:57 landscape
-rw-rw-r--  1 root      utmp  1460292 2012-02-11 22:16 lastlog
-rw-r-----  1 syslog    adm          0 2012-02-02 19:57 lpr.log
-rw-r-----  1 syslog    adm      7928 2012-02-11 22:16 mail.err
-rw-r-----  1 syslog    adm    687970 2012-02-11 22:16 mail.info
-rw-r-----  1 syslog    adm    688084 2012-02-11 22:16 mail.log
-rw-r-----  1 syslog    adm      72380 2012-02-11 22:16 mail.warn
-rw-r-----  1 syslog    adm    1997634 2012-02-11 22:16 messages
drwxr-s---  2 mysql    adm      4096 2012-02-04 11:59 mysql
-rw-r-----  1 mysql    adm          0 2012-02-04 11:59 mysql.err
-rw-r-----  1 mysql    adm          0 2012-02-04 11:59 mysql.log
drwxr-xr-x  2 root      root      4096 2012-02-02 19:57 news
-rw-r--r--  1 root      root        0 2012-02-02 19:51 pycentral.log
drwxr-xr-x  2 root      root      4096 2011-10-01 01:34 samba
-rw-r-----  1 syslog    adm    3180797 2012-02-11 22:17 syslog
-rw-r--r--  1 root      root    144117 2012-02-11 22:16 udev
-rw-r-----  1 syslog    adm          0 2012-02-02 19:57 ufw.log
-rw-r-----  1 syslog    adm      1740 2012-02-02 20:03 user.log
-rw-rw-r--  1 root      utmp    277248 2012-02-11 22:16 wtmp


Repeated step on "14 Send A Welcome Email For Creating Maildir"

# tail /var/log/mail.log
Code:

Feb 11 22:35:52 ser01 postfix/smtp[1723]: warning: host mail.mydomain.com[xxx.xxx.xxx.xxx (fixed ip)]:25 greeted me with my own hostname ser01.mydomain.com
Feb 11 22:35:52 ser01 postfix/smtp[1723]: warning: host mail.mydomain.com[xxx.xxx.xxx.xxx (fixed ip)]:25 replied to HELO/EHLO with my own hostname ser01.mydomain.com
Feb 11 22:35:52 ser01 postfix/smtp[1723]: D56F3A00A0: to=<sales@mydomain.com>, relay=mail.mydomain.com[xxx.xxx.xxx.xxx (fixed ip)]:25, delay=5.6, delays=0.02/0/5.6/0, dsn=5.4.6, status=bounced (mail for mail.mydomain.com loops back to myself)
Feb 11 22:35:52 ser01 postfix/smtpd[1724]: disconnect from unknown[xxx.xxx.xxx.xxx (fixed ip)]
Feb 11 22:35:52 ser01 postfix/cleanup[1709]: 709C8A00B0: message-id=<20120211143552.709C8A00B0@ser01.mydomain.com>
Feb 11 22:35:52 ser01 postfix/bounce[1726]: D56F3A00A0: sender non-delivery notification: 709C8A00B0
Feb 11 22:35:52 ser01 postfix/qmgr[1578]: 709C8A00B0: from=<>, size=2857, nrcpt=1 (queue active)
Feb 11 22:35:52 ser01 postfix/qmgr[1578]: D56F3A00A0: removed
Feb 11 22:35:52 ser01 postfix/local[1727]: 709C8A00B0: to=<administrator@ser01.mydomain.com>, orig_to=<root@ser01.mydomain.com>, relay=local, delay=0.01, delays=0/0.01/0/0, dsn=5.1.1, status=bounced (unknown user: "administrator")
Feb 11 22:35:52 ser01 postfix/qmgr[1578]: 709C8A00B0: removed

# tail /var/log/mail.err
Code:

Feb 11 10:49:28 ser01 dccproc[1655]: continue not asking DCC 16 seconds after 1 failures
Feb 11 10:49:30 ser01 dccproc[1657]: continue not asking DCC 14 seconds after 1 failures
Feb 11 10:50:52 ser01 dccproc[1776]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 11:04:05 ser01 dccproc[1886]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 11:09:36 ser01 dccproc[1930]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 11:24:28 ser01 dccproc[1142]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 11:25:35 ser01 dccproc[1703]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 18:36:15 ser01 dccproc[1143]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 22:16:28 ser01 dccproc[1135]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 22:35:42 ser01 dccproc[1716]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1

# tail /var/log/mail.warn
Code:

Feb 11 18:36:15 ser01 dccproc[1143]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 22:16:28 ser01 dccproc[1135]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 22:35:42 ser01 dccproc[1716]: no working DCC servers dcc1.dcc-servers.net dcc2.dcc-servers.net dcc3.dcc-servers.net ... at 127.0.0.1
Feb 11 22:35:52 ser01 postfix/smtp[1723]: warning: host mail.mydomain.com[xxx.xxx.xxx.xxx (fixed ip)]:25 greeted me with my own hostname ser01.mydomain.com
Feb 11 22:35:52 ser01 postfix/smtp[1723]: warning: host mail.mydomain.com[xxx.xxx.xxx.xxx (fixed ip)]:25 replied to HELO/EHLO with my own hostname ser01.mydomain.com

No working DCC servers !!!

I have been googling a while and found many similar problems on Internet. I couldn't discover a solution there.

satimis

falko 12th February 2012 13:07

Quote:

Feb 11 22:35:52 ser01 postfix/smtp[1723]: warning: host mail.mydomain.com[xxx.xxx.xxx.xxx (fixed ip)]:25 greeted me with my own hostname ser01.mydomain.com
Feb 11 22:35:52 ser01 postfix/smtp[1723]: warning: host mail.mydomain.com[xxx.xxx.xxx.xxx (fixed ip)]:25 replied to HELO/EHLO with my own hostname ser01.mydomain.com
Do you use the correct hostname in your main.cf?


All times are GMT +2. The time now is 09:53.

Powered by vBulletin® Version 3.8.7
Copyright ©2000 - 2014, vBulletin Solutions, Inc.