Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

[http] The Player Item dose not updated with the Status it becomes undef after a view seconds #10066

Closed
Scherzin83 opened this issue Feb 6, 2021 · 5 comments · Fixed by #10213
Labels
bug An unexpected problem or unintended behavior of an add-on

Comments

@Scherzin83
Copy link
Contributor

openhabian 1.63
openhab 3.1.0M1

Player Item becom undef after a few seconds pressing play

*2021-02-06 12:33:27.457 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_rgrsgg' changed from PLAY to play
*2021-02-06 12:33:27.467 [INFO ] [openhab.event.ItemCommandEvent ] - Item 'RaumServerCommand_BuroPlayer' received command PLAY
*2021-02-06 12:33:27.468 [INFO ] [penhab.event.ItemStatePredictedEvent] - Item 'RaumServerCommand_BuroPlayer' predicted to become PLAY
*2021-02-06 12:33:27.471 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_BuroPlayer' changed from UNDEF to PLAY
*2021-02-06 12:33:32.417 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_BuroPlayer' changed from PLAY to UNDEF

I tryes both send with the Transformation the States PAUSE or the stop " Value for Command" without any success
JS Conversion
( function (input) { var parsedInput = JSON.parse(input); var RF_State = parsedInput.data[0].TransportState; if (RF_State == "PLAYING") { return "play" } return "stop" } )(input)

Channel Config

- id: BueroPlayer channelTypeUID: http:player label: Büro Player description: null configuration: playValue: play pauseValue: stop stateExtension: data/getRendererState?id=Buero nextValue: next commandExtension: /controller/%2$s?id=Buero stateTransformation: JS:RF_GetPlayerStatus.js previousValue: prev

I checked the Transformation also with a string Channel and the Transformation looks good

@Scherzin83 Scherzin83 added the bug An unexpected problem or unintended behavior of an add-on label Feb 6, 2021
@J-N-K
Copy link
Member

J-N-K commented Feb 7, 2021

Set the binding to TRACE and show what happens.

@Scherzin83
Copy link
Contributor Author

Hi not realy special things ....

I can not see anny issue on the http server side...

021-02-08 19:16:01.719 [INFO ] [nding.http.internal.HttpThingHandler] - Using the secure client for thing 'http:url:RaumServerCommand'.

2021-02-08 19:16:01.720 [DEBUG] [nding.http.internal.HttpThingHandler] - No authentication configured for thing 'http:url:RaumServerCommand'

2021-02-08 19:16:01.721 [TRACE] [ttp.internal.http.RefreshingUrlCache] - Started refresh task for URL 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero' with interval 5s

2021-02-08 19:16:01.722 [TRACE] [.HttpDynamicStateDescriptionProvider] - adding state description for channel http:url:RaumServerCommand:BueroPowerSwitch

2021-02-08 19:16:01.723 [TRACE] [.HttpDynamicStateDescriptionProvider] - adding state description for channel http:url:RaumServerCommand:BueroPlayer

2021-02-08 19:16:01.724 [TRACE] [.HttpDynamicStateDescriptionProvider] - adding state description for channel http:url:RaumServerCommand:grgrg

==> /var/log/openhab/events.log <==

2021-02-08 19:16:01.712 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'http:url:RaumServerCommand' changed from UNINITIALIZED (DISABLED) to INITIALIZING

2021-02-08 19:16:01.725 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'http:url:RaumServerCommand' changed from INITIALIZING to ONLINE

==> /var/log/openhab/openhab.log <==

2021-02-08 19:16:02.721 [TRACE] [ttp.internal.http.RefreshingUrlCache] - Requesting refresh (retry=false) from 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero' with timeout 3000ms

2021-02-08 19:16:02.723 [TRACE] [ttp.internal.http.RefreshingUrlCache] - Sending to 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero': Method = {GET}, Headers = {Accept-Encoding: gzip, User-Agent: Jetty/9.4.20.v20190813}, Content = {null}

