Error when deploying EMS with Pi temp humidity sensor.

[rkelly1]

(I am not the administrator for my instance)

In part 5 of the Raspberry Pi Weather Application project, I get an error when trying to connect the Pi to ThingWorx. the commands I ran are:

java -jar ./temperature-thing-jar-with-dependencies.jar ws://xxxxxx.clould.thingworx.com:80//Thingworx/ws b7b95994-865b-446c-ace7-b9438bdf1d80

and

java -jar ./temperature-thing-jar-with-dependencies.jar wss://xxxxxx.clould.thingworx.com//Thingworx/ws b7b95994-865b-446c-ace7-b9438bdf1d80

Also, when I run the simulated command from my desktop, I receive the message that the system cannot find the file, but the .jar file is clearly where it is supposed to be. Any help will be appreciated. The errors from the Pi and Windows are shown below:

From my Desktop:

C:\temperature-thing\temperature-thing\target>java -jar ./temperature-thing-jar-with-dependencies.jar wss://xxxxxxxx.cloud.thingworx.com//Thingworx/WS</thingworx b7b95994-865b-446c-ace7-b9438bdf1d80 simulated

The system cannot find the file specified.

C:\temperature-thing\temperature-thing\target>java -jar C:\temperature-thing\temperature-thing\target/temperature-thing-jar-with-dependencies.jar wss://xxxxxxxxx.cloud.thingworx.com//Thingworx/WS</thingworx b7b95994-865b-446c-ace7-b9438bdf1d80 simulated

The system cannot find the file specified.

From my Pi:

pi@raspberrypi ~ $ java -jar ./temperature-thing-jar-with-dependencies.jar ws://xxxxxx.clould.thingworx.com:80//Thingworx/ws b7b95994-865b-446c-ace7-b9438bdf1d80

19:19:14.662 [main] DEBUG c.p.tempthing.BaseEdgeServer - EDGE SERVER STARTING....

19:19:15.199 [main] INFO  c.t.c.c.p.ClientMessageProcessor - Created new ClientMessageProcessor [minPoolSize: 4, maxPoolSize: 10, maxThreadLife: 10000, maxQueueSize: 1000]

19:19:15.577 [main] DEBUG com.ptcmanaged.tempthing.Main - Connecting to ws://xxxxx.clould.thingworx.com:80//Thingworx/ws using key b7b95994-865b-446c-ace7-b9438bdf1d80

19:19:15.657 [main] DEBUG i.n.u.i.l.InternalLoggerFactory - Using SLF4J as the default logging framework

19:19:15.684 [main] DEBUG i.n.c.MultithreadEventLoopGroup - -Dio.netty.eventLoopThreads: 8

19:19:15.748 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.nio.ch.DirectBuffer.cleaner(): available

19:19:15.754 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Buffer.address: available

19:19:15.759 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.theUnsafe: available

19:19:15.763 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.copyMemory: available

19:19:15.766 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Bits.unaligned: false

19:19:15.808 [main] DEBUG i.n.util.internal.PlatformDependent - UID: 1000

19:19:15.810 [main] DEBUG i.n.util.internal.PlatformDependent - Java version: 8

19:19:15.811 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noUnsafe: false

19:19:15.811 [main] DEBUG i.n.util.internal.PlatformDependent - sun.misc.Unsafe: available

19:19:15.814 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noJavassist: false

19:19:15.820 [main] DEBUG i.n.util.internal.PlatformDependent - Javassist: unavailable

