Community Tip - Have a PTC product question you need answered fast? Chances are someone has asked it before. Learn about the community search. X
Hi,
I am facing an issue with endpoint reconnection unsuccessful error when deploying the ems code. I tried changing the proxy settings but still the error exists. I am not able to get the data on ThingWorx. I am getting the following result while executing:
Simulated Data supported...........
SimulateTimer.Set.run() Tue Apr 26 09:49:28 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:49:28 IST 2016
09:49:28.390 [main] INFO c.t.c.c.p.ClientMessageProcessor - Created new ClientMessageProcessor [minPoolSize: 4, maxPoolSize: 10, maxThreadLife: 10000, maxQueueSize: 1000]
09:49:28.540 [main] DEBUG i.n.u.i.l.InternalLoggerFactory - Using SLF4J as the default logging framework
09:49:28.557 [main] DEBUG i.n.c.MultithreadEventLoopGroup - -Dio.netty.eventLoopThreads: 8
09:49:28.596 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.nio.ch.DirectBuffer.cleaner(): available
09:49:28.597 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Buffer.address: available
09:49:28.599 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.theUnsafe: available
09:49:28.600 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.copyMemory: available
09:49:28.601 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Bits.unaligned: true
09:49:28.602 [main] DEBUG i.n.util.internal.PlatformDependent - Platform: Windows
09:49:28.607 [main] DEBUG i.n.util.internal.PlatformDependent - Java version: 8
09:49:28.607 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noUnsafe: false
09:49:28.608 [main] DEBUG i.n.util.internal.PlatformDependent - sun.misc.Unsafe: available
09:49:28.609 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noJavassist: false
09:49:28.610 [main] DEBUG i.n.util.internal.PlatformDependent - Javassist: unavailable
09:49:28.611 [main] DEBUG i.n.util.internal.PlatformDependent - You don't have Javassist in your class path or you don't have enough permission to load dynamically generated classes. Please check the configuration for better performance.
09:49:28.611 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.tmpdir: C:\Users\PREETH~1\AppData\Local\Temp (java.io.tmpdir)
09:49:28.612 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.bitMode: 64 (sun.arch.data.model)
09:49:28.612 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noPreferDirect: false
09:49:28.649 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.noKeySetOptimization: false
09:49:28.649 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.selectorAutoRebuildThreshold: 512
09:49:28.972 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numHeapArenas: 4
09:49:28.972 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numDirectArenas: 4
09:49:28.972 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.pageSize: 8192
09:49:28.973 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxOrder: 11
09:49:28.973 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.chunkSize: 16777216
09:49:28.973 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.tinyCacheSize: 512
09:49:28.973 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.smallCacheSize: 256
09:49:28.973 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.normalCacheSize: 64
09:49:28.973 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxCachedBufferCapacity: 32768
09:49:28.973 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheTrimInterval: 8192
09:49:28.973 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheCleanupInterval: 5000 ms
09:49:28.991 [main] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - Initializing CommunicationEndpoint Connection Monitor...
09:49:28.994 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:49:28.995 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:49:28.995 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:49:28.996 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
09:49:29.092 [Client-EndpointMonitor-1] DEBUG i.n.util.internal.ThreadLocalRandom - -Dio.netty.initialSeedUniquifier: 0xbf101f470ca3ac88
09:49:29.106 [Client-EndpointMonitor-1] DEBUG i.n.channel.ChannelOutboundBuffer - -Dio.netty.threadLocalDirectBufferSize: 65536
09:49:29.107 [Client-EndpointMonitor-1] DEBUG io.netty.util.Recycler - -Dio.netty.recycler.maxCapacity.default: 262144
09:49:29.143 [Client-EndpointMonitor-1] DEBUG io.netty.buffer.ByteBufUtil - -Dio.netty.allocator.type: unpooled
09:49:29.240 [NettyClient-NIO-1] DEBUG io.netty.util.ResourceLeakDetector - -Dio.netty.leakDetectionLevel: simple
SimulateTimer.ReSet.run() Tue Apr 26 09:49:38 IST 2016
09:49:39.153 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:49:39.154 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:49:39.155 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:49:40 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:49:48 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:49:52 IST 2016
09:49:54.154 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:49:54.154 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:49:54.154 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:49:54.154 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.ReSet.run() Tue Apr 26 09:49:58 IST 2016
09:50:04.155 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:50:04.159 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:50:04.159 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:50:04 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:50:08 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:50:16 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:50:18 IST 2016
09:50:19.159 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:50:19.159 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:50:19.159 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:50:19.159 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.Set.run() Tue Apr 26 09:50:28 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:50:28 IST 2016
09:50:29.161 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:50:29.161 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:50:29.161 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.ReSet.run() Tue Apr 26 09:50:38 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:50:40 IST 2016
09:50:44.161 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:50:44.161 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:50:44.161 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:50:44.161 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.ReSet.run() Tue Apr 26 09:50:48 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:50:52 IST 2016
09:50:54.162 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:50:54.162 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:50:54.162 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.ReSet.run() Tue Apr 26 09:50:58 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:51:04 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:51:08 IST 2016
09:51:09.161 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:51:09.161 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:51:09.161 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:51:09.162 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.Set.run() Tue Apr 26 09:51:16 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:51:18 IST 2016
09:51:19.165 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:51:19.165 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:51:19.165 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:51:28 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:51:28 IST 2016
09:51:34.165 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:51:34.165 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:51:34.165 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:51:34.165 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.ReSet.run() Tue Apr 26 09:51:38 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:51:40 IST 2016
09:51:44.166 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:51:44.166 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:51:44.167 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.ReSet.run() Tue Apr 26 09:51:48 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:51:52 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:51:58 IST 2016
09:51:59.167 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:51:59.167 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:51:59.167 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:51:59.167 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.Set.run() Tue Apr 26 09:52:04 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:52:08 IST 2016
09:52:09.168 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:52:09.168 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:52:09.168 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:52:16 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:52:18 IST 2016
09:52:24.168 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:52:24.168 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:52:24.168 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:52:24.168 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.Set.run() Tue Apr 26 09:52:28 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:52:28 IST 2016
09:52:34.169 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:52:34.169 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:52:34.169 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.ReSet.run() Tue Apr 26 09:52:38 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:52:40 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:52:48 IST 2016
09:52:49.168 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:52:49.168 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:52:49.168 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:52:49.168 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.Set.run() Tue Apr 26 09:52:52 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:52:58 IST 2016
09:52:59.170 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:52:59.170 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:52:59.170 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:53:04 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:53:08 IST 2016
09:53:14.169 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:53:14.169 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:53:14.169 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:53:14.169 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.Set.run() Tue Apr 26 09:53:16 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:53:18 IST 2016
09:53:24.170 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:53:24.170 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:53:24.170 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:53:28 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:53:28 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:53:38 IST 2016
09:53:39.170 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:53:39.170 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:53:39.170 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:53:39.170 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.Set.run() Tue Apr 26 09:53:40 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:53:48 IST 2016
09:53:49.171 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:53:49.171 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:53:49.171 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:53:52 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:53:58 IST 2016
09:54:04.171 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:54:04.171 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:54:04.171 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:54:04.171 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.Set.run() Tue Apr 26 09:54:04 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:54:08 IST 2016
09:54:14.172 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:54:14.172 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:54:14.172 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:54:16 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:54:18 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:54:28 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:54:28 IST 2016
09:54:29.172 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:54:29.172 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:54:29.172 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:54:29.172 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.ReSet.run() Tue Apr 26 09:54:38 IST 2016
09:54:39.175 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:54:39.175 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:54:39.175 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:54:40 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:54:48 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:54:52 IST 2016
09:54:54.175 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:54:54.175 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:54:54.175 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:54:54.175 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.ReSet.run() Tue Apr 26 09:54:58 IST 2016
09:55:04.176 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:55:04.176 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:55:04.176 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Tue Apr 26 09:55:04 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:55:08 IST 2016
SimulateTimer.Set.run() Tue Apr 26 09:55:16 IST 2016
SimulateTimer.ReSet.run() Tue Apr 26 09:55:18 IST 2016
Just to follow up on the other post, is this setup to run with SSL? The reason I'm asking is because it seems to timeout waiting for the websocket handshake to complete, and you've pointed it to localhost:80. Is your platform at port 80? Can you try adding a self-signed certificate to your Tomcat and then connecting over wss instead? Here's a quick guide on how to setup SSL on Tomcat.
hi,
thanks for replying. when I click the link for setup of SSL, the page is redirected saying as Access denied. Can you suggest some other way to setup SSL on tomcat.
Hi,
I followed the setup for SSL in tomcat through other other website and tried executing code but still the result is same. Can you suggest some solution for this issue.
Preethi, with the SSL setup, can you post a new set of logs?
after SSL setup, I got the following result:
Data Configred...
getThingWorxUri : ws://localhost:80/Thingworx/WS
getAppKey : 590f0f4d-2288-4703-807a-e31d30ea1e49
getScanRate : 10000
getStartSensor : 1
getNoOfSensors : 6
getOperation : simulated
Simulated Data supported...........
SimulateTimer.Set.run() Fri Apr 29 09:59:02 IST 2016
SimulateTimer.ReSet.run() Fri Apr 29 09:59:02 IST 2016
09:59:02.817 [main] INFO c.t.c.c.p.ClientMessageProcessor - Created new ClientMessageProcessor [minPoolSize: 4, maxPoolSize: 10, maxThreadLife: 10000, maxQueueSize: 1000]
09:59:02.973 [main] DEBUG i.n.u.i.l.InternalLoggerFactory - Using SLF4J as the default logging framework
09:59:02.990 [main] DEBUG i.n.c.MultithreadEventLoopGroup - -Dio.netty.eventLoopThreads: 8
09:59:03.008 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.nio.ch.DirectBuffer.cleaner(): available
09:59:03.009 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Buffer.address: available
09:59:03.010 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.theUnsafe: available
09:59:03.011 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.copyMemory: available
09:59:03.011 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Bits.unaligned: true
09:59:03.012 [main] DEBUG i.n.util.internal.PlatformDependent - Platform: Windows
09:59:03.013 [main] DEBUG i.n.util.internal.PlatformDependent - Java version: 8
09:59:03.013 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noUnsafe: false
09:59:03.013 [main] DEBUG i.n.util.internal.PlatformDependent - sun.misc.Unsafe: available
09:59:03.014 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noJavassist: false
09:59:03.016 [main] DEBUG i.n.util.internal.PlatformDependent - Javassist: unavailable
09:59:03.016 [main] DEBUG i.n.util.internal.PlatformDependent - You don't have Javassist in your class path or you don't have enough permission to load dynamically generated classes. Please check the configuration for better performance.
09:59:03.017 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.tmpdir: C:\Users\PREETH~1\AppData\Local\Temp (java.io.tmpdir)
09:59:03.017 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.bitMode: 64 (sun.arch.data.model)
09:59:03.017 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noPreferDirect: false
09:59:03.051 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.noKeySetOptimization: false
09:59:03.051 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.selectorAutoRebuildThreshold: 512
09:59:03.217 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numHeapArenas: 4
09:59:03.218 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numDirectArenas: 4
09:59:03.218 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.pageSize: 8192
09:59:03.221 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxOrder: 11
09:59:03.222 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.chunkSize: 16777216
09:59:03.222 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.tinyCacheSize: 512
09:59:03.222 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.smallCacheSize: 256
09:59:03.222 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.normalCacheSize: 64
09:59:03.222 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxCachedBufferCapacity: 32768
09:59:03.222 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheTrimInterval: 8192
09:59:03.222 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheCleanupInterval: 5000 ms
09:59:03.234 [main] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - Initializing CommunicationEndpoint Connection Monitor...
09:59:03.235 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:59:03.236 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:59:03.236 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:59:03.236 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
09:59:03.300 [Client-EndpointMonitor-1] DEBUG i.n.util.internal.ThreadLocalRandom - -Dio.netty.initialSeedUniquifier: 0xe51974cd1a0a5003
09:59:03.309 [Client-EndpointMonitor-1] DEBUG i.n.channel.ChannelOutboundBuffer - -Dio.netty.threadLocalDirectBufferSize: 65536
09:59:03.310 [Client-EndpointMonitor-1] DEBUG io.netty.util.Recycler - -Dio.netty.recycler.maxCapacity.default: 262144
09:59:03.332 [Client-EndpointMonitor-1] DEBUG io.netty.buffer.ByteBufUtil - -Dio.netty.allocator.type: unpooled
09:59:03.403 [NettyClient-NIO-1] DEBUG io.netty.util.ResourceLeakDetector - -Dio.netty.leakDetectionLevel: simple
SimulateTimer.ReSet.run() Fri Apr 29 09:59:12 IST 2016
09:59:13.346 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:59:13.347 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:59:13.348 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Fri Apr 29 09:59:14 IST 2016
SimulateTimer.ReSet.run() Fri Apr 29 09:59:22 IST 2016
SimulateTimer.Set.run() Fri Apr 29 09:59:26 IST 2016
09:59:28.348 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
09:59:28.348 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: HvacGateway, id: 0]. Attempting [re]connect...
09:59:28.348 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
09:59:28.348 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
SimulateTimer.ReSet.run() Fri Apr 29 09:59:32 IST 2016
09:59:38.352 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]
09:59:38.352 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://localhost:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
09:59:38.353 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: HvacGateway, id: 0]
SimulateTimer.Set.run() Fri Apr 29 09:59:38 IST 2016
for SSL setup, I followed the link:
Preethi, since you've setup ssl, please point the URI to your secure port, rather than 'ws://localhost:80/Thingworx/WS'. For example, if setup on port 443, the URI would be 'wss://localhost:443/Thingworx/WS'.
hi,
I tried with local host 8080 it is working but when I connected with other IP address, I got same error again. I got following log result. Can you suggest some solution.
Data Configred...
getThingWorxUri : ws://192.168.1.103:80/Thingworx/WS 5dfb3778-418c-4d2d-95c7-5ce195cf92e2 10000 1 6 simulated
getAppKey : xxxxxxxxxxxxxxxxxxxxxxxx
getScanRate : 1000
getStartSensor : 1
getNoOfSensors : 6
getOperation : simulated
Simulated Data not supported...........
SimulateTimer.Set.run() Wed May 11 12:43:50 IST 2016
SimulateTimer.ReSet.run() Wed May 11 12:43:50 IST 2016
12:43:50.268 [main] INFO c.t.c.c.p.ClientMessageProcessor - Created new ClientMessageProcessor [minPoolSize: 4, maxPoolSize: 10, maxThreadLife: 10000, maxQueueSize: 1000]
12:43:50.352 [main] DEBUG i.n.u.i.l.InternalLoggerFactory - Using SLF4J as the default logging framework
12:43:50.360 [main] DEBUG i.n.c.MultithreadEventLoopGroup - -Dio.netty.eventLoopThreads: 8
12:43:50.373 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.nio.ch.DirectBuffer.cleaner(): available
12:43:50.374 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Buffer.address: available
12:43:50.374 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.theUnsafe: available
12:43:50.374 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.copyMemory: available
12:43:50.375 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Bits.unaligned: true
12:43:50.375 [main] DEBUG i.n.util.internal.PlatformDependent - Platform: Windows
12:43:50.375 [main] DEBUG i.n.util.internal.PlatformDependent - Java version: 8
12:43:50.375 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noUnsafe: false
12:43:50.375 [main] DEBUG i.n.util.internal.PlatformDependent - sun.misc.Unsafe: available
12:43:50.376 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noJavassist: false
12:43:50.377 [main] DEBUG i.n.util.internal.PlatformDependent - Javassist: unavailable
12:43:50.377 [main] DEBUG i.n.util.internal.PlatformDependent - You don't have Javassist in your class path or you don't have enough permission to load dynamically generated classes. Please check the configuration for better performance.
12:43:50.377 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.tmpdir: C:\Users\PREETH~1\AppData\Local\Temp (java.io.tmpdir)
12:43:50.377 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.bitMode: 64 (sun.arch.data.model)
12:43:50.378 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noPreferDirect: false
12:43:50.394 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.noKeySetOptimization: false
12:43:50.395 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.selectorAutoRebuildThreshold: 512
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numHeapArenas: 4
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numDirectArenas: 4
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.pageSize: 8192
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxOrder: 11
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.chunkSize: 16777216
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.tinyCacheSize: 512
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.smallCacheSize: 256
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.normalCacheSize: 64
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxCachedBufferCapacity: 32768
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheTrimInterval: 8192
12:43:50.496 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheCleanupInterval: 5000 ms
12:43:50.503 [main] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - Initializing CommunicationEndpoint Connection Monitor...
12:43:50.503 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints
12:43:50.503 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: InsuranceGateway, id: 0]. Attempting [re]connect...
12:43:50.504 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]
12:43:50.504 [Client-EndpointMonitor-1] INFO c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]
12:43:50.536 [Client-EndpointMonitor-1] DEBUG i.n.util.internal.ThreadLocalRandom - -Dio.netty.initialSeedUniquifier: 0x4ad0020792e4e10f
12:43:50.542 [Client-EndpointMonitor-1] DEBUG i.n.channel.ChannelOutboundBuffer - -Dio.netty.threadLocalDirectBufferSize: 65536
12:43:50.543 [Client-EndpointMonitor-1] DEBUG io.netty.util.Recycler - -Dio.netty.recycler.maxCapacity.default: 262144
12:43:50.561 [Client-EndpointMonitor-1] DEBUG io.netty.buffer.ByteBufUtil - -Dio.netty.allocator.type: unpooled
12:43:50.595 [NettyClient-NIO-1] DEBUG io.netty.util.ResourceLeakDetector - -Dio.netty.leakDetectionLevel: simple
SimulateTimer.ReSet.run() Wed May 11 12:44:00 IST 2016
12:44:00.568 [Client-EndpointMonitor-1] INFO c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: true, is active: false]
12:44:00.570 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://192.168.1.103:80/Thingworx/WS] failed : timeout waiting for websocket handshake to complete
12:44:00.571 [Client-EndpointMonitor-1] INFO c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: InsuranceGateway, id: 0]
SimulateTimer.Set.run() Wed May 11 12:44:02 IST 2016
SimulateTimer.ReSet.run() Wed May 11 12:44:10 IST 2016
SimulateTimer.Set.run() Wed May 11 12:44:14 IST 2016
Preethi, just to check, you can browse to the server at 192.168.1.103:80/Thingworx, correct? Can you also verify the local firewall's config so that it is not blocking anything?