2021-02-08 19:16:02.737 [TRACE] [p.internal.http.HttpResponseListener] - Received from 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero': Code = {200}, Headers = {Content-Type: application/json, Access-Control-Allow-Origin: , Access-Control-Request-Method: , Access-Control-Allow-Methods: OPTIONS, GET, Access-Control-Allow-Headers: , Access-Control-Expose-Headers: updateId,updateid,updateID, updateId: 614933, Date: Mon, 08 Feb 2021 18:16:02 GMT, Connection: keep-alive, Keep-Alive: timeout=5, Transfer-Encoding: chunked}, Content = {{"requestUrl":"/raumserver/data/getRendererState?id=Buero","action":"getRendererState","error":false,"msg":"","data":[{"InstanceID":0,"CurrentTrackMetaData":"\n<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Favorites/RecentlyPlayed" id="0/Favorites/RecentlyPlayed/47" restricted="1" refID="0/RadioTime/Search/s-s302348">raumfeld:nameStation</raumfeld:name>upnp:classobject.item.audioItem.audioBroadcast.radio</upnp:class>raumfeld:sectionRadioTime</raumfeld:section>raumfeld:durability120</raumfeld:durability>dc:titleARMIN VAN BUUREN - I LOVE BIGFM NITROX</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">http://d1i6vahw24eb07.cloudfront.net/s302348q.png</upnp:albumArtURI>raumfeld:ebrowsehttp://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s302348&c=ebrowse</raumfeld:ebrowse><res bitrate="128" protocolInfo="http-get::audio/x-mpegurl:">http://opml.radiotime.com/Tune.ashx?id=e90416063&sid=s302348&formats=mp3,ogg&partnerId=7aJ9pvV5&serial=50:1e:2d:35:98:c4\n","CurrentRecordQualityMode":"NOT_IMPLEMENTED","AbsoluteTimePosition":"53:58:08","SecondsUntilSleep":"0","CurrentTrack":"1","AVTransportURIMetaData":"\n<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item refID="0/RadioTime/Search/s-s302348" id="0/Favorites/RecentlyPlayed/47" restricted="1" parentID="0/Favorites/RecentlyPlayed">dc:titlebigFM EDM & Progressive</dc:title>upnp:classobject.item.audioItem.audioBroadcast.radio</upnp:class>upnp:albumArtURIhttp://d1i6vahw24eb07.cloudfront.net/s302348q.png</upnp:albumArtURI>raumfeld:sectionRadioTime</raumfeld:section>raumfeld:nameStation</raumfeld:name>raumfeld:durability-2501.554561972618</raumfeld:durability>raumfeld:ebrowsehttp://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s302348&c=ebrowse</raumfeld:ebrowse>\n","PossiblePlaybackStorageMedia":"NETWORK","TransportPlaySpeed":"1","CurrentTrackDuration":"00:00:00","PossibleRecordQualityModes":"NOT_IMPLEMENTED","Bitrate":"128","PossibleRecordStorageMedia":"NONE","AVTransportURI":"dlna-playsingle://uuid%3Adba2b3b5-7231-4e73-b111-10858fcc1960?sid=urn%3Aupnp-org%3AserviceId%3AContentDirectory&iid=0%2FFavorites%2FRecentlyPlayed%2F47","RelativeTimePosition":"53:58:08","RelativeCounterPosition":"1","CurrentPlayMode":"NORMAL","TransportState":"PLAYING","AbsoluteCounterPosition":"1","CurrentTransportActions":"Stop","RoomStates":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=PLAYING","ContentType":"MP3","NumberOfTracks":"1","SleepTimerActive":"0","TransportStatus":"OK","CurrentTrackURI":"http://streams.bigfm.de/bigfm-nitroxedm-128-mp3?usid=0-0-H-A-D-02","Mute":0,"RoomVolumes":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=78","Volume":"78","RoomMutes":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=0","rooms":[{"roomUDN":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4","TransportState":"PLAYING","name":"Buero","PowerState":"ACTIVE","online":true,"Volume":"78","Mute":"0","udn":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4","powerState":"ACTIVE","renderer":[{"udn":"uuid:c1db05b5-0068-429e-97c4-f38ce69f0d36","name":"Connector Buero"}]}],"udn":"uuid:B7E34E08-6BC4-4954-90A4-4B6F5C7AF30B","mediaItem":{"class":"object.item.audioItem.audioBroadcast.radio","section":"RadioTime","name":"Station","durability":"120","childCount":null,"parentID":"0/Favorites/RecentlyPlayed","id":"0/Favorites/RecentlyPlayed/47","restricted":"1","refID":"0/RadioTime/Search/s-s302348","title":"ARMIN VAN BUUREN - I LOVE BIGFM NITROX","description":null,"artist":null,"albumArtURI":"http://d1i6vahw24eb07.cloudfront.net/s302348q.png","genre":null,"album":null,"date":null,"creator":null,"originalTrackNumber":null,"bitrate":"128","protocolInfo":"http-get::audio/x-mpegurl:*","signalStrength":null,"ebrowse":"http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s302348&c=ebrowse"},"friendlyName":"Buero","host":"192.168.1.230","manufacturer":"Lautsprecher Teufel GmbH","modelNumber":"1"}]}}

