SONOSPLAYER disable funktioniert nicht mehr richtig

[aski71]

Hallo,
ich habe neuerdings ein Problem mit der disable Funktion.

Mein Setup ist wiefolgt:
a)
5.1 Konfiguration mit
- Playbase an einer Schaltsteckdose
- Sub und 2 One an einer zweiten Schaltsteckdose
disable/enable DOIF für die Playbase Steckdose, kein disable/enable für die Sub/Surround, da ich die aus fhem nicht ansteuere.

b)
1 One in einem anderen Zimmer an einer Schaltsteckdose
disable/enable DOIF für die Schaltsteckdose

c)
1 weiterer One in einem weiteren Zimmer an einer Schaltsteckdose
disable/enable DOIF für die Schaltsteckdose

a) hat einwandfrei funktioniert, als es b) und c) noch nicht gab.
Sprich: Wenn die Steckdose mirgens wieder anging, ging auch in fhem die Playbase wieder auf appeared.

Seit ich b) und c) eingerichtet habe, bleiben leider morgens nach Einschalten der Steckdosen immer alle Sonosplayer auf disappeared und das Sonos Device steht auf disabled.
Obwohl die disable Attribute bei den Sonosplayer Devices aber ordentlich angelegt und wieder gelöscht werden.

Nach manuellem fhem shutdown, restart sind dann wieder alle da.

Was läuft hier schief? Wie kann ch es beheben?

VG Alex

[Reinerlein]

Hi Alex,

schaltest du das disable am Sonos-Device (Zentral) oder an den einzelnen Player-Devices?

An den Playerdevices kannst du dir das sparen, da das nur die Event-Verarbeitung der Player unterbindet, aber nichts zu einer Erkennung oder Stabilität beiträgt.
Das macht man z.B. wenn man mal Event-Ruhe beim basteln braucht...

Wenn du mit den ganzen Doifs das Disable-Attribut am Sonos-Device schaltest, solltest du prüfen, ob die sich nicht gegenseitig etwas überschreiben.
Im Allgemeinen ist es am Besten für das Schalten eines Attributs auch nur ein Doif zu verwenden. Dort definierst du dann alle Bedingungen, die zum Schalten des Attributs beitragen sollen in einen Doif-Zweig. DoElse schaltet das Attribut dann nur noch zurück.
Damit hast du zentral in einer (großen) Bedingung, was zum Aktivieren des Attributs beiträgt, in allen anderen Fällen wird es wieder deaktiviert...

Grüße
Reinerlein

[aski71]

Hi Reinerlein,

ich habe mich bei der Vorgehensweise ans Wiki gehalten.

Dort steht, dass man es an den Player-Devices machen soll.
Ich habe auch tatsächlich je Steckdose nur 1 DOIF/DOELSE.

Am Sonos-Device ein disable zentral zu schalten, macht doch irgendwie keinen Sinn, oder? 
Ich habe ja drei unterschiedliche Schaltsteckdosen, die nicht zwangsweise alle an oder alle aus sind.
Es kann sein, dass die Schaltsteckdose im Büro, an der die ONE hängt, aus ist, während die Schaltsteckdose im Wohnzimmer, an der die Playbase hängt, an ist.
Ich brauche also die Möglichkeit, dass die ONE im Büro neu mit Fhem verbunden wird, wenn diese Steckdose angeht.
Und dass die Playbase neu mit fhem verbunden wird, wenn jene Steckdose angeht.
Wenn ich das nur mittels des zentralen Sonos-Device schalten kann, müsste ich ja immer alle Steckdosen gleichzeitig einschalten?!

VG Alex

[Reinerlein]

Hi Alex,

im Normalfall kannst du die Player einfach abschalten, sie werden dann nach einer Weile als disappeared festgestellt, und bei Bedarf einfach wieder anschalten. Nach dem Anschalten erfolgt eine Erkennung und Aktivierung automatisch.

