No email in or out

[ValueVPS]

Hi, as the title says, i have no mail going in or out of the server. Email sent to it dissapears. Trying to send an email from within zimbra gives the following error:

A network service error has occurred.
method: SendMsgRequest
msg: system failure: Unable to send message
code: service.FAILURE
detail: soap:Receiver
trace: btpool0-15://mail.wirednetworks.info/service/soap/SendMsgRequest:1263314153527:3d1e245185b93ccc
request:

Body: {
SendMsgRequest: {
_jsns: "urn:zimbraMail",
m: {
e: [
0: {
a: "support@xxxxxxxxx.co.uk",
t: "t"
},
1: {
a: "dave@wirednetworks.info",
p: "David Austen",
t: "f"
}
],
idnt: "24c36866-4146-4a14-9c6e-cdbb6c8c9104",
mp: [
0: {
content: {
_content: "hello"
},
ct: "text/plain"
}
],
su: {
_content: "test1"
}
},
suid: 1263314038103
}
},
Header: {
context: {
_jsns: "urn:zimbra",
account: {
_content: "dave@wirednetworks.info",
by: "name"
},
authToken: "(removed)",
notify: {
seq: 1
},
session: {
_content: 15,
id: 15
},
userAgent: {
name: "ZimbraWebClient - FF3.0 (Win)",
version: "6.0.4_GA_2038.RHEL5_64"
}
}
}

cat /etc/hosts

127.0.0.1 localhost.localdomain localhost
193.104.35.243 mail.wirednetworks.info

cat /etc/resolv.conf

nameserver 82.138.232.200
nameserver 82.138.233.155

dig wirednetworks.info mx

;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 31685
;; flags: qr rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 2, ADDITIONAL: 3

;; QUESTION SECTION:
;wirednetworks.info. IN MX

;; ANSWER SECTION:
wirednetworks.info. 14064 IN MX 10 mail.wirednetworks.info.

;; AUTHORITY SECTION:
wirednetworks.info. 11432 IN NS ns4.wnservers.com.
wirednetworks.info. 11432 IN NS ns5.wnservers.com.

;; ADDITIONAL SECTION:
mail.wirednetworks.info. 11432 IN A 193.104.35.243
ns4.wnservers.com. 4582 IN A 193.104.35.64
ns5.wnservers.com. 4582 IN A 193.104.35.65

;; Query time: 1 msec
;; SERVER: 82.138.232.200#53(82.138.232.200)
;; WHEN: Tue Jan 12 11:52:15 2010
;; MSG SIZE rcvd: 154

dig wirednetworks.info any

; <<>> DiG 9.3.6-P1-RedHat-9.3.6-4.P1.el5_4.1 <<>> wirednetworks.info any
;; global options: printcmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 61100
;; flags: qr rd ra; QUERY: 1, ANSWER: 3, AUTHORITY: 2, ADDITIONAL: 3

;; QUESTION SECTION:
;wirednetworks.info. IN ANY

;; ANSWER SECTION:
wirednetworks.info. 11392 IN NS ns4.wnservers.com.
wirednetworks.info. 11392 IN NS ns5.wnservers.com.
wirednetworks.info. 14024 IN MX 10 mail.wirednetworks.info.

;; AUTHORITY SECTION:
wirednetworks.info. 11392 IN NS ns4.wnservers.com.
wirednetworks.info. 11392 IN NS ns5.wnservers.com.

;; ADDITIONAL SECTION:
ns4.wnservers.com. 4542 IN A 193.104.35.64
ns5.wnservers.com. 4542 IN A 193.104.35.65
mail.wirednetworks.info. 11392 IN A 193.104.35.243

;; Query time: 2 msec
;; SERVER: 82.138.232.200#53(82.138.232.200)
;; WHEN: Tue Jan 12 11:52:56 2010
;; MSG SIZE rcvd: 182

host `hostname` <--backticks not single quotes

mail.wirednetworks.info has address 193.104.35.243

[uxbod]

Please check /var/log/zimbra.log for any error messages from Postfix. Telnet to port 25 on your server does not respond with the banner message. Also if you could post

su - zimbra
zmcontrol -v
zmhostname

[ValueVPS]

zmcontrol -v

Release 6.0.4_GA_2038.RHEL5_64_20091214192925 CentOS5_64 FOSS edition.

zmhostname
mail.wirednetworks.info


