Clients stopped receiving emails

[egadinc]

Zimbra 6.02 / Centos 5.2 / Intel P4 / 2GB / 100GB Disk

Users can't download emails from Zimbra server -- out of ideas!

Installed Zimbra 6.02 several weeks ago. Worked fine, until CPU usage and Disk swapping was over the top. Zimbra was very sluggish. Daily mailbox.log filling up to 1.9GB everyday.

Shutdown server, and restarted. From that moment
- the Deferred Queues are accumulating email
- Individual accounts are accumulating email.
- POP3 and webmail logins working fine.
- No emails reported to the clients. Can't download or access any visible new emails.

Getting a 'temporary message error, try again later [DATA]' , but nothing is clearing up.

Performed permissions fix... nothing changed.

Following tail of mailbox.log:
-----------------------------------------------------------------------------------------------------------------
[root@mail log]# tail -100 mailbox.log
at com.zimbra.cs.lmtpserver.LmtpHandler.processMessag eData(LmtpHandler.java:365)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.continueDA TA(TcpLmtpHandler.java:72)
at com.zimbra.cs.lmtpserver.LmtpHandler.doDATA(LmtpHa ndler.java:350)
at com.zimbra.cs.lmtpserver.LmtpHandler.processComman d(LmtpHandler.java:170)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.processCom mand(TcpLmtpHandler.java:66)
at com.zimbra.cs.tcpserver.ProtocolHandler.processCon nection(ProtocolHandler.java:175)
at com.zimbra.cs.tcpserver.ProtocolHandler.run(Protoc olHandler.java:132)
at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Wo rker.run(Unknown Source)
at java.lang.Thread.run(Thread.java:619)
2009-12-11 16:50:57,537 INFO [LmtpServer-405] [name=katrinka.zaharkiv@egad.com;mid=4;ip=76.246.22 6.114;] mailbox - Deferred Indexing: submitted 2702 items in 140952ms (19.17/sec). (0 items failed to index). IndexDeferredCount now at 2702 NumNotSubmitted= 2702
2009-12-11 16:50:57,541 WARN [LmtpServer-405] [name=katrinka.zaharkiv@egad.com;mid=4;ip=76.246.22 6.114;] filter - An error occurred while processing filter rules. Filing message to /Inbox.
java.lang.NullPointerException
at com.zimbra.cs.mailbox.IndexHelper.generateIndexId( IndexHelper.java:178)
at com.zimbra.cs.mailbox.Mailbox.generateIndexId(Mail box.java:1028)
at com.zimbra.cs.mailbox.Message.createInternal(Messa ge.java:417)
at com.zimbra.cs.mailbox.Message.create(Message.java: 360)
at com.zimbra.cs.mailbox.Mailbox.addMessageInternal(M ailbox.java:4446)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4293)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4226)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4186)
at com.zimbra.cs.filter.IncomingMessageHandler.addMes sage(IncomingMessageHandler.java:116)
at com.zimbra.cs.filter.IncomingMessageHandler.implic itKeep(IncomingMessageHandler.java:109)
at com.zimbra.cs.filter.ZimbraMailAdapter.doDefaultFi ling(ZimbraMailAdapter.java:284)
at com.zimbra.cs.filter.ZimbraMailAdapter.executeActi ons(ZimbraMailAdapter.java:188)
at org.apache.jsieve.SieveFactory.evaluate(SieveFacto ry.java:164)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:348)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:311)
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:425 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:257 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver (ZimbraLmtpBackend.java:162)
at com.zimbra.cs.lmtpserver.LmtpHandler.processMessag eData(LmtpHandler.java:365)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.continueDA TA(TcpLmtpHandler.java:72)
at com.zimbra.cs.lmtpserver.LmtpHandler.doDATA(LmtpHa ndler.java:350)
at com.zimbra.cs.lmtpserver.LmtpHandler.processComman d(LmtpHandler.java:170)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.processCom mand(TcpLmtpHandler.java:66)
at com.zimbra.cs.tcpserver.ProtocolHandler.processCon nection(ProtocolHandler.java:175)
at com.zimbra.cs.tcpserver.ProtocolHandler.run(Protoc olHandler.java:132)
at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Wo rker.run(Unknown Source)
at java.lang.Thread.run(Thread.java:619)
2009-12-11 16:50:57,542 WARN [LmtpServer-405] [name=katrinka.zaharkiv@egad.com;mid=4;ip=76.246.22 6.114;] lmtp - try again for message katrinka.zaharkiv@egad.com: exception occurred
java.lang.NullPointerException
at com.zimbra.cs.mailbox.IndexHelper.generateIndexId( IndexHelper.java:178)
at com.zimbra.cs.mailbox.Mailbox.generateIndexId(Mail box.java:1028)
at com.zimbra.cs.mailbox.Message.createInternal(Messa ge.java:417)
at com.zimbra.cs.mailbox.Message.create(Message.java: 360)
at com.zimbra.cs.mailbox.Mailbox.addMessageInternal(M ailbox.java:4446)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4293)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4226)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4186)
at com.zimbra.cs.filter.IncomingMessageHandler.addMes sage(IncomingMessageHandler.java:116)
at com.zimbra.cs.filter.IncomingMessageHandler.implic itKeep(IncomingMessageHandler.java:109)
at com.zimbra.cs.filter.ZimbraMailAdapter.doDefaultFi ling(ZimbraMailAdapter.java:284)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:363)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:311)
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:425 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:257 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver (ZimbraLmtpBackend.java:162)
at com.zimbra.cs.lmtpserver.LmtpHandler.processMessag eData(LmtpHandler.java:365)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.continueDA TA(TcpLmtpHandler.java:72)
at com.zimbra.cs.lmtpserver.LmtpHandler.doDATA(LmtpHa ndler.java:350)
at com.zimbra.cs.lmtpserver.LmtpHandler.processComman d(LmtpHandler.java:170)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.processCom mand(TcpLmtpHandler.java:66)
at com.zimbra.cs.tcpserver.ProtocolHandler.processCon nection(ProtocolHandler.java:175)
at com.zimbra.cs.tcpserver.ProtocolHandler.run(Protoc olHandler.java:132)
at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Wo rker.run(Unknown Source)
at java.lang.Thread.run(Thread.java:619)
2009-12-11 16:50:57,543 INFO [LmtpServer-405] [name=katrinka.zaharkiv@egad.com;mid=4;ip=76.246.22 6.114;] lmtp - 451 4.0.0 Temporary message delivery failure try again (DATA)
2009-12-11 16:50:59,698 INFO [LmtpServer-405] [name=katrinka.zaharkiv@egad.com;mid=4;ip=76.246.22 6.114;] lmtp - disconnected without quit
2009-12-11 16:50:59,698 INFO [LmtpServer-405] [] ProtocolHandler - Handler exiting normally
2009-12-11 16:51:01,516 INFO [Timer-Zimbra] [] SessionCache - Removed 1 idle sessions (ADMIN). 1 active sessions remain.
2009-12-11 16:51:20,434 INFO [LmtpServer-422] [ip=76.246.226.114;] lmtp - Delivering message: size=2958 bytes, nrcpts=1, sender=vig_rx@typefold.com, msgid=<-gxcpirlg022n-j6@typefold.com>
2009-12-11 16:51:20,438 WARN [LmtpServer-422] [name=peter.zaharkiv@egad.com;mid=3;ip=76.246.226.1 14;] lmtp - try again for message peter.zaharkiv@egad.com: exception occurred
java.lang.NullPointerException
at com.zimbra.cs.mailbox.IndexHelper.generateIndexId( IndexHelper.java:178)
at com.zimbra.cs.mailbox.Mailbox.generateIndexId(Mail box.java:1028)
at com.zimbra.cs.mailbox.Message.createInternal(Messa ge.java:417)
at com.zimbra.cs.mailbox.Message.create(Message.java: 360)
at com.zimbra.cs.mailbox.Mailbox.addMessageInternal(M ailbox.java:4446)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4293)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4226)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4186)
at com.zimbra.cs.filter.IncomingMessageHandler.addMes sage(IncomingMessageHandler.java:116)
at com.zimbra.cs.filter.IncomingMessageHandler.implic itKeep(IncomingMessageHandler.java:109)
at com.zimbra.cs.filter.ZimbraMailAdapter.doDefaultFi ling(ZimbraMailAdapter.java:284)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:363)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:311)
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:425 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:257 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver (ZimbraLmtpBackend.java:162)
at com.zimbra.cs.lmtpserver.LmtpHandler.processMessag eData(LmtpHandler.java:365)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.continueDA TA(TcpLmtpHandler.java:72)
at com.zimbra.cs.lmtpserver.LmtpHandler.doDATA(LmtpHa ndler.java:350)
at com.zimbra.cs.lmtpserver.LmtpHandler.processComman d(LmtpHandler.java:170)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.processCom mand(TcpLmtpHandler.java:66)
at com.zimbra.cs.tcpserver.ProtocolHandler.processCon nection(ProtocolHandler.java:175)
at com.zimbra.cs.tcpserver.ProtocolHandler.run(Protoc olHandler.java:132)
at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Wo rker.run(Unknown Source)
at java.lang.Thread.run(Thread.java:619)
2009-12-11 16:51:20,439 INFO [LmtpServer-422] [name=peter.zaharkiv@egad.com;mid=3;ip=76.246.226.1 14;] lmtp - 451 4.0.0 Temporary message delivery failure try again (DATA)
2009-12-11 16:51:20,441 INFO [LmtpServer-422] [] ProtocolHandler - Handler exiting normally
-------------------------------------------------------------------------------------------------------------------------------