Ein Disable (oder "Enable") am Player startet keinerlei Erkennungsvorgang. Auch wird bei einem Disable der Erkennungsvorgang nicht unterbunden. Lediglich die Verarbeitung von Aktualisierungen durch den Player (wenn also z.B. eine Wiedergabe gestoppt oder gestartet wird) wird damit eingestellt.

Dem entgegen gibt es am zentralen Sonos-Device ein Disable, welches den gesamten Subprozess beendet (oder eben startet).
Das steuern manche, da der Prozess nicht bei jedem stabil läuft.

Du meinst sicherlich das Beispiel 14.19, wo es um ein Beispiel für den Betrieb an einer Funksteckdose geht. Das meint tatsächlich das zentrale Device, und nur dann, wenn es bei dem normalen Vorgehen zu Problemen kommt.

In deinem Fall würde ich erstmal von einem disable der einzelnen Player abraten, und mal schauen, was passiert.

Grüße
Reinerlein

[aski71]

Hi Reinerlein,

ja, das Beispiel 14.19. Dann hatte ich das wohl falsch verstanden.

Der Zustand bei mir ohne DOIFs ist, wie mir scheint, folgender:
Sobald z.B. das Wohnzimmer 5.1 stromlos wird, reißt das nach einer gewissen Zeit wohl das FHEM Sonos Hauptdevice mit in den Abgrund.
Sprich: Alle Player gehen auf disappeared. Auch wenn deren Stromversorgung an bleibt.
Das FHEM Sonos Hauptdevice wird dann als "disabled" gezeigt.
Da kommt leider auch nix mehr auf die Füße, wenn man die Steckdose einschaltet.

Erst wenn ich dann am Hauptdevice das Attribut "disabled" setze und wieder lösche, gehen alle Player wieder auf "appeared".

[Reinerlein]

Hi Alex,

kannst du mal vom SubProzess die Logausgabe auf Level 5 mitschreiben lassen, und die Zeilen vor einem solchen "disappeared"-Wechsel hier posten?
Eigentlich ist der Bereich mittlerweile stabil. Es gibt im Bereich von Speak und PlayURITemp bekannte Ausfälle, aber da bin ich dran...

Danke schon mal.

Grüße
Reinerlein

[aski71]

Ich sehe im Log nichts auf "disappeared" wechseln.
Stattdessen endet der Log nachts um Halbzwölf einfach. Ich hab Dir mal das Ende hier rausgeschnitten:

Code Auswählen Erweitern

