FHEM Forum

FHEM - Anwendungen => Multimedia => Thema gestartet von: Reinerlein am 14 Mai 2017, 16:43:29

Titel: Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 14 Mai 2017, 16:43:29
Hallo zusammen,

endlich mal wieder ein Update :) Es hat sich doch einiges angesammelt, aber da es auch stabil laufen soll, lief es auch einige Zeit auf meinem Teststand...

Im Wesentlichen ist die Abfrage der von Sonos per Webservice bereitgestellten Informationen zu den Musikanbietern hinzugekomnen. Dabei werden Name, Icon und Infotexte geladen.
Dadurch werden jetzt kleine rechteckige und runde Icons zur Verfügung gestellt, die auch in der Weboberfläche verwendet und angezeigt werden.
Für die nicht automatisch gelieferten Provider (wie Bibliothek und LineIn-Eingänge oder auch TuneIn) habe ich Icons gebaut, die dann ausgeliefert werden.

Außerdem habe ich die Prüfkommunikation zum SubProzess etwas umgebaut. Bislang konnte es passieren, dass eine Prüfabfrage durchgeführt wurde, obwohl gerade Daten übertragen wurden. Dabei konnte es zu blöden Zuständen kommen.
Nun wird nur noch abgefragt, wenn in dem letzten Zeitraum keinerlei Daten übertragen wurden. Damit sollten diese Überschneidungen Geschichte sein.

Des Weiteren gibt es jetzt ein Reading "currentSource", welches die Quelle für den aktuellen Titel angibt. Das kann der Name einer Sonos-Playliste sein, aber auch einer Spotify-Playliste oder ein Albumname.

Zusätzlich gibt es jetzt die Möglichkeit einen internen Mechanismus für die Simulation der currentTrackPosition zu aktivieren. Das Intervall dieser Simulation kann eingestellt werden, falls man nicht sekündlich ein Event in Fhem haben möchte :)

Eine große Änderung ist auch die jetzige Möglichkeit, die Cover- und Titelanzeige intern vom Modul durchführen zu lassen. Das bedeutet, dass die zusätzlichen Devices für die Titelanzeige (eine ReadingsGroup) und die Steuerung (ein RemoteControl, ein Weblink und ein Notify dazu) nicht mehr notwendig sind. Wer sie dennoch weiterhin verwenden möchte, kann die Darstellung in der Raumansicht wieder auf die DeviceZeile beschränken. In der Detailansicht bleibt die neue Anzeige aber immer bestehen.

Und ich habe natürlich mein Tablet-UI-Beispiel im Wiki angepasst. Dort werden vor Allem die neuen Features bzgl. der currentTrackPositionSimulation und die neuen ProviderIcons verwendet. Außerdem wird die aktuelle Quelle über dem Cover angezeigt...

Alle Änderungen im Detail:

Wie immer ab sofort im SVN oder ab Morgen per update.
Viel Spaß damit...

Grüße
Reinerlein
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: l2r am 15 Mai 2017, 18:23:51
hi Danke für die Aktualisierung!

ich hatte bei mir die Sonos im Bad mal zu Testzwecken gelöscht und vom Sonos-Device wieder anlegen lassen.

Folgende Meldung ist noch im Log erschienen:
2017.05.15 18:16:15 1: SONOS1: Successfully autocreated SonosPlayer 'Bad' (S1) as 'Sonos_Bad' with Software Revision 7.2 and ID 'RINCON_5CAAFD9AC7XXXXXXX_MR'
2017.05.15 18:16:32 1: PERL WARNING: Argument "0:00:00" isn't numeric in addition (+) at ./FHEM/21_SONOSPLAYER.pm line 386.


Gruß Michael
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tom71 am 15 Mai 2017, 20:53:03
Hallo,
ich erhalte seit kurzem immer wieder diese Meldung:
Loading device description failed with error: 500 Can't connect to 192.168.40.2:49000 (Location: http://192.168.40.2:49000/igddesc.xml) at ./FHEM/00_SONOS.pm line 4311 thread 1.

Version von 00_SONOS.pm ist:
$Id: 00_SONOS.pm 14279 2017-05-14 11:18:12Z Reinerlein $

Ich kann damit leider nichts anfangen. Mein IP-Adress-Bereich ist 192.168.0/25 . Ich finde auch nichts mit der Konfig von 192.168.40.2

Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: MikeRoxx am 15 Mai 2017, 21:23:26
Hallo Rainer,

ich bekomme im Sekundentakt die Meldung ins Logfile, da kommen schnell mal 100MB zusammen:

recv() on unopened socket 1 at FHEM/lib/UPnP/ControlPoint.pm line 447, <$client> line 5.

Das kommt wohl daher:
ZitatIn der Datei ControlPoint.pm wurde beim Öffnen des SSDP-Ports das Attribut ReusePort hinzugefügt (sofern das Betriebssystem das unterstützt).

sub _receiveSSDPEvent {
my $self = shift;
my $socket = shift;
my $buf = '';

my $peer = recv($socket, $buf, 2048, 0);  <---------------  Hier ist Zeile 447
return if (!defined($peer));

my @peerdata = unpack_sockaddr_in($peer);
return if (!@peerdata);

return if (scalar(%USEDONLYIP) && (!$USEDONLYIP{inet_ntoa($peerdata[1])}));
return if ($IGNOREIP{inet_ntoa($peerdata[1])});

if ($buf !~ /\015?\012\015?\012/) {
return;
}


Leider kann ich das nicht beheben. Habe die alte ControlPoint.pm wieder verwendet.

Als ignoredIP habe ich einen Samsung TV eingetragen 192.168.178.45, da hattest du mir schon einmal geholfen:
https://forum.fhem.de/index.php/topic,41640.msg339516.html#msg339516 (https://forum.fhem.de/index.php/topic,41640.msg339516.html#msg339516)

Gruß
Mike
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: FunkOdyssey am 15 Mai 2017, 21:25:11
Meine Player-Devices in FHEM aktualisieren nun gar nichts mehr. Keine Readings.
Und es steht überall "Player disappeared".
Läuft bei euch alles nach diesem Update?
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: MikeRoxx am 15 Mai 2017, 21:36:12
Hi,

ich hatte bei meinem Player mal das attribut disable auf 0 gesetzt. Dann ging es wieder

Zitat von: FunkOdyssey am 15 Mai 2017, 21:25:11
Und es steht überall "Player disappeared".

Gruß
Mike
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: FunkOdyssey am 15 Mai 2017, 22:09:11
Hmm. Stimmt. Da war ja was.
Wobei ich sogar den RasPi schon komplett neu gestartet hatte.
Nun ja. jetzt läuft es.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: fhem-challenge am 15 Mai 2017, 22:31:47
Zitat von: Reinerlein am 14 Mai 2017, 16:43:29
Hallo zusammen,

endlich mal wieder ein Update :) Es hat sich doch einiges angesammelt, aber da es auch stabil laufen soll, lief es auch einige Zeit auf meinem Teststand...

Im Wesentlichen ist die Abfrage der von Sonos per Webservice bereitgestellten Informationen zu den Musikanbietern hinzugekomnen. Dabei werden Name, Icon und Infotexte geladen.
Dadurch werden jetzt kleine rechteckige und runde Icons zur Verfügung gestellt, die auch in der Weboberfläche verwendet und angezeigt werden.
Für die nicht automatisch gelieferten Provider (wie Bibliothek und LineIn-Eingänge oder auch TuneIn) habe ich Icons gebaut, die dann ausgeliefert werden.
... SNIP

Grüße
Reinerlein


Nach dem SONOS Update gibt es bei mir ausschliesslich Chaos. Ich bekomme  x*10E6 Logevents. der folgenden Art. FHEM ist dann de facto nicht mehr bedienbar.
Ich habe auf die Alte "SONOS.pm" umgestellt, damit gehts wieder.


recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.
recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447.



Wenn mann auch noch "RescanNetwork" macht, bricht das Chaos erneut los.

... mal so zum Spass, erstaunlich wie viele "recv() on unopened socket 1 at /opt/fhem/FHEM/lib/UPnP/ControlPoint.pm line 447." Controlpoint.pm ins log schreiben kann. Pro Sekunde sind es > 10.000.

root@fhem:~# cat /opt/fhem/log/fhem-2017-05.log | wc -l
646330
root@fhem:~# cat /opt/fhem/log/fhem-2017-05.log | wc -l
664322
root@fhem:~# cat /opt/fhem/log/fhem-2017-05.log | wc -l
699803
root@fhem:~# cat /opt/fhem/log/fhem-2017-05.log | wc -l
717031
root@fhem:~# cat /opt/fhem/log/fhem-2017-05.log | wc -l
725568



Da wundert's mich nicht, das FHEM aufgibt, was es dann natürlich auch macht.



Viele Grüße!


Andreas
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 15 Mai 2017, 23:16:07
Hallo zusammen,

@Michael: Da hat sich ein falscher Defaultwert eingeschlichen.. das korrigiere ich gleich.

@Tom71: Der Port 49000 mit dem igddesc.xml scheint etwas von der Fritzbox zu sein. Einfach auch auf die Ignore-Liste setzen.

@Mike: hmm. das ist der Handler, der die Antworten auf das SSDP verarbeiten soll. Dort habe ich keine Änderung gemacht. Die Änderung ist ab Zeile 81...
Da scheint irgendwas mit der Portverbindung nicht gut zu laufen. ReUse Port soll ja das Verbinden mit einem Port ermöglichen, obwohl er vielleicht noch belegt ist. Ich werde das wohl konfigurierbar machen, da es anscheinend bei manchen nicht sauber läuft.
Ich brauchte z.B. beim erstenmal auch nicht einfach einen Fhem Neustart, sondern ein Beenden des SubProzesses (also ein disable auf dem Sonos-Device, mit einer Pause, und wieder löschen des disable).

@Andreas: Da reicht es, die ControlPoint.pm auszutauschen. Wie bei Mike, ich werde das mit dem Reuse konfigurierbar machen. Mal schauen, ob ich das gleich noch schaffe...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Loredo am 15 Mai 2017, 23:18:09
Traumhaft, super Arbeit Reinerlein!  :D


Zwei Dinge sind mit aufgefallen:

1. Der Cover-Proxy funktioniert leider noch nicht mit dem FHEMWEB Attribut webname zusammen. Die Lösung dafür ist im Reading nicht eine fixe URI mit /fhem/ beginnend hinzuschreiben, sondern den Webnamen wegzulassen und nur ? hinzuschreiben. Natürlich muss der Infix entsprechend angepasst werden. So funktioniert es bei meinem ONKYO_AVR Modul problemlos mit den Covern.

2. Die Web Darstellung beißt sich leider etwas, wenn man webCmd und cmdIcon verwendet (siehe Screenshot).



VG
Julian
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 16 Mai 2017, 00:19:06
Hi zusammen,

so, habe eine neue Version eingecheckt.

@Julian: Für den Webname habe ich ein Attribut "webname" am Sonos-Device hinzugefügt, da das Modul viele Links ohne Zugriff über eine FhemWeb-Instanz zusammenbaut, und ich damit keinerlei Zugriff auf den verwendeten Web-Namen habe.
Bei deinem Detaildarstellungsproblem muss ich noch etwas forschen...

Hier die eingebauten Änderungen:
Wie immer ab sofort im SVN oder ab Morgen im Update...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Loredo am 16 Mai 2017, 00:36:02
Zitat von: Reinerlein am 16 Mai 2017, 00:19:06
@Julian: Für den Webname habe ich ein Attribut "webname" am Sonos-Device hinzugefügt, da das Modul viele Links ohne Zugriff über eine FhemWeb-Instanz zusammenbaut, und ich damit keinerlei Zugriff auf den verwendeten Web-Namen habe.


Hm, da komme ich gerade nicht ganz mit. Warum müsste das Modul denn überhaupt von der jeweiligen FHEMWEB Instanz wissen? Bei Verwendung des ? ist das unerheblich, denn der Browser kümmert sich darum es an die verwendete URI (und somit auch die vom User angesprochene FHEMWEB Instanz) anzuhängen. Ein Attribut "webname" am Sonos-Device hilft da leider nicht weiter, denn es beschränkt mich nach wie vor auf die Verwendung einer einzelnen FHEMWEB Instanz, die jetzt eben nur anders als /fhem heißen kann. Der Trick ist wirklich die Verwendung des Fragezeichens als Teil des Infix-Namens, damit man unabhängig von der FHEMWEB Instanz bleibt.





Gruß
Julian
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 16 Mai 2017, 01:37:38
Hi Julian,

es werden einige Links auf die statischen Coverbildchen oder Proxypfade zusammengebaut, die keine Fragezeichen enthalten (bzw. weiter hinten). Was sollte ich dort denn angeben?

Die URLs lauten dann ja z.B.

/fhem/sonos/cover/empty.jpg
oder
/fhem/sonos/proxy/aa?url=urlEncodedOriginalURL

Wenn ich dort nur

sonos/cover/empty.jpg
oder
sonos/proxy/aa?url=urlEncodedOriginalURL

erzeugen würde, würde der Browser doch das "fhem" auch weglassen. Ein Fragezeichen als erstes Zeichen würde auch nicht gehen, da damit FhemWeb die Verarbeitung meiner Cover und Proxy machen müsste, und die Anfrage damit nicht in meinem Modul landen würde...

Das liegt an dem unüblichen Aufbau einer Fhem-URL.
Eigentlich sollten die ja eher so lauten:

https://192.168.0.0:1234/fhem/room?name=Wohnzimmer
oder
https://192.168.0.0:1234/fhem/detail?name=Sonos

oder mehr nach REST-Paradigma

https://192.168.0.0:1234/fhem/room/Wohnzimmer
bzw.
https://192.168.0.0:1234/fhem/detail/Sonos

Dann würden auch meine statischen URLs durch weglassen des "/fhem/"-Webname funktionieren (zumindest in der nicht-REST-Variante).
Gleichzeitig müsste das Attribut webname eigentlich nicht an einer Fhemweb-Instanz hängen, sondern an global (damit man innerhalb der Applikation Fhem darauf als "statischen" Wert zugreifen kann), da die FhemWeb-Instanzen sich ja bereits durch die Ports unterscheiden...
Dann könnte man auch wieder die REST-Variante zusammenbauen...

Und ja, ich kenne es nur so, dass eine Applikation nur über einen Webname erreichbar ist... Wozu sollte man auch Port und Webname gleichzeitig unterschiedlich gestalten, wenn man diesselbe Anwendung meint? Der Webname stammt ja aus dem Bereich der Webapplikationsserver, die damit die Unterscheidung treffen, um welche der vielen Installierten Applikationen es sich handeln soll, damit man beim Administrieren und Ausführen des Systems die internen Namensräume sauber getrennt bekommt.
Die Portnummer definiert im Normalfall den "Dienst" oder die "Art-und-Weise" wie zugegriffen wird. Meint als Konvention z.B. 80 für HTTP oder 443 für HTTPS...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tom71 am 16 Mai 2017, 15:04:29
Hallo,
in der neuen sowie alten Version wird das MP3-File von speak im Wurzelverzeichnis von fhem abgelegt: /opt/fhem/RINCON_949F3E7407DE01400_MR_Speak.mp3

obwohl gesetzt ist:

attr Sonos targetSpeakDir /opt/fhem/SonosSpeak
attr Sonos targetSpeakURL \\192.168.0.38\SonosSpeak
attr Sonos targetSpeakFileTimestamp
attr Sonos targetSpeakMP3FileDir /opt/fhem/SonosSpeak


Rechte auf dem Verzeichnis sind: drwxrwxrwx  2 fhem dialout   4096 Mai 16 15:12 SonosSpeak

2017.05.16 14:53:48 3: SONOS1: Load Google generated MP3 (1. Element) from "http://translate.google.com/translate_tts?tl=de&client=tw-ob&q=%20Waschmaschine%20ist%20fertig" to "./RINCON_949F3E7407DE01400_MR_Speak.mp31"
2017.05.16 14:53:48 3: SONOS1: Combine loaded chunks into "./RINCON_949F3E7407DE01400_MR_Speak.mp3"
2017.05.16 14:53:48 3: SONOS1: Start temporary playing of "/RINCON_949F3E7407DE01400_MR_Speak.mp3"

==> /opt/fhem/log/Sonos-2017-05.log <==
2017-05-16_14:53:49 Sonos_Wohnen LastActionResult: PlayURITemp: Success!


Danach spielt der Speaker einfach den letzten Song ab, obwohl vor "speak" auf Pause gesetzt war.

@Reinerlein Was meintest du mit "Ignore-Liste"? attr ignoredIPs ?
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 16 Mai 2017, 15:11:52
Hi Tom71,

genau, in das Attribut "ignoredIPs" am Sonos-Device einfach die IP-Adressen eintragen, die komisch stören. Diese werden dann ignoriert.

Zu deinem Speak: Hast du nach dem Setzen des Attributs den Sonos-SubProzess neugestartet?
Einmal das Attribut "disable" am Sonos-Device setzen, ein paar Sekunden warten, und das Attribut einfach wieder löschen...

Grüße
Reinerlein
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tom71 am 16 Mai 2017, 15:32:40
Krass ;-) Was immer es war. Jetzt geht es. Ich hab schon mehrmals alles gelöscht und wieder neu gestartet. Aber etwas hakelig ist es immer noch. Der Fhem-Player zeigt oft nicht an, was ich im iPhone ausgewählt habe.

In der älteren Version hatte ich nur einen Sonos Player ( Ich habe 2 Boxen zu einem Stereo-Paar verbunden). Jetzt habe ich 2 Player
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 16 Mai 2017, 16:05:51
Hi Tom71,

was meinst du mit "nur einen Player"?
Das Modul legt für jeden gemeldeten, physikalischen Sonosplayer ein Fhem-Device an. Allerdings sollte Standardmäßig nur bei den Masterdevices eine Cover-/Titelanzeige erfolgen.

Kannst du da mal einen Screenshot posten?

Grüße
Reinerlein
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: FunkOdyssey am 16 Mai 2017, 16:07:58
Ich vermute, dass hier die alten ReadingsGroups gemeint sind.
Ich selbst habe auch gerade erst (wie beschrieben) alle notifys, weblinks, remoteControls und readingsGroups gelöscht.




Am Rande: Ich habe einige falsche URLs in den Readings.

currentTrackURI
http://http://wdr-4.akacast.akamaistream.net/7/42/119438/v1/gnl.akacast.akamaistream.net/wdr-4

currentTrackHandle
ähnlich




Die folgenden readingsGroup gibt es nun nur noch ein einziges mal in FHEM. Das ist gewollt, oder?

*RG_Favourites
*RG_Playlists
*RG_Radios

Vorher hatte ich diese je SONOS-Gerät.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tom71 am 16 Mai 2017, 16:18:19
Ich hatte zuvor alle Sonos Devices gelöscht und nach dem Upgrade neu angelegt.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: FunkOdyssey am 16 Mai 2017, 16:20:25
Hast du denn auch die anderen Geräte (siehe mein Post oben) gelöscht?
Eigentlich hättest du nur diese löschen müssen. Nicht den Player.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tom71 am 16 Mai 2017, 16:31:51
Hatte ich gemacht. Aber doppelt hält besser. Also nochmal alles gelöscht und nun ist nur noch ein Player da.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 16 Mai 2017, 18:13:02
Hallo FunkOdyssey,

eigentlich sollten die für jedes Device existieren, aber auch nur, wenn du sie brauchst.
Das sind ReadingsGroups, die die Favouriten, Playlists und Radios eines Devices anzeigen können. Da die Dinger direkt auf dem entsprechenden Player den Eintrag starten, gibt es die entsprechend auch für jeden Player.

