UPNP - Device Not Registered Error

mjcumming · March 31, 2024, 3:05pm

I am on 4.2 S4020 (the error has been present since I started with OH 3.0). The bridge connects correctly to the device at startup but eventually goes off line. There is a Java error in the console that seems to be related to the UPNP service. Error and trace ouitput below.

2024-03-31 07:39:04.828 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable CurrentTrackMetaData with value <?xml version="1.0" encoding="UTF-8"?> <DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:song="www.wiimu.com/song/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"> <upnp:class>object.item.audioItem.musicTrack</upnp:class> <item id="0"> <song:subid></song:subid> <song:description></song:description> <song:skiplimit>0</song:skiplimit> <song:id></song:id> <song:like>0</song:like> <song:singerid>0</song:singerid> <song:albumid>0</song:albumid> <song:rate_hz></song:rate_hz> <song:format_s></song:format_s> <song:bitrate>0</song:bitrate> <res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;" duration="00:00:00.000"></res> <dc:title></dc:title> <dc:creator></dc:creator> <upnp:artist></upnp:artist> <upnp:album></upnp:album> <upnp:albumArtURI>un_known</upnp:albumArtURI> </item> </DIDL-Lite>  from service AVTransport
2024-03-31 07:39:04.835 [TRACE] [internal.handler.UpnpRendererHandler] - Renderer Arylic Kitchen, received media ID: 0
2024-03-31 07:39:04.836 [TRACE] [internal.handler.UpnpRendererHandler] - Current queue res: 
2024-03-31 07:39:04.836 [TRACE] [internal.handler.UpnpRendererHandler] - Updated media res: 
2024-03-31 07:39:04.837 [TRACE] [internal.handler.UpnpRendererHandler] - Received meta data is for current entry: true
2024-03-31 07:39:04.838 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception: 
java.lang.IllegalArgumentException: Illegal character in path at index 8: un_known 
	at java.net.URI.create(URI.java:906) ~[?:?]
	at org.eclipse.jetty.client.HttpClient.newRequest(HttpClient.java:473) ~[?:?]
	at org.openhab.core.io.net.http.HttpUtil.executeUrlAndGetReponse(HttpUtil.java:212) ~[?:?]
	at org.openhab.core.io.net.http.HttpUtil.downloadData(HttpUtil.java:443) ~[?:?]
	at org.openhab.core.io.net.http.HttpUtil.downloadImage(HttpUtil.java:406) ~[?:?]
	at org.openhab.core.io.net.http.HttpUtil.downloadImage(HttpUtil.java:377) ~[?:?]
	at org.openhab.core.io.net.http.HttpUtil.downloadImage(HttpUtil.java:363) ~[?:?]
	at org.openhab.binding.upnpcontrol.internal.handler.UpnpRendererHandler.updateMetaDataState(UpnpRendererHandler.java:1654) ~[?:?]
	at org.openhab.binding.upnpcontrol.internal.handler.UpnpRendererHandler.onValueReceivedCurrentMetaData(UpnpRendererHandler.java:1306) ~[?:?]
	at org.openhab.binding.upnpcontrol.internal.handler.UpnpRendererHandler.onValueReceived(UpnpRendererHandler.java:1089) ~[?:?]
	at org.openhab.binding.upnpcontrol.internal.handler.UpnpRendererHandler.lambda$3(UpnpRendererHandler.java:1161) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) ~[?:?]
	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:1136) [?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?]
	at java.lang.Thread.run(Thread.java:833) [?:?]
Caused by: java.net.URISyntaxException: Illegal character in path at index 8: un_known 
	at java.net.URI$Parser.fail(URI.java:2976) ~[?:?]
	at java.net.URI$Parser.checkChars(URI.java:3147) ~[?:?]
	at java.net.URI$Parser.parseHierarchical(URI.java:3229) ~[?:?]
	at java.net.URI$Parser.parse(URI.java:3188) ~[?:?]
	at java.net.URI.<init>(URI.java:623) ~[?:?]
	at java.net.URI.create(URI.java:904) ~[?:?]
	... 16 more

