Sonos Play1 soll TV-Sound abspielen und ggf Rückmeldung

Begonnen von aherby, 07 November 2014, 22:14:51

Vorheriges Thema - Nächstes Thema

rapster

Hi Reinerlein,

list Sonos_Bad (Gruppiert mit Playbar auf Channel TV/SPDIF:
Internals:
   CFGFN      ./FHEM/sonos.cfg
   CHANGED
   DEF        RINCON_000E58C74E4801400_MR
   NAME       Sonos_Bad
   NR         352
   STATE      PLAYING =>  'Gruppenwiedergabe' vom Album 'Kueche'
   TYPE       SONOSPLAYER
   UDN        RINCON_000E58C74E4801400_MR
   Readings:
     2014-11-17 00:42:47   AlarmRunning    0
     2014-11-17 15:00:58   AlarmRunningID
     2014-11-17 00:42:45   Balance         0
     2014-11-17 00:42:48   Bass            -1
     2014-11-17 07:37:29   CrossfadeMode   0
     2014-11-17 00:42:48   DailyIndexRefreshTime 04:00:00
     2014-11-17 00:42:47   HeadphoneConnected 0
     2014-11-17 00:42:48   Loudness        1
     2014-11-17 00:42:47   Mute            0
     2014-11-17 07:37:29   Repeat          0
     2014-11-17 07:37:29   Shuffle         0
     2014-11-17 00:42:47   SleepTimer      off
     2014-11-17 00:55:44   SleepTimerVersion 0
     2014-11-17 00:42:48   Treble          1
     2014-11-17 08:05:06   Volume          8
     2014-11-17 15:19:40   ZoneGroupID     RINCON_000E58B7AF1401400:__
     2014-11-17 15:19:40   ZonePlayerUUIDsInGroup RINCON_000E58B7AF1401400,RINCON_000E58C74E4801400
     2014-11-17 15:19:40   currentAlbum    Kueche
     2014-11-17 15:19:40   currentAlbumArtURI ./www/images/default/SONOSPLAYER/Sonos_Bad_AlbumArt.png
     2014-11-17 15:19:40   currentAlbumArtist PLAYING
     2014-11-17 15:00:58   currentArtist
     2014-11-17 15:19:40   currentNormalAudio 1
     2014-11-17 15:00:58   currentOriginalTrackNumber
     2014-11-17 15:19:40   currentSender
     2014-11-17 15:00:58   currentSenderCurrent
     2014-11-17 15:00:58   currentSenderInfo
     2014-11-17 15:19:40   currentStreamAudio
     2014-11-17 15:19:40   currentTitle    Gruppenwiedergabe
     2014-11-17 07:37:29   currentTrack    1
     2014-11-17 15:19:40   currentTrackDuration
     2014-11-17 15:19:40   currentTrackURI x-rincon:RINCON_000E58B7AF1401400
     2014-11-17 15:00:56   fieldType
     2014-11-17 15:19:40   infoSummarize1   'Gruppenwiedergabe' vom Album 'Kueche'
     2014-11-17 15:19:40   infoSummarize2  PLAYING =>  'Gruppenwiedergabe' vom Album 'Kueche'
     2014-11-17 08:05:06   infoSummarize3  Lautstaerke: 8 ~ Ton An ~ Balance: Mitte ~ Kein Kopfhoerer
     2014-11-17 15:00:58   infoSummarize4
     2014-11-17 00:42:45   location        http://192.168.1.150:1400/xml/device_description.xml
     2014-11-17 15:00:58   nextAlbum
     2014-11-17 07:37:29   nextAlbumArtURI ./www/images/default/SONOSPLAYER/Sonos_Bad_NextAlbumArt.png
     2014-11-17 15:00:58   nextAlbumArtist
     2014-11-17 15:00:58   nextArtist
     2014-11-17 15:00:58   nextOriginalTrackNumber
     2014-11-17 15:00:58   nextTitle
     2014-11-17 15:00:58   nextTrackDuration
     2014-11-17 15:19:40   nextTrackURI
     2014-11-17 15:19:40   numberOfTracks  1
     2014-11-17 00:42:45   playerType      S1
     2014-11-17 15:00:56   presence        appeared
     2014-11-17 00:42:48   roomIcon        bathroom
     2014-11-17 00:42:45   roomName        Bad
     2014-11-17 00:42:45   saveRoomName    Bad
     2014-11-17 00:42:45   serialNum       00-0E-58-C7-4E-48:C
     2014-11-17 00:42:45   softwareRevision 5.2
     2014-11-17 15:19:40   state           PLAYING =>  'Gruppenwiedergabe' vom Album 'Kueche'
     2014-11-17 15:19:40   transportState  PLAYING
Attributes:
   generateInfoSummarize1 <NormalAudio><Artist prefix="(" suffix=")"/><Title prefix=" '" suffix="'" ifempty="[Keine Musikdatei]"/><Album prefix=" vom Album '" suffix="'"/></NormalAudio> <StreamAudio><Sender suffix=":"/><SenderCurrent prefix=" '" suffix="' -"/><SenderInfo prefix=" "/></StreamAudio>
   generateInfoSummarize2 <TransportState/><InfoSummarize1 prefix=" => "/>
   generateInfoSummarize3 <Volume prefix="Lautstaerke: "/><Mute instead=" ~ Kein Ton" ifempty=" ~ Ton An" emptyval="0"/> ~ Balance: <Balance ifempty="Mitte" emptyval="0"/><HeadphoneConnected instead=" ~ Kopfhoerer aktiv" ifempty=" ~ Kein Kopfhoerer" emptyval="0"/>
   getAlarms  1
   group      Bad
   icon       icoSONOSPLAYER_icon-S1.png
   minVolume  0
   model      Sonos_S1
   room       Sonos
   stateVariable InfoSummarize2
   webCmd     Play:Pause:Previous:Next:VolumeD:VolumeU:MuteT


list Sonos_Kueche (Playbar im Eingang SPDIF):
Internals:
   CFGFN      ./FHEM/sonos.cfg
   DEF        RINCON_000E58B7AF1401400_MR
   NAME       Sonos_Kueche
   NR         346
   STATE      PLAYING =>  'SPDIF-Wiedergabe' vom Album 'Kueche'
   TYPE       SONOSPLAYER
   UDN        RINCON_000E58B7AF1401400_MR
   Readings:
     2014-11-17 00:42:48   AlarmRunning    0
     2014-11-17 15:00:56   AlarmRunningID
     2014-11-17 00:42:47   Balance         0
     2014-11-17 00:42:48   Bass            1
     2014-11-17 00:42:48   CrossfadeMode   0
     2014-11-17 00:42:48   DailyIndexRefreshTime 04:00:00
     2014-11-17 00:42:48   HeadphoneConnected 0
     2014-11-17 00:42:48   Loudness        1
     2014-11-17 02:39:21   Mute            0
     2014-11-17 00:42:48   Repeat          0
     2014-11-17 00:42:48   Shuffle         0
     2014-11-17 00:42:48   SleepTimer      off
     2014-11-17 00:55:45   SleepTimerVersion 0
     2014-11-17 00:42:48   Treble          0
     2014-11-17 02:28:45   Volume          13
     2014-11-17 10:40:28   ZoneGroupID     RINCON_000E58B7AF1401400:__
     2014-11-17 15:19:40   ZoneGroupName   Kueche + 1
     2014-11-17 15:19:40   ZonePlayerUUIDsInGroup RINCON_000E58B7AF1401400,RINCON_000E58C74E4801400
     2014-11-17 15:18:08   currentAlbum    Kueche
     2014-11-17 01:02:53   currentAlbumArtURI ./www/images/default/SONOSPLAYER/Sonos_Kueche_AlbumArt.png
     2014-11-17 15:18:08   currentAlbumArtist PLAYING
     2014-11-17 15:18:08   currentArtist
     2014-11-17 00:42:48   currentNormalAudio 1
     2014-11-17 15:00:56   currentOriginalTrackNumber
     2014-11-17 15:00:56   currentSender
     2014-11-17 15:00:56   currentSenderCurrent
     2014-11-17 15:00:56   currentSenderInfo
     2014-11-17 15:00:56   currentStreamAudio
     2014-11-17 15:18:08   currentTitle    SPDIF-Wiedergabe
     2014-11-17 00:42:48   currentTrack    1
     2014-11-17 15:18:08   currentTrackDuration
     2014-11-17 15:18:08   currentTrackURI x-sonos-htastream:RINCON_000E58B7AF1401400:spdif
     2014-11-17 15:00:55   fieldType
     2014-11-17 15:18:08   infoSummarize1   'SPDIF-Wiedergabe' vom Album 'Kueche'
     2014-11-17 15:18:08   infoSummarize2  PLAYING =>  'SPDIF-Wiedergabe' vom Album 'Kueche'
     2014-11-17 02:39:21   infoSummarize3  Lautstaerke: 13 ~ Ton An ~ Balance: Mitte ~ Kein Kopfhoerer
     2014-11-17 15:00:56   infoSummarize4
     2014-11-17 00:42:47   location        http://192.168.1.149:1400/xml/device_description.xml
     2014-11-17 15:00:56   nextAlbum
     2014-11-17 01:02:53   nextAlbumArtURI ./www/images/default/SONOSPLAYER/Sonos_Kueche_NextAlbumArt.png
     2014-11-17 15:00:56   nextAlbumArtist
     2014-11-17 15:00:56   nextArtist
     2014-11-17 15:00:56   nextOriginalTrackNumber
     2014-11-17 15:00:56   nextTitle
     2014-11-17 15:00:56   nextTrackDuration
     2014-11-17 15:00:56   nextTrackURI
     2014-11-17 01:02:53   numberOfTracks  1
     2014-11-17 00:42:47   playerType      S9
     2014-11-17 15:00:55   presence        appeared
     2014-11-17 00:42:48   roomIcon        kitchen
     2014-11-17 00:42:47   roomName        Kueche
     2014-11-17 00:42:47   saveRoomName    Kueche
     2014-11-17 00:42:47   serialNum       00-0E-58-B7-AF-14:7
     2014-11-17 00:42:47   softwareRevision 5.2
     2014-11-17 15:18:08   state           PLAYING =>  'SPDIF-Wiedergabe' vom Album 'Kueche'
     2014-11-17 15:18:08   transportState  PLAYING
Attributes:
   generateInfoSummarize1 <NormalAudio><Artist prefix="(" suffix=")"/><Title prefix=" '" suffix="'" ifempty="[Keine Musikdatei]"/><Album prefix=" vom Album '" suffix="'"/></NormalAudio> <StreamAudio><Sender suffix=":"/><SenderCurrent prefix=" '" suffix="' -"/><SenderInfo prefix=" "/></StreamAudio>
   generateInfoSummarize2 <TransportState/><InfoSummarize1 prefix=" => "/>
   generateInfoSummarize3 <Volume prefix="Lautstaerke: "/><Mute instead=" ~ Kein Ton" ifempty=" ~ Ton An" emptyval="0"/> ~ Balance: <Balance ifempty="Mitte" emptyval="0"/><HeadphoneConnected instead=" ~ Kopfhoerer aktiv" ifempty=" ~ Kein Kopfhoerer" emptyval="0"/>
   getAlarms  1
   group      Kueche
   icon       icoSONOSPLAYER_icon-S9.png
   minVolume  0
   model      Sonos_S9
   room       Sonos
   stateVariable InfoSummarize2
   webCmd     Play:Pause:Previous:Next:VolumeD:VolumeU:MuteT


Bin grad nicht zuhause, d.H. der Eingang TV/SPDIF ist zwar gewählt, der Fernseher spielt allerdings grad nichts ab (denke sollte aber an den Readings nicht ändern?)
Ansonsten kann ich heute Abend gerne nochmal nachschauen.

Und Catching Fire wird jetzt auch sauber abgespielt, Danke Dir!  ;D

Reinerlein

Hi Claudiu,

das sieht (leider) alles so aus, wie ich es erwarten würde.

Kannst du mal den LogLevel des Sonos-Moduls (am Sonos-Device) auf 5 stellen, und die Konsolenausgabe posten, die du erhältst, wenn du folgendes bei nicht gruppierten Playern ausführst:

set Sonos_Bad PlayURI Sonos_Kueche

Es ist dabei egal, was die Playbar gerade macht, das sollte immer gehen (Man kann ja den TV-Ton woanders hören, auch wenn die Playbar still ist oder was anderes wiedergibt :-)
Ich interessiere mich für etwaige Fehlermeldungen nach Ausführung der obigen Anweisung. Irgendwas muss ihn stören, und ich weiss noch nicht was...

Vielen Dank schon mal für deine Unterstützung...

Grüße
Reinerlein

rapster

#17
Hi Reinerlein,

ich probiere das später sobald ich zuhause bin, allerdings falls ich dich richtig verstanden habe ist das so nicht richtig.
Auf anderen Playern lässt sich der SPDIF (TV) Eingang der Playbar nur durch eine Gruppe abspielen, und auch nur wenn die Playbar gerade ebenfalls den SPDIF abspielt.

Wenn ich der TV-Gruppe anschließend die Playbar wegnehme, verschwindet auch der TV-Eingang am zweiten Player und er schaltet auf [keine Musikdatei].

Zumindest ist das so mit dem Sonos-Controller  ;)

