Page 4 of 5

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Tue Feb 06, 2018 9:44 am
by brf
davidkillingsworth wrote:
brf wrote:davidkillingsworth, from your description, you might be seeing a different problem than what this thread is about. I don't recall seeing high CPU usage or slowness when this problem happens, what I do see is many users unable to login and access email. In your mailbox.log, do you see tons of "Failed to lock" errors happening when this problem is going on? If not, then I believe your problem is something different.
Yes, seeing lots of Failed to lock messages in mailbox.log. Mail delivery works fine, it's just that webmail users cannot login, or their functions within the browser are seriously too slow.
Ah, ok. Same problem then. Interesting, because I haven't noticed high CPU usage or sluggishness when this happens to us. Just that certain people (seemingly at random) can't access their email at all. As I said in a previous post, our email server is pretty small-scale though, maybe that's why.

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Wed Feb 07, 2018 4:57 pm
by superboer12
Like all of you I'm desperately awaiting a fix for this nasty and high priority bug!

In the meanwhile I am keeping my mailserver kind of alive by adding this to the crontab of the zimbra user '/var/spool/cron/crontabs/zimbra':

Code: Select all

05 */3 * * * /opt/zimbra/bin/zmmailboxdctl restart
It will restart zmmailboxd every three hours. I don't have to restart Zimbra entirely but only zmmailboxd and for me every three hours seems just about often enough.

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Wed Feb 07, 2018 8:57 pm
by jorgedlcruz
Hi guys,
Thank you for reaching out and identifying the issue. We're on it! As we conduct a high priority investigation to determine if or what patches might be necessary, check back here for updates in the next few of days. Thanks again!

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Thu Feb 08, 2018 7:22 am
by JakeMS
Thanks for the response!

Also, there are too many reports of this for it to be caused by a manual user configuration issue or weak hardware (too many different hardware also).

I think this will require a patch one way or another. Even if that patch is to fix some configuration the upgrade script might have changed :D.

Hopefully, we can get this sorted and we won't have to constantly reboot zimbra service every couple of hours. In some cases Zimbra has done this now in less than 3 hours of operation (for me)! Thankfully automated service restarts do resolve it temporarily.

But I would prefer to let Zimbra just run without constant service restarts again, that may sound selfish, but it is a production server after all :D

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Mon Feb 12, 2018 4:10 pm
by userid12
New here, but been a long time Zimbra user.


Our deployment is extremely small (less than 10 mailboxes) and we use Thunderbird/Lightning, K-9 Mail and DavDroid. Only four mailboxes are used regularly with only one large in size mailbox that was never an issue until the upgrade.
Experiencing the same issue since upgrading from 8.7.1 to 8.8.6, using the suggested cron job helps, although some times Zimbra gets locked withing the 3 hour range.

However a this point we're considering a downgrade, the restarts take the server offline for almost 10min every time, what's the safest way to do this without impacting the mailboxes?

@ jorgedlcruz , what is the ticket/bug ID for this issue?

Symptoms:
- IMAP check from K-9 slows down but no new mail is received
- Web app gives back 504/502 errors or just blank

Code: Select all

zimbra@myserver:/root$ zmmailbox -z -m userex@domain1.com gaf
        Id  View      Unread   Msg Count  Path
----------  ----  ----------  ----------  ----------
ERROR: service.FAILURE (system failure: com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout)

zimbra@myserver:/root$ zmmailbox -z -m userex@domain1.com gaf
        Id  View      Unread   Msg Count  Path
----------  ----  ----------  ----------  ----------
ERROR: service.FAILURE (system failure: com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout)


zimbra@myserver:/root$ zmmailbox -z -m userex@domain1.com gaf
        Id  View      Unread   Msg Count  Path
----------  ----  ----------  ----------  ----------
ERROR: service.FAILURE (system failure: com.zimbra.cs.mailbox.MailboxLock$LockFailedException: too many waiters: 15)

zmmailbox ERROR: service.FAILURE (system failure: com.zimbra.cs.mailbox.MailboxLock$LockFailedException: too many waiters: 15)

Code: Select all

zimbra@myserver:/root$ uptime
 13:17:17 up 1 day, 15:30,  1 user,  load average: 0.12, 0.34, 0.35
 
zimbra@myserver:/root$ w
 13:17:32 up 1 day, 15:30,  1 user,  load average: 0.16, 0.34, 0.35