2019.01.07 23:33:31 4: SONOS3: 192.168.2.40 is alive
2019.01.07 23:33:31 4: SONOS3: IsAlive-Event UDN=RINCON_7828CAB2221A01400_MR
2019.01.07 23:33:31 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CAB2221A01400_MR, reading, location, ) -> http://192.168.2.50:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: Location: http://192.168.2.50:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: PingType: syn
2019.01.07 23:33:31 4: SONOS3: 192.168.2.50 is alive
2019.01.07 23:33:31 4: SONOS3: IsAlive-Event UDN=RINCON_7828CA16089E01400_MR
2019.01.07 23:33:31 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CA16089E01400_MR, reading, location, ) -> http://192.168.2.42:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: Location: http://192.168.2.42:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: PingType: syn
2019.01.07 23:33:31 4: SONOS3: 192.168.2.42 is alive
2019.01.07 23:33:31 4: SONOS3: IsAlive-Event UDN=RINCON_7828CA17EDC401400_MR
2019.01.07 23:33:31 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CA17EDC401400_MR, reading, location, ) -> http://192.168.2.43:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: Location: http://192.168.2.43:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: PingType: syn
2019.01.07 23:33:31 4: SONOS3: 192.168.2.43 is alive
2019.01.07 23:33:31 4: SONOS3: IsAlive-Event UDN=RINCON_949F3E48AD3A01400_MR
2019.01.07 23:33:31 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_949F3E48AD3A01400_MR, reading, location, ) -> http://192.168.2.41:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: Location: http://192.168.2.41:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: PingType: syn
2019.01.07 23:33:31 4: SONOS3: 192.168.2.41 is alive
2019.01.07 23:33:31 4: SONOS3: IsAlive-Event UDN=RINCON_7828CAC9CA2601400_MR
2019.01.07 23:33:31 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CAC9CA2601400_MR, reading, location, ) -> http://192.168.2.52:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: Location: http://192.168.2.52:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: PingType: syn
2019.01.07 23:33:31 4: SONOS3: 192.168.2.52 is alive
2019.01.07 23:33:31 4: SONOS3: IsAlive-Event UDN=RINCON_949F3EC0DF0201400_MR
2019.01.07 23:33:31 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_949F3EC0DF0201400_MR, reading, location, ) -> http://192.168.2.62:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: Location: http://192.168.2.62:1400/xml/device_description.xml
2019.01.07 23:33:31 5: SONOS3: PingType: syn
2019.01.07 23:33:31 4: SONOS3: 192.168.2.62 is alive
2019.01.07 23:33:32 3: SONOS1: DeviceProperties-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.07 23:33:35 3: SONOS1: MusicServices-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.07 23:33:38 3: SONOS1: Alarm-Subscription for ZonePlayer "RINCON_7828CA16089E01400_MR" has expired and is now renewed.
2019.01.07 23:33:41 3: SONOS1: ZoneGroupTopology-Subscription for ZonePlayer "RINCON_7828CA16089E01400_MR" has expired and is now renewed.
2019.01.07 23:33:44 3: SONOS1: DeviceProperties-Subscription for ZonePlayer "RINCON_7828CA16089E01400_MR" has expired and is now renewed.
2019.01.07 23:33:47 3: SONOS1: Alarm-Subscription for ZonePlayer "RINCON_7828CA17EDC401400_MR" has expired and is now renewed.
2019.01.07 23:33:50 3: SONOS1: ZoneGroupTopology-Subscription for ZonePlayer "RINCON_7828CA17EDC401400_MR" has expired and is now renewed.
2019.01.07 23:33:53 3: SONOS1: DeviceProperties-Subscription for ZonePlayer "RINCON_7828CA17EDC401400_MR" has expired and is now renewed.
2019.01.07 23:33:56 3: SONOS1: Alarm-Subscription for ZonePlayer "RINCON_949F3E48AD3A01400_MR" has expired and is now renewed.
2019.01.07 23:33:57 5: SONOS0: Received: 'DoWork:undef:refreshProcessAnswer:'
2019.01.07 23:33:57 2: SONOS0: LastProcessAnswer way too old (Lastanswer: 1546900311 ~ 2019-01-07 23:31:51)... try to restart the process and connection...
2019.01.07 23:33:57 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos"
2019.01.07 23:33:57 4: SONOS0: ReadingsEndUpdate from Module for "Sonos"
2019.01.07 23:33:58 5: SONOS0: Received: 'shutdown'
2019.01.07 23:33:58 3: SONOS0: Disconnecting client and shutdown server...
2019.01.07 23:33:58 3: SONOS0: Trying to kill Sonos_Thread...
2019.01.07 23:33:58 3: SONOS0: Trying to kill LongJobs_Thread...
2019.01.07 23:33:58 3: SONOS0: Trying to kill IsAlive_Thread...
2019.01.07 23:33:58 3: SONOS0: Trying to kill PlayerRestore_Thread...
2019.01.07 23:33:58 0: SONOS0: Das Lauschen auf der Schnittstelle wurde beendet. Prozess endet nun auch...
2019.01.07 23:33:58 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Arbeiten"
2019.01.07 23:33:58 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Arbeiten"
2019.01.07 23:33:58 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Kochen"
2019.01.07 23:33:58 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Kochen"
2019.01.07 23:33:58 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Schlafzimmer"
2019.01.07 23:33:59 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Schlafzimmer"
2019.01.07 23:33:59 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Wohnen"
2019.01.07 23:33:59 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Wohnen"
2019.01.07 23:33:59 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Wohnen_LR"
2019.01.07 23:33:59 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Wohnen_LR"
2019.01.07 23:33:59 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Wohnen_RR"
2019.01.07 23:33:59 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Wohnen_RR"
2019.01.07 23:33:59 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Wohnen_SW"
2019.01.07 23:33:59 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Wohnen_SW"
2019.01.07 23:34:00 4: SONOS0: ReadingsBeginUpdate from Module for "Sonos_Wohnen"
2019.01.07 23:34:00 4: SONOS0: ReadingsEndUpdate from Module for "Sonos_Wohnen"

