Postfix not sending mail

Discussion in 'Server Operation' started by arnolette, Nov 3, 2012.

  1. arnolette

    arnolette New Member

    Hi Guys.

    I am new to linux and have a kolab mail server that is running Ubuntu 10. I tried running the kolab services as well as postfix but now, outgoing mails are not moving. and incoming mail from selected domains are coming in while others are not.

    Below is an extract of /var/log/mail.log

    Nov 2 16:30:01 mail postfix/smtpd[15743]: NOQUEUE: reject: RCPT from unknown[74.113.233.9]: 550 5.1.1 <user@mydomain.com>: Recipient address rejected: User unknown in local recipient table; from=<webbu0000000000xx@att.net> to=<user@mydomain.com> proto=ESMTP helo=<nemo.cut.ac.au>
    Nov 2 16:30:01 mail postfix/smtpd[15743]: disconnect from unknown[74.113.233.9]Nov 2 16:30:19 mail postfix/qmgr[5424]: 9B9573480D65: from=<user@mydomain.com>, size=163251, nrcpt=1 (queue active)Nov 2 16:30:39 mail postfix/smtp[16226]: 9B9573480D65: to=<noldie@gmail.com>, relay=none, delay=2185, delays=2165/0.01/20/0, dsn=4.4.3, status=deferred (Host or domain name not found. Name service error for name=mx3.cut.ac.au type=MX: Host not found, try again)
    Nov 2 16:33:21 mail postfix/anvil[15745]: statistics: max connection rate 1/60s for (smtp:74.113.233.9) at Nov 2 16:27:23Nov 2 16:33:21 mail postfix/anvil[15745]: statistics: max connection count 1 for (smtp:74.113.233.9) at Nov 2 16:27:23
    Nov 2 16:33:21 mail postfix/anvil[15745]: statistics: max cache size 1 at Nov 2 16:27:23
    Nov 2 16:35:23 mail postfix/smtpd[16229]: connect from unknown[74.113.233.9]Nov 2 16:35:23 mail postfix/smtpd[16229]: NOQUEUE: reject: RCPT from unknown[74.113.233.9]: 550 5.1.1 <user@mydomain.com>: Recipient address rejected: User unknown in local recipient table; from=<GolfBooking@royalharare.co.zw> to=<user@mydomain.com> proto=ESMTP helo=<nemo.cut.ac.au>
    Nov 2 16:35:23 mail postfix/smtpd[16229]: disconnect from unknown[74.113.233.9]
    Nov 2 16:35:31 mail postfix/smtpd[16231]: connect from unknown[74.113.233.9]Nov 2 16:35:31 mail postfix/smtpd[16231]: NOQUEUE: reject: RCPT from unknown[74.113.233.9]: 550 5.1.1 <3A511D53A@mydomain.com>: Recipient address rejected: User unknown in local recipient table; from=<> to=<3A511D53A@mydomain.com> proto=ESMTP helo=<nemo.cut.ac.au>
    Nov 2 16:35:31 mail postfix/smtpd[16231]: disconnect from unknown[74.113.233.9]
    Nov 2 16:38:32 mail postfix/smtpd[16235]: connect from unknown[74.113.233.9]Nov 2 16:38:32 mail postfix/smtpd[16235]: NOQUEUE: reject: RCPT from unknown[74.113.233.9]: 550 5.1.1 <user@mydomain.com>: Recipient address rejected: User unknown in local recipient table; from=<pengyc2004@yahoo.com.cn> to=<user@mydomain.com> proto=ESMTP helo=<nemo.cut.ac.au>
    Nov 2 16:38:32 mail postfix/smtpd[16235]: disconnect from unknown[74.113.233.9]
    Nov 2 16:41:52 mail postfix/anvil[16233]: statistics: max connection rate 2/60s for (smtp:74.113.233.9) at Nov 2 16:35:31Nov 2 16:41:52 mail postfix/anvil[16233]: statistics: max connection count 1 for (smtp:74.113.233.9) at Nov 2 16:35:23
    Nov 2 16:41:52 mail postfix/anvil[16233]: statistics: max cache size 1 at Nov 2 16:35:23
    Nov 2 16:45:41 mail postfix/master[5422]: terminating on signal 15
    Nov 2 16:45:41 mail postfix/master[18844]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 16:52:40 mail spamd[847]: logger: removing stderr method
    Nov 2 16:52:41 mail spamd[894]: error creating a DNS resolver socket: Network is unreachable at /usr/share/perl5/Mail/SpamAssassin/DnsResolver.pm line 235.
    Nov 2 16:52:41 mail spamd[894]: spamd: server started on port 783/tcp (running version 3.3.1)Nov 2 16:52:41 mail spamd[894]: spamd: server pid: 894
    Nov 2 16:52:41 mail spamd[894]: spamd: server successfully spawned child process, pid 925
    Nov 2 16:52:41 mail spamd[894]: spamd: server successfully spawned child process, pid 926
    Nov 2 16:52:41 mail spamd[894]: prefork: child states: ISNov 2 16:52:41 mail spamd[894]: prefork: child states: II
    Nov 2 16:52:47 mail postfix/master[1516]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 16:59:55 mail postfix/master[4024]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 17:50:37 mail postfix/master[8668]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission deniedNov 2 17:57:20 mail spamd[752]: logger: removing stderr method
    Nov 2 17:57:21 mail spamd[908]: error creating a DNS resolver socket: Network is unreachable at /usr/share/perl5/Mail/SpamAssassin/DnsResolver.pm line 235.
    Nov 2 17:57:21 mail spamd[908]: spamd: server started on port 783/tcp (running version 3.3.1)
    Nov 2 17:57:21 mail spamd[908]: spamd: server pid: 908Nov 2 17:57:21 mail spamd[908]: spamd: server successfully spawned child process, pid 916
    Nov 2 17:57:21 mail spamd[908]: spamd: server successfully spawned child process, pid 917
    Nov 2 17:57:21 mail spamd[908]: prefork: child states: IS
    Nov 2 17:57:21 mail spamd[908]: prefork: child states: II
    Nov 2 17:57:27 mail postfix/master[1535]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 18:14:18 mail postfix/master[4993]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission deniedNov 2 18:28:14 mail postfix/master[7550]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 18:34:36 mail spamd[697]: logger: removing stderr method
    Nov 2 18:34:37 mail spamd[852]: error creating a DNS resolver socket: Network is unreachable at /usr/share/perl5/Mail/SpamAssassin/DnsResolver.pm line 235.
    Nov 2 18:34:37 mail spamd[852]: spamd: server started on port 783/tcp (running version 3.3.1)Nov 2 18:34:37 mail spamd[852]: spamd: server pid: 852
    Nov 2 18:34:37 mail spamd[852]: spamd: server successfully spawned child process, pid 860
    Nov 2 18:34:37 mail spamd[852]: spamd: server successfully spawned child process, pid 861
    Nov 2 18:34:37 mail spamd[852]: prefork: child states: ISNov 2 18:34:37 mail spamd[852]: prefork: child states: II
    Nov 2 18:34:43 mail postfix/master[1479]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 18:37:36 mail postfix/master[4075]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 19:28:02 mail spamd[880]: logger: removing stderr method
    Nov 2 19:28:03 mail spamd[926]: error creating a DNS resolver socket: Network is unreachable at /usr/share/perl5/Mail/SpamAssassin/DnsResolver.pm line 235.
    Nov 2 19:28:03 mail spamd[926]: spamd: server started on port 783/tcp (running version 3.3.1)
    Nov 2 19:28:03 mail spamd[926]: spamd: server pid: 926
    Nov 2 19:28:03 mail spamd[926]: spamd: server successfully spawned child process, pid 957
    Nov 2 19:28:03 mail spamd[926]: spamd: server successfully spawned child process, pid 958
    Nov 2 19:28:03 mail spamd[926]: prefork: child states: II
    Nov 2 19:28:09 mail postfix/master[1548]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 19:35:55 mail postfix/master[8375]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 19:48:51 mail postfix/master[9156]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 20:02:39 mail postfix/master[11968]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 20:12:11 mail postfix/master[14322]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied



    An extract of mail.err

    Nov 1 08:17:26 mail postfix/master[8368]: fatal: bind 0.0.0.0 port 25: Address already in use
    Nov 1 08:36:08 mail postfix/master[12669]: fatal: bind 0.0.0.0 port 25: Address already in use
    Nov 2 13:13:01 mail postfix/master[18927]: fatal: bind 0.0.0.0 port 25: Address already in use
    Nov 2 16:45:41 mail postfix/master[18844]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 16:52:47 mail postfix/master[1516]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 16:59:55 mail postfix/master[4024]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 17:50:37 mail postfix/master[8668]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 17:57:27 mail postfix/master[1535]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 18:14:18 mail postfix/master[4993]: fatal: open lock file /var/lib/postfix/master.lock: cannot open file: Permission denied
    Nov 2 18:28:14 mail postfix/master[7550]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 18:34:43 mail postfix/master[1479]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 18:37:36 mail postfix/master[4075]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 19:28:09 mail postfix/master[1548]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 19:35:55 mail postfix/master[8375]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 19:48:51 mail postfix/master[9156]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 20:02:39 mail postfix/master[11968]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied
    Nov 2 20:12:11 mail postfix/master[14322]: fatal: open lock file /var/lib/postfix/master.lock: cannot create file exclusively: Permission denied




    root@mail:/# netstat -tap
    Active Internet connections (servers and established)
    Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name
    tcp 0 0 *:imaps *:* LISTEN 3374/cyrmaster
    tcp 0 0 *:pop3s *:* LISTEN 3374/cyrmaster
    tcp 0 0 *:ldap *:* LISTEN 1935/slapd
    tcp 0 0 localhost:10025 *:* LISTEN 3592/master
    tcp 0 0 localhost:10026 *:* LISTEN 3592/master
    tcp 0 0 *:pop3 *:* LISTEN 3374/cyrmaster
    tcp 0 0 localhost:9999 *:* LISTEN 3696/perl
    tcp 0 0 *:imap2 *:* LISTEN 3374/cyrmaster
    tcp 0 0 localhost:spamd *:* LISTEN 926/spamd.pid
    tcp 0 0 *:www *:* LISTEN 5785/apache
    tcp 0 0 *:cisco-sccp *:* LISTEN 3374/cyrmaster
    tcp 0 0 *:ssmtp *:* LISTEN 3592/master
    tcp 0 0 localhost:cfinger *:* LISTEN 3374/cyrmaster
    tcp 0 0 *:ssh *:* LISTEN 682/sshd
    tcp 0 0 localhost:ipp *:* LISTEN 810/cupsd
    tcp 0 0 *:3128 *:* LISTEN 905/squid
    tcp 0 0 *:smtp *:* LISTEN 3592/master
    tcp 0 0 *:https *:* LISTEN 5785/apache
    tcp 0 0 *:ldaps *:* LISTEN 1935/slapd
    tcp 0 0 localhost:54495 localhost:ldap TIME_WAIT -
    tcp 0 0 localhost:ldap localhost:54424 ESTABLISHED 1935/slapd
    tcp 0 0 localhost:ldap localhost:54489 ESTABLISHED 1935/slapd
    tcp 0 0 localhost:ldap localhost:54487 ESTABLISHED 1935/slapd
    tcp 0 0 localhost:54427 localhost:ldap ESTABLISHED 2226/saslauthd



    May you please assits
     
  2. falko

    falko Super Moderator Howtoforge Staff Moderator HowtoForge Supporter ISPConfig Developer

    Have you tried to reboot the system?

    Do you have working nameservers in /etc/resolv.conf?
     
  3. arnolette

    arnolette New Member

    Thanks Falko.

    Ya, had tried rebooting the system and stuff but the problem persisted. Tried rechecking my postfix/main.cf and everything looked ok. But i eventually bumped into somethng that i would like to fool myself into believing it sorted out thngs... got these commands from one websie...

    # sudo chmod -R 755 /var/spool/postfix
    # sudo chmod 1733 /var/spool/postfix/maildrop

    so i did made a backup of the postfix folder and ran the two commands and ya, it worked. mail started moving again. Realised i had deleted one file...
    /var/lib/postfix/master.lock

    i dont know of how much importance is that file, coz i didnt back it up.
     
  4. arnolette

    arnolette New Member

Share This Page