Connection problems

Spark clients does not auto reconnect to the OpenFire server after it has been restarted…

Openfire and Spark versions?

Anything in Openfire logs?

Spark logs? C:\Users\User\AppData\Roaming\Spark\logs

Openfire version 4.0.3

Spark version 2.8.0

log openfire all.log:

2016.11.17 13:03:59 INFO [Thread-1]: org.jivesoftware.openfire.XMPPServer - Shutting down 50 modules …

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.pubsub.PubSubPersistenceManager - Flushing write cache to database

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.pubsub.PubSubPersistenceManager - Flushing write cache to database

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[socket_c2s] - Stopped.

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[socket_c2s-legacyMode] - Stopped.

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[socket_s2s] - Stopped.

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[component] - Stopped.

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[component-legacyMode] - Stopped.

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[connection_manager] - Stopped.

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[connection_manager-legacyMode] - Stopped.

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.http.HttpSessionManager - Stopping instance

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.http.HttpBindManager - HTTP bind service stopped

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.XMPPServer - Shutting down plugins …

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.XMPPServer - Openfire stopped

2016.11.17 13:04:00 INFO [Thread-1]: org.jivesoftware.openfire.XMPPServer - Server halted

2016.11.17 13:04:17 INFO [main]: org.jivesoftware.openfire.XMPPServer - Registering shutdown hook (standalone mode)

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Routing Servers Cache

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Routing Components Cache

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Routing Users Cache

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Routing AnonymousUsers Cache

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Routing User Sessions

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Roster

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Multicast Service

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Offline Message Size

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for VCard

2016.11.17 13:04:21 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Privacy Lists

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for File Transfer Cache

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Offline Presence Cache

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Last Activity Cache

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for User

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Remote Users Existence

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Components Sessions

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Connection Managers Sessions

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Incoming Server Sessions

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Sessions by Hostname

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Validated Domains

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Client Session Info Cache

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created local-only cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Entity Capabilities

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created local-only cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Entity Capabilities Users

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Directed Presences

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created local-only cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for PEPServiceManager

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for File Transfer

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Published Items

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Disco Server Features

2016.11.17 13:04:22 INFO [main]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Disco Server Items

2016.11.17 13:04:23 INFO [main]: org.jivesoftware.openfire.pubsub.PubSubModule - Публикация подписки домена: pubsub.voip.tsd-group.ru

2016.11.17 13:04:23 INFO [main]: org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl - Домен чата: conference.voip.tsd-group.ru

2016.11.17 13:04:24 INFO [main]: org.jivesoftware.openfire.XMPPServer - Openfire 4.0.3 [17.11.2016 13:04:24]

2016.11.17 13:04:25 INFO [pool-3-thread-1]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Creating new SslContextFactory instance

2016.11.17 13:04:28 INFO [pool-3-thread-1]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Favicon Misses

2016.11.17 13:04:28 INFO [pool-3-thread-1]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Favicon Hits

2016.11.17 13:04:28 INFO [pool-3-thread-1]: org.jivesoftware.openfire.container.AdminConsolePlugin - Konsol uspecho zapuchena po adressam :

http://voip.tsd-group.ru:9090

https://voip.tsd-group.ru:9091

