FHEM Forum

FHEM - Anwendungen => Multimedia => Thema gestartet von: Nobby1805 am 22 August 2018, 10:39:07

Titel: Wird mein Problerm von FHEM oder Sonos-intern ausgelöst
Beitrag von: Nobby1805 am 22 August 2018, 10:39:07
Hallo Reiner,

seit einiger Zeit habe ich das Problem, dass der Sonos-Client sagt, die Play-Liste sei leer. Es werden aber alle Titel noch angezeigt und bei einem Doppelklick auf eines dieser Elemente wird die Liste wieder zugeordnet, die vorher ausgewählte zufällige Abspielung ist aber ausgeschaltet.
Ich bin mir nicht sicher, ob das Problem besteht nachdem ich ein Sonos-Beam hinzugefügt habe oder schon vorher aufgetreten ist :-\
Jetzt habe ich das Logging mal auf 5 gestellt und folgendes gefunden, ich hoffe du kannst am Log etwas erkennen

Gruß Nobby
Titel: Antw:Wird mein Problerm von FHEM oder Sonos-intern ausgelöst
Beitrag von: Nobby1805 am 24 August 2018, 17:16:53
Hi,

ich weiß jetzt nicht ob dieser Fall mit dem zuerst beschriebenen zu tun hat oder nicht ...

2018.08.24 14:22:27.631 5: SONOS0: Received from UPnP-Server: 'rePing:undef::'
2018.08.24 14:22:57.648 5: SW: DoWork:undef:refreshProcessAnswer:

2018.08.24 14:22:57.762 5: SONOS0: Received from UPnP-Server: 'rePing:undef::'
2018.08.24 14:23:27.844 5: SW: DoWork:undef:refreshProcessAnswer:

2018.08.24 14:23:57.882 5: SW: DoWork:undef:refreshProcessAnswer:

2018.08.24 14:24:27.897 5: SW: DoWork:undef:refreshProcessAnswer:

2018.08.24 14:24:57.917 5: SW: DoWork:undef:refreshProcessAnswer:

2018.08.24 14:24:57.930 2: SONOS0: LastProcessAnswer way too old (Lastanswer: 1535113377.76386 ~ 2018-08-24 14:22:57)... try to restart the process and connection...
2018.08.24 14:24:57.932 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos"
2018.08.24 14:24:57.947 4: SONOS0: ReadingsEndUpdate from Module for "Sonos"
2018.08.24 14:24:58.974 5: SW: shutdown

2018.08.24 14:24:58.992 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_BRIDGE"
2018.08.24 14:24:58.999 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_BRIDGE"
2018.08.24 14:24:59.000 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Fernsehzimmer"
2018.08.24 14:24:59.003 5: SONOSPLAYER0: Notify-CoverTitle: transportState: STOPPED
2018.08.24 14:24:59.003 5: SONOSPLAYER0: Notify-TransportState: transportState: STOPPED
2018.08.24 14:24:59.008 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Fernsehzimmer"
2018.08.24 14:24:59.009 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Schlafzimmer"
2018.08.24 14:24:59.198 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Schlafzimmer"
2018.08.24 14:24:59.200 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Schlafzimmer_RF"
2018.08.24 14:24:59.208 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Schlafzimmer_RF"
2018.08.24 14:24:59.210 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Wohnzimmer"
2018.08.24 14:24:59.217 5: SONOSPLAYER0: Notify-CoverTitle: transportState: STOPPED
2018.08.24 14:24:59.217 5: SONOSPLAYER0: Notify-TransportState: transportState: STOPPED
2018.08.24 14:24:59.393 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Wohnzimmer"
2018.08.24 14:25:00.108 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Fernsehzimmer"
2018.08.24 14:25:00.120 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Fernsehzimmer"
2018.08.24 14:25:00.220 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Wohnzimmer"
2018.08.24 14:25:00.335 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Wohnzimmer"

