Page 1 of 3 123 LastLast
Results 1 to 10 of 21

Thread: [SOLVED] Postfix unavailable - queue down

  1. #1
    pmona is offline Active Member
    Join Date
    Jan 2010
    Posts
    26
    Rep Power
    5

    Exclamation [SOLVED] Postfix unavailable - queue down

    I have this same problem. Last night my server stopped sending/receiving mail. I have gone through this post and many other and have not yet found an answer for this problem. I could not find anything in the logs which indicated a problem. Below is output from the commands requested in this and other posts.



    [zimbra@zimbra ~]$ cat /etc/hosts
    # Do not remove the following line, or various programs
    # that require network functionality will fail.
    127.0.0.1 localhost.localdomain localhost
    172.20.1.4 zimbra.monafamily.com zimbra
    [zimbra@zimbra ~]$ cat /etc/resolv.conf
    search monafamily.com
    nameserver 172.20.1.4
    #nameserver 172.20.1.1
    #nameserver 172.20.1.2
    [zimbra@zimbra ~]$ dig monafamily.com mx

    ; <<>> DiG 9.3.6-P1-RedHat-9.3.6-4.P1.el5_4.1 <<>> monafamily.com mx
    ;; global options: printcmd
    ;; Got answer:
    ;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 26221
    ;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 2, ADDITIONAL: 2

    ;; QUESTION SECTION:
    ;monafamily.com. IN MX

    ;; ANSWER SECTION:
    monafamily.com. 86400 IN MX 10 zimbra.monafamily.com.

    ;; AUTHORITY SECTION:
    monafamily.com. 86400 IN NS ns1.commpartners.us.
    monafamily.com. 86400 IN NS ns1.monafamily.com.

    ;; ADDITIONAL SECTION:
    zimbra.monafamily.com. 86400 IN A 172.20.1.4
    ns1.commpartners.us. 42686 IN A 204.14.36.99

    ;; Query time: 1 msec
    ;; SERVER: 172.20.1.4#53(172.20.1.4)
    ;; WHEN: Wed Jan 20 10:07:52 2010
    ;; MSG SIZE rcvd: 138

    [zimbra@zimbra ~]$ dig monafamily.com any

    ; <<>> DiG 9.3.6-P1-RedHat-9.3.6-4.P1.el5_4.1 <<>> monafamily.com any
    ;; global options: printcmd
    ;; Got answer:
    ;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 7616
    ;; flags: qr aa rd ra; QUERY: 1, ANSWER: 5, AUTHORITY: 0, ADDITIONAL: 2

    ;; QUESTION SECTION:
    ;monafamily.com. IN ANY

    ;; ANSWER SECTION:
    monafamily.com. 86400 IN SOA monafamily.com. webmaster.monafamily.com. 2009123100 3600 600 604800 3600
    monafamily.com. 86400 IN NS ns1.monafamily.com.
    monafamily.com. 86400 IN NS ns1.commpartners.us.
    monafamily.com. 86400 IN MX 10 zimbra.monafamily.com.
    monafamily.com. 86400 IN A 172.20.1.4

    ;; ADDITIONAL SECTION:
    ns1.commpartners.us. 42680 IN A 204.14.36.99
    zimbra.monafamily.com. 86400 IN A 172.20.1.4

    ;; Query time: 1 msec
    ;; SERVER: 172.20.1.4#53(172.20.1.4)
    ;; WHEN: Wed Jan 20 10:07:58 2010
    ;; MSG SIZE rcvd: 200

    [zimbra@zimbra ~]$ host `hostname`
    zimbra.monafamily.com has address 172.20.1.4
    [zimbra@zimbra ~]$
    [zimbra@zimbra ~]$ zmcontrol -v


    Release 6.0.4_GA_2038.RHEL5_20091214191028 CentOS5 FOSS edition.
    [zimbra@zimbra ~]$ postfix check
    postfix/postfix-script: warning: not owned by root: /opt/zimbra/data/postfix/spool
    postfix/postfix-script: warning: not owned by root: /opt/zimbra/postfix-2.6.5.2z/conf/main.cf
    postfix/postfix-script: warning: not owned by root: /opt/zimbra/postfix-2.6.5.2z/conf/master.cf
    postfix/postfix-script: warning: not owned by root: /opt/zimbra/postfix-2.6.5.2z/conf/master.cf.in
    [zimbra@zimbra ~]$
    [zimbra@zimbra ~]$ ps aux | grep zimbra
    avahi 2431 0.0 0.0 2600 1376 ? Ss 09:59 0:00 avahi-daemon: running [zimbra.local]
    zimbra 2547 0.2 1.4 137744 30240 ? Ssl 09:59 0:01 /opt/zimbra/openldap/sbin/slapd -l LOCAL0 -4 -u zimbra -h ldap://zimbra.monafamily.com:389 ldapi:/// -F /opt/zimbra/data/ldap/config
    zimbra 4450 0.0 0.2 8792 5896 ? Ss 10:00 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 4451 0.0 0.2 18792 5804 ? S 10:00 0:00 /usr/bin/perl /opt/zimbra/libexec/zmlogger
    zimbra 4568 0.0 0.1 7800 3928 ? S 10:00 0:00 zmlogger: zmrrdfetch: server
    zimbra 4577 0.1 0.3 10068 7420 ? S 10:00 0:00 /usr/bin/perl /opt/zimbra/libexec/zmmtaconfig
    zimbra 4594 0.0 0.0 2560 1112 ? S 10:00 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 4734 0.4 4.0 287976 83852 ? Sl 10:00 0:02 /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 6822 0.0 0.0 1660 388 ? Ss 10:02 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 -Xms810m -Xmx810m -Xmn202m
    zimbra 6823 29.3 16.6 1154860 346232 ? Sl 10:02 2:12 /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 -Xms810m -Xmx810m -Xmn202m -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 7024 0.3 2.5 62088 52704 ? Ss 10:02 0:01 amavisd (master)
    zimbra 7071 0.0 2.4 62088 51328 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7072 0.0 2.4 62088 51300 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7073 0.0 2.4 62088 51300 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7074 0.0 2.4 62088 51300 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7075 0.0 2.4 62088 51300 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7076 0.0 2.4 62088 51300 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7079 0.0 2.4 62088 51300 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7080 0.0 2.4 62088 51300 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7081 0.0 2.4 62088 51300 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7082 0.0 2.4 62088 51300 ? S 10:02 0:00 amavisd (virgin child)
    zimbra 7118 0.0 0.0 3116 1356 ? Ss 10:02 0:00 /opt/zimbra/clamav/bin/freshclam --config-file=/opt/zimbra/conf/freshclam.conf --quiet --daemon --checks=12
    zimbra 7432 0.0 4.2 100536 87932 ? Ssl 10:02 0:00 /opt/zimbra/clamav/sbin/clamd --config-file=/opt/zimbra/conf/clamd.conf
    zimbra 7456 0.0 0.2 6748 4828 ? S 10:02 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 7476 0.0 0.3 8796 6724 ? S 10:02 0:00 /usr/bin/perl /opt/zimbra/data/tmp/.swatch_script.7456
    zimbra 7514 0.0 0.3 12304 6684 ? Ss 10:02 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 7529 0.0 0.3 14796 7716 ? S 10:02 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 7530 0.0 0.2 12304 6056 ? S 10:02 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 7531 0.0 0.2 12304 6056 ? S 10:02 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 7532 0.0 0.2 12304 6056 ? S 10:02 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 7533 0.0 0.2 12304 6056 ? S 10:02 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 7647 0.0 0.0 7436 804 ? Ss 10:02 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
    zimbra 7651 0.0 0.0 7436 552 ? S 10:02 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
    zimbra 7652 0.0 0.0 7436 540 ? S 10:02 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
    zimbra 7653 0.0 0.0 7436 540 ? S 10:02 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
    zimbra 7654 0.0 0.0 7436 540 ? S 10:02 0:00 /opt/zimbra/cyrus-sasl/sbin/saslauthd -r -a zimbra
    zimbra 7990 0.0 0.2 6684 4792 ? S 10:03 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-proc
    zimbra 7992 0.0 0.2 6432 4580 ? S 10:03 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-cpu
    zimbra 7994 0.0 0.2 6432 4584 ? S 10:03 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-vm
    zimbra 7996 0.0 0.2 6432 4652 ? S 10:03 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-io -x
    zimbra 7998 0.0 0.2 6432 4452 ? S 10:03 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-df
    zimbra 8000 0.0 0.2 6432 4584 ? S 10:03 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-io
    zimbra 8002 0.0 0.2 6428 4516 ? S 10:03 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-fd
    zimbra 8004 0.4 0.2 7132 5180 ? S 10:03 0:01 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-allprocs
    zimbra 8006 0.0 0.2 6568 4696 ? S 10:03 0:00 /usr/bin/perl -w? /opt/zimbra/libexec/zmstat-mysql
    zimbra 8109 0.0 0.2 6432 4556 ? S 10:03 0:00 /usr/bin/perl -w /opt/zimbra/libexec/zmstat-mtaqueue
    zimbra 8698 0.0 0.0 1688 456 ? S 10:03 0:00 /usr/bin/vmstat -n -S K 30
    zimbra 8699 0.0 0.0 1700 612 ? S 10:03 0:00 /usr/bin/iostat -d -k 30
    zimbra 8704 0.0 0.0 1700 644 ? S 10:03 0:00 /usr/bin/iostat -d -k -x 30
    root 9822 0.0 0.0 4920 1268 pts/0 S 10:04 0:00 su - zimbra
    zimbra 9823 0.0 0.0 4660 1504 pts/0 S 10:04 0:00 -bash
    zimbra 11508 0.0 0.2 12304 6056 ? S 10:06 0:00 /opt/zimbra/httpd-2.2.14/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 13815 3.3 0.7 411048 15804 ? Sl 10:09 0:00 /opt/zimbra/java/bin/java -XX:ErrorFile=/opt/zimbra/log -client -Xmx256m -Dzimbra.home=/opt/zimbra -Djava.library.path=/opt/zimbra/lib -Djava.ext.dirs=/opt/zimbra/java/jre/lib/ext:/opt/zimbra/lib/jars:/opt/zimbra/lib/ext-common:/opt/zimbra/lib/ext/clamscanner com.zimbra.cs.account.ProvUtil -l gs zimbra.monafamily.com
    zimbra 13987 0.0 0.0 2184 820 pts/0 R+ 10:09 0:00 ps aux
    zimbra 13988 0.0 0.0 1844 476 pts/0 R+ 10:09 0:00 grep zimbra
    [zimbra@zimbra ~]$
    [zimbra@zimbra ~]$ zmmtactl stop
    Stopping zmmtaconfig...done.
    postfix/postfix-script: fatal: the Postfix mail system is not running
    Stopping saslauthd...done.
    [zimbra@zimbra ~]$ zmmtactl start
    Rewriting configuration files...done.
    Starting zmmtaconfig...done.
    Starting saslauthd...done.
    [zimbra@zimbra ~]$

  2. #2
    pmona is offline Active Member
    Join Date
    Jan 2010
    Posts
    26
    Rep Power
    5

    Default

    I should have also noted that I tried to reinstall using install -s but there was no change.

    When attempting to send mail, I get the following error:

    An unknown error (mail.TRY_AGAIN) has occurred.msg: try again: Unable to connect to the MTA
    code: mail.TRY_AGAIN
    method: SendMsgRequest
    detail: soap:Receiver
    trace: btpool0-12://monafamily.com:8010/service/soap/SendMsgRequest:1264025039274:f029875c8986b6e7
    request: Body: { SendMsgRequest: { _jsns: "urn:zimbraMail", m: { e: { 0: { a: "pmona@commpartners.us", t: "t" }, 1: { a: "pmona@monafamily.com", p: "Paul Mona", t: "f" } }, id: "928323", idnt: "028db9fc-a9d8-4c42-a900-3e487498ddd0", irt: { _content: "<25808596.32.1263962479624.JavaMail.root@zimb ra>" }, mp: { 0: { content: { _content: "test" }, ct: "text/plain" } }, su: { _content: "test" } }, suid: 1264024901067 } }, Header: { context: { _jsns: "urn:zimbra", account: { _content: "pmona@monafamily.com", by: "name" }, authToken: "(removed)", session: { _content: 11, id: 11 }, userAgent: { name: "ZimbraWebClient - FF3.0 (Win)", version: "6.0.4_GA_2038.RHEL5" } } }

  3. #3
    uxbod's Avatar
    uxbod is offline Moderator
    Join Date
    Nov 2006
    Location
    UK
    Posts
    8,016
    Rep Power
    24

    Default

    When you restarted the MTA please check /var/log/zimbra.log for any error messages and post them please.

  4. #4
    pmona is offline Active Member
    Join Date
    Jan 2010
    Posts
    26
    Rep Power
    5

    Default

    I did a stop and start while tailing the zimbra log.


    [root@zimbra ~]# su - zimbra
    [zimbra@zimbra ~]$ zmcontrol stop
    Host zimbra.monafamily.com
    Stopping stats...Done.
    Stopping mta...Done.
    Stopping spell...Done.
    Stopping snmp...Done.
    Stopping archiving...Done.
    Stopping antivirus...Done.
    Stopping antispam...Done.
    Stopping imapproxy...Done.
    Stopping memcached...Done.
    Stopping mailbox...Done.
    Stopping logger...Done.
    Stopping ldap...Done.
    [zimbra@zimbra ~]$ zmcontrol start
    Host zimbra.monafamily.com
    Starting ldap...Done.
    Starting logger...Done.
    Starting mailbox...Done.
    Starting antispam...Done.
    Starting antivirus...Done.
    Starting snmp...Done.
    Starting spell...Done.
    Starting mta...Done.
    Starting stats...Done.
    [zimbra@zimbra ~]$ zmcontrol status
    Host zimbra.monafamily.com
    antispam Running
    antivirus Running
    ldap Running
    logger Running
    mailbox Running
    mta Running
    snmp Running
    spell Running
    stats Running
    [zimbra@zimbra ~]$


    Jan 20 17:28:26 zimbra zimbramon[21228]: 21228:info: Stopping services initiated by zmcontrol
    Jan 20 17:28:26 zimbra zimbramon[21228]: 21228:info: Stopping stats via zmcontrol
    Jan 20 17:28:26 zimbra zimbramon[21228]: 21228:info: Stopping mta via zmcontrol
    Jan 20 17:28:28 zimbra postfix/postfix-script[21317]: fatal: the Postfix mail system is not running
    Jan 20 17:28:28 zimbra saslauthd[31836]: server_exit : master exited: 31836
    Jan 20 17:28:29 zimbra zimbramon[21228]: 21228:info: Stopping spell via zmcontrol
    Jan 20 17:28:29 zimbra zimbramon[21228]: 21228:info: Stopping snmp via zmcontrol
    Jan 20 17:28:30 zimbra zimbramon[21228]: 21228:info: Stopping archiving via zmcontrol
    Jan 20 17:28:30 zimbra amavis[22797]: Net::Server: 2010/01/20-17:28:30 Server closing!
    Jan 20 17:28:36 zimbra zimbramon[21228]: 21228:info: Stopping antivirus via zmcontrol
    Jan 20 17:28:36 zimbra clamd[22933]: Pid file removed.
    Jan 20 17:28:36 zimbra clamd[22933]: --- Stopped at Wed Jan 20 17:28:36 2010
    Jan 20 17:28:38 zimbra zimbramon[21228]: 21228:info: Stopping antispam via zmcontrol
    Jan 20 17:28:39 zimbra zimbramon[21228]: 21228:info: Stopping imapproxy via zmcontrol
    Jan 20 17:28:39 zimbra zimbramon[21228]: 21228:info: Stopping memcached via zmcontrol
    Jan 20 17:28:39 zimbra zimbramon[21228]: 21228:info: Stopping mailbox via zmcontrol
    Jan 20 17:28:39 zimbra zmmailboxdmgr[21527]: status requested
    Jan 20 17:28:39 zimbra zmmailboxdmgr[21527]: status OK
    Jan 20 17:28:41 zimbra zmmailboxdmgr[21532]: stop requested
    Jan 20 17:28:41 zimbra zmmailboxdmgr[21532]: waiting for manager process 22721 to die
    Jan 20 17:28:41 zimbra zmmailboxdmgr[22721]: shutdown requested, sending TERM signal to 22722
    Jan 20 17:28:44 zimbra zmmailboxdmgr[22721]: mailboxd/JVM process exited (waitpid expected 22722 got 22722)
    Jan 20 17:28:44 zimbra zmmailboxdmgr[22721]: manager woke up from wait on mailboxd/JVM with pid 22722
    Jan 20 17:28:45 zimbra zmmailboxdmgr[21532]: manager process 22721 died, shutdown completed
    Jan 20 17:28:49 zimbra zimbramon[21228]: 21228:info: Stopping convertd via zmcontrol
    Jan 20 17:28:49 zimbra zimbramon[21228]: 21228:info: Stopping logger via zmcontrol
    Jan 20 17:28:51 zimbra zimbramon[21228]: 21228:info: Stopping ldap via zmcontrol
    Jan 20 17:28:51 zimbra slapd[18544]: daemon: shutdown requested and initiated.
    Jan 20 17:28:51 zimbra slapd[18544]: slapd shutdown: waiting for 0 operations/tasks to finish
    Jan 20 17:28:51 zimbra slapd[18544]: slapd stopped.
    Jan 20 17:29:37 zimbra zimbramon[21591]: 21591:info: Starting services initiated by zmcontrol
    Jan 20 17:29:37 zimbra slapd[21629]: @(#) $OpenLDAP: slapd 2.4.20 (Dec 4 2009 09:06:48) $ build@build10.lab.zimbra.com:/home/build/p4/GNR-604/ThirdParty/openldap/openldap-2.4.20.4z/servers/slapd
    Jan 20 17:29:37 zimbra slapd[21630]: slapd starting
    Jan 20 17:29:48 zimbra zimbramon[21591]: 21591:info: Rewriting configs antispam amavis antivirus amavis webxml mailbox amavis antispam antivirus mta sasl
    Jan 21 01:30:02 zimbra postfix/postqueue[22194]: fatal: Queue report unavailable - mail system is down
    Jan 20 17:30:02 zimbra zimbramon[22170]: 22170:info: 2010-01-20 17:30:02, QUEUE: 0 0
    Jan 20 17:30:02 zimbra sendmail[22195]: o0L1U2nC022195: from=zimbra, size=381, class=0, nrcpts=1, msgid=<201001210130.o0L1U2nC022195@zimbra.monafami ly.com>, relay=zimbra@localhost
    Jan 20 17:30:02 zimbra sendmail[22195]: o0L1U2nC022195: to=zimbra, ctladdr=zimbra (501/501), delay=00:00:00, xdelay=00:00:00, mailer=relay, pri=30381, relay=[127.0.0.1] [127.0.0.1], dsn=4.0.0, stat=Deferred: Connection refused by [127.0.0.1]
    Jan 20 17:30:21 zimbra zmmailboxdmgr[22910]: status requested
    Jan 20 17:30:21 zimbra zmmailboxdmgr[22910]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
    Jan 20 17:30:21 zimbra zmmailboxdmgr[22910]: assuming no other instance is running
    Jan 20 17:30:21 zimbra zmmailboxdmgr[22910]: file /opt/zimbra/log/zmmailboxd.pid does not exist
    Jan 20 17:30:21 zimbra zmmailboxdmgr[22910]: assuming no other instance is running
    Jan 20 17:30:21 zimbra zmmailboxdmgr[22910]: no manager process is running
    Jan 20 17:30:37 zimbra zimbramon[21591]: 21591:info: Starting logger via zmcontrol
    Jan 20 17:30:44 zimbra zimbramon[21591]: 21591:info: Starting mailbox via zmcontrol
    Jan 20 17:30:45 zimbra zimbramon[23661]: 23661:info: zmmtaconfig: zmmtaconfig started on zimbra.monafamily.com with loglevel=3 pid=23661
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25882]: status requested
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25882]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25882]: assuming no other instance is running
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25882]: file /opt/zimbra/log/zmmailboxd.pid does not exist
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25882]: assuming no other instance is running
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25882]: no manager process is running
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25900]: start requested
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25900]: checking if another instance of manager is already running
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25900]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25900]: assuming no other instance is running
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25900]: file /opt/zimbra/log/zmmailboxd.pid does not exist
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25900]: assuming no other instance is running
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25901]: wrote manager pid 25901 to /opt/zimbra/log/zmmailboxd_manager.pid
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25902]: wrote java pid 25902 to /opt/zimbra/log/zmmailboxd_java.pid
    Jan 20 17:32:05 zimbra zmmailboxdmgr[25901]: manager started mailboxd/JVM with pid 25902
    Jan 20 17:32:05 zimbra zimbramon[21591]: 21591:info: Starting antispam via zmcontrol
    Jan 20 17:32:11 zimbra amavis[25989]: starting. /opt/zimbra/amavisd/sbin/amavisd at zimbra.monafamily.com amavisd-new-2.6.4 (20090625), Unicode aware, LC_ALL="C", LANG="en_US.UTF-8"
    Jan 20 17:32:11 zimbra amavis[25989]: user=501, EUID: 501 (501); group=, EGID: 501 502 501 5 4 (501 502 501 5 4)
    Jan 20 17:32:11 zimbra amavis[25989]: Perl version 5.008008
    Jan 20 17:32:14 zimbra amavis[25989]: SpamControl: init_pre_chroot on SpamAssassin done
    Jan 20 17:32:14 zimbra amavis[26055]: Net::Server: Process Backgrounded
    Jan 20 17:32:14 zimbra amavis[26055]: Net::Server: 2010/01/20-17:32:14 Amavis (type Net::Server::PreForkSimple) starting! pid(26055)
    Jan 20 17:32:14 zimbra zimbramon[21591]: 21591:info: Starting antivirus via zmcontrol
    Jan 20 17:32:14 zimbra amavis[26055]: Net::Server: Binding to UNIX socket file /opt/zimbra/data/amavisd/amavisd.sock using SOCK_STREAM
    Jan 20 17:32:14 zimbra amavis[26055]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1
    Jan 20 17:32:14 zimbra amavis[26055]: Net::Server: Group Not Defined. Defaulting to EGID '501 502 501 5 4'
    Jan 20 17:32:14 zimbra amavis[26055]: Net::Server: User Not Defined. Defaulting to EUID '501'
    Jan 20 17:32:14 zimbra amavis[26055]: Module Amavis::Conf 2.207
    Jan 20 17:32:14 zimbra amavis[26055]: Module Archive::Zip 1.30
    Jan 20 17:32:14 zimbra amavis[26055]: Module Compress::Zlib 1.42
    Jan 20 17:32:14 zimbra amavis[26055]: Module Convert::TNEF 0.17
    Jan 20 17:32:14 zimbra amavis[26055]: Module Convert::UUlib 1.32
    Jan 20 17:32:14 zimbra amavis[26055]: Module Crypt::OpenSSL::RSA 0.25
    Jan 20 17:32:14 zimbra amavis[26055]: Module DBD::mysql 4.013
    Jan 20 17:32:14 zimbra amavis[26055]: Module DBI 1.609
    Jan 20 17:32:14 zimbra amavis[26055]: Module DB_File 1.82
    Jan 20 17:32:14 zimbra amavis[26055]: Module Digest::MD5 2.36
    Jan 20 17:32:14 zimbra amavis[26055]: Module Digest::SHA 5.47
    Jan 20 17:32:14 zimbra amavis[26055]: Module Digest::SHA1 2.12
    Jan 20 17:32:14 zimbra amavis[26055]: Module IO::Socket::INET6 2.56
    Jan 20 17:32:14 zimbra amavis[26055]: Module MIME::Entity 5.427
    Jan 20 17:32:14 zimbra amavis[26055]: Module MIME::Parser 5.427
    Jan 20 17:32:14 zimbra amavis[26055]: Module MIME::Tools 5.427
    Jan 20 17:32:14 zimbra amavis[26055]: Module Mail:KIM::Signer 0.37
    Jan 20 17:32:14 zimbra amavis[26055]: Module Mail:KIM::Verifier 0.37
    Jan 20 17:32:14 zimbra amavis[26055]: Module Mail::Header 2.04
    Jan 20 17:32:14 zimbra amavis[26055]: Module Mail::Internet 2.04
    Jan 20 17:32:14 zimbra amavis[26055]: Module Mail::SpamAssassin 3.002005
    Jan 20 17:32:14 zimbra amavis[26055]: Module Net:NS 0.65
    Jan 20 17:32:14 zimbra amavis[26055]: Module Net::LDAP 0.39
    Jan 20 17:32:14 zimbra amavis[26055]: Module Net::Server 0.97
    Jan 20 17:32:14 zimbra amavis[26055]: Module Socket6 0.23
    Jan 20 17:32:14 zimbra amavis[26055]: Module Time::HiRes 1.9719
    Jan 20 17:32:14 zimbra amavis[26055]: Module URI 1.40
    Jan 20 17:32:14 zimbra amavis[26055]: Module Unix::Syslog 1.1
    Jan 20 17:32:14 zimbra amavis[26055]: Amavis:B code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: Amavis::Cache code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: SQL base code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: SQL::Log code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: SQL::Quarantine NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: Lookup::SQL code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: Lookup::LDAP code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: AM.PDP-in proto code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: SMTP-in proto code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: Courier proto code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: SMTP-out proto code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: Pipe-out proto code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: BSMTP-out proto code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: Local-out proto code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: OS_Fingerprint code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: ANTI-VIRUS code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: ANTI-SPAM code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: ANTI-SPAM-EXT code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: ANTI-SPAM-C code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: ANTI-SPAM-SA code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: Unpackers code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: DKIM code loaded
    Jan 20 17:32:14 zimbra amavis[26055]: Tools code NOT loaded
    Jan 20 17:32:14 zimbra amavis[26055]: Found $file at /usr/bin/file
    Jan 20 17:32:14 zimbra amavis[26055]: No $altermime, not using it
    Jan 20 17:32:14 zimbra amavis[26055]: Internal decoder for .mail
    Jan 20 17:32:14 zimbra amavis[26055]: Internal decoder for .asc
    Jan 20 17:32:14 zimbra amavis[26055]: Internal decoder for .uue
    Jan 20 17:32:14 zimbra amavis[26055]: Internal decoder for .hqx
    Jan 20 17:32:14 zimbra amavis[26055]: Internal decoder for .ync
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .F tried: unfreeze, freeze -d, melt, fcat
    Jan 20 17:32:14 zimbra amavis[26055]: Found decoder for .Z at /usr/bin/gzip -d
    Jan 20 17:32:14 zimbra amavis[26055]: Found decoder for .gz at /usr/bin/gzip -d
    Jan 20 17:32:14 zimbra amavis[26055]: Found decoder for .bz2 at /usr/bin/bzip2 -d
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .lzo tried: lzop -d
    Jan 20 17:32:14 zimbra amavis[26055]: Found decoder for .rpm at /usr/bin/rpm2cpio
    Jan 20 17:32:14 zimbra amavis[26055]: Found decoder for .cpio at /usr/bin/pax
    Jan 20 17:32:14 zimbra amavis[26055]: Found decoder for .tar at /usr/bin/pax
    Jan 20 17:32:14 zimbra amavis[26055]: Found decoder for .deb at /usr/bin/ar
    Jan 20 17:32:14 zimbra amavis[26055]: Internal decoder for .zip
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .7z tried: 7zr, 7za, 7z
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .rar tried: rar, unrar
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .arj tried: arj, unarj
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .arc tried: nomarch, arc
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .zoo tried: zoo, unzoo
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .lha tried: lha
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .cab tried: cabextract
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .tnef tried: tnef
    Jan 20 17:32:14 zimbra amavis[26055]: Internal decoder for .tnef
    Jan 20 17:32:14 zimbra amavis[26055]: No decoder for .exe tried: rar, unrar; lha; arj, unarj
    Jan 20 17:32:14 zimbra amavis[26055]: Using primary internal av scanner code for ClamAV-clamd
    Jan 20 17:32:15 zimbra amavis[26055]: initializing Mail::SpamAssassin
    Jan 20 17:32:16 zimbra clamd[26137]: clamd daemon 0.95.3-broken-compiler (OS: linux-gnu, ARCH: i386, CPU: i686)
    Jan 20 17:32:16 zimbra clamd[26137]: Log file size limited to 20971520 bytes.
    Jan 20 17:32:16 zimbra clamd[26137]: Reading databases from /opt/zimbra/data/clamav/db
    Jan 20 17:32:16 zimbra clamd[26137]: Not loading PUA signatures.
    Jan 20 17:32:20 zimbra amavis[26055]: SpamControl: init_pre_fork on SpamAssassin done
    Jan 20 17:32:27 zimbra zmmailboxdmgr[26325]: status requested
    Jan 20 17:32:27 zimbra zmmailboxdmgr[26325]: status OK
    Jan 20 17:32:31 zimbra clamd[26137]: Loaded 701211 signatures.
    Jan 20 17:32:31 zimbra clamd[26137]: TCP: Bound to port 3310
    Jan 20 17:32:31 zimbra clamd[26137]: TCP: Setting connection queue length to 15
    Jan 20 17:32:31 zimbra clamd[26390]: Limits: Global size limit set to 10240000 bytes.
    Jan 20 17:32:31 zimbra clamd[26390]: Limits: File size limit set to 10240000 bytes.
    Jan 20 17:32:31 zimbra clamd[26390]: Limits: Recursion level limit set to 16.
    Jan 20 17:32:31 zimbra clamd[26390]: Limits: Files limit set to 10000.
    Jan 20 17:32:31 zimbra clamd[26390]: Archive support enabled.
    Jan 20 17:32:31 zimbra clamd[26390]: Archive: Blocking encrypted archives.
    Jan 20 17:32:31 zimbra clamd[26390]: Algorithmic detection enabled.
    Jan 20 17:32:31 zimbra clamd[26390]: Portable Executable support enabled.
    Jan 20 17:32:31 zimbra clamd[26390]: ELF support enabled.
    Jan 20 17:32:31 zimbra clamd[26390]: Mail files support enabled.
    Jan 20 17:32:31 zimbra clamd[26390]: OLE2 support enabled.
    Jan 20 17:32:31 zimbra clamd[26390]: PDF support enabled.
    Jan 20 17:32:31 zimbra clamd[26390]: HTML support enabled.
    Jan 20 17:32:31 zimbra clamd[26390]: Self checking every 600 seconds.
    Jan 20 17:32:31 zimbra zimbramon[21591]: 21591:info: Starting snmp via zmcontrol
    Jan 20 17:32:31 zimbra zimbramon[21591]: 21591:info: Starting spell via zmcontrol
    Jan 20 17:32:32 zimbra zimbramon[21591]: 21591:info: Starting mta via zmcontrol
    Jan 20 17:32:40 zimbra zimbramon[21591]: 21591:info: Starting stats via zmcontrol
    Jan 20 17:32:40 zimbra saslauthd[26519]: detach_tty : master pid is: 26519
    Jan 20 17:32:40 zimbra saslauthd[26519]: ipc_init : listening on socket: /opt/zimbra/cyrus-sasl-2.1.23.3z/state/mux

    [root@zimbra log]#

  5. #5
    pmona is offline Active Member
    Join Date
    Jan 2010
    Posts
    26
    Rep Power
    5

    Default

    Just so it is clear, this server was up and working with out a problem. The last email I sent was at 10:31 AM 1/19/2010. I tried sending another email around 7:50 PM but it kept failing. Though I couldn't send, I was still receiving email. I then stopped and started zimbra. After doing so, I could no longer receive nor send. I'm attaching the log from yesterday.
    Attached Files Attached Files

  6. #6
    uxbod's Avatar
    uxbod is offline Moderator
    Join Date
    Nov 2006
    Location
    UK
    Posts
    8,016
    Rep Power
    24

    Default

    Code:
    Jan 19 19:58:11 zimbra postfix/qmgr[2008]: DBA8F8D8006: from=<>, size=6632, nrcpt=1 (queue active)
    Jan 19 19:58:14 zimbra postfix/lmtp[11217]: connect to voodoo.monafamily.com[172.20.1.1]:7025: No route to host
    Jan 19 19:58:14 zimbra postfix/lmtp[11217]: DBA8F8D8006: to=<spam.1ps50aa0@monafamily.com>, relay=none, delay=101210, delays=101207/0.22/3/0, dsn=4.4.1, status=deferred (connect to voodoo.monafamily.com[172.20.1.1]:7025: No route to host)
    Jan 19 19:58:16 zimbra zmmailboxdmgr[11440]: status requested
    Were any changes made as it would appear that a LMTP request is being made to a different server ?

  7. #7
    pmona is offline Active Member
    Join Date
    Jan 2010
    Posts
    26
    Rep Power
    5

    Default

    voodoo.monafamily.com 172.20.1.1 is another server on my network, but it hasn't been powered on for more than a month now. I don't know how or why anything would change on the zimbra box to point to that.
    Is there some config I should look at and change?

  8. #8
    uxbod's Avatar
    uxbod is offline Moderator
    Join Date
    Nov 2006
    Location
    UK
    Posts
    8,016
    Rep Power
    24

    Default

    Okay, looks like you SPAM training account was on the other server! To fix that you will need to do
    Code:
    su - zimbra
    zmprov ma  spam.1ps50aa0@monafamily.com zimbraMailTransport lmtp:`zmhostname`:7025
    It would be best to check that the spam training account is correct using
    Code:
    su - zimbra
    zmprov gacf zimbraSpamIsSpamAccount

  9. #9
    pmona is offline Active Member
    Join Date
    Jan 2010
    Posts
    26
    Rep Power
    5

    Default

    I ran the check first to see what it was, but the other command failed.

    [zimbra@zimbra ~]$ zmprov gacf zimbraSpamIsSpamAccount
    zimbraSpamIsSpamAccount: spam.1ps50aa0@monafamily.com
    [zimbra@zimbra ~]$
    [zimbra@zimbra ~]$
    [zimbra@zimbra ~]$ zmprov ma spam.1ps50aa0@monafamily.com zimbraMailTransport lmtp:`zmhostname`:7025
    ERROR: service.FAILURE (system failure: java.lang.NullPointerException)
    [zimbra@zimbra ~]$

  10. #10
    uxbod's Avatar
    uxbod is offline Moderator
    Join Date
    Nov 2006
    Location
    UK
    Posts
    8,016
    Rep Power
    24

    Default

    Okay it probably does not like the command expansion. As zimbra user execute zmhostname, and then use that in the command instead of `zmhostname`. Would you also post
    Code:
    zmcontrol status
    ps aux | grep postfix
    netstat -an | grep 25

Page 1 of 3 123 LastLast

Thread Information

Users Browsing this Thread

There are currently 1 users browsing this thread. (0 members and 1 guests)

Similar Threads

  1. postdrop fail to create file after upgrade to 5.0.3
    By echoadisan in forum Installation
    Replies: 23
    Last Post: 07-15-2013, 03:02 PM
  2. [SOLVED] Mailserver down when send file attach of 50Mb
    By ZMilton in forum Administrators
    Replies: 20
    Last Post: 04-10-2008, 11:44 AM
  3. Replies: 2
    Last Post: 02-12-2008, 11:55 AM
  4. 5.0 RC1: admin interface: no statistics, no mail queue
    By christian.kieft in forum Administrators
    Replies: 1
    Last Post: 11-13-2007, 09:22 AM
  5. fatal: Queue report unavailable - mail system is down
    By zzzzsg in forum Administrators
    Replies: 16
    Last Post: 08-24-2006, 02:31 AM

Posting Permissions

  • You may not post new threads
  • You may not post replies
  • You may not post attachments
  • You may not edit your posts
  •