Hi,
I have Kodi as Binding and some Xiaomi Bulbs. I have a rule binded with a switch and when the switch goes on/off it’s adjust lighting and resume/pause kodi movie.
Sometimes OpenHab is unresponsive due to Kodi binding. For example something is going wrong with the Kodi command and every other command is executed delayed or not at all.
Logs:
16:40:38.415 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.io.rest.sse.internal.listeners.SseEventSubscriber@1cfdba0’ takes more than 5000ms.
16:40:38.415 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.core.thing.internal.ThingManager@1d31995’ takes more than 5000ms.
16:40:38.417 [WARN ] [ome.core.thing.internal.ThingManager] - Handler for thing yeelight:Wonder:0x0000000003474e00 takes more than 5000ms for processing event
16:40:38.431 [INFO ] [marthome.event.ItemStateChangedEvent] - myKodi_Pause changed from ON to OFF
16:40:39.198 [ERROR] [i.internal.protocol.KodiClientSocket] - Timeout during callMethod(Player.GetActivePlayers, )
16:40:43.466 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.core.thing.internal.ThingManager@1d31995’ takes more than 5000ms.
16:40:43.469 [WARN ] [ome.core.thing.internal.ThingManager] - Handler for thing ‘yeelight:Wonder:0x000000000335d658’ takes more than 5000ms for processing event
16:40:43.472 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.model.rule.runtime.internal.engine.RuleEngineImpl@191356d’ takes more than 5000ms.
16:40:43.481 [INFO ] [yeelight.handler.YeelightHandlerBase] - YeelightColorHandler: command: 10
16:40:43.488 [INFO ] [smarthome.event.ItemCommandEvent ] - Item ‘dimmer3’ received command 10
16:40:48.506 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.core.autoupdate.internal.AutoUpdateBinding@119b51’ takes more than 5000ms.
16:40:48.507 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.core.thing.internal.ThingManager@1d31995’ takes more than 5000ms.
16:40:48.506 [WARN ] [ome.core.thing.internal.ThingManager] - Handler for thing yeelight:Wonder:0x000000000335d658 takes more than 5000ms for processing event
16:40:53.532 [WARN ] [ome.core.thing.internal.ThingManager] - Handler for thing ‘yeelight:Wonder:0x0000000003474e00’ takes more than 5000ms for processing event
16:40:53.532 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.eclipse.smarthome.core.thing.internal.ThingManager@1d31995’ takes more than 5000ms.
16:40:53.532 [WARN ] [ore.internal.events.OSGiEventManager] - Dispatching event to subscriber ‘org.openhab.io.openhabcloud.internal.CloudService@54d8af’ takes more than 5000ms.
and this one:
16:39:39.194 [ERROR] [i.internal.protocol.KodiClientSocket] - Timeout during callMethod(Player.GetItem, {“playerid”:-1,“properties”:[“title”,“album”,“artist”,“director”,“thumbnail”,“file”,“fanart”,“showtitle”,“streamdetails”]})
16:39:39.196 [ERROR] [i.internal.protocol.KodiClientSocket] - Error handling event {“jsonrpc”:“2.0”,“method”:“Player.OnPlay”,“params”:{“data”:{“item”:{“episode”:21,“season”:5,“showtitle”:“Arrow”,“title”:“Honor Thy Fathers”,“type”:“episode”},“player”:{“playerid”:-1,“speed”:1}},“sender”:“xbmc”}} player state change message: null
java.lang.NullPointerException
at org.openhab.binding.kodi.internal.protocol.KodiConnection.requestPlayerUpdate(KodiConnection.java:237)[183:org.openhab.binding.kodi:2.0.0]
at org.openhab.binding.kodi.internal.protocol.KodiConnection.processPlayerStateChanged(KodiConnection.java:370)[183:org.openhab.binding.kodi:2.0.0]
at org.openhab.binding.kodi.internal.protocol.KodiConnection.handleEvent(KodiConnection.java:342)[183:org.openhab.binding.kodi:2.0.0]
at org.openhab.binding.kodi.internal.protocol.KodiClientSocket$KodiWebSocketListener$2.run(KodiClientSocket.java:157)[183:org.openhab.binding.kodi:2.0.0]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)[:1.8.0_121]
at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_121]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)[:1.8.0_121]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)[:1.8.0_121]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_121]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_121]
at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]
Is there any way to fix that or reduce the 5secs time out?