[aski71]

Gibt's irgendwas neues? Oder etwas, das ich nich tun kann, um dem Problem auf die Schliche zu kommen?

[aski71]

Ich stelle additiv folgendes Verhalten fest.

Konfig nochmal zusammen gefasst:
a) 2 Sonos One (je an einer eigenen Schaltsteckdose)
b) 1 Playbase (an einer Schaltsteckdose)
c) 1 Sub+ 2 Sonos One (zusammen an einer eigenen Schaltsteckdose, die in Abhängigkeit von b geschaltet wird.)
d) 1 Beam (immer am Strom)

Momentan kein Setzen des "disable" Attributs.
Über Nacht gehen alle Steckdosen aus. Morgens steht das Sonos Hauptdevice auf disabled und alle Player auf disappeared.

Schalte ich nur die beiden an a) aus, geht kein Gerät auf disappeared. Auch die beiden nicht.
Schalte ich zusätzlich b) aus, gehen alle auf disappeared und Sonos auf disabled. Aber nicht sofort. Das dauert eine Weile.

Ich hab dann mal bei ausgeschalteten Steckdosen das disable Attribut auf Sonos gesetzt und wieder gelöscht. Erwartungsgemäß ging nur d) auf appeared. Die anderen blieben auf disappeared.
Dann habe ich a, b, c eingeschaltet: Und alle gingen auf appeared.
Dann habe ich a, b, c wieder ausgeschaltet: Und alle blieben auf appeared. Auch nach längerer Zeit.
Dann habe ich a, b, c wieder eingeschaltet: Und alle gingen auf disappeared und das Sonos Device auf disabled.

Langsam versteh ich gar nix mehr. 

[Reinerlein]

Hi Alex,

sorry für die Pause...
Du hast das Fhem-Log gepostet, wo die Meldungen vom SubProzess und Fhem gemischt sind, und der Loglevel (verbose) ist zu klein...

Setz mal bitte das Attribut "SubProcessLogfileName" am Sonos-Device, und verbose auf 5 (auch am Sonos-Device). Dadurch werden die Log-Ausgaben des SubProzesses nicht mehr im Fhem-Log landen, und wegen 5 sehr(!) viel geloggt.
Dann provoziere mal deinen Disappeared-Zustand, und poste das (Ende des) SubProzess-Logfile hier.
Das müsste ja mit etwas offenem enden, wo er nicht mehr weiterreagiert... Vielleicht finden wir dann den Übeltäter heraus

Grüße
Reinerlein

[aski71]

Ok, kann ich machen.
Du schreibst: verbose auf 5 (auch am Sonos-Device)
Wo noch?
Ich hatte verbose NUR auf dem Sonos-Device auf 5 gesetzt.

[Reinerlein]

Hi Alex,

"auch" bezog sich auf die Tatsache, dass auch dieses Attribut am Sonos-Device gesetzt werden soll

Grüße
Reinerlein

[aski71]

Also:
Sonos Device auf verbose=5 gesetzt.
Mit SubProcessLogfileName ein eigenes Logfile erzeugt.