USER     TTY      FROM             LOGIN@   IDLE   JCPU   PCPU WHAT
zimbrauser  pts/6    192.168.1.202    11:36    4.00s 54.27s  0.01s sshd: zimbrauser  [p
zimbra@myserver:/root$ cat /proc/loadavg
0.35 0.37 0.36 3/520 13595

Code: Select all

zimbra@myserver:/root$ tail -f /opt/zimbra/log/mailbox.log
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:17:54,871 WARN  [Timer-Zimbra] [] imap - skipping error while trying to remove session ImapSession{id=2326, authAcct=c8acf2e7-5331-4f7e-9a79-7af63ba358a5, lastAccessed=2018-02-07 12:03:55,271, cleanedUp=true, addedToCache=false, path=Archives/2017, folderId=c8acf2e7-5331-4f7e-9a79-7af63ba358a5:53326, handler=null}
com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.detach(ImapListener.java:546)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.quietRemoveSession(ImapSessionManager.java:244)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:199)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:18:29,809 INFO  [ImapSSLServer-281] [] imap - dropping connection for user userex@domain2.com (LOGOUT)
2018-02-07 13:18:34,417 INFO  [ImapSSLServer-281] [] imap - dropping connection for user userex@domain2.com (LOGOUT)
2018-02-07 13:18:40,854 INFO  [MailboxPurge] [name=galsync@domain2.com;mid=3;] purge - Purging messages.
2018-02-07 13:18:51,965 INFO  [qtp1595953398-866:http://localhost:8080/service/soap/AuthRequest] [name=userex@domain1.com;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - AuthRequest elapsed=8
^N2018-02-07 13:19:24,873 ERROR [Timer-Zimbra] [] mailbox - Failed to lock mailbox
Write Lock Owner - ImapSSLServer-8 prio=5 id=276 state=TERMINATED
Lock Waiter - qtp1595953398-866:http://localhost:8080/service/soap/GetInfoRequest prio=5 id=866 state=TIMED_WAITING
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
    at java.util.concurrent.locks.ReentrantReadWriteLock$ReadLock.tryLock(ReentrantReadWriteLock.java:871)
    at com.zimbra.cs.mailbox.MailboxLock.tryLockWithTimeout(MailboxLock.java:116)
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:194)
    at com.zimbra.cs.mailbox.Mailbox.getLastSoapAccessTime(Mailbox.java:1448)
    at com.zimbra.cs.service.account.GetInfo.handle(GetInfo.java:189)
    at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
    at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
    at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
    at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:116)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
    at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
    at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Thread.java:748)

com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.unload(ImapListener.java:580)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:195)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:19:24,874 WARN  [Timer-Zimbra] [] imap - error serializing session; clearing ImapSession{id=2324, authAcct=c8acf2e7-5331-4f7e-9a79-7af63ba358a5, lastAccessed=2018-02-07 12:03:55,269, cleanedUp=true, addedToCache=false, path=Travel, folderId=c8acf2e7-5331-4f7e-9a79-7af63ba358a5:2223, handler=null}
com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.unload(ImapListener.java:580)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:195)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:19:40,861 INFO  [MailboxPurge] [name=userex@domain1.com;mid=4;] purge - Purging messages.
2018-02-07 13:20:06,213 INFO  [qtp1595953398-1030:https:https://localhost:7071/service/admin/soap/AuthRequest] [name=zimbra;ua=zmprov/8.8.6_GA_1906;] soap - AuthRequest elapsed=6
2018-02-07 13:20:11,517 INFO  [qtp1595953398-993:https:https://localhost:7071/service/admin/soap/GetAllServersRequest] [name=zimbra;ua=zmprov/8.8.6_GA_1906;] soap - GetAllServersRequest elapsed=26
2018-02-07 13:20:21,982 ERROR [qtp1595953398-866:http://localhost:8080/service/soap/GetInfoRequest] [name=userex@domain1.com;mid=4;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] mailbox - Failed to lock mailbox
Write Lock Owner - ImapSSLServer-8 prio=5 id=276 state=TERMINATED
Lock Waiter - MailboxPurge prio=5 id=64 state=TIMED_WAITING
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireNanos(AbstractQueuedSynchronizer.java:934)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireNanos(AbstractQueuedSynchronizer.java:1247)
    at java.util.concurrent.locks.ReentrantReadWriteLock$WriteLock.tryLock(ReentrantReadWriteLock.java:1115)
    at com.zimbra.cs.mailbox.MailboxLock.tryLockWithTimeout(MailboxLock.java:114)
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:194)
    at com.zimbra.cs.mailbox.Mailbox.beginTransaction(Mailbox.java:1759)
    at com.zimbra.cs.mailbox.Mailbox.beginTransaction(Mailbox.java:1740)
    at com.zimbra.cs.mailbox.Mailbox.purgeMessages(Mailbox.java:8884)
    at com.zimbra.cs.mailbox.PurgeThread.run(PurgeThread.java:150)
Lock Waiter - Timer-Zimbra daemon prio=5 id=30 state=TIMED_WAITING
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireNanos(AbstractQueuedSynchronizer.java:934)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireNanos(AbstractQueuedSynchronizer.java:1247)
    at java.util.concurrent.locks.ReentrantReadWriteLock$WriteLock.tryLock(ReentrantReadWriteLock.java:1115)
    at com.zimbra.cs.mailbox.MailboxLock.tryLockWithTimeout(MailboxLock.java:114)
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:194)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.detach(ImapListener.java:546)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.quietRemoveSession(ImapSessionManager.java:244)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:199)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)

com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.getLastSoapAccessTime(Mailbox.java:1448)
    at com.zimbra.cs.service.account.GetInfo.handle(GetInfo.java:189)
    at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
    at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
    at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
    at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:116)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
    at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
    at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Thread.java:748)
2018-02-07 13:20:21,983 WARN  [qtp1595953398-866:http://localhost:8080/service/soap/GetInfoRequest] [name=userex@domain1.com;mid=4;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - handler exception
com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.getLastSoapAccessTime(Mailbox.java:1448)
    at com.zimbra.cs.service.account.GetInfo.handle(GetInfo.java:189)
    at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
    at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
    at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
    at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:116)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
    at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
    at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Thread.java:748)