==> /var/log/openhab/events.log <==

2021-02-08 19:16:02.748 [INFO ] [openhab.event.ItemCommandEvent ] - Item 'RaumServerCommand_BuroPlayer' received command PLAY

2021-02-08 19:16:02.750 [INFO ] [penhab.event.ItemStatePredictedEvent] - Item 'RaumServerCommand_BuroPlayer' predicted to become PLAY

2021-02-08 19:16:02.757 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_BuroPlayer' changed from UNDEF to PLAY

==> /var/log/openhab/openhab.log <==

2021-02-08 19:16:07.725 [TRACE] [ttp.internal.http.RefreshingUrlCache] - Requesting refresh (retry=false) from 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero' with timeout 3000ms

2021-02-08 19:16:07.726 [TRACE] [ttp.internal.http.RefreshingUrlCache] - Sending to 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero': Method = {GET}, Headers = {Accept-Encoding: gzip, User-Agent: Jetty/9.4.20.v20190813}, Content = {null}

2021-02-08 19:16:07.737 [TRACE] [p.internal.http.HttpResponseListener] - Received from 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero': Code = {200}, Headers = {Content-Type: application/json, Access-Control-Allow-Origin: , Access-Control-Request-Method: , Access-Control-Allow-Methods: OPTIONS, GET, Access-Control-Allow-Headers: , Access-Control-Expose-Headers: updateId,updateid,updateID, updateId: 614933, Date: Mon, 08 Feb 2021 18:16:07 GMT, Connection: keep-alive, Keep-Alive: timeout=5, Transfer-Encoding: chunked}, Content = {{"requestUrl":"/raumserver/data/getRendererState?id=Buero","action":"getRendererState","error":false,"msg":"","data":[{"InstanceID":0,"CurrentTrackMetaData":"\n<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Favorites/RecentlyPlayed" id="0/Favorites/RecentlyPlayed/47" restricted="1" refID="0/RadioTime/Search/s-s302348">raumfeld:nameStation</raumfeld:name>upnp:classobject.item.audioItem.audioBroadcast.radio</upnp:class>raumfeld:sectionRadioTime</raumfeld:section>raumfeld:durability120</raumfeld:durability>dc:titleARMIN VAN BUUREN - I LOVE BIGFM NITROX</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">http://d1i6vahw24eb07.cloudfront.net/s302348q.png</upnp:albumArtURI>raumfeld:ebrowsehttp://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s302348&c=ebrowse</raumfeld:ebrowse><res bitrate="128" protocolInfo="http-get::audio/x-mpegurl:">http://opml.radiotime.com/Tune.ashx?id=e90416063&sid=s302348&formats=mp3,ogg&partnerId=7aJ9pvV5&serial=50:1e:2d:35:98:c4\n","CurrentRecordQualityMode":"NOT_IMPLEMENTED","AbsoluteTimePosition":"53:58:08","SecondsUntilSleep":"0","CurrentTrack":"1","AVTransportURIMetaData":"\n<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item refID="0/RadioTime/Search/s-s302348" id="0/Favorites/RecentlyPlayed/47" restricted="1" parentID="0/Favorites/RecentlyPlayed">dc:titlebigFM EDM & Progressive</dc:title>upnp:classobject.item.audioItem.audioBroadcast.radio</upnp:class>upnp:albumArtURIhttp://d1i6vahw24eb07.cloudfront.net/s302348q.png</upnp:albumArtURI>raumfeld:sectionRadioTime</raumfeld:section>raumfeld:nameStation</raumfeld:name>raumfeld:durability-2501.554561972618</raumfeld:durability>raumfeld:ebrowsehttp://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s302348&c=ebrowse</raumfeld:ebrowse>\n","PossiblePlaybackStorageMedia":"NETWORK","TransportPlaySpeed":"1","CurrentTrackDuration":"00:00:00","PossibleRecordQualityModes":"NOT_IMPLEMENTED","Bitrate":"128","PossibleRecordStorageMedia":"NONE","AVTransportURI":"dlna-playsingle://uuid%3Adba2b3b5-7231-4e73-b111-10858fcc1960?sid=urn%3Aupnp-org%3AserviceId%3AContentDirectory&iid=0%2FFavorites%2FRecentlyPlayed%2F47","RelativeTimePosition":"53:58:08","RelativeCounterPosition":"1","CurrentPlayMode":"NORMAL","TransportState":"PLAYING","AbsoluteCounterPosition":"1","CurrentTransportActions":"Stop","RoomStates":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=PLAYING","ContentType":"MP3","NumberOfTracks":"1","SleepTimerActive":"0","TransportStatus":"OK","CurrentTrackURI":"http://streams.bigfm.de/bigfm-nitroxedm-128-mp3?usid=0-0-H-A-D-02","Mute":0,"RoomVolumes":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=78","Volume":"78","RoomMutes":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=0","rooms":[{"roomUDN":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4","TransportState":"PLAYING","name":"Buero","PowerState":"ACTIVE","online":true,"Volume":"78","Mute":"0","udn":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4","powerState":"ACTIVE","renderer":[{"udn":"uuid:c1db05b5-0068-429e-97c4-f38ce69f0d36","name":"Connector Buero"}]}],"udn":"uuid:B7E34E08-6BC4-4954-90A4-4B6F5C7AF30B","mediaItem":{"class":"object.item.audioItem.audioBroadcast.radio","section":"RadioTime","name":"Station","durability":"120","childCount":null,"parentID":"0/Favorites/RecentlyPlayed","id":"0/Favorites/RecentlyPlayed/47","restricted":"1","refID":"0/RadioTime/Search/s-s302348","title":"ARMIN VAN BUUREN - I LOVE BIGFM NITROX","description":null,"artist":null,"albumArtURI":"http://d1i6vahw24eb07.cloudfront.net/s302348q.png","genre":null,"album":null,"date":null,"creator":null,"originalTrackNumber":null,"bitrate":"128","protocolInfo":"http-get::audio/x-mpegurl:*","signalStrength":null,"ebrowse":"http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s302348&c=ebrowse"},"friendlyName":"Buero","host":"192.168.1.230","manufacturer":"Lautsprecher Teufel GmbH","modelNumber":"1"}]}}

