Connect SDK Binding (for LG WebOS TVs)

webos
connectsdk
Tags: #<Tag:0x00007f0148b73540> #<Tag:0x00007f0148b73360>

(Petr Leitermann) #406

Thanks for quick and kind reply. Will try this out right away. I have obviously missed the part about appLauncher channel.

EDIT: Everything works like a charm! Thanks a huge lot once again, Sebastian!
Now I need to appreciate the documentation as well, because it describes everything well from now on :slight_smile:


(Sebastian Prehn) #407

Just note there is a bug in the documentation. ThingID is no longer made up by IP address.
It uses a Unique ID provided by the TV, which remains constant.

So no longer use

lgwebos:WebOSTV:192_168_2_119

but

lgwebos:WebOSTV:3aab9eea-953b-4272-bdbd-f0cd0ecf4a46

if you want to bind to channels in config files.


(Matt Shepherd) #408

Hi, im trying to write a rule for my tv to use a default input when it turns on as every time it turns on it changes from livetv to hdmi.

/* LGTV default input*/
rule "LGTV Default input"
when
Item LG_TV0_Power changed
then
if(LG_TV0_Power.state ==ON)	
sendCommand(LG_TV0_Application, com.webos.app.livetv)

end

I get error code ‘com’ cannot be resolved.

cheers


(Håvard Berland) #409

I guess you have to quote your string.


(Tim Jakobi) #410

Hi,
just test the LGwebOs binding. Very nice! I am using the snapshot oh2.3 and used the items, sitemap and rules according to the documentation “latest version”.
In the log I get an error regarding the items: LG_TV0_ChannelDown and LG_TV0_ChannelUp.

btw, the channels can not be switched relative according to the example rule.

2018-04-14 19:27:55.408 [WARN ] [basic.internal.render.SwitchRenderer] - Cannot determine item type of 'LG_TV0_ChannelDown'
org.eclipse.smarthome.core.items.ItemNotFoundException: Item 'LG_TV0_ChannelDown' could not be found in the item registry
	at org.eclipse.smarthome.core.internal.items.ItemRegistryImpl.getItem(ItemRegistryImpl.java:72) [103:org.eclipse.smarthome.core:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.internal.items.ItemUIRegistryImpl.getItem(ItemUIRegistryImpl.java:780) [151:org.eclipse.smarthome.ui:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.SwitchRenderer.renderWidget(SwitchRenderer.java:58) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.PageRenderer.renderWidget(PageRenderer.java:169) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.PageRenderer.processChildren(PageRenderer.java:135) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.PageRenderer.processChildren(PageRenderer.java:156) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.PageRenderer.processPage(PageRenderer.java:99) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.servlet.WebAppServlet.service(WebAppServlet.java:159) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:848) [86:org.eclipse.jetty.servlet:9.3.21.v20170918]
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:584) [86:org.eclipse.jetty.servlet:9.3.21.v20170918]
	at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:71) [187:org.ops4j.pax.web.pax-web-jetty:6.0.9]
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) [83:org.eclipse.jetty.security:9.3.21.v20170918]
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:284) [187:org.ops4j.pax.web.pax-web-jetty:6.0.9]
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) [86:org.eclipse.jetty.servlet:9.3.21.v20170918]
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80) [187:org.ops4j.pax.web.pax-web-jetty:6.0.9]
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.Server.handle(Server.java:534) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:333) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [78:org.eclipse.jetty.io:9.3.21.v20170918]
	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [78:org.eclipse.jetty.io:9.3.21.v20170918]
	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) [78:org.eclipse.jetty.io:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at java.lang.Thread.run(Thread.java:748) [?:?]
2018-04-14 19:27:55.417 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item 'LG_TV0_ChannelDown' for widget org.eclipse.smarthome.model.sitemap.Switch
2018-04-14 19:27:55.420 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item for widget org.eclipse.smarthome.model.sitemap.Switch
2018-04-14 19:27:55.424 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item 'LG_TV0_ChannelDown' for widget org.eclipse.smarthome.model.sitemap.Switch
2018-04-14 19:27:55.428 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item 'LG_TV0_ChannelDown' for widget org.eclipse.smarthome.model.sitemap.Switch
2018-04-14 19:27:55.431 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item 'LG_TV0_ChannelDown' for widget org.eclipse.smarthome.model.sitemap.Switch
2018-04-14 19:27:55.434 [WARN ] [basic.internal.render.SwitchRenderer] - Cannot determine item type of 'LG_TV0_ChannelUp'
org.eclipse.smarthome.core.items.ItemNotFoundException: Item 'LG_TV0_ChannelUp' could not be found in the item registry
	at org.eclipse.smarthome.core.internal.items.ItemRegistryImpl.getItem(ItemRegistryImpl.java:72) [103:org.eclipse.smarthome.core:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.internal.items.ItemUIRegistryImpl.getItem(ItemUIRegistryImpl.java:780) [151:org.eclipse.smarthome.ui:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.SwitchRenderer.renderWidget(SwitchRenderer.java:58) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.PageRenderer.renderWidget(PageRenderer.java:169) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.PageRenderer.processChildren(PageRenderer.java:135) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.PageRenderer.processChildren(PageRenderer.java:156) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.render.PageRenderer.processPage(PageRenderer.java:99) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.smarthome.ui.basic.internal.servlet.WebAppServlet.service(WebAppServlet.java:159) [198:org.eclipse.smarthome.ui.basic:0.10.0.201804091757]
	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:848) [86:org.eclipse.jetty.servlet:9.3.21.v20170918]
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:584) [86:org.eclipse.jetty.servlet:9.3.21.v20170918]
	at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:71) [187:org.ops4j.pax.web.pax-web-jetty:6.0.9]
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) [83:org.eclipse.jetty.security:9.3.21.v20170918]
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:284) [187:org.ops4j.pax.web.pax-web-jetty:6.0.9]
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) [86:org.eclipse.jetty.servlet:9.3.21.v20170918]
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80) [187:org.ops4j.pax.web.pax-web-jetty:6.0.9]
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.Server.handle(Server.java:534) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:333) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) [85:org.eclipse.jetty.server:9.3.21.v20170918]
	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [78:org.eclipse.jetty.io:9.3.21.v20170918]
	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [78:org.eclipse.jetty.io:9.3.21.v20170918]
	at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) [78:org.eclipse.jetty.io:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) [89:org.eclipse.jetty.util:9.3.21.v20170918]
	at java.lang.Thread.run(Thread.java:748) [?:?]