2018-02-07 13:20:21,984 INFO  [qtp1595953398-866:http://localhost:8080/service/soap/GetInfoRequest] [name=userex@domain1.com;mid=4;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=90003
2018-02-07 13:20:22,014 INFO  [qtp1595953398-1021:http://localhost:8080/service/soap/GetAvailableLocalesRequest] [name=userex@domain1.com;mid=4;ua=ZCS/8.8.6_GA_1906;] soap - GetAvailableLocalesRequest elapsed=8
2018-02-07 13:20:22,036 INFO  [qtp1595953398-1030:https:https://localhost:7071/service/admin/soap/GetDomainInfoRequest] [ua=ZCS/8.8.6_GA_1906;] soap - GetDomainInfoRequest elapsed=0
2018-02-07 13:20:22,060 INFO  [qtp1595953398-993:http://localhost:8080/service/soap/AuthRequest] [name=userex@domain1.com;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - AuthRequest elapsed=1
2018-02-07 13:20:54,875 ERROR [Timer-Zimbra] [] mailbox - Failed to lock mailbox
Write Lock Owner - ImapSSLServer-8 prio=5 id=276 state=TERMINATED
Lock Waiter - qtp1595953398-1021:http://localhost:8080/service/soap/GetFolderRequest prio=5 id=1021 state=TIMED_WAITING
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
    at java.util.concurrent.locks.ReentrantReadWriteLock$ReadLock.tryLock(ReentrantReadWriteLock.java:871)
    at com.zimbra.cs.mailbox.MailboxLock.tryLockWithTimeout(MailboxLock.java:116)
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:194)
    at com.zimbra.cs.mailbox.Mailbox.getFolderTree(Mailbox.java:4295)
    at com.zimbra.cs.service.mail.GetFolder.handle(GetFolder.java:113)
    at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
    at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
    at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
    at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:116)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
    at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
    at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Thread.java:748)
Lock Waiter - MailboxPurge prio=5 id=64 state=TIMED_WAITING
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireNanos(AbstractQueuedSynchronizer.java:934)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireNanos(AbstractQueuedSynchronizer.java:1247)
    at java.util.concurrent.locks.ReentrantReadWriteLock$WriteLock.tryLock(ReentrantReadWriteLock.java:1115)
    at com.zimbra.cs.mailbox.MailboxLock.tryLockWithTimeout(MailboxLock.java:114)
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:194)
    at com.zimbra.cs.mailbox.Mailbox.beginTransaction(Mailbox.java:1759)
    at com.zimbra.cs.mailbox.Mailbox.beginTransaction(Mailbox.java:1740)
    at com.zimbra.cs.mailbox.Mailbox.purgeMessages(Mailbox.java:8884)
    at com.zimbra.cs.mailbox.PurgeThread.run(PurgeThread.java:150)

com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.detach(ImapListener.java:546)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.quietRemoveSession(ImapSessionManager.java:244)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:199)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:20:54,876 WARN  [Timer-Zimbra] [] imap - skipping error while trying to remove session ImapSession{id=2324, authAcct=c8acf2e7-5331-4f7e-9a79-7af63ba358a5, lastAccessed=2018-02-07 12:03:55,269, cleanedUp=true, addedToCache=false, path=Travel, folderId=c8acf2e7-5331-4f7e-9a79-7af63ba358a5:2223, handler=null}
com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.detach(ImapListener.java:546)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.quietRemoveSession(ImapSessionManager.java:244)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:199)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:21:10,882 ERROR [MailboxPurge] [name=userex@domain1.com;mid=4;] mailbox - Failed to lock mailbox
Write Lock Owner - ImapSSLServer-8 prio=5 id=276 state=TERMINATED
Lock Waiter - Timer-Zimbra daemon prio=5 id=30 state=TIMED_WAITING
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireNanos(AbstractQueuedSynchronizer.java:934)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireNanos(AbstractQueuedSynchronizer.java:1247)
    at java.util.concurrent.locks.ReentrantReadWriteLock$WriteLock.tryLock(ReentrantReadWriteLock.java:1115)
    at com.zimbra.cs.mailbox.MailboxLock.tryLockWithTimeout(MailboxLock.java:114)
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:194)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.unload(ImapListener.java:580)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:195)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
Lock Waiter - qtp1595953398-1021:http://localhost:8080/service/soap/GetFolderRequest prio=5 id=1021 state=TIMED_WAITING
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
    at java.util.concurrent.locks.ReentrantReadWriteLock$ReadLock.tryLock(ReentrantReadWriteLock.java:871)
    at com.zimbra.cs.mailbox.MailboxLock.tryLockWithTimeout(MailboxLock.java:116)
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:194)
    at com.zimbra.cs.mailbox.Mailbox.getFolderTree(Mailbox.java:4295)
    at com.zimbra.cs.service.mail.GetFolder.handle(GetFolder.java:113)
    at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
    at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
    at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
    at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:116)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
    at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
    at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Thread.java:748)