==> /var/log/openhab/events.log <==

2021-02-08 19:16:07.750 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_BuroPlayer' changed from PLAY to UNDEF

@J-N-K
Copy link
Member

J-N-K commented Feb 14, 2021

I can't reproduce that. I added your response content to a file, created the transformation and it works fine, thing stays at PLAY.

Do you see seomthing like

08:18:15.507 [WARN ] [l.transform.SingleValueTransformation] - Executing transformation ChannelStateTransformation{pattern='RF_GetPlayerStatus.js', serviceName='JS'} failed: An error occurred while executing script. SyntaxError: Invalid JSON: <json>:9:55 Expected , or } but found "
            "CurrentTrackMetaData":"\n<DIDL-Lite xmlns=""urn":"schemas-upnp-org":metadata-1-0/DIDL-Lite/" xmlns:raumfeld=""urn":"schemas-raumfeld-com":"meta-data/raumfeld"" xmlns:upnp=""urn":"schemas-upnp-org":metadata-1-0/upnp/" xmlns:dc=""http"://purl.org/dc/elements/1.1/" xmlns:dlna=""urn":"schemas-dlna-org":metadata-1-0/" xmlns:pv=""http":" lang=""en""><item parentID="0/Favorites/RecentlyPlayed" id="0/Favorites/RecentlyPlayed/47" restricted="1" refID="0/RadioTime/Search/s-s302348">raumfeld:nameStation</raumfeld:name>upnp:classobject.item.audioItem.audioBroadcast.radio</upnp:class>raumfeld:sectionRadioTime</raumfeld:section>raumfeld:durability120</raumfeld:durability>dc:titleARMIN VAN BUUREN - I LOVE BIGFM NITROX</dc:title><upnp:albumArtURI dlna:profileID=""JPEG_TN"">http://d1i6vahw24eb07.cloudfront.net/s302348q.png</upnp:albumArtURI>raumfeld:ebrowsehttp://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s302348&c=ebrowse</raumfeld:ebrowse><res bitrate="128" protocolInfo=""http-get"::"audio/x-mpegurl":">http://opml.radiotime.com/Tune.ashx?id=e90416063&sid=s302348&formats=mp3,ogg&partnerId=7aJ9pvV5&serial=50:1e:2d:35:98:c4\n",
                                                       ^ in <eval> at line number 2