r.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:24.464 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:24.465 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:24.466 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:24.469 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:24.469 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:24.470 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:24.470 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:24.471 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:24.473 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:24.473 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:24.473 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:24.476 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:24.477 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:24.478 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:24.479 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:24.480 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:24.481 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.122 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.123 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.124 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.125 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.127 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.129 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.136 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.137 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.138 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.139 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.139 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.140 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.140 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.140 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.141 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.141 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.149 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.150 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.484 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.485 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.489 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.490 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.491 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.491 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.491 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.491 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.491 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.492 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.492 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.491 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.490 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.493 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.493 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.494 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlevolume already exists
2024-03-31 07:09:25.494 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:09:25.495 [TRACE] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen, channel Singlemute already exists
2024-03-31 07:39:04.767 [DEBUG] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen add upnp subscription on AVTransport
2024-03-31 07:39:04.771 [DEBUG] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen add upnp subscription on RenderingControl
2024-03-31 07:39:04.791 [DEBUG] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen received subscription reply true from service AVTransport
2024-03-31 07:39:04.795 [DEBUG] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen received subscription reply true from service RenderingControl
2024-03-31 07:39:04.801 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable LastChange with value <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/">
&lt;DIDL-Lite xmlns:dc=&quot;http://purl.org/dc/elements/1.1/&quot; xmlns:upnp=&quot;urn:schemas-upnp-org:metadata-1-0/upnp/&quot; xmlns:song=&quot;www.wiimu.com/song/&quot; xmlns=&quot;urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/&quot;&gt;
&lt;upnp:class&gt;object.item.audioItem.musicTrack&lt;/upnp:class&gt;
&lt;upnp:artist&gt;&lt;/upnp:artist&gt;
&lt;upnp:album&gt;&lt;/upnp:album&gt;
&lt;upnp:albumArtURI&gt;un_known&lt;/upnp:albumArtURI&gt;
2024-03-31 07:39:04.807 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable CurrentTrackURI with value spotify from service AVTransport
2024-03-31 07:39:04.807 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable LastChange with value <Event xmlns="urn:schemas-upnp-org:metadata-1-0/RCS/">
2024-03-31 07:39:04.808 [TRACE] [internal.handler.UpnpRendererHandler] - Renderer Arylic Kitchen received URI: spotify
2024-03-31 07:39:04.809 [TRACE] [internal.handler.UpnpRendererHandler] - Renderer Arylic Kitchen current URI: , equal to received URI false
2024-03-31 07:39:04.811 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable InstanceID with value 0 from service RenderingControl
2024-03-31 07:39:04.811 [TRACE] [internal.handler.UpnpRendererHandler] - Renderer Arylic Kitchen next URI: 
2024-03-31 07:39:04.815 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable Channel with value 0 from service RenderingControl
2024-03-31 07:39:04.816 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable MasterMute with value 0 from service RenderingControl
2024-03-31 07:39:04.816 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable AbsoluteTimePosition with value NOT_IMPLEMENTED from service AVTransport
2024-03-31 07:39:04.817 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable Equaluzer with value 0 from service RenderingControl
2024-03-31 07:39:04.817 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable PresetNameList with value FactoryDefaults from service RenderingControl
2024-03-31 07:39:04.817 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable TransportPlaySpeed with value 1 from service AVTransport
2024-03-31 07:39:04.818 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable MasterVolume with value 43 from service RenderingControl
2024-03-31 07:39:04.818 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable AbsoluteCounterPosition with value -1 from service AVTransport
2024-03-31 07:39:04.820 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable CurrentTrackURI with value spotify from service AVTransport
2024-03-31 07:39:04.821 [TRACE] [internal.handler.UpnpRendererHandler] - Renderer Arylic Kitchen received URI: spotify
2024-03-31 07:39:04.822 [TRACE] [internal.handler.UpnpRendererHandler] - Renderer Arylic Kitchen current URI: , equal to received URI false
2024-03-31 07:39:04.824 [TRACE] [internal.handler.UpnpRendererHandler] - Renderer Arylic Kitchen next URI: 
2024-03-31 07:39:04.827 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable InstanceID with value 0 from service AVTransport
2024-03-31 07:39:04.828 [TRACE] [internal.handler.UpnpRendererHandler] - UPnP device Arylic Kitchen received variable CurrentTrackMetaData with value <?xml version="1.0" encoding="UTF-8"?> <DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:song="www.wiimu.com/song/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"> <upnp:class>object.item.audioItem.musicTrack</upnp:class> <item id="0"> <song:subid></song:subid> <song:description></song:description> <song:skiplimit>0</song:skiplimit> <song:id></song:id> <song:like>0</song:like> <song:singerid>0</song:singerid> <song:albumid>0</song:albumid> <song:rate_hz></song:rate_hz> <song:format_s></song:format_s> <song:bitrate>0</song:bitrate> <res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_PN=MP3;DLNA.ORG_OP=01;" duration="00:00:00.000"></res> <dc:title></dc:title> <dc:creator></dc:creator> <upnp:artist></upnp:artist> <upnp:album></upnp:album> <upnp:albumArtURI>un_known</upnp:albumArtURI> </item> </DIDL-Lite>  from service AVTransport
2024-03-31 07:39:04.835 [TRACE] [internal.handler.UpnpRendererHandler] - Renderer Arylic Kitchen, received media ID: 0
2024-03-31 07:39:04.836 [TRACE] [internal.handler.UpnpRendererHandler] - Current queue res: 
2024-03-31 07:39:04.836 [TRACE] [internal.handler.UpnpRendererHandler] - Updated media res: 
2024-03-31 07:39:04.837 [TRACE] [internal.handler.UpnpRendererHandler] - Received meta data is for current entry: true
	at org.openhab.binding.upnpcontrol.internal.handler.UpnpRendererHandler.updateMetaDataState(UpnpRendererHandler.java:1654) ~[?:?]
	at org.openhab.binding.upnpcontrol.internal.handler.UpnpRendererHandler.onValueReceivedCurrentMetaData(UpnpRendererHandler.java:1306) ~[?:?]
	at org.openhab.binding.upnpcontrol.internal.handler.UpnpRendererHandler.onValueReceived(UpnpRendererHandler.java:1089) ~[?:?]
	at org.openhab.binding.upnpcontrol.internal.handler.UpnpRendererHandler.lambda$3(UpnpRendererHandler.java:1161) ~[?:?]