Der Log sieht aber nicht sehr viel anders aus, als der voran gegangene, den ich schon mal gepostet habe.
Was mich am meisten irritiert: Die Steckdosen gingen um ca. 17:00 Uhr aus.
Dann bin ich aus dem Haus gegangen.
Die IP Adressen der Sonos-Büchsen werden hier aber noch bis 18:43 als alive gemeldet....
Als ich nach Hause kam: Alles auf disappeared und Sonos Device auf disabled.

Code Auswählen Erweitern

2019.01.11 18:43:07 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CA16089E01400_MR, reading, location, ) -> http://192.168.2.42:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: Location: http://192.168.2.42:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: PingType: syn
2019.01.11 18:43:07 4: SONOS3: 192.168.2.42 is alive
2019.01.11 18:43:07 4: SONOS3: IsAlive-Event UDN=RINCON_7828CAB2221A01400_MR
2019.01.11 18:43:07 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CAB2221A01400_MR, reading, location, ) -> http://192.168.2.50:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: Location: http://192.168.2.50:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: PingType: syn
2019.01.11 18:43:07 4: SONOS3: 192.168.2.50 is alive
2019.01.11 18:43:07 4: SONOS3: IsAlive-Event UDN=RINCON_7828CAC9CA2601400_MR
2019.01.11 18:43:07 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CAC9CA2601400_MR, reading, location, ) -> http://192.168.2.52:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: Location: http://192.168.2.52:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: PingType: syn
2019.01.11 18:43:07 4: SONOS3: 192.168.2.52 is alive
2019.01.11 18:43:07 4: SONOS3: IsAlive-Event UDN=RINCON_B8E93746375101400_MR
2019.01.11 18:43:07 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_B8E93746375101400_MR, reading, location, ) -> http://192.168.2.40:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: Location: http://192.168.2.40:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: PingType: syn
2019.01.11 18:43:07 4: SONOS3: 192.168.2.40 is alive
2019.01.11 18:43:07 4: SONOS3: IsAlive-Event UDN=RINCON_949F3E48AD3A01400_MR
2019.01.11 18:43:07 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_949F3E48AD3A01400_MR, reading, location, ) -> http://192.168.2.41:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: Location: http://192.168.2.41:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: PingType: syn
2019.01.11 18:43:07 4: SONOS3: 192.168.2.41 is alive
2019.01.11 18:43:07 4: SONOS3: IsAlive-Event UDN=RINCON_949F3EC0DF0201400_MR
2019.01.11 18:43:07 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_949F3EC0DF0201400_MR, reading, location, ) -> http://192.168.2.62:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: Location: http://192.168.2.62:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: PingType: syn
2019.01.11 18:43:07 4: SONOS3: 192.168.2.62 is alive
2019.01.11 18:43:07 4: SONOS3: IsAlive-Event UDN=RINCON_7828CA17EDC401400_MR
2019.01.11 18:43:07 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CA17EDC401400_MR, reading, location, ) -> http://192.168.2.43:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: Location: http://192.168.2.43:1400/xml/device_description.xml
2019.01.11 18:43:07 5: SONOS3: PingType: syn
2019.01.11 18:43:07 4: SONOS3: 192.168.2.43 is alive
2019.01.11 18:43:09 3: SONOS1: Rendering-Subscription for ZonePlayer "RINCON_7828CAB2221A01400_MR" has expired and is now renewed.
2019.01.11 18:43:12 3: SONOS1: GroupRendering-Subscription for ZonePlayer "RINCON_7828CAB2221A01400_MR" has expired and is now renewed.
2019.01.11 18:43:15 3: SONOS1: ContentDirectory-Subscription for ZonePlayer "RINCON_7828CAB2221A01400_MR" has expired and is now renewed.
2019.01.11 18:43:18 3: SONOS1: Alarm-Subscription for ZonePlayer "RINCON_7828CAB2221A01400_MR" has expired and is now renewed.
2019.01.11 18:43:19 5: SONOS0: Received: 'DoWork:undef:refreshProcessAnswer:'
2019.01.11 18:43:21 3: SONOS1: ZoneGroupTopology-Subscription for ZonePlayer "RINCON_7828CAB2221A01400_MR" has expired and is now renewed.
2019.01.11 18:43:24 3: SONOS1: DeviceProperties-Subscription for ZonePlayer "RINCON_7828CAB2221A01400_MR" has expired and is now renewed.
2019.01.11 18:43:28 3: SONOS1: MusicServices-Subscription for ZonePlayer "RINCON_7828CAB2221A01400_MR" has expired and is now renewed.
2019.01.11 18:43:28 3: SONOS1: Transport-Subscription for ZonePlayer "RINCON_949F3EC0DF0201400_MR" has expired and is now renewed.
2019.01.11 18:43:28 3: SONOS1: Rendering-Subscription for ZonePlayer "RINCON_949F3EC0DF0201400_MR" has expired and is now renewed.
2019.01.11 18:43:28 3: SONOS1: GroupRendering-Subscription for ZonePlayer "RINCON_949F3EC0DF0201400_MR" has expired and is now renewed.
2019.01.11 18:43:28 3: SONOS1: ContentDirectory-Subscription for ZonePlayer "RINCON_949F3EC0DF0201400_MR" has expired and is now renewed.
2019.01.11 18:43:28 3: SONOS1: Alarm-Subscription for ZonePlayer "RINCON_949F3EC0DF0201400_MR" has expired and is now renewed.
2019.01.11 18:43:28 3: SONOS1: ZoneGroupTopology-Subscription for ZonePlayer "RINCON_949F3EC0DF0201400_MR" has expired and is now renewed.
2019.01.11 18:43:28 3: SONOS1: DeviceProperties-Subscription for ZonePlayer "RINCON_949F3EC0DF0201400_MR" has expired and is now renewed.
2019.01.11 18:43:28 3: SONOS1: MusicServices-Subscription for ZonePlayer "RINCON_949F3EC0DF0201400_MR" has expired and is now renewed.
2019.01.11 18:43:30 3: SONOS1: Transport-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.11 18:43:33 3: SONOS1: Rendering-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.11 18:43:36 3: SONOS1: GroupRendering-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.11 18:43:37 4: SONOS3: IsAlive-Event UDN=RINCON_7828CA16089E01400_MR
2019.01.11 18:43:37 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CA16089E01400_MR, reading, location, ) -> http://192.168.2.42:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: Location: http://192.168.2.42:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: PingType: syn
2019.01.11 18:43:37 4: SONOS3: 192.168.2.42 is alive
2019.01.11 18:43:37 4: SONOS3: IsAlive-Event UDN=RINCON_7828CAB2221A01400_MR
2019.01.11 18:43:37 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CAB2221A01400_MR, reading, location, ) -> http://192.168.2.50:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: Location: http://192.168.2.50:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: PingType: syn
2019.01.11 18:43:37 4: SONOS3: 192.168.2.50 is alive
2019.01.11 18:43:37 4: SONOS3: IsAlive-Event UDN=RINCON_7828CAC9CA2601400_MR
2019.01.11 18:43:37 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CAC9CA2601400_MR, reading, location, ) -> http://192.168.2.52:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: Location: http://192.168.2.52:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: PingType: syn
2019.01.11 18:43:37 4: SONOS3: 192.168.2.52 is alive
2019.01.11 18:43:37 4: SONOS3: IsAlive-Event UDN=RINCON_B8E93746375101400_MR
2019.01.11 18:43:37 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_B8E93746375101400_MR, reading, location, ) -> http://192.168.2.40:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: Location: http://192.168.2.40:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: PingType: syn
2019.01.11 18:43:37 4: SONOS3: 192.168.2.40 is alive
2019.01.11 18:43:37 4: SONOS3: IsAlive-Event UDN=RINCON_949F3E48AD3A01400_MR
2019.01.11 18:43:37 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_949F3E48AD3A01400_MR, reading, location, ) -> http://192.168.2.41:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: Location: http://192.168.2.41:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: PingType: syn
2019.01.11 18:43:37 4: SONOS3: 192.168.2.41 is alive
2019.01.11 18:43:37 4: SONOS3: IsAlive-Event UDN=RINCON_949F3EC0DF0201400_MR
2019.01.11 18:43:37 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_949F3EC0DF0201400_MR, reading, location, ) -> http://192.168.2.62:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: Location: http://192.168.2.62:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: PingType: syn
2019.01.11 18:43:37 4: SONOS3: 192.168.2.62 is alive
2019.01.11 18:43:37 4: SONOS3: IsAlive-Event UDN=RINCON_7828CA17EDC401400_MR
2019.01.11 18:43:37 4: SONOS3: SONOS_Client_Data_Retreive(RINCON_7828CA17EDC401400_MR, reading, location, ) -> http://192.168.2.43:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: Location: http://192.168.2.43:1400/xml/device_description.xml
2019.01.11 18:43:37 5: SONOS3: PingType: syn
2019.01.11 18:43:37 4: SONOS3: 192.168.2.43 is alive
2019.01.11 18:43:39 3: SONOS1: ContentDirectory-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.11 18:43:43 3: SONOS1: Alarm-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.11 18:43:46 3: SONOS1: ZoneGroupTopology-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.11 18:43:49 3: SONOS1: DeviceProperties-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.11 18:43:52 3: SONOS1: MusicServices-Subscription for ZonePlayer "RINCON_B8E93746375101400_MR" has expired and is now renewed.
2019.01.11 18:43:52 5: SONOS0: Received: 'DoWork:undef:refreshProcessAnswer:'
2019.01.11 18:43:53 5: SONOS0: Received: 'shutdown'
2019.01.11 18:43:53 3: SONOS0: Disconnecting client and shutdown server...
2019.01.11 18:43:53 3: SONOS0: Trying to kill Sonos_Thread...
2019.01.11 18:43:53 3: SONOS0: Trying to kill LongJobs_Thread...
2019.01.11 18:43:53 3: SONOS0: Trying to kill IsAlive_Thread...
2019.01.11 18:43:53 3: SONOS0: Trying to kill PlayerRestore_Thread...
2019.01.11 18:43:53 0: SONOS0: Das Lauschen auf der Schnittstelle wurde beendet. Prozess endet nun auch...

[Reinerlein]

Hi Alex,

spiel mal etwas mit dem Attribut "pingType" am Sonos-Device herum.
Ich verwende dort "icmp", das braucht allerdings root-Rechte für Fhem... wenn das bei dir nicht passt, versuch mal "tcp" oder andere...

Grüße
Reiner

[aski71]

Also pingType auf tcp umstellen löst schon mal das Problem, dass die Kisten trotz Stromabschaltung nicht disappeared gingen.
Funktioniert jetzt innerhalb etwa einer Minute.

[aski71]

Nach zwei Tagen kann ich jetzt sagen: Damit ist wohl auch das andere Problem behoben.
Ich hatte seitdem keine Totalverabschiedung des Sonos Devices mehr. 
Danke! Wäre vielleicht eine Überlegung wert, den default-pingType auf was weniger von root abhängiges zu setzen?!

[Reinerlein]

Hi Alex,

das Problem ist, dass es leider keine allgemein und überall funktionierende Standardeinstellung gibt.
Ping (icmp) funktioniert eigentlich immer, braucht aber Root-Rechte, die anderen Varianten muss man immer ausprobieren...

Schön, dass es jetzt geht

Grüße
Reiner

[aski71]

Verstehe.
Danke für die Hilfe!

VG Alex