Gruß Claudiu

Reinerlein

Hi Claudiu,

ok, wieder was gelernt :) Ich kenne das Ding ja nur theoretisch. Aber genau das kann das Problem sein.
Bei normalen AV-Eingängen kann man das ja einfach beliebig wiedergeben.

Wenn das mit dem SPDIF auf diese Weise nicht gehen sollte, dann muss man wahrscheinlich eine Sequenz ausführen (oder zumindest sicherstellen, dass die Playbar gerade TV wiedergibt):
1. Playbar auf SPDIF schalten
2. Gruppe mit Playbar bilden

Ginge auch, das müssen wir jetzt nur feststellen, dann kann ich diesen Schritt automatisieren...

Nur um sicherzugehen:
Du hast also nicht in dem Original-Controller einen Eingang unter der Eingänge-Auflistung, der deinem TV entspricht, und den du einfach wiedergeben kannst? Dort tauchen nur die "normalen" Audio-Eingänge der anderen Player auf?

Danke schon mal...

Grüße
Reinerlein

P.S.: Nicht falsch verstehen, ich glaube dir, aber auch nicht jeder Anwender hat sein Sonos schon genauestens untersucht :-)

rapster

Jup genau dieses Vorgehen ist richtig (1. Playbar auf SPDIF schalten, 2. Gruppe mit Playbar bilden)
Allerdings, wenn die Playbar mit einem anderen Player gruppiert ist (auf anderem Input), hat die Gruppe einen TV-Eingang zu Auswahl.