Have run out of ideas of where to look!

Any suggestions would be appreciated soon.

- Peter

[egadinc]

So far I've reindexed the mailboxes and done a permissions fix. Nothing has changed.
Looks like everything is working. Email comes into the queues and the webmail and Pop3 accounts work, but the mail doesn't make it from the queues into the individual mailboxes.

[egadinc]

I've verified that the /etc/hosts file hasn't been changed.

Email keeps coming into the MTA but doesn't make it into the mailboxes.
I've gone through the notes on WIKI, but none of the vague answers seem to apply.

[phoenix]

Originally Posted by egadinc

Performed permissions fix... nothing changed.

Sutdown Zimbra then as root run the following:

/opt/zimbra/libexec/zmfixperms --extended

When that's finished restart Zimbra and see if you get any errors in the log files, if you do then post the output.

[egadinc]

zimbra.log:
-----------------------------------------------------------------------------------------------------------------------
[root@mail log]# tail -100 zimbra.log
Dec 12 10:07:39 mail zimbramon[29208]: 29208:info: Stopping archiving via zmcontrol
Dec 12 10:07:39 mail amavis[31526]: Net::Server: 2009/12/12-10:07:39 Server closing!
Dec 12 10:07:45 mail zimbramon[29208]: 29208:info: Stopping antivirus via zmcontrol
Dec 12 10:08:07 mail zmmailboxdmgr[29838]: status requested
Dec 12 10:08:07 mail zmmailboxdmgr[29838]: status OK
Dec 12 10:08:18 mail clamd[31673]: Pid file removed.
Dec 12 10:08:18 mail clamd[31673]: --- Stopped at Sat Dec 12 10:08:18 2009
Dec 12 10:08:19 mail zimbramon[29208]: 29208:info: Stopping antispam via zmcontrol
Dec 12 10:08:20 mail zimbramon[29208]: 29208:info: Stopping imapproxy via zmcontrol
Dec 12 10:08:20 mail zimbramon[29208]: 29208:info: Stopping memcached via zmcontrol
Dec 12 10:08:21 mail zimbramon[29208]: 29208:info: Stopping mailbox via zmcontrol
Dec 12 10:08:21 mail zmmailboxdmgr[30007]: status requested
Dec 12 10:08:21 mail zmmailboxdmgr[30007]: status OK
Dec 12 10:08:51 mail zmmailboxdmgr[30014]: stop requested
Dec 12 10:08:51 mail zmmailboxdmgr[30014]: waiting for manager process 31444 to die
Dec 12 10:08:52 mail zmmailboxdmgr[31444]: shutdown requested, sending TERM signal to 31445
Dec 12 10:10:00 mail zmmailboxdmgr[31444]: mailboxd/JVM process exited (waitpid expected 31445 got 31445)
Dec 12 10:10:00 mail zmmailboxdmgr[31444]: manager woke up from wait on mailboxd/JVM with pid 31445
Dec 12 18:10:01 mail postfix/postqueue[30059]: fatal: Queue report unavailable - mail system is down
Dec 12 10:10:01 mail zimbramon[30039]: 30039:info: 2009-12-12 10:10:01, QUEUE: 0 0
Dec 12 10:10:01 mail zmmailboxdmgr[30014]: manager process 31444 died, shutdown completed
Dec 12 10:10:01 mail sendmail[30060]: nBCIA12f030060: from=zimbra, size=379, class=0, nrcpts=1, msgid=<200912121810.nBCIA12f030060@mail.egad.com>, relay=zimbra@localhost
Dec 12 10:10:01 mail sendmail[30060]: nBCIA12f030060: to=zimbra, ctladdr=zimbra (501/501), delay=00:00:00, xdelay=00:00:00, mailer=relay, pri=30379, relay=[127.0.0.1] [127.0.0.1], dsn=4.0.0, stat=Deferred: Connection refused by [127.0.0.1]
Dec 12 10:10:11 mail zmmailboxdmgr[30554]: status requested
Dec 12 10:10:11 mail zmmailboxdmgr[30554]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
Dec 12 10:10:11 mail zmmailboxdmgr[30554]: assuming no other instance is running
Dec 12 10:10:11 mail zmmailboxdmgr[30554]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Dec 12 10:10:11 mail zmmailboxdmgr[30554]: assuming no other instance is running
Dec 12 10:10:11 mail zmmailboxdmgr[30554]: no manager process is running
Dec 12 10:10:18 mail zimbramon[29208]: 29208:info: Stopping convertd via zmcontrol
Dec 12 10:10:18 mail zimbramon[29208]: 29208:info: Stopping logger via zmcontrol
Dec 12 10:10:20 mail zimbramon[29208]: 29208:info: Stopping ldap via zmcontrol
Dec 12 10:10:20 mail slapd[27481]: daemon: shutdown requested and initiated.
Dec 12 10:10:21 mail slapd[27481]: slapd shutdown: waiting for 0 operations/tasks to finish
Dec 12 10:10:23 mail slapd[27481]: slapd stopped.
Dec 12 10:11:54 mail zimbramon[30690]: 30690:info: Stopping services initiated by zmcontrol
Dec 12 10:11:54 mail zimbramon[30690]: 30690:info: Stopping stats via zmcontrol
Dec 12 10:11:54 mail zimbramon[30690]: 30690:info: Stopping mta via zmcontrol
Dec 12 10:11:54 mail postfix/postfix-script[30777]: fatal: the Postfix mail system is not running
Dec 12 10:11:54 mail zimbramon[30690]: 30690:info: Stopping spell via zmcontrol
Dec 12 10:11:54 mail zimbramon[30690]: 30690:info: Stopping snmp via zmcontrol
Dec 12 10:11:54 mail zimbramon[30690]: 30690:info: Stopping archiving via zmcontrol
Dec 12 10:11:54 mail zimbramon[30690]: 30690:info: Stopping antivirus via zmcontrol
Dec 12 10:11:55 mail zimbramon[30690]: 30690:info: Stopping antispam via zmcontrol
Dec 12 10:11:55 mail zimbramon[30690]: 30690:info: Stopping imapproxy via zmcontrol
Dec 12 10:11:55 mail zimbramon[30690]: 30690:info: Stopping memcached via zmcontrol
Dec 12 10:11:55 mail zimbramon[30690]: 30690:info: Stopping mailbox via zmcontrol
Dec 12 10:11:55 mail zmmailboxdmgr[30929]: status requested
Dec 12 10:11:55 mail zmmailboxdmgr[30929]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
Dec 12 10:11:55 mail zmmailboxdmgr[30929]: assuming no other instance is running
Dec 12 10:11:55 mail zmmailboxdmgr[30929]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Dec 12 10:11:55 mail zmmailboxdmgr[30929]: assuming no other instance is running
Dec 12 10:11:55 mail zmmailboxdmgr[30929]: no manager process is running
Dec 12 10:11:55 mail zimbramon[30690]: 30690:info: Stopping convertd via zmcontrol
Dec 12 10:11:55 mail zimbramon[30690]: 30690:info: Stopping logger via zmcontrol
Dec 12 10:11:55 mail zimbramon[30690]: 30690:info: Stopping ldap via zmcontrol
Dec 12 10:12:05 mail zmmailboxdmgr[31248]: status requested
Dec 12 10:12:05 mail zmmailboxdmgr[31248]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
Dec 12 10:12:05 mail zmmailboxdmgr[31248]: assuming no other instance is running
Dec 12 10:12:05 mail zmmailboxdmgr[31248]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Dec 12 10:12:05 mail zmmailboxdmgr[31248]: assuming no other instance is running
Dec 12 10:12:05 mail zmmailboxdmgr[31248]: no manager process is running
Dec 12 10:12:06 mail sendmail[31131]: nBCIC4UM031131: from=zimbra, size=429, class=0, nrcpts=1, msgid=<200912121812.nBCIC4UM031131@mail.egad.com>, relay=zimbra@localhost
Dec 12 10:12:06 mail sendmail[31131]: nBCIC4UM031131: to=zimbra, ctladdr=zimbra (501/501), delay=00:00:02, xdelay=00:00:00, mailer=relay, pri=30429, relay=[127.0.0.1] [127.0.0.1], dsn=4.0.0, stat=Deferred: Connection refused by [127.0.0.1]
Dec 12 10:14:16 mail zmmailboxdmgr[32118]: status requested
Dec 12 10:14:16 mail zmmailboxdmgr[32118]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
Dec 12 10:14:16 mail zmmailboxdmgr[32118]: assuming no other instance is running
Dec 12 10:14:16 mail zmmailboxdmgr[32118]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Dec 12 10:14:16 mail zmmailboxdmgr[32118]: assuming no other instance is running
Dec 12 10:14:16 mail zmmailboxdmgr[32118]: no manager process is running
Dec 12 10:14:19 mail sendmail[31999]: nBCIEFEI031999: from=zimbra, size=429, class=0, nrcpts=1, msgid=<200912121814.nBCIEFEI031999@mail.egad.com>, relay=zimbra@localhost
Dec 12 10:14:19 mail sendmail[31999]: nBCIEFEI031999: to=zimbra, ctladdr=zimbra (501/501), delay=00:00:04, xdelay=00:00:00, mailer=relay, pri=30429, relay=[127.0.0.1] [127.0.0.1], dsn=4.0.0, stat=Deferred: Connection refused by [127.0.0.1]
Dec 12 10:16:06 mail zmmailboxdmgr[32577]: status requested
Dec 12 10:16:06 mail zmmailboxdmgr[32577]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
Dec 12 10:16:06 mail zmmailboxdmgr[32577]: assuming no other instance is running
Dec 12 10:16:06 mail zmmailboxdmgr[32577]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Dec 12 10:16:06 mail zmmailboxdmgr[32577]: assuming no other instance is running
Dec 12 10:16:06 mail zmmailboxdmgr[32577]: no manager process is running
Dec 12 10:16:08 mail sendmail[32456]: nBCIG6mB032456: from=zimbra, size=429, class=0, nrcpts=1, msgid=<200912121816.nBCIG6mB032456@mail.egad.com>, relay=zimbra@localhost
Dec 12 10:16:08 mail sendmail[32456]: nBCIG6mB032456: to=zimbra, ctladdr=zimbra (501/501), delay=00:00:02, xdelay=00:00:00, mailer=relay, pri=30429, relay=[127.0.0.1] [127.0.0.1], dsn=4.0.0, stat=Deferred: Connection refused by [127.0.0.1]
Dec 12 10:18:05 mail zmmailboxdmgr[525]: status requested
Dec 12 10:18:05 mail zmmailboxdmgr[525]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
Dec 12 10:18:05 mail zmmailboxdmgr[525]: assuming no other instance is running
Dec 12 10:18:05 mail zmmailboxdmgr[525]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Dec 12 10:18:05 mail zmmailboxdmgr[525]: assuming no other instance is running
Dec 12 10:18:05 mail zmmailboxdmgr[525]: no manager process is running
Dec 12 10:18:06 mail sendmail[404]: nBCII5Xw000404: from=zimbra, size=429, class=0, nrcpts=1, msgid=<200912121818.nBCII5Xw000404@mail.egad.com>, relay=zimbra@localhost
Dec 12 10:18:06 mail sendmail[404]: nBCII5Xw000404: to=zimbra, ctladdr=zimbra (501/501), delay=00:00:01, xdelay=00:00:00, mailer=relay, pri=30429, relay=[127.0.0.1] [127.0.0.1], dsn=4.0.0, stat=Deferred: Connection refused by [127.0.0.1]
Dec 12 18:20:02 mail postfix/postqueue[668]: fatal: Queue report unavailable - mail system is down
Dec 12 10:20:02 mail zimbramon[638]: 638:info: 2009-12-12 10:20:02, QUEUE: 0 0
Dec 12 10:20:02 mail sendmail[669]: nBCIK2WA000669: from=zimbra, size=379, class=0, nrcpts=1, msgid=<200912121820.nBCIK2WA000669@mail.egad.com>, relay=zimbra@localhost
Dec 12 10:20:02 mail sendmail[669]: nBCIK2WA000669: to=zimbra, ctladdr=zimbra (501/501), delay=00:00:00, xdelay=00:00:00, mailer=relay, pri=30379, relay=[127.0.0.1] [127.0.0.1], dsn=4.0.0, stat=Deferred: Connection refused by [127.0.0.1]
Dec 12 10:20:11 mail zmmailboxdmgr[1124]: status requested
Dec 12 10:20:11 mail zmmailboxdmgr[1124]: file /opt/zimbra/log/zmmailboxd_manager.pid does not exist
Dec 12 10:20:11 mail zmmailboxdmgr[1124]: assuming no other instance is running
Dec 12 10:20:11 mail zmmailboxdmgr[1124]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Dec 12 10:20:11 mail zmmailboxdmgr[1124]: assuming no other instance is running
Dec 12 10:20:11 mail zmmailboxdmgr[1124]: no manager process is running
Dec 12 10:20:12 mail sendmail[1008]: nBCIKBUp001008: from=zimbra, size=429, class=0, nrcpts=1, msgid=<200912121820.nBCIKBUp001008@mail.egad.com>, relay=zimbra@localhost
Dec 12 10:20:12 mail sendmail[1008]: nBCIKBUp001008: to=zimbra, ctladdr=zimbra (501/501), delay=00:00:01, xdelay=00:00:00, mailer=relay, pri=30429, relay=[127.0.0.1] [127.0.0.1], dsn=4.0.0, stat=Deferred: Connection refused by [127.0.0.1]
[root@mail log]#
---------------------------------------------------------------------------------------------------------------