Wenn du die sowieso nicht verwendest, kannst du die natürlich auch löschen. Das sollte nur als Vorlage dienen.
Wenn du auf einem Player z.B. "get <Player> FavouritesWithCovers" ausführst, dann enthält die entsprechende ReadingsGroup die Liste (umstellbar zwischen Liste mit danebenstehendem Namen, oder als reine Covermenge)...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Wuppi68 am 17 Mai 2017, 10:57:23
Moin Zusammen,

ich habe ein Problem :-)

Meine Sonos Play I (4 Stück) sind sporadisch auf disapeared :-(

Manchmal hilf ein Dis/Enable des Sonos Moduls
Manchmal ein Neustart von FHEM
aber meistens NUR ein Neustart des gesamten Computers :-(

Dieses Problem scheint auch Computer unabhängig zu sein, da es auf meinem Cubietruck auch schon vorhanden war und mit dem Umzug auf nen Intel I3 mitgewandert ist :-( Die Sonos APP findet die Player immer ...
Sonos komplett löschen und neu anlegen nach FHEM Neustart findet auch nicht die disappearten Player.

Jetzt noch ein wenig zur Netzkonfiguration:
Alle Sonos Player sind mit statischer DHCP IP im Media VLAN und WLAN
FHEM hat auch LAN Interface im Media VLAN
Ping funktiniert immer
Routing ist auch in Ordnung

Jemand eine Idee?
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 17 Mai 2017, 11:12:31
Hi Wuppi68,

wenn die Player im Modul auf disappeared stehen, dann hat der IsAlive-Checker diesen nicht mehr entdecken können. Das hilft dir jetzt viel, nicht wahr? :)

Entweder du versuchst es mal mit einem anderen "pingType" am Sonos-Device, oder du untersuchst mal allgemein, ob der Fhem-Rechner stets Zugriff in das richtige Netz zu den Playern hat. Nicht das da nach einer Weile irgendwelche Routen oder Netzmasken ignoriert werden oder kurzzeitig ungültig sind.
Vielleicht kannst du mal mit einem parallel eingerichteten lanping schauen, ob der Rechner an sich immer zu den Player hinkommt...
Immerhin reden wir auch von Multicast-Routen, die vom Betriebssystem dynamisch gehandhabt werden müssen...

Wenn du schreibst, dass oftmals nur ein Neustart des Rechners hilft, dann deutet das eher auf ein Problem eine Ebene tiefer hin...

Grüße
Reinerlein
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Wuppi68 am 17 Mai 2017, 12:51:32
Zitat von: Reinerlein am 17 Mai 2017, 11:12:31
Hi Wuppi68,

wenn die Player im Modul auf disappeared stehen, dann hat der IsAlive-Checker diesen nicht mehr entdecken können. Das hilft dir jetzt viel, nicht wahr? :)

stimmt ist ja auch die logische Konsequenz ;-)

Kannst Du nicht auch eine Option ForceIPs mit aufnehmen für so Wackelkandidaten wie meine Player?

Zitat von: Reinerlein am 17 Mai 2017, 11:12:31
Entweder du versuchst es mal mit einem anderen "pingType" am Sonos-Device, oder du untersuchst mal allgemein, ob der Fhem-Rechner stets Zugriff in das richtige Netz zu den Playern hat. Nicht das da nach einer Weile irgendwelche Routen oder Netzmasken ignoriert werden oder kurzzeitig ungültig sind.

den Ping Type habe ich noch nicht geändert - steht ab sofort auf meiner ToDo Liste und werde berichten

Zitat von: Reinerlein am 17 Mai 2017, 11:12:31
Vielleicht kannst du mal mit einem parallel eingerichteten lanping schauen, ob der Rechner an sich immer zu den Player hinkommt...
Immerhin reden wir auch von Multicast-Routen, die vom Betriebssystem dynamisch gehandhabt werden müssen...

für Multicast habe ich gar nichts auf meinen Linuxboxen gemacht (weder am Cubietruck AltSystem noch am neuen Intel I3 PC mit Debian)

Zitat von: Reinerlein am 17 Mai 2017, 11:12:31
Wenn du schreibst, dass oftmals nur ein Neustart des Rechners hilft, dann deutet das eher auf ein Problem eine Ebene tiefer hin...

ja leider :-(

Im Fehlerfall kann ich vom FHEM Rechner immer die Sonos System anpingen - egal ob über das Media Eigene Interface, oder über das Hauptinterface (geroutet)

Ich glaube ich baue ein Notify auf den disappeared und starte dann mal für 2 Minuten oder einen Ping unter Linux

Was eventuell noch ein Hinweis sein kann: Mein WLAN ist zu 98% von der Aussenkamera belegt 8-) aber es funktioniert alles via App incl. 4 Streams gleichzeitig

Zitat von: Reinerlein am 17 Mai 2017, 11:12:31
Grüße
Reinerlein

Auch ganz liebe Grüße und einen Riesen Dank an die Sonos Unterstützung

Ralf

PS.: Die WLan Kamera ist schon fast in der Tonne - der Ersatz via LAN Kabel und POE wartet nur noch auf Einbau
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 17 Mai 2017, 13:57:18
Hi Ralf,

so etwas wie "forceIPs" geht im Kontext von UPnP nicht. Da das System auf Broadcasts aufbaut. Lediglich die direkten Befehle sind dann einfache SOAP-Pakete. Aber nach der Definition von UPnP könnte das Ausführen von Befehlen auf den Playern auch geblockt werden, wenn man nicht vorher die Bekanntschaft mittels Broadcast gemacht hat :) Monentan macht Sonos so etwas nicht, könnte aber ja kommen...

Der andere Punkt: Mein Modul baut natürlich komplett auf diesen UPnP Erkennungen und anschließender Steuerung auf. Das wäre zunächst mal eine große Baustelle... Ich kann es aber mal im Hinterkopf behalten, fürchte nur, dass es weder bald was wird, noch direkt dein Problem lösen wird...

Zu dem Lanping: Du kannst doch einfach ein Presence-Device dafür verwenden, der kann doch auch einen Lanping-Modus... Ob das nun ein Handy oder ein Sonosplayer ist, ist doch im Prinzip Wurst :)

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Wuppi68 am 17 Mai 2017, 14:49:08
Zitat von: Reinerlein am 17 Mai 2017, 13:57:18
Hi Ralf,

so etwas wie "forceIPs" geht im Kontext von UPnP nicht. Da das System auf Broadcasts aufbaut. Lediglich die direkten Befehle sind dann einfache SOAP-Pakete. Aber nach der Definition von UPnP könnte das Ausführen von Befehlen auf den Playern auch geblockt werden, wenn man nicht vorher die Bekanntschaft mittels Broadcast gemacht hat :) Monentan macht Sonos so etwas nicht, könnte aber ja kommen...

Der andere Punkt: Mein Modul baut natürlich komplett auf diesen UPnP Erkennungen und anschließender Steuerung auf. Das wäre zunächst mal eine große Baustelle... Ich kann es aber mal im Hinterkopf behalten, fürchte nur, dass es weder bald was wird, noch direkt dein Problem lösen wird...

Zu dem Lanping: Du kannst doch einfach ein Presence-Device dafür verwenden, der kann doch auch einen Lanping-Modus... Ob das nun ein Handy oder ein Sonosplayer ist, ist doch im Prinzip Wurst :)

Grüße
Reiner

Dann kommen die Sonos Player in das Cacti Monitoring erst einmal rein :-)
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: MikeRoxx am 17 Mai 2017, 21:52:13
Hallo Rainer,

ich habe noch einmal mit reusePort gespielt, leider ohne erfolg. Ich bekomme immer noch die Meldung:

recv() on unopened socket 1 at FHEM/lib/UPnP/ControlPoint.pm line 447, <$client> line 5.

reusePort auf 0 und dann einmal disable auf 1 kurz gewartet und disbale wieder auf 0.
Egal ob ich reusePort auf 0 oder 1 habe bekomme ich die Meldung ins Logfile.

Gruß
Mike


Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Wuppi68 am 17 Mai 2017, 22:18:16
Zitat von: Wuppi68 am 17 Mai 2017, 14:49:08
Dann kommen die Sonos Player in das Cacti Monitoring erst einmal rein :-)

so, die Sonos sind im Cacti drinnen und den PingType habe ich auch icmp gesetzt

Jetzt heißt es warten
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: l2r am 18 Mai 2017, 10:33:29
hi Reiner,

folgende Meldung ist heute morgen bei mir im Log aufgetaucht:
Can't call method "kill" on an undefined value at ./FHEM/00_SONOS.pm line 9730, <$client> line 6


Vor dem Update auf die aktuelle Version kam die Meldung auch mal sporadisch vor, sah aber ein bisschen anders aus:
Can't call method "kill" on an undefined value at ./FHEM/00_SONOS.pm line 9120.
Perl exited with active threads:
2 running and unjoined
1 finished and unjoined
0 running and detached
2017.05.15 07:33:50 0: SONOS0: No Answer from Subprocess. Restart Sonos-Subprocess...
2017.05.15 07:33:50 1: SONOS0: Kein UPnP-Server gefunden... Starte selber einen und warte 1 Sekunde(n) darauf...
2017.05.15 07:33:55 1: SONOS0: ./FHEM/00_SONOS.pm is listening to Port 4711
2017.05.15 07:34:54 1: localhost:4711 reappeared (Sonos)
2017.05.15 07:34:55 1: SONOS2: IsAlive-Thread gestartet. Warte 120 Sekunden und pruefe dann alle 30 Sekunden...
2017.05.15 07:34:56 1: SONOS3: Restore-Thread gestartet. Warte auf Arbeit...


Gruß Michael
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: ThiemoSt am 18 Mai 2017, 11:02:49
Hallo Zusammen,

habe seit ein/zwei Tagen ein Problem das mein Sonos nicht mehr erkannt wird. Die Player haben den Status "Player disappeared"

Hier mal ein Log nach dem Start von FHEM (in diesem Fall waren die Player bis zu letzten Zeile ansprechbar und erst danach "Player disappeared"):
2017.05.18 09:50:44 1: Including fhem.cfg
2017.05.18 09:50:45 2: eventTypes: loaded 4871 events from ./log/eventTypes.txt
2017.05.18 09:50:54 1: Including ./log/fhem.save
2017.05.18 09:51:06 1: usb create starting
2017.05.18 09:51:06 1: usb create end
2017.05.18 09:51:06 0: Featurelevel: 5.8
2017.05.18 09:51:06 0: Server started with 189 defined entities (fhem.pl:14284/2017-05-14 perl:5.020002 os:linux user:fhem pid:14831)
2017.05.18 09:51:06 1: SONOS0: Kein UPnP-Server gefunden... Starte selber einen und warte 8 Sekunde(n) darauf...
2017.05.18 09:51:08 0: SONOS0: Can't bind Port 4711: Bind failed: Address already in use at ./FHEM/00_SONOS.pm line 9693.
2017.05.18 09:51:08 0: SONOS0: Retries left (wait 30s): 9
2017.05.18 09:51:14 3: Opening Sonos device localhost:4711
2017.05.18 09:51:14 3: Can't connect to localhost:4711: Connection refused
2017.05.18 09:51:38 0: SONOS0: Can't bind Port 4711: Bind failed: Address already in use at ./FHEM/00_SONOS.pm line 9693.
2017.05.18 09:51:38 0: SONOS0: Retries left (wait 30s): 8
2017.05.18 09:52:08 1: SONOS0: ./FHEM/00_SONOS.pm is listening to Port 4711
2017.05.18 09:52:15 3: SONOS0: Connection accepted from localhost:37290
2017.05.18 09:52:15 1: localhost:4711 reappeared (Sonos)
2017.05.18 09:53:16 3: SONOS0: Connection accepted from localhost:37406
2017.05.18 09:53:46 3: SONOS0: Connection accepted from localhost:37426
2017.05.18 09:54:16 3: SONOS0: Connection accepted from localhost:37452
2017.05.18 09:54:46 3: SONOS0: Connection accepted from localhost:37476
2017.05.18 09:55:16 3: SONOS0: Connection accepted from localhost:37498
2017.05.18 09:55:46 3: SONOS0: Connection accepted from localhost:37522
2017.05.18 09:56:16 3: SONOS0: Connection accepted from localhost:37590
2017.05.18 09:56:46 3: SONOS0: Connection accepted from localhost:37622
2017.05.18 09:57:16 3: SONOS0: Connection accepted from localhost:37648
2017.05.18 09:57:46 3: SONOS0: Connection accepted from localhost:37668
2017.05.18 09:58:16 3: SONOS0: Connection accepted from localhost:37702
2017.05.18 09:58:46 3: SONOS0: Connection accepted from localhost:37726
2017.05.18 09:59:16 3: SONOS0: Connection accepted from localhost:37752
2017.05.18 09:59:46 3: SONOS0: Connection accepted from localhost:37776
2017.05.18 10:00:16 3: SONOS0: Connection accepted from localhost:37800
2017.05.18 10:00:46 3: SONOS0: Connection accepted from localhost:37824
2017.05.18 10:01:16 3: SONOS0: Connection accepted from localhost:37852
2017.05.18 10:01:46 3: SONOS0: Connection accepted from localhost:37884
2017.05.18 10:02:16 3: SONOS0: Connection accepted from localhost:37914
2017.05.18 10:02:46 3: SONOS0: Connection accepted from localhost:37930
2017.05.18 10:03:16 3: SONOS0: Connection accepted from localhost:37954
2017.05.18 10:03:46 3: SONOS0: Connection accepted from localhost:37978
2017.05.18 10:04:16 3: SONOS0: Connection accepted from localhost:38006
2017.05.18 10:04:46 3: SONOS0: Connection accepted from localhost:38030
2017.05.18 10:05:16 3: SONOS0: Connection accepted from localhost:38064
2017.05.18 10:05:46 3: SONOS0: Connection accepted from localhost:38084
2017.05.18 10:06:16 3: SONOS0: Connection accepted from localhost:38112
2017.05.18 10:06:46 3: SONOS0: Connection accepted from localhost:38144
2017.05.18 10:07:16 3: SONOS0: Connection accepted from localhost:38168
2017.05.18 10:07:46 3: SONOS0: Connection accepted from localhost:38198
2017.05.18 10:08:16 3: SONOS0: Connection accepted from localhost:38222
2017.05.18 10:08:46 3: SONOS0: Connection accepted from localhost:38244
2017.05.18 10:09:16 3: SONOS0: Connection accepted from localhost:38270
2017.05.18 10:09:46 3: SONOS0: Connection accepted from localhost:38294
2017.05.18 10:10:16 3: SONOS0: Connection accepted from localhost:38318
2017.05.18 10:10:46 3: SONOS0: Connection accepted from localhost:38340
2017.05.18 10:11:16 3: SONOS0: Connection accepted from localhost:38370
2017.05.18 10:11:46 3: SONOS0: Connection accepted from localhost:38400
2017.05.18 10:12:16 3: SONOS0: Connection accepted from localhost:38426
2017.05.18 10:12:46 3: SONOS0: Connection accepted from localhost:38448
2017.05.18 10:13:16 3: SONOS0: Connection accepted from localhost:38482
2017.05.18 10:13:46 3: SONOS0: Connection accepted from localhost:38504
2017.05.18 10:14:17 3: SONOS0: Connection accepted from localhost:38530
2017.05.18 10:14:47 3: SONOS0: Connection accepted from localhost:38552
2017.05.18 10:15:17 3: SONOS0: Connection accepted from localhost:38582
2017.05.18 10:15:47 3: SONOS0: Connection accepted from localhost:38606
2017.05.18 10:16:17 3: SONOS0: Connection accepted from localhost:38630
2017.05.18 10:16:47 3: SONOS0: Connection accepted from localhost:38662
2017.05.18 10:17:17 3: SONOS0: Connection accepted from localhost:38688
2017.05.18 10:17:47 3: SONOS0: Connection accepted from localhost:38710
2017.05.18 10:18:17 3: SONOS0: Connection accepted from localhost:38736
2017.05.18 10:18:47 3: SONOS0: Connection accepted from localhost:38762
2017.05.18 10:19:17 3: SONOS0: Connection accepted from localhost:38784
2017.05.18 10:19:47 3: SONOS0: Connection accepted from localhost:38808
2017.05.18 10:20:17 3: SONOS0: Connection accepted from localhost:38834
2017.05.18 10:20:47 3: SONOS0: Connection accepted from localhost:38856
Can't call method "kill" on an undefined value at ./FHEM/00_SONOS.pm line 9730, <$client> line 3.


List Sonos:
Internals:
   DELAYTIME  0
   DeviceName localhost:4711
   FD         23
   INTERVAL   30
   NAME       Sonos
   NOTIFYDEV  global,TYPE=SONOSPLAYER
   NR         202
   NTFY_ORDER 50-Sonos
   PARTIAL
   STATE      opened
   TYPE       SONOS
   WAITTIME   8
   Readings:
     2017-05-18 09:49:21   AllPlayer       ['sonos_Bad','sonos_Kueche']
     2017-05-18 09:49:21   AllPlayerCount  2
     2017-05-18 09:49:21   AllPlayerNotBonded ['sonos_Bad','sonos_Kueche']
     2017-05-18 09:49:21   AllPlayerNotBondedCount 2
     2017-05-18 08:56:53   LineInPlayer    []
     2017-05-18 09:49:21   MasterPlayer    ['sonos_Bad','sonos_Kueche']
     2017-05-18 09:49:21   MasterPlayerCount 2
     2017-05-18 09:49:21   MasterPlayerNotPlaying ['sonos_Bad','sonos_Kueche']
     2017-05-18 09:49:21   MasterPlayerNotPlayingCount 2
     2017-05-18 08:56:53   MasterPlayerPlaying []
     2017-05-18 08:56:53   MasterPlayerPlayingCount 0
     2017-05-18 08:57:47   MusicServicesListVersion RINCON_000E5880CE9C01400:177
     2017-05-18 08:57:47   ShareIndexInProgress 0
     2017-05-18 09:49:22   ZoneGroupState  <ZoneGroups><ZoneGroup Coordinator="RINCON_000E584787EE01400" ID="RINCON_000E584787EE01400:0"><ZoneGroupMember UUID="RINCON_000E584787EE01400" Location="http://192.168.0.107:1400/xml/device_description.xml" ZoneName="BRIDGE" Icon="x-rincon-roomicon:viper" Configuration="1" Invisible="1" IsZoneBridge="1" SoftwareVersion="35.3-39010" MinCompatibleVersion="34.0-00000" LegacyCompatibleVersion="25.0-00000" BootSeq="78" WirelessMode="0" WirelessLeafOnly="0" HasConfiguredSSID="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1" Orientation="-1" RoomCalibrationState="0" SecureRegState="2"/></ZoneGroup><ZoneGroup Coordinator="RINCON_000E5870CA1001400" ID="RINCON_000E5870CA1001400:267"><ZoneGroupMember UUID="RINCON_000E5870CA1001400" Location="http://192.168.0.111:1400/xml/device_description.xml" ZoneName="Bad" Icon="x-rincon-roomicon:bathroom" Configuration="1" SoftwareVersion="35.3-39010" MinCompatibleVersion="34.0-00000" LegacyCompatibleVersion="25.0-00000" BootSeq="95" WirelessMode="0" WirelessLeafOnly="0" HasConfiguredSSID="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1" Orientation="0" RoomCalibrationState="1" SecureRegState="2"/></ZoneGroup><ZoneGroup Coordinator="RINCON_000E5880CE9C01400" ID="RINCON_000E5870CA1001400:266"><ZoneGroupMember UUID="RINCON_000E5880CE9C01400" Location="http://192.168.0.106:1400/xml/device_description.xml" ZoneName="Küche" Icon="x-rincon-roomicon:kitchen" Configuration="1" SoftwareVersion="35.3-39010" MinCompatibleVersion="34.0-00000" LegacyCompatibleVersion="25.0-00000" BootSeq="79" WirelessMode="0" WirelessLeafOnly="0" HasConfiguredSSID="0" ChannelFreq="2437" BehindWifiExtender="0" WifiEnabled="1" Orientation="0" RoomCalibrationState="1" SecureRegState="2"/></ZoneGroup></ZoneGroups>
     2017-05-18 10:57:12   state           opened