Nein, auf dem 2. Player habe ich keinen TV-Eingang.

Kein Thema, habs vorhin auch erst nochmal am Controller geprüft bevor ichs geschrieben hab, weil ich mir selber nicht mehr sicher war  ;D

Gruß Claudiu

rapster

So mal die Logs nach Absenden des Befehls "set Sonos_Bad PlayURI Sonos_Kueche" mit verbose 5.


stdout:
2014.11.17 17:34:48 5: SONOS0: Received: 'DoWork:RINCON_000E58C74E4801400_MR:playURI:x-sonos-htastream:RINCON_000E58B7AF1401400:spdif'
2014.11.17 17:34:48 4: SONOS1: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0x7f7e8c5aa4b0)
2014.11.17 17:34:48 4: SONOS1: SONOS_Client_Data_Retreive(SONOS, reading, UserID_Spotify, -) -> SA_RINCON2311_X_%23Svc2311-0-Token
2014.11.17 17:34:48 4: SONOS1: SONOS_Client_Data_Retreive(SONOS, reading, UserID_Napster, -) -> DEFAULT
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
2014.11.17 17:34:48 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, def, NAME, RINCON_000E58C74E4801400_MR) -> Sonos_Bad
2014.11.17 17:34:48 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, attr, disable, 0) -> DEFAULT
2014.11.17 17:34:48 3: SONOS1: Event: Received Transport-Event for Zone "Sonos_Bad".
2014.11.17 17:34:48 4: SONOS1: Transport-Event: All correct with this service-call till now. UDN='uuid:RINCON_000E58C74E4801400_MR'
2014.11.17 17:34:48 4: SONOS1: Transport-Event: GroundURL: http://192.168.1.150:1400
2014.11.17 17:34:48 4: SONOS1: 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="0"/><CurrentTrack val="0"/><CurrentSection val="0"/><CurrentTrackURI val=""/><CurrentTrackDuration val="0:00:00"/><CurrentTrackMetaData val=""/><r:NextTrackURI val=""/><r:NextTrackMetaData val=""/><r:EnqueuedTransportURI val=""/><r:EnqueuedTransportURIMetaData val=""/></InstanceID></Event>
2014.11.17 17:34:48 4: SONOS1: Transport-Event: CurrentTrackMetaData:
2014.11.17 17:34:48 4: SONOS1: Transport-Event: Normal erkannt!
2014.11.17 17:34:48 4: SONOS1: Transport-Event: NextTrackMetaData:
2014.11.17 17:34:48 3: SONOS1: Event: End of Transport-Event for Zone "Sonos_Bad".



fhem.log
2014.11.17 17:34:48.081 5: SW: 446f576f726b3a52494e434f4e5f30303045353843373445343830313430305f4d523a706c61795552493a782d736f6e6f732d68746173747265616d3a52494e434f4e5f30303045353842374146313430313430303a73706469660d0a
2014.11.17 17:34:48.883 5: SONOS0: Received from UPnP-Server: 'DoWorkAnswer:RINCON_000E58C74E4801400_MR:LastActionResult:PlayURI: Error!'
2014.11.17 17:34:48.883 4: SONOS0: DoWorkAnswer arrived for Sonos_Bad->LastActionResult: 'PlayURI: Error!'
2014.11.17 17:34:48.885 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_000E58C74E4801400_MR:1'
2014.11.17 17:34:48.885 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:STOPPED'
2014.11.17 17:34:48.886 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2014.11.17 17:34:48.886 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:0'
2014.11.17 17:34:48.886 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:0'
2014.11.17 17:34:48.886 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:'
2014.11.17 17:34:48.886 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:0:00:00'
2014.11.17 17:34:48.886 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_000E58C74E4801400_MR:0::http://192.168.1.150:1400'
2014.11.17 17:34:48.886 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./www/images/default/fhemicon.png', './www/images/default/SONOSPLAYER/Sonos_Bad_AlbumArt.png');
2014.11.17 17:34:48.887 4: SONOS0: Couldn't retrieve file "./www/images/default/fhemicon.png" via web. Trying to copy directly...
2014.11.17 17:34:48.887 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Bad_AlbumArt.png'!
2014.11.17 17:34:48.887 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NormalAudio:1'
2014.11.17 17:34:48.888 5: SONOS0: Received from UPnP-Server: 'SetCurrent:AlbumArtist:STOPPED'
2014.11.17 17:34:48.888 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2014.11.17 17:34:48.888 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_000E58C74E4801400_MR:1::http://192.168.1.150:1400'
2014.11.17 17:34:48.888 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./www/images/default/fhemicon.png', './www/images/default/SONOSPLAYER/Sonos_Bad_NextAlbumArt.png');
2014.11.17 17:34:48.889 4: SONOS0: Couldn't retrieve file "./www/images/default/fhemicon.png" via web. Trying to copy directly...
2014.11.17 17:34:48.889 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Bad_NextAlbumArt.png'!
2014.11.17 17:34:48.889 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_000E58C74E4801400_MR'



Und hier noch die Logs wenn ich den SPDIF über den Sonos Controller gruppiere.

stdout
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, def, NAME, RINCON_000E58C74E4801400_MR) -> Sonos_Bad
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, attr, disable, 0) -> DEFAULT
2014.11.17 17:36:20 3: SONOS1: Event: Received Transport-Event for Zone "Sonos_Bad".
2014.11.17 17:36:20 4: SONOS1: Transport-Event: All correct with this service-call till now. UDN='uuid:RINCON_000E58C74E4801400_MR'
2014.11.17 17:36:20 4: SONOS1: Transport-Event: GroundURL: http://192.168.1.150:1400
2014.11.17 17:36:20 4: SONOS1: 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="1"/><CurrentTrack val="1"/><CurrentSection val="0"/><CurrentTrackURI val="x-rincon:RINCON_000E58B7AF1401400"/><CurrentTrackDuration val=""/><CurrentTrackMetaData val=""/><r:NextTrackURI val=""/><r:NextTrackMetaData val=""/><r:EnqueuedTransportURI val=""/><r:EnqueuedTransportURIMetaData val=""/><PlaybackStorageMedium val="NETWORK"/><AVTransportURI val="x-rincon:RINCON_000E58B7AF1401400"/><AVTransportURIMetaData val=""/><CurrentTransportActions val="Play, Stop"/><r:CurrentValidPlayModes val="CROSSFADE"/></InstanceID></Event>
2014.11.17 17:36:20 4: SONOS1: Transport-Event: CurrentTrackMetaData:
2014.11.17 17:36:20 4: SONOS1: Transport-Event: Normal erkannt!
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58B7AF1401400_MR, reading, roomName, RINCON_000E58B7AF1401400) -> Kueche
2014.11.17 17:36:20 4: SONOS1: Transport-Event: NextTrackMetaData:
2014.11.17 17:36:20 3: SONOS1: Event: End of Transport-Event for Zone "Sonos_Bad".
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58B7AF1401400_MR, def, NAME, RINCON_000E58B7AF1401400_MR) -> Sonos_Kueche
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58B7AF1401400_MR, attr, disable, 0) -> DEFAULT
2014.11.17 17:36:20 3: SONOS1: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Kueche".
2014.11.17 17:36:20 4: SONOS1: ZoneGroupTopology-Event: All correct with this service-call till now. UDN='uuid:RINCON_000E58B7AF1401400_MR'
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58B7AF1401400_MR, reading, ZonePlayerUUIDsInGroup, ) -> RINCON_000E58B7AF1401400
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58B7AF1401400_MR, reading, ZoneGroupID, ) -> RINCON_000E58B7AF1401400:__
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58B7AF1401400_MR, reading, fieldType, ) ->
2014.11.17 17:36:20 4: SONOS1: Retrieved TopoType:
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58B7AF1401400_MR, reading, ZoneGroupName, ) -> Kueche
2014.11.17 17:36:20 3: SONOS1: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Kueche".
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, def, NAME, RINCON_000E58C74E4801400_MR) -> Sonos_Bad
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, attr, disable, 0) -> DEFAULT
2014.11.17 17:36:20 3: SONOS1: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Bad".
2014.11.17 17:36:20 4: SONOS1: ZoneGroupTopology-Event: All correct with this service-call till now. UDN='uuid:RINCON_000E58C74E4801400_MR'
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, reading, ZonePlayerUUIDsInGroup, ) -> RINCON_000E58C74E4801400
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, reading, ZoneGroupID, ) -> RINCON_000E58C74E4801400:__
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, reading, fieldType, ) ->
2014.11.17 17:36:20 4: SONOS1: Retrieved TopoType:
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, reading, ZoneGroupName, ) -> Bad
2014.11.17 17:36:20 3: SONOS1: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Bad".
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_B8E93752FD2401400_MR, def, NAME, RINCON_B8E93752FD2401400_MR) -> Sonos_Schlafzimmer
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_B8E93752FD2401400_MR, attr, disable, 0) -> DEFAULT
2014.11.17 17:36:20 3: SONOS1: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 17:36:20 4: SONOS1: ZoneGroupTopology-Event: All correct with this service-call till now. UDN='uuid:RINCON_B8E93752FD2401400_MR'
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_B8E93752FD2401400_MR, reading, ZonePlayerUUIDsInGroup, ) -> RINCON_B8E93752FD2401400
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_B8E93752FD2401400_MR, reading, ZoneGroupID, ) -> RINCON_B8E93752FD2401400:__
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_B8E93752FD2401400_MR, reading, fieldType, ) ->
2014.11.17 17:36:20 4: SONOS1: Retrieved TopoType:
2014.11.17 17:36:20 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_B8E93752FD2401400_MR, reading, ZoneGroupName, ) -> Schlafzimmer
2014.11.17 17:36:20 3: SONOS1: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Schlafzimmer".
2014.11.17 17:36:23 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, def, NAME, RINCON_000E58C74E4801400_MR) -> Sonos_Bad
2014.11.17 17:36:23 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58C74E4801400_MR, attr, disable, 0) -> DEFAULT
2014.11.17 17:36:23 3: SONOS1: Event: Received Transport-Event for Zone "Sonos_Bad".
2014.11.17 17:36:23 4: SONOS1: Transport-Event: All correct with this service-call till now. UDN='uuid:RINCON_000E58C74E4801400_MR'
2014.11.17 17:36:23 4: SONOS1: Transport-Event: GroundURL: http://192.168.1.150:1400
2014.11.17 17:36:23 4: SONOS1: 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="1"/><CurrentTrack val="1"/><CurrentSection val="0"/><CurrentTrackURI val="x-rincon:RINCON_000E58B7AF1401400"/><CurrentTrackDuration val=""/><CurrentTrackMetaData val=""/><r:NextTrackURI val=""/><r:NextTrackMetaData val=""/><r:EnqueuedTransportURI val=""/><r:EnqueuedTransportURIMetaData val=""/></InstanceID></Event>
2014.11.17 17:36:23 4: SONOS1: Transport-Event: CurrentTrackMetaData:
2014.11.17 17:36:23 4: SONOS1: Transport-Event: Normal erkannt!
2014.11.17 17:36:23 4: SONOS1: SONOS_Client_Data_Retreive(RINCON_000E58B7AF1401400_MR, reading, roomName, RINCON_000E58B7AF1401400) -> Kueche
2014.11.17 17:36:23 4: SONOS1: Transport-Event: NextTrackMetaData:
2014.11.17 17:36:23 3: SONOS1: Event: End of Transport-Event for Zone "Sonos_Bad".
Odd number of elements in hash assignment at /usr/share/perl5/IO/Socket/IP.pm line 352, <$client> line 7.
Loading device description failed with error: 200 OK at FHEM/00_SONOS.pm line 2281 thread 1.



fhem.log
2014.11.17 17:36:20.069 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_000E58C74E4801400_MR:1'
2014.11.17 17:36:20.070 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2014.11.17 17:36:20.070 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2014.11.17 17:36:20.071 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:1'
2014.11.17 17:36:20.071 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2014.11.17 17:36:20.071 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:x-rincon:RINCON_000E58B7AF1401400'
2014.11.17 17:36:20.071 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:'
2014.11.17 17:36:20.071 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_000E58C74E4801400_MR:0::http://192.168.1.150:1400'
2014.11.17 17:36:20.072 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./www/images/default/fhemicon.png', './www/images/default/SONOSPLAYER/Sonos_Bad_AlbumArt.png');
2014.11.17 17:36:20.072 4: SONOS0: Couldn't retrieve file "./www/images/default/fhemicon.png" via web. Trying to copy directly...
2014.11.17 17:36:20.073 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Bad_AlbumArt.png'!
2014.11.17 17:36:20.073 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NormalAudio:1'
2014.11.17 17:36:20.073 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Album:Kueche'
2014.11.17 17:36:20.073 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Title:Gruppenwiedergabe'
2014.11.17 17:36:20.074 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Artist:'
2014.11.17 17:36:20.074 5: SONOS0: Received from UPnP-Server: 'SetCurrent:AlbumArtist:PLAYING'
2014.11.17 17:36:20.074 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2014.11.17 17:36:20.074 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_000E58C74E4801400_MR:1::http://192.168.1.150:1400'
2014.11.17 17:36:20.074 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./www/images/default/fhemicon.png', './www/images/default/SONOSPLAYER/Sonos_Bad_NextAlbumArt.png');
2014.11.17 17:36:20.075 4: SONOS0: Couldn't retrieve file "./www/images/default/fhemicon.png" via web. Trying to copy directly...
2014.11.17 17:36:20.075 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Bad_NextAlbumArt.png'!
2014.11.17 17:36:20.076 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_000E58C74E4801400_MR'
2014.11.17 17:36:20.171 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:undef:ZoneGroupState:<ZoneGroups><ZoneGroup Coordinator="RINCON_B8E93752FD2401400" ID="RINCON_000E58C74E4801400:68"><ZoneGroupMember UUID="RINCON_B8E93752FD2401400" Location="http://192.168.1.104:1400/xml/device_description.xml" ZoneName="Schlafzimmer" Icon="x-rincon-roomicon:masterbedroom" Configuration="1" SoftwareVersion="28.1-82291" MinCompatibleVersion="26.0-00000" LegacyCompatibleVersion="24.0-0000" BootSeq="20" WirelessMode="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1"/></ZoneGroup><ZoneGroup Coordinator="RINCON_000E58B7AF1401400" ID="RINCON_000E58B7AF1401400:40"><ZoneGroupMember UUID="RINCON_000E58C74E4801400" Location="http://192.168.1.150:1400/xml/device_description.xml" ZoneName="Bad" Icon="x-rincon-roomicon:bathroom" Configuration="1" SoftwareVersion="28.1-82291" MinCompatibleVersion="26.0-00000" LegacyCompatibleVersion="24.0-0000" BootSeq="39" WirelessMode="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1"/><ZoneGroupMember UUID="RINCON_000E58B7AF1401400" Location="http://192.168.1.149:1400/xml/device_description.xml" ZoneName="Kueche" Icon="x-rincon-roomicon:kitchen" Configuration="1" SoftwareVersion="28.1-82291" MinCompatibleVersion="26.0-00000" LegacyCompatibleVersion="24.0-0000" BootSeq="38" WirelessMode="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1"/></ZoneGroup></ZoneGroups>'
2014.11.17 17:36:20.201 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_000E58B7AF1401400_MR:ZonePlayerUUIDsInGroup:RINCON_000E58B7AF1401400,RINCON_000E58C74E4801400'
2014.11.17 17:36:20.203 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_000E58B7AF1401400_MR:ZoneGroupID:RINCON_000E58B7AF1401400:__'
2014.11.17 17:36:20.203 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_000E58B7AF1401400_MR:fieldType:'
2014.11.17 17:36:20.204 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_000E58B7AF1401400_MR:ZoneGroupName:Kueche + 1'
2014.11.17 17:36:20.205 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:undef:ZoneGroupState:<ZoneGroups><ZoneGroup Coordinator="RINCON_B8E93752FD2401400" ID="RINCON_000E58C74E4801400:68"><ZoneGroupMember UUID="RINCON_B8E93752FD2401400" Location="http://192.168.1.104:1400/xml/device_description.xml" ZoneName="Schlafzimmer" Icon="x-rincon-roomicon:masterbedroom" Configuration="1" SoftwareVersion="28.1-82291" MinCompatibleVersion="26.0-00000" LegacyCompatibleVersion="24.0-0000" BootSeq="20" WirelessMode="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1"/></ZoneGroup><ZoneGroup Coordinator="RINCON_000E58B7AF1401400" ID="RINCON_000E58B7AF1401400:40"><ZoneGroupMember UUID="RINCON_000E58B7AF1401400" Location="http://192.168.1.149:1400/xml/device_description.xml" ZoneName="Kueche" Icon="x-rincon-roomicon:kitchen" Configuration="1" SoftwareVersion="28.1-82291" MinCompatibleVersion="26.0-00000" LegacyCompatibleVersion="24.0-0000" BootSeq="38" WirelessMode="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1"/><ZoneGroupMember UUID="RINCON_000E58C74E4801400" Location="http://192.168.1.150:1400/xml/device_description.xml" ZoneName="Bad" Icon="x-rincon-roomicon:bathroom" Configuration="1" SoftwareVersion="28.1-82291" MinCompatibleVersion="26.0-00000" LegacyCompatibleVersion="24.0-0000" BootSeq="39" WirelessMode="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1"/></ZoneGroup></ZoneGroups>'
2014.11.17 17:36:20.236 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_000E58C74E4801400_MR:ZonePlayerUUIDsInGroup:RINCON_000E58B7AF1401400,RINCON_000E58C74E4801400'
2014.11.17 17:36:20.237 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_000E58C74E4801400_MR:ZoneGroupID:RINCON_000E58B7AF1401400:__'
2014.11.17 17:36:20.238 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_000E58C74E4801400_MR:fieldType:'
2014.11.17 17:36:20.239 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:undef:ZoneGroupState:<ZoneGroups><ZoneGroup Coordinator="RINCON_000E58B7AF1401400" ID="RINCON_000E58B7AF1401400:40"><ZoneGroupMember UUID="RINCON_000E58B7AF1401400" Location="http://192.168.1.149:1400/xml/device_description.xml" ZoneName="Kueche" Icon="x-rincon-roomicon:kitchen" Configuration="1" SoftwareVersion="28.1-82291" MinCompatibleVersion="26.0-00000" LegacyCompatibleVersion="24.0-0000" BootSeq="38" WirelessMode="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1"/><ZoneGroupMember UUID="RINCON_000E58C74E4801400" Location="http://192.168.1.150:1400/xml/device_description.xml" ZoneName="Bad" Icon="x-rincon-roomicon:bathroom" Configuration="1" SoftwareVersion="28.1-82291" MinCompatibleVersion="26.0-00000" LegacyCompatibleVersion="24.0-0000" BootSeq="39" WirelessMode="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1"/></ZoneGroup><ZoneGroup Coordinator="RINCON_B8E93752FD2401400" ID="RINCON_000E58C74E4801400:68"><ZoneGroupMember UUID="RINCON_B8E93752FD2401400" Location="http://192.168.1.104:1400/xml/device_description.xml" ZoneName="Schlafzimmer" Icon="x-rincon-roomicon:masterbedroom" Configuration="1" SoftwareVersion="28.1-82291" MinCompatibleVersion="26.0-00000" LegacyCompatibleVersion="24.0-0000" BootSeq="20" WirelessMode="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1"/></ZoneGroup></ZoneGroups>'
2014.11.17 17:36:20.269 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_B8E93752FD2401400_MR:ZonePlayerUUIDsInGroup:RINCON_B8E93752FD2401400'
2014.11.17 17:36:20.270 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_B8E93752FD2401400_MR:ZoneGroupID:RINCON_B8E93752FD2401400:__'
2014.11.17 17:36:20.270 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_B8E93752FD2401400_MR:fieldType:'
2014.11.17 17:36:20.270 5: SONOS0: Received from UPnP-Server: 'ReadingsSingleUpdateIfChanged:RINCON_B8E93752FD2401400_MR:ZoneGroupName:Schlafzimmer'
2014.11.17 17:36:23.177 5: SONOS0: Received from UPnP-Server: 'GetReadingsToCurrentHash:RINCON_000E58C74E4801400_MR:1'
2014.11.17 17:36:23.178 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TransportState:PLAYING'
2014.11.17 17:36:23.178 5: SONOS0: Received from UPnP-Server: 'SetCurrent:CrossfadeMode:0'
2014.11.17 17:36:23.178 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NumberOfTracks:1'
2014.11.17 17:36:23.179 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Track:1'
2014.11.17 17:36:23.179 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackURI:x-rincon:RINCON_000E58B7AF1401400'
2014.11.17 17:36:23.179 5: SONOS0: Received from UPnP-Server: 'SetCurrent:TrackDuration:'
2014.11.17 17:36:23.179 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_000E58C74E4801400_MR:0::http://192.168.1.150:1400'
2014.11.17 17:36:23.179 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./www/images/default/fhemicon.png', './www/images/default/SONOSPLAYER/Sonos_Bad_AlbumArt.png');
2014.11.17 17:36:23.180 4: SONOS0: Couldn't retrieve file "./www/images/default/fhemicon.png" via web. Trying to copy directly...
2014.11.17 17:36:23.180 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Bad_AlbumArt.png'!
2014.11.17 17:36:23.180 5: SONOS0: Received from UPnP-Server: 'SetCurrent:NormalAudio:1'
2014.11.17 17:36:23.181 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Album:Kueche'
2014.11.17 17:36:23.181 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Title:Gruppenwiedergabe'
2014.11.17 17:36:23.181 5: SONOS0: Received from UPnP-Server: 'SetCurrent:Artist:'
2014.11.17 17:36:23.181 5: SONOS0: Received from UPnP-Server: 'SetCurrent:AlbumArtist:PLAYING'
2014.11.17 17:36:23.181 5: SONOS0: Received from UPnP-Server: 'SetCurrent:nextTrackURI:'
2014.11.17 17:36:23.182 5: SONOS0: Received from UPnP-Server: 'ProcessCover:RINCON_000E58C74E4801400_MR:1::http://192.168.1.150:1400'
2014.11.17 17:36:23.182 4: SONOS0: Transport-Event: CoverArt konnte nicht gefunden werden. Verwende FHEM-Logo. Bilder-Download: SONOS_DownloadReplaceIfChanged('./www/images/default/fhemicon.png', './www/images/default/SONOSPLAYER/Sonos_Bad_NextAlbumArt.png');
2014.11.17 17:36:23.182 4: SONOS0: Couldn't retrieve file "./www/images/default/fhemicon.png" via web. Trying to copy directly...
2014.11.17 17:36:23.182 4: SONOS0: Identical filecontent for './www/images/default/SONOSPLAYER/Sonos_Bad_NextAlbumArt.png'!
2014.11.17 17:36:23.183 5: SONOS0: Received from UPnP-Server: 'CurrentBulkUpdate:RINCON_000E58C74E4801400_MR'


Gruß Claudiu

rapster

#21
Nur so ganz nebenbei, ich habe das gruppieren des SPDIF der Playbar bis her noch nie benötigt  ;D

Was ist denn eigentlich der Standard verbose-Wert beim Sonos-Dev, 3 ? (Habs auf die schnelle nicht gefunden im Wiki)


Wegen dem wide character Problem nochmal, es kann ja passieren dass das Sonos-Modul mal "abraucht", lässt es sich aber evtl. verhindern dass anschließend im Fhem log pro Millisekunde >5 neue Zeilen geschrieben werden?
Falls man das sonst mal nicht mitbekommt läuft die Festplatte rucki zucki voll, hatte gestern Abend nach paar Minuten testen bereits ein mehrere hundert MB großes Fhem.log  :-\

Fhem.log von gestern:
2014.11.17 03:04:07.213 1: SONOS0: Nothing could be read from TCP-Channel (the first level) even though the Read-Function was called.
2014.11.17 03:04:07.214 1: SONOS0: Nothing could be read from TCP-Channel (the first level) even though the Read-Function was called.
2014.11.17 03:04:07.214 1: SONOS0: Nothing could be read from TCP-Channel (the first level) even though the Read-Function was called.
2014.11.17 03:04:07.214 1: SONOS0: Nothing could be read from TCP-Channel (the first level) even though the Read-Function was called.
2014.11.17 03:04:07.214 1: SONOS0: Nothing could be read from TCP-Channel (the first level) even though the Read-Function was called.
2014.11.17 03:04:07.214 1: SONOS0: Nothing could be read from TCP-Channel (the first level) even though the Read-Function was called.


Gruß Claudiu

Reinerlein

Hi Claudiu,

danke für die Logs. Leider meldet der Sonosplayer (Bad) einfach nur einen Fehler und keine weiteren Hinweise, ob es einen anderen Weg gäbe.
Ich denke, ich würde es darauf beschränken, dass man den SPDIF-Eingang nur von sich selbst wählen kann.
Geht das folgende bei dir?

set Sonos_Kueche PlayURI Sonos_Kueche
Er sollte dann ja eigentlich seinen eigenen TV-Eingang als Abspielquelle wählen...

Zu dem Log:
Ich habe da noch etwas eingebaut, was diese Unmenge an Logs verhindern soll. Ich weiss aber noch nichts zur Wirksamkeit :-)

Grüße
Reinerlein

P.S. Standard für Verbose gibt es keinen richtigen. Ich verwende 3. Dann bekomme ich noch einiges mit, und nicht zuviele Mitteilungen. Manche stellen das aber auf 0 um Ruhe zu haben...

rapster

Hi Reinerlein,

OK, 3 sah für mich auch vernünftig aus :-)

Jup der Befehl funktioniert, und er schaltet wie erwartet auf den TV Eingang. Das ist evtl. sogar mal ganz nützlich :-)

Ja diese Beschränkung sollte denke ich auch in 99,9% aller Fälle ausreichen.
Falls man SPDIF auf einem anderen Player (mit) ausgeben will funktioniert das ja hervorragend über AddMember (set <Playbar> PlayURI <Playbar>;; set <Playbar> AddMember <andererPlayer>)
Ich denke anders wird es auch nicht funktionieren, da diese Vorgehensweise ja genau so auch im original Sonos Controller durchgeführt werden muss.

Hoffe dass das mit dem Log allerdings klappt, so ein Linux mit keinem freien Speicher mehr, verhällt sich ja manchmal doch etwas komisch  ;D

Gruß Claudiu

Reinerlein

Hi Claudiu,

ich habe die Dev-Version mal aktualisiert.
Wenn man jetzt den TV-Eingang eines anderen Players (der Playbar) per PlayURI starten möchte, macht er jetzt die beiden Schritte automatisch:
- An der Playbar den TV-Eingang wählen
- Eine Gruppenwiedergabe bei dem gewünschten Player (und der gewünschten Lautstärke) mit der Playbar starten
Das war doch einfacher als erwartet...

Kannst du das noch kurz testen? Dann sind wir mit dem Thema auch durch, und ich lasse dich erstmal in Ruhe :-)

Grüße
Reinerlein

rapster

funzt 1A!  8)
- Eingang schaltet von der aktuell gespielten Musik auf TV um, Gruppe wird erstellt => TV wird auf Playbar + anderem Player ausgegeben.


Allerdings... ist mir das bereits heute Nachmittag aufgefallen, ich weiss nicht woher das kommt, allerdings bilde ich mir ein das Verhalten war gestern noch nicht so.

Nach einem shutdown+restart von fhem, bzw. nach einem Reboot der ganzen Kiste, bleibt das Sonos Modul bei allen Devices auf dem Status "initialized" stehen und es werden keine aktuellen Informationen von den Devices angezeigt.
Erst wenn man irgend eine Befehl ausführt, z.B. MuteT, VolumeD,... werden alle Devices nach ~4sec  geladen (der Befehl allerdings nicht ausgeführt), und erst beim 2. absetzen des Befehls wird er nun auch ausgeführt. 

Gruß Claudiu

Reinerlein

Hi Claudiu,

schön, dann haben wir das mit der Playbar jetzt durch.

Zu dem initialized-Thema:
Bei mir läuft das z.B. auf einem Raspberry Pi. Der ist nicht so schnell. Bei meinen vier Sonos-Komponenten dauert das ingesamt lockere 30-45 Sekunden bis alles fertig erkannt wurde und in Fhem eingetragen wurde.
Bis dahin steht dann dieses initialized und wird Stück für Stück angepasst. Erst danach geht auch eine Steuerung des jeweiligen Players...
Da hilft es auch, das Log kleiner zu halten, da es auf der SD-Karte Zeit kostet es wegzuschreiben...

Außerdem muss man natürlich longpoll aktiviert haben, um die Aktualisierung auf der Oberfläche direkt zu sehen :-)

Grüße
Reinerlein

rapster

Hi Reinerlein,

hmm, dass wird aber denk ich bei mir nicht das Problem sein.

1. Habe ich bereits einmal >5min gewartet, und egal wann (auch direkt nach Fhem start) ich eine Aktion ausführe, 4sec später sind die Devices da.
2. Glaube ich das es mit der Version von gestern Abend noch funktionierte :-)
3. Läuft Fhem bei mir auf einer VM (ESXi) mit relativ schneller i7 CPU und einer Samsung 840Pro SSD als Storage.
4. Sollte doch longpoll per default aktiviert sein oder? (Geändert habe ich es zumindest nicht). Alternativ sollte doch ein F5 das selbe bewirken?

Hast du vll. einen Tipp woran das sonst liegen könnte?

Gruß Claudiu

Reinerlein

Hi Claudiu,

ok, das klingt nicht nach Perfomanceproblemen bei der Hardware und ja, longpoll sollte aktiv sein und ja, F5 hat die gleiche Wirkung :-)

Du kannst zum Testen mal mehrere Konsolenfenster nebeneinander machen.
In einem Fenster ein "tail -f" für die Konsolenausgabe des Subprozesses. Im nächsten Fenster ein "tail -f" auf der Fhem-Logdatei.
Außerdem noch ein Browserfenster oder Telnet-Fenster für den Fhem-Restart.