2018.08.24 14:23:09.263 4: SONOS3: 192.168.1.70 is alive
2018.08.24 14:23:26.177 3: SONOS1: Transport-Subscription for ZonePlayer "RINCON_949F3ED0548201400_MR" has expired and is now renewed.
2018.08.24 14:23:27.849 5: SONOS0: Received: 'DoWork:undef:refreshProcessAnswer:'
2018.08.24 14:23:39.317 4: SONOS3: IsAlive-Event UDN=RINCON_000E58E3988A01400_MR
2018.08.24 14:23:39.317 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_000E58E3988A01400_MR, reading, location, ) -> http://192.168.1.53:1400/xml/device_description.xml
2018.08.24 14:23:39.321 5: SONOS3: Location: http://192.168.1.53:1400/xml/device_description.xml
2018.08.24 14:23:39.324 5: SONOS3: PingType: syn
2018.08.24 14:23:39.327 4: SONOS3: 192.168.1.53 is alive
2018.08.24 14:23:39.333 4: SONOS3: IsAlive-Event UDN=RINCON_000E58C1DE0A01400_MR
2018.08.24 14:23:39.335 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_000E58C1DE0A01400_MR, reading, location, ) -> http://192.168.1.57:1400/xml/device_description.xml
2018.08.24 14:23:39.336 5: SONOS3: Location: http://192.168.1.57:1400/xml/device_description.xml
2018.08.24 14:23:39.337 5: SONOS3: PingType: syn
2018.08.24 14:23:39.340 4: SONOS3: 192.168.1.57 is alive
2018.08.24 14:23:39.342 4: SONOS3: IsAlive-Event UDN=RINCON_7828CA255F0A01400_MR
2018.08.24 14:23:39.357 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CA255F0A01400_MR, reading, location, ) -> http://192.168.1.60:1400/xml/device_description.xml
2018.08.24 14:23:39.359 5: SONOS3: Location: http://192.168.1.60:1400/xml/device_description.xml
2018.08.24 14:23:39.360 5: SONOS3: PingType: syn
2018.08.24 14:23:39.364 4: SONOS3: 192.168.1.60 is alive
2018.08.24 14:23:39.365 4: SONOS3: IsAlive-Event UDN=RINCON_000E58A376D201400_MR
2018.08.24 14:23:39.367 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_000E58A376D201400_MR, reading, location, ) -> http://192.168.1.56:1400/xml/device_description.xml
2018.08.24 14:23:39.368 5: SONOS3: Location: http://192.168.1.56:1400/xml/device_description.xml
2018.08.24 14:23:39.369 5: SONOS3: PingType: syn
2018.08.24 14:23:39.374 4: SONOS3: 192.168.1.56 is alive
2018.08.24 14:23:39.375 4: SONOS3: IsAlive-Event UDN=RINCON_949F3ED0548201400_MR
2018.08.24 14:23:39.377 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_949F3ED0548201400_MR, reading, location, ) -> http://192.168.1.70:1400/xml/device_description.xml
2018.08.24 14:23:39.378 5: SONOS3: Location: http://192.168.1.70:1400/xml/device_description.xml
2018.08.24 14:23:39.380 5: SONOS3: PingType: syn
2018.08.24 14:23:39.383 4: SONOS3: 192.168.1.70 is alive
2018.08.24 14:23:46.177 3: SONOS1: Rendering-Subscription for ZonePlayer "RINCON_949F3ED0548201400_MR" has expired and is now renewed.
2018.08.24 14:23:57.880 5: SONOS0: Received: 'DoWork:undef:refreshProcessAnswer:'
2018.08.24 14:24:06.177 3: SONOS1: GroupRendering-Subscription for ZonePlayer "RINCON_949F3ED0548201400_MR" has expired and is now renewed.
2018.08.24 14:24:09.380 4: SONOS3: IsAlive-Event UDN=RINCON_000E58E3988A01400_MR
2018.08.24 14:24:09.380 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_000E58E3988A01400_MR, reading, location, ) -> http://192.168.1.53:1400/xml/device_description.xml
2018.08.24 14:24:09.382 5: SONOS3: Location: http://192.168.1.53:1400/xml/device_description.xml
2018.08.24 14:24:09.383 5: SONOS3: PingType: syn
2018.08.24 14:24:09.387 4: SONOS3: 192.168.1.53 is alive
2018.08.24 14:24:09.390 4: SONOS3: IsAlive-Event UDN=RINCON_000E58C1DE0A01400_MR
2018.08.24 14:24:09.393 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_000E58C1DE0A01400_MR, reading, location, ) -> http://192.168.1.57:1400/xml/device_description.xml
2018.08.24 14:24:09.394 5: SONOS3: Location: http://192.168.1.57:1400/xml/device_description.xml
2018.08.24 14:24:09.396 5: SONOS3: PingType: syn
2018.08.24 14:24:09.398 4: SONOS3: 192.168.1.57 is alive
2018.08.24 14:24:09.400 4: SONOS3: IsAlive-Event UDN=RINCON_7828CA255F0A01400_MR
2018.08.24 14:24:09.401 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CA255F0A01400_MR, reading, location, ) -> http://192.168.1.60:1400/xml/device_description.xml
2018.08.24 14:24:09.402 5: SONOS3: Location: http://192.168.1.60:1400/xml/device_description.xml
2018.08.24 14:24:09.403 5: SONOS3: PingType: syn
2018.08.24 14:24:09.406 4: SONOS3: 192.168.1.60 is alive
2018.08.24 14:24:09.407 4: SONOS3: IsAlive-Event UDN=RINCON_000E58A376D201400_MR
2018.08.24 14:24:09.408 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_000E58A376D201400_MR, reading, location, ) -> http://192.168.1.56:1400/xml/device_description.xml
2018.08.24 14:24:09.409 5: SONOS3: Location: http://192.168.1.56:1400/xml/device_description.xml
2018.08.24 14:24:09.410 5: SONOS3: PingType: syn
2018.08.24 14:24:09.413 4: SONOS3: 192.168.1.56 is alive
2018.08.24 14:24:09.414 4: SONOS3: IsAlive-Event UDN=RINCON_949F3ED0548201400_MR
2018.08.24 14:24:09.415 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_949F3ED0548201400_MR, reading, location, ) -> http://192.168.1.70:1400/xml/device_description.xml
2018.08.24 14:24:09.416 5: SONOS3: Location: http://192.168.1.70:1400/xml/device_description.xml
2018.08.24 14:24:09.417 5: SONOS3: PingType: syn
2018.08.24 14:24:09.420 4: SONOS3: 192.168.1.70 is alive
2018.08.24 14:24:26.177 3: SONOS1: ContentDirectory-Subscription for ZonePlayer "RINCON_949F3ED0548201400_MR" has expired and is now renewed.
2018.08.24 14:24:27.896 5: SONOS0: Received: 'DoWork:undef:refreshProcessAnswer:'
2018.08.24 14:24:39.427 4: SONOS3: IsAlive-Event UDN=RINCON_000E58E3988A01400_MR
2018.08.24 14:24:39.427 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_000E58E3988A01400_MR, reading, location, ) -> http://192.168.1.53:1400/xml/device_description.xml
2018.08.24 14:24:39.428 5: SONOS3: Location: http://192.168.1.53:1400/xml/device_description.xml
2018.08.24 14:24:39.431 5: SONOS3: PingType: syn
2018.08.24 14:24:39.434 4: SONOS3: 192.168.1.53 is alive
2018.08.24 14:24:39.436 4: SONOS3: IsAlive-Event UDN=RINCON_000E58C1DE0A01400_MR
2018.08.24 14:24:39.437 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_000E58C1DE0A01400_MR, reading, location, ) -> http://192.168.1.57:1400/xml/device_description.xml
2018.08.24 14:24:39.438 5: SONOS3: Location: http://192.168.1.57:1400/xml/device_description.xml
2018.08.24 14:24:39.439 5: SONOS3: PingType: syn
2018.08.24 14:24:39.443 4: SONOS3: 192.168.1.57 is alive
2018.08.24 14:24:39.444 4: SONOS3: IsAlive-Event UDN=RINCON_7828CA255F0A01400_MR
2018.08.24 14:24:39.445 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CA255F0A01400_MR, reading, location, ) -> http://192.168.1.60:1400/xml/device_description.xml
2018.08.24 14:24:39.447 5: SONOS3: Location: http://192.168.1.60:1400/xml/device_description.xml
2018.08.24 14:24:39.448 5: SONOS3: PingType: syn
2018.08.24 14:24:39.451 4: SONOS3: 192.168.1.60 is alive
2018.08.24 14:24:39.453 4: SONOS3: IsAlive-Event UDN=RINCON_000E58A376D201400_MR
2018.08.24 14:24:39.454 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_000E58A376D201400_MR, reading, location, ) -> http://192.168.1.56:1400/xml/device_description.xml
2018.08.24 14:24:39.455 5: SONOS3: Location: http://192.168.1.56:1400/xml/device_description.xml
2018.08.24 14:24:39.456 5: SONOS3: PingType: syn
2018.08.24 14:24:39.459 4: SONOS3: 192.168.1.56 is alive
2018.08.24 14:24:39.460 4: SONOS3: IsAlive-Event UDN=RINCON_949F3ED0548201400_MR
2018.08.24 14:24:39.462 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_949F3ED0548201400_MR, reading, location, ) -> http://192.168.1.70:1400/xml/device_description.xml
2018.08.24 14:24:39.463 5: SONOS3: Location: http://192.168.1.70:1400/xml/device_description.xml
2018.08.24 14:24:39.464 5: SONOS3: PingType: syn
2018.08.24 14:24:39.467 4: SONOS3: 192.168.1.70 is alive
2018.08.24 14:24:46.177 3: SONOS1: Alarm-Subscription for ZonePlayer "RINCON_949F3ED0548201400_MR" has expired and is now renewed.
2018.08.24 14:24:57.927 5: SONOS0: Received: 'DoWork:undef:refreshProcessAnswer:'
2018.08.24 14:24:58.974 5: SONOS0: Received: 'shutdown'
2018.08.24 14:24:59.062 3: SONOS0: Disconnecting client and shutdown server...
2018.08.24 14:24:59.185 3: SONOS0: Trying to kill Sonos_Thread...
2018.08.24 14:24:59.193 3: SONOS0: Trying to kill LongJobs_Thread...
2018.08.24 14:24:59.194 3: SONOS0: Trying to kill IsAlive_Thread...
2018.08.24 14:24:59.196 3: SONOS0: Trying to kill PlayerRestore_Thread...
2018.08.24 14:24:59.228 0: SONOS0: Das Lauschen auf der Schnittstelle wurde beendet. Prozess endet nun auch...
2018.08.24 14:24:59.349 1: SONOS4: Restore-Thread wurde beendet.
2018.08.24 14:24:59.521 1: SONOS3: IsAlive-Thread wurde beendet.
2018.08.24 14:24:59.489 1: SONOS2: LongJobs-Thread wurde beendet.

Auf jeden Fall hat der Versuch den Subprozess neu zu starten bei mir noch nie funktioniert :(

Gruß Nobby