Sony Devices Binding

alpol · March 30, 2021, 5:17pm

Hello!
Cannot make binding to work.
Fresh OH3 with zwave things and items, few rules.
openHAB 3.1.0.M2
added Sony binding.jar placed here on Mar 14 fto the folder, when OH3 was stopped, started OH3 - nothing.
Broadlink.jar is OK, for example.
Then I jumped to the first post Sep 2016, installed everything, OH3 stopped to work…
Then I uninstalled everything from Sep 2016 post.
Removed Sony.jar, removed Sony folder in /var/lib/openhab.
Now OH3 is working BUT in Things inbox I seeing Sony binding, but it uninstalled. (Also I seeing deleted Chromecast binding…).
Sooo, any help, how to install Sony binding for OH3 and do not break my hub ?
Also how to delete binding info if it is not in adding folder?
Fast reading of posts from Nov 2020 didn’t helped.

andan · April 2, 2021, 7:54pm

@alpol Have you followed each step from the ‘How to uninstall/install new version’ section of the first posting? In addition you might need to install additional dependencies for the Sony binding:

feature:install openhab-transformation-map
feature:install openhab-transport-upnp
feature:install openhab-transport-serial

Then placing the jar from Release 3.1.0-alpha.andan-SNAPSHOT · andan67/openhab-addons-sony (github.com) into the addons folder and restarting OH3 should automatically discover the scalar service/thing.

If this doesn’t work please provide log information showing the problem/error messages.

andirs · April 3, 2021, 5:46am