Bei Loglevel 3 sieht man gut, wenn er mit der Erkennung anfängt, wo verzögerungen sind, und wann es bei fhem landet. Vielleicht sieht man dabei was er so alles tut...

Grüße
Reinerlein

rapster

Hi Reinerlein,

Konsolen standen schon zufällig genau so bereit  ;D

Nach Fhem Start ohne eine Aktion zu betätigen:

fhem.log
2014.11.17 20:27:21.541 1: Including fhem.cfg
2014.11.17 20:27:21.586 2: eventTypes: loaded 5731 events from ./log/eventTypes.txt
2014.11.17 20:27:21.587 1: Including ./FHEM/connectionConfig.cfg
2014.11.17 20:27:21.592 3: telnetPort: port 23 opened
2014.11.17 20:27:21.626 3: WEB: port 443 opened
2014.11.17 20:27:21.665 3: WEBphone: port 8084 opened
2014.11.17 20:27:21.665 3: WEBtablet: port 8085 opened
2014.11.17 20:27:21.667 1: Including ./FHEM/CUL_VCCU.cfg
2014.11.17 20:27:21.676 3: Opening CUL1 device /dev/ttyACM0
2014.11.17 20:27:21.773 3: Setting CUL1 baudrate to 9600
2014.11.17 20:27:21.774 3: CUL1 device opened
2014.11.17 20:27:21.895 3: CUL1: Possible commands: BbCFiAZEGMKUYRTVWXefmltux
2014.11.17 20:27:21.946 2: Switched CUL1 rfmode to HomeMatic
2014.11.17 20:27:22.050 1: Including ./FHEM/actionDetector.cfg
2014.11.17 20:27:22.050 1: Including ./FHEM/HMinfo.cfg
2014.11.17 20:27:22.070 1: Including ./FHEM/devices.cfg
2014.11.17 20:27:22.134 1: Including ./FHEM/svgPlots.cfg
2014.11.17 20:27:22.150 1: Including ./FHEM/residents.cfg
2014.11.17 20:27:22.167 1: Including ./FHEM/geofancy.cfg
2014.11.17 20:27:22.171 3: Registering GEOFANCY geofancy for URL /geo...
2014.11.17 20:27:22.173 1: Including ./FHEM/dashboard.cfg
2014.11.17 20:27:22.182 1: Including ./FHEM/ignoreDevices.cfg
2014.11.17 20:27:22.184 1: Including ./FHEM/sonos.cfg
2014.11.17 20:27:22.366 1: SONOS0: Kein UPnP-Server gefunden... Starte selber einen und warte 8 sekunden darauf...
2014.11.17 20:27:30.367 3: Opening Sonos device localhost:4711
2014.11.17 20:27:30.368 3: Sonos device opened
2014.11.17 20:27:30.380 1: Including ./FHEM/pushover.cfg
2014.11.17 20:27:30.383 1: Including ./FHEM/notify.cfg
2014.11.17 20:27:30.383 1: Including ./FHEM/TEST.cfg
2014.11.17 20:27:30.400 1: Including ./log/fhem.save
2014.11.17 20:27:30.478 1: statefile: Reading Sonos_Bad->LastActionResult must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
Reading Sonos_Bad->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
Reading Sonos_Kueche->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
Reading Sonos_Schlafzimmer->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
2014.11.17 20:27:30.483 2: Error messages while initializing FHEM: statefile: Reading Sonos_Bad->LastActionResult must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem. Reading Sonos_Bad->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem. Reading Sonos_Kueche->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem. Reading Sonos_Schlafzimmer->presence must not be used out of statefile. This is not an error! This happens due to restrictions of Fhem.
2014.11.17 20:27:30.483 0: Server started with 178 defined entities (version $Id: fhem.pl 6913 2014-11-08 10:32:44Z rudolfkoenig $, os linux, user root, pid 2027)
2014.11.17 20:27:35.401 3: Device CUL_HM_HM_SEC_RHS_238E26 added to ActionDetector with 028:00 time
2014.11.17 20:27:35.411 3: Device dg_wz_fensterkontakt_links added to ActionDetector with 000:50 time
2014.11.17 20:27:35.413 3: Device dg_wz_fensterkontakt_rechts added to ActionDetector with 000:50 time
2014.11.17 20:27:35.415 3: Device dg_wz_heizkoerper added to ActionDetector with 000:10 time
2014.11.17 20:27:35.424 3: Device dg_wz_wandthermostat added to ActionDetector with 000:10 time
2014.11.17 20:27:35.429 3: Device og_bz_fensterkontakt added to ActionDetector with 000:50 time
2014.11.17 20:27:35.431 3: Device og_bz_heizkoerper added to ActionDetector with 000:10 time
2014.11.17 20:27:35.439 3: Device og_bz_wandthermostat added to ActionDetector with 000:10 time
2014.11.17 20:27:35.446 3: Device og_ez_fensterkontakt added to ActionDetector with 000:50 time
2014.11.17 20:27:35.449 3: Device og_ez_heizkoerper added to ActionDetector with 000:10 time
2014.11.17 20:27:35.458 3: Device og_ez_wandthermostat added to ActionDetector with 000:10 time
2014.11.17 20:27:35.465 3: Device og_schlieserschnittstelle added to ActionDetector with 028:00 time
2014.11.17 20:27:35.467 3: Device og_sz_fensterkontakt added to ActionDetector with 000:50 time
2014.11.17 20:27:35.469 3: Device og_sz_heizkoerper added to ActionDetector with 000:10 time
2014.11.17 20:27:35.478 3: Device og_sz_wandthermostat added to ActionDetector with 000:10 time


stdout
Smartmatch is experimental at ./FHEM/10_RESIDENTS.pm line 167, <$fh> line 3.
Smartmatch is experimental at ./FHEM/10_RESIDENTS.pm line 168, <$fh> line 3.
Smartmatch is experimental at ./FHEM/00_SONOS.pm line 3435.
Current: "fhem.pl", gPath: "./FHEM"
Smartmatch is experimental at FHEM/00_SONOS.pm line 3435.
Current: "FHEM/00_SONOS.pm", gPath: ""
2014.11.17 20:27:22 1: SONOS0: FHEM/00_SONOS.pm is listening to Port 4711
2014.11.17 20:27:30 1: SONOS0: Connection accepted from localhost:54568



...Rest im nächsten Beitrag...