This is what I get if I just copy your content response to the .json file, but I guess this is due to the formatting of the content output in the log.

@Scherzin83
Copy link
Contributor Author

This are not good news first thenks for your Analysis no I can not see any transformation issues. This I should see then in the JASONReplayString item this is use the same transformation so I can see if my transformation is working. And this Item got no Update to something else

sometime I got
2021-02-15 20:04:35.306 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_rgrsgg' changed from play to stop

2021-02-15 20:04:35.310 [INFO ] [openhab.event.ItemCommandEvent ] - Item 'RaumServerCommand_BuroPlayer' received command PAUSE

2021-02-15 20:04:35.312 [INFO ] [penhab.event.ItemStatePredictedEvent] - Item 'RaumServerCommand_BuroPlayer' predicted to become PAUSE

2021-02-15 20:04:35.314 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_BuroPlayer' changed from UNDEF to PAUSE

2021-02-15 20:04:35.316 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_JASONReplayString' changed from play to stop

2021-02-15 20:04:40.314 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_BuroPlayer' changed from PAUSE to UNDEF

==> /var/log/openhab/openhab.log <==

2021-02-15 20:04:55.303 [WARN ] [p.internal.http.HttpResponseListener] - Requesting 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero' (method='GET', content='null') failed: HttpConnectionOverHTTP@1a69b7a::SocketChannelEndPoint@9a5e34{/192.168.1.232:8587<->/192.168.1.232:35994,ISHUT,fill=-,flush=-,to=0/0}{io=0/0,kio=0,kro=1}->HttpConnectionOverHTTP@1a69b7a(l:/192.168.1.232:35994 <-> r:/192.168.1.232:8587,closed=false)=>HttpChannelOverHTTP@125a541(exchange=HttpExchange@14cd136 req=TERMINATED/null@null res=PENDING/null@null)[send=HttpSenderOverHTTP@1b51861(req=QUEUED,snd=COMPLETED,failure=null)[HttpGenerator@1988c1d{s=START}],recv=HttpReceiverOverHTTP@18d2782(rsp=IDLE,failure=null)[HttpParser{s=CLOSED,0 of -1}]]]

@Scherzin83
Copy link
Contributor Author

Hi again
I create a new log and you can see the first command where all the Channels getting the Update when I press the Pause via the Raumfeld App. The Player Item goes from play to pause what is expected. also the Jason Test sting item ist changing from play to stop. After the next Request only the Player Item gets a new Update with Undef... the string channel (statusstrig) get no update... So I think that the Player Object doing something wrong because the string objects behavior is as expected.

Hopefully this is helping you to fix it...

2021-02-21 14:09:12.010 [TRACE] [ttp.internal.http.RefreshingUrlCache] - Requesting refresh (retry=false) from 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero' with timeout 3000ms

2021-02-21 14:09:12.012 [TRACE] [ttp.internal.http.RefreshingUrlCache] - Sending to 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero': Method = {GET}, Headers = {Accept-Encoding: gzip, User-Agent: Jetty/9.4.20.v20190813}, Content = {null}