I have checked zimbra.log - nothing in it (zero bytes file)

[uxbod]

If the file is zero bytes then something must be wrong with permissions. As root execute

/opt/zimbra/libexec/zmfixperms --extended
su - zimbra
zmcontrol stop
zmcontrol start
zmcontrol status

and then check /var/log/zimbra.log

[ValueVPS]

Done all that, still nothing in that log file. And according to zmcontrol status, all services are running.

-rw-r--r-- 1 zimbra zimbra 0 Jan 12 20:56 zimbra-stats.log
-rw-r--r-- 1 zimbra zimbra 0 Jan 12 20:56 zimbra.log

[uxbod]

ps aux | grep zimbra

Are any of the log files under /opt/zimbra/log being updated ?

[ValueVPS]

a bit messy but here goes:

[root@mail log]#ps aux | grep zimbra
zimbra 14394 0.0 2.2 261996 48016 ? Ssl 05:26 0:01 /opt/zimbra/openldap/sbin/slapd -l LOCAL0 -4 -u zimbra -h ldap://mail.wirednetworks.info:389 ldapi:/// -F /opt/zimbra/data/ldap/config
zimbra 16113 0.0 0.4 43192 9124 ? Ss 05:27 0:00 /opt/zimbra/libexec/logswatch --config-file=/opt/zimbra/conf/logswatchrc --use-cpan-file-tail --pid-file=/opt/zimbra/log/logswatch.pid --daemon --script-dir=/opt/zimbra/data/tmp -t /var/log/zimbra-stats.log
zimbra 16219 0.1 0.5 51392 11588 pts/1 S 05:27 0:01 /usr/bin/perl /opt/zimbra/libexec/zmmtaconfig
zimbra 16236 0.0 0.0 8820 1352 pts/1 S 05:27 0:00 /bin/sh /opt/zimbra/mysql/bin/mysqld_safe --defaults-file=/opt/zimbra/conf/my.cnf --external-locking --log-error=/opt/zimbra/log/mysql_error.log --ledir=/opt/zimbra/mysql/libexec
zimbra 16330 0.0 5.2 860624 110872 pts/1 Sl 05:27 0:00 /opt/zimbra/mysql/libexec/mysqld --defaults-file=/opt/zimbra/conf/my.cnf --basedir=/opt/zimbra/mysql --datadir=/opt/zimbra/db/data --pid-file=/opt/zimbra/db/mysql.pid --skip-external-locking --port=7306 --socket=/opt/zimbra/db/mysql.sock --external-locking
root 19086 0.0 0.0 3788 404 ? Ss 05:27 0:00 /opt/zimbra/libexec/zmmailboxdmgr start -server -Djava.awt.headless=true -XX:+UseConcMarkSweepGC -XX:NewRatio=2 -XX:PermSize=128m -XX:MaxPermSize=128m -XX:SoftRefLRUPolicyMSPerMB=1 -verbose:gc -XX:+PrintGCDetails -XX:+PrintGCTimeStamps -XX:+PrintGCApplicationStoppedTime -Xss256k -Xms819m -Xmx819m -Xmn204m
zimbra 19087 0.9 14.2 1337496 299508 ? Sl 05:27 0:15 /opt/zimbra/java/bin/java -server -Djava.awt.headless=true -XX:+UseConcMarkSweepGC -XX:NewRatio=2 -XX:PermSize=128m -XX:MaxPermSize=128m -XX:SoftRefLRUPolicyMSPerMB=1 -verbose:gc -XX:+PrintGCDetails -XX:+PrintGCTimeStamps -XX:+PrintGCApplicationStoppedTime -Xss256k -Xms819m -Xmx819m -Xmn204m -Djava.io.tmpdir=/opt/zimbra/mailboxd/work
-Djava.library.path=/opt/zimbra/lib -Djava.endorsed.dirs=/opt/zimbra/mailboxd/common/endorsed -Dzimbra.config=/opt/zimbra/conf/localconfig.xml -Djetty.home=/opt/zimbra/mailboxd -DSTART=/opt/zimbra/mailboxd/etc/start.config -jar /opt/zimbra/mailboxd/start.jar /opt/zimbra/mailboxd/etc/jetty.properties /opt/zimbra/mailboxd/etc/jetty-setuid.xml /opt/zimbra/mailboxd/etc/jetty.xml
zimbra 19150 0.0 3.9 197580 83592 ? Ss 05:27 0:00 amavisd (master)
zimbra 19228 0.0 0.0 17712 860 ? Ss 05:27 0:00 /opt/zimbra/clamav/bin/freshclam --config-file=/opt/zimbra/conf/freshclam.conf --quiet --daemon
--checks=12
zimbra 19229 0.0 3.9 197580 82132 ? S 05:27 0:00 amavisd (virgin
child)
zimbra 19230 0.0 3.9 197580 82116 ? S 05:27 0:00 amavisd (virgin
child)
zimbra 19231 0.0 3.9 197580 82116 ? S 05:27 0:00 amavisd (virgin
child)
zimbra 19232 0.0 3.9 197580 82116 ? S 05:27 0:00 amavisd (virgin
child)
zimbra 19233 0.0 3.9 197580 82116 ? S 05:27 0:00 amavisd (virgin
child)