19:19:15.821 [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.

19:19:15.822 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.tmpdir: /tmp (java.io.tmpdir)

19:19:15.824 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.bitMode: 32 (sun.arch.data.model)

19:19:15.824 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noPreferDirect: false

19:19:15.934 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.noKeySetOptimization: false

19:19:15.935 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.selectorAutoRebuildThreshold: 512

19:19:16.064 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numHeapArenas: 1

19:19:16.065 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numDirectArenas: 1

19:19:16.065 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.pageSize: 8192

19:19:16.066 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxOrder: 11

19:19:16.066 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.chunkSize: 16777216

19:19:16.066 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.tinyCacheSize: 512

19:19:16.067 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.smallCacheSize: 256

19:19:16.067 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.normalCacheSize: 64

19:19:16.067 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxCachedBufferCapacity: 32768

19:19:16.068 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheTrimInterval: 8192

19:19:16.068 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheCleanupInterval: 5000 ms

19:19:16.136 [main] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - Initializing CommunicationEndpoint Connection Monitor...

19:19:16.138 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints

19:19:16.139 [Client-EndpointMonitor-1] INFO  c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: EP_0, id: 0]. Attempting [re]connect...

19:19:16.142 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]

19:19:16.143 [Client-EndpointMonitor-1] INFO  c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]

19:19:16.351 [Client-EndpointMonitor-1] DEBUG i.n.util.internal.ThreadLocalRandom - -Dio.netty.initialSeedUniquifier: 0x1e0de45765c53dc6

19:19:16.393 [Client-EndpointMonitor-1] DEBUG i.n.channel.ChannelOutboundBuffer - -Dio.netty.threadLocalDirectBufferSize: 65536

19:19:16.399 [Client-EndpointMonitor-1] DEBUG io.netty.util.Recycler - -Dio.netty.recycler.maxCapacity.default: 262144

19:19:16.491 [Client-EndpointMonitor-1] DEBUG io.netty.buffer.ByteBufUtil - -Dio.netty.allocator.type: unpooled

19:19:16.744 [NettyClient-NIO-1] DEBUG io.netty.util.ResourceLeakDetector - -Dio.netty.leakDetectionLevel: simple

19:19:26.552 [Client-EndpointMonitor-1] INFO  c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]

19:19:26.558 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri:

ws://stevenscollege.clould.thingworx.com:80//Thingworx/ws] failed : timeout waiting for websocket handshake to complete

19:19:26.560 [Client-EndpointMonitor-1] INFO  c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: EP_0, id: 0]

[ibanham]

Hi

1st question is the instance that you are connecting to HTTP or HTTPS?

2nd question : are you running the command on the pi from the directory where the jar file resides? I'll assume that you are....

If your ThingWorx instance is HTTP, then:

java -jar temperature-thing-jar-with-dependencies.jar ws://xxxxxx.clould.thingworx.com:80/Thingworx/ws b7b95994-865b-446c-ace7-b9438bdf1d80

Should work.

If it's HTTPS (and using default HTTPS port) then:

java -jar temperature-thing-jar-with-dependencies.jar wss://xxxxxx.clould.thingworx.com:443/Thingworx/ws b7b95994-865b-446c-ace7-b9438bdf1d80

should work.

In both cases I've taken out the ./ before the jar file name (as I'm assuming you're in that directory) and changed // to / before "Thingworx" in the URL. For the HTTPS example I've also added the port to the URL.

In the windows example, it won't like the ./ so take that out and also make the same updates to your URL as above.

Regards

Ian

[rkelly1]

After making the suggested changes and ensuring the instance is http and that I am running the command from the proper directory, the problem still persists. I am at a loss of where I can go from here. Could it be the settings on my schools network? Do the steps that take place on ThingWorx have to be done as an administrator? My results are below, thank you.

pi@raspberrypi ~ $ java -jar temperature-thing-jar-with-dependencies.jar ws://xxxxxxx.cloud.thingworx.com:80/Thingworx/ws b7b95994-865b-446c-ace7-b9438bdf1d80

19:06:55.210 [main] DEBUG c.p.tempthing.BaseEdgeServer - EDGE SERVER STARTING....

19:06:55.746 [main] INFO  c.t.c.c.p.ClientMessageProcessor - Created new ClientMessageProcessor [minPoolSize: 4, maxPoolSize: 10, maxThreadLife: 10000, maxQueueSize: 1000]

19:06:56.124 [main] DEBUG com.ptcmanaged.tempthing.Main - Connecting to ws://stevenscollege.cloud.thingworx.com:80/Thingworx/ws using key b7b95994-865b-446c-ace7-b9438bdf1d80

