Tellstick binding creating lots of errors

antonh · March 6, 2017, 5:01pm

When switching one light there’s no problem at all, but when using a dummy switch to activate a rule for night mode, switching all lights of except the one in the kids room, I get a lot of errors and have to wait several minutes before all my lights are off. Here is a debug log, could anyone please find anything helpful in it? I’m running the latest snapshot on a Raspberry pi, and the Tellstick is a Basic one. At the end there might be a new ON command for one of the lights, since the rest of the family didn’t like my testing

2017-03-06 17:45:44.550 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event ON for tellstick:switch:1:46:state
2017-03-06 17:45:44.553 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE alexander (46) id: tellstick:switch:1:46
2017-03-06 17:45:44.639 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send ON to TellstickDevice [deviceId=46, name=alexander, status=1, deviceType=DEVICE, data=null] times=0
2017-03-06 17:45:44.687 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Wait for 100 millisec
2017-03-06 17:45:44.731 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event OFF for tellstick:switch:1:48:state
2017-03-06 17:45:44.776 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE sovrumsfonster (48) id: tellstick:switch:1:48
2017-03-06 17:45:44.834 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send ON to TellstickDevice [deviceId=46, name=alexander, status=1, deviceType=DEVICE, data=null] times=1
2017-03-06 17:45:45.020 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event OFF for tellstick:switch:1:47:state
2017-03-06 17:45:45.023 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE koksfonster (47) id: tellstick:switch:1:47
2017-03-06 17:45:45.253 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event OFF for tellstick:switch:1:45:state
2017-03-06 17:45:45.303 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE vardagsrum (45) id: tellstick:switch:1:45
2017-03-06 17:45:47.901 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send OFF to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null] times=0
2017-03-06 17:46:16.440 [ERROR] [andler.core.TelldusCoreBridgeHandler] - Failed to send msg:OFF to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null]
org.tellstick.device.TellstickException: vardagsrum: Could not connect to the Telldus Service
at org.tellstick.device.SwitchableDeviceImpl.off(SwitchableDeviceImpl.java:21)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.turnOff(TelldusCoreDeviceController.java:213)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.sendEvent(TelldusCoreDeviceController.java:171)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.access$0(TelldusCoreDeviceController.java:147)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController$TelldusCoreWorker.run(TelldusCoreDeviceController.java:268)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]
2017-03-06 17:46:16.478 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send OFF to TellstickDevice [deviceId=47, name=koksfonster, status=1, deviceType=DEVICE, data=null] times=0
2017-03-06 17:46:45.024 [ERROR] [andler.core.TelldusCoreBridgeHandler] - Failed to send msg:OFF to TellstickDevice [deviceId=47, name=koksfonster, status=1, deviceType=DEVICE, data=null]
org.tellstick.device.TellstickException: koksfonster: Could not connect to the Telldus Service
at org.tellstick.device.SwitchableDeviceImpl.off(SwitchableDeviceImpl.java:21)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.turnOff(TelldusCoreDeviceController.java:213)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.sendEvent(TelldusCoreDeviceController.java:171)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.access$0(TelldusCoreDeviceController.java:147)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController$TelldusCoreWorker.run(TelldusCoreDeviceController.java:268)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]
2017-03-06 17:46:45.078 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send OFF to TellstickDevice [deviceId=48, name=sovrumsfonster, status=1, deviceType=DEVICE, data=null] times=0
2017-03-06 17:47:13.620 [ERROR] [andler.core.TelldusCoreBridgeHandler] - Failed to send msg:OFF to TellstickDevice [deviceId=48, name=sovrumsfonster, status=1, deviceType=DEVICE, data=null]
org.tellstick.device.TellstickException: sovrumsfonster: Could not connect to the Telldus Service
at org.tellstick.device.SwitchableDeviceImpl.off(SwitchableDeviceImpl.java:21)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.turnOff(TelldusCoreDeviceController.java:213)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.sendEvent(TelldusCoreDeviceController.java:171)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.access$0(TelldusCoreDeviceController.java:147)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController$TelldusCoreWorker.run(TelldusCoreDeviceController.java:268)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]
2017-03-06 17:47:33.571 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event ON for tellstick:switch:1:45:state
2017-03-06 17:47:33.605 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE vardagsrum (45) id: tellstick:switch:1:45
2017-03-06 17:47:33.664 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send ON to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null] times=0
2017-03-06 17:47:58.217 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event ON for tellstick:switch:1:45:state
2017-03-06 17:47:58.251 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE vardagsrum (45) id: tellstick:switch:1:45
2017-03-06 17:48:02.218 [ERROR] [andler.core.TelldusCoreBridgeHandler] - Failed to send msg:ON to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null]
org.tellstick.device.TellstickException: vardagsrum: Could not connect to the Telldus Service
at org.tellstick.device.SwitchableDeviceImpl.on(SwitchableDeviceImpl.java:15)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.turnOn(TelldusCoreDeviceController.java:221)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.sendEvent(TelldusCoreDeviceController.java:169)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.access$0(TelldusCoreDeviceController.java:147)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController$TelldusCoreWorker.run(TelldusCoreDeviceController.java:268)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]
2017-03-06 17:48:02.246 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send ON to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null] times=0
2017-03-06 17:48:29.028 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event ON for tellstick:switch:1:45:state
2017-03-06 17:48:29.066 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE vardagsrum (45) id: tellstick:switch:1:45
2017-03-06 17:48:30.790 [ERROR] [andler.core.TelldusCoreBridgeHandler] - Failed to send msg:ON to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null]
org.tellstick.device.TellstickException: vardagsrum: Could not connect to the Telldus Service
at org.tellstick.device.SwitchableDeviceImpl.on(SwitchableDeviceImpl.java:15)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.turnOn(TelldusCoreDeviceController.java:221)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.sendEvent(TelldusCoreDeviceController.java:169)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.access$0(TelldusCoreDeviceController.java:147)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController$TelldusCoreWorker.run(TelldusCoreDeviceController.java:268)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]
2017-03-06 17:48:30.820 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send ON to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null] times=0
2017-03-06 17:48:39.056 [ERROR] [ellstick.device.TellsticEventHandler] - Failed in TDDeviceEvent
java.lang.RuntimeException: DeviceType not found for -6
at org.tellstick.enums.DeviceType.getDeviceTypeById(DeviceType.java:20)
at org.tellstick.device.TellstickDevice.(TellstickDevice.java:133)
at org.tellstick.device.SwitchableDeviceImpl.(SwitchableDeviceImpl.java:9)
at org.tellstick.device.TellstickDevice.getDevice(TellstickDevice.java:229)
at org.tellstick.device.TellsticEventHandler$1.invoke(TellsticEventHandler.java:102)
at sun.reflect.GeneratedMethodAccessor148.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_121]
at java.lang.reflect.Method.invoke(Method.java:498)[:1.8.0_121]
at com.sun.jna.CallbackReference$DefaultCallbackProxy.invokeCallback(CallbackReference.java:471)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at com.sun.jna.CallbackReference$DefaultCallbackProxy.callback(CallbackReference.java:501)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
2017-03-06 17:48:59.361 [ERROR] [andler.core.TelldusCoreBridgeHandler] - Failed to send msg:ON to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null]
org.tellstick.device.TellstickException: vardagsrum: Could not connect to the Telldus Service
at org.tellstick.device.SwitchableDeviceImpl.on(SwitchableDeviceImpl.java:15)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.turnOn(TelldusCoreDeviceController.java:221)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.sendEvent(TelldusCoreDeviceController.java:169)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.access$0(TelldusCoreDeviceController.java:147)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController$TelldusCoreWorker.run(TelldusCoreDeviceController.java:268)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]
2017-03-06 17:49:13.488 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event ON for tellstick:switch:1:45:state
2017-03-06 17:49:13.505 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE vardagsrum (45) id: tellstick:switch:1:45
2017-03-06 17:49:13.534 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send ON to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null] times=0
2017-03-06 17:49:23.615 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event ON for tellstick:switch:1:48:state
2017-03-06 17:49:23.633 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE sovrumsfonster (48) id: tellstick:switch:1:48
2017-03-06 17:49:30.681 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Handle event ON for tellstick:switch:1:47:state
2017-03-06 17:49:30.699 [DEBUG] [lstick.handler.TelldusDevicesHandler] - Updating state of DEVICE koksfonster (47) id: tellstick:switch:1:47
2017-03-06 17:49:42.076 [ERROR] [andler.core.TelldusCoreBridgeHandler] - Failed to send msg:ON to TellstickDevice [deviceId=45, name=vardagsrum, status=1, deviceType=DEVICE, data=null]
org.tellstick.device.TellstickException: vardagsrum: Could not connect to the Telldus Service
at org.tellstick.device.SwitchableDeviceImpl.on(SwitchableDeviceImpl.java:15)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.turnOn(TelldusCoreDeviceController.java:221)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.sendEvent(TelldusCoreDeviceController.java:169)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.access$0(TelldusCoreDeviceController.java:147)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController$TelldusCoreWorker.run(TelldusCoreDeviceController.java:268)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]
2017-03-06 17:49:42.094 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send ON to TellstickDevice [deviceId=47, name=koksfonster, status=1, deviceType=DEVICE, data=null] times=0
2017-03-06 17:50:10.626 [ERROR] [andler.core.TelldusCoreBridgeHandler] - Failed to send msg:ON to TellstickDevice [deviceId=47, name=koksfonster, status=1, deviceType=DEVICE, data=null]
org.tellstick.device.TellstickException: koksfonster: Could not connect to the Telldus Service
at org.tellstick.device.SwitchableDeviceImpl.on(SwitchableDeviceImpl.java:15)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.turnOn(TelldusCoreDeviceController.java:221)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.sendEvent(TelldusCoreDeviceController.java:169)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController.access$0(TelldusCoreDeviceController.java:147)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at org.openhab.binding.tellstick.handler.core.TelldusCoreDeviceController$TelldusCoreWorker.run(TelldusCoreDeviceController.java:268)[215:org.openhab.binding.tellstick:2.1.0.201702121957]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]
2017-03-06 17:50:10.647 [DEBUG] [andler.core.TelldusCoreBridgeHandler] - Send ON to TellstickDevice [deviceId=48, name=sovrumsfonster, status=1, deviceType=DEVICE, data=null] times=0