zimbra 19235 0.0 3.9 197580 82116 ? S 05:27 0:00 amavisd (virgin
child)
zimbra 19236 0.0 3.9 197580 82116 ? S 05:27 0:00 amavisd (virgin
child)
zimbra 19237 0.0 3.9 197580 82116 ? S 05:27 0:00 amavisd (virgin
child)
zimbra 19239 0.0 3.9 197580 82116 ? S 05:27 0:00 amavisd (virgin
child)
zimbra 19240 0.0 3.9 197580 82116 ? S 05:27 0:00 amavisd (virgin
child)
zimbra 19250 0.2 6.0 155260 126348 ? Ssl 05:27 0:04 /opt/zimbra/clamav/sbin/clamd --config-file=/opt/zimbra/conf/clamd.conf
zimbra 19272 0.0 0.3 33816 7000 pts/1 S 05:27 0:00 /usr/bin/perl /opt/zimbra/libexec/swatch --config-file=/opt/zimbra/conf/swatchrc --use-cpan-file-tail --script-dir=/opt/zimbra/data/tmp -t /var/log/zimbra.log
zimbra 19289 0.0 0.2 52984 4656 ? Ss 05:27 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
zimbra 19291 0.0 0.1 52984 3100 ? S 05:27 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
zimbra 19292 0.0 0.1 52984 3100 ? S 05:27 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
zimbra 19293 0.0 0.1 52984 3100 ? S 05:27 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
zimbra 19294 0.0 0.1 52984 3100 ? S 05:27 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
zimbra 19295 0.0 0.1 52984 3100 ? S 05:27 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
zimbra 19297 0.0 0.4 43324 10104 pts/1 S 05:27 0:00 /usr/bin/perl /opt/zimbra/data/tmp/.swatch_script.19272
root 21239 0.0 0.1 43004 2220 ? Ss 05:28 0:00 /opt/zimbra/postfix/libexec/master
zimbra 21247 0.0 0.0 53548 952 ? Ss 05:28 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
zimbra 21249 0.0 0.0 53548 684 ? S 05:28 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
zimbra 21250 0.0 0.0 53548 672 ? S 05:28 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
zimbra 21251 0.0 0.0 53548 672 ? S 05:28 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
zimbra 21252 0.0 0.0 53548 672 ? S 05:28 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
zimbra 21485 0.0 0.3 41700 6756 pts/1 S 05:28 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-proc
zimbra 21487 0.0 0.3 41440 6476 pts/1 S 05:28 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-cpu
zimbra 21489 0.0 0.3 41440 6468 pts/1 S 05:28 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-vm
zimbra 21491 0.0 0.3 41436 6488 pts/1 S 05:28 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-io -x
zimbra 21493 0.0 0.3 41440 6424 pts/1 S 05:28 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-df
zimbra 21497 0.0 0.3 41440 6472 pts/1 S 05:28 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-io
zimbra 21524 0.0 0.3 41304 6368 pts/1 S 05:28 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-fd
zimbra 21531 0.1 0.3 44560 7512 pts/1 S 05:28 0:01 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-allprocs
zimbra 21546 0.0 0.3 41568 6568 pts/1 S 05:28 0:00 /usr/bin/perl -w? /opt/zimbra/libexec/zmstat-mysql
zimbra 21560 0.0 0.3 41308 6388 pts/1 S 05:28 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-mtaqueue
zimbra 21763 0.0 0.0 46888 1520 ? S 05:54 0:00 crond
zimbra 21764 0.8 0.2 35300 4276 ? Ss 05:54 0:00 /usr/bin/perl /opt/zimbra/libexec/zmstatuslog
zimbra 21779 1.2 0.3 41692 6668 ? S 05:54 0:00 /usr/bin/perl /opt/zimbra/bin/zmcontrol status
zimbra 22007 0.0 0.0 8812 1212 ? S 05:54 0:00 sh -c /opt/zimbra/bin/zmantispamctl status > /opt/zimbra/data/tmp/zmcontrol.status.loDRj 2> /opt/zimbra/data/tmp/zmcontrol.error.TSI8c
zimbra 22008 0.0 0.0 8812 1364 ? S 05:54 0:00 /bin/bash /opt/zimbra/bin/zmantispamctl status
zimbra 22015 0.0 0.0 3824 720 pts/1 S 05:28 0:00 /usr/bin/iostat
-d -k -x 30
zimbra 22016 0.0 0.0 3824 720 pts/1 S 05:28 0:00 /usr/bin/iostat
-d -k 30
zimbra 22017 0.0 0.0 5864 596 pts/1 S 05:28 0:00 /usr/bin/vmstat -n -S K 30
zimbra 22018 0.0 0.0 8812 748 ? S 05:54 0:00 /bin/bash /opt/zimbra/bin/zmantispamctl status
zimbra 22019 0.0 0.0 8812 1280 ? R 05:54 0:00 /bin/bash /opt/zimbra/libexec/get_plat_tag.sh
root 22023 0.0 0.0 6024 648 pts/1 R+ 05:54 0:00 grep zimbra
[root@mail log]#