[egadinc]

mailbox.log
-------------------------------------------------------------------------------------------------------------------------------
[root@mail log]# tail -100 mailbox.log
2009-12-12 10:09:58,082 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,083 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,085 INFO [Shutdown] [] redolog - Redo log rollover took 2193ms
2009-12-12 10:09:58,131 INFO [Shutdown] [] redolog - Logged: 558 items, 86.267ms/item
2009-12-12 10:09:58,131 INFO [Shutdown] [] extensions - Destroying extensions
2009-12-12 10:09:58,393 INFO [Shutdown] [] extensions - Destroyed extension com_zimbra_cert_manager: com.zimbra.cert.ZimbraCertMgrExt@com...t ension.ZimbraExtensionClassLoader@13a83cc
2009-12-12 10:09:58,393 INFO [Shutdown] [] extensions - Destroyed extension nginx-lookup: com.zimbra.cs.nginx.NginxLookupExten...extension.ZimbraExtensionClassLoader@1bef5e8
2009-12-12 10:09:58,393 INFO [Shutdown] [] extensions - Destroyed extension com_zimbra_bulkprovision: com.zimbra.bp.ZimbraBulkProvisionExt...extension.ZimbraExtensionClassLoader@17e60a1
2009-12-12 10:09:58,393 INFO [Shutdown] [] extensions - Destroyed extension zimbrasamba: com.zimbra.ldaputils.ZimbraLDAPUtils...extension.ZimbraExtensionClassLoader@19d9c0d
2009-12-12 10:09:58,394 INFO [Shutdown] [] extensions - Destroyed extension versioncheck: com.zimbra.cs.versioncheck.VersionCh...extension.ZimbraExtensionClassLoader@626fd2
2009-12-12 10:09:58,394 INFO [Shutdown] [] extensions - Destroyed extension clamscanner: com.zimbra.clam.ClamScanner@com.zimb...tensio n.ZimbraExtensionClassLoader@1fb24d3
2009-12-12 10:09:58,394 INFO [Shutdown] [] index - Shutting down IndexHelper thread pools....
2009-12-12 10:09:58,420 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,421 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,447 INFO [Shutdown] [] index - ...ReIndexing threadpool shutdown completed.
2009-12-12 10:09:58,447 INFO [Shutdown] [] index - ...IndexingCompleted threadpool shutdown completed.
2009-12-12 10:09:58,448 INFO [IncomingDirectorySweeper] [] store - IncomingDirectorySweeper thread exiting
2009-12-12 10:09:58,448 WARN [Shutdown] [] ZimbraHttpConnectionManager - shutting down http client idle connection reaper thread
2009-12-12 10:09:58,448 INFO [Shutdown] [] soap - Servlet SoapServlet shutting down
2009-12-12 10:09:58,451 INFO [Shutdown] [] log - Shutdown hook complete
2009-12-12 10:09:58,487 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,487 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,563 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,563 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,631 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,631 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,690 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,690 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,740 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,740 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,780 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,780 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,840 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,840 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,875 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,875 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,928 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,928 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,984 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:58,984 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,039 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,040 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,090 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,090 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,161 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,161 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,217 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,217 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,280 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,281 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,359 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,359 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,414 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,414 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,471 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,472 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,514 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while indexing message id 0 - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
2009-12-12 10:09:59,514 WARN [LmtpServer-5487] [name=joe.vieira@masspolice.com;mid=41;ip=76.246.22 6.114;] indexadd - Caught exception while flushing index - indexing blocked. Possibly corrupt index?
java.lang.NullPointerException
[root@mail log]#
---------------------------------------------------------------------------------------------------------------------

