Wird mein Problerm von FHEM oder Sonos-intern ausgelöst

Begonnen von Nobby1805, 22 August 2018, 10:39:07

Vorheriges Thema - Nächstes Thema

Nobby1805

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
FHEM-Featurelevel: 6.2   (fhem.pl:28227/2023-11-29) auf Windows 10 Pro mit Strawberry Perl 5.32.1.1-32bit
TabletUI: 2.7.15
IO: 2xHMLAN(0.965)|HMUSB2(0.967)

Nobby1805

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
FHEM-Featurelevel: 6.2   (fhem.pl:28227/2023-11-29) auf Windows 10 Pro mit Strawberry Perl 5.32.1.1-32bit
TabletUI: 2.7.15
IO: 2xHMLAN(0.965)|HMUSB2(0.967)