Are the scalar preset channels (for example #ps_channel-dvbt) for changing the tv stations working for anyone? Here at my setup (OH2 and @tmrobert8 's latest binding version) the channels do not get scanned as written in the docs and therefore are not working.

Though I can change the channels doing it the hard way by setting the #cn_parenturi and #cn_childcount and sending ‘select’ to #cn_cmd. So i guess it is not a problem on my TV side…

Thanks in advance

jon.hazan · April 3, 2021, 8:50am

Has anyone had any luck with the UBP-X800M2 BluRay player? I’m on OH3 and using the 3.1.0 snapshot of the addon. The binding discovers only the DIAL service for the device, but doesn’t discover any channels and the device doesn’t give an access code. Log file here: sony.log (44.6 KB)

The binding works well with my other Sony devices.

Any help would be much appreciated, thanks!

andan · April 3, 2021, 9:17pm

There seems to be a bug in the latest OH2 version with the impact that the first 150 channels are skipped when scanning for the preset channel. Thus if the number of dvbt channels is less than 150, the preset channel is empty. This apparent bug (not yet confirmed by @tmrobert8) is fixed in my OH3 release which in addition allows filtering and sorting the preset channels via a configuration file.

andan · April 3, 2021, 10:04pm

Did you migrate from OH2 and - if yes - were more services discivered for your player with this version?

The provided log just confirms that no ircc and scalar services are discovered, but doesn’t show any obvious error.

You could check the result of [ip address]:52323/dmr.xml for any notion of other services than dial.
It might also worth checking the player settings.

Unfortunatley I can only make some guesses concerning the cause of the problem. Your question would be best answered by the author of the binding @tmrobert8 who I think owns a X800 model (the predecessor?).

jon.hazan · April 4, 2021, 7:44am

It’s a brand new install of OH3 as I decided to start from scratch rather than migrating from OH2. And it’s also a new player, so I never used it with OH2. I can’t find any obvious settings on the player and there’s no mention of IRCC or scalar in dmr.xml (output below), so I suspect this player simply doesn’t expose these capabilities.

<root xmlns="urn:schemas-upnp-org:device-1-0" xmlns:pnpx="http://schemas.microsoft.com/windows/pnpx/2005/11" xmlns:df="http://schemas.microsoft.com/windows/2008/09/devicefoundation" xmlns:av="urn:schemas-sony-com:av">
<script> try { Object.defineProperty(navigator, "globalPrivacyControl", { value: false, configurable: false, writable: false }); document.currentScript.parentElement.removeChild(document.currentScript); } catch(e) {}; </script>
<specVersion>
<major>1</major>
<minor>0</minor>
</specVersion>
<device>
<deviceType>urn:schemas-upnp-org:device:MediaRenderer:1</deviceType>
<friendlyName>UBP-X800M2</friendlyName>
<manufacturer>Sony Corporation</manufacturer>
<manufacturerURL>http://www.sony.net/</manufacturerURL>
<modelName>UBP-X800M2</modelName>
<modelNumber>BDP-2019</modelNumber>
<UDN>uuid:00000000-0000-1010-8000-143fa608f62d</UDN>
<dlna:X_DLNADOC xmlns:dlna="urn:schemas-dlna-org:device-1-0">DMR-1.50</dlna:X_DLNADOC>
<dlna:X_DLNACAP xmlns:dlna="urn:schemas-dlna-org:device-1-0">playcontainer-0-0</dlna:X_DLNACAP>
<iconList>
<icon>
<mimetype>image/jpeg</mimetype>
<width>120</width>
<height>120</height>
<depth>24</depth>
<url>/bdp_cx_Lily_device_icon_large.jpg</url>
</icon>
<icon>
<mimetype>image/png</mimetype>
<width>120</width>
<height>120</height>
<depth>24</depth>
<url>/bdp_cx_Lily_device_icon_large.png</url>
</icon>
<icon>
<mimetype>image/jpeg</mimetype>
<width>48</width>
<height>48</height>
<depth>24</depth>
<url>/bdp_cx_Lily_device_icon_small.jpg</url>
</icon>
<icon>
<mimetype>image/png</mimetype>
<width>48</width>
<height>48</height>
<depth>24</depth>
<url>/bdp_cx_Lily_device_icon_small.png</url>
</icon>
</iconList>
<serviceList>
<service>
<serviceType>urn:schemas-upnp-org:service:RenderingControl:1</serviceType>
<serviceId>urn:upnp-org:serviceId:RenderingControl</serviceId>
<SCPDURL>/RenderingControlBdpSCPD.xml</SCPDURL>
<controlURL>/upnp/control/RenderingControl</controlURL>
<eventSubURL>/upnp/event/RenderingControl</eventSubURL>
</service>
<service>
<serviceType>urn:schemas-upnp-org:service:ConnectionManager:1</serviceType>
<serviceId>urn:upnp-org:serviceId:ConnectionManager</serviceId>
<SCPDURL>/ConnectionManagerSCPD.xml</SCPDURL>
<controlURL>/upnp/control/ConnectionManager</controlURL>
<eventSubURL>/upnp/event/ConnectionManager</eventSubURL>
</service>
<service>
<serviceType>urn:schemas-upnp-org:service:AVTransport:1</serviceType>
<serviceId>urn:upnp-org:serviceId:AVTransport</serviceId>
<SCPDURL>/AVTransportBdpSCPD.xml</SCPDURL>
<controlURL>/upnp/control/AVTransport</controlURL>
<eventSubURL>/upnp/event/AVTransport</eventSubURL>
</service>
</serviceList>
<av:X_StandardDMR>1.1</av:X_StandardDMR>
<microsoft:magicPacketWakeSupported xmlns:microsoft="urn:schemas-microsoft-com:WMPNSS-1-0"> 1 </microsoft:magicPacketWakeSupported>
</device>
</root>

andan · April 5, 2021, 8:42am

In the meantime I’ve found out that there seems to be a general issue with this player and network remote control. See e.g. OFFICIAL Sony UBP-X800M2 Owners Thread (No Price Talk) | Page 32 | AVS Forum. I’d suggest to try HMDI CEC as alternative.

jon.hazan · April 5, 2021, 4:28pm

Thanks for the update, yes I’ve seen others complaining about this too. I shall leave it for now!

buch · April 12, 2021, 6:46pm

On my OH3.0.1 use org.openhab.binding.sony-3.1.0-alpha.andan-SNAPSHOT.jar
After my BRAVIA KDL-26EX553 is discovered (sony:ircc:5453EDC2BE0A) goes into disabled state

In log files:

2021-04-12 20:41:52.071 [INFO ] [openhab.event.InboxAddedEvent       ] - Discovery Result with UID 'sony:ircc:5453EDC2BE0A' has been added.
2021-04-12 20:42:02.478 [INFO ] [openhab.event.InboxRemovedEvent     ] - Discovery Result with UID 'sony:ircc:5453EDC2BE0A' has been removed.
2021-04-12 20:42:02.486 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'sony:ircc:5453EDC2BE0A' changed from UNINITIALIZED to UNINITIALIZED (DISABLED)
2021-04-12 20:42:38.336 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'sony:ircc:5453EDC2BE0A' changed from UNINITIALIZED (DISABLED) to INITIALIZING
2021-04-12 20:42:38.342 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'sony:ircc:5453EDC2BE0A' changed from INITIALIZING to UNKNOWN: Initializing ...
2021-04-12 20:42:38.595 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'sony:ircc:5453EDC2BE0A' changed from UNKNOWN: Initializing ... to OFFLINE (CONFIGURATION_ERROR): 404 - <html><head><title>not found</title></head><body>not found</body></html>
2021-04-12 20:42:46.805 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'sony:ircc:5453EDC2BE0A' changed from OFFLINE (CONFIGURATION_ERROR): 404 - <html><head><title>not found</title></head><body>not found</body></html> to UNINITIALIZED
2021-04-12 20:42:46.831 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'sony:ircc:5453EDC2BE0A' changed from UNINITIALIZED to UNINITIALIZED (DISABLED)

dmr.xml

<root xmlns="urn:schemas-upnp-org:device-1-0" xmlns:pnpx="http://schemas.microsoft.com/windows/pnpx/2005/11" xmlns:df="http://schemas.microsoft.com/windows/2008/09/devicefoundation">
<specVersion>
<major>1</major>
<minor>0</minor>
</specVersion>
<device>
<deviceType>urn:schemas-upnp-org:device:MediaRenderer:1</deviceType>
<friendlyName>BRAVIA KDL-26EX553</friendlyName>
<manufacturer>Sony Corporation</manufacturer>
<manufacturerURL>http://www.sony.net/</manufacturerURL>
<modelName>KDL-26EX553</modelName>
<UDN>uuid:00000000-0000-1010-8000-5453EDC2BE0A</UDN>
<dlna:X_DLNADOC xmlns:dlna="urn:schemas-dlna-org:device-1-0">DMR-1.50</dlna:X_DLNADOC>
<iconList>
<icon>
<mimetype>image/png</mimetype>
<width>32</width>
<height>32</height>
<depth>24</depth>
<url>/MediaRenderer_32x32.png</url>
</icon>
<icon>
<mimetype>image/png</mimetype>
<width>48</width>
<height>48</height>
<depth>24</depth>
<url>/MediaRenderer_48x48.png</url>
</icon>
<icon>
<mimetype>image/png</mimetype>
<width>60</width>
<height>60</height>
<depth>24</depth>
<url>/MediaRenderer_60x60.png</url>
</icon>
<icon>
<mimetype>image/png</mimetype>
<width>120</width>
<height>120</height>
<depth>24</depth>
<url>/MediaRenderer_120x120.png</url>
</icon>
<icon>
<mimetype>image/jpeg</mimetype>
<width>32</width>
<height>32</height>
<depth>24</depth>
<url>/MediaRenderer_32x32.jpg</url>
</icon>
<icon>
<mimetype>image/jpeg</mimetype>
<width>48</width>
<height>48</height>
<depth>24</depth>
<url>/MediaRenderer_48x48.jpg</url>
</icon>
<icon>
<mimetype>image/jpeg</mimetype>
<width>60</width>
<height>60</height>
<depth>24</depth>
<url>/MediaRenderer_60x60.jpg</url>
</icon>
<icon>
<mimetype>image/jpeg</mimetype>
<width>120</width>
<height>120</height>
<depth>24</depth>
<url>/MediaRenderer_120x120.jpg</url>
</icon>
</iconList>
<serviceList>
<service>
<serviceType>urn:schemas-upnp-org:service:RenderingControl:1</serviceType>
<serviceId>urn:upnp-org:serviceId:RenderingControl</serviceId>
<SCPDURL>/RenderingControlSCPD.xml</SCPDURL>
<controlURL>/upnp/control/RenderingControl</controlURL>
<eventSubURL>/upnp/event/RenderingControl</eventSubURL>
</service>
<service>
<serviceType>urn:schemas-upnp-org:service:ConnectionManager:1</serviceType>
<serviceId>urn:upnp-org:serviceId:ConnectionManager</serviceId>
<SCPDURL>/ConnectionManagerSCPD.xml</SCPDURL>
<controlURL>/upnp/control/ConnectionManager</controlURL>
<eventSubURL>/upnp/event/ConnectionManager</eventSubURL>
</service>
<service>
<serviceType>urn:schemas-upnp-org:service:AVTransport:1</serviceType>
<serviceId>urn:upnp-org:serviceId:AVTransport</serviceId>
<SCPDURL>/AVTransportSCPD.xml</SCPDURL>
<controlURL>/upnp/control/AVTransport</controlURL>
<eventSubURL>/upnp/event/AVTransport</eventSubURL>
</service>
<service>
<serviceType>urn:schemas-sony-com:service:IRCC:1</serviceType>
<serviceId>urn:schemas-sony-com:serviceId:IRCC</serviceId>
<SCPDURL>http://192.168.88.30:80/IRCC/IRCCSCPD.xml</SCPDURL>
<controlURL>http://192.168.88.30:80/IRCC</controlURL>
<eventSubURL/>
</service>
</serviceList>
<av:X_MaxBGMCount xmlns:av="urn:schemas-sony-com:av">64</av:X_MaxBGMCount>
<av:X_StandardDMR xmlns:av="urn:schemas-sony-com:av">1.1</av:X_StandardDMR>
<av:X_IRCCCodeList xmlns:av="urn:schemas-sony-com:av">
<av:X_IRCCCode command="Power">AAAAAQAAAAEAAAAVAw==</av:X_IRCCCode>
<av:X_IRCCCode command="Power ON">AAAAAQAAAAEAAAAuAw==</av:X_IRCCCode>
<av:X_IRCCCode command="Power OFF">AAAAAQAAAAEAAAAvAw==</av:X_IRCCCode>
</av:X_IRCCCodeList>
<pnpx:X_compatibleId>MS_DigitalMediaDeviceClass_DMR_V001</pnpx:X_compatibleId>
<pnpx:X_deviceCategory>MediaDevices</pnpx:X_deviceCategory>
<pnpx:X_hardwareId>VEN_0033&DEV_0006&REV_01</pnpx:X_hardwareId>
<df:X_deviceCategory>Display.TV Multimedia.DMR</df:X_deviceCategory>
<av:X_IRCC_DeviceInfo xmlns:av="urn:schemas-sony-com:av">
<av:X_IRCC_Version>1.0</av:X_IRCC_Version>
<av:X_IRCC_CategoryList>
<av:X_IRCC_Category>
<av:X_CategoryInfo>AAEAAAAB</av:X_CategoryInfo>
</av:X_IRCC_Category>
<av:X_IRCC_Category>
<av:X_CategoryInfo>AAIAAACX</av:X_CategoryInfo>
</av:X_IRCC_Category>
<av:X_IRCC_Category>
<av:X_CategoryInfo>AAIAAAAa</av:X_CategoryInfo>
</av:X_IRCC_Category>
<av:X_IRCC_Category>
<av:X_CategoryInfo>AAIAAACk</av:X_CategoryInfo>
</av:X_IRCC_Category>
</av:X_IRCC_CategoryList>
</av:X_IRCC_DeviceInfo>
<av:X_UNR_DeviceInfo xmlns:av="urn:schemas-sony-com:av">
<av:X_UNR_Version>1.2</av:X_UNR_Version>
<av:X_CERS_ActionList_URL>http://192.168.88.30:80/cers/ActionList.xml</av:X_CERS_ActionList_URL>
</av:X_UNR_DeviceInfo>
<av:X_RDIS_DeviceInfo xmlns:av="urn:schemas-sony-com:av">
<av:X_RDIS_Version>1.0</av:X_RDIS_Version>
<av:X_RDIS_SESSION_CONTROL>false</av:X_RDIS_SESSION_CONTROL>
<av:X_RDIS_ENTRY_PORT>20677</av:X_RDIS_ENTRY_PORT>
</av:X_RDIS_DeviceInfo>
<av:X_S2MTV_DeviceInfo xmlns:av="urn:schemas-sony-com:av">
<av:X_S2MTV_Version>1.0</av:X_S2MTV_Version>
<av:X_S2MTV_BaseURL>http://192.168.88.30:80/s2mtv</av:X_S2MTV_BaseURL>
</av:X_S2MTV_DeviceInfo>
</device>
</root>

andan · April 13, 2021, 4:43pm

@buch As far as I can see the cause of the problem is that you use a rather old Bravia TV that uses /IRCC instead /ircc as endpoint of the ircc service. As the binding (OH2.5 and OH 3 versions) only supports /ircc, a file not found 404 error is thrown when a request is made.

I run into the same problem with my TV when I started to work on the OH 3 migration of the binding. My first fix was to make a hard coded change of the endpoint, but then @tmrobert8 told me that this will break compatibility with newer Sony devices. So I reverted the change and instead use the ircc service that is discovered by the scalar service. This workaround works well for me, so I’d suggest to give it a try.

A final fix (auto discovery of correct endpoint) is on my to do list but not yet prioritized.

buch · April 13, 2021, 7:51pm

You are right, the TV is old (2012).
I have a PC application (Sony virtual remote control) that works with my TV.
It uses <av: X_CERS_ActionList_URL>

andan · April 15, 2021, 4:01pm

OK. Your TV seems to be of an even older generation with no scalar service support.

Could you please send me the debug log of the Sony binding covering the period from thing discovery to the point where the power off command is sent (which I understand seems to work).

Short description of setting the debug log level in the file log4j2.xml

<Appenders>
...
    <!-- Sony binding appender -->
    <RollingFile fileName="${sys:openhab.logdir}/sony.log" filePattern="${sys:openhab.logdir}/sony-%d{yyyyMMdd-HHmmss}.log" name="SONY">
        <PatternLayout pattern="%d{yyyy-MM-dd HH:mm:ss.SSS} [%-5.5p] [%-36.36c] - %m%n"/>
        <Policies>
            <OnStartupTriggeringPolicy/>
            <SizeBasedTriggeringPolicy size="16 MB"/>
        </Policies>
    </RollingFile>
</Appenders>

<Loggers>
    <Logger additivity="false" level="DEBUG" name="org.openhab.binding.sony">
        <AppenderRef ref="SONY"/>
    </Logger>
</Loggers>

buch · April 24, 2021, 5:49pm

Good day!
I apologize for the long silence.
I post the log file of the moment the TV was detected and added to OH3 thihg (shutdown command does not work).
Additionally, wireshark tracing of a third-party application (getting started and CH + and CH- commands).

sony.log (93.7 KB) sony.pcapng.txt (18.1 KB)

andan · April 26, 2021, 8:08pm

Thank you for providing the helpful logs.

At a first glance there seems to be an authorization problem that prevents getting the complete remote control command list. This might explain why the power off command works as this command is extracted from the service descriptions during discovery.

The 404 error as seen in the event log originates from trying to use an access control service that doesn’t exist on your TV.

I will do some further analysis and hope to provide a solution for the OH 3 version.

yfaway · April 27, 2021, 3:26am

Andreas, thank you for updating the binding to OH3. I only used the power on/off feature on the Sony TV to detect occupancy, and it works immediately after loading the action.

However, I do see a few stack traces similar to the following when starting up OH 3.0.1. Are you aware of these? Thanks.

2021-04-25 22:37:47.376 [WARN ] [ache.cxf.phase.PhaseInterceptorChain] - Interceptor for {http://192.168.0.71:10000/sony/guide}WebClient has thrown exception, unwinding now
org.apache.cxf.interceptor.Fault: Could not send Message.
        at org.apache.cxf.interceptor.MessageSenderInterceptor$MessageSenderEndingInterceptor.handleMessage(MessageSenderInterceptor.java:67) ~[bundleFile:1.0.9]
        at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308) [bundleFile:1.0.9]
        at org.apache.cxf.jaxrs.client.AbstractClient.doRunInterceptorChain(AbstractClient.java:705) [bundleFile:1.0.9]
        at org.apache.cxf.jaxrs.client.WebClient.doChainedInvocation(WebClient.java:1081) [bundleFile:1.0.9]
        at org.apache.cxf.jaxrs.client.WebClient.doInvoke(WebClient.java:927) [bundleFile:1.0.9]
        at org.apache.cxf.jaxrs.client.WebClient.doInvoke(WebClient.java:896) [bundleFile:1.0.9]
        at org.apache.cxf.jaxrs.client.WebClient.invoke(WebClient.java:461) [bundleFile:1.0.9]
        at org.apache.cxf.jaxrs.client.SyncInvokerImpl.method(SyncInvokerImpl.java:150) [bundleFile:1.0.9]
        at org.apache.cxf.jaxrs.client.SyncInvokerImpl.method(SyncInvokerImpl.java:145) [bundleFile:1.0.9]
        at org.apache.cxf.jaxrs.client.SyncInvokerImpl.post(SyncInvokerImpl.java:85) [bundleFile:1.0.9]
        at org.apache.cxf.jaxrs.client.spec.InvocationBuilderImpl.post(InvocationBuilderImpl.java:153) [bundleFile:1.0.9]
        at org.openhab.binding.sony.internal.net.HttpRequest.sendPostCommand(HttpRequest.java:158) [bundleFile:?]
        at org.openhab.binding.sony.internal.net.HttpRequest.sendPostJsonCommand(HttpRequest.java:138) [bundleFile:?]
        at org.openhab.binding.sony.internal.transports.SonyHttpTransport.executePostJson(SonyHttpTransport.java:331) [bundleFile:?]
        at org.openhab.binding.sony.internal.transports.SonyHttpTransport.executePostJson(SonyHttpTransport.java:308) [bundleFile:?]
        at org.openhab.binding.sony.internal.transports.SonyHttpTransport.execute(SonyHttpTransport.java:129) [bundleFile:?]  
        at org.openhab.binding.sony.internal.transports.SonyTransport.execute(SonyTransport.java:108) [bundleFile:?]
        at org.openhab.binding.sony.internal.scalarweb.ScalarWebClientFactory.tryDefaultClientUrl(ScalarWebClientFactory.java:166) [bundleFile:?]

zacofunny · April 27, 2021, 9:42am

Hi, I’m constantly getting the following warnings, does anybody know what could be the reason?

2021-04-27 11:40:19.703 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception:
java.lang.IllegalArgumentException: Cannot convert ScalarWebResult to class org.openhab.binding.sony.internal.scalarweb.models.api.CurrentTime for reason: null
        at org.openhab.binding.sony.internal.scalarweb.models.AbstractScalarResponse.as(AbstractScalarResponse.java:96) ~[?:?]
        at org.openhab.binding.sony.internal.scalarweb.models.ScalarWebResult.as(ScalarWebResult.java:231) ~[?:?]
        at org.openhab.binding.sony.internal.scalarweb.protocols.ScalarWebSystemProtocol.refreshCurrentTime(ScalarWebSystemProtocol.java:562) ~[?:?]
        at org.openhab.binding.sony.internal.scalarweb.protocols.ScalarWebSystemProtocol.refreshState(ScalarWebSystemProtocol.java:433) ~[?:?]
        at org.openhab.binding.sony.internal.scalarweb.protocols.ScalarWebProtocolFactory.lambda$2(ScalarWebProtocolFactory.java:167) ~[?:?]
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) ~[?:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304) ~[?:?]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
        at java.lang.Thread.run(Thread.java:834) [?:?]