2021-02-21 14:09:12.017 [TRACE] [p.internal.http.HttpResponseListener] - Received from 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero': Code = {200}, Headers = {Content-Type: application/json, Access-Control-Allow-Origin: , Access-Control-Request-Method: , Access-Control-Allow-Methods: OPTIONS, GET, Access-Control-Allow-Headers: , Access-Control-Expose-Headers: updateId,updateid,updateID, updateId: 689079, Date: Sun, 21 Feb 2021 13:09:12 GMT, Connection: keep-alive, Keep-Alive: timeout=5, Transfer-Encoding: chunked}, Content = {{"requestUrl":"/raumserver/data/getRendererState?id=Buero","action":"getRendererState","error":false,"msg":"","data":[{"InstanceID":0,"CurrentTrackMetaData":"\n<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Favorites/RecentlyPlayed" id="0/Favorites/RecentlyPlayed/6" restricted="1" refID="0/RadioTime/Search/s-s237963">raumfeld:nameStation</raumfeld:name>upnp:classobject.item.audioItem.audioBroadcast.radio</upnp:class>raumfeld:sectionRadioTime</raumfeld:section>raumfeld:durability120</raumfeld:durability>dc:titlesunshine live - EDM</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">http://d1i6vahw24eb07.cloudfront.net/s237963q.png</upnp:albumArtURI>raumfeld:ebrowsehttp://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s237963&c=ebrowse</raumfeld:ebrowse><res bitrate="192" protocolInfo="http-get::audio/x-mpegurl:">http://opml.radiotime.com/Tune.ashx?id=e65724633&sid=s237963&formats=mp3,ogg&partnerId=7aJ9pvV5&serial=50:1e:2d:35:98:c4\n","CurrentRecordQualityMode":"NOT_IMPLEMENTED","AbsoluteTimePosition":"17:51:19","SecondsUntilSleep":"0","CurrentTrack":"1","AVTransportURIMetaData":"\n<DIDL-Lite xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item restricted="1" parentID="0/Favorites/RecentlyPlayed" id="0/Favorites/RecentlyPlayed/6" refID="0/RadioTime/Search/s-s237963">dc:titlesunshine live - EDM</dc:title>upnp:classobject.item.audioItem.audioBroadcast.radio</upnp:class>upnp:albumArtURIhttp://d1i6vahw24eb07.cloudfront.net/s237963q.png</upnp:albumArtURI>raumfeld:sectionRadioTime</raumfeld:section>raumfeld:nameStation</raumfeld:name>raumfeld:durability116.38626599311829</raumfeld:durability>raumfeld:ebrowsehttp://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s237963&c=ebrowse</raumfeld:ebrowse>\n","PossiblePlaybackStorageMedia":"NETWORK","TransportPlaySpeed":"1","CurrentTrackDuration":"00:00:00","PossibleRecordQualityModes":"NOT_IMPLEMENTED","Bitrate":"192","PossibleRecordStorageMedia":"NONE","AVTransportURI":"dlna-playsingle://uuid%3Adba2b3b5-7231-4e73-b111-10858fcc1960?sid=urn%3Aupnp-org%3AserviceId%3AContentDirectory&iid=0%2FFavorites%2FRecentlyPlayed%2F6","RelativeTimePosition":"17:51:19","RelativeCounterPosition":"1","CurrentPlayMode":"NORMAL","TransportState":"STOPPED","AbsoluteCounterPosition":"1","CurrentTransportActions":"Play","RoomStates":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=STOPPED","ContentType":"MP3","NumberOfTracks":"1","SleepTimerActive":"0","TransportStatus":"OK","CurrentTrackURI":"http://sunshinelive.hoerradar.de/sunshinelive-edm-mp3-hq?sABC=60315qsr%230%23883q2nsp2qo97nr8sppoo2596o81644n%23gharva&=&amsparams=playerid:tunein;skey:1613848062","Mute":0,"RoomVolumes":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=78","Volume":"78","RoomMutes":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=0","rooms":[{"roomUDN":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4","TransportState":"STOPPED","name":"Buero","PowerState":"ACTIVE","online":true,"Volume":"78","Mute":"0","udn":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4","powerState":"ACTIVE","renderer":[{"udn":"uuid:c1db05b5-0068-429e-97c4-f38ce69f0d36","name":"Connector Buero"}]}],"udn":"uuid:B7E34E08-6BC4-4954-90A4-4B6F5C7AF30B","mediaItem":{"class":"object.item.audioItem.audioBroadcast.radio","section":"RadioTime","name":"Station","durability":"120","childCount":null,"parentID":"0/Favorites/RecentlyPlayed","id":"0/Favorites/RecentlyPlayed/6","restricted":"1","refID":"0/RadioTime/Search/s-s237963","title":"sunshine live - EDM","description":null,"artist":null,"albumArtURI":"http://d1i6vahw24eb07.cloudfront.net/s237963q.png","genre":null,"album":null,"date":null,"creator":null,"originalTrackNumber":null,"bitrate":"192","protocolInfo":"http-get::audio/x-mpegurl:*","signalStrength":null,"ebrowse":"http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s237963&c=ebrowse"},"friendlyName":"Buero","host":"192.168.1.230","manufacturer":"Lautsprecher Teufel GmbH","modelNumber":"1"}]}}

**2021-02-21 14:09:12.032 [TRACE] [.HttpDynamicStateDescriptionProvider] - returning new stateDescription for http:url:RaumServerCommand:BueroPlayer