19:06:56.197 [main] DEBUG i.n.u.i.l.InternalLoggerFactory - Using SLF4J as the default logging framework

19:06:56.229 [main] DEBUG i.n.c.MultithreadEventLoopGroup - -Dio.netty.eventLoopThreads: 8

19:06:56.288 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.nio.ch.DirectBuffer.cleaner(): available

19:06:56.295 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Buffer.address: available

19:06:56.298 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.theUnsafe: available

19:06:56.302 [main] DEBUG i.n.util.internal.PlatformDependent0 - sun.misc.Unsafe.copyMemory: available

19:06:56.305 [main] DEBUG i.n.util.internal.PlatformDependent0 - java.nio.Bits.unaligned: false

19:06:56.341 [main] DEBUG i.n.util.internal.PlatformDependent - UID: 1000

19:06:56.343 [main] DEBUG i.n.util.internal.PlatformDependent - Java version: 8

19:06:56.345 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noUnsafe: false

19:06:56.345 [main] DEBUG i.n.util.internal.PlatformDependent - sun.misc.Unsafe: available

19:06:56.348 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noJavassist: false

19:06:56.354 [main] DEBUG i.n.util.internal.PlatformDependent - Javassist: unavailable

19:06:56.355 [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.

19:06:56.357 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.tmpdir: /tmp (java.io.tmpdir)

19:06:56.358 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.bitMode: 32 (sun.arch.data.model)

19:06:56.358 [main] DEBUG i.n.util.internal.PlatformDependent - -Dio.netty.noPreferDirect: false

19:06:56.467 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.noKeySetOptimization: false

19:06:56.468 [main] DEBUG io.netty.channel.nio.NioEventLoop - -Dio.netty.selectorAutoRebuildThreshold: 512

19:06:56.596 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numHeapArenas: 1

19:06:56.596 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.numDirectArenas: 1

19:06:56.597 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.pageSize: 8192

19:06:56.597 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxOrder: 11

19:06:56.598 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.chunkSize: 16777216

19:06:56.598 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.tinyCacheSize: 512

19:06:56.599 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.smallCacheSize: 256

19:06:56.599 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.normalCacheSize: 64

19:06:56.599 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxCachedBufferCapacity: 32768

19:06:56.600 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheTrimInterval: 8192

19:06:56.600 [main] DEBUG i.n.buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheCleanupInterval: 5000 ms

19:06:56.670 [main] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - Initializing CommunicationEndpoint Connection Monitor...

19:06:56.672 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - checking for disconnected endpoints

19:06:56.673 [Client-EndpointMonitor-1] INFO  c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint not connected [name: EP_0, id: 0]. Attempting [re]connect...

19:06:56.675 [Client-EndpointMonitor-1] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]

19:06:56.675 [Client-EndpointMonitor-1] INFO  c.t.c.c.e.ClientCommunicationEndpoint - Needed to refill connections on client endpoint [id: 0] : [active: 0, max: 1]

19:06:56.882 [Client-EndpointMonitor-1] DEBUG i.n.util.internal.ThreadLocalRandom - -Dio.netty.initialSeedUniquifier: 0xaf4b25c97bc68637

19:06:56.924 [Client-EndpointMonitor-1] DEBUG i.n.channel.ChannelOutboundBuffer - -Dio.netty.threadLocalDirectBufferSize: 65536

19:06:56.930 [Client-EndpointMonitor-1] DEBUG io.netty.util.Recycler - -Dio.netty.recycler.maxCapacity.default: 262144

19:06:57.028 [Client-EndpointMonitor-1] DEBUG io.netty.buffer.ByteBufUtil - -Dio.netty.allocator.type: unpooled

19:06:57.267 [NettyClient-NIO-1] DEBUG io.netty.util.ResourceLeakDetector - -Dio.netty.leakDetectionLevel: simple

19:06:57.509 [NettyClient-NIO-1] DEBUG c.t.c.c.c.n.ThingworxClientConnectionHandler - WebSocket Channel is connected [is open: true]

