My users are being disconnected from the Zimbra Jabber server a couple of times a day. Maybe two or three times. They are all disconnected at the same time no matter whether they use the Zimbra WebUI or iChat, and they can immediately reconnect.

Digging in the logs I found that the Session Cache removed stale sessions just before the disconnect (see below for log-snipet).


Can anybody confirm the Symptom?
Any ideas?

BTW: Running Zimbra 6.0.13 OSE on Ubuntu 10.04 LTS 64.

Any hint yould be appreciated.

-jsl

Code:
2011-07-06 16:56:50,138 INFO  [Timer-Zimbra] [] SessionCache - Removed 7 idle sessions (SOAP, ADMIN). 4 active sessions remain.
2011-07-06 16:56:50,196 INFO  [AnonymousIoService-8] [] im - XMPP Session closed: (SOCKET, R: /192.168.100.115:57867, L: /192.168.100.158:5222, S: 0.0.0.0/0.0.0.0:5222)
2011-07-06 16:56:50,781 INFO  [btpool0-7506://zimbra/service/soap/NoOpRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:50,781 INFO  [btpool0-7506://zimbra/service/soap/NoOpRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] session - requested session no longer exists: 110527
2011-07-06 16:56:50,843 INFO  [btpool0-7513://zimbra/service/soap/NoOpRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:50,843 INFO  [btpool0-7513://zimbra/service/soap/NoOpRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] session - requested session no longer exists: 110529
2011-07-06 16:56:50,849 INFO  [btpool0-7515://zimbra/service/soap/NoOpRequest] [name=user3;mid=19;ip=192.168.100.127;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:50,850 INFO  [btpool0-7515://zimbra/service/soap/NoOpRequest] [name=user3;mid=19;ip=192.168.100.127;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] session - requested session no longer exists: 110528
2011-07-06 16:56:50,853 INFO  [btpool0-7515://zimbra/service/soap/NoOpRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:50,854 INFO  [btpool0-7515://zimbra/service/soap/NoOpRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] session - requested session no longer exists: 110530
2011-07-06 16:56:50,872 INFO  [btpool0-7512://zimbra/service/soap/NoOpRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:50,982 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - IMGatewayListRequest
2011-07-06 16:56:50,991 INFO  [btpool0-7510://zimbra/service/soap/NoOpRequest] [name=user3;mid=19;ip=192.168.100.127;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:50,997 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMRosterNotification:
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user5  Subscribed=false
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user6 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user7 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user12 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user8 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user9 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user3 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user4 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user10 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user11 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,998 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user13 Firstname Lastname Subscribed=true
2011-07-06 16:56:50,999 INFO  [btpool0-7512://zimbra/service/soap/NoOpRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:51,009 INFO  [btpool0-7510://zimbra/service/soap/NoOpRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:51,017 INFO  [btpool0-7512://zimbra/service/soap/NoOpRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:51,023 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] soap - IMGatewayListRequest
2011-07-06 16:56:51,024 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] soap - BatchRequest
2011-07-06 16:56:51,024 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] soap - (batch) SearchRequest
2011-07-06 16:56:51,034 INFO  [btpool0-7510://zimbra/service/soap/NoOpRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:51,039 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] soap - (batch) SearchRequest
2011-07-06 16:56:51,040 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] soap - (batch) GetMiniCalRequest
2011-07-06 16:56:51,051 INFO  [btpool0-7515://zimbra/service/soap/IMGetRosterRequest] [name=user2;mid=28;ip=192.168.100.100;ua=ZimbraWebClient - SAF3 (Mac)/6.0.13_GA_2918;] soap - IMGetRosterRequest
2011-07-06 16:56:51,063 INFO  [pool-6-thread-1] [] im - INCOMING: 
<iq type="result" id="getPrivLists-198" to="user1/zcs">
  <query xmlns="jabber:iq:privacy"/>
</iq>
2011-07-06 16:56:51,081 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user3;mid=19;ip=192.168.100.127;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - IMGatewayListRequest
2011-07-06 16:56:51,085 INFO  [btpool0-7510://zimbra/service/soap/NoOpRequest] [name=user3;mid=19;ip=192.168.100.127;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:51,091 INFO  [pool-6-thread-1] [] im - INCOMING: 
<iq type="result" id="getPrivLists-105" to="user2/zcs">
  <query xmlns="jabber:iq:privacy"/>
</iq>
2011-07-06 16:56:51,130 INFO  [btpool0-7515://zimbra/service/soap/IMGatewayListRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - IMGatewayListRequest
2011-07-06 16:56:51,136 INFO  [btpool0-7512://zimbra/service/soap/NoOpRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - NoOpRequest
2011-07-06 16:56:51,137 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - IMGetRosterRequest
2011-07-06 16:56:51,138 INFO  [pool-6-thread-1] [] im - INCOMING: 
<iq type="result" id="getPrivLists-106" to="user2/zcs">
  <query xmlns="jabber:iq:privacy"/>
</iq>
2011-07-06 16:56:51,138 INFO  [pool-6-thread-1] [] im - INCOMING: 
<iq type="result" id="getPrivLists-172" to="user3/zcs">
  <query xmlns="jabber:iq:privacy"/>
</iq>
2011-07-06 16:56:51,141 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMRosterNotification:
2011-07-06 16:56:51,141 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user5  Subscribed=false
2011-07-06 16:56:51,141 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user6 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,141 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user7 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,142 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user12 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,142 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user8 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,142 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user9 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,142 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user3 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,142 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user4 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,142 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user10 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,142 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user11 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,142 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user13 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,155 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - BatchRequest
2011-07-06 16:56:51,156 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - (batch) SearchRequest
2011-07-06 16:56:51,176 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - (batch) SearchRequest
2011-07-06 16:56:51,177 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - (batch) GetMiniCalRequest
2011-07-06 16:56:51,179 INFO  [pool-6-thread-1] [] im - INCOMING: 
<iq type="result" id="getPrivLists-172" to="user4/zcs">
  <query xmlns="jabber:iq:privacy"/>
</iq>
2011-07-06 16:56:51,181 INFO  [pool-6-thread-1] [] im - INCOMING: 
<iq type="result" id="getPrivLists-199" to="user1/zcs">
  <query xmlns="jabber:iq:privacy"/>
</iq>
2011-07-06 16:56:51,191 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMRosterNotification:
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user5  Subscribed=false
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user6 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user7 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user12 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user8 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user9 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user3 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user4 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user10 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user11 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,192 INFO  [btpool0-7506://zimbra/service/soap/BatchRequest] [name=user1;mid=20;ip=192.168.100.26;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user13 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,234 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] soap - IMGetRosterRequest
2011-07-06 16:56:51,235 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMRosterNotification:
2011-07-06 16:56:51,235 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user5  Subscribed=false
2011-07-06 16:56:51,235 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user6 Susanne Subscribed=true
2011-07-06 16:56:51,235 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user7 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,235 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user12 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,235 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user8 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,236 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user3 Firstname Subscribed=true
2011-07-06 16:56:51,236 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user10 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,236 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user1 Firstname Subscribed=true
2011-07-06 16:56:51,236 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user11 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,236 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMSubscribedNotification user13 Firstname Lastname Subscribed=true
2011-07-06 16:56:51,237 INFO  [btpool0-7506://zimbra/service/soap/IMGetRosterRequest] [name=user4;mid=17;ip=192.168.100.128;ua=ZimbraWebClient - FF3.0 (Mac)/6.0.13_GA_2918;] im - IMRosterNotification: