Sonos langsam und träge

mrhaefele@gmx.de · 10 Januar 2017, 21:07:19

Hallo,

ich habe das Problem, dass mein Sonos Play 1 extrem träge und langsam reagiert auf FHEM Befehle (Befehle vom Handy oder Tablet führt der Sonos Play1 sofort aus). Gemäß Wiki habe ich schon über

Code Auswählen

attr usedonlyIPs 192.168.178.92
andere Quellen/Player ausgeschlossen.

Konkret:
Wenn ich beispielsweise ein

Code Auswählen

set Sonos_Arbeitszimmer Pause ausführe, dann dauert es in unterem Beispiel ~13 Sekunden, bis der Player anhält. Der Pause Befehl wurde bei 2017.01.10 20:42:45 abgesetzt. Bei 2017.01.10 20:42:58 wurde er dann stumm und ich habe dann wieder einen Play Befehl abgesetzt....

Ich werde aus dem Log nicht schlau. Ich weiß auch nicht, ob es in Ordnung ist, dass mehrere Threads laufen bei nur einem Player (Sonos Play 1 - "Sonos_Arbeitszimmer") im Netz.

Ich hänge unten mal das Log file und ein List der devices an.

Ich hoffe ihr könnt mir weiterhelfen.

Danke schon mal vorab

Ausschnitt Log (startet beim Pause Befehl):
[code]
2017.01.10 20:42:43 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.10 20:42:43 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.10 20:42:43 5: SONOS0: Received from UPnP-Server: 'DoWorkAnswer:RINCON_949F3E19ED8201400_MR:LastActionResult:Play: Success!'
2017.01.10 20:42:43 4: SONOS0: DoWorkAnswer arrived for Sonos_Arbeitszimmer->LastActionResult: 'Play: Success!'
2017.01.10 20:42:44 5: SONOS0: ===Udo=== 999 Ende
2017.01.10 20:42:45 5: SW: 446f576f726b3a52494e434f4e5f39343946334531394544383230313430305f4d523a70617573653a0d0a
2017.01.10 20:42:45 5: SONOS0: Received: 'DoWork:RINCON_949F3E19ED8201400_MR:pause:'
2017.01.10 20:42:45 5: SONOS0: ===Udo=== 1
2017.01.10 20:42:45 5: SONOS0: ===Udo=== 2
2017.01.10 20:42:45 5: SONOS0: ===Udo=== 3
2017.01.10 20:42:45 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.10 20:42:45 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2017.01.10 20:42:45 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.10 20:42:45 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.10 20:42:45 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.10 20:42:45 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3'
2017.01.10 20:42:45 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.10 20:42:45 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.10 20:42:45 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.10 20:42:45 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.10 20:42:45 4: SONOS7: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0x74767310)
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, attr, disable, 0) -> DEFAULT
2017.01.10 20:42:46 3: SONOS7: Event: Received Transport-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:46 4: SONOS7: Transport-Event: All correct with this service-call till now. UDN='uuid:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:46 4: SONOS7: Transport-Event: GroundURL: http://192.168.178.92:1400
2017.01.10 20:42:46 4: SONOS7: Transport-Event: LastChange: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/"><InstanceID val="0"><TransportState val="STOPPED"/><CurrentPlayMode val="NORMAL"/><CurrentCrossfadeMode val="0"/><NumberOfTracks val="2"/><CurrentTrack val="1"/><CurrentSection val="0"/><CurrentTrackURI val="x-rincon-mp3radio://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3"/><CurrentTrackDuration val="0:00:00"/><CurrentTrackMetaData val="<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s57730?sid=254&amp;flags=8224&amp;sn=0</res><r:streamContent></r:streamContent><r:radioShowMd>Club,p272960</r:radioShowMd><upnp:albumArtURI>/getaa?s=1&amp;u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s57730?sid=254&amp;flags=8224&amp;sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>"/><r:NextTrackURI val=""/><r:NextTrackMetaData val=""/><r:EnqueuedTransportURI val="x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0"/><r:EnqueuedTransportURIMetaData val="<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><dc:title>SWR3 Elchradio</dc:title><upnp:class>object.item.audioItem.audioBroadcast</upnp:class><desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/">SA_RINCON65031_</desc></item></DIDL-Lite>"/></InstanceID></Event>
2017.01.10 20:42:46 5: SONOS7: ___________________________________________________________________________
2017.01.10 20:42:46 5: SONOS7: OldTracks: 1
2017.01.10 20:42:46 5: SONOS7: NumTracks: 0
2017.01.10 20:42:46 5: SONOS7: OldTrackURIs: http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3
2017.01.10 20:42:46 5: SONOS7: OldTrackPositions: 0
2017.01.10 20:42:46 5: SONOS7: OldTrackDurations: 0
2017.01.10 20:42:46 5: SONOS7: OldTransportstate: PLAYING
2017.01.10 20:42:46 5: SONOS7: OldTimestamp: 1484076989.48735
2017.01.10 20:42:46 5: SONOS7: OldTitle: SWR3 Elchradio
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, QueueHash, ) -> a2739bcd14655d63a4c4ce17f2e4690d
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:46 5: SONOS7: ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
2017.01.10 20:42:46 4: SONOS7: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0x74767310)
2017.01.10 20:42:46 4: SONOS7: Transport-Event: CurrentTrackMetaData: <DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0</res><r:streamContent></r:streamContent><r:radioShowMd>Club,p272960</r:radioShowMd><upnp:albumArtURI>/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>
2017.01.10 20:42:46 4: SONOS7: Transport-Event: Stream erkannt!
2017.01.10 20:42:46 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:SWR3 Elchradio'
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderCurrent:Club'
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:Am Mikrofon: Stefanie Tï¿½cking'
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.10 20:42:46 4: SONOS7: Transport-Event: NextTrackMetaData:
2017.01.10 20:42:46 5: SONOS7: ___________________________________________________________________________
2017.01.10 20:42:46 5: SONOS7: OldTracks: 1
2017.01.10 20:42:46 5: SONOS7: NumTracks: 0
2017.01.10 20:42:46 5: SONOS7: OldTrackURIs: http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3
2017.01.10 20:42:46 5: SONOS7: OldTrackPositions: 0
2017.01.10 20:42:46 5: SONOS7: OldTrackDurations: 0
2017.01.10 20:42:46 5: SONOS7: OldTransportstate: STOPPED
2017.01.10 20:42:46 5: SONOS7: OldTimestamp: 1484076989.48735
2017.01.10 20:42:46 5: SONOS7: OldTitle: SWR3 Elchradio
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, QueueHash, ) -> a2739bcd14655d63a4c4ce17f2e4690d
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:46 5: SONOS7: ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(SONOS, reading, ZoneGroupState, ) -> <ZoneGroups><ZoneGroup Coordinator="RINCON_949F3E19ED8201400" ID="RINCON_949F3E19ED8201400:0"><ZoneGroupMember UUID="RINCON_949F3E19ED8201400" Location="http://192.168.178.92:1400/xml/device_description.xml" ZoneName="Arbeitszimmer" Icon="x-rincon-roomicon:office" Configuration="1" SoftwareVersion="34.7-35162c" MinCompatibleVersion="33.0-00000" LegacyCompatibleVersion="25.0-00000" BootSeq="2" WirelessMode="1" WirelessLeafOnly="0" HasConfiguredSSID="1" ChannelFreq="2462" BehindWifiExtender="0" WifiEnabled="1" Orientation="0" RoomCalibrationState="1" SecureRegState="2"/></ZoneGroup></ZoneGroups>
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, TransportState, -) -> STOPPED
2017.01.10 20:42:46 3: SONOS7: Event: End of Transport-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, presence, disappeared) -> appeared
2017.01.10 20:42:46 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.10 20:42:46 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, attr, disable, 0) -> DEFAULT
2017.01.10 20:42:46 3: SONOS7: Event: Received DeviceProperties-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:46 4: SONOS7: DeviceProperties-Event: All correct with this service-call till now. UDN='uuid:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:46 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, roomName, ) -> Arbeitszimmer
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, fieldType, ) ->
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, roomIcon, ) -> office
2017.01.10 20:42:46 3: SONOS7: Event: End of DeviceProperties-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:46 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, presence, disappeared) -> appeared
2017.01.10 20:42:47 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.10 20:42:47 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:['Sonos_Arbeitszimmer']'
2017.01.10 20:42:47 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:1'
2017.01.10 20:42:47 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:[]'
2017.01.10 20:42:47 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:0'
2017.01.10 20:42:47 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.10 20:42:47 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.10 20:42:47 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.10 20:42:47 5: SONOS0: ===Udo=== 999 Ende
2017.01.10 20:42:47 3: SONOS0: Connection accepted from localhost:40892
2017.01.10 20:42:47 5: SONOS0: Received: 'hello'
2017.01.10 20:42:47 5: SONOS0: Received: 'goaway'
2017.01.10 20:42:47 4: SONOS0: Got correct Answer from Subprocess...
2017.01.10 20:42:47 5: SONOS0: Received from UPnP-Server: 'DoWorkAnswer:RINCON_949F3E19ED8201400_MR:LastActionResult:Pause: Success!'
2017.01.10 20:42:47 4: SONOS0: DoWorkAnswer arrived for Sonos_Arbeitszimmer->LastActionResult: 'Pause: Success!'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:STOPPED'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.10 20:42:48 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.10 20:42:48 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.10 20:42:48 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:SWR3 Elchradio'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderCurrent:Club'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.10 20:42:48 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.10 20:42:48 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.10 20:42:48 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:[]'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:0'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:['Sonos_Arbeitszimmer']'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:1'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomName:Arbeitszimmer'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:saveRoomName:Arbeitszimmer'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomNameAlias:Arbeitszimmer'
2017.01.10 20:42:49 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomIcon:office'
2017.01.10 20:42:49 5: SONOS0: ===Udo=== 999 Ende
2017.01.10 20:42:50 5: SW: 446f576f726b3a52494e434f4e5f39343946334531394544383230313430305f4d523a706c61793a0d0a
2017.01.10 20:42:50 5: SONOS0: Received: 'DoWork:RINCON_949F3E19ED8201400_MR:play:'
2017.01.10 20:42:50 4: SONOS7: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0x74767310)
2017.01.10 20:42:50 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:50 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, attr, disable, 0) -> DEFAULT
2017.01.10 20:42:50 3: SONOS7: Event: Received Transport-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:50 4: SONOS7: Transport-Event: All correct with this service-call till now. UDN='uuid:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:50 4: SONOS7: Transport-Event: GroundURL: http://192.168.178.92:1400
2017.01.10 20:42:50 4: SONOS7: Transport-Event: LastChange: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/"><InstanceID val="0"><TransportState val="TRANSITIONING"/><CurrentPlayMode val="NORMAL"/><CurrentCrossfadeMode val="0"/><NumberOfTracks val="2"/><CurrentTrack val="1"/><CurrentSection val="0"/><CurrentTrackURI val="x-rincon-mp3radio://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3"/><CurrentTrackDuration val="0:00:00"/><CurrentTrackMetaData val="<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s57730?sid=254&amp;flags=8224&amp;sn=0</res><r:streamContent>ZPSTR_CONNECTING</r:streamContent><r:radioShowMd>Club,p272960</r:radioShowMd><upnp:albumArtURI>/getaa?s=1&amp;u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s57730?sid=254&amp;flags=8224&amp;sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>"/><r:NextTrackURI val=""/><r:NextTrackMetaData val=""/><r:EnqueuedTransportURI val="x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0"/><r:EnqueuedTransportURIMetaData val="<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><dc:title>SWR3 Elchradio</dc:title><upnp:class>object.item.audioItem.audioBroadcast</upnp:class><desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/">SA_RINCON65031_</desc></item></DIDL-Lite>"/></InstanceID></Event>
2017.01.10 20:42:50 5: SONOS7: ___________________________________________________________________________
2017.01.10 20:42:50 5: SONOS7: OldTracks: 1
2017.01.10 20:42:50 5: SONOS7: NumTracks: 0
2017.01.10 20:42:50 5: SONOS7: OldTrackURIs: http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3
2017.01.10 20:42:50 5: SONOS7: OldTrackPositions: 0
2017.01.10 20:42:50 5: SONOS7: OldTrackDurations: 0
2017.01.10 20:42:50 5: SONOS7: OldTransportstate: STOPPED
2017.01.10 20:42:50 5: SONOS7: OldTimestamp: 1484076989.48735
2017.01.10 20:42:50 5: SONOS7: OldTitle: SWR3 Elchradio
2017.01.10 20:42:50 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:50 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, QueueHash, ) -> a2739bcd14655d63a4c4ce17f2e4690d
2017.01.10 20:42:50 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:50 5: SONOS7: ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
2017.01.10 20:42:50 4: SONOS7: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0x74767310)
2017.01.10 20:42:51 4: SONOS7: Transport-Event: CurrentTrackMetaData: <DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0</res><r:streamContent>ZPSTR_CONNECTING</r:streamContent><r:radioShowMd>Club,p272960</r:radioShowMd><upnp:albumArtURI>/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>
2017.01.10 20:42:51 4: SONOS7: Transport-Event: Stream erkannt!
2017.01.10 20:42:51 4: SONOS7: Transport-Event: NextTrackMetaData:
2017.01.10 20:42:51 5: SONOS7: ___________________________________________________________________________
2017.01.10 20:42:51 5: SONOS7: OldTracks: 1
2017.01.10 20:42:51 5: SONOS7: NumTracks: 0
2017.01.10 20:42:51 5: SONOS7: OldTrackURIs: http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3
2017.01.10 20:42:51 5: SONOS7: OldTrackPositions: 0
2017.01.10 20:42:51 5: SONOS7: OldTrackDurations: 0
2017.01.10 20:42:51 5: SONOS7: OldTransportstate: PLAYING
2017.01.10 20:42:51 5: SONOS7: OldTimestamp: 1484076989.48735
2017.01.10 20:42:51 5: SONOS7: OldTitle: SWR3 Elchradio
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, QueueHash, ) -> a2739bcd14655d63a4c4ce17f2e4690d
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 5: SONOS7: ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(SONOS, reading, ZoneGroupState, ) -> <ZoneGroups><ZoneGroup Coordinator="RINCON_949F3E19ED8201400" ID="RINCON_949F3E19ED8201400:0"><ZoneGroupMember UUID="RINCON_949F3E19ED8201400" Location="http://192.168.178.92:1400/xml/device_description.xml" ZoneName="Arbeitszimmer" Icon="x-rincon-roomicon:office" Configuration="1" SoftwareVersion="34.7-35162c" MinCompatibleVersion="33.0-00000" LegacyCompatibleVersion="25.0-00000" BootSeq="2" WirelessMode="1" WirelessLeafOnly="0" HasConfiguredSSID="1" ChannelFreq="2462" BehindWifiExtender="0" WifiEnabled="1" Orientation="0" RoomCalibrationState="1" SecureRegState="2"/></ZoneGroup></ZoneGroups>
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, TransportState, -) -> PLAYING
2017.01.10 20:42:51 3: SONOS7: Event: End of Transport-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, presence, disappeared) -> appeared
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, attr, disable, 0) -> DEFAULT
2017.01.10 20:42:51 3: SONOS7: Event: Received Transport-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:51 4: SONOS7: Transport-Event: All correct with this service-call till now. UDN='uuid:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:51 4: SONOS7: Transport-Event: GroundURL: http://192.168.178.92:1400
2017.01.10 20:42:51 4: SONOS7: Transport-Event: LastChange: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/"><InstanceID val="0"><TransportState val="TRANSITIONING"/><CurrentPlayMode val="NORMAL"/><CurrentCrossfadeMode val="0"/><NumberOfTracks val="2"/><CurrentTrack val="1"/><CurrentSection val="0"/><CurrentTrackURI val="x-rincon-mp3radio://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3"/><CurrentTrackDuration val="0:00:00"/><CurrentTrackMetaData val="<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s57730?sid=254&amp;flags=8224&amp;sn=0</res><r:streamContent>ZPSTR_BUFFERING</r:streamContent><r:radioShowMd>Club,p272960</r:radioShowMd><upnp:albumArtURI>/getaa?s=1&amp;u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s57730?sid=254&amp;flags=8224&amp;sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>"/><r:NextTrackURI val=""/><r:NextTrackMetaData val=""/><r:EnqueuedTransportURI val="x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0"/><r:EnqueuedTransportURIMetaData val="<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><dc:title>SWR3 Elchradio</dc:title><upnp:class>object.item.audioItem.audioBroadcast</upnp:class><desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/">SA_RINCON65031_</desc></item></DIDL-Lite>"/></InstanceID></Event>
2017.01.10 20:42:51 5: SONOS7: ___________________________________________________________________________
2017.01.10 20:42:51 5: SONOS7: OldTracks: 1
2017.01.10 20:42:51 5: SONOS7: NumTracks: 0
2017.01.10 20:42:51 5: SONOS7: OldTrackURIs: http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3
2017.01.10 20:42:51 5: SONOS7: OldTrackPositions: 0
2017.01.10 20:42:51 5: SONOS7: OldTrackDurations: 0
2017.01.10 20:42:51 5: SONOS7: OldTransportstate: PLAYING
2017.01.10 20:42:51 5: SONOS7: OldTimestamp: 1484076989.48735
2017.01.10 20:42:51 5: SONOS7: OldTitle: SWR3 Elchradio
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, QueueHash, ) -> a2739bcd14655d63a4c4ce17f2e4690d
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 5: SONOS7: ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
2017.01.10 20:42:51 4: SONOS7: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0x74767310)
2017.01.10 20:42:51 4: SONOS7: Transport-Event: CurrentTrackMetaData: <DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0</res><r:streamContent>ZPSTR_BUFFERING</r:streamContent><r:radioShowMd>Club,p272960</r:radioShowMd><upnp:albumArtURI>/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>
2017.01.10 20:42:51 4: SONOS7: Transport-Event: Stream erkannt!
2017.01.10 20:42:51 4: SONOS7: Transport-Event: NextTrackMetaData:
2017.01.10 20:42:51 5: SONOS7: ___________________________________________________________________________
2017.01.10 20:42:51 5: SONOS7: OldTracks: 1
2017.01.10 20:42:51 5: SONOS7: NumTracks: 0
2017.01.10 20:42:51 5: SONOS7: OldTrackURIs: http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3
2017.01.10 20:42:51 5: SONOS7: OldTrackPositions: 0
2017.01.10 20:42:51 5: SONOS7: OldTrackDurations: 0
2017.01.10 20:42:51 5: SONOS7: OldTransportstate: PLAYING
2017.01.10 20:42:51 5: SONOS7: OldTimestamp: 1484076989.48735
2017.01.10 20:42:51 5: SONOS7: OldTitle: SWR3 Elchradio
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, QueueHash, ) -> a2739bcd14655d63a4c4ce17f2e4690d
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 5: SONOS7: ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(SONOS, reading, ZoneGroupState, ) -> <ZoneGroups><ZoneGroup Coordinator="RINCON_949F3E19ED8201400" ID="RINCON_949F3E19ED8201400:0"><ZoneGroupMember UUID="RINCON_949F3E19ED8201400" Location="http://192.168.178.92:1400/xml/device_description.xml" ZoneName="Arbeitszimmer" Icon="x-rincon-roomicon:office" Configuration="1" SoftwareVersion="34.7-35162c" MinCompatibleVersion="33.0-00000" LegacyCompatibleVersion="25.0-00000" BootSeq="2" WirelessMode="1" WirelessLeafOnly="0" HasConfiguredSSID="1" ChannelFreq="2462" BehindWifiExtender="0" WifiEnabled="1" Orientation="0" RoomCalibrationState="1" SecureRegState="2"/></ZoneGroup></ZoneGroups>
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, TransportState, -) -> PLAYING
2017.01.10 20:42:51 3: SONOS7: Event: End of Transport-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, presence, disappeared) -> appeared
2017.01.10 20:42:51 5: SONOS0: ===Udo=== 1
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, attr, disable, 0) -> DEFAULT
2017.01.10 20:42:51 3: SONOS7: Event: Received Transport-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:51 4: SONOS7: Transport-Event: All correct with this service-call till now. UDN='uuid:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:51 4: SONOS7: Transport-Event: GroundURL: http://192.168.178.92:1400
2017.01.10 20:42:51 4: SONOS7: Transport-Event: LastChange: <Event xmlns="urn:schemas-upnp-org:metadata-1-0/AVT/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/"><InstanceID val="0"><TransportState val="PLAYING"/><CurrentPlayMode val="NORMAL"/><CurrentCrossfadeMode val="0"/><NumberOfTracks val="2"/><CurrentTrack val="1"/><CurrentSection val="0"/><CurrentTrackURI val="x-rincon-mp3radio://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3"/><CurrentTrackDuration val="0:00:00"/><CurrentTrackMetaData val="<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s57730?sid=254&amp;flags=8224&amp;sn=0</res><r:streamContent>Am Mikrofon: Stefanie T�cking</r:streamContent><r:radioShowMd>Club,p272960</r:radioShowMd><upnp:albumArtURI>/getaa?s=1&amp;u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s57730?sid=254&amp;flags=8224&amp;sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>"/><r:NextTrackURI val=""/><r:NextTrackMetaData val=""/><r:EnqueuedTransportURI val="x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0"/><r:EnqueuedTransportURIMetaData val="<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><dc:title>SWR3 Elchradio</dc:title><upnp:class>object.item.audioItem.audioBroadcast</upnp:class><desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/">SA_RINCON65031_</desc></item></DIDL-Lite>"/></InstanceID></Event>
2017.01.10 20:42:51 5: SONOS7: ___________________________________________________________________________
2017.01.10 20:42:51 5: SONOS7: OldTracks: 1
2017.01.10 20:42:51 5: SONOS7: NumTracks: 0
2017.01.10 20:42:51 5: SONOS7: OldTrackURIs: http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3
2017.01.10 20:42:51 5: SONOS7: OldTrackPositions: 0
2017.01.10 20:42:51 5: SONOS7: OldTrackDurations: 0
2017.01.10 20:42:51 5: SONOS7: OldTransportstate: PLAYING
2017.01.10 20:42:51 5: SONOS7: OldTimestamp: 1484076989.48735
2017.01.10 20:42:51 5: SONOS7: OldTitle: SWR3 Elchradio
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, QueueHash, ) -> a2739bcd14655d63a4c4ce17f2e4690d
2017.01.10 20:42:51 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:51 5: SONOS0: ===Udo=== 2
2017.01.10 20:42:51 5: SONOS7: ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
2017.01.10 20:42:51 4: SONOS7: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0x74767310)
2017.01.10 20:42:51 5: SONOS0: ===Udo=== 3
2017.01.10 20:42:51 5: SONOS0: Received from UPnP-Server: 'DoWorkAnswer:RINCON_949F3E19ED8201400_MR:LastActionResult:Play: Success!'
2017.01.10 20:42:51 4: SONOS0: DoWorkAnswer arrived for Sonos_Arbeitszimmer->LastActionResult: 'Play: Success!'
2017.01.10 20:42:51 4: SONOS7: Transport-Event: CurrentTrackMetaData: <DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0</res><r:streamContent>Am Mikrofon: Stefanie T�cking</r:streamContent><r:radioShowMd>Club,p272960</r:radioShowMd><upnp:albumArtURI>/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s57730?sid=254&flags=8224&sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>
2017.01.10 20:42:51 4: SONOS7: Transport-Event: Stream erkannt!
2017.01.10 20:42:52 4: SONOS7: Transport-Event: NextTrackMetaData:
2017.01.10 20:42:52 5: SONOS7: ___________________________________________________________________________
2017.01.10 20:42:52 5: SONOS7: OldTracks: 1
2017.01.10 20:42:52 5: SONOS7: NumTracks: 0
2017.01.10 20:42:52 5: SONOS7: OldTrackURIs: http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3
2017.01.10 20:42:52 5: SONOS7: OldTrackPositions: 0
2017.01.10 20:42:52 5: SONOS7: OldTrackDurations: 0
2017.01.10 20:42:52 5: SONOS7: OldTransportstate: PLAYING
2017.01.10 20:42:52 5: SONOS7: OldTimestamp: 1484076989.48735
2017.01.10 20:42:52 5: SONOS7: OldTitle: SWR3 Elchradio
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, QueueHash, ) -> a2739bcd14655d63a4c4ce17f2e4690d
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:52 5: SONOS7: ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(SONOS, reading, ZoneGroupState, ) -> <ZoneGroups><ZoneGroup Coordinator="RINCON_949F3E19ED8201400" ID="RINCON_949F3E19ED8201400:0"><ZoneGroupMember UUID="RINCON_949F3E19ED8201400" Location="http://192.168.178.92:1400/xml/device_description.xml" ZoneName="Arbeitszimmer" Icon="x-rincon-roomicon:office" Configuration="1" SoftwareVersion="34.7-35162c" MinCompatibleVersion="33.0-00000" LegacyCompatibleVersion="25.0-00000" BootSeq="2" WirelessMode="1" WirelessLeafOnly="0" HasConfiguredSSID="1" ChannelFreq="2462" BehindWifiExtender="0" WifiEnabled="1" Orientation="0" RoomCalibrationState="1" SecureRegState="2"/></ZoneGroup></ZoneGroups>
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, TransportState, -) -> PLAYING
2017.01.10 20:42:52 3: SONOS7: Event: End of Transport-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, presence, disappeared) -> appeared
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, attr, disable, 0) -> DEFAULT
2017.01.10 20:42:52 3: SONOS7: Event: Received DeviceProperties-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:52 4: SONOS7: DeviceProperties-Event: All correct with this service-call till now. UDN='uuid:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, roomName, ) -> Arbeitszimmer
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, fieldType, ) ->
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, roomIcon, ) -> office
2017.01.10 20:42:52 3: SONOS7: Event: End of DeviceProperties-Event for Zone "Sonos_Arbeitszimmer".
2017.01.10 20:42:52 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, presence, disappeared) -> appeared
2017.01.10 20:42:53 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.10 20:42:53 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2017.01.10 20:42:53 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.10 20:42:53 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.10 20:42:53 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.10 20:42:53 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3'
2017.01.10 20:42:53 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.10 20:42:53 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.10 20:42:53 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.10 20:42:53 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.10 20:42:54 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:SWR3 Elchradio'
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderCurrent:Club'
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:Verbindung herstellen...'
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.10 20:42:54 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.10 20:42:54 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.10 20:42:54 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:55 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.10 20:42:55 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:['Sonos_Arbeitszimmer']'
2017.01.10 20:42:55 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:1'
2017.01.10 20:42:55 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:[]'
2017.01.10 20:42:55 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:0'
2017.01.10 20:42:55 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.10 20:42:55 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.10 20:42:55 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.10 20:42:56 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.10 20:42:56 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.10 20:42:56 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:SWR3 Elchradio'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderCurrent:Club'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:Wird gestartet...'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.10 20:42:56 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.10 20:42:56 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.10 20:42:56 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:42:57 4: SONOS8: IsAlive-Event UDN=RINCON_949F3E19ED8201400_MR
2017.01.10 20:42:57 4: SONOS8: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, reading, location, ) -> http://192.168.178.92:1400/xml/device_description.xml
2017.01.10 20:42:57 5: SONOS8: Location: http://192.168.178.92:1400/xml/device_description.xml
2017.01.10 20:42:57 5: SONOS8: PingType: syn
2017.01.10 20:42:57 4: SONOS8: 192.168.178.92 is alive
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:['Sonos_Arbeitszimmer']'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:1'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:[]'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:0'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.10 20:42:58 5: SONOS0: ===Udo=== 999 Ende
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:http://swr-mp3-m-swr3.akacast.akamaistream.net/7/720/137136/v1/gnl.akacast.akamaistream.net/swr-mp3-m-swr3'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.10 20:42:58 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.10 20:42:58 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.10 20:42:58 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as57730%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.10 20:42:59 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:SWR3 Elchradio'
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderCurrent:Club'
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:Am Mikrofon: Stefanie Tï¿½cking'
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.10 20:42:59 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.10 20:42:59 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.10 20:42:59 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:['Sonos_Arbeitszimmer']'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:1'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:[]'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:0'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomName:Arbeitszimmer'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:saveRoomName:Arbeitszimmer'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomNameAlias:Arbeitszimmer'
2017.01.10 20:43:01 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomIcon:office'
2017.01.10 20:43:01 5: SONOS0: ===Udo=== 999 Ende
2017.01.10 20:43:05 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, def, NAME, RINCON_949F3E19ED8201400_MR) -> Sonos_Arbeitszimmer
2017.01.10 20:43:05 4: SONOS7: SONOS_Client_Data_Retreive(RINCON_949F3E19ED8201400_MR, attr, disable, 0) -> DEFAULT
2017.01.10 20:

Reinerlein · 10 Januar 2017, 21:47:08

Hallo mrhaefele,

das scheint mir komisch,
aus dem Log geht eindeutig hervor, dass du um 20:42:45 das Pause-Kommando gesendet hast, und bereits um 20:42:46 kam die Antwort vom Player mit dem neuen Transportstate (in diesem Fall ein "STOPPED", da es sich um einen Radiostream gehandelt hat) das ist einigermaßen fix und normal...

Auch der folgende Play-Befehl wurde in unter einer Sekunde beantwortet. Da kam natürlich erstmal der Status "TRANSITIONING", der bedeutet, dass der Radiostream gerade gepuffert wird. Danach kam die Wiedergabemeldung nach insg. drei Sekunden, was auch ok ist...

Hatte der Player denn in der Realität nicht gleich angehalten bzw. gestartet?

Grüße
Reinerlein

mrhaefele@gmx.de · 10 Januar 2017, 22:08:15

Hallo,

leider nein. Bin mir absolut sicher.

Wenn ich mit einem Fhem Befehlt immer >30 Sekunden warte, dann setzt er den Befehl immer gleich um. Nur wenn ich mehrere Befehle absetzte und nur beispielsweise 3 Sekunden warte dazwischen, dann scheint es so, dass eine Queue (oder so was ähnliches) voll läuft und er erst mal warten muss. Also wenn ich den Player anschalte und dann die Lautstärke evrstellen möchte, dann dauert das ewig. Oder wenn ich anschalte und einen anderen Sender wähle, dann dauert es auch ewig. Nur wenn ich lediglich einen einzigen Befehl absetze, dann geht es schnell.

Was ich auch beobachte, ist, dass ein Kern auf meinem Raspberry3 mit 100% genau so lange ausgelastet ist, wie der Player schläft. Ich hänge mal ein Bild von einem htop Befehl an.

Was kann das sein?

Gruß

Reinerlein · 10 Januar 2017, 23:34:34

Hi,

also bei dem Top fällt mir spontan auf, dass es mehrere SubProzesse gibt (erkennbar an den Parametern für den Port usw.).
Das sollte nicht so sein. Davon sollte eigentlich nur einer laufen.

Setze mal das Attribut "disable" am Sonos-Device auf 1, beende die ganzen übrigen Prozesse mal, und lösche das Attribut wieder.
Danach sollte wieder einer (und auch nur einer) dieser Prozesse vorhanden sein...

Grüße
Reinerlein

Reinerlein · 11 Januar 2017, 00:22:20

Hi,

sehe gerade, dass das htop ist. Zeigt der die Threads als einzelne Prozesse an?

Dann wären ingesamt vier Sonos-Einträge mit der Portangabe im Aufruf normal:
1x SubProzess
3x Thread innerhalb dieses SubProzesses
Das ganze unabhängig von der Menge der Player, da die Threads auf verschiedene Jobs aufgeteilt sind...

Dann habe ich auf Anhieb auch keine Idee...

Grüße
Reiner

mrhaefele@gmx.de · 11 Januar 2017, 09:36:06

Hi,

macht es Sinn die Datei 00_SONOS.pm zu instrumentieren?

Er bleibt ja gemäß "apptime" hängen in der Funkltion Sonos_Read (00_SONOS.pm). Dort könnte ich in allen if/then/else-Zweigen der sub-Funktion Sonos_Read Log-Einträge erzeugen lassen, um zu sehen, wo er hängen bleibt. Macht das Sinn? Oder reichen die normalen Log Einträge schon?

Gruß

Reinerlein · 11 Januar 2017, 13:11:38

Hi,

ich lese bei dir in einem Satz gerade die Formulierung "wenn ich den Player anschalte und dann die Lautstärke verstellen möchte, dann dauert das ewig".

Meint Anschalten des Player: Er wird dann erst mit Strom versorgt?
Dann wäre es ja normal, da der ja eine Weile zum Hochfahren braucht. Wenn du meinst: Nach dem Anstarten eines Radiostreams: Dann wäre eine kurze Wartezeit (ein paar Sekunden) auch normal...

Das Problem ist, dass das Log normal aussieht, und dein Player scheinbar was anderes macht. Dein Zeitverhalten, welches du beschreibst, ist überhaupt nicht im Log wiederzufinden...

Grüße
Reinerlein

mrhaefele@gmx.de · 11 Januar 2017, 19:27:11

Hi,

ne, sorry. War zu flapsig formuliert von mir. Mit Einschalten meinte ich ein

Code Auswählen

set Sonos_Arbeitszimmer Play

Mit Ausschalten ein

Code Auswählen

set Sonos_Arbeitszimmer Pause
bzw.

Code Auswählen

set Sonos_Arbeitszimmer Stop
Zwischen "Pause" und "Stop" habe ich keinen Unterschied bemerkt. Beides gleich "schlecht"

Das seltsame ist, dass wenn ich mein Handy benutze (iphone 6) mit der Sonos App, dann geht alles innerhalb 1 Sekunde (maximal 2 Sekunden). Solch eine "Totzeit" von 10 bis 20 Sekunden, habe ich nie mit der Sonos app gehabt. Mit Fhem leider immer.

Zu meiner Frage von vorher: Bringt es etwas, wenn ich die Sonos_Read "instrumentiere, um herauszufinden, wo er hängt. Gibt es irgendwo einen Handshake zwischen der Sonos_Read Funkltion, bei dem Fhem hängenbleiben könnte?

Was ich auch nicht verstehe, ist die Info von vorher, dass der Player bereits den Transportstate nach ~1sec zurückmeldet und trotzdem still bleibt bzw die Aktion erst 10 Sekunden später auslöst am Player. Was passiert in der Sonos_Read hinter dieser Rückmeldung vom Player? Woran könnte sich Fhem diese 10 Sekunden "aufhängen". Es scheint nicht (nur) am Player zu liegen, sonst wäre FHEM vermutlich nicht für mehrere Sekunden auf 100% Auslastung im "htop". Irgendwo scheint ein dead lock zu sein. Gibt es in der Sonos_Read eine Stelle, wo fhem nach der Rückmeldung des Trasport states "steckenbleiben" könnte?

Gruß Udo

mrhaefele@gmx.de · 11 Januar 2017, 19:43:33

... noch was seltsames entdeckt...

Wenn ich anstatt dem Stop/Pause/Play Kommando das MuteT benutze, dann habe ich keinen delay und der Player geht nach einer bis maximal 3 Sekunden an bzw aus.
Was ist der Unterschied zwischen der Play/Pause kombination und dem MuteT Toggle Kommando?

Code Auswählen

set Sonos_Arbeitszimmer MuteT

Wenn ich aber zwischen 2 Radiosendern umschalte, dann habe ich trotzdem das problem. Also konkret, wenn ich ein

Code Auswählen


set Sonos_Arbeitszimmer StartFavourite /SWR3/

und dann ein

Code Auswählen


set Sonos_Arbeitszimmer StartFavourite /SWR1/

abschicke, dann habe ich auch ein Delay von 10-20 Sekunden....genau wie bei Play und Pause

Nur den MuteT Befehl scheint er zügig abzuarbeiten.

Gruß

mrhaefele@gmx.de · 11 Januar 2017, 22:10:25

....noch was sehr seltsames entdeckt.....

Ich schaffe es auch fhem für 10-20 Sekunden einzufrieren, indem ich NUR mein Handy mit der Sonos-App benutze und dann irgendetwas bediene. Also z.B. auf dem iPhone Pause drücke, Play drücke oder einen Sender einstelle.

==> Es ist also unabhängig, ob ich den Befehl in FHEM absetze mit beispielsweise

Code Auswählen

set Sonos_Arbeitszimmer Play oder ob ich mein iPhone benutze und die Play Taste drücke.

Ich habe folgende Test-Szenario reproduzierbar nachvollzogen
1.) fhem neustarten (um evtl andere Einflüsse auszuschliessen). Fehler lässt sich aber auch reproduzieren ohne fhem Neustart
2.) apptime starten
3.) Auf dem iPhone in der Sonos App auf Play (in diesem Fall wird ein Radio Stream gestartet. Geht aber genau so mit einem mp3 file)
4.) fhem friert ein für 10-20 Sekunden

Mit folgende Ergebnis in "apptime"

Code Auswählen


 name             function    max  count    total  average maxDly 
                               Sonos           SONOS_Read  11920      4    24578  6144.50      0 HASH(Sonos) 
      WEBtablet_192.168.178.58_44067            FW_Notify    800     41     4663   113.73      0 HASH(WEBtablet_192.168.178.58_44067); HASH(Sonos_Arbeitszimmer) 
      WEBtablet_192.168.178.62_36194            FW_Notify    800     56     4679    83.55      0 HASH(WEBtablet_192.168.178.62_36194); HASH(Sonos_Arbeitszimmer) 
      WEBtablet_192.168.178.58_44029            FW_Notify    798     56     4747    84.77      0 HASH(WEBtablet_192.168.178.58_44029); HASH(Sonos_Arbeitszimmer) 
                 Sonos_Arbeitszimmer      SONOSPLAYER_Set    797     24    18164   756.83      0 HASH(Sonos_Arbeitszimmer); Sonos_Arbeitszimmer; ? 
      WEBtablet_192.168.178.62_36193            FW_Notify    786     56     4672    83.43      0 HASH(WEBtablet_192.168.178.62_36193); HASH(Sonos_Arbeitszimmer) 
                              HMLAN1           HMLAN_Read    627     26     1876    72.15      0 HASH(HMLAN1) 
                         tmr-at_Exec      HASH(0xb9f7ea0)    617      2     1211   605.50   1472 HASH(at_UhrzeitECMDupdate) 
                              HMLAN2           HMLAN_Read    581     28      945    33.75      0 HASH(HMLAN2) 
                             ARDUINO            ECMD_Read    315      8      675    84.38      0 HASH(ARDUINO) 
                         UhrzeitECMD       ECMDDevice_Set    302     37     1095    29.59      0 HASH(UhrzeitECMD); UhrzeitECMD; on 
      WEBtablet_192.168.178.58_44067              FW_Read    259      8      474    59.25      0 HASH(WEBtablet_192.168.178.58_44067) 
             tmr-CUL_HM_respPendTout      respPend:31C9BC    183      3      188    62.67      4 respPend:31C9BC 
                   st_EG.FensterAlle     structure_Notify    106     56      204     3.64      0 HASH(st_EG.FensterAlle); HASH(EG.Bad.Fenster) 
                   tmr-SYSMON_Update      HASH(0x60066e0)    101      1      101   101.00   9968 HASH(sysmon_raspberrypi) 
      WEBtablet_192.168.178.58_44070              FW_Read     68      4      143    35.75      0 HASH(WEBtablet_192.168.178.58_44070) 
      WEBtablet_192.168.178.58_44071              FW_Read     65      7      151    21.57      0 HASH(WEBtablet_192.168.178.58_44071) 
                               TRX_0             TRX_Read     58      4       66    16.50      0 HASH(TRX_0) 
                           Statistik    statistics_Notify     56     56       56     1.00      0 HASH(Statistik); HASH(Nordwand) 
               st_EG.Bad.FensterAlle     structure_Notify     56     56       56     1.00      0 HASH(st_EG.Bad.FensterAlle); HASH(EG.Bad.Fenster) 
        st_EG.Wohnzimmer.FensterAlle     structure_Notify     56     56       56     1.00      0 HASH(st_EG.Wohnzimmer.FensterAlle);

Zusätzlich habe ich noch ein Print screen vom "htop" ==> siehe angehängtes Bild

Kann es sein, dass der Sonos Player irgendetwas macht bzw verschickt, was fhem bzw das SONOS Modul blockiert.

PS: Habe am Player ein Firmware Update gemacht, wie während der Inbetriebnahme gefordert. Gibt es irgendein "Handshake" im Sonos Modul, die der Sonos Modul blockieren kann. Ich habe mal die Daten des Sonos Players vom iPhone als print screen angehängt.

PS2: Sorry. Kann leider nicht selbst nachschauen, weil meine Programmierkenntnisse dafür nicht ausreichen.

Reinerlein · 11 Januar 2017, 23:35:08

Hi Udo,

hmm.. was wir auf jeden Fall auf Basis des htop sagen können, ist, dass es im Fhem-Teil des Moduls auftritt (das hat ja apptime schließlich auch nahegelegt).

Du könntest mal in der _Read in der ersten While-Schleife (dort, wo auf ein \n als letztes Zeichen geprüft wird) nach dem DevIo_SimpleRead ein

Code Auswählen


select(undef, undef, undef, 0.1);

einfügen.

Damit sollte zumindest die 100% CPU Last verhindert werden.
Aus irgendeinem Grunde scheint das letzte Zeichen niemals, bzw. sehr spät ein "\n" zu werden...
Man könnte das jetzt noch mal als Logausgabe einbauen (so, dass man auch etwaige Leerzeichen dahinter erkennen kann), vielleicht können wir daraus etwas ablesen...

Unter Umständen muss ich diese Mechanik auch einfach mal umbauen, so werden u.U. fertig gelieferte Aktualisierungen (die bereits mit einem \n abgeschlossen wurden, aber eben nicht als letztes Zeichen) erst später bearbeitet, wenn das letzte Zeichen mal irgendwann passt...
Aber erstmal hier die Erkenntnisse abschließen...

Danke schon mal...

Grüße
Reiner

mrhaefele@gmx.de · 12 Januar 2017, 00:14:18

Hi,

werd ich morgen probieren. Jetzt fallen mir die Augen zu

Muss morgen um 5 raus

Was ich gerade noch in den readings gesehen habe, ist, dass der "transportState" unmittelbar einem Befehl auf z.B. "PLAYING" geht (beim "set Sonos_Arbeitszimmer Play"). Du hast auch selbiges aus einem der Log files oben schon herausgelesen. Ein Reading das erst ~12sec danach gesetzt wird ist z.B. "currentSenderInfo" oder "infoSummarize1".
Evtl scheint er damit ein Problem zu bekommen.

ABER: Vielen Dank für deinen nächtlichen Einsatz und die Hilfe. Melde mich morgen Abend. Danke

Gruß Udo

Reinerlein · 12 Januar 2017, 00:26:18

Hi Udo,

das mit der currentSenderInfo (und als Folge davon dann auch infoSummarize) kann normal sein. Der Stream liefert nicht sofort alle Informationen, und aktualisiert dann während des Hörens, wie z.B auch bei einem Liedwechsel...

Wichtig ist immer der zeitliche Abstand zwischen einer Aktualisierung in der Sonos-App und Fhem. Idealerweise passieren diese nahezu gleichzeitig, da ja beide vom Player nahezu gleichzeitig getriggert werden...

Gute Nacht

Grüße
Reiner

mrhaefele@gmx.de · 12 Januar 2017, 00:42:00

doch noch probiert

folgenden Code habe ich geändert

Code Auswählen


	# Wenn noch nicht alles gekommen ist, dann hier auf den Rest warten...
	while (substr($buf, -1, 1) ne "\n") {
		my $newRead = DevIo_SimpleRead($hash);
		select(undef, undef, undef, 0.1);
		# Wenn hier gar nichts gekommen ist, dann diesen Aufruf beenden...

dann ein

Code Auswählen


reload 00_Sonos.pm

Leider selbes Verhalten. Die cpu geht wieder auf 100% im fhem.pl process (siehe oben). Was sich geändert hat. Er hat nun nicht mehr eine Pause zwischen dem Setzen des Trasport states und dem Abholen von "currentSenderInfo" oder "infoSummarize1". Diese Readings werden jetzt zum gleichen Zeitpunkt gesetzt.

Log file sieht so aus

Code Auswählen


2017.01.12 00:35:50 3: CUL_HM set GarageSw4 statusRequest
2017.01.12 00:35:51 3: CUL_HM set HM_2C90C3_Sw statusRequest
2017.01.12 00:35:52 3: CUL_HM set HM_Repeater statusRequest
2017.01.12 00:35:53 3: CUL_HM set OG.David.Licht_Btn_01 statusRequest
2017.01.12 00:35:54 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!
2017.01.12 00:35:54 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!
2017.01.12 00:35:54 3: CUL_HM set OG.David.Licht_Btn_02 statusRequest
2017.01.12 00:35:55 3: CUL_HM set OG.David.Licht_Sw_01 statusRequest
2017.01.12 00:35:56 3: Missing Ack bei Device: EG.Paul.Licht
2017.01.12 00:35:56 3: CUL_HM set OG.David.Licht_Sw_02 statusRequest
2017.01.12 00:35:57 5: SW: 446f576f726b3a52494e434f4e5f39343946334531394544383230313430305f4d523a706c61793a0d0a
2017.01.12 00:35:58 3: CUL_HM set OG.David.Stripe_Sw statusRequest
2017.01.12 00:35:58 5: SONOS0: ===Udo=== 1
2017.01.12 00:35:58 5: SONOS0: ===Udo=== 2
2017.01.12 00:35:58 5: SONOS0: ===Udo=== 3
2017.01.12 00:35:58 5: SONOS0: Received from UPnP-Server: 'DoWorkAnswer:RINCON_949F3E19ED8201400_MR:LastActionResult:Play: Success!'
2017.01.12 00:35:58 4: SONOS0: DoWorkAnswer arrived for Sonos_Arbeitszimmer->LastActionResult: 'Play: Success!'
2017.01.12 00:36:02 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.12 00:36:02 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2017.01.12 00:36:02 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.12 00:36:02 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.12 00:36:02 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.12 00:36:02 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:aac://stream.srg-ssr.ch/m/rsj/aacp_96'
2017.01.12 00:36:02 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.12 00:36:02 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.12 00:36:02 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.12 00:36:02 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.12 00:36:03 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.12 00:36:03 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.12 00:36:03 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:Radio Swiss Jazz'
2017.01.12 00:36:03 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.12 00:36:03 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:Verbindung herstellen...'
2017.01.12 00:36:03 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.12 00:36:03 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.12 00:36:03 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.12 00:36:03 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.12 00:36:03 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.12 00:36:03 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.12 00:36:03 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:1'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:[]'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:0'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:aac://stream.srg-ssr.ch/m/rsj/aacp_96'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.12 00:36:07 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.12 00:36:07 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.12 00:36:07 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.12 00:36:08 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.12 00:36:08 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.12 00:36:08 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:Radio Swiss Jazz'
2017.01.12 00:36:08 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.12 00:36:08 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:'
2017.01.12 00:36:08 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.12 00:36:08 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.12 00:36:08 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.12 00:36:08 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.12 00:36:08 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.12 00:36:08 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.12 00:36:08 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:1'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:[]'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:0'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomName:Arbeitszimmer'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:saveRoomName:Arbeitszimmer'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomNameAlias:Arbeitszimmer'
2017.01.12 00:36:12 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomIcon:office'
2017.01.12 00:36:12 5: SONOS0: ===Udo=== 999 Ende
2017.01.12 00:36:13 3: CUL_HM set RauchEGArbeit statusRequest
2017.01.12 00:36:13 2: WhatsApp: setting $HOME to /opt/fhem
2017.01.12 00:36:13 2: WhatsApp: starting yoswup-cli: /opt/yowsup-master/yowsup-cli demos -c /opt/yowsup-config/yowsup.config --yowsup
2017.01.12 00:36:13 3: Missing Ack bei Device: GarageLicht
2017.01.12 00:36:13 4: SONOS0: Got correct Answer from Subprocess...
2017.01.12 00:36:13 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!
2017.01.12 00:36:13 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!
2017.01.12 00:36:13 1: ARDUINO: unexpected answer TS:1TC:1276\r\nOK\r\n (\124\123\072\061\124\103\072\061\062\067\066\015\012\117\113\015\012) received (wrote bt00-36-13tte (\142\164\060\060\055\063\066\055\061\063\164\164\145), expected .*OK\r\n)
2017.01.12 00:36:14 5: SONOS0: ===Udo=== 1
2017.01.12 00:36:14 5: SONOS0: ===Udo=== 2
2017.01.12 00:36:14 5: SONOS0: ===Udo=== 3
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:aac://stream.srg-ssr.ch/m/rsj/aacp_96'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.12 00:36:15 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.12 00:36:15 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.12 00:36:15 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:Radio Swiss Jazz'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:Dunstan Coulber Quartet - Blues For Zain'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.12 00:36:15 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.12 00:36:15 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.12 00:36:15 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:1'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:[]'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:0'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:aac://stream.srg-ssr.ch/m/rsj/aacp_96'
2017.01.12 00:36:19 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.12 00:36:20 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.12 00:36:20 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.12 00:36:20 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:Radio Swiss Jazz'
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:Ruth Cameron - Willow Weep For Me'
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.12 00:36:20 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.12 00:36:20 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.12 00:36:20 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.12 00:36:24 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.12 00:36:24 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:24 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:1'
2017.01.12 00:36:24 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:[]'
2017.01.12 00:36:24 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:0'
2017.01.12 00:36:24 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:24 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.12 00:36:24 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.12 00:36:24 5: SONOS0: ===Udo=== 999 Ende
2017.01.12 00:36:25 3: CUL_HM set RauchEGGarage statusRequest
2017.01.12 00:36:25 3: WhatsApp: sending /L
2017.01.12 00:36:25 3: WhatsApp: sending /presence available
2017.01.12 00:36:25 3: WhatsApp: sending /presence name 'Haus-Automatisierung-Udo'
2017.01.12 00:36:26 5: SW: 446f576f726b3a52494e434f4e5f39343946334531394544383230313430305f4d523a70617573653a0d0a
2017.01.12 00:36:26 5: SONOS0: ===Udo=== 1
2017.01.12 00:36:26 5: SONOS0: ===Udo=== 2
2017.01.12 00:36:26 5: SONOS0: ===Udo=== 3
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:aac://stream.srg-ssr.ch/m/rsj/aacp_96'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.12 00:36:26 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.12 00:36:26 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.12 00:36:26 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:Radio Swiss Jazz'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:Ruth Cameron - Willow Weep For Me'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.12 00:36:26 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.12 00:36:26 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:1'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:[]'
2017.01.12 00:36:26 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:0'
2017.01.12 00:36:27 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:27 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.12 00:36:27 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.12 00:36:27 5: SONOS0: ===Udo=== 999 Ende
2017.01.12 00:36:27 3: CUL_HM set RauchEGPaul statusRequest
2017.01.12 00:36:27 5: SONOS0: ===Udo=== 1
2017.01.12 00:36:27 5: SONOS0: ===Udo=== 2
2017.01.12 00:36:27 5: SONOS0: ===Udo=== 3
2017.01.12 00:36:27 5: SONOS0: Received from UPnP-Server: 'DoWorkAnswer:RINCON_949F3E19ED8201400_MR:LastActionResult:Pause: Success!'
2017.01.12 00:36:27 4: SONOS0: DoWorkAnswer arrived for Sonos_Arbeitszimmer->LastActionResult: 'Pause: Success!'
2017.01.12 00:36:31 5: SONOS0: ===Udo=== 999 Ende
2017.01.12 00:36:31 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:32 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:32 3: CUL_HM set RauchEGWohnzimmer statusRequest
2017.01.12 00:36:32 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!
2017.01.12 00:36:32 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!
2017.01.12 00:36:32 5: SONOS0: ===Udo=== 1
2017.01.12 00:36:32 5: SONOS0: ===Udo=== 2
2017.01.12 00:36:32 5: SONOS0: ===Udo=== 3
2017.01.12 00:36:32 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_949F3E19ED8201400_MR:1'
2017.01.12 00:36:32 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:STOPPED'
2017.01.12 00:36:32 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2017.01.12 00:36:32 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:2'
2017.01.12 00:36:32 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2017.01.12 00:36:32 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:aac://stream.srg-ssr.ch/m/rsj/aacp_96'
2017.01.12 00:36:32 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2017.01.12 00:36:32 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:0:/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0:http://192.168.178.92:1400'
2017.01.12 00:36:32 4: SONOS0: Transport-Event: Bilder-Download: SONOS_DownloadReplaceIfChanged('http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif');
2017.01.12 00:36:32 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("http://192.168.178.92:1400/getaa?s=1&u=x-sonosapi-stream%3as6814%3fsid%3d254%26flags%3d8224%26sn%3d0", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif")
2017.01.12 00:36:33 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_AlbumArt.gif'!
2017.01.12 00:36:33 5: SONOS0: Received from UPnP-Server: 'SetCurrent:StreamAudio:1'
2017.01.12 00:36:33 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Sender:Radio Swiss Jazz'
2017.01.12 00:36:33 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackProvider:Radio'
2017.01.12 00:36:33 5: SONOS0: Received from UPnP-Server: 'SetCurrent:SenderInfo:'
2017.01.12 00:36:33 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2017.01.12 00:36:33 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackProvider:'
2017.01.12 00:36:33 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_949F3E19ED8201400_MR:1::http://192.168.178.92:1400'
2017.01.12 00:36:33 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./FHEM/lib/UPnP/sonos_empty.jpg', './www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png');
2017.01.12 00:36:33 5: SONOS0: Call of SONOS_DownloadReplaceIfChanged("./FHEM/lib/UPnP/sonos_empty.jpg", "./www/images/default/SONOSPLAYER/Sonos_Arbeitszimmer_NextAlbumArt.png")
2017.01.12 00:36:33 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackPosition:0:00:00'
2017.01.12 00:36:33 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_949F3E19ED8201400_MR'
2017.01.12 00:36:37 5: SONOS0: Received from UPnP-Server: 'ReadingsBeginUpdate:undef'
2017.01.12 00:36:37 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlaying:[]'
2017.01.12 00:36:37 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerPlayingCount:0'
2017.01.12 00:36:37 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlaying:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:37 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerNotPlayingCount:1'
2017.01.12 00:36:37 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayer:['Sonos_Arbeitszimmer']'
2017.01.12 00:36:37 5: SONOS0: Received from UPnP-Server: 'ReadingsBulkUpdateIfChanged:undef:MasterPlayerCount:1'
2017.01.12 00:36:37 5: SONOS0: Received from UPnP-Server: 'ReadingsEndUpdate:undef'
2017.01.12 00:36:38 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomName:Arbeitszimmer'
2017.01.12 00:36:38 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:saveRoomName:Arbeitszimmer'
2017.01.12 00:36:38 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomNameAlias:Arbeitszimmer'
2017.01.12 00:36:38 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_949F3E19ED8201400_MR:roomIcon:office'
2017.01.12 00:36:38 5: SONOS0: ===Udo=== 999 Ende
2017.01.12 00:36:38 3: CUL_HM set RauchELWSchlaf statusRequest
2017.01.12 00:36:38 3: WhatsApp: sending /disconnect
2017.01.12 00:36:38 3: WhatsApp: Disconnected
2017.01.12 00:36:38 3: WhatsApp: read: error during sysread: Keine Kind-Prozesse
2017.01.12 00:36:38 3: WhatsApp: read: end of file reached while sysread
2017.01.12 00:36:40 3: CUL_HM set RauchELWWohn statusRequest
2017.01.12 00:36:40 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:40 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:41 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:41 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:42 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:42 3: CUL_HM set RauchELWvorHeizraum statusRequest
2017.01.12 00:36:42 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:42 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:43 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:43 3: CUL_HM set RauchOGArbeitTilde statusRequest
2017.01.12 00:36:44 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:44 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:45 4: SONOS0: Got correct Answer from Subprocess...
2017.01.12 00:36:45 3: CUL_HM set RauchOGArbeitUdo statusRequest
2017.01.12 00:36:45 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:46 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:46 3: CUL_HM set RauchOGDavid statusRequest
2017.01.12 00:36:47 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:47 3: CUL_HM set RauchOGSchlaf statusRequest
2017.01.12 00:36:47 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!
2017.01.12 00:36:47 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!
2017.01.12 00:36:48 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:48 3: CUL_HM set RauchOGTreppenhaus statusRequest
2017.01.12 00:36:48 2: WhatsApp: setting $HOME to /opt/fhem
2017.01.12 00:36:48 2: WhatsApp: starting yoswup-cli: /opt/yowsup-master/yowsup-cli demos -c /opt/yowsup-config/yowsup.config --yowsup
2017.01.12 00:36:49 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:49 3: act_on_Rauchmelder_Team_off return value: warning: <div><div><font size="+2"><b><u>Rauchmelder:</u></b></font></div><div><font size="+2" color="red">0</font></div><div>&nbsp;</div><div><font size="+2"><b><u>ActionDetector:</u></b></font></div><div><font size="+1">Status DavidHzgFenster: unknown</font></div><div><font size="+1">Status EG.Haustuer.Lichtschalter: unknown</font></div><div><font size="+1">Status GarageTorEos: unknown</font></div><div><font size="+1">Status Keller: unknown</font></div><div><font size="+1">Status Nordwand: unknown</font></div><div><font size="+1">Status OG.Bad.Fenster: unknown</font></div><div><font size="+1">Status WasserEGKueche: unknown</font></div><div><font size="+1">Status WasserEGWasch: unknown</font></div><div><font size="+1">Status WasserELW: unknown</font></div><div>&nbsp;</div></div>
2017.01.12 00:36:49 3: CUL_HM set HaustuerBuzzer statusRequest
2017.01.12 00:36:50 3: WhatsApp: sending /L
2017.01.12 00:36:50 3: WhatsApp: sending /presence available
2017.01.12 00:36:50 3: WhatsApp: sending /presence name 'Haus-Automatisierung-Udo'
2017.01.12 00:36:50 3: CUL_HM set UG.Schaltschrank.Switch_Sw_01 statusRequest
2017.01.12 00:36:51 3: CUL_HM set UG.Schaltschrank.Switch_Sw_02 statusRequest
2017.01.12 00:36:52 3: WhatsApp: sending /disconnect
2017.01.12 00:36:52 3: WhatsApp: Disconnected
2017.01.12 00:36:52 3: WhatsApp: read: error during sysread: Keine Kind-Prozesse
2017.01.12 00:36:52 3: WhatsApp: read: end of file reached while sysread
2017.01.12 00:36:53 3: CUL_HM set UG.Schaltschrank.Switch_Sw_03 statusRequest
2017.01.12 00:36:54 3: CUL_HM set UG.Schaltschrank.Switch_Sw_04 statusRequest
2017.01.12 00:36:55 3: CUL_HM set PlatscherPumpe statusRequest
2017.01.12 00:36:56 3: Missing Ack bei Device: OG.David.Licht
2017.01.12 00:36:56 3: CUL_HM set PlatscherLicht statusRequest
2017.01.12 00:37:00 3: CUL_HM set EG.Paul.TuerBalkon getConfig
2017.01.12 00:37:02 2: WhatsApp: setting $HOME to /opt/fhem
2017.01.12 00:37:02 2: WhatsApp: starting yoswup-cli: /opt/yowsup-master/yowsup-cli demos -c /opt/yowsup-config/yowsup.config --yowsup
2017.01.12 00:37:02 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!
2017.01.12 00:37:02 3: AMAD (AMADCommBridge) - GetUpdate, Please set AMADCommBridge fhemServerIP <IP-FHEM> NOW!

Bin mir nicht sicher, ob ich deinen Punkt oben verstanden habe:

ZitatWichtig ist immer der zeitliche Abstand zwischen einer Aktualisierung in der Sonos-App und Fhem

Wenn ich am iPhone auf "Play" drücken in der Sonos App, dann friert fhem ein und ich sehe die Aktualisierung in den Readings nicht bzw 20 sec später

Grüße

mrhaefele@gmx.de · 17 Januar 2017, 11:29:00

Hallo Reiner,
Hast du noch eine Idee für mich?
Gruß Udo

Gesendet von iPhone mit Tapatalk