com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.beginTransaction(Mailbox.java:1759)
    at com.zimbra.cs.mailbox.Mailbox.beginTransaction(Mailbox.java:1740)
    at com.zimbra.cs.mailbox.Mailbox.purgeMessages(Mailbox.java:8884)
    at com.zimbra.cs.mailbox.PurgeThread.run(PurgeThread.java:150)
2018-02-07 13:21:10,883 WARN  [MailboxPurge] [name=userex@domain1.com;mid=4;] mailbox - transaction canceled because of lock failure
2018-02-07 13:21:10,883 WARN  [MailboxPurge] [name=userex@domain1.com;mid=4;] purge - Unable to purge mailbox 4
com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.beginTransaction(Mailbox.java:1759)
    at com.zimbra.cs.mailbox.Mailbox.beginTransaction(Mailbox.java:1740)
    at com.zimbra.cs.mailbox.Mailbox.purgeMessages(Mailbox.java:8884)
    at com.zimbra.cs.mailbox.PurgeThread.run(PurgeThread.java:150)
2018-02-07 13:21:28,092 INFO  [qtp1595953398-866:https:https://localhost:7071/service/admin/soap/GetDomainInfoRequest] [ua=ZCS/8.8.6_GA_1906;] soap - GetDomainInfoRequest elapsed=1
2018-02-07 13:21:28,134 INFO  [qtp1595953398-866:https:https://localhost:7071/service/admin/soap/GetDomainInfoRequest] [ua=ZCS/8.8.6_GA_1906;] soap - GetDomainInfoRequest elapsed=1
2018-02-07 13:21:28,329 INFO  [qtp1595953398-1037:https:https://localhost:7071/service/admin/soap/GetDomainInfoRequest] [ua=ZCS/8.8.6_GA_1906;] soap - GetDomainInfoRequest elapsed=1
2018-02-07 13:21:52,076 ERROR [qtp1595953398-1021:http://localhost:8080/service/soap/GetFolderRequest] [name=userex@domain1.com;mid=4;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] mailbox - Failed to lock mailbox
Write Lock Owner - ImapSSLServer-8 prio=5 id=276 state=TERMINATED
Lock Waiter - Timer-Zimbra daemon prio=5 id=30 state=TIMED_WAITING
    at sun.misc.Unsafe.park(Native Method)
    at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireNanos(AbstractQueuedSynchronizer.java:934)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireNanos(AbstractQueuedSynchronizer.java:1247)
    at java.util.concurrent.locks.ReentrantReadWriteLock$WriteLock.tryLock(ReentrantReadWriteLock.java:1115)
    at com.zimbra.cs.mailbox.MailboxLock.tryLockWithTimeout(MailboxLock.java:114)
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:194)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.unload(ImapListener.java:580)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:195)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)

com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.getFolderTree(Mailbox.java:4295)
    at com.zimbra.cs.service.mail.GetFolder.handle(GetFolder.java:113)
    at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
    at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
    at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
    at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:116)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
    at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
    at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Thread.java:748)
2018-02-07 13:21:52,077 WARN  [qtp1595953398-1021:http://localhost:8080/service/soap/GetFolderRequest] [name=userex@domain1.com;mid=4;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - handler exception
com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.getFolderTree(Mailbox.java:4295)
    at com.zimbra.cs.service.mail.GetFolder.handle(GetFolder.java:113)
    at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
    at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
    at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
    at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
    at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
    at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
    at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:116)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
    at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
    at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
    at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
    at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
    at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
    at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
    at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
    at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
    at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
    at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
    at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
    at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
    at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
    at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
    at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
    at org.eclipse.jetty.server.Server.handle(Server.java:517)
    at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
    at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
    at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
    at java.lang.Thread.run(Thread.java:748)