Attributes:
   targetSpeakDir /mnt/SonosSpeak
   targetSpeakFileTimestamp 1
   targetSpeakMP3FileDir /mnt/SonosSpeak
   targetSpeakURL \\192.168.0.50\SonosSpeak


List sonos_Bad:
Internals:
   DEF        RINCON_000E5870CA1001400_MR
   NAME       sonos_Bad
   NOTIFYDEV  sonos_Bad
   NR         209
   NTFY_ORDER 50-sonos_Bad
   STATE      initialized
   TYPE       SONOSPLAYER
   UDN        RINCON_000E5870CA1001400_MR
   Readings:
     2017-05-18 10:56:51   AlarmList       ~~NotLoadedMarker~~
     2017-05-18 10:56:51   AlarmListIDs    ~~NotLoadedMarker~~
     2017-05-18 10:56:51   AlarmListVersion ~~NotLoadedMarker~~
     2017-05-18 08:57:47   AlarmRunning    0
     2017-05-18 08:57:47   AlarmRunningID
     2017-05-18 09:49:21   AvailablePlayer ['sonos_Kueche']
     2017-05-18 08:56:54   Balance         0
     2017-05-18 08:57:49   Bass            0
     2017-05-18 08:57:47   CrossfadeMode   0
     2017-05-18 08:57:47   DailyIndexRefreshTime 02:00:00
     2017-05-18 08:57:47   DirectControlAccountID
     2017-05-18 08:57:47   DirectControlClientID
     2017-05-18 08:57:47   DirectControlIsSuspended 0
     2017-05-18 08:57:47   FavouritesVersion RINCON_000E5880CE9C01400,31
     2017-05-18 08:57:47   GroupMute       0
     2017-05-18 08:57:47   GroupVolume     23
     2017-05-18 08:57:47   HeadphoneConnected 0
     2017-05-18 08:56:54   IsBonded        0
     2017-05-18 08:56:54   IsMaster        1
     2017-05-18 08:57:49   Loudness        1
     2017-05-18 08:57:46   MasterPlayer    sonos_Bad
     2017-05-18 08:57:47   Mute            0
     2017-05-18 08:57:49   OutputFixed     0
     2017-05-18 08:57:47   PlaylistsVersion RINCON_000E5870CA1001400,5
     2017-05-18 08:57:48   QueueHash       9a1c7ee2c7ce38d4bbbaf29ab9f2ac1e
     2017-05-18 08:57:48   QueueVersion
     2017-05-18 08:57:47   RadiosVersion   RINCON_000E5880CE9C01400,31
     2017-05-18 08:57:47   Repeat          0
     2017-05-18 08:57:47   RepeatOne       0
     2017-05-18 08:57:47   Shuffle         0
     2017-05-18 08:56:54   SlavePlayer     []
     2017-05-18 08:56:54   SlavePlayerNotBonded []
     2017-05-18 08:57:47   SleepTimer      off
     2017-05-18 08:57:46   SleepTimerVersion
     2017-05-18 08:57:49   SubEnable       1
     2017-05-18 08:57:49   SubGain         0
     2017-05-18 08:57:49   SubPolarity     0
     2017-05-18 08:57:49   Treble          0
     2017-05-18 08:57:49   TruePlay        1
     2017-05-18 08:56:54   Volume          23
     2017-05-18 08:57:47   ZoneGroupID     RINCON_000E5870CA1001400:__
     2017-05-18 08:57:46   ZoneGroupNameDetails
     2017-05-18 08:57:47   currentAlbum
     2017-05-18 08:57:47   currentAlbumArtURI ./www/images/default/SONOSPLAYER/sonos_Bad_AlbumArt.png
     2017-05-18 08:57:47   currentAlbumArtURL http://cdn-radiotime-logos.tunein.com/s84565g.png
     2017-05-18 08:57:47   currentAlbumArtist
     2017-05-18 08:57:47   currentArtist
     2017-05-18 08:57:47   currentEnqueuedTransportHandle x-sonosapi-stream:s84565?sid=254&flags=8224&sn=0|<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><dc:title>Radio Berg</dc:title><upnp:class>object.item.audioItem.audioBroadcast</upnp:class><desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/">SA_RINCON65031_</desc></item></DIDL-Lite>
     2017-05-18 08:57:47   currentEnqueuedTransportURI x-sonosapi-stream:s84565?sid=254&flags=8224&sn=0
     2017-05-18 08:57:47   currentFavouriteName
     2017-05-18 08:56:54   currentNormalAudio
     2017-05-18 08:57:47   currentOriginalTrackNumber
     2017-05-18 08:57:47   currentPlaylistName
     2017-05-18 08:57:47   currentRadioName
     2017-05-18 08:57:47   currentSender   Radio Berg
     2017-05-18 08:57:47   currentSenderCurrent
     2017-05-18 08:57:47   currentSenderInfo
     2017-05-18 08:57:47   currentSource   Radio Berg
     2017-05-18 08:56:54   currentStreamAudio 1
     2017-05-18 08:57:47   currentTitle
     2017-05-18 08:56:54   currentTrack    1
     2017-05-18 08:56:54   currentTrackDuration 0:00:00
     2017-05-18 08:56:54   currentTrackDurationSec 1
     2017-05-18 08:57:47   currentTrackHandle http://http://edge.live.mp3.mdn.newmedia.nacamar.net/ps-radioberg/livestream.mp3|<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s84565?sid=254&amp;flags=8224&amp;sn=0</res><r:streamContent></r:streamContent><r:radioShowMd></r:radioShowMd><upnp:albumArtURI>/getaa?s=1&amp;u=x-sonosapi-stream%3as84565%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s84565?sid=254&amp;flags=8224&amp;sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>
     2017-05-18 08:56:54   currentTrackPosition 0:00:00
     2017-05-18 09:49:22   currentTrackPositionSec 0
     2017-05-18 08:57:47   currentTrackPositionSimulated 0:00:00
     2017-05-18 08:56:54   currentTrackPositionSimulatedPercent 0.0
     2017-05-18 08:57:47   currentTrackPositionSimulatedSec 0.371761083602905
     2017-05-18 08:56:54   currentTrackProvider Radio
     2017-05-18 08:56:54   currentTrackProviderIconQuadraticURL /fhem/sonos/cover/tunein_quadratic.jpg
     2017-05-18 08:56:54   currentTrackProviderIconRoundURL /fhem/sonos/cover/tunein_round.png
     2017-05-18 09:49:22   currentTrackURI http://http://edge.live.mp3.mdn.newmedia.nacamar.net/ps-radioberg/livestream.mp3
     2017-05-18 08:56:54   fieldType
     2017-05-18 08:57:47   infoSummarize1  Radio Berg:
     2017-05-18 08:57:47   infoSummarize2  STOPPED => Radio Berg:
     2017-05-18 08:57:47   infoSummarize3  Lautstärke: 23 ~ Ton An ~ Balance: Mitte ~ Kein Kopfhörer
     2017-05-18 08:57:47   infoSummarize4
     2017-05-18 08:56:54   location        http://192.168.0.111:1400/xml/device_description.xml
     2017-05-18 08:57:47   nextAlbum
     2017-05-18 08:57:47   nextAlbumArtURI ./www/images/default/SONOSPLAYER/sonos_Bad_NextAlbumArt.png
     2017-05-18 08:57:47   nextAlbumArtURL /fhem/sonos/cover/empty.jpg
     2017-05-18 08:57:47   nextAlbumArtist
     2017-05-18 08:57:47   nextArtist
     2017-05-18 08:57:47   nextOriginalTrackNumber
     2017-05-18 08:57:47   nextTitle
     2017-05-18 08:57:47   nextTrackDuration
     2017-05-18 08:57:47   nextTrackDurationSec
     2017-05-18 08:57:47   nextTrackHandle |
     2017-05-18 08:57:47   nextTrackProvider
     2017-05-18 08:57:47   nextTrackProviderIconQuadraticURL
     2017-05-18 08:57:47   nextTrackProviderIconRoundURL
     2017-05-18 08:57:47   nextTrackURI
     2017-05-18 08:56:54   numberOfTracks  1
     2017-05-18 08:56:54   playerType      S3
     2017-05-18 10:56:51   presence        ~~NotLoadedMarker~~
     2017-05-18 08:57:47   roomIcon        bathroom
     2017-05-18 08:56:54   roomName        Bad
     2017-05-18 08:56:54   roomNameAlias   Bad
     2017-05-18 08:56:54   saveRoomName    Bad
     2017-05-18 08:56:54   serialNum       00-0E-58-70-CA-10:A
     2017-05-18 08:56:54   softwareRevision 7.2
     2017-05-18 10:56:50   state           initialized
     2017-05-18 08:56:54   transportState  STOPPED
   Helper:
     simulateCurrentTrackPosition 0
Attributes:
   alias      Bad
   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="Lautstärke: "/><Mute instead=" ~ Kein Ton" ifempty=" ~ Ton An" emptyval="0"/> ~ Balance: <Balance ifempty="Mitte" emptyval="0"/><HeadphoneConnected instead=" ~ Kopfhörer aktiv" ifempty=" ~ Kein Kopfhörer" emptyval="0"/>
   generateVolumeSlider 1
   getAlarms  1
   getTitleInfoFromMaster 1
   group      Bad
   icon       icoSONOSPLAYER_icon-S3.png
   minVolume  0
   model      Sonos_S3
   room       Bad
   simulateCurrentTrackPosition 1
   sortby     1
   stateFormat presence ~ currentTrackPositionSimulated / currentTrackDuration
   userReadings Favourites:LastActionResult.*?GetFavouritesWithCovers.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }, Radios:LastActionResult.*?GetRadiosWithCovers.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }, Playlists:LastActionResult.*?GetPlaylistsWithCovers.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }, Queue:LastActionResult.*?GetQueueWithCovers.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }, currentTrackPosition:LastActionResult.*?GetCurrentTrackPosition.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }
   webCmd     Volume


List sonos_Kueche:
Internals:
   DEF        RINCON_000E5880CE9C01400_MR
   NAME       sonos_Kueche
   NOTIFYDEV  sonos_Kueche
   NR         203
   NTFY_ORDER 50-sonos_Kueche
   STATE      initialized
   TYPE       SONOSPLAYER
   UDN        RINCON_000E5880CE9C01400_MR
   Readings:
     2017-05-18 10:56:51   AlarmList       ~~NotLoadedMarker~~
     2017-05-18 10:56:51   AlarmListIDs    ~~NotLoadedMarker~~
     2017-05-18 10:56:51   AlarmListVersion ~~NotLoadedMarker~~
     2017-05-18 08:56:53   AlarmRunning    0
     2017-05-18 08:56:53   AlarmRunningID
     2017-05-18 08:57:46   AvailablePlayer ['sonos_Bad']
     2017-05-18 08:56:51   Balance         0
     2017-05-18 08:57:49   Bass            0
     2017-05-18 08:56:53   CrossfadeMode   0
     2017-05-18 08:57:47   DailyIndexRefreshTime 02:00:00
     2017-05-18 08:56:53   DirectControlAccountID
     2017-05-18 08:56:53   DirectControlClientID
     2017-05-18 08:56:53   DirectControlIsSuspended 0
     2017-05-18 08:57:47   FavouritesVersion RINCON_000E5880CE9C01400,31
     2017-05-18 08:57:46   GroupMute       0
     2017-05-18 08:57:46   GroupVolume     30
     2017-05-18 08:56:53   HeadphoneConnected 0
     2017-05-18 08:56:51   IsBonded        0
     2017-05-18 08:56:51   IsMaster        1
     2017-05-18 08:57:47   LineInConnected 0
     2017-05-18 08:57:47   LineInIcon      AudioComponent
     2017-05-18 08:57:47   LineInName      Audio Component
     2017-05-18 08:57:49   Loudness        1
     2017-05-18 09:49:18   MasterPlayer    sonos_Kueche
     2017-05-18 08:56:53   Mute            0
     2017-05-18 08:57:49   OutputFixed     0
     2017-05-18 08:57:47   PlaylistsVersion RINCON_000E5870CA1001400,5
     2017-05-18 09:46:11   QueueHash       9a1c7ee2c7ce38d4bbbaf29ab9f2ac1e
     2017-05-18 09:46:11   QueueVersion    1
     2017-05-18 08:57:47   RadiosVersion   RINCON_000E5880CE9C01400,31
     2017-05-18 08:56:53   Repeat          0
     2017-05-18 08:56:53   RepeatOne       0
     2017-05-18 08:56:53   Shuffle         0
     2017-05-18 08:56:51   SlavePlayer     []
     2017-05-18 08:56:51   SlavePlayerNotBonded []
     2017-05-18 08:56:53   SleepTimer      off
     2017-05-18 08:56:52   SleepTimerVersion
     2017-05-18 08:57:49   SubEnable       1
     2017-05-18 08:57:49   SubGain         0
     2017-05-18 08:57:49   SubPolarity     0
     2017-05-18 08:57:49   Treble          0
     2017-05-18 08:57:49   TruePlay        1
     2017-05-18 08:56:51   Volume          30
     2017-05-18 08:57:47   ZoneGroupID     RINCON_000E5880CE9C01400:__
     2017-05-18 08:56:53   ZoneGroupNameDetails
     2017-05-18 08:56:53   currentAlbum
     2017-05-18 08:56:53   currentAlbumArtURI ./www/images/default/SONOSPLAYER/sonos_Kueche_AlbumArt.png
     2017-05-18 08:56:53   currentAlbumArtURL http://cdn-radiotime-logos.tunein.com/s84565g.png
     2017-05-18 08:56:53   currentAlbumArtist
     2017-05-18 08:56:53   currentArtist
     2017-05-18 08:56:53   currentEnqueuedTransportHandle x-sonosapi-stream:s84565?sid=254&flags=8224&sn=0|<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><dc:title>Radio Berg</dc:title><upnp:class>object.item.audioItem.audioBroadcast</upnp:class><desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/">SA_RINCON65031_</desc></item></DIDL-Lite>
     2017-05-18 08:56:53   currentEnqueuedTransportURI x-sonosapi-stream:s84565?sid=254&flags=8224&sn=0
     2017-05-18 08:56:53   currentFavouriteName
     2017-05-18 08:56:51   currentNormalAudio
     2017-05-18 08:56:53   currentOriginalTrackNumber
     2017-05-18 08:56:53   currentPlaylistName
     2017-05-18 08:56:53   currentRadioName
     2017-05-18 08:56:53   currentSender   Radio Berg
     2017-05-18 08:56:53   currentSenderCurrent
     2017-05-18 08:56:53   currentSenderInfo
     2017-05-18 08:56:53   currentSource   Radio Berg
     2017-05-18 08:56:51   currentStreamAudio 1
     2017-05-18 08:56:53   currentTitle
     2017-05-18 08:56:51   currentTrack    1
     2017-05-18 08:56:51   currentTrackDuration 0:00:00
     2017-05-18 08:56:51   currentTrackDurationSec 1
     2017-05-18 08:56:53   currentTrackHandle http://http://edge.live.mp3.mdn.newmedia.nacamar.net/ps-radioberg/livestream.mp3|<DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"><item id="-1" parentID="-1" restricted="true"><res protocolInfo="sonos.com-http:*:*:*">x-sonosapi-stream:s84565?sid=254&amp;flags=8224&amp;sn=0</res><r:streamContent></r:streamContent><r:radioShowMd></r:radioShowMd><upnp:albumArtURI>/getaa?s=1&amp;u=x-sonosapi-stream%3as84565%3fsid%3d254%26flags%3d8224%26sn%3d0</upnp:albumArtURI><dc:title>x-sonosapi-stream:s84565?sid=254&amp;flags=8224&amp;sn=0</dc:title><upnp:class>object.item</upnp:class></item></DIDL-Lite>
     2017-05-18 09:46:05   currentTrackPosition 0:00:00
     2017-05-18 09:49:21   currentTrackPositionSec 0
     2017-05-18 08:56:53   currentTrackPositionSimulated 0:00:00
     2017-05-18 08:56:52   currentTrackPositionSimulatedPercent 0.0
     2017-05-18 08:56:53   currentTrackPositionSimulatedSec 0.500694990158081
     2017-05-18 08:56:51   currentTrackProvider Radio
     2017-05-18 08:56:51   currentTrackProviderIconQuadraticURL /fhem/sonos/cover/tunein_quadratic.jpg
     2017-05-18 08:56:51   currentTrackProviderIconRoundURL /fhem/sonos/cover/tunein_round.png
     2017-05-18 09:49:21   currentTrackURI http://http://edge.live.mp3.mdn.newmedia.nacamar.net/ps-radioberg/livestream.mp3
     2017-05-18 08:56:51   fieldType
     2017-05-18 08:56:53   infoSummarize1  Radio Berg:
     2017-05-18 08:56:53   infoSummarize2  STOPPED => Radio Berg:
     2017-05-18 08:56:53   infoSummarize3  Lautstärke: 30 ~ Ton An ~ Balance: Mitte ~ Kein Kopfhörer
     2017-05-18 08:56:53   infoSummarize4
     2017-05-18 08:56:51   location        http://192.168.0.106:1400/xml/device_description.xml
     2017-05-18 08:56:53   nextAlbum
     2017-05-18 08:56:53   nextAlbumArtURI ./www/images/default/SONOSPLAYER/sonos_Kueche_NextAlbumArt.png
     2017-05-18 08:56:53   nextAlbumArtURL /fhem/sonos/cover/empty.jpg
     2017-05-18 08:56:53   nextAlbumArtist
     2017-05-18 08:56:53   nextArtist
     2017-05-18 08:56:53   nextOriginalTrackNumber
     2017-05-18 08:56:53   nextTitle
     2017-05-18 08:56:53   nextTrackDuration
     2017-05-18 08:56:53   nextTrackDurationSec
     2017-05-18 08:56:53   nextTrackHandle |
     2017-05-18 08:56:53   nextTrackProvider
     2017-05-18 08:56:53   nextTrackProviderIconQuadraticURL
     2017-05-18 08:56:53   nextTrackProviderIconRoundURL
     2017-05-18 08:56:53   nextTrackURI
     2017-05-18 08:56:51   numberOfTracks  1
     2017-05-18 08:56:51   playerType      S5
     2017-05-18 10:56:51   presence        ~~NotLoadedMarker~~
     2017-05-18 08:57:47   roomIcon        kitchen
     2017-05-18 08:56:51   roomName        Küche
     2017-05-18 08:56:51   roomNameAlias   Küche
     2017-05-18 08:56:51   saveRoomName    Kueche
     2017-05-18 08:56:51   serialNum       00-0E-58-80-CE-9C:0
     2017-05-18 08:56:51   softwareRevision 7.2
     2017-05-18 10:56:50   state           initialized
     2017-05-18 08:56:51   transportState  STOPPED
   Helper:
     simulateCurrentTrackPosition 0
Attributes:
   alias      Küche
   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="Lautstärke: "/><Mute instead=" ~ Kein Ton" ifempty=" ~ Ton An" emptyval="0"/> ~ Balance: <Balance ifempty="Mitte" emptyval="0"/><HeadphoneConnected instead=" ~ Kopfhörer aktiv" ifempty=" ~ Kein Kopfhörer" emptyval="0"/>
   generateVolumeSlider 1
   getAlarms  1
   getTitleInfoFromMaster 1
   group      Kueche
   icon       icoSONOSPLAYER_icon-S5.png
   minVolume  0
   model      Sonos_S5
   room       Küche
   simulateCurrentTrackPosition 1
   sortby     1
   stateFormat presence ~ currentTrackPositionSimulated / currentTrackDuration
   userReadings Favourites:LastActionResult.*?GetFavouritesWithCovers.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }, Radios:LastActionResult.*?GetRadiosWithCovers.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }, Playlists:LastActionResult.*?GetPlaylistsWithCovers.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }, Queue:LastActionResult.*?GetQueueWithCovers.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }, currentTrackPosition:LastActionResult.*?GetCurrentTrackPosition.* { if (ReadingsVal($name, "LastActionResult", "") =~ m/.*?: (.*)/) { return $1; } }
   webCmd     Volume


Ich hatte in der letzten Woche auch Probleme das FHEM komplett hing. Status war auf running, jedoch kein Zugriff über Web. Nach mehreren Neustarts hat es dann wieder geklalppt.
Vermute aber eher eine Problem beim BT (für Xiaomi Flower) weil es dort auch regelmäßig Aussetzer gibt.

Hoffe das mir mit den Logs jemand helfen kann.
Danke schonmal!
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: mrfloppy am 18 Mai 2017, 16:40:03
Habe seit der neuen Version auch immer wieder das Sonos auf disappeared geht.
Nach einem disable 0/1 funtkioniert es wieder.
Heute morgen nach einem Update neugestartet wieder disappeared.

im Logfile finde ich auch diese Einträge

2017.05.18 11:58:47 1: SONOS0: ./FHEM/00_SONOS.pm is listening to Port 4711
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.18 11:58:55 1: SONOS2: IsAlive-Thread gestartet. Warte 120 Sekunden und pruefe dann alle 45 Sekunden...
2017.05.18 11:58:55 1: SONOS3: Restore-Thread gestartet. Warte auf Arbeit...
at ./FHEM/00_SONOS.pm line 5022 thread 3.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.

2017.05.18 16:29:54 1: SONOS0: ./FHEM/00_SONOS.pm is listening to Port 4711
2017.05.18 16:30:31 1: localhost:4711 reappeared (Sonos)
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.18 16:30:33 1: SONOS2: IsAlive-Thread gestartet. Warte 120 Sekunden und pruefe dann alle 45 Sekunden...
2017.05.18 16:30:33 1: SONOS3: Restore-Thread gestartet. Warte auf Arbeit...
at ./FHEM/00_SONOS.pm line 5022 thread 3.
at ./FHEM/00_SONOS.pm line 4310 thread 1.



LG
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: markusm am 19 Mai 2017, 08:14:05
Hi
Beobachte genau das gleiche Problem.
Player disappeared nach einiger Zeit immer wieder.
Löschen/neu hinzufügen hilft nicht.
Ideen?
Danke
Markus
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: l2r am 19 Mai 2017, 08:24:29
meine standen gestern Abend auch auf disappeared.

Gruß Michael
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: MikeRoxx am 19 Mai 2017, 14:53:37
Hallo

Ich habe bei mir beide Sonos entfernt und wieder neu hinzugefügt. Jetzt scheint es zu funktionieren.

Gruß
Mike

Gesendet von meinem A0001 mit Tapatalk

Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: ThiemoSt am 19 Mai 2017, 17:57:05
Zitat von: MikeRoxx am 19 Mai 2017, 14:53:37
Hallo

Ich habe bei mir beide Sonos entfernt und wieder neu hinzugefügt. Jetzt scheint es zu funktionieren.


Das hatte ich bereits probiert. Allerdings nach ca. einem Tag wieder das gleiche Problem.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: mrfloppy am 20 Mai 2017, 06:08:11
Habe meine Sonos auch komplett gelöscht und wieder eingerichtet.
jetzt müllt mir Sonos das Logfile zu.

at ./FHEM/00_SONOS.pm line 4310 thread 4.
2017.05.20 03:37:42 2: SONOS4: Discover Sonosplayer 'Wohnzimmer' (S1) Software Revision 7.2 with ID 'RINCON_5CAAFD4B541E01400_MR'
2017.05.20 03:37:44 2: SONOS4: SonosPlayer 'Wohnzimmer' (S1) with ID 'RINCON_5CAAFD4B541E01400_MR' is already defined (as 'Sonos_Wohnzimmer') and will only be updated
2017.05.20 03:37:44 2: SONOS4: SonosPlayer 'Wohnzimmer' is now updated
2017.05.20 03:37:44 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171119
2017.05.20 03:37:44 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171120
2017.05.20 03:37:44 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171121
2017.05.20 03:37:44 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171122
2017.05.20 03:37:44 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171123
2017.05.20 03:37:44 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171124
2017.05.20 03:37:44 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171125
2017.05.20 03:37:44 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171126
2017.05.20 03:37:44 3: SONOS4: Discover: End of discover-event for "Wohnzimmer".
2017.05.20 03:37:44 2: SONOS4: Discover Sonosplayer 'Wohnzimmer 2' (S3) Software Revision 7.2 with ID 'RINCON_B8E937D046C001400_MR'
2017.05.20 03:37:46 2: SONOS4: SonosPlayer 'Wohnzimmer_2' (S3) with ID 'RINCON_B8E937D046C001400_MR' is already defined (as 'Sonos_Wohnzimmer_2') and will only be updated
2017.05.20 03:37:46 2: SONOS4: SonosPlayer 'Wohnzimmer_2' is now updated
2017.05.20 03:37:46 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152079
2017.05.20 03:37:46 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152080
2017.05.20 03:37:46 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152081
2017.05.20 03:37:46 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152082
2017.05.20 03:37:46 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152083
2017.05.20 03:37:46 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152084
2017.05.20 03:37:46 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152085
2017.05.20 03:37:46 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152086
2017.05.20 03:37:46 3: SONOS4: Discover: End of discover-event for "Wohnzimmer 2".
2017.05.20 03:37:46 3: SONOS4: Event: Received Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: End of Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: Received Transport-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: End of Transport-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: Received GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: End of GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: Received Alarm-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: End of Alarm-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: Received Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: End of Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: Received MusicServices-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: End of MusicServices-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: Received MusicServices-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: End of MusicServices-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: Received DeviceProperties-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: End of DeviceProperties-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: Received DeviceProperties-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: End of DeviceProperties-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: Received ContentDirectory-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: End of ContentDirectory-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: Received ContentDirectory-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: End of ContentDirectory-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: Received Rendering-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: End of Rendering-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:37:47 3: SONOS4: Event: Received Rendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:37:47 3: SONOS4: Event: End of Rendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:38:34 3: SONOS0: Connection accepted from localhost:53950
2017.05.20 03:39:19 3: SONOS0: Connection accepted from localhost:53986
2017.05.20 03:40:05 3: SONOS0: Connection accepted from localhost:54040
2017.05.20 03:40:50 3: SONOS0: Connection accepted from localhost:54070
2017.05.20 03:41:35 3: SONOS0: Connection accepted from localhost:54122
2017.05.20 03:42:20 3: SONOS0: Connection accepted from localhost:54158
2017.05.20 03:43:05 3: SONOS0: Connection accepted from localhost:54218
2017.05.20 03:43:51 3: SONOS0: Connection accepted from localhost:54250
2017.05.20 03:44:36 3: SONOS0: Connection accepted from localhost:54302
2017.05.20 03:45:11 2: SONOS4: Error during UPnP-Handling, restarting handling: mismatched tag 'head'

at ./FHEM/00_SONOS.pm line 4310 thread 4.
2017.05.20 03:45:12 2: SONOS4: Discover Sonosplayer 'Wohnzimmer' (S1) Software Revision 7.2 with ID 'RINCON_5CAAFD4B541E01400_MR'
2017.05.20 03:45:13 2: SONOS4: SonosPlayer 'Wohnzimmer' (S1) with ID 'RINCON_5CAAFD4B541E01400_MR' is already defined (as 'Sonos_Wohnzimmer') and will only be updated
2017.05.20 03:45:13 2: SONOS4: SonosPlayer 'Wohnzimmer' is now updated
2017.05.20 03:45:13 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171127
2017.05.20 03:45:13 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171128
2017.05.20 03:45:13 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171129
2017.05.20 03:45:13 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171130
2017.05.20 03:45:13 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171131
2017.05.20 03:45:13 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171132
2017.05.20 03:45:13 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171133
2017.05.20 03:45:13 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171134
2017.05.20 03:45:13 3: SONOS4: Discover: End of discover-event for "Wohnzimmer".
2017.05.20 03:45:14 2: SONOS4: Discover Sonosplayer 'Wohnzimmer 2' (S3) Software Revision 7.2 with ID 'RINCON_B8E937D046C001400_MR'
2017.05.20 03:45:15 2: SONOS4: SonosPlayer 'Wohnzimmer_2' (S3) with ID 'RINCON_B8E937D046C001400_MR' is already defined (as 'Sonos_Wohnzimmer_2') and will only be updated
2017.05.20 03:45:15 2: SONOS4: SonosPlayer 'Wohnzimmer_2' is now updated
2017.05.20 03:45:15 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152087
2017.05.20 03:45:15 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152088
2017.05.20 03:45:15 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152089
2017.05.20 03:45:15 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152090
2017.05.20 03:45:15 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152091
2017.05.20 03:45:16 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152092
2017.05.20 03:45:16 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152093
2017.05.20 03:45:16 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152094
2017.05.20 03:45:16 3: SONOS4: Discover: End of discover-event for "Wohnzimmer 2".
2017.05.20 03:45:16 3: SONOS4: Event: Received Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:16 3: SONOS4: Event: End of Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:16 2: SONOS4: Discover Sonosplayer 'Wohnzimmer 2' (S3) Software Revision 7.2 with ID 'RINCON_B8E937D046C001400_MR'
2017.05.20 03:45:18 2: SONOS4: SonosPlayer 'Wohnzimmer_2' (S3) with ID 'RINCON_B8E937D046C001400_MR' is already defined (as 'Sonos_Wohnzimmer_2') and will only be updated
2017.05.20 03:45:18 2: SONOS4: SonosPlayer 'Wohnzimmer_2' is now updated
2017.05.20 03:45:18 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152095
2017.05.20 03:45:18 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152096
2017.05.20 03:45:18 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152097
2017.05.20 03:45:18 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152098
2017.05.20 03:45:18 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152099
2017.05.20 03:45:18 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152100
2017.05.20 03:45:18 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152101
2017.05.20 03:45:18 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152102
2017.05.20 03:45:18 3: SONOS4: Discover: End of discover-event for "Wohnzimmer 2".
2017.05.20 03:45:18 3: SONOS4: Event: Received Transport-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:19 3: SONOS4: Event: End of Transport-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:19 3: SONOS4: Event: Received GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:19 3: SONOS4: Event: End of GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:19 2: SONOS4: Discover Sonosplayer 'Wohnzimmer 2' (S3) Software Revision 7.2 with ID 'RINCON_B8E937D046C001400_MR'
2017.05.20 03:45:20 2: SONOS4: SonosPlayer 'Wohnzimmer_2' (S3) with ID 'RINCON_B8E937D046C001400_MR' is already defined (as 'Sonos_Wohnzimmer_2') and will only be updated
2017.05.20 03:45:20 2: SONOS4: SonosPlayer 'Wohnzimmer_2' is now updated
2017.05.20 03:45:20 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152103
2017.05.20 03:45:20 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152104
2017.05.20 03:45:20 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152105
2017.05.20 03:45:20 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152106
2017.05.20 03:45:21 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152107
2017.05.20 03:45:21 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152108
2017.05.20 03:45:21 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152109
2017.05.20 03:45:21 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152110
2017.05.20 03:45:21 3: SONOS4: Discover: End of discover-event for "Wohnzimmer 2".
2017.05.20 03:45:21 3: SONOS4: Event: Received Alarm-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: End of Alarm-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: Received Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: End of Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: Received MusicServices-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: End of MusicServices-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: Received MusicServices-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: End of MusicServices-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: Received DeviceProperties-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: End of DeviceProperties-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: Received DeviceProperties-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: End of DeviceProperties-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: Received ContentDirectory-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: End of ContentDirectory-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: Received ContentDirectory-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: End of ContentDirectory-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: Received Rendering-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: End of Rendering-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: Received Rendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: End of Rendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:45:21 3: SONOS4: Event: Received Transport-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: End of Transport-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: Received Alarm-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:45:21 3: SONOS4: Event: End of Alarm-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:46:07 3: SONOS0: Connection accepted from localhost:54654
2017.05.20 03:46:53 3: SONOS0: Connection accepted from localhost:54688
2017.05.20 03:47:38 3: SONOS0: Connection accepted from localhost:54740
2017.05.20 03:48:23 3: SONOS0: Connection accepted from localhost:54774
2017.05.20 03:49:08 3: SONOS0: Connection accepted from localhost:54824
2017.05.20 03:49:19 2: CUL_TX Unknown device 3, please define it
2017.05.20 03:49:53 3: SONOS0: Connection accepted from localhost:54860
2017.05.20 03:50:39 3: SONOS0: Connection accepted from localhost:54916
2017.05.20 03:50:41 2: SONOS4: Discover Sonosplayer 'Wohnzimmer' (S1) Software Revision 7.2 with ID 'RINCON_5CAAFD4B541E01400_MR'
2017.05.20 03:50:43 2: SONOS4: SonosPlayer 'Wohnzimmer' (S1) with ID 'RINCON_5CAAFD4B541E01400_MR' is already defined (as 'Sonos_Wohnzimmer') and will only be updated
2017.05.20 03:50:43 2: SONOS4: SonosPlayer 'Wohnzimmer' is now updated
2017.05.20 03:50:43 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171135
2017.05.20 03:50:43 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171136
2017.05.20 03:50:43 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171137
2017.05.20 03:50:43 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171138
2017.05.20 03:50:43 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171139
2017.05.20 03:50:43 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171140
2017.05.20 03:50:43 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171141
2017.05.20 03:50:43 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171142
2017.05.20 03:50:43 3: SONOS4: Discover: End of discover-event for "Wohnzimmer".
2017.05.20 03:50:43 3: SONOS4: Event: Received Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:44 3: SONOS4: Event: End of Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:44 3: SONOS4: Event: Received GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:44 3: SONOS4: Event: End of GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:44 2: SONOS4: Discover Sonosplayer 'Wohnzimmer' (S1) Software Revision 7.2 with ID 'RINCON_5CAAFD4B541E01400_MR'
2017.05.20 03:50:45 2: SONOS4: SonosPlayer 'Wohnzimmer' (S1) with ID 'RINCON_5CAAFD4B541E01400_MR' is already defined (as 'Sonos_Wohnzimmer') and will only be updated
2017.05.20 03:50:46 2: SONOS4: SonosPlayer 'Wohnzimmer' is now updated
2017.05.20 03:50:46 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171143
2017.05.20 03:50:46 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171144
2017.05.20 03:50:46 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171145
2017.05.20 03:50:46 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171146
2017.05.20 03:50:46 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171147
2017.05.20 03:50:46 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171148
2017.05.20 03:50:46 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171149
2017.05.20 03:50:46 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171150
2017.05.20 03:50:46 3: SONOS4: Discover: End of discover-event for "Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: Received Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: End of Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: Received MusicServices-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: End of MusicServices-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: Received DeviceProperties-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: End of DeviceProperties-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: Received ContentDirectory-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: End of ContentDirectory-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: Received Rendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: End of Rendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:46 3: SONOS4: Event: Received Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:47 3: SONOS4: Event: End of Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:47 3: SONOS4: Event: Received GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:47 3: SONOS4: Event: End of GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:47 3: SONOS4: Event: Received Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:50:47 3: SONOS4: Event: End of Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:51:33 3: SONOS0: Connection accepted from localhost:55112
2017.05.20 03:52:18 3: SONOS0: Connection accepted from localhost:55144
2017.05.20 03:52:41 2: SONOS4: Error during UPnP-Handling, restarting handling: mismatched tag 'head'

at ./FHEM/00_SONOS.pm line 4310 thread 4.
2017.05.20 03:52:43 2: SONOS4: Discover Sonosplayer 'Wohnzimmer 2' (S3) Software Revision 7.2 with ID 'RINCON_B8E937D046C001400_MR'
2017.05.20 03:52:44 2: SONOS4: SonosPlayer 'Wohnzimmer_2' (S3) with ID 'RINCON_B8E937D046C001400_MR' is already defined (as 'Sonos_Wohnzimmer_2') and will only be updated
2017.05.20 03:52:44 2: SONOS4: SonosPlayer 'Wohnzimmer_2' is now updated
2017.05.20 03:52:44 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152111
2017.05.20 03:52:44 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152112
2017.05.20 03:52:44 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152113
2017.05.20 03:52:44 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152114
2017.05.20 03:52:45 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152115
2017.05.20 03:52:45 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152116
2017.05.20 03:52:45 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152117
2017.05.20 03:52:45 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_B8E937D046C001400_sub0000152118
2017.05.20 03:52:45 3: SONOS4: Discover: End of discover-event for "Wohnzimmer 2".
2017.05.20 03:52:45 2: SONOS4: Discover Sonosplayer 'Wohnzimmer' (S1) Software Revision 7.2 with ID 'RINCON_5CAAFD4B541E01400_MR'
2017.05.20 03:52:46 2: SONOS4: SonosPlayer 'Wohnzimmer' (S1) with ID 'RINCON_5CAAFD4B541E01400_MR' is already defined (as 'Sonos_Wohnzimmer') and will only be updated
2017.05.20 03:52:46 2: SONOS4: SonosPlayer 'Wohnzimmer' is now updated
2017.05.20 03:52:47 2: SONOS4: Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171151
2017.05.20 03:52:47 2: SONOS4: Rendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171152
2017.05.20 03:52:47 2: SONOS4: GroupRendering-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171153
2017.05.20 03:52:47 2: SONOS4: ContentDirectory-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171154
2017.05.20 03:52:47 2: SONOS4: Alarm-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171155
2017.05.20 03:52:47 2: SONOS4: ZoneGroupTopology-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171156
2017.05.20 03:52:47 2: SONOS4: DeviceProperties-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171157
2017.05.20 03:52:47 2: SONOS4: MusicServices-Service-subscribing successful with SID=uuid:RINCON_5CAAFD4B541E01400_sub0000171158
2017.05.20 03:52:47 3: SONOS4: Discover: End of discover-event for "Wohnzimmer".
2017.05.20 03:52:47 3: SONOS4: Event: Received Transport-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:47 3: SONOS4: Event: End of Transport-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:47 3: SONOS4: Event: Received Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:47 3: SONOS4: Event: End of Transport-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:47 3: SONOS4: Event: Received Alarm-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:47 3: SONOS4: Event: End of Alarm-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:47 3: SONOS4: Event: Received GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:47 3: SONOS4: Event: End of GroupRendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:47 3: SONOS4: Event: Received MusicServices-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:47 3: SONOS4: Event: End of MusicServices-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:47 3: SONOS4: Event: Received Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:47 3: SONOS4: Event: End of Alarm-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:47 3: SONOS4: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:48 3: SONOS4: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:48 3: SONOS4: Event: Received MusicServices-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:48 3: SONOS4: Event: End of MusicServices-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:48 3: SONOS4: Event: Received DeviceProperties-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:48 3: SONOS4: Event: End of DeviceProperties-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:48 3: SONOS4: Event: Received ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:48 3: SONOS4: Event: End of ZoneGroupTopology-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:48 3: SONOS4: Event: Received ContentDirectory-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:48 3: SONOS4: Event: End of ContentDirectory-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:48 3: SONOS4: Event: Received DeviceProperties-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:48 3: SONOS4: Event: End of DeviceProperties-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:48 3: SONOS4: Event: Received Rendering-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:48 3: SONOS4: Event: End of Rendering-Event for Zone "Sonos_Wohnzimmer_2".
2017.05.20 03:52:48 3: SONOS4: Event: Received ContentDirectory-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:48 3: SONOS4: Event: End of ContentDirectory-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:48 3: SONOS4: Event: Received Rendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:52:48 3: SONOS4: Event: End of Rendering-Event for Zone "Sonos_Wohnzimmer".
2017.05.20 03:53:35 3: SONOS0: Connection accepted from localhost:55442
2017.05.20 03:54:20 3: SONOS0: Connection accepted from localhost:55474
2017.05.20 03:55:05 3: SONOS0: Connection accepted from localhost:55524
2017.05.20 03:55:50 3: SONOS0: Connection accepted from localhost:55560
2017.05.20 03:56:35 3: SONOS0: Connection accepted from localhost:55612
2017.05.20 03:57:21 3: SONOS0: Connection accepted from localhost:55650
2017.05.20 03:58:06 3: SONOS0: Connection accepted from localhost:55706
2017.05.20 03:58:51 3: SONOS0: Connection accepted from localhost:55742
2017.05.20 03:59:36 3: SONOS0: Connection accepted from localhost:55790
2017.05.20 04:00:00 3: FHEMNASBackupOn return value: -1
/FhemBackup bereits vorhanden
2017.05.20 04:00:11 2: SONOS4: Error during UPnP-Handling, restarting handling: mismatched tag 'head'