2021-02-21 14:09:12.038 [TRACE] [.HttpDynamicStateDescriptionProvider] - returning new stateDescription for http:url:RaumServerCommand:statusstrig

2021-02-21 14:09:12.042 [TRACE] [.HttpDynamicStateDescriptionProvider] - returning new stateDescription for http:url:RaumServerCommand:grgrg**

==> /var/log/openhab/events.log <==

2021-02-21 14:09:12.023 [INFO ] [openhab.event.ItemCommandEvent ] - Item 'RaumServerCommand_BuroPlayer' received command PAUSE

2021-02-21 14:09:12.028 [INFO ] [penhab.event.ItemStatePredictedEvent] - Item 'RaumServerCommand_BuroPlayer' predicted to become PAUSE

2021-02-21 14:09:12.030 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_BuroPlayer' changed from UNDEF to PAUSE

2021-02-21 14:09:12.036 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_JASONReplayString' changed from play to stop

2021-02-21 14:09:12.039 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_rgrsgg' changed from play to stop

==> /var/log/openhab/openhab.log <==

2021-02-21 14:09:17.011 [TRACE] [ttp.internal.http.RefreshingUrlCache] - Requesting refresh (retry=false) from 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero' with timeout 3000ms

2021-02-21 14:09:17.014 [TRACE] [ttp.internal.http.RefreshingUrlCache] - Sending to 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero': Method = {GET}, Headers = {Accept-Encoding: gzip, User-Agent: Jetty/9.4.20.v20190813}, Content = {null}