2018-02-07 13:21:52,077 INFO  [qtp1595953398-1021:http://localhost:8080/service/soap/GetFolderRequest] [name=userex@domain1.com;mid=4;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetFolderRequest elapsed=90002
2018-02-07 13:22:10,883 INFO  [MailboxPurge] [name=userex@domain2.com;mid=5;] purge - Purging messages.
2018-02-07 13:22:24,876 ERROR [Timer-Zimbra] [] mailbox - Failed to lock mailbox
Write Lock Owner - ImapSSLServer-8 prio=5 id=276 state=TERMINATED

com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.unload(ImapListener.java:580)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:195)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:22:24,877 WARN  [Timer-Zimbra] [] imap - error serializing session; clearing ImapSession{id=2323, authAcct=c8acf2e7-5331-4f7e-9a79-7af63ba358a5, lastAccessed=2018-02-07 12:03:55,264, cleanedUp=true, addedToCache=false, path=Norwell/Sinagogue, folderId=c8acf2e7-5331-4f7e-9a79-7af63ba358a5:50560, handler=null}
com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.unload(ImapListener.java:580)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:195)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:22:55,183 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/AuthRequest] [name=hb@domain2.com;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - AuthRequest elapsed=3
2018-02-07 13:22:55,200 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,202 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=2
2018-02-07 13:22:55,208 INFO  [qtp1595953398-1043:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,208 INFO  [qtp1595953398-1043:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,213 INFO  [qtp1595953398-1044:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,213 INFO  [qtp1595953398-1044:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,216 INFO  [qtp1595953398-1044:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,216 INFO  [qtp1595953398-1044:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,219 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,219 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,222 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,222 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,225 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,225 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,228 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,228 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,234 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,234 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,237 INFO  [qtp1595953398-1044:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,237 INFO  [qtp1595953398-1044:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=1
2018-02-07 13:22:55,239 INFO  [qtp1595953398-1043:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,240 INFO  [qtp1595953398-1043:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=1
2018-02-07 13:22:55,245 INFO  [qtp1595953398-1045:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,246 INFO  [qtp1595953398-1045:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=1
2018-02-07 13:22:55,249 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,249 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,252 INFO  [qtp1595953398-1044:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,252 INFO  [qtp1595953398-1044:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,255 INFO  [qtp1595953398-1043:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:22:55,255 INFO  [qtp1595953398-1043:http://localhost:8080/service/soap/GetInfoRequest] [oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:22:55,268 INFO  [qtp1595953398-1043:http://localhost:8080/service/soap/GetInfoRequest] [name=hb@domain2.com;mid=11;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=2
2018-02-07 13:22:56,827 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/SearchRequest] [name=hb@domain2.com;mid=11;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - SearchRequest elapsed=5
2018-02-07 13:23:03,598 INFO  [qtp1595953398-1045:http://localhost:8080/service/soap/SearchRequest] [name=hb@domain2.com;mid=11;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - SearchRequest elapsed=8
2018-02-07 13:23:05,641 INFO  [qtp1595953398-1036:http://localhost:8080/service/soap/GetMsgRequest] [name=hb@domain2.com;mid=11;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetMsgRequest elapsed=12
2018-02-07 13:23:07,036 INFO  [qtp1595953398-1045:http://localhost:8080/service/soap/GetMsgRequest] [name=hb@domain2.com;mid=11;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - GetMsgRequest elapsed=4
2018-02-07 13:23:10,923 INFO  [MailboxPurge] [name=gabriel@domain2.com;mid=8;] purge - Purging messages.
2018-02-07 13:23:13,084 INFO  [qtp1595953398-1042:https:https://myserver.domain1.com:5960/dav/norwell@domain2.com/Tasks/] [aname=norwell@domain2.com;ip=192.168.1.100;port=59657;ua=DAVdroid/1.9.10-ose (1/19/18;; dav4android;; okhttp3) Android/6.0.1;] FileUploadServlet - saveUpload(): received Upload: { accountId=a4af9644-511b-43ed-ae07-b523d91ce477, time=Wed Feb 07 13:23:13 EST 2018, size=227, uploadId=478b65de-ba0b-48d9-b81a-46f49ed1f249:660dc4fd-7536-4c91-9bda-e128a17604d3, name=null, path=null }
2018-02-07 13:23:13,088 INFO  [qtp1595953398-1042:https:https://myserver.domain1.com:5960/dav/norwell@domain2.com/Tasks/] [name=norwell@domain2.com;aname=norwell@domain2.com;ip=192.168.1.100;port=59657;ua=DAVdroid/1.9.10-ose (1/19/18;; dav4android;; okhttp3) Android/6.0.1;] dav - DavServlet operation PROPFIND to /home/norwell@domain2.com/Tasks/ (depth: zero) finished in 5ms
2018-02-07 13:23:25,615 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/SendMsgRequest] [name=hb@domain2.com;mid=11;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] smtp - Sending message to MTA at localhost: Message-ID=<199780128.81.1518027805577.JavaMail.zimbra@domain2.com>, origMsgId=36b72047-787a-4f6d-ad6d-2ef6d3f89b25:10265, replyType=r
2018-02-07 13:23:25,670 INFO  [qtp1595953398-1030:http://localhost:8080/service/soap/SendMsgRequest] [name=hb@domain2.com;mid=11;oip=192.168.1.100;ua=zclient/8.8.6_GA_1906;] soap - SendMsgRequest elapsed=100
2018-02-07 13:23:44,230 INFO  [qtp1595953398-1046:https:https://myserver.domain1.com:8443/service/soap/AuthRequest] [name=hb@domain2.com;ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - AuthRequest elapsed=2
2018-02-07 13:23:44,241 INFO  [qtp1595953398-1045:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,242 INFO  [qtp1595953398-1045:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=1
2018-02-07 13:23:44,251 INFO  [qtp1595953398-1030:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,251 INFO  [qtp1595953398-1030:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:23:44,257 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,257 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=1
2018-02-07 13:23:44,260 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,260 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:23:44,265 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,265 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:23:44,268 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,270 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=2
2018-02-07 13:23:44,274 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,276 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=2
2018-02-07 13:23:44,279 INFO  [qtp1595953398-1046:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,280 INFO  [qtp1595953398-1046:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=1
2018-02-07 13:23:44,283 INFO  [qtp1595953398-1045:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,283 INFO  [qtp1595953398-1045:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:23:44,286 INFO  [qtp1595953398-1030:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,286 INFO  [qtp1595953398-1030:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=1
2018-02-07 13:23:44,288 INFO  [qtp1595953398-1030:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,289 INFO  [qtp1595953398-1030:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=1
2018-02-07 13:23:44,291 INFO  [qtp1595953398-1046:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,291 INFO  [qtp1595953398-1046:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:23:44,294 INFO  [qtp1595953398-1045:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,294 INFO  [qtp1595953398-1045:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:23:44,298 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,298 INFO  [qtp1595953398-1052:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=1
2018-02-07 13:23:44,301 INFO  [qtp1595953398-1030:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] SoapEngine - no valid authtoken present: cannot dispatch request
2018-02-07 13:23:44,301 INFO  [qtp1595953398-1030:https:https://myserver.domain1.com:8443/service/soap/GetInfoRequest] [ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - GetInfoRequest elapsed=0
2018-02-07 13:23:44,311 INFO  [qtp1595953398-1046:https:https://myserver.domain1.com:8443/service/soap/EndSessionRequest] [name=hb@domain2.com;mid=11;ip=192.168.1.100;port=60805;ua=zclient/8.8.6_GA_1906;] soap - EndSessionRequest elapsed=1
2018-02-07 13:23:44,340 INFO  [qtp1595953398-1038:https:https://localhost:7071/service/admin/soap/GetDomainInfoRequest] [ua=ZCS/8.8.6_GA_1906;] soap - GetDomainInfoRequest elapsed=0
2018-02-07 13:23:44,353 INFO  [qtp1595953398-1052:https:https://localhost:7071/service/admin/soap/GetDomainInfoRequest] [ua=ZCS/8.8.6_GA_1906;] soap - GetDomainInfoRequest elapsed=0
2018-02-07 13:23:44,841 INFO  [qtp1595953398-1030:https:https://localhost:7071/service/admin/soap/GetDomainInfoRequest] [ua=ZCS/8.8.6_GA_1906;] soap - GetDomainInfoRequest elapsed=0
2018-02-07 13:23:54,818 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:54,841 INFO  [ImapSSLServer-281] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:54,877 ERROR [Timer-Zimbra] [] mailbox - Failed to lock mailbox
Write Lock Owner - ImapSSLServer-8 prio=5 id=276 state=TERMINATED

com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.detach(ImapListener.java:546)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.quietRemoveSession(ImapSessionManager.java:244)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:199)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:23:54,901 WARN  [Timer-Zimbra] [] imap - skipping error while trying to remove session ImapSession{id=2323, authAcct=c8acf2e7-5331-4f7e-9a79-7af63ba358a5, lastAccessed=2018-02-07 12:03:55,264, cleanedUp=true, addedToCache=false, path=Norwell/Sinagogue, folderId=c8acf2e7-5331-4f7e-9a79-7af63ba358a5:50560, handler=null}
com.zimbra.cs.mailbox.MailboxLock$LockFailedException: timeout
    at com.zimbra.cs.mailbox.MailboxLock.lock(MailboxLock.java:211)
    at com.zimbra.cs.mailbox.Mailbox.lock(Mailbox.java:10424)
    at com.zimbra.cs.imap.ImapListener.detach(ImapListener.java:546)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.quietRemoveSession(ImapSessionManager.java:244)
    at com.zimbra.cs.imap.ImapSessionManager$SessionSerializerTask.run(ImapSessionManager.java:199)
    at java.util.TimerThread.mainLoop(Timer.java:555)
    at java.util.TimerThread.run(Timer.java:505)
2018-02-07 13:23:55,729 INFO  [ImapSSLServer-281] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:55,736 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:55,736 INFO  [ImapSSLServer-281] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:55,961 INFO  [ImapSSLServer-281] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:55,961 INFO  [ImapSSLServer-326] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - user userex@domain2.com authenticated, mechanism=PLAIN [TLS]
2018-02-07 13:23:55,961 INFO  [ImapSSLServer-326] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:56,437 INFO  [ImapSSLServer-326] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - user userex@domain2.com authenticated, mechanism=PLAIN [TLS]
2018-02-07 13:23:56,437 INFO  [ImapSSLServer-326] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=1
2018-02-07 13:23:56,792 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,052 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,052 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,068 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,069 INFO  [ImapSSLServer-326] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - NAMESPACE elapsed=1
2018-02-07 13:23:57,080 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,081 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,081 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,081 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,082 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,082 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,108 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,121 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,122 INFO  [ImapSSLServer-326] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,146 INFO  [ImapSSLServer-328] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,146 INFO  [ImapSSLServer-328] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,146 INFO  [ImapSSLServer-328] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,146 INFO  [ImapSSLServer-328] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,153 INFO  [ImapSSLServer-329] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=1
2018-02-07 13:23:57,154 INFO  [ImapSSLServer-330] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=1
2018-02-07 13:23:57,154 INFO  [ImapSSLServer-330] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,169 INFO  [ImapSSLServer-332] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,174 INFO  [ImapSSLServer-333] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - copying message data from serialized session: /Drafts
2018-02-07 13:23:57,174 INFO  [ImapSSLServer-333] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - selected folder Drafts
2018-02-07 13:23:57,175 INFO  [ImapSSLServer-333] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - EXAMINE elapsed=3
2018-02-07 13:23:57,183 INFO  [ImapSSLServer-334] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,193 INFO  [ImapSSLServer-335] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,197 INFO  [ImapSSLServer-336] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=1
2018-02-07 13:23:57,209 INFO  [ImapSSLServer-337] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,209 INFO  [ImapSSLServer-337] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,209 INFO  [ImapSSLServer-337] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,209 INFO  [ImapSSLServer-337] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,210 INFO  [ImapSSLServer-338] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - NAMESPACE elapsed=0
2018-02-07 13:23:57,210 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,210 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,211 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,211 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,211 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,211 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,211 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,211 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,211 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,212 INFO  [ImapSSLServer-338] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=1
2018-02-07 13:23:57,212 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:23:57,213 INFO  [ImapSSLServer-339] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,243 INFO  [ImapSSLServer-341] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=1
2018-02-07 13:23:57,244 INFO  [ImapSSLServer-342] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=1
2018-02-07 13:23:57,245 INFO  [ImapSSLServer-343] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=1
2018-02-07 13:23:57,252 INFO  [ImapSSLServer-344] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=7
2018-02-07 13:23:57,253 INFO  [ImapSSLServer-345] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,253 INFO  [ImapSSLServer-346] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,260 INFO  [ImapSSLServer-347] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=1
2018-02-07 13:23:57,260 INFO  [ImapSSLServer-348] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,261 INFO  [ImapSSLServer-349] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=1
2018-02-07 13:23:57,264 INFO  [ImapSSLServer-350] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,264 INFO  [ImapSSLServer-351] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,274 INFO  [ImapSSLServer-353] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:23:57,281 INFO  [ImapSSLServer-354] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=1
2018-02-07 13:24:10,933 INFO  [MailboxPurge] [name=hb@domain2.com;mid=11;] purge - Purging messages.
2018-02-07 13:24:55,603 INFO  [ImapSSLServer-357] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:24:55,603 INFO  [ImapSSLServer-357] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:24:55,604 INFO  [ImapSSLServer-357] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=1
2018-02-07 13:24:55,604 INFO  [ImapSSLServer-357] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:24:55,604 INFO  [ImapSSLServer-357] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:24:55,606 INFO  [ImapSSLServer-358] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:24:55,613 INFO  [ImapSSLServer-358] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=7
2018-02-07 13:24:55,613 INFO  [ImapSSLServer-359] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:24:55,613 INFO  [ImapSSLServer-359] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:24:55,613 INFO  [ImapSSLServer-359] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:24:55,613 INFO  [ImapSSLServer-359] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:24:55,613 INFO  [ImapSSLServer-359] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - ID elapsed=0
2018-02-07 13:24:55,630 INFO  [ImapSSLServer-359] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - copying message data from serialized session: /Inbox
2018-02-07 13:24:55,635 INFO  [ImapSSLServer-360] [name=userex@domain2.com;mid=5;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - [ search is: in:"Drafts" (item:all date:>=11/7/17 -tag:\Deleted) ]
2018-02-07 13:24:55,636 INFO  [ImapSSLServer-359] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - selected folder INBOX
2018-02-07 13:24:55,644 INFO  [ImapSSLServer-360] [name=userex@domain2.com;mid=5;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - UID SEARCH elapsed=12
2018-02-07 13:24:55,644 INFO  [ImapSSLServer-360] [] imap - dropping connection for user userex@domain2.com (LOGOUT)
2018-02-07 13:24:55,644 INFO  [ImapSSLServer-359] [name=userex@domain2.com;ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - EXAMINE elapsed=31
2018-02-07 13:24:55,645 INFO  [ImapSSLServer-359] [] imap - dropping connection for user userex@domain2.com (LOGOUT)
2018-02-07 13:24:55,645 INFO  [ImapSSLServer-359] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:24:55,645 INFO  [ImapSSLServer-359] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:24:55,645 INFO  [ImapSSLServer-359] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:24:55,646 INFO  [ImapSSLServer-360] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:24:55,646 INFO  [ImapSSLServer-360] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:24:55,646 INFO  [ImapSSLServer-360] [ip=192.168.1.100;oip=10.10.10.10;via=192.168.1.100(nginx/1.7.1);ua=Zimbra/8.8.6_GA_1906;] imap - AUTHENTICATE elapsed=0
2018-02-07 13:25:10,944 INFO  [MailboxPurge] [name=norwell@domain2.com;mid=14;] purge - Purging messages.

Code: Select all

zimbra@myserver:/root$ tail -f /opt/zimbra/log/nginx.log
2018/02/07 13:25:45 [info] 30152#0: *1208 proxied session done, client: 173.76.36.29:46051, server: 0.0.0.0:993, login: "gabriel@domain2.com", upstream: 192.168.1.100:7993 (173.76.36.29:46051->192.168.1.100:993) <=> (192.168.1.100:58460->192.168.1.100:7993)
2018/02/07 13:25:55 [info] 30151#0: *2485 upstream timed out (110: Connection timed out) while reading response from upstream, client: 10.10.10.10:62250, server: 0.0.0.0:993, login: "userex@domain1.com", upstream: 192.168.1.100:7993 (10.10.10.10:62250->192.168.1.100:993) <=> (192.168.1.100:59489->192.168.1.100:7993)
2018/02/07 13:25:55 [info] 30151#0: *2508 upstream timed out (110: Connection timed out) while reading response from upstream, client: 10.10.10.10:38450, server: 0.0.0.0:993, login: "userex@domain1.com", upstream: 192.168.1.100:7993 (10.10.10.10:38450->192.168.1.100:993) <=> (192.168.1.100:59493->192.168.1.100:7993)
2018/02/07 13:25:55 [info] 30151#0: *2504 upstream timed out (110: Connection timed out) while reading response from upstream, client: 10.10.10.10:21008, server: 0.0.0.0:993, login: "userex@domain1.com", upstream: 192.168.1.100:7993 (10.10.10.10:21008->192.168.1.100:993) <=> (192.168.1.100:59495->192.168.1.100:7993)
2018/02/07 13:25:55 [info] 30151#0: *2501 upstream timed out (110: Connection timed out) while reading response from upstream, client: 10.10.10.10:1624, server: 0.0.0.0:993, login: "userex@domain1.com", upstream: 192.168.1.100:7993 (10.10.10.10:1624->192.168.1.100:993) <=> (192.168.1.100:59499->192.168.1.100:7993)
2018/02/07 13:25:55 [info] 30151#0: *2509 upstream timed out (110: Connection timed out) while reading response from upstream, client: 10.10.10.10:55164, server: 0.0.0.0:993, login: "userex@domain1.com", upstream: 192.168.1.100:7993 (10.10.10.10:55164->192.168.1.100:993) <=> (192.168.1.100:59501->192.168.1.100:7993)
2018/02/07 13:25:55 [info] 30151#0: *2493 upstream timed out (110: Connection timed out) while reading response from upstream, client: 10.10.10.10:34421, server: 0.0.0.0:993, login: "userex@domain1.com", upstream: 192.168.1.100:7993 (10.10.10.10:34421->192.168.1.100:993) <=> (192.168.1.100:59503->192.168.1.100:7993)
2018/02/07 13:25:55 [info] 30151#0: *2494 upstream timed out (110: Connection timed out) while reading response from upstream, client: 10.10.10.10:22869, server: 0.0.0.0:993, login: "userex@domain1.com", upstream: 192.168.1.100:7993 (10.10.10.10:22869->192.168.1.100:993) <=> (192.168.1.100:59507->192.168.1.100:7993)
2018/02/07 13:25:55 [info] 30151#0: *2507 upstream timed out (110: Connection timed out) while reading response from upstream, client: 10.10.10.10:10076, server: 0.0.0.0:993, login: "userex@domain1.com", upstream: 192.168.1.100:7993 (10.10.10.10:10076->192.168.1.100:993) <=> (192.168.1.100:59513->192.168.1.100:7993)
2018/02/07 13:25:55 [info] 30151#0: *2511 upstream timed out (110: Connection timed out) while reading response from upstream, client: 10.10.10.10:34706, server: 0.0.0.0:993, login: "userex@domain1.com", upstream: 192.168.1.100:7993 (10.10.10.10:34706->192.168.1.100:993) <=> (192.168.1.100:59515->192.168.1.100:7993)

Code: Select all

$ zmcontrol -v
Release 8.8.6.GA.1906.UBUNTU14.64 UBUNTU14_64 FOSS edition.

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Mon Feb 12, 2018 7:45 pm
by userid12
jorgedlcruz wrote:Hi guys,
Thank you for reaching out and identifying the issue. We're on it! As we conduct a high priority investigation to determine if or what patches might be necessary, check back here for updates in the next few of days. Thanks again!
Hi Jorge, what is the ticket/bug ID for this issue?

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Tue Feb 13, 2018 2:16 pm
by David Bingham
userid12 wrote: Hi Jorge, what is the ticket/bug ID for this issue?
We don't have a public bug for this, as it has been reported through Zimbra support. We've had a team of engineers focused on this, and have a hotfix in test now. It's anticipated to be available before the end of this week - I expect EOD Thursday, if all goes well. (I've warned the team that it must be done before my vacation begins on Friday! ;) )

Once the hotfix is available, it will be announced prominently in the forum.

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Tue Feb 13, 2018 5:14 pm
by davidkillingsworth
David Bingham wrote:
We don't have a public bug for this, as it has been reported through Zimbra support. We've had a team of engineers focused on this, and have a hotfix in test now. It's anticipated to be available before the end of this week - I expect EOD Thursday, if all goes well. (I've warned the team that it must be done before my vacation begins on Friday! ;) )

Once the hotfix is available, it will be announced prominently in the forum.
Thanks for the update David. The communication is much appreciated.

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Wed Feb 14, 2018 6:38 am
by JakeMS
Thanks for the update! Hopefully you guys are able to fix it :D.

Re: Since Upgrading To Zimbra 8.8.5, Have Been Getting Numerous Lock Errors

Posted: Wed Feb 14, 2018 3:05 pm
by L. Mark Stone
David Bingham wrote:
userid12 wrote: Hi Jorge, what is the ticket/bug ID for this issue?
We don't have a public bug for this, as it has been reported through Zimbra support. We've had a team of engineers focused on this, and have a hotfix in test now. It's anticipated to be available before the end of this week - I expect EOD Thursday, if all goes well. (I've warned the team that it must be done before my vacation begins on Friday! ;) )

Once the hotfix is available, it will be announced prominently in the forum.
Thanks David!

Very much appreciate Zimbra posting updates like this here in the forums!

All the best,
Mark