Jetzt nach einem FHEM Update und neustart wieder auf disappeared.
Einmal disable /enable und Sonos ist wieder erreichbar.

Noch jemand Probleme in der Art oder einen Lösungsvorschlag?

LG Thomas
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: juemuc am 20 Mai 2017, 22:25:57
Hallo zusammen,

bei mir funktioniert soweit alles sehr gut. Ich habe nur zwei Verbesserungswünsche:
1. Die Sortierung der Favoritenlogos sollten nach dem Namen der Sender sortiert sein
2. Im Dashboard sollten die Logos den gesamten Platz nutzen.

Es fehlen leider auch noch einige Logos

Viele Grüße
juemuc
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 20 Mai 2017, 23:40:34
Hi juemuc,

bzgl. des Dashboards habe ich keinen Einfluss auf die Darstellung. Die Liste wird von einer Readingsgroup angezeigt, diese haben, wie immer nur eine Ausbreitung über die erste beiden Spalten.

Zu den Favoriten-Listen:
In meiner Standardimplementierung wird die Sortierung von Sonos verwendet. Wenn du das anders haben möchtest, musst du dir eine Kopie der Prozedur "SONOS_getListRG()" in deiner eigenen myUtils anlegen (anders nennen natürlich).
Dort kannst du den Bereich der for-Schleife dann auf deine Belange anpassen und die Sortierung selbst durchführen...
Dann brauchst du nur noch in der ReadingsGroup der Anzeige deine Prozedur angeben.

Mit den Logos: Versuch mal den entsprechenden Befehl "get...WithCovers" am entsprechenden Player nochmal auszuführen. Mit der neuen Version werden die Links für Radio-Cover anders erzeugt...

Grüße
Reinerlein
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Loredo am 21 Mai 2017, 12:47:17
Hi Reinerlein,

Zitat von: Reinerlein am 16 Mai 2017, 01:37:38
es werden einige Links auf die statischen Coverbildchen oder Proxypfade zusammengebaut, die keine Fragezeichen enthalten (bzw. weiter hinten). Was sollte ich dort denn angeben?

Die URLs lauten dann ja z.B.

/fhem/sonos/cover/empty.jpg
oder
/fhem/sonos/proxy/aa?url=urlEncodedOriginalURL

Wenn ich dort nur

sonos/cover/empty.jpg
oder
sonos/proxy/aa?url=urlEncodedOriginalURL

erzeugen würde, würde der Browser doch das "fhem" auch weglassen. Ein Fragezeichen als erstes Zeichen würde auch nicht gehen, da damit FhemWeb die Verarbeitung meiner Cover und Proxy machen müsste, und die Anfrage damit nicht in meinem Modul landen würde...


FHEMWEB reicht dir ja einfach alles durch, was du als Infix registrierst. Wenn du diesen von "/sonos" auf "?/sonos" umänderst, ist es nur eine Frage deines Moduls, wie du mit dem Parsen der URI weiter umgehst. Die virtuellen Unterverzeichnisse wie /cover /proxy etc kannst du entweder so belassen oder auch als Teil des Body übertragen, um das zweite Fragezeichen weiter hinten überflüssig zu machen. Oder du registrierst unterschiedliche Infix unabhängig voneinander.




?/sonos&t=cover&n=empty.jpg
oder
?/sonos&t=proxy&n=aa&url=urlEncodedOriginalURL



Letztendlich kommt es ja nur darauf an, wie du in deinem Modul den URI String parst. Ich vermute sogar, dass man auch mit zwei ? in der URI arbeiten kann, weil FHEMWEB da nicht wie ein normaler Webserver arbeitet und die URI für dich zerlegt. Habe es nicht probiert, aber dem Browser ist es vermutlich egal, wenn nach dem ersten Fragezeichen irgendwo noch ein zweites kommt.


Zitat von: Reinerlein am 16 Mai 2017, 01:37:38Wozu sollte man auch Port und Webname gleichzeitig unterschiedlich gestalten, wenn man diesselbe Anwendung meint?


Der Grund ist nicht, weil ich auf deine Sonos Anwendung unterschiedlich zugreifen will. Der Grund ist, dass über die unterschiedlichen FHEMWEB Instanzen die Zugriffsrechte entsprechend gesteuert werden und ich derzeit so in meiner Admin-CONFIG Instanz keine Coveranzeige habe und ich mich bei den User-Instanzen für eine entscheiden muss, die dann für Smartphones und für Tablets gleichermaßen funktioniert.


Zitat von: Reinerlein am 16 Mai 2017, 01:37:38Der Webname stammt ja aus dem Bereich der Webapplikationsserver, die damit die Unterscheidung treffen, um welche der vielen Installierten Applikationen es sich handeln soll


Da komme ich nicht ganz mit. Du meinst hier vermutlich eher den Infix und nicht den Webname. Der Webname ist IMHO eine reine Zuordnung FHEMWEB intern (obgleich ich das auch nicht verstehe, der zugegriffene Port alleine sollte ja auch für die Unterscheidung reichen, aber nunja). Wenn es dir darum geht, dass Reverse Proxies auf einfache Weise zwischen unterschiedlichen Backend Servern unterscheiden können, ohne intern die URI umschreiben zu müssen: Ja, das ist richtig. Bleibt aber trotzdem eine reine FHEMWEB Geschichte und ich sehe keinen Grund ein Modul innerhalb von FHEM davon abhängig zu machen. Wie gesagt, bei meinem ONKYO_AVR Modul (https://svn.fhem.de/trac/browser/trunk/fhem/FHEM/70_ONKYO_AVR.pm?rev=14337#L2922) funktioniert es ohne Probleme, auch wenn ich nicht so viele Parameter übergebe wie du. Ich kann mir nicht vorstellen, weshalb du diese Abhängigkeit bei dir nicht auch aufgelöst bekommen sollst  ;)
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 21 Mai 2017, 17:15:16
Hi Julian,

Ich baue ungern ungültige URLs zusammen, da irgendein schlauer Browser oder Proxy dazwischen dass dann bestimmt irgendwann (u.U. erst in der Zukunft) mal verwirft.
Ich bleibe dabei, das Attribut Webname von Fhem ist bei anderen Webapplikationen grundsätzlich fest (für eine bestimmte Funktionalität natürlich), da es dort meist etwas wie "index.php", "main.do" oder wer weiß wie sonst lautet, auf jeden Fall immer identisch. Da kann man sich drauf einstellen, und es fest in die URL einplanen.
Ich weiß nicht, was du als Infix bezeichnest, der Begriff ist mir in einer URL noch nicht untergekommen, denke aber, dass du Bestandteile des Pfades meinst (das ist der Bereich hinter der Portnummer bis um ersten Fragezeichen), vgl. dazu auch https://de.wikipedia.org/wiki/Uniform_Resource_Locator#Aufbau (https://de.wikipedia.org/wiki/Uniform_Resource_Locator#Aufbau), damit wir über dasselbe reden...

Und warum verwendest du nicht einfach immer denselben Webname (und damit meine ich das Attribut einer FhemWeb-Definition) und unterscheidest (wie ich bei mir auch) nur Anhand des Ports?
Das ist korrekt nach RFC und berücksichtigt die gewachsenen Begebenheiten von Fhem.
Damit sind doch alle Probleme beseitigt, und ich muss hier nichts im Code anpassen...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: DeeSPe am 22 Mai 2017, 08:01:51
Hallo Reiner,

ich habe nach einem Neustart immer folgende Zeilen im Log und kann mir diese nicht erklären.

at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 5022 thread 3.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
Use of uninitialized value $_[0] in concatenation (.) or string at /usr/share/perl5/XML/Parser/Lite.pm line 168, <$client> line 8.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.


Kannst Du damit evtl. etwas anfangen?

Danke.

Gruß
Dan
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 22 Mai 2017, 08:58:29
Hi Dan,

das haben hier im Forum auch schon ein paar andere Anwender gepostet. Leider fehlt da ja die eigentliche Fehlermeldung, und es steht nur wo es passiert ist :(

Die beiden angegebenen Zeilen sind im Sonos-Modul die Aufrufzeilen für den UPnP-Listener. Das bedeutet, dass irgendwas per UPnP ankam, was diese Library nicht verarbeiten konnte und deswegen an dieser Stelle zurückkommt. Es wäre schön zu wissen was :)
Geht es denn danach normal weiter, oder steigt der SubProzess komplett aus?

Vielleicht sollte ich mal allgemein aus einigen "croak"-Aufrufen im UPnP-Modul "carp"-Aufrufe machen. Dann werden diese wenigstens von meinem Modul aufgefangen, und beenden nicht den gesamten Prozess...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: DeeSPe am 22 Mai 2017, 09:16:58
Ich konnte bisher nichts Nachteiliges feststellen, nur die Ausgaben im Log.
War auch etwas verwundert dass die Ausgaben ohne weitere Infos kommen.
Werde das mal weiter beobachten...

Gruß
Dan
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: fhem-challenge am 22 Mai 2017, 10:40:34
Hallo Zusammen,

heute habe ich meinen zweiten Versuch gestartet, die neue SONOS.pm (incl. FHEM/lib/UPnP/ControlPoint.pm) zu updaten.

Das führt persistent dazu, dass meinen drei SONOS alle "Player disappeared" sind. Auch ein disable=0 / disable=1 und vice versa bringtt nichts. Ein rescan network ebenfalls nicht. die Player sind aller nicht erreichbar.

Gibts irgend einen sinnvollen Workaround dafür ? oder ist es sinnvoll, bei der "alten" sonos.pm zu bleiben ?

Nachtrag: Ich habe nun meine alte SONOS config komplett entfernt, und alle SONOS wieder neu in FHEM installiert/angelegt. Jetzt sind die Player erreichbar, aber der Weg ist nicht einfach.

Nachtrag2: suppressControlButtons=0 hat bei mir keine Wirkung. Ich hätte hierbei erwartet, das die Steuerungs(buttons) dargestellt werden ? Aber diese werden nur beim Masterplayer angezeigt (wenngleich dieser interessanterweise suppressControlButtons=1 hatte) ?


Viele Grüße!


Andreas
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 22 Mai 2017, 14:01:31
Hi Andreas,

"suppressControlButtons" heißt die Anzeige der Buttons zu unterdrücken. Und zwar nur in der Raumansicht für den Player, an dem es gesetzt wurde.
Das verwendet man, wenn man selber seine eigene (RemoteControl-)Buttonleiste anzeigen möchte.

In der Detailansicht werden die Buttons immer angezeigt. Da dort auch keine anderen Controls möglich wären, stört das auch nicht weiter.

Allgemein gilt für die neue Darstellung: Nur der Masterplayer einer Gruppe zeigt die Cover-/Titelanzeige und die Buttons. Ist ein Player ein Slaveplayer, wird das alles nicht angezeigt...

Wenn du das alte Verhalten möchtest, kannst du das Attribut "deviceRoomView" am Sonos-Device (also nur für alle Player gleichzeitig) auf "DeviceLineOnly" setzen, dann wird auch die Cover-/Titelanzeige in der Raumansicht unterdrückt.

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: markusm am 23 Mai 2017, 07:16:25
Hi Andreas!

Hilft das dauerhaft?
Bei mir sind die Player spätestens am nächsten Tag wieder "disappeared" . :-(

LG
Markus
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: fhem-challenge am 23 Mai 2017, 10:35:49
Zitat von: markusm am 23 Mai 2017, 07:16:25
Hi Andreas!

Hilft das dauerhaft?
Bei mir sind die Player spätestens am nächsten Tag wieder "disappeared" . :-(

LG
Markus


Bei mir sind die Player nach einem Tag immer noch appeared. Ich habe aber gestern nach FHEM restart ca. 5 Minuten gewartet, da waren die Player noch disappeared. Ich habe dann anschliessend ein Network Scan am "sonos" Device im FHEM gemacht, danach waren die "appeared"! und sind es jetzt auch noch (nach ca. 30 Stunden).

Nachtrag: Ein Problem besteht und ist reproduzierbar.

Wenn FHEM neu gestartet wird, bleiben nach Neustart alle Player DISAPEARED. Daran ändert sich nichts, es sei denn, dass ich entweder ein Network Scan mache, oder auch beliebig Play,Pause,Stop am Masterplayer in FHEM bediene (also set [SONOS-Player] start). Unmittelbar danach werden die Player auch gefunden.

2017.05.23 11:23:13 3: SONOS0: Connection accepted from localhost:46150
2017.05.23 11:23:40 3: SONOS1: UPnP-Thread gestartet.
at /opt/fhem/FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.23 11:23:40 1: SONOS2: IsAlive-Thread gestartet. Warte 120 Sekunden und pruefe dann alle 30 Sekunden...
2017.05.23 11:23:40 3: SONOS1: ProxyObject does not exists
2017.05.23 11:23:40 1: SONOS3: Restore-Thread gestartet. Warte auf Arbeit...
at /opt/fhem/FHEM/00_SONOS.pm line 5022 thread 3.
2017.05.23 11:23:40 2: SONOS1: Discover Sonosplayer 'Küche' (S1) Software Revision 7.2 with ID 'RINCON_xxxxxx_MR'
2017.05.23 11:23:41 2: SONOS1: SonosPlayer 'Kueche' (S1) with ID 'RINCON_xxxxxx_MR' is already defined (as 'Sonos_Kueche') and will only be updated



Das ist übrigens unabhängig, ob ich ICMP,UDP etc. als PingType am sonos Device einstelle.

Als Interimslösung werde ich mir bei Neustart von FHEM ein 5 Minuten Timer bauen, der dann ein RescanNetwork am SONOS Device macht. Ich denke, dann sind die Player i.d.R. "appeared".

So in der Art:

define FHEMinit notify global:INITIALIZED {
fhem("defmod wakeup_sonos_player_on_start at +00:05:00 set Sonos RescanNetwork")
}




Viele Grüße!



Andreas
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: DeeSPe am 23 Mai 2017, 10:40:11
Wie schafft man denn von gestern Abend bis heute früh eine Betriebszeit von ca. 30 Stunden?

Gruß
Dan
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: fhem-challenge am 23 Mai 2017, 10:42:55
Zitat von: DeeSPe am 23 Mai 2017, 10:40:11
Wie schafft man denn von gestern Abend bis heute früh eine Betriebszeit von ca. 30 Stunden?

Gruß
Dan


Von gestern Morgen bis now-10 Minuten. Okay, sind dann eher 27,5 Stunden, aber inhaltlich ändert sich da nicht sehr viel.

Viele Grüße!


Andreas
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: DeeSPe am 23 Mai 2017, 10:44:49
Sorry, hatte in Deinen Satz irgendwie noch ein "Abend" hineininterpretiert, was aber gar nicht da ist.
My Fault!

Cheers
Dan
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 23 Mai 2017, 11:40:49
Hi Dan,

ich habe den Grund für die Fehlermeldungen ohne Fehler gefunden :)

Es ist tatsächlich genau das: Kein Fehler.
Ich habe in der ControlPoint ein If vergessen, und gebe an einer Stelle immer eine Fehlervariable $@ zurück. Im Erfolgsfall enthält diese Variable aber nun mal keinen Fehler...

Der Fluß wird dadurch nicht gestört. Ich habe es natürlich trotzdem behoben, checke es aber erst später ein, da es ohne Einfluss ist...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: mrfloppy am 23 Mai 2017, 12:10:50
Ich muss mich nochmals melden, da ich der einige sein dürfte dem sein LOG voll geschrieben wird.
Habe alle Player gelöscht, neugestartet alles eingerichtet, nochmals neugestartet.
Loglevel auf 1 gesetzt.
Und es kommen dauernd diese Meldungen?

Bei der alten Version war es von Sonos eigentlich sehr still im LOG.
Bei verbose auf 3 sind es noch viel mehr.

2017.05.23 08:13:59 1: SONOS0: ./FHEM/00_SONOS.pm is listening to Port 4711
2017.05.23 08:14:27 3: SONOS0: Connection accepted from localhost:46888
2017.05.23 08:14:27 1: localhost:4711 reappeared (Sonos)
2017.05.23 08:15:28 3: SONOS0: Connection accepted from localhost:46956
2017.05.23 08:15:58 3: SONOS0: Connection accepted from localhost:46980
2017.05.23 08:16:09 3: FHEMWEB WEB CSRF error: csrf_260177983775233 ne csrf_155924022765736. For detals see the csrfToken FHEMWEB attribute
2017.05.23 08:16:28 3: SONOS0: Connection accepted from localhost:47014
2017.05.23 08:16:36 3: FHEMWEB WEB CSRF error: csrf_260177983775233 ne csrf_155924022765736. For detals see the csrfToken FHEMWEB attribute
2017.05.23 08:16:58 3: SONOS0: Connection accepted from localhost:47050
2017.05.23 08:17:28 3: SONOS0: Connection accepted from localhost:47070
2017.05.23 08:17:58 3: SONOS0: Connection accepted from localhost:47106
2017.05.23 08:18:28 3: SONOS0: Connection accepted from localhost:47140
2017.05.23 08:18:58 3: SONOS0: Connection accepted from localhost:47164
2017.05.23 08:19:28 3: SONOS0: Connection accepted from localhost:47196
2017.05.23 08:20:00 3: SONOS0: Connection accepted from localhost:47234
2017.05.23 08:20:30 3: SONOS0: Connection accepted from localhost:47252
2017.05.23 08:21:00 3: SONOS0: Connection accepted from localhost:47290
2017.05.23 08:21:30 3: SONOS0: Connection accepted from localhost:47324
2017.05.23 08:21:41 3: SONOS1: UPnP-Thread gestartet.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.23 08:21:41 1: SONOS2: IsAlive-Thread gestartet. Warte 120 Sekunden und pruefe dann alle 30 Sekunden...
2017.05.23 08:21:41 2: SONOS1: Discover Sonosplayer 'Wohnzimmer 2' (S3) Software Revision 7.2 with ID 'RINCON_B8E937D046C001400_MR'
2017.05.23 08:21:41 1: SONOS1: Setting LogLevel to new value: 1
2017.05.23 08:21:41 1: SONOS3: Restore-Thread gestartet. Warte auf Arbeit...
at ./FHEM/00_SONOS.pm line 5022 thread 3.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.23 10:50:51 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackURI,x-rincon-mp3radio://http://mp3stream7.apasf.apa.at:8000) missed to call readingsBeginUpdate first.
2017.05.23 10:50:51 1: stacktrace:
2017.05.23 10:50:51 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 10:50:51 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 10:50:51 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 10:50:51 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 10:50:51 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPosition,0:08:58) missed to call readingsBeginUpdate first.
2017.05.23 10:50:51 1: stacktrace:
2017.05.23 10:50:51 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 10:50:51 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 10:50:51 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 10:50:51 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 10:50:51 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPositionSec,538) missed to call readingsBeginUpdate first.
2017.05.23 10:50:51 1: stacktrace:
2017.05.23 10:50:51 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 10:50:51 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 10:50:51 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 10:50:51 1:     main::CallFn                        called by fhem.pl (686)
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackURI,x-rincon:RINCON_5CAAFD4B541E01400) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:00:07 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackProvider,Gruppenwiedergabe: Wohnzimmer) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:00:07 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackProviderIconRoundURL,) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:00:07 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackProviderIconQuadraticURL,) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:00:07 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackDuration,NOT_IMPLEMENTED) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:00:07 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackDurationSec,0) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:00:07 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackPosition,NOT_IMPLEMENTED) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (1252)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackPositionSec,0) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (1252)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,numberOfTracks,1) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:00:07 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentStreamAudio,) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:00:07 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:00:07 1: readingsUpdate(Sonos_Wohnzimmer_2,currentNormalAudio,1) missed to call readingsBeginUpdate first.
2017.05.23 11:00:07 1: stacktrace:
2017.05.23 11:00:07 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:00:07 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:00:07 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:00:07 1:     main::CallFn                        called by fhem.pl (686)
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,IsMaster,1) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackURI,x-rincon:RINCON_5CAAFD4B541E01400) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackProvider,Gruppenwiedergabe: Wohnzimmer) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackProviderIconRoundURL,) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackProviderIconQuadraticURL,) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackDuration,NOT_IMPLEMENTED) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackDurationSec,0) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackPosition,NOT_IMPLEMENTED) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (1252)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackPositionSec,0) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (1252)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,numberOfTracks,1) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentStreamAudio,) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:15:04 1: readingsUpdate(Sonos_Wohnzimmer_2,currentNormalAudio,1) missed to call readingsBeginUpdate first.
2017.05.23 11:15:04 1: stacktrace:
2017.05.23 11:15:04 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:15:04 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:15:04 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:15:04 1:     main::CallFn                        called by fhem.pl (686)
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.23 11:20:51 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackURI,x-rincon-mp3radio://http://mp3stream7.apasf.apa.at:8000) missed to call readingsBeginUpdate first.
2017.05.23 11:20:51 1: stacktrace:
2017.05.23 11:20:51 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:20:51 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:20:51 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:20:51 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:20:51 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPosition,0:28:35) missed to call readingsBeginUpdate first.
2017.05.23 11:20:51 1: stacktrace:
2017.05.23 11:20:51 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:20:51 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:20:51 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:20:51 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:20:51 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPositionSec,1715) missed to call readingsBeginUpdate first.
2017.05.23 11:20:51 1: stacktrace:
2017.05.23 11:20:51 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:20:51 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:20:51 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:20:51 1:     main::CallFn                        called by fhem.pl (686)
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.23 11:45:35 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackURI,x-rincon-mp3radio://http://mp3stream7.apasf.apa.at:8000) missed to call readingsBeginUpdate first.
2017.05.23 11:45:35 1: stacktrace:
2017.05.23 11:45:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:45:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:45:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:45:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:45:35 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPosition,0:02:03) missed to call readingsBeginUpdate first.
2017.05.23 11:45:35 1: stacktrace:
2017.05.23 11:45:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:45:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:45:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:45:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:45:35 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPositionSec,123) missed to call readingsBeginUpdate first.
2017.05.23 11:45:35 1: stacktrace:
2017.05.23 11:45:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:45:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:45:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:45:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:45:35 1: readingsUpdate(Sonos_Wohnzimmer,currentNormalAudio,) missed to call readingsBeginUpdate first.
2017.05.23 11:45:35 1: stacktrace:
2017.05.23 11:45:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:45:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:45:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:45:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:50:49 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackURI,x-rincon-mp3radio://http://mp3stream7.apasf.apa.at:8000) missed to call readingsBeginUpdate first.
2017.05.23 11:50:49 1: stacktrace:
2017.05.23 11:50:49 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:50:49 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:50:49 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:50:49 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:50:49 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPosition,0:07:17) missed to call readingsBeginUpdate first.
2017.05.23 11:50:49 1: stacktrace:
2017.05.23 11:50:49 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:50:49 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:50:49 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:50:49 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:50:49 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPositionSec,437) missed to call readingsBeginUpdate first.
2017.05.23 11:50:49 1: stacktrace:
2017.05.23 11:50:49 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:50:49 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:50:49 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:50:49 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 11:50:49 1: readingsUpdate(Sonos_Wohnzimmer,currentNormalAudio,) missed to call readingsBeginUpdate first.
2017.05.23 11:50:49 1: stacktrace:
2017.05.23 11:50:49 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 11:50:49 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 11:50:49 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 11:50:49 1:     main::CallFn                        called by fhem.pl (686)
at ./FHEM/00_SONOS.pm line 4310 thread 1.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.23 12:00:33 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackURI,x-rincon-mp3radio://http://mp3stream7.apasf.apa.at:8000) missed to call readingsBeginUpdate first.
2017.05.23 12:00:33 1: stacktrace:
2017.05.23 12:00:33 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:33 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:33 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:33 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:33 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPosition,0:17:01) missed to call readingsBeginUpdate first.
2017.05.23 12:00:33 1: stacktrace:
2017.05.23 12:00:33 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:33 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:33 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:33 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:33 1: readingsUpdate(Sonos_Wohnzimmer,currentTrackPositionSec,1021) missed to call readingsBeginUpdate first.
2017.05.23 12:00:33 1: stacktrace:
2017.05.23 12:00:33 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:33 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:33 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:33 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,IsMaster,1) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackURI,x-rincon:RINCON_5CAAFD4B541E01400) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackProvider,Gruppenwiedergabe: Wohnzimmer) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackProviderIconRoundURL,) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackProviderIconQuadraticURL,) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackDuration,NOT_IMPLEMENTED) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackDurationSec,0) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackPosition,NOT_IMPLEMENTED) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (1252)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentTrackPositionSec,0) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (1252)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,numberOfTracks,1) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentStreamAudio,) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)
2017.05.23 12:00:35 1: readingsUpdate(Sonos_Wohnzimmer_2,currentNormalAudio,1) missed to call readingsBeginUpdate first.
2017.05.23 12:00:35 1: stacktrace:
2017.05.23 12:00:35 1:     main::readingsBulkUpdate            called by ./FHEM/00_SONOS.pm (9289)
2017.05.23 12:00:35 1:     main::SONOS_readingsBulkUpdateIfChanged called by ./FHEM/00_SONOS.pm (1265)
2017.05.23 12:00:35 1:     main::SONOS_Read                    called by fhem.pl (3412)
2017.05.23 12:00:35 1:     main::CallFn                        called by fhem.pl (686)