[egadinc]

Tail of messages after '/opt/zimbra/libexec/zmfixperms --extended :
-------------------------------------------------------------------------------------------------------------
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MakeMaker/Tutorial.pod': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MakeMaker/FAQ.pod': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MakeMaker': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM_Win32.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM_OS2.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM_Win95.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/Install.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/Command.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MakeMaker.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM_NW5.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/Liblist/Kid.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/Liblist': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/Mksymlists.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM_QNX.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/testlib.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM_BeOS.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM_VOS.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM_Cygwin.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/Manifest.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/Installed.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MM_DOS.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MANIFEST.SKIP': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils/MY.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/ExtUtils': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/_login.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/URL.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/data.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/mms.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/ldap.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/ldaps.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/_userpass.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/urn.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/mailto.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/news.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/pop.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/file/OS2.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/file/FAT.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/file/Unix.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/file/Base.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/file/Mac.pm': Operation not permitted
chown: changing ownership of `/opt/zimbra/zimbramon/lib/URI/file/QNX.pm': Operation not permitted

-----------------------------------------------------------------------------------------------------------------------

[phoenix]

Please update your forum profile with the output of the following command (do not post it in this thread):

zmcontrol -v

Is this a single server? Do you have adequate space on the drive where /opt/zimbra is located? Do you have the proxy installed? I assume you actually ran the zmfixperms command I asked you to run?

[egadinc]

- profile has been updated
- Single server: P4, 2.6Mhz, 2.5GB Ram
- Free Disk Space: 74GB
- zmfixperms run as requested: sample output of command is above.

Note: mailbox.log has been filling at the rate of 1.9GB per day for the last week.

[egadinc]

Since last message:
- Logged back into root, and went to /opt/zimbra/libexec
- executed: ./zmfixperms --extended
- ran without errors.
- the tail of mailbox.log:
--------------------------------------------------------------------------------------------------
2009-12-12 14:04:24,582 INFO [LmtpServer-48] [name=sue.felt@webstersvillage.com;mid=42;ip=76.246 .226.114;] lmtp - 451 4.0.0 Temporary message delivery failure try again (DATA)
2009-12-12 14:04:24,583 INFO [LmtpServer-48] [name=sue.felt@webstersvillage.com;mid=42;ip=76.246 .226.114;] lmtp - 451 4.0.0 Temporary message delivery failure try again (DATA)
2009-12-12 14:04:24,583 INFO [LmtpServer-48] [] ProtocolHandler - Handler exiting normally
2009-12-12 14:04:25,954 INFO [LmtpServer-49] [ip=76.246.226.114;] lmtp - Delivering message: size=61843 bytes, nrcpts=1, sender=aejrdoqikrpkz@ms21.hinet.net, msgid=<01ca7b77$037367e0$040aa8c0@aejrdoqikrpkz>
2009-12-12 14:04:25,957 WARN [LmtpServer-49] [name=elizabeth.zaharkiv@lizmoda.com;mid=9;ip=76.24 6.226.114;] lmtp - try again for message elizabeth.zaharkiv@lizmoda.com: exception occurred
java.lang.NullPointerException
at com.zimbra.cs.mailbox.IndexHelper.generateIndexId( IndexHelper.java:178)
at com.zimbra.cs.mailbox.Mailbox.generateIndexId(Mail box.java:1028)
at com.zimbra.cs.mailbox.Message.createInternal(Messa ge.java:417)
at com.zimbra.cs.mailbox.Message.create(Message.java: 360)
at com.zimbra.cs.mailbox.Mailbox.addMessageInternal(M ailbox.java:4446)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4293)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4226)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4186)
at com.zimbra.cs.filter.IncomingMessageHandler.addMes sage(IncomingMessageHandler.java:116)
at com.zimbra.cs.filter.IncomingMessageHandler.implic itKeep(IncomingMessageHandler.java:109)
at com.zimbra.cs.filter.ZimbraMailAdapter.doDefaultFi ling(ZimbraMailAdapter.java:284)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:363)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:311)
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:425 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:257 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver (ZimbraLmtpBackend.java:162)
at com.zimbra.cs.lmtpserver.LmtpHandler.processMessag eData(LmtpHandler.java:365)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.continueDA TA(TcpLmtpHandler.java:72)
at com.zimbra.cs.lmtpserver.LmtpHandler.doDATA(LmtpHa ndler.java:350)
at com.zimbra.cs.lmtpserver.LmtpHandler.processComman d(LmtpHandler.java:170)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.processCom mand(TcpLmtpHandler.java:66)
at com.zimbra.cs.tcpserver.ProtocolHandler.processCon nection(ProtocolHandler.java:175)
at com.zimbra.cs.tcpserver.ProtocolHandler.run(Protoc olHandler.java:132)
at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Wo rker.run(Unknown Source)
at java.lang.Thread.run(Thread.java:619)
2009-12-12 14:04:25,958 INFO [LmtpServer-49] [name=elizabeth.zaharkiv@lizmoda.com;mid=9;ip=76.24 6.226.114;] lmtp - 451 4.0.0 Temporary message delivery failure try again (DATA)
2009-12-12 14:04:25,963 INFO [LmtpServer-49] [] ProtocolHandler - Handler exiting normally
2009-12-12 14:04:51,503 INFO [LmtpServer-50] [ip=76.246.226.114;] lmtp - Delivering message: size=2173 bytes, nrcpts=1, sender=18188481868@vm.vonage.com, msgid=<20091212220451.6449F358C1A@mail.egad.com>
2009-12-12 14:04:51,505 WARN [LmtpServer-50] [name=elizabeth.zaharkiv@lizmoda.com;mid=9;ip=76.24 6.226.114;] filter - An error occurred while processing filter rules. Filing message to /Inbox.
java.lang.NullPointerException
at com.zimbra.cs.mailbox.IndexHelper.generateIndexId( IndexHelper.java:178)
at com.zimbra.cs.mailbox.Mailbox.generateIndexId(Mail box.java:1028)
at com.zimbra.cs.mailbox.Message.createInternal(Messa ge.java:417)
at com.zimbra.cs.mailbox.Message.create(Message.java: 360)
at com.zimbra.cs.mailbox.Mailbox.addMessageInternal(M ailbox.java:4446)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4293)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4226)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4186)
at com.zimbra.cs.filter.IncomingMessageHandler.addMes sage(IncomingMessageHandler.java:116)
at com.zimbra.cs.filter.IncomingMessageHandler.implic itKeep(IncomingMessageHandler.java:109)
at com.zimbra.cs.filter.ZimbraMailAdapter.doDefaultFi ling(ZimbraMailAdapter.java:284)
at com.zimbra.cs.filter.ZimbraMailAdapter.executeActi ons(ZimbraMailAdapter.java:188)
at org.apache.jsieve.SieveFactory.evaluate(SieveFacto ry.java:164)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:348)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:311)
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:425 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:257 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver (ZimbraLmtpBackend.java:162)
at com.zimbra.cs.lmtpserver.LmtpHandler.processMessag eData(LmtpHandler.java:365)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.continueDA TA(TcpLmtpHandler.java:72)
at com.zimbra.cs.lmtpserver.LmtpHandler.doDATA(LmtpHa ndler.java:350)
at com.zimbra.cs.lmtpserver.LmtpHandler.processComman d(LmtpHandler.java:170)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.processCom mand(TcpLmtpHandler.java:66)
at com.zimbra.cs.tcpserver.ProtocolHandler.processCon nection(ProtocolHandler.java:175)
at com.zimbra.cs.tcpserver.ProtocolHandler.run(Protoc olHandler.java:132)
at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Wo rker.run(Unknown Source)
at java.lang.Thread.run(Thread.java:619)
2009-12-12 14:04:51,506 WARN [LmtpServer-50] [name=elizabeth.zaharkiv@lizmoda.com;mid=9;ip=76.24 6.226.114;] lmtp - try again for message elizabeth.zaharkiv@lizmoda.com: exception occurred
java.lang.NullPointerException
at com.zimbra.cs.mailbox.IndexHelper.generateIndexId( IndexHelper.java:178)
at com.zimbra.cs.mailbox.Mailbox.generateIndexId(Mail box.java:1028)
at com.zimbra.cs.mailbox.Message.createInternal(Messa ge.java:417)
at com.zimbra.cs.mailbox.Message.create(Message.java: 360)
at com.zimbra.cs.mailbox.Mailbox.addMessageInternal(M ailbox.java:4446)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4293)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4226)
at com.zimbra.cs.mailbox.Mailbox.addMessage(Mailbox.j ava:4186)
at com.zimbra.cs.filter.IncomingMessageHandler.addMes sage(IncomingMessageHandler.java:116)
at com.zimbra.cs.filter.IncomingMessageHandler.implic itKeep(IncomingMessageHandler.java:109)
at com.zimbra.cs.filter.ZimbraMailAdapter.doDefaultFi ling(ZimbraMailAdapter.java:284)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:363)
at com.zimbra.cs.filter.RuleManager.applyRulesToIncom ingMessage(RuleManager.java:311)
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:425 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:257 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver (ZimbraLmtpBackend.java:162)
at com.zimbra.cs.lmtpserver.LmtpHandler.processMessag eData(LmtpHandler.java:365)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.continueDA TA(TcpLmtpHandler.java:72)
at com.zimbra.cs.lmtpserver.LmtpHandler.doDATA(LmtpHa ndler.java:350)
at com.zimbra.cs.lmtpserver.LmtpHandler.processComman d(LmtpHandler.java:170)
at com.zimbra.cs.lmtpserver.TcpLmtpHandler.processCom mand(TcpLmtpHandler.java:66)
at com.zimbra.cs.tcpserver.ProtocolHandler.processCon nection(ProtocolHandler.java:175)
at com.zimbra.cs.tcpserver.ProtocolHandler.run(Protoc olHandler.java:132)
at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Wo rker.run(Unknown Source)
at java.lang.Thread.run(Thread.java:619)
2009-12-12 14:04:51,506 INFO [LmtpServer-50] [name=elizabeth.zaharkiv@lizmoda.com;mid=9;ip=76.24 6.226.114;] lmtp - 451 4.0.0 Temporary message delivery failure try again (DATA)
2009-12-12 14:04:51,508 INFO [LmtpServer-50] [] ProtocolHandler - Handler exiting normally

----------------------------------------------------------------------------------------------------------------------------------------

Problem still the same -- emails not moving from MTA to individual mailboxes.