Caused by: java.lang.reflect.InvocationTargetException
        at jdk.internal.reflect.GeneratedConstructorAccessor313.newInstance(Unknown Source) ~[?:?]
        at jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:?]
        at java.lang.reflect.Constructor.newInstance(Constructor.java:490) ~[?:?]
        at org.openhab.binding.sony.internal.scalarweb.models.AbstractScalarResponse.as(AbstractScalarResponse.java:62) ~[?:?]
        ... 10 more
Caused by: java.time.format.DateTimeParseException: Text '2021-04-27T11:40:19+0200' could not be parsed, unparsed text found at index 19
        at java.time.format.DateTimeFormatter.parseResolved0(DateTimeFormatter.java:2049) ~[?:?]
        at java.time.format.DateTimeFormatter.parse(DateTimeFormatter.java:1948) ~[?:?]
        at java.time.LocalDateTime.parse(LocalDateTime.java:492) ~[?:?]
        at java.time.LocalDateTime.parse(LocalDateTime.java:477) ~[?:?]
        at org.openhab.binding.sony.internal.scalarweb.models.api.CurrentTime.<init>(CurrentTime.java:98) ~[?:?]
        at jdk.internal.reflect.GeneratedConstructorAccessor313.newInstance(Unknown Source) ~[?:?]
        at jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:?]
        at java.lang.reflect.Constructor.newInstance(Constructor.java:490) ~[?:?]
        at org.openhab.binding.sony.internal.scalarweb.models.AbstractScalarResponse.as(AbstractScalarResponse.java:62) ~[?:?]
        ... 10 more

andan · April 27, 2021, 6:06pm

Hello,

The warning messages are thrown when the TV has become offline as result of the connection retry process that is activated by default (retry polling paramater > 0).

You can deactivate the logs in the console

log:set error org.apache.cxf.phase.PhaseInterceptorChain

or alternatively in log4j2.xml

<Logger level="ERROR" name="org.apache.cxf.phase.PhaseInterceptorChain"/>

andan · April 27, 2021, 7:18pm

Hi,

Did the warnings appear after migration to the OH3 version?
If this is the case, then they might be caused by the replacement of the used java datetime libs. I would then try to fix this bug.

yfaway · April 28, 2021, 1:11am

Andreas, I was using the original 2.5 version of the binding. It was gone when I upgraded to OH3, so I don’t know if it is new or not.

I also disabled the logging yesterday similar to what you suggested, but I think it is nicer to trap the exception and log an info/warning instead of the stacktrace.

Thanks,