LG Thomas
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Xamsum am 24 Mai 2017, 21:07:30
Hallo zusammen,

mein 1. Post hier. Habe gerade erst angefangen FHEM aufzusetzen. Leider laufe ich in die gleichen Probleme wie sie Mike vorher beschrieben hat. Das Logfile läuft mit sehr vielen der folgenden Einträge voll, die meine Raspberry Pi 3 bis zum Stillstand ausbremsen

recv() on unopened socket 1 at FHEM/lib/UPnP/ControlPoint.pm line 450, <$client> line 6.

Dies passiert unabhängig davon, ob ich reusePort auf 0 oder 1 setze.

Viele Gruesse
--Michael
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Photon68 am 26 Mai 2017, 07:08:36
@Reinerlein:

Zunächst erst mal vielen Dank für das Modul. Ich bin seit einiger Zeit Nutzer des Moduls, hauptsächlich in Verbindung mit FTUI.

Ich habe die neueste Version installiert. Die funktioniert auch nach zwei, drei Anläufen (musste erst alles alte löschen und die Player neu anlegen)

Allerdings habe ich zwei Fragen:
1.) Wenn ich die Player laufen lasse (Radio), wird mir im Minutentakt das LOG vollgeschrieben.
2017.05.26 06:56:01 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.

2017.05.26 06:56:23 1: SONOS0: Error during retreiving of FavouriteName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1369.

2017.05.26 06:56:23 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.


2.) Die mitgelieferten RG bleiben leer. (ist für mich nicht schlimm, da ich sie für FTUI nicht brauche)

Für mich funzt das Modul insgesamt fehlerfrei, d.h. ich kann außer den o.g. zwei Punkten keine Fehler feststellen.


Gruß Photon68
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: mrfloppy am 26 Mai 2017, 07:21:21
ZitatFür mich funzt das Modul insgesamt fehlerfrei, d.h. ich kann außer den o.g. zwei Punkten keine Fehler feststellen.

So wie es aussieht aber bei einigen anderen nicht, vorallem mit den disappeared Fehler.
Das vor der neuen Version nicht vorhanden war.

Ist das ein Fehler im Modul oder liegt der Fehler beim System der Leute?
Es nervt ungemein wenn die Player immer abwesend sind.

LG
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 26 Mai 2017, 09:59:52
Hallo,

@photon68: Diese beiden Fehler hängen zusammen. Im Wiki (https://wiki.fhem.de/wiki/SONOS#Automatische_Aktualisierung_der_Favoriten_.2F_Playlisten_.2F_Radios_durch_Notifies (https://wiki.fhem.de/wiki/SONOS#Automatische_Aktualisierung_der_Favoriten_.2F_Playlisten_.2F_Radios_durch_Notifies)) gibt es eine Beschreibung, wie man sich diese Listen automatisch aktualisieren kann. In der nächsten Version wird das auch intern abgewickelt werden können, dann braucht man diese Notifies nicht mehr...
Du kannst für den Player einfach die beiden Befehle 'get PLAYER RadiosWithCovers' bzw. 'get PLAYER Radios' ausführen, dann ist der Fehler weg (und deine ReadingsGroups zeigen auch etwas an :) ). Das ganze natürlich auch für 'Favourites' und 'Playlists'...
Der Fehler wird auf Level 1 ausgegeben, mann könnte ihn also auch mit einem verbose auf 0 unterbinden :)

@mrfloppy: Ich konnte den Fehler bislang noch nicht mal ansatzweise finden. Es ist z.B. unklar, ob der SubProzess nicht mehr gefunden wird, und damit alle Player auf einen Schlag disappeared gesetzt werden, oder ob der IsAlive-Checker des SubProzesses einen Plaser nicht mehr finden kann, und diesen dann als abwesend meldet.
Dazu brauchen wir Logausgaben auf Level 5 (was sehr viel wird), um die letzten funktionierenden Aktionen sehen zu können, um dann hoffentlich auf das eigentliche Problem schließen zu können.

Grüße
Reinerlein
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: mrfloppy am 26 Mai 2017, 12:56:13
ZitatDazu brauchen wir Logausgaben auf Level 5 (was sehr viel wird)

Ich werde Sonntag mich mal hinsetzen un dLOG auf 5 stellen und schauen was da so raus kommt und es dann posten.

Es muss sich aber etwas bei der neues Version getan haben, weil in der alten Version was das Log eigentlich sehr ruhig.

LG
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: ThiemoSt am 26 Mai 2017, 13:31:38
Zitat von: Reinerlein am 26 Mai 2017, 09:59:52
@mrfloppy: Ich konnte den Fehler bislang noch nicht mal ansatzweise finden. Es ist z.B. unklar, ob der SubProzess nicht mehr gefunden wird, und damit alle Player auf einen Schlag disappeared gesetzt werden, oder ob der IsAlive-Checker des SubProzesses einen Plaser nicht mehr finden kann, und diesen dann als abwesend meldet.
Dazu brauchen wir Logausgaben auf Level 5 (was sehr viel wird), um die letzten funktionierenden Aktionen sehen zu können, um dann hoffentlich auf das eigentliche Problem schließen zu können.

Ich werde morgen mal den Log auf 5 erstellen und mir Zeit nehmen mit Sonos zu "spielen". Konnte bisher auch nicht genau feststellen ob es z.B. eine Regel gibt wann die Player aussteigen.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Zerika am 26 Mai 2017, 14:47:09
Hallo zusammen,

nach Installation der neuen Version flutet das Modul aktuell mein Log.
Auf der einen Seite bekomme ich dauerhaft Fehler über die neuen Readings der TrackProvide:
...
Use of uninitialized value $trackProviderQuadraticURL in concatenation (.) or string at ./FHEM/00_SONOS.pm line 6980, <$client> line 5.
Use of uninitialized value $trackProviderRoundURL in concatenation (.) or string at ./FHEM/00_SONOS.pm line 6951, <$client> line 5.
Use of uninitialized value $trackProviderQuadraticURL in concatenation (.) or string at ./FHEM/00_SONOS.pm line 6952, <$client> line 5.
Use of uninitialized value $trackProviderRoundURL in concatenation (.) or string at ./FHEM/00_SONOS.pm line 6979, <$client> line 5.
Use of uninitialized value $trackProviderQuadraticURL in concatenation (.) or string at ./FHEM/00_SONOS.pm line 6980, <$client> line 5.
Use of uninitialized value $trackProviderRoundURL in concatenation (.) or string at ./FHEM/00_SONOS.pm line 6951, <$client> line 5.
Use of uninitialized value $trackProviderQuadraticURL in concatenation (.) or string at ./FHEM/00_SONOS.pm line 6952, <$client> line 5.
Use of uninitialized value $trackProviderRoundURL in concatenation (.) or string at ./FHEM/00_SONOS.pm line 6979, <$client> line 5.
Use of uninitialized value $trackProviderQuadraticURL in concatenation (.) or string at ./FHEM/00_SONOS.pm line 6980, <$client> line 5.
...


Auf der anderen Seite scheint irgendwas mit dem Laden der Cover für die Playlists und Queues noch nicht ganz zu funktionieren. Die Cover in der Detailansicht der Player werden allerdings sauber geladen:
2017.05.26 14:42:08 1: SONOS0: Cover couldn't be loaded "http://cdn-radiotime-logos.tunein.com/s223993g.png": 404 Not Found
2017.05.26 14:42:08 1: SONOS0: Cover couldn't be loaded "http://192.168.178.41:1400/getaa?u=x-sonos-http%3Alibrarytrack%253ai.17414.mp4%3Fsid%3D204%26flags%3D8224%26sn%3D2": 404 Not Found
2017.05.26 14:42:08 1: SONOS0: Cover couldn't be loaded "http://192.168.178.41:1400/getaa?u=x-sonos-http%3Alibrarytrack%253ai.17718.mp4%3Fsid%3D204%26flags%3D8224%26sn%3D2": 404 Not Found
2017.05.26 14:42:08 1: SONOS0: Cover couldn't be loaded "http://192.168.178.41:1400/getaa?u=x-sonos-http%3Alibrarytrack%253ai.17694.mp4%3Fsid%3D204%26flags%3D8224%26sn%3D2": 404 Not Found
2017.05.26 14:42:08 1: SONOS0: Cover couldn't be loaded "http://192.168.178.41:1400/getaa?u=x-sonos-http%3Alibrarytrack%253ai.17462.mp4%3Fsid%3D204%26flags%3D8224%26sn%3D2": 404 Not Found
...


Zusätlich bekomme ich im Event Monitor folgenden Fehler beim Aufruf von get QueueWithCovers

jquery.min.js line 3:
Uncaught TypeError: Cannot read property 'lastChild' of null


Gruß
Tom
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: juemuc am 26 Mai 2017, 21:10:38
Zitat von: Reinerlein am 20 Mai 2017, 23:40:34
Hi juemuc,

bzgl. des Dashboards habe ich keinen Einfluss auf die Darstellung. Die Liste wird von einer Readingsgroup angezeigt, diese haben, wie immer nur eine Ausbreitung über die erste beiden Spalten.

Zu den Favoriten-Listen:
In meiner Standardimplementierung wird die Sortierung von Sonos verwendet. Wenn du das anders haben möchtest, musst du dir eine Kopie der Prozedur "SONOS_getListRG()" in deiner eigenen myUtils anlegen (anders nennen natürlich).
Dort kannst du den Bereich der for-Schleife dann auf deine Belange anpassen und die Sortierung selbst durchführen...
Dann brauchst du nur noch in der ReadingsGroup der Anzeige deine Prozedur angeben.

Mit den Logos: Versuch mal den entsprechenden Befehl "get...WithCovers" am entsprechenden Player nochmal auszuführen. Mit der neuen Version werden die Links für Radio-Cover anders erzeugt...

Grüße
Reinerlein

Hallo Reinerlein,
das Problem mit den Covers scheint bei Sonos zu liegen, da sie auch im original Sonos-Programm fehlen.

Die Sortierung verstehe ich allerdings noch nicht. Ich habe ein Userreading, in der die Favoriten alphabetisch aufgelistet sind (ermittelt über get Favourites), die angezeigten Favoriten haben aber einer andere Sortierung. Ich habe den Eindruck, dass hier die Favoriten in der Reihenfolge angezeigt werden, in der ich sie im Sonos-Programm hinzugefügt habe. Wie sie intern in Sonos verwaltet werden, kann ich leider nicht erkennen.
 
Das neue Feature mit currentTrackPositionSimulated finde ich auf der einen Seite gut, auf der anderen Seite wird dadurch permanent ein Event erzeugt, wenn simulateCurrentTrackPosition auf 1 steht. Gibt es eine Möglichkeit, die Events zu unterdrücken ohne die anderen Readings einzeln bei event-on-change-reading auflisten zu müssen?

Leider habe ich auch das Problem, dass bei einem Neustart von Fhem erst ein set RescanNetwork die Player wieder auf appeared setzt. Das Logfile liefert leider keine Hinweise. Manchmal funktioniert es aber auch.

Unabhängig von diesen Kleinigkeiten ist die neue Version super. Vielen Dank dafür.

Viele Grüße
juemuc
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: juemuc am 26 Mai 2017, 21:50:26
Hallo Reinerlein,

ich habe jetzt folgendes beobachten können:
Nachdem ich Sonos auf disabled gesetzt hatte und das Attribut nach ca 1 Munite gelöscht hatte, hat ernur den lokalhost hochgezählt. Nach einem RescanNetwork wurde erst der UPnP-Thread gestartet. Ich hoffe, dies hilft bei der Fehlersuche.

Zitat2017.05.26 21:42:10 3: Sonos device opened
2017.05.26 21:42:31 3: SONOS0: Connection accepted from localhost:54594
2017.05.26 21:42:41 3: SONOS0: Connection accepted from localhost:54596
2017.05.26 21:42:51 3: SONOS0: Connection accepted from localhost:54600
2017.05.26 21:43:01 3: SONOS0: Connection accepted from localhost:54604
2017.05.26 21:43:11 3: SONOS0: Connection accepted from localhost:54606
2017.05.26 21:43:21 3: SONOS0: Connection accepted from localhost:54610
2017.05.26 21:43:31 3: SONOS0: Connection accepted from localhost:54612
2017.05.26 21:43:41 3: SONOS0: Connection accepted from localhost:54614
2017.05.26 21:43:51 3: SONOS0: Connection accepted from localhost:54618
2017.05.26 21:44:01 3: SONOS0: Connection accepted from localhost:54620
2017.05.26 21:44:11 3: SONOS0: Connection accepted from localhost:54622
2017.05.26 21:44:21 3: SONOS0: Connection accepted from localhost:54626
2017.05.26 21:44:31 3: SONOS0: Connection accepted from localhost:54628
2017.05.26 21:44:41 3: SONOS0: Connection accepted from localhost:54630
2017.05.26 21:44:51 3: SONOS0: Connection accepted from localhost:54634
2017.05.26 21:45:01 3: SONOS0: Connection accepted from localhost:54636
2017.05.26 21:45:11 3: SONOS0: Connection accepted from localhost:54638
2017.05.26 21:45:21 3: SONOS0: Connection accepted from localhost:54642
2017.05.26 21:45:31 3: SONOS0: Connection accepted from localhost:54644
2017.05.26 21:45:41 3: SONOS0: Connection accepted from localhost:54646
2017.05.26 21:45:49 3: SONOS1: UPnP-Thread gestartet.
at ./FHEM/00_SONOS.pm line 4310 thread 1.
2017.05.26 21:45:49 1: SONOS2: IsAlive-Thread gestartet. Warte 120 Sekunden und pruefe dann alle 10 Sekunden...
2017.05.26 21:45:49 1: SONOS3: Restore-Thread gestartet. Warte auf Arbeit...
at ./FHEM/00_SONOS.pm line 5022 thread 3.
2017.05.26 21:45:50 2: SONOS1: Discover Sonosplayer 'Büro' (S12) Software Revision 7.2 with ID 'RINCON_949F3E08E98201400_MR'