2021-02-21 14:09:17.018 [TRACE] [p.internal.http.HttpResponseListener] - Received from 'http://192.168.1.232:8587/raumserver/data/getRendererState?id=Buero': Code = {200}, Headers = {Content-Type: application/json, Access-Control-Allow-Origin: , Access-Control-Request-Method: , Access-Control-Allow-Methods: OPTIONS, GET, Access-Control-Allow-Headers: , Access-Control-Expose-Headers: updateId,updateid,updateID, updateId: 689079, Date: Sun, 21 Feb 2021 13:09:17 GMT, Connection: keep-alive, Keep-Alive: timeout=5, Transfer-Encoding: chunked}, Content = {{"requestUrl":"/raumserver/data/getRendererState?id=Buero","action":"getRendererState","error":false,"msg":"","data":[{"InstanceID":0,"CurrentTrackMetaData":"\n<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Favorites/RecentlyPlayed" id="0/Favorites/RecentlyPlayed/6" restricted="1" refID="0/RadioTime/Search/s-s237963">raumfeld:nameStation</raumfeld:name>upnp:classobject.item.audioItem.audioBroadcast.radio</upnp:class>raumfeld:sectionRadioTime</raumfeld:section>raumfeld:durability120</raumfeld:durability>dc:titlesunshine live - EDM</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">http://d1i6vahw24eb07.cloudfront.net/s237963q.png</upnp:albumArtURI>raumfeld:ebrowsehttp://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s237963&c=ebrowse</raumfeld:ebrowse><res bitrate="192" protocolInfo="http-get::audio/x-mpegurl:">http://opml.radiotime.com/Tune.ashx?id=e65724633&sid=s237963&formats=mp3,ogg&partnerId=7aJ9pvV5&serial=50:1e:2d:35:98:c4\n","CurrentRecordQualityMode":"NOT_IMPLEMENTED","AbsoluteTimePosition":"17:51:19","SecondsUntilSleep":"0","CurrentTrack":"1","AVTransportURIMetaData":"\n<DIDL-Lite xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item restricted="1" parentID="0/Favorites/RecentlyPlayed" id="0/Favorites/RecentlyPlayed/6" refID="0/RadioTime/Search/s-s237963">dc:titlesunshine live - EDM</dc:title>upnp:classobject.item.audioItem.audioBroadcast.radio</upnp:class>upnp:albumArtURIhttp://d1i6vahw24eb07.cloudfront.net/s237963q.png</upnp:albumArtURI>raumfeld:sectionRadioTime</raumfeld:section>raumfeld:nameStation</raumfeld:name>raumfeld:durability116.38626599311829</raumfeld:durability>raumfeld:ebrowsehttp://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s237963&c=ebrowse</raumfeld:ebrowse>\n","PossiblePlaybackStorageMedia":"NETWORK","TransportPlaySpeed":"1","CurrentTrackDuration":"00:00:00","PossibleRecordQualityModes":"NOT_IMPLEMENTED","Bitrate":"192","PossibleRecordStorageMedia":"NONE","AVTransportURI":"dlna-playsingle://uuid%3Adba2b3b5-7231-4e73-b111-10858fcc1960?sid=urn%3Aupnp-org%3AserviceId%3AContentDirectory&iid=0%2FFavorites%2FRecentlyPlayed%2F6","RelativeTimePosition":"17:51:19","RelativeCounterPosition":"1","CurrentPlayMode":"NORMAL","TransportState":"STOPPED","AbsoluteCounterPosition":"1","CurrentTransportActions":"Play","RoomStates":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=STOPPED","ContentType":"MP3","NumberOfTracks":"1","SleepTimerActive":"0","TransportStatus":"OK","CurrentTrackURI":"http://sunshinelive.hoerradar.de/sunshinelive-edm-mp3-hq?sABC=60315qsr%230%23883q2nsp2qo97nr8sppoo2596o81644n%23gharva&=&amsparams=playerid:tunein;skey:1613848062","Mute":0,"RoomVolumes":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=78","Volume":"78","RoomMutes":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4=0","rooms":[{"roomUDN":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4","TransportState":"STOPPED","name":"Buero","PowerState":"ACTIVE","online":true,"Volume":"78","Mute":"0","udn":"uuid:7e72abd0-cd00-474f-98ba-d3ee7ed825a4","powerState":"ACTIVE","renderer":[{"udn":"uuid:c1db05b5-0068-429e-97c4-f38ce69f0d36","name":"Connector Buero"}]}],"udn":"uuid:B7E34E08-6BC4-4954-90A4-4B6F5C7AF30B","mediaItem":{"class":"object.item.audioItem.audioBroadcast.radio","section":"RadioTime","name":"Station","durability":"120","childCount":null,"parentID":"0/Favorites/RecentlyPlayed","id":"0/Favorites/RecentlyPlayed/6","restricted":"1","refID":"0/RadioTime/Search/s-s237963","title":"sunshine live - EDM","description":null,"artist":null,"albumArtURI":"http://d1i6vahw24eb07.cloudfront.net/s237963q.png","genre":null,"album":null,"date":null,"creator":null,"originalTrackNumber":null,"bitrate":"192","protocolInfo":"http-get::audio/x-mpegurl:*","signalStrength":null,"ebrowse":"http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg&serial=50%3A1e%3A2d%3A35%3A98%3Ac4&id=s237963&c=ebrowse"},"friendlyName":"Buero","host":"192.168.1.230","manufacturer":"Lautsprecher Teufel GmbH","modelNumber":"1"}]}}

2021-02-21 14:09:17.028 [TRACE] [.HttpDynamicStateDescriptionProvider] - returning new stateDescription for http:url:RaumServerCommand:BueroPlayer

==> /var/log/openhab/events.log <==

2021-02-21 14:09:17.026 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'RaumServerCommand_BuroPlayer' changed from PAUSE to UNDEF

Scherzin83 added a commit to Scherzin83/openhab-addons that referenced this issue Feb 22, 2021
Scherzin83 added a commit to Scherzin83/openhab-addons that referenced this issue Feb 22, 2021
Signed-off-by: Matthias Scherzinger <scherzin@outlook.com>
kaikreuzer pushed a commit that referenced this issue Feb 28, 2021
Signed-off-by: Matthias Scherzinger <scherzin@outlook.com>
themillhousegroup pushed a commit to themillhousegroup/openhab2-addons that referenced this issue May 10, 2021
Signed-off-by: Matthias Scherzinger <scherzin@outlook.com>
Signed-off-by: John Marshall <john.marshall.au@gmail.com>
computergeek1507 pushed a commit to computergeek1507/openhab-addons that referenced this issue Jul 13, 2021
Signed-off-by: Matthias Scherzinger <scherzin@outlook.com>
thinkingstone pushed a commit to thinkingstone/openhab-addons that referenced this issue Nov 7, 2021
Signed-off-by: Matthias Scherzinger <scherzin@outlook.com>
marcfischerboschio pushed a commit to bosch-io/openhab-addons that referenced this issue May 5, 2022
Signed-off-by: Matthias Scherzinger <scherzin@outlook.com>
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug An unexpected problem or unintended behavior of an add-on
Projects
None yet
Development

Successfully merging a pull request may close this issue.

2 participants