[uxbod]

Would you try shutting down zimbra, removing /var/log/zimbra.log, and the restart please. Are the other zimbra log files being updated ?

[ValueVPS]

Ok, deleted the log file, shutdown zimbra and then restarted it - some logs were updated:

before:

-rw------- 1 root root 0 Dec 2 17:16 boot.log
-rw------- 1 root utmp 64128 Jan 12 12:44 btmp
-rw------- 1 root root 73941 Jan 13 06:32 cron
-rw-r--r-- 1 root root 5427 Jan 12 20:44 dmesg
-rw------- 1 root root 16064 Jan 12 11:01 faillog
-rw------- 1 root root 609875 Jan 13 06:32 maillog
-rw------- 1 root root 22360188 Jan 13 06:32 messages
-rw-r--r-- 1 root root 5846 Jan 13 04:02 rpmpkgs
drwxr-xr-x 2 root root 4096 Jan 13 00:00 sa
-rw------- 1 root root 537381 Jan 13 06:32 secure
-rw------- 1 root root 0 Dec 2 17:16 spooler
-rw------- 1 root root 0 Dec 2 17:21 tallylog
-rw-rw-r-- 1 root utmp 72576 Jan 13 06:28 wtmp
-rw-r--r-- 1 root root 2160 Jan 12 20:40 yum.log
-rw-r--r-- 1 zimbra zimbra 0 Jan 12 20:56 zimbra-stats.log

After restart:

[zimbra@mail log]#ls -l
total 23344
-rw------- 1 root root 0 Dec 2 17:16 boot.log
-rw------- 1 root utmp 64128 Jan 12 12:44 btmp
-rw------- 1 root root 74299 Jan 13 06:38 cron
-rw-r--r-- 1 root root 5427 Jan 12 20:44 dmesg
-rw------- 1 root root 16064 Jan 12 11:01 faillog
-rw------- 1 root root 613249 Jan 13 06:38 maillog
-rw------- 1 root root 22453376 Jan 13 06:39 messages
-rw-r--r-- 1 root root 5846 Jan 13 04:02 rpmpkgs
drwxr-xr-x 2 root root 4096 Jan 13 00:00 sa
-rw------- 1 root root 540322 Jan 13 06:38 secure
-rw------- 1 root root 0 Dec 2 17:16 spooler
-rw------- 1 root root 0 Dec 2 17:21 tallylog
-rw-rw-r-- 1 root utmp 72576 Jan 13 06:28 wtmp
-rw-r--r-- 1 root root 2160 Jan 12 20:40 yum.log
-rw-r--r-- 1 zimbra zimbra 0 Jan 12 20:56 zimbra-stats.log

the zimbra.log file was not recreated.

[uxbod]

Hmmm, what are the permission on /var and /var/log. Is SElinux disabled ? Anything in /var/log/messages ?