Viele Grüße
juemuc
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: mrfloppy am 28 Mai 2017, 10:15:49
Habe mal das Verbose auf 5 gestellt. und neu gestartet.
Etwas gewartet und dann mal beim Player auf play gedrückt.
Nach einiger zeit nochmal play und nach noch einer Pause wieder play. Erst dann hat er gespielt.
Anbei das LOG davon.

Was mir auch auffällt es kommt auch immer dieser Eintrag
Loading device description failed with error: 500 Can't connect to 192.168.49.1:53760 (Location: http://192.168.49.1:53760/upnp/dev/44da200e-6e9b-0a71-ffff-ffffa044fb2c/desc) at ./FHEM/00_SONOS.pm line 4312 thread 1.

Woher kann das kommen. Diese IP gibt es in meinem Netzwerk eigentlich nicht.
Und mir kommt vor das ist auch ein Grund wieso die Player einige Zeit nicht reagieren.

Wenn ich was spezielles testen soll und loggen dann bitte sagen.

LG

Edit: Wollte nun Pause drücken ging nicht.
Wie man im Log schön sieht mehrmals immer mit etwas pause gedrückt und erst nach einer zeit hat es dann geklappt.
2017.05.28 10:20:27 4: SONOS2: IsAlive-Event UDN=RINCON_B8E937D046C001400_MR
2017.05.28 10:20:27 4: SONOS2: SONOS_Client_Data_Retreive(RINCON_B8E937D046C001400_MR, reading, location, ) -> http://10.0.0.111:1400/xml/device_description.xml
2017.05.28 10:20:27 5: SONOS2: Location: http://10.0.0.111:1400/xml/device_description.xml
2017.05.28 10:20:27 5: SONOS2: PingType: syn
2017.05.28 10:20:27 4: SONOS2: 10.0.0.111 is alive
2017.05.28 10:20:33 5: SW: 446f576f726b3a52494e434f4e5f35434141464434423534314530313430305f4d523a70617573653a0d0a
2017.05.28 10:20:33 5: SONOS0: Received: 'DoWork:RINCON_5CAAFD4B541E01400_MR:pause:'
2017.05.28 10:20:36 3: SONOS0: Connection accepted from localhost:59404
2017.05.28 10:20:36 4: SONOS0: Got correct answer from Subprocess...
2017.05.28 10:20:36 5: SW: 446f576f726b3a52494e434f4e5f35434141464434423534314530313430305f4d523a70617573653a0d0a
2017.05.28 10:20:36 5: SONOS0: Received: 'DoWork:RINCON_5CAAFD4B541E01400_MR:pause:'
2017.05.28 10:20:45 5: SONOS0: FhemWebCallback: /sonos/cover/tunein_round.png
2017.05.28 10:20:45 5: SONOS0: Cover: /tunein_round.png
2017.05.28 10:20:47 5: SW: 446f576f726b3a52494e434f4e5f35434141464434423534314530313430305f4d523a70617573653a0d0a
2017.05.28 10:20:47 5: SONOS0: Received: 'DoWork:RINCON_5CAAFD4B541E01400_MR:pause:'
2017.05.28 10:20:53 5: SW: 446f576f726b3a52494e434f4e5f35434141464434423534314530313430305f4d523a70617573653a0d0a
2017.05.28 10:20:53 5: SONOS0: Received: 'DoWork:RINCON_5CAAFD4B541E01400_MR:pause:'
2017.05.28 10:20:57 4: SONOS2: IsAlive-Event UDN=RINCON_5CAAFD4B541E01400_MR
2017.05.28 10:20:57 4: SONOS2: SONOS_Client_Data_Retreive(RINCON_5CAAFD4B541E01400_MR, reading, location, ) -> http://10.0.0.110:1400/xml/device_description.xml
2017.05.28 10:20:57 5: SONOS2: Location: http://10.0.0.110:1400/xml/device_description.xml
2017.05.28 10:20:57 5: SONOS2: PingType: syn
2017.05.28 10:20:57 4: SONOS2: 10.0.0.110 is alive
2017.05.28 10:20:57 4: SONOS2: IsAlive-Event UDN=RINCON_B8E937D046C001400_MR
2017.05.28 10:20:57 4: SONOS2: SONOS_Client_Data_Retreive(RINCON_B8E937D046C001400_MR, reading, location, ) -> http://10.0.0.111:1400/xml/device_description.xml
2017.05.28 10:20:57 5: SONOS2: Location: http://10.0.0.111:1400/xml/device_description.xml
2017.05.28 10:20:57 5: SONOS2: PingType: syn
2017.05.28 10:20:57 4: SONOS2: 10.0.0.111 is alive
2017.05.28 10:21:06 3: SONOS0: Connection accepted from localhost:59428
2017.05.28 10:21:06 4: SONOS0: Got correct answer from Subprocess...
2017.05.28 10:21:27 4: SONOS2: IsAlive-Event UDN=RINCON_5CAAFD4B541E01400_MR
2017.05.28 10:21:27 4: SONOS2: SONOS_Client_Data_Retreive(RINCON_5CAAFD4B541E01400_MR, reading, location, ) -> http://10.0.0.110:1400/xml/device_description.xml
2017.05.28 10:21:27 5: SONOS2: Location: http://10.0.0.110:1400/xml/device_description.xml
2017.05.28 10:21:27 5: SONOS2: PingType: syn
2017.05.28 10:21:27 4: SONOS2: 10.0.0.110 is alive
2017.05.28 10:21:27 4: SONOS2: IsAlive-Event UDN=RINCON_B8E937D046C001400_MR
2017.05.28 10:21:27 4: SONOS2: SONOS_Client_Data_Retreive(RINCON_B8E937D046C001400_MR, reading, location, ) -> http://10.0.0.111:1400/xml/device_description.xml
2017.05.28 10:21:27 5: SONOS2: Location: http://10.0.0.111:1400/xml/device_description.xml
2017.05.28 10:21:27 5: SONOS2: PingType: syn
2017.05.28 10:21:27 4: SONOS2: 10.0.0.111 is alive
2017.05.28 10:21:36 3: SONOS0: Connection accepted from localhost:59458
2017.05.28 10:21:36 4: SONOS0: Got correct answer from Subprocess...
2017.05.28 10:21:38 5: SW: 446f576f726b3a52494e434f4e5f35434141464434423534314530313430305f4d523a70617573653a0d0a
2017.05.28 10:21:38 5: SONOS0: Received: 'DoWork:RINCON_5CAAFD4B541E01400_MR:pause:'
2017.05.28 10:21:57 4: SONOS2: IsAlive-Event UDN=RINCON_5CAAFD4B541E01400_MR
2017.05.28 10:21:57 4: SONOS2: SONOS_Client_Data_Retreive(RINCON_5CAAFD4B541E01400_MR, reading, location, ) -> http://10.0.0.110:1400/xml/device_description.xml
2017.05.28 10:21:57 5: SONOS2: Location: http://10.0.0.110:1400/xml/device_description.xml
2017.05.28 10:21:57 5: SONOS2: PingType: syn
2017.05.28 10:21:57 4: SONOS2: 10.0.0.110 is alive
2017.05.28 10:21:57 4: SONOS2: IsAlive-Event UDN=RINCON_B8E937D046C001400_MR
2017.05.28 10:21:57 4: SONOS2: SONOS_Client_Data_Retreive(RINCON_B8E937D046C001400_MR, reading, location, ) -> http://10.0.0.111:1400/xml/device_description.xml
2017.05.28 10:21:57 5: SONOS2: Location: http://10.0.0.111:1400/xml/device_description.xml
2017.05.28 10:21:57 5: SONOS2: PingType: syn
2017.05.28 10:21:57 4: SONOS2: 10.0.0.111 is alive
2017.05.28 10:22:06 3: SONOS0: Connection accepted from localhost:59490
2017.05.28 10:22:06 4: SONOS0: Got correct answer from Subprocess...
2017.05.28 10:22:17 4: SONOS1: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0xb48b37c0)
2017.05.28 10:22:17 4: SONOS1: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0xb48b37c0)
2017.05.28 10:22:17 5: SONOS0: Received from UPnP-Server: 'DoWorkAnswer:RINCON_5CAAFD4B541E01400_MR:LastActionResult:Pause: Success!'
2017.05.28 10:22:17 4: SONOS0: DoWorkAnswer arrived for Sonos_Wohnzimmer->LastActionResult: 'Pause: Success!'
2017.05.28 10:22:17 4: SONOS1: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0xb48b37c0)
2017.05.28 10:22:17 4: SONOS1: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0xb48b37c0)
2017.05.28 10:22:17 4: SONOS1: ProxyObject exists: UPnP::ControlPoint::ControlProxy=HASH(0xb48b37c0)
2017.05.28 10:22:17 5: SONOS0: Received from UPnP-Server: 'DoWorkAnswer:RINCON_5CAAFD4B541E01400_MR:LastActionResult:Pause: Success!'
2017.05.28 10:22:18 4: SONOS0: DoWorkAnswer arrived for Sonos_Wohnzimmer->LastActionResult: 'Pause: Success!'
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: ThiemoSt am 28 Mai 2017, 12:15:40
So, ich habe mal einen Log auf 5 erstellt.

Die Player wurden dabei zwar nicht disappeared, jedoch war eine Verzögerung von ca. 1-2 Minuten zwischen Befehlen von FHEM bis das Sonos diese umgesetzt hat. Vielleicht hilft dies ja auch schon bei der Suche.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: juemuc am 28 Mai 2017, 13:51:14
Hallo,

ich habe bei der neuen Version ein paar Probleme mit den Button-Events. Diese funktionieren nur manchmal, obwohl im Eventlog die Tasten korrekt protokolliert sind.
Wer hat eine Idee?

VG
juemuc
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Loredo am 28 Mai 2017, 16:11:32
Hi Reiner,

Zitat von: Reinerlein am 21 Mai 2017, 17:15:16
Ich baue ungern ungültige URLs zusammen, da irgendein schlauer Browser oder Proxy dazwischen dass dann bestimmt irgendwann (u.U. erst in der Zukunft) mal verwirft.

Dazu habe ich auch (nicht wirklich) raten wollen ;-)

Zitat von: Reinerlein am 21 Mai 2017, 17:15:16
Ich bleibe dabei, das Attribut Webname von Fhem ist bei anderen Webapplikationen grundsätzlich fest (für eine bestimmte Funktionalität natürlich), da es dort meist etwas wie "index.php", "main.do" oder wer weiß wie sonst lautet, auf jeden Fall immer identisch. Da kann man sich drauf einstellen, und es fest in die URL einplanen.

So etwas fest einzuplanen ist IMHO grundsätzlich verkehrt. Es mag ja sein, dass du es von Tomcat o.ä. so gewohnt bist, dass diese sich über den URI Präfix identifizieren. Soweit ich weiß gilt das aber auch pro Instanz und man kann die selbe Anwendung auch mehrfach laufen lassen. Das machen wir bei FHEMWEB ja auch so.

Zitat von: Reinerlein am 21 Mai 2017, 17:15:16
Ich weiß nicht, was du als Infix bezeichnest, der Begriff ist mir in einer URL noch nicht untergekommen, denke aber, dass du Bestandteile des Pfades meinst (das ist der Bereich hinter der Portnummer bis um ersten Fragezeichen), vgl. dazu auch https://de.wikipedia.org/wiki/Uniform_Resource_Locator#Aufbau (https://de.wikipedia.org/wiki/Uniform_Resource_Locator#Aufbau), damit wir über dasselbe reden...
Der Begriff Infix stammt nicht von mir, sondern aus dem Dunstkreis um das FHEMWEB Modul herum (ich weiß selbst nicht mehr wo ich das aufgeschnappt habe). Nach meinem Verständnis wird damit der URI Präfix beschrieben, anhand dessen FHEMWEB das Routing an die jeweilige Modulfunktion vornimmt. Im Wikipedia Artikel fehlt die Unterscheidung zwischen URL und URI für mich, daher die Übersetzung in meinen Sprachgebrauch: URI entspricht Pfad+Query+Fragment, wobei für mich dabei nur der Pfad bzw. dessen Anfang hier entscheidend ist.

Gemeint ist, was wir zur Registrierung bei FHEMWEB im %data Hash ablegen, also z.B.:

$data{FWEXT}{'?/sonos'}{LINK} = '?/sonos';

Ich hoffe du weißt jetzt, was gemeint ist ;-)

Zitat von: Reinerlein am 21 Mai 2017, 17:15:16
Und warum verwendest du nicht einfach immer denselben Webname (und damit meine ich das Attribut einer FhemWeb-Definition) und unterscheidest (wie ich bei mir auch) nur Anhand des Ports?
Das ist korrekt nach RFC und berücksichtigt die gewachsenen Begebenheiten von Fhem.

Das ist einfach: Ich fasse meine FHEM Instanzen über einen Reverse Proxy unter einem einzelnen Port zusammen (u.a. zwecks SSL-Offloading) und brauche somit für die richtige Adressierung des jeweiligen Backends dort die unterschiedlichen Pfade. Soweit ich weiß ist das auch der Grund, weshalb man den webname in FHEMWEB individuell abändern kann.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: l2r am 01 Juni 2017, 10:30:44
moin,

folgendes ist heute morgen bei mir im Log aufgetaucht:
SONOS1: MakeCoverURL-Before: x-sonos-spotify:spotify%3atrack%3a1XyFcaHfNymuyDHtry9XvD?sid=9&flags=8224&sn=1
Use of uninitialized value in pattern match (m//) at ./FHEM/00_SONOS.pm line 4695.



Gruß Michael
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 01 Juni 2017, 13:27:53
Hi Michael,

da konnte ein Spotify-Cover nicht geladen werden. Ich habe die Meldung mal verhindert, aber das Resultat (ein fehlendes Cover) verhindert das nicht.

Ist da vielleicht kurzzeitig das Internet weg gewesen?
Kommt denn im Sonos Controller ein Cover?

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: l2r am 01 Juni 2017, 14:24:08
hi,

ja lag wohl am kurzzeitigen Internet-Schluckauf ... jetzt läuft alles wieder und die Cover sind wieder da..


Gruß Michael
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tobias am 02 Juni 2017, 16:33:32
Ich bekomme es nicht hin das die Readings currentTrackDurationSec permanent aktualisiert werden. Ich habe schon das Attr "simulateCurrentTrackPosition" auf 1 gesetzt, aber das REading wird nur zum Start des Tracks einmal mit 1 aktualisiert und dann nicht mehr.
Was habe ich vergessen?
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: juemuc am 02 Juni 2017, 22:57:53
Hallo,
nach jetzt gut 2 Wochen häufen sich die Probleme. Aktuell funktioniert bei mir die SPEAK-Funktion nicht korrekt. Der Satz hört teilweise nach dem 2. Wort auf und der Player bleibt danach stumm obwohl vorher Musik lief. Auf einem 2. System habe ich dann Sonos komplett neu definiert. Dort funktioniert es gar nicht mehr. Bei wem funktioniert Speak?

Viele Grüße
juemuc
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 03 Juni 2017, 00:46:48
Hi Tobias,

mit der Simulation werden die Readings "currentTrackPositionSimulated", "currentTrackPositionSimulatedSec" und "currentTrackPositionSimulatedPercent" aktualisiert, vielleicht liegt es daran? :)

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Wuppi68 am 03 Juni 2017, 12:16:55
ich möchte jetzt mal was positives sagen :-)

Bei mir klappt es wieder - seit der Überwachung via Cacti habe ich keine Fehler mehr .... scheinen wohl irgendwelche TimeOuts oder so in meinem Netz zu sein
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: juemuc am 03 Juni 2017, 19:00:01
Zitat von: juemuc am 02 Juni 2017, 22:57:53
Hallo,
nach jetzt gut 2 Wochen häufen sich die Probleme. Aktuell funktioniert bei mir die SPEAK-Funktion nicht korrekt. Der Satz hört teilweise nach dem 2. Wort auf und der Player bleibt danach stumm obwohl vorher Musik lief. Auf einem 2. System habe ich dann Sonos komplett neu definiert. Dort funktioniert es gar nicht mehr. Bei wem funktioniert Speak?

Viele Grüße
juemuc

Hallo,

wenn der gesprochene Satz abgebrochen wird, ist im log folgender Eintrag.

ZitatContent-Length header value was wrong, fixed at /usr/share/perl5/LWP/Protocol/http.pm line 257, <$client> line 8.

Wer kann helfen?

VG
juemuc
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tabularasa am 04 Juni 2017, 10:39:28
Servus. ich habe auch das Problem dass der Player disappeared ist. Habe auch schon ein paar Vorschläge durchprobiert aber ohne Erfolg. Was immer mal im log steht ist Can't call method "kill" on an undefined value at ./FHEM/00_SONOS.pm line 9730, <$client> line 3.
Gibt es da schon was neues? Danke
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: FunkOdyssey am 04 Juni 2017, 12:12:02
Ich habe das immer dann, wenn ich die Player vom Netz und das Master-Device deaktiviert hatte.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tabularasa am 06 Juni 2017, 17:15:17
Geht es denn mit dem alten Modul? Wenn ja wo würde ich das bekommen und was muss ich einstellen dass es beim nächsten update nicht mit aktualisiert wird?
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: JoWiemann am 07 Juni 2017, 08:55:10
Zitat von: Tabularasa am 06 Juni 2017, 17:15:17
-- was muss ich einstellen dass es beim nächsten update nicht mit aktualisiert wird?

Unter FhemWeb global gibt es das Attribut: exclude_from_update. Siehe auch Fhem Wiki: https://wiki.fhem.de/wiki/Update#exclude_from_update

Ich habe bei mir gesetzt:

attr global exclude_from_update 00_SONOS.pm Common.pm ControlPoint.pm


Grüße Jörg
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tabularasa am 07 Juni 2017, 11:16:31
OK. Danke. Und wo gibt es das alte Modul? ;D
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Wuppi68 am 07 Juni 2017, 13:35:17
Zitat von: Tabularasa am 07 Juni 2017, 11:16:31
OK. Danke. Und wo gibt es das alte Modul? ;D
im svn :-)

https://svn.fhem.de/trac/browser/trunk/fhem/FHEM/00_SONOS.pm?rev=13971 vom 4. April (die letzte vor dem Update)

Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tabularasa am 07 Juni 2017, 20:47:27
Super! Habe jetzt nur das Problem, dass ich sie via WinSCP nicht kopieren kann, weil ich keine Rechte habe... muss ich mich da als fhem user anmelden? und wie ist da das Passwort?
Edit: habe es hin bekommen und die alte Version läuft prima
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: sTaN am 14 Juni 2017, 12:40:05
Hallo Zusammen,

auch ich habe das Problem mit der Status Meldung Player disappeared nach einem FHEM Update. Laut 00_SONOS.pm verwende ich aber bereits die Version:
$Id: 00_SONOS.pm 14298 2017-05-15 22:46:37Z Reinerlein $