2018-04-14 19:27:55.441 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item 'LG_TV0_ChannelUp' for widget org.eclipse.smarthome.model.sitemap.Switch
2018-04-14 19:27:55.444 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item for widget org.eclipse.smarthome.model.sitemap.Switch
2018-04-14 19:27:55.447 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item 'LG_TV0_ChannelUp' for widget org.eclipse.smarthome.model.sitemap.Switch
2018-04-14 19:27:55.450 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item 'LG_TV0_ChannelUp' for widget org.eclipse.smarthome.model.sitemap.Switch
2018-04-14 19:27:55.453 [ERROR] [ui.internal.items.ItemUIRegistryImpl] - Cannot retrieve item 'LG_TV0_ChannelUp' for widget org.eclipse.smarthome.model.sitemap.Switch```

(Sebastian Prehn) #411

Thx, yes, these two entries have to be removed from the demo sitemap.


(Tim Jakobi) #412

Thx, for reply. I’ve already removed them, but the relative channel switching does not work. Any help in that issue?


(Sebastian Prehn) #413

all error messages you posted relate to LG_TV0_ChannelUp items, which dont exist in the demo items.
can you pls post error messages regarding your second problem: relative channel switching
we should see LG_TV0_ChannelNo related errors


(Tim Jakobi) #414

Well, I have no error messages in the logs, which is good, but the channels can not been changed. The increment does not work. Volume is working.

See below the log file, where I used the arrow “up” button in the UI…

2018-04-16 11:39:07.684 [vent.ItemStateChangedEvent] - LG_TV0_Volume changed from 0 to 1
2018-04-16 11:39:08.245 [ome.event.ItemCommandEvent] - Item 'LG_TV0_VolDummy' received command 1
2018-04-16 11:39:08.253 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Volume' received command INCREASE
2018-04-16 11:39:08.279 [vent.ItemStateChangedEvent] - LG_TV0_Volume changed from 1 to 2
2018-04-16 11:39:08.549 [ome.event.ItemCommandEvent] - Item 'LG_TV0_VolDummy' received command 1
2018-04-16 11:39:08.560 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Volume' received command INCREASE
2018-04-16 11:39:08.577 [vent.ItemStateChangedEvent] - LG_TV0_Volume changed from 2 to 3
2018-04-16 11:39:08.844 [ome.event.ItemCommandEvent] - Item 'LG_TV0_VolDummy' received command 1
2018-04-16 11:39:08.860 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Volume' received command INCREASE
2018-04-16 11:39:08.879 [vent.ItemStateChangedEvent] - LG_TV0_Volume changed from 3 to 4
2018-04-16 11:39:09.081 [ome.event.ItemCommandEvent] - Item 'LG_TV0_VolDummy' received command 1
2018-04-16 11:39:09.096 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Volume' received command INCREASE
2018-04-16 11:39:09.116 [vent.ItemStateChangedEvent] - LG_TV0_Volume changed from 4 to 5
2018-04-16 11:39:12.733 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 1
2018-04-16 11:39:12.744 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command INCREASE
2018-04-16 11:39:13.161 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 1
2018-04-16 11:39:13.167 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command INCREASE
2018-04-16 11:39:13.408 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 1
2018-04-16 11:39:13.420 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command INCREASE

(Sebastian Prehn) #415

does it work if you send an absolute number? i wonder if the channel is properly set up


(Tim Jakobi) #416

No it does not work. As I have written, the relative volume increase is working, not the channel. Sadly, no error log is written. When I change the channel manually by console, nothing happen.

How can I give more details, when I do not see any errors?


(Sebastian Prehn) #417

Hi,
start and check if your channel is receiving updates as you switch through your channels on your TV.
You should see those changes reflected in Basic UI or PaperUI Control.
You could then use Paper UI Control to set the channel to a specific value, e.g. channel no. 1.

If this does not work, then I suspect the item is not properly bound to the channel “channel”.

Next step to trouble shoot: Enable debug logging for the binding and observer logs under userdata/logs/openhab.log

ssh -p 8101 openhab@localhost  // password is habopen
log:set DEBUG org.openhab.binding.lgwebos

(Tim Jakobi) #418

I have enabled the DEBUG for the binding.

The log shows. different things.
1st. I recognized, that WOL from the basic UI, does not power ON the TV, when the TV was OFF for a longer time. But it is possible to power the TV ON, by help of the FritzBox (router).

(The network is a gigabit LAN with 3 Fritzbox routers. One acts a the DSL WAN Modem, the other works in IP-Client mode (using them as WLAN AP).

switching by basicUI (TV will not be powered up)

2018-04-17 08:59:59.265 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Power' received command ON
==> /var/log/openhab2/openhab.log <==
2018-04-17 08:59:59.266 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255:power,ON) is called
==> /var/log/openhab2/events.log <==
2018-04-17 08:59:59.283 [ome.event.ItemCommandEvent] - Item 'LG_TV0_WOL' received command ON
==> /var/log/openhab2/openhab.log <==
2018-04-17 08:59:59.285 [INFO ] [nhab.binding.wol.internal.WolBinding] - Wake-on-LAN packet sent [broadcastIp=LGwebOSTV.fritz.box, macaddress=785dc84ce151]

Switching by FritzBox (TV starts)

2018-04-17 09:03:36.391 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from OFFLINE: TV is off to ONLINE: Device Ready
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:03:36.633 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 09:03:36.633 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from ONLINE: Device Ready to ONLINE: Connected
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:03:36.647 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 09:03:36.658 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 09:03:36.663 [vent.ItemStateChangedEvent] - LG_TV0_Application changed from  to com.webos.app.hdmi3
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:03:36.664 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 09:03:36.677 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 09:03:36.688 [vent.ItemStateChangedEvent] - LG_TV0_Power changed from OFF to ON
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:03:36.704 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - error: 500 {"errorText":"internal error","returnValue":false,"errorCode":-1000} Application error
2018-04-17 09:03:36.728 [DEBUG] [gwebos.internal.TVControlChannelName] - 500 {"errorText":"internal error","returnValue":false,"errorCode":-1000} Application error

Now, that the TV is ON by FritzBox, I am able to power it OFF and ON by basicUI. See log:

2018-04-17 09:12:26.674 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Power' received command OFF
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:12:26.675 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255:power,OFF) is called
2018-04-17 09:12:26.766 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Capabilities updated: {"modelName":"LG Smart TV","lastConnected":1523948616,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523948616,"friendlyName":"[LG] webOS TV OLED65C7D"} - added: [] - removed: [VolumeControl.Get, VolumeControl.Set, VolumeControl.UpDown, VolumeControl.Subscribe, VolumeControl.Mute.Get, VolumeControl.Mute.Set, VolumeControl.Mute.Subscribe, MediaPlayer.Display.Image, MediaPlayer.Play.Video, MediaPlayer.Play.Audio, MediaPlayer.Close, MediaPlayer.MetaData.Title, MediaPlayer.MetaData.Description, MediaPlayer.MetaData.Thumbnail, MediaPlayer.MetaData.MimeType, MediaPlayer.MediaInfo.Get, MediaPlayer.MediaInfo.Subscribe, TextInputControl.Send, TextInputControl.Enter, TextInputControl.Delete, TextInputControl.Subscribe, MouseControl.Connect, MouseControl.Disconnect, MouseControl.Click, MouseControl.Move, MouseControl.Scroll, KeyControl.Up, KeyControl.Down, KeyControl.Left, KeyControl.Right, KeyControl.OK, KeyControl.Back, KeyControl.Home, KeyControl.KeyCode, MediaPlayer.Display.Image, MediaPlayer.Play.Video, MediaPlayer.Play.Audio, MediaPlayer.Close, MediaPlayer.MetaData.Title, MediaPlayer.MetaData.Description, MediaPlayer.MetaData.Thumbnail, MediaPlayer.MetaData.MimeType, MediaPlayer.MediaInfo.Get, MediaPlayer.MediaInfo.Subscribe, Launcher.App, Launcher.App.Params, Launcher.App.Close, Launcher.App.List, Launcher.Browser, Launcher.Browser.Params, Launcher.Hulu, Launcher.Hulu.Params, Launcher.Netflix, Launcher.Netflix.Params, Launcher.YouTube, Launcher.YouTube.Params, Launcher.AppStore, Launcher.AppStore.Params, Launcher.AppState, Launcher.AppState.Subscribe, Launcher.RunningApp, Launcher.RunningApp.Subscribe, TVControl.Channel.Get, TVControl.Channel.Set, TVControl.Channel.Up, TVControl.Channel.Down, TVControl.Channel.List, TVControl.Channel.Subscribe, TVControl.Program.Get, TVControl.Program.List, TVControl.Program.Subscribe, TVControl.Program.List.Subscribe, TVControl.3D.Get, TVControl.3D.Set, TVControl.3D.Subscribe, ExternalInputControl.Picker.Launch, ExternalInputControl.Picker.Close, ExternalInputControl.List, ExternalInputControl.Set, ToastControl.Show, ToastControl.Show.Clickable.App, ToastControl.Show.Clickable.App.Params, ToastControl.Show.Clickable.URL, PowerControl.Off, WebAppLauncher.Launch, WebAppLauncher.Launch.Params, WebAppLauncher.Message.Send, WebAppLauncher.Message.Receive, WebAppLauncher.Message.Send.JSON, WebAppLauncher.Message.Receive.JSON, WebAppLauncher.Connect, WebAppLauncher.Disconnect, WebAppLauncher.Join, WebAppLauncher.Close, WebAppLauncher.Pin, MediaControl.Play, MediaControl.Pause, MediaControl.Stop, MediaControl.Rewind, MediaControl.FastForward, MediaControl.Seek, MediaControl.Previous, MediaControl.Next, MediaControl.Duration, MediaControl.PlayState, MediaControl.PlayState.Subscribe, MediaControl.Position, MediaPlayer.Subtitle.WebVTT, PlaylistControl.JumpToTrack, PlaylistControl.Next, PlaylistControl.Previous, MediaPlayer.Loop]
2018-04-17 09:12:26.766 [DEBUG] [.internal.discovery.LGWebOSDiscovery] - Device removed: {"modelName":"LG Smart TV","lastConnected":1523948616,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523948616,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 09:12:26.770 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
2018-04-17 09:12:26.776 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523948616,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523948616,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 09:12:26.780 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 09:12:26.795 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 09:12:26.798 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 09:12:26.801 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
2018-04-17 09:12:26.777 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception
java.lang.NullPointerException: null
	at org.openhab.binding.lgwebos.internal.BaseChannelHandler.refreshSubscription(BaseChannelHandler.java:59) ~[?:?]
	at org.openhab.binding.lgwebos.handler.LGWebOSHandler.lambda$4(LGWebOSHandler.java:210) ~[?:?]
	at java.util.HashMap.forEach(HashMap.java:1289) [?:?]
	at java.util.Collections$UnmodifiableMap.forEach(Collections.java:1505) [?:?]
	at org.openhab.binding.lgwebos.handler.LGWebOSHandler.refreshAllChannelSubscriptions(LGWebOSHandler.java:210) [201:org.openhab.binding.lgwebos:2.3.0.201804141026]
	at org.openhab.binding.lgwebos.handler.LGWebOSHandler.onCapabilityUpdated(LGWebOSHandler.java:156) [201:org.openhab.binding.lgwebos:2.3.0.201804141026]
	at com.connectsdk.device.ConnectableDevice$2.run(ConnectableDevice.java:217) [201:org.openhab.binding.lgwebos:2.3.0.201804141026]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:?]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:?]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:?]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
	at java.lang.Thread.run(Thread.java:748) [?:?]
==> /var/log/openhab2/events.log <==
2018-04-17 09:12:26.821 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from ONLINE: Connected to OFFLINE: TV is off
2018-04-17 09:12:26.833 [vent.ItemStateChangedEvent] - LG_TV0_Power changed from ON to OFF
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:12:26.839 [DEBUG] [lgwebos.internal.VolumeControlVolume] - 0 null connection lost
2018-04-17 09:12:26.842 [DEBUG] [lgwebos.internal.LauncherApplication] - 0 null connection lost
2018-04-17 09:12:26.844 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - error: 0 null connection lost
2018-04-17 09:12:26.846 [DEBUG] [g.lgwebos.internal.VolumeControlMute] - 0 null connection lost
2018-04-17 09:12:26.849 [DEBUG] [gwebos.internal.TVControlChannelName] - 0 null connection lost
==> /var/log/openhab2/events.log <==
2018-04-17 09:12:33.023 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Power' received command ON
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:12:33.028 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255:power,ON) is called
==> /var/log/openhab2/events.log <==
2018-04-17 09:12:33.045 [ome.event.ItemCommandEvent] - Item 'LG_TV0_WOL' received command ON
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:12:33.046 [INFO ] [nhab.binding.wol.internal.WolBinding] - Wake-on-LAN packet sent [broadcastIp=LGwebOSTV.fritz.box, macaddress=785dc84ce151]
==> /var/log/openhab2/events.log <==
2018-04-17 09:12:37.319 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from OFFLINE: TV is off to ONLINE: Device Ready
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:12:37.545 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 09:12:37.546 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from ONLINE: Device Ready to ONLINE: Connected
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:12:37.553 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 09:12:37.559 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 09:12:37.565 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 09:12:37.570 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 09:12:37.584 [vent.ItemStateChangedEvent] - LG_TV0_Power changed from OFF to ON
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:12:37.608 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - error: 500 {"errorText":"internal error","returnValue":false,"errorCode":-1000} Application error
2018-04-17 09:12:37.637 [DEBUG] [gwebos.internal.TVControlChannelName] - 500 {"errorText":"internal error","returnValue":false,"errorCode":-1000} Application error
==> /var/log/openhab2/events.log <==
2018-04-17 09:12:49.388 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Application' received command com.webos.app.livetv
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:12:49.395 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255:appLauncher,com.webos.app.livetv) is called
==> /var/log/openhab2/events.log <==
2018-04-17 09:12:49.401 [vent.ItemStateChangedEvent] - LG_TV0_Application changed from com.webos.app.hdmi3 to com.webos.app.livetv
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:12:49.802 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livetv - Live TV
2018-04-17 09:12:49.806 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.discovery - LG Content Store
2018-04-17 09:12:49.809 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.voice - Suche
2018-04-17 09:12:49.812 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.tvguide - PROGRAMMFÜHRER
2018-04-17 09:12:49.815 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.browser - Webbrowser
2018-04-17 09:12:49.818 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.tvuserguide - Benutzeranleitung
2018-04-17 09:12:49.821 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.music - Musik
2018-04-17 09:12:49.824 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.photovideo - Foto und Video
2018-04-17 09:12:49.827 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.igallery - OLED-Galerie
2018-04-17 09:12:49.831 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.recordings - Aufnahmen
2018-04-17 09:12:49.834 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.scheduler - Planer
2018-04-17 09:12:49.837 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.miracast - Screen Share
2018-04-17 09:12:49.840 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.connectionwizard - Geräteanschluss
2018-04-17 09:12:49.844 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.multiview - Multi-view
2018-04-17 09:12:49.846 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.accessibility - Barrierefreiheit
2018-04-17 09:12:49.849 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.notificationcenter - Benachrichtigungen
2018-04-17 09:12:49.852 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.adapp - Werbung
2018-04-17 09:12:49.855 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.brandshop - Brand Shop
2018-04-17 09:12:49.859 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.facebooklogin - Thirdparty Login
2018-04-17 09:12:49.862 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.membership - LG-Mitgliedschaft
2018-04-17 09:12:49.866 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.inputcommon - InputCommon
2018-04-17 09:12:49.868 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.palm.app.firstuse - Erste Verwendung
2018-04-17 09:12:49.872 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.palm.app.settings - Einstellungen
2018-04-17 09:12:49.875 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.channeledit - SENDERMANAGER
2018-04-17 09:12:49.878 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.channelsetting - Sendereinstellung
2018-04-17 09:12:49.881 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.cheeringtv - Cheering Mode
2018-04-17 09:12:49.884 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.container - Enyo (2.6) App Container
2018-04-17 09:12:49.887 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.crb - Connected Red Button
2018-04-17 09:12:49.890 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.customersupport - Kundendienst
2018-04-17 09:12:49.893 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.dvrpopup - DvrPopup
2018-04-17 09:12:49.897 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.eula - User Agreement
2018-04-17 09:12:49.900 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.externalinput.av1 - AV
2018-04-17 09:12:49.903 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.externalinput.av2 - AV-2
2018-04-17 09:12:49.907 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.externalinput.component - Komponente
2018-04-17 09:12:49.910 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.externalinput.scart - AV1
2018-04-17 09:12:49.912 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.factorywin - QML Factorywin
2018-04-17 09:12:49.915 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.favshows - My Content
2018-04-17 09:12:49.918 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.hdmi1 - HDMI-1
2018-04-17 09:12:49.921 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.hdmi2 - HDMI-2
2018-04-17 09:12:49.925 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.hdmi3 - HDMI-3
2018-04-17 09:12:49.928 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.hdmi4 - HDMI-4
2018-04-17 09:12:49.931 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.inputmgr - Input Hub
2018-04-17 09:12:49.935 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.installation - Installation Settings
2018-04-17 09:12:49.938 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livehbbtv - Live HbbTV
2018-04-17 09:12:49.941 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livezoom-inhdmi1 - Live Zoom App
2018-04-17 09:12:49.944 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livezoom-inhdmi2 - Live Zoom App
2018-04-17 09:12:49.947 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livezoom-inhdmi3 - Live Zoom App
2018-04-17 09:12:49.950 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livezoom-inhdmi4 - Live Zoom App
2018-04-17 09:12:49.953 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livezoom-inphotovideo - Live Zoom App
2018-04-17 09:12:49.956 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livezoom-inrecordings - Live Zoom App
2018-04-17 09:12:49.959 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livezoom-insmhl - Live Zoom App
2018-04-17 09:12:49.962 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.livezoom-intv - Live Zoom App
2018-04-17 09:12:49.965 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.magicnum - Magic Number
2018-04-17 09:12:49.969 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.mystarter - My Starter
2018-04-17 09:12:49.975 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.remotesetting - Einstellung der Fernbedienung
2018-04-17 09:12:49.977 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.screensaver - Screen Saver
2018-04-17 09:12:49.979 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.softwareupdate - Software Update
2018-04-17 09:12:49.982 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.store-demo - Demo im Geschäft
2018-04-17 09:12:49.984 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.systemmusic - Music Overlay
2018-04-17 09:12:49.986 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.tips - Tips App
2018-04-17 09:12:49.988 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.tvhotkey - Local Control Panel
2018-04-17 09:12:49.990 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.tvsimpleviewer - Viewer
2018-04-17 09:12:49.992 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.tvtutorial - Adjust camera angle
2018-04-17 09:12:49.995 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo com.webos.app.webapphost - Web App
2018-04-17 09:12:49.997 [DEBUG] [lgwebos.internal.LauncherApplication] - AppInfo youtube.leanback.v4 - YouTube
2018-04-17 09:12:50.035 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - org.openhab.binding.lgwebos.internal.LauncherApplication: com.connectsdk.service.sessions.LaunchSession@1179040.

Increasing volume work. See log

2018-04-17 09:16:29.495 [ome.event.ItemCommandEvent] - Item 'LG_TV0_VolDummy' received command 1
2018-04-17 09:16:29.518 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Volume' received command INCREASE
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:16:29.523 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255:volume,INCREASE) is called
==> /var/log/openhab2/events.log <==
2018-04-17 09:16:29.598 [vent.ItemStateChangedEvent] - LG_TV0_Volume changed from 11 to 12
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:16:29.608 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - org.openhab.binding.lgwebos.internal.VolumeControlVolume: {"returnValue":true}.
==> /var/log/openhab2/events.log <==
2018-04-17 09:17:07.413 [ome.event.ItemCommandEvent] - Item 'LG_TV0_VolDummy' received command 0
2018-04-17 09:17:07.426 [vent.ItemStateChangedEvent] - LG_TV0_VolDummy changed from 1 to 0
2018-04-17 09:17:07.449 [ome.event.ItemCommandEvent] - Item 'LG_TV0_Volume' received command DECREASE
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:17:07.456 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255:volume,DECREASE) is called
==> /var/log/openhab2/events.log <==
2018-04-17 09:17:07.522 [vent.ItemStateChangedEvent] - LG_TV0_Volume changed from 12 to 11
==> /var/log/openhab2/openhab.log <==
2018-04-17 09:17:07.526 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - org.openhab.binding.lgwebos.internal.VolumeControlVolume: {"returnValue":true}.

channel switching.
Switching with basic UI

2018-04-17 09:17:45.491 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 0
2018-04-17 09:17:45.504 [vent.ItemStateChangedEvent] - LG_TV0_ChannelDummy changed from 1 to 0
2018-04-17 09:17:45.511 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command DECREASE
2018-04-17 09:17:48.530 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 1
2018-04-17 09:17:48.540 [vent.ItemStateChangedEvent] - LG_TV0_ChannelDummy changed from 0 to 1
2018-04-17 09:17:48.553 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command INCREASE

Switching by remote controller does not produce any DEBUG entries. It also does not change any items in the basic UI.


(Sebastian Prehn) #419

the last two lines of your second log snippet explain what is going wrong:
The TV reports that it has the capability “Channel_Subscribe”, but the code tries to register to the events it responds with an internal error code. Same for ChannelName. Unfortunately I have no idea how to fix this, but it seems to be related to the TV’s firmware, not the binding code.
Increase and Decrease is silent, which could mean that it is simply not supported.

Could you still try to set an absolute value to the channel, just to see if this reports an error as well.

re wol. Do you have the WOL binding installed? Otherwise it is not configured properly.


(Tim Jakobi) #420

Could you please give me advise how to set an absolute value.
I do not have the TV in paperUI under control and therefore could not use this. But maybe you can give me the command for karaf console, how to set .

The wol binding is installed. Its a bit strange. When the TV is off for several hours, let’s say for the night and I will try to power it next day, then it is not possible. But, if the TV was ON some minutes before or even if it is on, I can power it OFF and ON again by basicUI… See my logs in the post before. I have switched in ON by the FritzBox and it works. Then I am able to power it ON and OFF by the binding.


(Tim Jakobi) #421

TV was off for 6h and now WOL is working:

2018-04-17 21:49:54.400 [vent.ItemStateChangedEvent] - LG_TV0_Power changed from OFF to ON
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:49:54.400 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255:power,ON) is called
2018-04-17 21:49:54.398 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:4c415ec0:power,ON) is called
==> /var/log/openhab2/events.log <==
2018-04-17 21:49:54.412 [ome.event.ItemCommandEvent] - Item 'LG_TV0_WOL' received command ON
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:49:54.414 [INFO ] [nhab.binding.wol.internal.WolBinding] - Wake-on-LAN packet sent [broadcastIp=LGwebOSTV.fritz.box, macaddress=785dc84ce151]
==> /var/log/openhab2/events.log <==
2018-04-17 21:49:58.904 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:4c415ec0' changed from OFFLINE: TV is off to ONLINE: Device Ready
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:49:58.913 [WARN ] [com.connectsdk.core.Log             ] - Connect SDK - already connecting; not trying to connect again: CONNECTING
==> /var/log/openhab2/events.log <==
2018-04-17 21:49:58.918 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from OFFLINE: TV is off to ONLINE: Device Ready
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:49:58.921 [WARN ] [com.connectsdk.core.Log             ] - Connect SDK - already connecting; not trying to connect again: CONNECTING
==> /var/log/openhab2/events.log <==
2018-04-17 21:49:58.942 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:eaad3131' changed from OFFLINE: TV is off to ONLINE: Device Ready
2018-04-17 21:49:59.355 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:4c415ec0' changed from ONLINE: Device Ready to ONLINE: Connected
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:49:59.357 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
2018-04-17 21:49:59.365 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 21:49:59.371 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 21:49:59.377 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 21:49:59.381 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 21:49:59.403 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from ONLINE: Device Ready to ONLINE: Connected
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:49:59.408 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
2018-04-17 21:49:59.414 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 21:49:59.420 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 21:49:59.425 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 21:49:59.435 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 21:49:59.440 [vent.ItemStateChangedEvent] - LG_TV0_Application changed from  to com.webos.app.livetv
2018-04-17 21:49:59.464 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:eaad3131' changed from ONLINE: Device Ready to ONLINE: Connected
2018-04-17 21:50:12.421 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 0
2018-04-17 21:50:12.430 [vent.ItemStateChangedEvent] - LG_TV0_ChannelDummy changed from 1 to 0
2018-04-17 21:50:12.448 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command DECREASE
2018-04-17 21:50:13.119 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 0
2018-04-17 21:50:13.137 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command DECREASE
2018-04-17 21:50:13.797 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 1
2018-04-17 21:50:13.803 [vent.ItemStateChangedEvent] - LG_TV0_ChannelDummy changed from 0 to 1
2018-04-17 21:50:13.816 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command INCREASE
2018-04-17 21:50:14.438 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 1
2018-04-17 21:50:14.455 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command INCREASE
2018-04-17 21:50:14.899 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 0
2018-04-17 21:50:14.906 [vent.ItemStateChangedEvent] - LG_TV0_ChannelDummy changed from 1 to 0
2018-04-17 21:50:14.917 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command DECREASE
2018-04-17 21:50:15.081 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 0
2018-04-17 21:50:15.096 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command DECREASE
2018-04-17 21:50:16.904 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 1
2018-04-17 21:50:16.919 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command INCREASE
2018-04-17 21:50:16.922 [vent.ItemStateChangedEvent] - LG_TV0_ChannelDummy changed from 0 to 1
2018-04-17 21:50:17.156 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelDummy' received command 1
2018-04-17 21:50:17.169 [ome.event.ItemCommandEvent] - Item 'LG_TV0_ChannelNo' received command INCREASE

Firmware of the TV is: 04.70.85

Below is now the log for channel switching by remote control and finally power down by remote control.


2018-04-17 21:54:25.019 [vent.ItemStateChangedEvent] - LG_TV0_ChannelNo changed from 2060 to 2061
2018-04-17 21:54:25.034 [vent.ItemStateChangedEvent] - LG_TV0_Channel changed from Fashion 4K to SAT.1 Gold HD Austria
2018-04-17 21:54:30.628 [vent.ItemStateChangedEvent] - LG_TV0_ChannelNo changed from 2061 to 2060
2018-04-17 21:54:30.652 [vent.ItemStateChangedEvent] - LG_TV0_Channel changed from SAT.1 Gold HD Austria to Fashion 4K
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:35.563 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Capabilities updated: {"modelName":"LG Smart TV","lastConnected":1523994599,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994598,"friendlyName":"[LG] webOS TV OLED65C7D"} - added: [] - removed: [VolumeControl.Get, VolumeControl.Set, VolumeControl.UpDown, VolumeControl.Subscribe, VolumeControl.Mute.Get, VolumeControl.Mute.Set, VolumeControl.Mute.Subscribe, MediaPlayer.Display.Image, MediaPlayer.Play.Video, MediaPlayer.Play.Audio, MediaPlayer.Close, MediaPlayer.MetaData.Title, MediaPlayer.MetaData.Description, MediaPlayer.MetaData.Thumbnail, MediaPlayer.MetaData.MimeType, MediaPlayer.MediaInfo.Get, MediaPlayer.MediaInfo.Subscribe, TextInputControl.Send, TextInputControl.Enter, TextInputControl.Delete, TextInputControl.Subscribe, MouseControl.Connect, MouseControl.Disconnect, MouseControl.Click, MouseControl.Move, MouseControl.Scroll, KeyControl.Up, KeyControl.Down, KeyControl.Left, KeyControl.Right, KeyControl.OK, KeyControl.Back, KeyControl.Home, KeyControl.KeyCode, MediaPlayer.Display.Image, MediaPlayer.Play.Video, MediaPlayer.Play.Audio, MediaPlayer.Close, MediaPlayer.MetaData.Title, MediaPlayer.MetaData.Description, MediaPlayer.MetaData.Thumbnail, MediaPlayer.MetaData.MimeType, MediaPlayer.MediaInfo.Get, MediaPlayer.MediaInfo.Subscribe, Launcher.App, Launcher.App.Params, Launcher.App.Close, Launcher.App.List, Launcher.Browser, Launcher.Browser.Params, Launcher.Hulu, Launcher.Hulu.Params, Launcher.Netflix, Launcher.Netflix.Params, Launcher.YouTube, Launcher.YouTube.Params, Launcher.AppStore, Launcher.AppStore.Params, Launcher.AppState, Launcher.AppState.Subscribe, Launcher.RunningApp, Launcher.RunningApp.Subscribe, TVControl.Channel.Get, TVControl.Channel.Set, TVControl.Channel.Up, TVControl.Channel.Down, TVControl.Channel.List, TVControl.Channel.Subscribe, TVControl.Program.Get, TVControl.Program.List, TVControl.Program.Subscribe, TVControl.Program.List.Subscribe, TVControl.3D.Get, TVControl.3D.Set, TVControl.3D.Subscribe, ExternalInputControl.Picker.Launch, ExternalInputControl.Picker.Close, ExternalInputControl.List, ExternalInputControl.Set, ToastControl.Show, ToastControl.Show.Clickable.App, ToastControl.Show.Clickable.App.Params, ToastControl.Show.Clickable.URL, PowerControl.Off, WebAppLauncher.Launch, WebAppLauncher.Launch.Params, WebAppLauncher.Message.Send, WebAppLauncher.Message.Receive, WebAppLauncher.Message.Send.JSON, WebAppLauncher.Message.Receive.JSON, WebAppLauncher.Connect, WebAppLauncher.Disconnect, WebAppLauncher.Join, WebAppLauncher.Close, WebAppLauncher.Pin, MediaControl.Play, MediaControl.Pause, MediaControl.Stop, MediaControl.Rewind, MediaControl.FastForward, MediaControl.Seek, MediaControl.Previous, MediaControl.Next, MediaControl.Duration, MediaControl.PlayState, MediaControl.PlayState.Subscribe, MediaControl.Position, MediaPlayer.Subtitle.WebVTT, PlaylistControl.JumpToTrack, PlaylistControl.Next, PlaylistControl.Previous, MediaPlayer.Loop]
2018-04-17 21:54:35.560 [DEBUG] [.internal.discovery.LGWebOSDiscovery] - Device removed: {"modelName":"LG Smart TV","lastConnected":1523994599,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994598,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 21:54:35.578 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
2018-04-17 21:54:35.580 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523994599,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994598,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 21:54:35.596 [DEBUG] [lgwebos.internal.VolumeControlVolume] - 0 null connection lost
2018-04-17 21:54:35.597 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 21:54:35.597 [DEBUG] [lgwebos.internal.LauncherApplication] - 0 null connection lost
2018-04-17 21:54:35.598 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - error: 0 null connection lost
2018-04-17 21:54:35.598 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 21:54:35.599 [DEBUG] [g.lgwebos.internal.VolumeControlMute] - 0 null connection lost
2018-04-17 21:54:35.601 [DEBUG] [gwebos.internal.TVControlChannelName] - 0 null connection lost
2018-04-17 21:54:35.602 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 21:54:35.603 [DEBUG] [lgwebos.internal.LauncherApplication] - 0 null connection lost
2018-04-17 21:54:35.603 [DEBUG] [lgwebos.internal.VolumeControlVolume] - 0 null connection lost
2018-04-17 21:54:35.604 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
2018-04-17 21:54:35.605 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - error: 0 null connection lost
2018-04-17 21:54:35.608 [DEBUG] [g.lgwebos.internal.VolumeControlMute] - 0 null connection lost
2018-04-17 21:54:35.609 [DEBUG] [gwebos.internal.TVControlChannelName] - 0 null connection lost
==> /var/log/openhab2/events.log <==
2018-04-17 21:54:35.626 [vent.ItemStateChangedEvent] - LG_TV0_Power changed from ON to OFF
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:35.606 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception
java.lang.NullPointerException: null
	at org.openhab.binding.lgwebos.internal.BaseChannelHandler.refreshSubscription(BaseChannelHandler.java:59) ~[?:?]
	at org.openhab.binding.lgwebos.handler.LGWebOSHandler.lambda$4(LGWebOSHandler.java:210) ~[?:?]
	at java.util.HashMap.forEach(HashMap.java:1289) [?:?]
	at java.util.Collections$UnmodifiableMap.forEach(Collections.java:1505) [?:?]
	at org.openhab.binding.lgwebos.handler.LGWebOSHandler.refreshAllChannelSubscriptions(LGWebOSHandler.java:210) [201:org.openhab.binding.lgwebos:2.3.0.201804141026]
	at org.openhab.binding.lgwebos.handler.LGWebOSHandler.onCapabilityUpdated(LGWebOSHandler.java:156) [201:org.openhab.binding.lgwebos:2.3.0.201804141026]
	at com.connectsdk.device.ConnectableDevice$2.run(ConnectableDevice.java:217) [201:org.openhab.binding.lgwebos:2.3.0.201804141026]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:?]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:?]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:?]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
	at java.lang.Thread.run(Thread.java:748) [?:?]
2018-04-17 21:54:35.622 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523994599,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994598,"friendlyName":"[LG] webOS TV OLED65C7D"}
==> /var/log/openhab2/events.log <==
2018-04-17 21:54:35.631 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:4c415ec0' changed from ONLINE: Connected to OFFLINE: TV is off
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:35.635 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
2018-04-17 21:54:35.642 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 21:54:35.645 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 21:54:35.650 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 21:54:35.656 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
2018-04-17 21:54:35.668 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523994599,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994598,"friendlyName":"[LG] webOS TV OLED65C7D"}
==> /var/log/openhab2/events.log <==
2018-04-17 21:54:35.674 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from ONLINE: Connected to OFFLINE: TV is off
2018-04-17 21:54:35.685 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:eaad3131' changed from ONLINE: Connected to OFFLINE: TV is off
2018-04-17 21:54:40.317 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:4c415ec0' changed from OFFLINE: TV is off to ONLINE: Device Ready
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:40.316 [WARN ] [com.connectsdk.core.Log             ] - Connect SDK - already connecting; not trying to connect again: CONNECTING
==> /var/log/openhab2/events.log <==
2018-04-17 21:54:40.324 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from OFFLINE: TV is off to ONLINE: Device Ready
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:40.338 [WARN ] [com.connectsdk.core.Log             ] - Connect SDK - already connecting; not trying to connect again: CONNECTING
==> /var/log/openhab2/events.log <==
2018-04-17 21:54:40.347 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:eaad3131' changed from OFFLINE: TV is off to ONLINE: Device Ready
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:40.516 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 21:54:40.523 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:4c415ec0' changed from ONLINE: Device Ready to ONLINE: Connected
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:40.524 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 21:54:40.529 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 21:54:40.535 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 21:54:40.542 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 21:54:40.555 [vent.ItemStateChangedEvent] - LG_TV0_Application changed from com.webos.app.livetv to 
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:40.568 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
2018-04-17 21:54:40.576 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - error: 500 {"errorText":"internal error","returnValue":false,"errorCode":-1000} Application error
2018-04-17 21:54:40.578 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 21:54:40.581 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from ONLINE: Device Ready to ONLINE: Connected
2018-04-17 21:54:40.588 [vent.ItemStateChangedEvent] - LG_TV0_Power changed from OFF to ON
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:40.594 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 21:54:40.598 [DEBUG] [gwebos.internal.TVControlChannelName] - 500 {"errorText":"internal error","returnValue":false,"errorCode":-1000} Application error
2018-04-17 21:54:40.609 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - error: 500 {"errorText":"internal error","returnValue":false,"errorCode":-1000} Application error
2018-04-17 21:54:40.608 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 21:54:40.621 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Subscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 21:54:40.653 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:eaad3131' changed from ONLINE: Device Ready to ONLINE: Connected
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:54:40.668 [DEBUG] [gwebos.internal.TVControlChannelName] - 500 {"errorText":"internal error","returnValue":false,"errorCode":-1000} Application error
2018-04-17 21:55:15.895 [DEBUG] [.internal.discovery.LGWebOSDiscovery] - Device removed: {"modelName":"LG Smart TV","lastConnected":1523994880,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994880,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 21:55:15.898 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523994880,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994880,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 21:55:15.901 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
2018-04-17 21:55:15.917 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 21:55:15.916 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Capabilities updated: {"modelName":"LG Smart TV","lastConnected":1523994880,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994880,"friendlyName":"[LG] webOS TV OLED65C7D"} - added: [] - removed: [VolumeControl.Get, VolumeControl.Set, VolumeControl.UpDown, VolumeControl.Subscribe, VolumeControl.Mute.Get, VolumeControl.Mute.Set, VolumeControl.Mute.Subscribe, MediaPlayer.Display.Image, MediaPlayer.Play.Video, MediaPlayer.Play.Audio, MediaPlayer.Close, MediaPlayer.MetaData.Title, MediaPlayer.MetaData.Description, MediaPlayer.MetaData.Thumbnail, MediaPlayer.MetaData.MimeType, MediaPlayer.MediaInfo.Get, MediaPlayer.MediaInfo.Subscribe, TextInputControl.Send, TextInputControl.Enter, TextInputControl.Delete, TextInputControl.Subscribe, MouseControl.Connect, MouseControl.Disconnect, MouseControl.Click, MouseControl.Move, MouseControl.Scroll, KeyControl.Up, KeyControl.Down, KeyControl.Left, KeyControl.Right, KeyControl.OK, KeyControl.Back, KeyControl.Home, KeyControl.KeyCode, MediaPlayer.Display.Image, MediaPlayer.Play.Video, MediaPlayer.Play.Audio, MediaPlayer.Close, MediaPlayer.MetaData.Title, MediaPlayer.MetaData.Description, MediaPlayer.MetaData.Thumbnail, MediaPlayer.MetaData.MimeType, MediaPlayer.MediaInfo.Get, MediaPlayer.MediaInfo.Subscribe, Launcher.App, Launcher.App.Params, Launcher.App.Close, Launcher.App.List, Launcher.Browser, Launcher.Browser.Params, Launcher.Hulu, Launcher.Hulu.Params, Launcher.Netflix, Launcher.Netflix.Params, Launcher.YouTube, Launcher.YouTube.Params, Launcher.AppStore, Launcher.AppStore.Params, Launcher.AppState, Launcher.AppState.Subscribe, Launcher.RunningApp, Launcher.RunningApp.Subscribe, TVControl.Channel.Get, TVControl.Channel.Set, TVControl.Channel.Up, TVControl.Channel.Down, TVControl.Channel.List, TVControl.Channel.Subscribe, TVControl.Program.Get, TVControl.Program.List, TVControl.Program.Subscribe, TVControl.Program.List.Subscribe, TVControl.3D.Get, TVControl.3D.Set, TVControl.3D.Subscribe, ExternalInputControl.Picker.Launch, ExternalInputControl.Picker.Close, ExternalInputControl.List, ExternalInputControl.Set, ToastControl.Show, ToastControl.Show.Clickable.App, ToastControl.Show.Clickable.App.Params, ToastControl.Show.Clickable.URL, PowerControl.Off, WebAppLauncher.Launch, WebAppLauncher.Launch.Params, WebAppLauncher.Message.Send, WebAppLauncher.Message.Receive, WebAppLauncher.Message.Send.JSON, WebAppLauncher.Message.Receive.JSON, WebAppLauncher.Connect, WebAppLauncher.Disconnect, WebAppLauncher.Join, WebAppLauncher.Close, WebAppLauncher.Pin, MediaControl.Play, MediaControl.Pause, MediaControl.Stop, MediaControl.Rewind, MediaControl.FastForward, MediaControl.Seek, MediaControl.Previous, MediaControl.Next, MediaControl.Duration, MediaControl.PlayState, MediaControl.PlayState.Subscribe, MediaControl.Position, MediaPlayer.Subtitle.WebVTT, PlaylistControl.JumpToTrack, PlaylistControl.Next, PlaylistControl.Previous, MediaPlayer.Loop]
2018-04-17 21:55:15.924 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 21:55:15.924 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception
java.lang.NullPointerException: null
	at org.openhab.binding.lgwebos.internal.BaseChannelHandler.refreshSubscription(BaseChannelHandler.java:59) ~[?:?]
	at org.openhab.binding.lgwebos.handler.LGWebOSHandler.lambda$4(LGWebOSHandler.java:210) ~[?:?]
	at java.util.HashMap.forEach(HashMap.java:1289) [?:?]
	at java.util.Collections$UnmodifiableMap.forEach(Collections.java:1505) [?:?]
	at org.openhab.binding.lgwebos.handler.LGWebOSHandler.refreshAllChannelSubscriptions(LGWebOSHandler.java:210) [201:org.openhab.binding.lgwebos:2.3.0.201804141026]
	at org.openhab.binding.lgwebos.handler.LGWebOSHandler.onCapabilityUpdated(LGWebOSHandler.java:156) [201:org.openhab.binding.lgwebos:2.3.0.201804141026]
	at com.connectsdk.device.ConnectableDevice$2.run(ConnectableDevice.java:217) [201:org.openhab.binding.lgwebos:2.3.0.201804141026]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:?]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:?]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:?]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
	at java.lang.Thread.run(Thread.java:748) [?:?]
2018-04-17 21:55:15.940 [DEBUG] [lgwebos.internal.VolumeControlVolume] - 0 null connection lost
2018-04-17 21:55:15.944 [DEBUG] [lgwebos.internal.LauncherApplication] - 0 null connection lost
2018-04-17 21:55:15.945 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - error: 0 null connection lost
2018-04-17 21:55:15.946 [DEBUG] [g.lgwebos.internal.VolumeControlMute] - 0 null connection lost
2018-04-17 21:55:15.947 [DEBUG] [gwebos.internal.TVControlChannelName] - 0 null connection lost
2018-04-17 21:55:15.948 [DEBUG] [lgwebos.internal.VolumeControlVolume] - 0 null connection lost
2018-04-17 21:55:15.949 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - error: 0 null connection lost
2018-04-17 21:55:15.936 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 21:55:15.939 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523994880,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994880,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 21:55:15.959 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
2018-04-17 21:55:15.951 [DEBUG] [lgwebos.internal.LauncherApplication] - 0 null connection lost
2018-04-17 21:55:15.968 [DEBUG] [g.lgwebos.internal.VolumeControlMute] - 0 null connection lost
==> /var/log/openhab2/events.log <==
2018-04-17 21:55:15.972 [vent.ItemStateChangedEvent] - LG_TV0_Power changed from ON to OFF
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:55:15.972 [DEBUG] [gwebos.internal.TVControlChannelName] - 0 null connection lost
==> /var/log/openhab2/events.log <==
2018-04-17 21:55:15.984 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:4c415ec0' changed from ONLINE: Connected to OFFLINE: TV is off
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:55:15.985 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523994880,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994880,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 21:55:15.986 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523994880,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994880,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 21:55:15.991 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlVolume on IP: 192.168.0.56
2018-04-17 21:55:15.994 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.LauncherApplication on IP: 192.168.0.56
2018-04-17 21:55:15.996 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannel on IP: 192.168.0.56
2018-04-17 21:55:16.002 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.VolumeControlMute on IP: 192.168.0.56
2018-04-17 21:55:16.006 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - Unsubscribed org.openhab.binding.lgwebos.internal.TVControlChannelName on IP: 192.168.0.56
==> /var/log/openhab2/events.log <==
2018-04-17 21:55:16.024 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255' changed from ONLINE: Connected to OFFLINE: TV is off
==> /var/log/openhab2/openhab.log <==
2018-04-17 21:55:16.025 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523994880,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994880,"friendlyName":"[LG] webOS TV OLED65C7D"}
2018-04-17 21:55:16.025 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - Device disconnected: {"modelName":"LG Smart TV","lastConnected":1523994880,"lastKnownIPAddress":"192.168.0.56","modelNumber":"OLED65C7D-Z","id":"71c08b40-6fbc-4329-98c0-add23cef4255","services":{},"lastDetection":1523994880,"friendlyName":"[LG] webOS TV OLED65C7D"}
==> /var/log/openhab2/events.log <==
2018-04-17 21:55:16.034 [hingStatusInfoChangedEvent] - 'lgwebos:WebOSTV:eaad3131' changed from ONLINE: Connected to OFFLINE: TV is off

(Sebastian Prehn) #422

Command on Karaf console is:

smarthome:send LG_TV0_ChannelNo 1

Check out:
https://docs.openhab.org/administration/runtime.html#items


(Tim Jakobi) #423

Thanks,
Channel switching works by manually set with karaf console.
But it takes about more than 15sec to switch, because the log shows several thousands lines of entries in the openhap.log

Switching to channel 4:

smarthome:send LG_TV0_ChannelNo 4

openhab.log

2018-04-17 22:47:14.756 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:4c415ec0:channel,4) is called
2018-04-17 22:47:14.761 [DEBUG] [nding.lgwebos.handler.LGWebOSHandler] - handleCommand(lgwebos:WebOSTV:71c08b40-6fbc-4329-98c0-add23cef4255:channel,4) is called
2018-04-17 22:47:29.259 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1 - Das Erste HD
2018-04-17 22:47:29.261 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 2 - ZDF HD
2018-04-17 22:47:29.263 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 3 - RTL HD
2018-04-17 22:47:29.264 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 4 - SAT.1 HD
2018-04-17 22:47:29.265 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 5 - ProSieben HD
2018-04-17 22:47:29.266 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 6 - VOX HD
2018-04-17 22:47:29.268 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 7 - kabel eins HD
2018-04-17 22:47:29.269 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 8 - RTLII HD
...

comment:  first ten lines of logentries following by severals thousand further entries of all TV and Radio channels same listing and ends with:

2018-04-17 22:47:36.857 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1660 - RADIO SABA
2018-04-17 22:47:36.858 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1661 - RADIO 01 WORLD SERVICE
2018-04-17 22:47:36.859 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1662 - RADIO 02 WORLD SERVICE
2018-04-17 22:47:36.860 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1663 - RADIO 04 WORLD SERVICE
2018-04-17 22:47:36.861 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1664 - RADIO 03 WORLD SERVICE
2018-04-17 22:47:36.862 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1665 - RADIO 05 WORLD SERVICE
2018-04-17 22:47:36.863 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1666 - RADIO 06 WORLD SERVICE
2018-04-17 22:47:36.864 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1667 - RADIO 07 WORLD SERVICE
2018-04-17 22:47:36.865 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1668 - RADIO VARZESH
2018-04-17 22:47:36.866 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1669 - RADIO GOFTEGOO
2018-04-17 22:47:36.867 [DEBUG] [ng.lgwebos.internal.TVControlChannel] - Channel 1670 - RADIO TELAVAT
2018-04-17 22:47:36.893 [DEBUG] [.lgwebos.internal.BaseChannelHandler] - org.openhab.binding.lgwebos.internal.TVControlChannel: {"returnValue":true}.

(Bruce) #424

Hi, I hope someone can help me out.

I’d like to have a separate switch for every HDMI (1,2 and 3). When HDMI 1 switch turns on, my TV should go to HDMI 1.

What i have for now is
.items:
Switch TV_HDMI1 “HDMI 1”
String TV_Application “Application [%s]” { channel=“lgwebos:WebOSTV:xxxxxx-xxxx-xxxx-xxxx-xxxxxxxx:appLauncher” }

.sitemap:
Switch item=TV_HDMI1

.rules:
rule “Switch to HDMI 1”
when
Item TV_HDMI1 received command ON
then
sendCommand(TV_Application, “com.webos.app.hdmi1”)
end


(Sebastian Prehn) #425

In principle this should work. to debug. do you see the current application in appLauncher channel. and do your rules trigger?