[SOLVED] MTA will not start

[lpossie]

For no apparent reason that I'm aware my MTA stopped working my mail server. It tells me to start postfix and even after I try to start it, I get the same results. Any suggestions would be appreciated. Thx

Here is some info that I hope will help explain:

zimbra@mail:~/bin$ zmcontrol status
Host mail.possiefamily.com
antispam Running
antivirus Stopped
zmclamdctl is not running
ldap Running
logger Running
mailbox Running
mta Stopped
postfix is not running
snmp Running
spell Running

zimbra@mail:~/bin$ postfix start
postfix/postfix-script: warning: not owned by root: /opt/zimbra/postfix-2.2.9/conf/main.cf
postfix/postfix-script: starting the Postfix mail system

/var/log/zimbrar.log
Sep 8 13:06:12 mail CRON[25705]: (pam_unix) session closed for user zimbra
Sep 8 13:07:23 mail clamd[26019]: clamd daemon 0.90.2 (OS: linux-gnu, ARCH: i386, CPU: i686)
Sep 8 13:07:23 mail clamd[26019]: Log file size limited to 20971520 bytes.
Sep 8 13:07:23 mail clamd[26019]: Reading databases from /opt/zimbra/clamav/db
Sep 8 13:07:29 mail su[26022]: (pam_unix) session opened for user zimbra by (uid=0)
Sep 8 13:07:46 mail zmtomcatmgr[26123]: status requested
Sep 8 13:07:46 mail zmtomcatmgr[26123]: status OK
Sep 8 13:07:46 mail postfix/postqueue[26137]: fatal: Queue report unavailable - mail system is down
Sep 8 13:08:02 mail CRON[26159]: (pam_unix) session opened for user zimbra by (uid=0)
Sep 8 13:08:10 mail zmtomcatmgr[26260]: status requested
Sep 8 13:08:10 mail zmtomcatmgr[26260]: status OK
Sep 8 13:08:10 mail postfix/postqueue[26274]: fatal: Queue report unavailable - mail system is down
Sep 8 13:08:12 mail zimbramon[26160]: 26160:info: 2007-09-08 13:08:02, STATUS: mail.possiefamily.com: antispam: Running
Sep 8 13:08:12 mail zimbramon[26160]: 26160:info: 2007-09-08 13:08:02, STATUS: mail.possiefamily.com: antivirus: Stopped
Sep 8 13:08:12 mail zimbramon[26160]: 26160:info: 2007-09-08 13:08:02, STATUS: mail.possiefamily.com: ldap: Running
Sep 8 13:08:12 mail zimbramon[26160]: 26160:info: 2007-09-08 13:08:02, STATUS: mail.possiefamily.com: logger: Running
Sep 8 13:08:12 mail zimbramon[26160]: 26160:info: 2007-09-08 13:08:02, STATUS: mail.possiefamily.com: mailbox: Running
Sep 8 13:08:12 mail zimbramon[26160]: 26160:info: 2007-09-08 13:08:02, STATUS: mail.possiefamily.com: mta: Stopped
Sep 8 13:08:12 mail zimbramon[26160]: 26160:info: 2007-09-08 13:08:02, STATUS: mail.possiefamily.com: snmp: Running
Sep 8 13:08:12 mail zimbramon[26160]: 26160:info: 2007-09-08 13:08:02, STATUS: mail.possiefamily.com: spell: Running

[dijichi2]

looks like more than just postfix..

telnet to port 25 and see what happens in /var/log/zimbra.log?

[lpossie]

here is what I get:

lpossie@mail:~$ telnet localhost 25
Trying 127.0.0.1...
Connected to localhost.possiefamily.com.
Escape character is '^]'.
220 mail.possiefamily.com ESMTP Exim 4.60 Sat, 08 Sep 2007 15:44:26 -0600

/var/log/zimbra.log:

Sep 8 15:46:01 mail CRON[8545]: (pam_unix) session opened for user zimbra by (uid=0)
Sep 8 15:46:05 mail clamd[8621]: clamd daemon 0.90.2 (OS: linux-gnu, ARCH: i386, CPU: i686)
Sep 8 15:46:05 mail clamd[8621]: Log file size limited to 20971520 bytes.
Sep 8 15:46:05 mail clamd[8621]: Reading databases from /opt/zimbra/clamav/db
Sep 8 15:46:09 mail zmtomcatmgr[8689]: status requested
Sep 8 15:46:09 mail zmtomcatmgr[8689]: status OK
Sep 8 15:46:10 mail postfix/postqueue[8703]: fatal: Queue report unavailable - mail system is down
Sep 8 15:46:11 mail zimbramon[8546]: 8546:info: 2007-09-08 15:46:02, STATUS: mail.possiefamily.com: antispam: Running
Sep 8 15:46:11 mail zimbramon[8546]: 8546:info: 2007-09-08 15:46:02, STATUS: mail.possiefamily.com: antivirus: Stopped
Sep 8 15:46:11 mail zimbramon[8546]: 8546:info: 2007-09-08 15:46:02, STATUS: mail.possiefamily.com: ldap: Running
Sep 8 15:46:11 mail zimbramon[8546]: 8546:info: 2007-09-08 15:46:02, STATUS: mail.possiefamily.com: logger: Running
Sep 8 15:46:11 mail zimbramon[8546]: 8546:info: 2007-09-08 15:46:02, STATUS: mail.possiefamily.com: mailbox: Running
Sep 8 15:46:11 mail zimbramon[8546]: 8546:info: 2007-09-08 15:46:02, STATUS: mail.possiefamily.com: mta: Stopped
Sep 8 15:46:11 mail zimbramon[8546]: 8546:info: 2007-09-08 15:46:02, STATUS: mail.possiefamily.com: snmp: Running
Sep 8 15:46:11 mail zimbramon[8546]: 8546:info: 2007-09-08 15:46:02, STATUS: mail.possiefamily.com: spell: Running
Sep 8 15:46:11 mail CRON[8545]: (pam_unix) session closed for user zimbra

[jholder]

220 mail.possiefamily.com ESMTP Exim 4

You'll need to stop Exim. That's not Zimbra.

Then, once it's stopped, do a
postfix start

john

[lpossie]

Thx a million... that resolved the issue I removed exim4 and mutt and restarted my server and that cleared up the MTA issue.

Any recommendations on the antivirus?

[jholder]

Well, you can search on the antivirus. It basically comes down to clamav, and the fact that our watchdog process isn't playing nice with Clam. Clam is taking way too long to start up. We have a watchdog process that checks to see if it's running. If it's not, we restart it.

The watchdog thinks clam isn't running and restarts it. . .but it really is running. It's a endless cycle.

We think it's fixed in 4.5.7 which will probably be released sometime next week.

In the interm, search the forums, as there's a solution to increase the watchdog sampling rate. . or you can manually upgrade clamav.

cheers,
john

[lpossie]

Thank you for the wonderful advise. I did change the interval to 180 and it's working like a champ again.

[rhultay]

This also solved my issue, thank you! I didn't know about mutt

[support@blacq.net]

I have checked the Forums for the watchdog reference and can't find anything.

Where are the details on the setting of the watchdog sampling rate ?

blacq...