Was ist wäre den nun die richtige Vorgehensweise, um das Problem zu lösen? Ich habe unter anderem vom Löschen der Sonos Player gelesen.
Da ich ebenfalls die Player hauptsächlich für FTUI nutze, würde mich interessieren, wie ich hier am besten Vorgehe. Ich weiß ich müsste die UserReadings sichern und anschließend wieder eintragen. Gibt es noch weiteres zu beachten oder gar eine andere Möglichkeit die Verbindung neu aufzubauen?

Vielen Dank und Grüße
sTaN
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: FunkOdyssey am 14 Juni 2017, 12:47:50
Es sieht bei mir danach aus, als wäre das Problem weg seitdem ich das Attribut reusePort gesetzt habe.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: sTaN am 14 Juni 2017, 13:06:29
Zitat von: FunkOdyssey am 14 Juni 2017, 12:47:50
Es sieht bei mir danach aus, als wäre das Problem weg seitdem ich das Attribut reusePort gesetzt habe.

Bei welchem define hast du das Attribut gesetzt?
Finde es weder beim define SONOS, noch bei dem Sonos Playern.

Habe mir die User Readings von meinen Playern gespeichert und ein delete der einzelnen Sonos Player gemacht.
Kurz gewartet und die Player wurden automatisch wieder hinzugefügt. Dann habe ich mir die UserReadings angeschaut. Hier wurde mittlerweile die Variable $name für die Sonos Player Namen verwendet. Meine UserReadings für FTUI angepasst und an die bestehende erweitert, Nun werden die Player wieder sauber gesteuert.

Mal sehen wie lange es dabei bleibt. Ansonsten würde ich gern dein vorgeschlagenes Attribut reusePort testen.

Gruß und Danke!
sTaN
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: sTaN am 14 Juni 2017, 13:33:36
Das Problem taucht schneller wieder auf als erwartet. Hatte in meiner fhem.cfg noch eine andere Anpassung gemacht und nach dem Speichern haben die Player wieder den Status disappeared.

Habe das Attribut reusePort doch in der CommandRef gefunden und beim define Sonos SONOS gesetzt:

attr Sonos reusePort 1

Aber die Player bleiben weiterhin dissappeared.

Kann man eine neue Verbindung irgendwie triggern, ohne die Player erneut zu löschen?
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: US am 14 Juni 2017, 15:07:07
Hallo Reinerlein,

seit bei mir die neue Version läuft hab' ich dasselbe Problem wie photon68 oben bereits beschrieben hat; sobald ein Player läuft wird mein Log mit Fehlermeldungen Error during retreiving of <xxx> geflutet


2017.06.14 14:17:59 1: SONOS0: Error during retreiving of FavouriteName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1369.
2017.06.14 14:17:59 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.
2017.06.14 14:17:59 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.
2017.06.14 14:18:19 1: SONOS0: Error during retreiving of FavouriteName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1369.
2017.06.14 14:18:19 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.
2017.06.14 14:18:19 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.


Ich habe bereits auf alle Player ein get PLAYER <xxx>  für Radios, Favourites, Playlist durchgefüht, die Notifys für das automatische aktualisieren angelegt, Sonos neu gestartet, Player rebootet....ohne Effekt.

Was kann ich noch tun (ausser verbose 0), um das zu unterbinden resp. die Ursache zu identifizieren ?

Gruß Uwe
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 14 Juni 2017, 18:49:38
Hi Uwe,

du musst die entsprechenden "...withCovers"-Befehle ausführen.

Die Notifies werden übrigens erst bei einer Änderung der entsprechenden Liste getriggert, hast du mit dem Sonos-Controller denn auch entsprechend etwas verändert (also z.B. einen weiteren Favoriten oder Radiosender bzw. eine weitere Playlist angelegt)?

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: US am 14 Juni 2017, 21:10:34
Erstmal vielen Dank für die schnelle Antwort
Hatte natürlich auch die with cover-Befehle versucht, ohne Erfolg;
inzwischen hab ich mal in der SonosApp Favoriten und Playlisten verändert; danach hatte ich haufenweise Meldungen der Art
2017.06.14 20:47:56 0: SONOS1: MakeCoverURL-Before: x-sonos-http:track%3a307044367.mp3?sid=160&flags=8224&sn=5
2017.06.14 20:47:56 0: SONOS1: resURL-1: x-sonos-http%3Atrack%253a307044367.mp3%3Fsid%3D160%26amp%3Bflags%3D8224%26amp%3Bsn%3D5
2017.06.14 20:47:56 0: SONOS1: resURL-2: x-sonos-http%3Atrack%253a307044367.mp3%3Fsid%3D160%26flags%3D8224%26sn%3D5
2017.06.14 20:47:56 0: SONOS1: resURL-3: http://192.168.2.40:1400/getaa?s=1&u=x-sonos-http%3Atrack%253a307044367.mp3%3Fsid%3D160%26flags%3D8224%26sn%3D5
2017.06.14 20:47:56 0: SONOS1: MakeCoverURL-After: http://192.168.2.40:1400/getaa?s=1&u=x-sonos-http%3Atrack%253a307044367.mp3%3Fsid%3D160%26flags%3D8224%26sn%3D5
2017.06.14 20:47:56 0: SONOS1: MakeCoverURL-Before: file:///jffs/settings/savedqueues.rsq#11

im log; wenn ich nun wieder eine Player starte, leider selbes Ergebnis, Meldungen wie gehabt

2017.06.14 21:01:19 1: SONOS0: Error during retreiving of FavouriteName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1369.
2017.06.14 21:01:19 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.
2017.06.14 21:01:19 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.


Gruss Uwe
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 14 Juni 2017, 21:43:30
Hi Uwe,

die Logausgaben befinden sich auf dem falschen Level, das habe ich korrigiert.
Aber ein Fehler ist dabei nicht aufgetreten.

Was steht denn z.B. in dem Reading "Favourites"?
Wenn es leer ist: Verwendest du das Attribut "getListsDirectlyToReadings" oder verwendest du die userReadings-Variante zum Füllen der Readings?
Wenn du das Attribut nicht gesetzt hast, dann prüfe mal die userReadings...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: US am 15 Juni 2017, 09:26:14
Hallo Reiner,

Favourites sieht so aus, Radios, PLaylists analog

Favourites DirectlySet 2017-06-14 20:47:58
FavouritesList ANTENNE.BAYERN|ANTENNE.BAYERN.80er.Kulthits|Austria|Bayern3|Beats.1|Best.Spa.Music.101.-.Serenity.Relaxation.Songs,.Top.Wellness.Center.&amp;.Hotel.Tracks|Buddha.Lounge.-.Meditative.Entspannungsmusik|CalmRadio|Chalet.Beats.N°2..Maierl.Alm.|Chart-Hits|Coco.Beach.Ibiza,.Vol..3.-.10Th.Anniversary..Compiled.by.Paul.Lomax.|Coco.Beach.Ibiza,.Vol..4..Compiled.by.Paul.Lomax.|Depeche|Endless.Music.Ibiza..Compiled.by.Paul.Lomax.|KlafsWellness|MallorcaInselradio|OE3|SJC|SWR3|Shake.the.Disease|Smooth.Jazz|SmoothJazz.com.Global.Radio..KJAZ.db.|Topsongs1|We.Love.Endless.Winter.2017.Podcast|YOGA_CD
2017-06-14 20:43:15
FavouritesListAlias
ANTENNE BAYERN|ANTENNE BAYERN 80er Kulthits|Austria|Bayern3|Beats 1|Best Spa Music 101 - Serenity Relaxation Songs, Top Wellness Center &amp; Hotel Tracks|Buddha Lounge - Meditative Entspannungsmusik|CalmRadio|Chalet Beats N°2 (Maierl Alm)|Chart-Hits|Coco Beach Ibiza, Vol. 3 - 10Th Anniversary (Compiled by Paul Lomax)|Coco Beach Ibiza, Vol. 4 (Compiled by Paul Lomax)|Depeche|Endless Music Ibiza (Compiled by Paul Lomax)|KlafsWellness|MallorcaInselradio|OE3|SJC|SWR3|Shake the Disease|Smooth Jazz|SmoothJazz.com Global Radio (KJAZ.db)|Topsongs1|We Love Endless Winter 2017 Podcast|YOGA_CD
2017-06-14 20:43:15
FavouritesVersion RINCON_B8E93778D95C01400,106 2017-06-14 20:43:09


und Log füllt sich


2017.06.15 09:18:36 1: SONOS0: Error during retreiving of FavouriteName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1369.
2017.06.15 09:18:36 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.
2017.06.15 09:18:36 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.
2017.06.15 09:18:43 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.
2017.06.15 09:18:43 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.
2017.06.15 09:18:56 1: SONOS0: Error during retreiving of FavouriteName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1369.
2017.06.15 09:18:56 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.
2017.06.15 09:18:56 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.
2017.06.15 09:19:05 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.
2017.06.15 09:19:05 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.
2017.06.15 09:19:25 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.
2017.06.15 09:19:25 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.
2017.06.15 09:19:27 1: SONOS0: Error during retreiving of FavouriteName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1369.
2017.06.15 09:19:27 1: SONOS0: Error during retreiving of PlaylistName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1385.
2017.06.15 09:19:27 1: SONOS0: Error during retreiving of RadioName: Can't use an undefined value as a HASH reference at ./FHEM/00_SONOS.pm line 1401.


Gruß Uwe
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 15 Juni 2017, 09:59:36
Hi Uwe,

das sind aber die Listen ohne Cover (die enden auf "List").
Die Listen mit Cover (z.B. nur mit dem Namen "Favourites", ohne "List") sind textuelle Darstellungen von Perl-Hashes, und als solches versucht das Modul diese auch wieder zu parsen (was dann zu einem Fehler führt, wenn es kein Perl-Hash darstellt).

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: FunkOdyssey am 15 Juni 2017, 11:56:11
Zitat von: FunkOdyssey am 14 Juni 2017, 12:47:50
Es sieht bei mir danach aus, als wäre das Problem weg seitdem ich das Attribut reusePort gesetzt habe.

So, ich nehme alles wieder zurück. So langsam nervt mich dieser Bug.
Ich habe zig Threads durchgelesen und abgesehen von Rollback keine Lösung gefunden.

@Reinerlein:
Könntest du hier nicht bitte mal eine Ansage machen, was hier nun los ist?

Danke.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 15 Juni 2017, 12:07:46
Hi FunkOdyssey,

ich soll also eine Ansage machen :o

Fakt ist, der Fehler tritt bei einigen, wenigen Anwendern (mehr oder weniger sporadisch) auf, und ist, vor allem bei mir, bislang nicht reproduzierbar.
Bislang habe Logdateien lediglich darauf hingedeutet, dass anscheinend Daten auf dem Transportweg zwischen SubProzess und Fhem verloren gehen. Das "warum" ließ sich dabei auch nicht herleiten.

Ich weiß nicht, wie ich da weiter vorgehen kann...
Ich werde die Überprüfung nochmal umbauen, aber da die Ursache bislang nicht gefunden ist, ist es fraglich, ob es zufällig genau die Probleme löst...

Grüße
Reinerlein
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: FunkOdyssey am 15 Juni 2017, 12:37:03
Danke dir.
Ich hatte halt nicht direkt mitbekomme, dass du den Fehler bereits auf dem Schirm hast.

Ich habe das "disappeared"-Problem immer nach einem FHEM-Neustart. Den RasPi habe ich dabei nicht neu gestartet.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Tobias am 15 Juni 2017, 17:30:44
Ich habe bei mir beide Sonos Module erstmal wieder auf den alten stand zurück gesetzt.
Durch das ständige disappeared war die Steuerung via tabletui unmöglich.
Ich warte mal ab ob der Fehler gefunden wird

Gesendet von meinem Leap mit Tapatalk

Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: peter0255 am 15 Juni 2017, 17:52:56
Hallo Zusammen,

ich habe das Problem auch mehrmals täglich nach dem letzten Update, habe alles mögliche probiert, aber kein Erfolg. Ich werde jetzt auch auf den Stand von April zurück gehen.

Viele Grüße
Peter
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: US am 16 Juni 2017, 10:07:33
Hi Reiner,

hatte vor einiger Zeit das Attribut getListsDirectlyToReadings auf 1 gesetzt; dazu gehört wohl dann das Reading Favourites DirectlySet 2017-06-14 20:47:58
nehme mal an, das meintest Du...inzwischen hab' ich das Attribut getListsDirectlyToReadings wieder auf 0 gesetzt, alle Player gelöscht und neu anlegen lassen, jetzt hab' ich auch in dem Reading Favourites die Perl-Hashes und alles scheint wieder ok :)

Gruß Uwe
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 16 Juni 2017, 10:11:26
Hi Uwe,

das bevorzugte Vorgehen ist mit dem Attribut getListsDirectlyToReadings, dann müssen aber die einzelnen userReadings der Playerdevices aufgeräumt werden. Dort könnten Altlasten stehen, die dann im Konflikt mit einem direkten Setzen stehen...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Reinerlein am 16 Juni 2017, 18:49:57
Hallo,

kurzer Zwischenstand: Ich habe jetzt mal die Prüfroutine für den SubProzess umgebaut. Bei mir funktioniert das erstmal, lasse das aber jetzt erst noch ein paar Tage im Testbetrieb laufen.

Ich denke, dass im Laufe der Woche oder zum nächsten Wochenende hin eine neue Version bereitgestellt wird, die dann von den betroffenen Anwendern getestet werden kann/müsste...

Grüße
Reiner
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: ThiemoSt am 16 Juni 2017, 18:56:01
Also ich habe heute das alte Modul mit Stand vom 4.4. eingespielt.
Habe die gleichen Probleme damit wie mit dem aktuellen Modul. Liegt es eventuell an irgendwelchen anderen Updates und nicht am Sonos Modul?


Gesendet von iPhone mit Tapatalk
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: sTaN am 17 Juni 2017, 11:30:37
Danke Reiner, dass du an dem "disappeared"-Problem dran bleibst. Hoffe es ist ein lösbares und vor allem greifbares. Falls wir etwas tun können, um das ganze weiter einzugrenzen, gib bitte kurz Bescheid!

Gruß sTaN
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Phiolin am 21 Juni 2017, 14:21:24
Die neue Version hat aktuell wohl das Problem, dass sie sich öfters mal selber erschießt.
Habe gerade ein Update gemacht und neu gestartet:

2017.06.21 14:15:49 3: Opening Sonos device localhost:4711
2017.06.21 14:15:49 3: SONOS0: Connection accepted from localhost:45280
2017.06.21 14:15:49 3: Sonos device opened
2017.06.21 14:16:43 1: withings.Andreas: APPLIVER ERROR
2017.06.21 14:16:50 2: SONOS0: LastProcessAnswer way too old (Lastanswer: 2000-01-01 00:00:00)... try to restart the process and connection...
2017.06.21 14:16:50 3: SONOS1: UPnP-Thread gestartet.
2017.06.21 14:16:50 1: SONOS2: IsAlive-Thread gestartet. Warte 120 Sekunden und pruefe dann alle 30 Sekunden...
2017.06.21 14:16:50 1: SONOS3: Restore-Thread gestartet. Warte auf Arbeit...
2017.06.21 14:16:51 2: SONOS1: Discover Sonosplayer 'Schlafzimmer' (S12) Software Revision 7.2 with ID 'RINCON_949F3E85047601400_MR'
2017.06.21 14:16:51 3: SONOS0: Disconnecting client and shutdown server...
2017.06.21 14:16:51 3: SONOS0: Trying to kill Sonos_Thread...
2017.06.21 14:16:51 3: SONOS0: Trying to kill IsAlive_Thread...
2017.06.21 14:16:51 3: SONOS0: Trying to kill PlayerRestore_Thread...
2017.06.21 14:16:51 3: SONOS1: Controlpoint-Listener wurde beendet.
2017.06.21 14:16:51 0: SONOS0: Das Lauschen auf der Schnittstelle wurde beendet. Prozess endet nun auch...
2017.06.21 14:17:00 1: SONOS0: Kein UPnP-Server gefunden... Starte selber einen und warte 8 Sekunde(n) darauf...
2017.06.21 14:17:01 0: SONOS0: Can't bind Port 4711: Bind failed: Address already in use at ./FHEM/00_SONOS.pm line 9924.

2017.06.21 14:17:01 0: SONOS0: Retries left (wait 30s): 9
2017.06.21 14:17:08 3: Opening Sonos device localhost:4711
2017.06.21 14:17:08 3: Can't connect to localhost:4711: Connection refused
2017.06.21 14:17:31 0: SONOS0: Can't bind Port 4711: Bind failed: Address already in use at ./FHEM/00_SONOS.pm line 9924.

2017.06.21 14:17:31 0: SONOS0: Retries left (wait 30s): 8
2017.06.21 14:18:01 1: SONOS0: ./FHEM/00_SONOS.pm is listening to Port 4711
2017.06.21 14:18:09 3: SONOS0: Connection accepted from localhost:45438
2017.06.21 14:18:09 1: localhost:4711 reappeared (Sonos)
2017.06.21 14:18:21 2: SONOS0: LastProcessAnswer way too old (Lastanswer: 2017-06-21 14:16:50)... try to restart the process and connection...
2017.06.21 14:18:21 3: SONOS1: UPnP-Thread gestartet.
2017.06.21 14:18:21 1: SONOS2: IsAlive-Thread gestartet. Warte 120 Sekunden und pruefe dann alle 30 Sekunden...
2017.06.21 14:18:21 1: SONOS3: Restore-Thread gestartet. Warte auf Arbeit...
2017.06.21 14:18:21 2: SONOS1: Discover Sonosplayer 'Schlafzimmer' (S12) Software Revision 7.2 with ID 'RINCON_949F3E85047601400_MR'
2017.06.21 14:18:22 3: SONOS0: Disconnecting client and shutdown server...
2017.06.21 14:18:22 3: SONOS0: Trying to kill Sonos_Thread...
2017.06.21 14:18:22 3: SONOS0: Trying to kill IsAlive_Thread...
2017.06.21 14:18:22 3: SONOS0: Trying to kill PlayerRestore_Thread...
2017.06.21 14:18:22 0: SONOS0: Das Lauschen auf der Schnittstelle wurde beendet. Prozess endet nun auch...
2017.06.21 14:18:31 1: SONOS0: Kein UPnP-Server gefunden... Starte selber einen und warte 8 Sekunde(n) darauf...
2017.06.21 14:18:32 0: SONOS0: Can't bind Port 4711: Bind failed: Address already in use at ./FHEM/00_SONOS.pm line 9924.

2017.06.21 14:18:32 0: SONOS0: Retries left (wait 30s): 9
2017.06.21 14:18:39 3: Opening Sonos device localhost:4711
2017.06.21 14:18:39 3: Can't connect to localhost:4711: Connection refused


Beim ersten Start des Prozesses war wohl LastProcessAnswer nicht gesetzt, das wurde als "zu alt" gewertet und direkt der Prozess neu gestartet.
Dann kann der Prozess für 1-2 Minuten offenbar nicht mehr an Port 4711 binden, was dann aber irgendwann wieder geht. Dabei vergeht jedoch wieder so viel Zeit, dass dann LastProcessAnswer schon wieder zu alt ist - und dann geht das ganze von vorne los.
So läuft das jetzt schon eine ganze Weile. :D
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: gloob am 21 Juni 2017, 14:23:05
Schau mal hier:

https://forum.fhem.de/index.php/topic,73394.msg650870.html#msg650870 (https://forum.fhem.de/index.php/topic,73394.msg650870.html#msg650870)

in der neueren Version gibt es aktuell das gleiche Problem.
Titel: Antw:Sonos: Neue Version vom 14.5.
Beitrag von: Phiolin am 21 Juni 2017, 14:30:07
Danke für den Hinweis, hatte nicht gesehen, dass wir einen neuen Thread haben :)