2024-03-31 07:39:26.054 [DEBUG] [very.UpnpControlDiscoveryParticipant] - Device type MediaRenderer, manufacturer Rakoit Technology(SZ) Co., Ltd., model H50, SN# 00001, UDN FF97F35D-4C0A-1EB1-DA5E-0714FF97F35D
2024-03-31 07:39:26.057 [DEBUG] [control.internal.handler.UpnpHandler] - UPnP device Arylic Kitchen received status update false
2024-03-31 07:39:26.061 [DEBUG] [very.UpnpControlDiscoveryParticipant] - Media renderer found: Rakoit Technology(SZ) Co., Ltd., H50
2024-03-31 07:39:26.065 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'upnpcontrol:upnprenderer:FF97F35D-4C0A-1EB1-DA5E-0714FF97F35D' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Communication lost with Arylic Kitchen
2024-03-31 07:40:04.774 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'upnpcontrol:upnprenderer:FF97F35D-4C0A-1EB1-DA5E-0714FF97F35D' changed from OFFLINE (COMMUNICATION_ERROR): Communication lost with Arylic Kitchen to OFFLINE (COMMUNICATION_ERROR): UPnP device with UDN FF97F35D-4C0A-1EB1-DA5E-0714FF97F3

wborn · March 31, 2024, 3:22pm

The binding should be updated so it will properly handle these invalid URIs by ignoring them. Maybe you can create an issue for this?

mjcumming · March 31, 2024, 9:01pm

I raised an issue on github [UPnP Binding] Error when parsing URI · Issue #16595 · openhab/openhab-addons (github.com)