jarlebh · March 9, 2017, 10:31am

I don’t see this problem myselfe, what is the hardware you guys run on ?

jarlebh · March 9, 2017, 10:46am

You could try to increase the resendInterval on the bridge, this would lessen the burden on the telldus service.
Maybe try 500, this would the only send one message every 0,5 sec.

antonh · March 10, 2017, 8:04pm

Tried to set resend value to 1000 but that didn’t help. Tried all different variants but finally solved it by changing resend value on each item from 2 to 1.

I’m on a rpi with 512 MB ram, in other words the first rpi, and using Tellstick basic.

Edit: I was to quick in my assumptions, still error massages when sending multiple sendcommands.

jarlebh · March 13, 2017, 8:34am

That is strange, I use a Tellstick Duo on a 2.gn raspberry pi. Are you sure your telldus service and driver is built correctly?

antonh · March 15, 2017, 6:00pm

Well i think so, checking telldus service shows it’s running, and I can switch lights on and off. I see that apt-mark showmanual shows both libtelldus-core-dev, libtelldus-core2 and telldus-core, do you have three as well?

elias_gabrielsson · April 28, 2017, 9:30am

This could be a wild guess but which version of Java do you use?

When you say “Tellstick Basic” do you mean one of the first variants which look like this then?

antonh · May 8, 2017, 6:15pm

Thank’s for your reply @elias_gabrielsson! This is my java version:

[20:12:46] pi@openHABianPi:~$ java -version
java version "1.8.0_131"
Java™ SE Runtime Environment (build 1.8.0_131-b11)
Java HotSpot™ Client VM (build 25.131-b11, mixed mode)

Yes it’s a variant of that one, but an older batch.