19:06:57.535 [NettyClient-NIO-1] DEBUG i.n.h.c.h.w.WebSocketClientHandshaker13 - WebSocket version 13 client handshake key: 8v0aaujx8bk1wxBU+Sptwg==, expected response: yvddUO+WYI8WlfnvdoyW6leviwY=

19:07:07.088 [Client-EndpointMonitor-1] INFO  c.t.c.c.c.n.NettyClientConnectionFactory - forcing underlying tcp channel closed [is open: false, is active: false]

19:07:07.093 [Client-EndpointMonitor-1] ERROR c.t.c.c.e.ClientCommunicationEndpoint - Refilling connections on [endpoint 0, uri: ws://stevenscollege.cloud.thingworx.com:80/Thingworx/ws] failed : timeout waiting for websocket handshake to complete

19:07:07.094 [Client-EndpointMonitor-1] INFO  c.t.c.c.e.m.CommunicationEndpointMonitorTask - Endpoint reconnection was unsuccessful [name: EP_0, id: 0]

[ibanham]

Hi

As you put the URL and appKey in the above I tested it... it may be worth creating a new AppKey and removing the existing one.

I can access your server, the user that the AppKey is linked to doesn't have many permissions.... that may not help, but isn't your main problem. I tested with a simulator that I had lying around... it connected but then was giving "Not authorised for service invoke" errors.. which is linked to your user setup.

If the school has a proxy server, that may be causing issues, I'm not sure what the Academic program has in place for configuring for these. I'll ping one of the team and see if they can advise you...

Regards

Ian

[Aanjan]

Ryan, if it times out for websocket handshake to complete, it should be something related to your network. Is there any chance you can try this outside of that specific network?

On a side note, this might be a long shot, you have ws on your uri; switch that to WS and retry, so that it reads - ws://xxxxxxx.cloud.thingworx.com:80/Thingworx/WS

[rkelly1]

Wow changing ws to WS was the solution, thank you.

[Aanjan]

Glad that fixed it! Websockets work in mysterious ways (and case-sensitivity is one of them)

[pnali]

Hi,

i'm facing the same issue with endpoint reconnection failing. i tried replacing ws with WS but still facing the issue. can i get a suggestion to resolve this?

[Aanjan]

Preethi, can you post your entire log as well? If your issue looks to be different, you might want to create a new thread, just so we can track and resolve different questions/ issues individually

[pnali]

I am getting the following result:

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

[Aanjan]

Preethi, 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.

[pnali]

• Hi,

  I followed the set-up for SSL in tomcat through other website and tried executing code but still the result is same. Can you suggest some solution for this issue.

[pfischer1]

Hey,

my problem seems to be a step further ...

The connection works but my mashup wont show me the live data...

there is a single error, when i start the java:

Here is the standard output of the command:

stdout>Temp=22.0*  Humidity=23.0%

Here is the standard error of the command (if any):

07:21:15.358 [main] ERROR c.p.tempthing.BaseEdgeServer - Error Processing Scan Request for [WKAThing]

java.lang.NumberFormatException: For input string: "22.0*"

        at sun.misc.FloatingDecimal.readJavaFormatString(FloatingDecimal.java:2043) ~[na:1.8.0_65]

        at sun.misc.FloatingDecimal.parseDouble(FloatingDecimal.java:110) ~[na:1.8.0_65]

        at java.lang.Double.parseDouble(Double.java:538) ~[na:1.8.0_65]

        at com.ptcmanaged.tempthing.TempAndHumidityThing.parseTemperatureFromString(TempAndHumidityThing.java:151) ~[temperature-thing-jar-with-dependencies.jar:na]

        at com.ptcmanaged.tempthing.TempAndHumidityThing.getTemperature(TempAndHumidityThing.java:117) ~[temperature-thing-jar-with-dependencies.jar:na]

        at com.ptcmanaged.tempthing.TempAndHumidityThing.processScanRequest(TempAndHumidityThing.java:100) ~[temperature-thing-jar-with-dependencies.jar:na]

        at com.ptcmanaged.tempthing.BaseEdgeServer.monitorThings(BaseEdgeServer.java:128) ~[temperature-thing-jar-with-dependencies.jar:na]

        at com.ptcmanaged.tempthing.Main.main(Main.java:26) [temperature-thing-jar-with-dependencies.jar:na]

^C07:21:19.065 [Thread-0] INFO  c.p.tempthing.BaseEdgeServer - Shutting client down...

07:21:19.066 [Thread-0] DEBUG c.t.c.c.e.CommunicationEndpoint - Sending synchronous message, waiting for response [message: BindRequestMessage [requestId: 5, method: UNBINDREQUEST, names: [WKAThing]]]

07:21:19.066 [NettyClient-NIO-1] DEBUG i.n.h.c.h.w.WebSocket08FrameEncoder - Encoding WebSocket Frame opCode=2 length=27

07:21:19.185 [NettyClient-NIO-1] DEBUG i.n.h.c.h.w.WebSocket08FrameDecoder - Decoding WebSocket Frame opCode=2

07:21:19.185 [NettyClient-NIO-1] DEBUG i.n.h.c.h.w.WebSocket08FrameDecoder - Decoding WebSocket Frame length=17

07:21:19.188 [Thread-0] INFO  c.t.communications.client.BaseClient - CommunicationEndpoint Monitor - STOPPING...

07:21:19.188 [NettyClient-NIO-1] DEBUG c.t.c.c.e.DispatchingClientEndpoint - RESPONSE received [endpoint id: 0, duration: 122] ResponseMessage [requestId: 5, endpointId: -1, sessionId: -1, code: STATUS_SUCCESS, multipart: false, packet #: 0, total packets: 0]

07:21:19.188 [Thread-0] INFO  c.t.communications.client.BaseClient - CommunicationEndpoint Monitor - OFF

07:21:19.189 [Thread-0] DEBUG c.t.c.c.e.CommunicationEndpoint - [Endpoint id: 0] closing

07:21:19.189 [Client-EndpointMonitor-1] INFO  c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor was interrupted, system is probably shutting down

07:21:19.190 [Client-EndpointMonitor-1] INFO  c.t.c.c.e.m.CommunicationEndpointMonitorTask - CommunicationEndpoint Monitor - exiting

07:21:19.191 [NettyClient-NIO-1] DEBUG i.n.h.c.h.w.WebSocket08FrameEncoder - Encoding WebSocket Frame opCode=8 length=25

07:21:19.190 [Thread-0] DEBUG c.t.c.c.e.ClientCommunicationEndpoint - Clearing endpoint authentication data [id: 0]

07:21:19.193 [Thread-0] INFO  c.t.c.c.c.n.NettyClientConnectionFactory - NettyClientConnectionFactory - STOPPING

07:21:19.198 [NettyClient-NIO-1] INFO  c.t.c.c.c.n.NettyClientConnection - [websocket id: 0-0] Closing underlying websocket channel

07:21:19.198 [NettyClient-NIO-1] INFO  c.t.c.c.c.n.NettyClientConnection - [websocket id: 0-0] Unregistering NettyClientConnection from ClientEndpoint

07:21:19.198 [NettyClient-NIO-1] DEBUG c.t.c.c.e.CommunicationEndpoint - [Endpoint id: 0, connection id: 0-0] removed Connection

07:21:19.199 [NettyClient-NIO-1] INFO  c.t.c.c.e.CommunicationEndpoint - All Connections are closed [endpoint id: 0]

07:21:19.199 [NettyClient-NIO-1] INFO  c.t.c.client.ConnectedThingClient - Communications Endpoint Closed

07:21:21.406 [Thread-0] INFO  c.t.c.c.c.n.NettyClientConnectionFactory - NettyClientConnectionFactory - OFF

07:21:21.406 [Thread-0] INFO  c.p.tempthing.BaseEdgeServer - Successfully shut down client.

can you help me?

regards, Philipp

[acorreia1]

I'm having the same problem.

Can anyone help with this?

Thank you.