Zimbra MTA died and won't restart

[lallhands]

We just installed the Zimbra suite yesterday afternoon and all was working well with 10 test users. Some time last night, the Zimbra MTA died and will not restart. Here is what I saw when trying to restart.

[zimbra@zbox ~]$ zmcontrol stop
Host zbox.apprion.net
Stopping antispam...Done
Stopping antivirus...Done
Stopping ldap...Done
Stopping logger...Done
Stopping mailbox...Done
Stopping mta...Done
Stopping snmp...Done
Stopping spell...Done
[zimbra@zbox ~]$ zmcontrol start
Host zbox.apprion.net
Starting ldap...Done.
Starting antispam...Done.
Starting antivirus...Done.
Starting logger...Done.
Starting mailbox...Done.
Starting mta...FAILED
getService: sasl
getService: perdition
DO: /opt/zimbra/postfix/sbin/postconf -e content_filter='smtp-amavis:[127.0.0.1]:10024'
DO: /opt/zimbra/postfix/sbin/postconf -e myhostname='zbox.apprion.net'
DO: /opt/zimbra/postfix/sbin/postconf -e recipient_delimiter=''
DO: /opt/zimbra/postfix/sbin/postconf -e smtpd_sasl_auth_enable='yes'
DO: /opt/zimbra/postfix/sbin/postconf -e smtpd_tls_auth_only='yes'
DO: /opt/zimbra/postfix/sbin/postconf -e disable_dns_lookups='no'
DO: /opt/zimbra/postfix/sbin/postconf -e message_size_limit='10240000'
DO: /opt/zimbra/postfix/sbin/postconf -e relayhost=''
DO: /opt/zimbra/postfix/sbin/postconf -e smtpd_recipient_restrictions='reject_non_fqdn_reci pient, permit_sasl_authenticated, permit_mynetworks, reject_invalid_hostname, reject_non_fqdn_sender, reject_unauth_destination, permit'
saslauthd[9680] :set_auth_mech : failed to initialize mechanism zimbra


Starting snmp...Done.
Starting spell...Done.
[zimbra@zbox ~]$ hostname
zbox.apprion.net
[zimbra@zbox ~]$ zmcontrol start
Host zbox.apprion.net
Starting antispam...Done.
Starting antivirus...Done.
Starting logger...Done.
Starting mailbox...Done.
Starting mta...FAILED
getService: sasl
getService: perdition
DO: /opt/zimbra/postfix/sbin/postconf -e content_filter='smtp-amavis:[127.0.0.1]:10024'
DO: /opt/zimbra/postfix/sbin/postconf -e myhostname='zbox.apprion.net'
DO: /opt/zimbra/postfix/sbin/postconf -e recipient_delimiter=''
DO: /opt/zimbra/postfix/sbin/postconf -e smtpd_sasl_auth_enable='yes'
DO: /opt/zimbra/postfix/sbin/postconf -e smtpd_tls_auth_only='yes'
DO: /opt/zimbra/postfix/sbin/postconf -e disable_dns_lookups='no'
DO: /opt/zimbra/postfix/sbin/postconf -e message_size_limit='10240000'
DO: /opt/zimbra/postfix/sbin/postconf -e relayhost=''
DO: /opt/zimbra/postfix/sbin/postconf -e smtpd_recipient_restrictions='reject_non_fqdn_reci pient, permit_sasl_authenticated, permit_mynetworks, reject_invalid_hostname, reject_non_fqdn_sender, reject_unauth_destination, permit'
saslauthd[17686] :set_auth_mech : failed to initialize mechanism zimbra


Starting snmp...Done.
Starting spell...Done.


Any help or suggestions would be great

[marcmac]

What version, what platform, etc?

Is saslauthd running? What's in /var/log/zimbra.log wrt postfix? What do you get from /opt/zimbra/postfix/libexec/master?

[lallhands]

Config

Running Centos 4.2 Linux i386 - Zimbra 3.0 B3

saslauthd

[root@zbox log]# ps -ef | grep saslauthd
root 20873 1 0 12:15 ? 00:00:00 /usr/sbin/saslauthd -m /var/run/saslauthd -a shadow
root 20874 20873 0 12:15 ? 00:00:00 /usr/sbin/saslauthd -m /var/run/saslauthd -a shadow
root 20877 20873 0 12:15 ? 00:00:00 /usr/sbin/saslauthd -m /var/run/saslauthd -a shadow
root 20878 20873 0 12:15 ? 00:00:00 /usr/sbin/saslauthd -m /var/run/saslauthd -a shadow
root 20879 20873 0 12:15 ? 00:00:00 /usr/sbin/saslauthd -m /var/run/saslauthd -a shadow
root 22935 15041 0 12:17 pts/1 00:00:00 grep saslauthd

Log Sinppets