2016.11.17 13:04:29 INFO [pool-3-thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[socket_c2s] - Started.

2016.11.17 13:04:29 INFO [pool-3-thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[socket_c2s-legacyMode] - Started.

2016.11.17 13:04:29 WARN [pool-3-thread-1]: org.jivesoftware.openfire.spi.LegacyConnectionAcceptor - Configuration allows for up to 16 threads, although implementation is limited to exactly one.

2016.11.17 13:04:29 INFO [pool-3-thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[socket_s2s] - Started.

2016.11.17 13:04:30 INFO [pool-3-thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[component] - Started.

2016.11.17 13:04:30 INFO [pool-3-thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[component-legacyMode] - Started.

2016.11.17 13:04:30 INFO [pool-3-thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[connection_manager] - Started.

2016.11.17 13:04:30 INFO [pool-3-thread-1]: org.jivesoftware.openfire.spi.ConnectionListener[connection_manager-legacyMode] - Started.

2016.11.17 13:04:31 INFO [pool-3-thread-1]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Creating new SslContextFactory instance

2016.11.17 13:04:31 INFO [pool-3-thread-1]: org.jivesoftware.openfire.http.HttpBindManager - Installed response compression filter

2016.11.17 13:04:31 INFO [pool-3-thread-1]: org.jivesoftware.openfire.http.HttpSessionManager - Starting instance

2016.11.17 13:04:31 INFO [pool-3-thread-1]: org.jivesoftware.openfire.http.HttpBindManager - HTTP bind service started

2016.11.17 13:12:42 INFO [Jetty-QTP-AdminConsole-68]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Locked Out Accounts

2016.11.17 13:14:46 INFO [socket_c2s-thread-3]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Group

2016.11.17 13:14:46 INFO [socket_c2s-thread-3]: org.jivesoftware.util.cache.CacheFactory - Created cache [org.jivesoftware.util.cache.DefaultLocalCacheStrategy] for Group Metadata Cache

What about Spark logs?

What exactly happens after the server restart? Does Spark try to reconnect infinitely or do it just stops or freezes or crashes?

Btw, you might want to remove your domain name from the logs above.

There is nothing in the spark logs.

After restarting the server, all Spark clients is trying to reconnect infinitely.

It’s weird that Spark logs are empty. Should at least log some timeout error. Are you sure you are checking at C:\Users\User\AppData\Roaming\Spark\logs?

Also, you Openfire’s error log is empty also?

Well, you can try updating to 2.8.1, though i think it won’t change anything. Have no ideas.

In spark log appeared only this one record:

ноя 17, 2016 1:20:16 PM org.jivesoftware.spark.util.log.Log error

SEVERE:

org.jivesoftware.smack.SmackException$NotConnectedException: Client is not, or no longer, connected.

at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketWriter.throwNotConnectedExce ptionIfDoneAndResumptionNotPossible(XMPPTCPConnection.java:1252)

at org.jivesoftware.smack.tcp.XMPPTCPConnection.throwNotConnectedExceptionIfApprop riate(XMPPTCPConnection.java:345)

at org.jivesoftware.smack.AbstractXMPPConnection.sendStanza(AbstractXMPPConnection .java:617)

at org.jivesoftware.smack.AbstractXMPPConnection.createPacketCollectorAndSend(Abst ractXMPPConnection.java:711)

at org.jivesoftware.smack.AbstractXMPPConnection.createPacketCollectorAndSend(Abst ractXMPPConnection.java:700)

at org.jivesoftware.smackx.iqprivate.PrivateDataManager.getPrivateData(PrivateData Manager.java:162)

at org.jivesoftware.sparkimpl.plugin.scratchpad.Tasks.getTaskList(Tasks.java:208)

at org.jivesoftware.sparkimpl.plugin.scratchpad.TaskNotification$2.lambda$run$0(Ta skNotification.java:69)

at java.awt.event.InvocationEvent.dispatch(Unknown Source)

at java.awt.EventQueue.dispatchEventImpl(Unknown Source)

at java.awt.EventQueue.access$500(Unknown Source)

at java.awt.EventQueue$3.run(Unknown Source)

at java.awt.EventQueue$3.run(Unknown Source)

at java.security.AccessController.doPrivileged(Native Method)

at java.security.ProtectionDomain$JavaSecurityAccessImpl.doIntersectionPrivilege(U nknown Source)

at java.awt.EventQueue.dispatchEvent(Unknown Source)

at java.awt.EventDispatchThread.pumpOneEventForFilters(Unknown Source)

at java.awt.EventDispatchThread.pumpEventsForFilter(Unknown Source)

at java.awt.EventDispatchThread.pumpEventsForHierarchy(Unknown Source)

at java.awt.EventDispatchThread.pumpEvents(Unknown Source)

at java.awt.EventDispatchThread.pumpEvents(Unknown Source)

at java.awt.EventDispatchThread.run(Unknown Source)

Also, there are no records in openfire error log. Last record was on 15 Nov

We are using authorisation by Microsoft AD server

Update to version 2.8.1 has not solved the problem.

These clients were using older 2.7 versions? It is not a clean install? This reminded me an issue i had with one PC at work. It couldn’t reconnect after coming from Sleep and i think there were similar error in the log. I had to cleanly reinstall Spark and also start with a fresh profile for a user (have saved transcripts and copied them back to a new profile). Only then this issue went away. Another issue with new messages not appearing and only flashing in the taskbar has been fixed the same way. I think some older files (from old version) are causing that. But upgrade process only overwrites existing files and do not remove files that are not needed anymore.

So, you can try with a clean reinstall and fresh Spark profile.

All Clients using 2.8.0 and 2.8.1 version. I have installed the Spark client version 2.8.0 not long ago.

So, 2.8.0 was the first version installed on those PCs or maybe it was older 2.7 version before? Anyway, i don’t have any other suggestion as to try clean install\profile on one of them.