Jan 18 12:52:03 localhost postfix/postfix-script: warning: not owned by root: /opt/zimbra/postfix-2.2.5/conf/main.cf
Jan 18 12:52:03 localhost postfix/postfix-script: starting the Postfix mail system
Jan 18 12:52:03 localhost postfix/master[12453]: fatal: bind 0.0.0.0 port 25: Address already in use
Jan 18 20:52:07 localhost postfix/postqueue[12772]: fatal: Queue report unavailable - mail system is down
Jan 18 20:52:10 localhost postfix/postqueue[13171]: fatal: Queue report unavailable - mail system is down
Jan 18 20:53:05 localhost postfix/postqueue[14046]: fatal: Queue report unavailable - mail system is down
Jan 18 20:53:25 localhost postfix/postqueue[14520]: fatal: Queue report unavailable - mail system is down
Jan 18 20:54:04 localhost postfix/postqueue[15016]: fatal: Queue report unavailable - mail system is down
Jan 18 20:55:07 localhost postfix/postqueue[15991]: fatal: Queue report unavailable - mail system is down
Jan 18 12:55:31 localhost postfix/postfix-script: warning: not owned by root: /opt/zimbra/postfix-2.2.5/conf/main.cf
Jan 18 12:55:31 localhost postfix/postfix-script: starting the Postfix mail system
Jan 18 12:55:31 localhost postfix/master[16929]: fatal: bind 0.0.0.0 port 25: Address already in use
Jan 18 20:56:05 localhost postfix/postqueue[17436]: fatal: Queue report unavailable - mail system is down
Jan 18 20:57:06 localhost postfix/postqueue[17708]: fatal: Queue report unavailable - mail system is down
Jan 18 12:57:56 localhost postfix/postfix-script: warning: not owned by root: /opt/zimbra/postfix-2.2.5/conf/main.cf
Jan 18 12:57:56 localhost postfix/postfix-script: starting the Postfix mail system
Jan 18 12:57:56 localhost postfix/master[19344]: daemon started -- version 2.2.5, configuration /opt/zimbra/postfix-2.2.5/conf
Jan 18 13:11:33 localhost postfix/smtpd[30861]: initializing the server-side TLS engine
Jan 18 13:11:33 localhost postfix/smtpd[30861]: connect from localhost.localdomain[127.0.0.1]
Jan 18 13:11:33 localhost postfix/smtpd[30861]: setting up TLS connection from localhost.localdomain[127.0.0.1]
Jan 18 13:11:33 localhost postfix/smtpd[30861]: SSL_accept:before/accept initialization
Jan 18 13:11:33 localhost postfix/smtpd[30861]: read from 08222780 [0822EC10] (11 bytes => -1 (0xFFFFFFFF))
Jan 18 13:11:33 localhost postfix/smtpd[30861]: SSL_accept:error in SSLv2/v3 read client hello A
Jan 18 13:11:33 localhost postfix/smtpd[30861]: read from 08222780 [0822EC10] (11 bytes => 11 (0xB))
Jan 18 13:11:33 localhost postfix/smtpd[30861]: 0000 80 7c 01 03 01 00 63 00|00 00 10 .|....c. ...
Jan 18 13:11:33 localhost postfix/smtpd[30861]: read from 08222780 [0822EC1B] (115 bytes => -1 (0xFFFFFFFF))
Jan 18 13:11:33 localhost postfix/smtpd[30861]: SSL_accept:error in SSLv2/v3 read client hello B
Jan 18 13:11:33 localhost postfix/smtpd[30861]: read from 08222780 [0822EC1B] (115 bytes => 115 (0x73))
Jan 18 13:11:33 localhost postfix/smtpd[30861]: 0000 00 00 39 00 00 38 00 00|35 00 00 16 00 00 13 00 ..9..8.. 5.......
Jan 18 13:11:33 localhost postfix/smtpd[30861]: 0010 00 0a 07 00 c0 00 00 33|00 00 32 00 00 2f 03 00 .......3 ..2../..
Jan 18 13:11:33 localhost postfix/smtpd[30861]: 0020 80 00 00 66 00 00 05 00|00 04 01 00 80 08 00 80 ...f.... ........
Jan 18 13:11:33 localhost postfix/smtpd[30861]: 0030 00 00 63 00 00 62 00 00|61 00 00 15 00 00 12 00 ..c..b.. a.......
Jan 18 13:11:33 localhost postfix/smtpd[30861]: 0040 00 09 06 00 40 00 00 65|00 00 64 00 00 60 00 00 ....@..e ..d..`..
Jan 18 13:11:33 localhost postfix/smtpd[30861]: 0050 14 00 00 11 00 00 08 00|00 06 04 00 80 00 00 03 ........ ........
Jan 18 13:11:33 localhost postfix/smtpd[30861]: 0060 02 00 80 d5 10 f6 45 02|20 3c 8c 9b 86 7d fd 05 ......E. <...}..
Jan 18 13:11:33 localhost postfix/smtpd[30861]: 0070 85 1e 0a

[marcmac]

you're running a non-zimbra saslauthd, which is why the zimbra version won't start (and why postfix won't start). And there's something else listening on port 25 - you'll want to kill that, too.

What did you get from
ldd /opt/zimbra/postfix/libexec/master?