Test/Support Adapter SqueezeboxRPC

[hsteinme]

Danke! Aber bitte keine Hektik: Die Hochfahr-Thematik gehört nicht zur Kategorie "lebensbedrohlich und dringend".

[OliverIO]

@hsteinme
Muss dich leider entäuschen
Die ersten Tests sind gerade erfolgreich abgeschlossen worden.
Connect und Reconnect werden adhoc registriert.

Aber dennoch noch nicht veröffentlichungsreif.
Da ich hier mit den Netzwerk-Sockets spiele muss ich erst ausführlich testen, das ich hier keine Speicherlecks rein bekommen.
Aber sieht generell gut aus.

[hsteinme]

Dann werde ich die vereinbarten Vergleichsmessungen zur (Re)Connect-Erkennung erst mal sein lassen, da Du eh schon eine Lösung in der Hinterhand hast.

Wie gesagt:

die Reaktionsgeschwindigkeit und die Hilfsbereitschaft des Entwicklers im Forum haben mich sehr beeindruckt

[OliverIO]

@hsteinme
so in der Version 0.8.28 habe ich die Funktionalität eingebaut.
Das Server und die Playerobjekte werden nun aktualisiert, sobald signalisiert wird, das ein Player connected oder disconnected.
ggfs. musst du die Funktion erst in den Adapter Settings unter Reiter Performance aktivieren.

Bei mir hat es Funktioniert, da das bei andern nicht unbedingt der Fall sein muss (man kann nicht alle Fälle vorausdenken).
Bitte aktiviere zusätzlich noch in den Settings Reiter Debug Settings die Einstellung "Create debug output for server" und stelle nach Speichern der Konfiguration in der Instanzübersicht in der Expertendarstellung den Log-Level der Instanz auf "debug".
Dort solltest du dann einmal sehen, ob sich der Adapter mittels Telnet mit dem LNS verbindet.
Im Log sieht das dann wie folgt aus:

squeezeboxrpc.0	2020-01-09 00:21:34.576	debug	(16011) doTelnet recieved reconnect for : 00:27:00:be:00:b7
squeezeboxrpc.0	2020-01-09 00:21:02.032	debug	(16011) doTelnet recieved disconnect for : 00:27:00:be:00:b7
squeezeboxrpc.0	2020-01-09 00:20:13.265	debug	(16011) doTelnet connected to server!

Wenn Fehler auftauchen, dann bitte diese hier melden.

[hsteinme]

@OliverIO sagte in Test Adapter SqueezeboxRPC v0.8.x Latest:

so in der Version 0.8.28 habe ich die Funktionalität eingebaut.

Danke schön für die schnelle Bereitstellung, OliverIO!

ggfs. musst du die Funktion erst in den Adapter Settings unter Reiter Performance aktivieren.

"ggfs."? In welchem gegebenen Fall?

"in den Adapter Settings"? Meinst Du die Instanzen Settings? Im dortigen Reiter performance settings sehe ich jedoch nur zwei altbekannte Optionen zu den Playlist-Infos und zu den anderen LMS Servern. Mehr ist bei mir nicht zu finden.

*Bitte aktiviere zusätzlich noch in den Settings Reiter Debug Settings die Einstellung "Create debug output for server" und stelle nach Speichern der Konfiguration in der Instanzübersicht in der Expertendarstellung den Log-Level der Instanz auf "debug".

Das habe ich getan.

Dort solltest du dann einmal sehen, ob sich der Adapter mittels Telnet mit dem LNS verbindet.
Im Log sieht das dann wie folgt aus:

Derartige Einträge sehe ich bei mir nicht, auch nicht nach einem stop/start von ioBroker.

[OliverIO]

@hsteinme
dann bitte auf der commandozeile folgenden befehl eingeben:

iobroker upload squeezeboxrpc

[OliverIO]

@OliverIO Alternativ bzw als erstes kannst du auch noch <strg> + <f5> auf der Konfigurationsseite machen, falls im browsercache noch die alte seite gespeichert ist

[hsteinme]

@OliverIO sagte in Test Adapter SqueezeboxRPC v0.8.x Latest:

iobroker upload squeezeboxrpc

Das ist ja ein schönes Kommando Danach waren nun drei Optionen unter den performance settings zu sehen. Ich habe dann die telnet-Methode aktiviert. Die gesuchten doTelnet Einträge waren danach auch im Log zu sehen.

Heute scheint aber kein guter Tag zum Testen zu sein. Etwa nur in 10% der Einschaltvorgänge meiner Badezimmer-Squeezebox wurde eine Musikausgabe gestartet. Erste Blicke in mein Anwendungslog und in die History des Connected-Datenpunkts legen den Schluss nahe, dass der Connected-Datenpunkt in diesen Fällen nicht auf 1 gesetzt wurde. Da ich momentan unter Zeitdruck stehe, schiebe ich dieses Thema auf die nächsten Tage. Ich schaue dann etwas tiefer und genauer hin und melde mich hier wieder.

[OliverIO]

Das playlist widget steht schon seit längerem noch auf der Entwicklungsliste.
Hat jemand Lust mit mir zu besprechen, wobei man bei der Entwicklung der Playlist achten sollte, so dass es die folgenden Anforderungen erfüllt werden
(Liste kann ggfs. auch erweitert werden):

Stufe 1: Nur Anzeige

• Bereitstellung folgender Informationen je Track auf einer Playlist: Titel, Album, Artist, RadioName, Duration, Bitrate, Type
• Konfigurierbares Ein/Ausblenden einzelner Informationen
• Anpassen der Reihenfolge zur Ausgabe der Informationen
• Jede Information wird in einem eigenen DIV ausgegeben mit einem adressierbaren class-name
• Standardlayout wird wegen vereinfachtem Einsatz mitgegeben, kann aber durch eigene CSS-Angaben angepasst werden.

Sufe 2: (Interaktion)

• Auswahl eines Titels welcher dann gespielt wird (problem, der vorhandene Playbutton kann hier wahrscheinlich nicht wiederverwendet werden, sondern muss explizit neu Programmiert werden, wenn er verwednet werden kann, kann dieser nicht über vis gestylt werden. Alternativ eine vereinfachte Version
• Umsortieren der vorgegebenen Playlist (Titel eine Position hoch/runter

Relativ kurzfristig könnte Level 1 fertig gestellt werden. Mich würde interessieren was man bei Konfiguration sonst noch so beachten müsste, dass ich hier nicht in eine falsche Richtung laufe.

[hsteinme]

@hsteinme sagte in Test Adapter SqueezeboxRPC v0.8.x Latest:

schiebe ich dieses Thema auf die nächsten Tage. Ich schaue dann etwas tiefer und genauer hin und melde mich hier wieder.

@OliverIO: Heute habe ich nun meine angekündigte Test-Vertiefung durchführen können - mit einem leider überraschenden Ergebnis.

Test-Nebenbedingungen:

• meine eigenen Squeezebox-Skripte = nicht aktiv
• Squeezebox = Squeezebox Duet
• Serverrefresh = 30
• Player refresh = 950
• Favorite refresh = 720
• Discovery refresh = 30
• Provide Playlistinfos in as JSON-datapoint = true
• Search for other LMS-Server = false
• Create debug output for Server = true
• andere Create * output for * = false

In der ersten Testreihe wurde die Option "Use Telnet for advanced signaling" auf false gesetzt. Die Ergebnisse:

---------------------------------------
Auszeit     bis Conn.=1    Abbruch nach
---------------------------------------
   10         30            
   10         95
   10         60   
   10         65
   10         85
---------------------------------------
   50         38
   50         58
   50         --              150
   50         43
   50         40
---------------------------------------

Zur Erläuterung:

• Auszeit: Sekunden zwischen Aus- und Einschalten der Squeezebox
• bis Conn.=1: Sekunden vom Einschalten bis Connected-Status 1 wurde
• Abbruch nach: Sekunden vom Einschalten bis Abbruch der Messung, wenn Connected-Status nicht 1 wurde
• Ausschalten: Stromversorgung der Squeezebox ausschalten
• Einschalten: Stromversorgung der Squeezebox einschalten

In der (versuchten) zweiten Testreihe wurde die Option "Use Telnet for advanced signaling" auf true gesetzt. Die Wirksamkeit dieser Einstellung wurde im Log über die Existenz der doTelnet-Einträge überprüft.

Das Ergebnis: Nach dem Restart des Adapters stand Connected zunächst auf null. Beim ersten Einschalten der Squeezebox wechselte (nach der üblichen Wartezeit) der Connected-Status auf 1. Nachfolgendes Ausschalten sowie daraufhin erfolgte mehrmalige Aus-/Einschaltvorgänge änderten nichts am Connected-Status. Er blieb standhaft auf 1.

Dieses Verhalten entspricht auch meiner ersten Auf-die-Schnelle-Erfahrung vom Donnerstag: Beim ersten Einschalten startete meine Anwendung eine Musikausgabe, danach nie wieder. Nach dem Ausschalten der Telnet-Option startete meine Anwendung (fast) immer eine Musikausgabe. (Zum "fast" siehe auch oben den nach 150 Sekunden abgebrochenen Testlauf.)

Welche Informationen kann ich Dir noch liefern, um Dich bei der Diagnose dieses Verhaltens zu unterstützen?

Übrigens: Eine derartige Testreihe kann auch gut mit der SqueezePlay App auf einem PC durchgeführt werden (Einschalten = Starten der App, Ausschalten = Schließen der App), wobei natürlich die Wartezeiten auf Connect = 1 deutlich geringer sind, da die Hochfahrzeiten der Anwendung wesentlich kleiner als die Hochfahrzeiten einer "realen" Squeezebox sind.

[hsteinme]

@OliverIO sagte in Test Adapter SqueezeboxRPC v0.8.x Latest:

Hat jemand Lust mit mir zu besprechen, wobei man bei der Entwicklung der Playlist achten sollte, [...]
Stufe 1: Nur Anzeige

• Anzahl der Playlist-Items
• Positonsnummer des aktuellen Items

[OliverIO]

@hsteinme
hab mir das verhalten vom LMS nochmal angeschaut und folgendes ist mir aufgefallen.
Man darf nicht nur den Status Connected anschauen, sondern auch Power.
Den verwaltet der LMS unabhängig voneinander, so dass
Ein Gerät aus sein kann (power=0), aber dennoch noch connected (connected=1)
Für den LMS kann erstaunlicherweise ein Gerät auch nicht connected (connected = 0) sein und dennoch an (power=1). Das habe ich im adapter aber korrigiert.

Für dein Skript musst du nach dem Status Power schauen. folgende Zustände können nun vorkommen

power=0,connected=0; gerät nicht verfügbar
power=1,connected=0; kann nicht mehr in iobroker vorkommen, LMS kennt das aber noch
Power=0,connected=1; player ist mit LMS verbunden, aber Soft ausgeschaltet
Power=1,connected=1, player verbunden und eingeschaltet

Da ich Power bei der Ereignissignalisierung noch nicht berücksichtigt hatte, habe ich das nun ergänzt, sowie die oben erwähnte Korrektur eingearbeitet.
Damit man sieht was sonst noch über die Ereignissteuerung läuft, werden alle eingehenden Daten nun im Debug-Level ausgegeben.
Dies steht nun in Version 0.8.29 zur Verfügung.

[hsteinme]

@OliverIO: Heißen Dank für die wieder mal schnelle Diagnose und Lösungsbereitstellung.

Zwei Logs aus meiner früheren Anwendung:

Rec 22.12.2019 07:58:17 Data Received (47/47):
                        xx:xx:xx:xx:ca:58 client disconnect
Rec 22.12.2019 08:03:17 Data Received (43/43):
                        xx:xx:xx:xx:ca:58 client forget
Rec 22.12.2019 08:03:17 Data Received (43/83):
                        xx:xx:xx:xx:ca:58 playlist stop
Rec 22.12.2019 08:14:35 Data Received (40/40):
                        xx:xx:xx:xx:ca:58 client new

Wurde einem Client der Strom entzogen, so reichte der Server nach kurzer Zeit ein Signal "client disconnect" hoch. Blieb der Client weiter stromlos, so kam nach 5 Minuten die Notification "client forget". Bei einer erneuten Stromzufuhr meldete dann der Server "client new".

Rec 22.12.2019 00:06:59 Data Received (47/47):
                        xx:xx:xx:xx:ca:58 client disconnect
Rec 22.12.2019 00:07:12 Data Received (46/46):
                        xx:xx:xx:xx:ca:58 client reconnect

Erhielt ein stromlos gewordener Client innerhalb der 5-Minuten-Galgenfrist wieder Strom, so wurde seine Reanimation mit dem Status "client reconnect" kundgetan.

Meine frühere Anwendung reagierte also simpel auf die Signale "client new" und "client reconnect", auf sonst nix.

Man darf nicht nur den Status Connected anschauen, sondern auch Power.

Das Signal "power 1" konnte ich bisher ignorieren.

folgende Zustände können nun vorkommen

power=0,connected=0; gerät nicht verfügbar
power=1,connected=0; kann nicht mehr in iobroker vorkommen, LMS kennt das aber noch
Power=0,connected=1; player ist mit LMS verbunden, aber Soft ausgeschaltet
Power=1,connected=1, player verbunden und eingeschaltet

Ja, dem ist so. Das konnte ich ebenfalls verifizieren.

Für dein Skript musst du nach dem Status Power schauen.

Ja, auch dem ist nun so. Ich habe es nun in meinem Skript geändert (ein Hoch auf den Erfinder der Replace-all-Funktion in Editoren).

Damit man sieht was sonst noch über die Ereignissteuerung läuft, werden alle eingehenden Daten nun im Debug-Level ausgegeben.

Schön, dann kann ich ab sofort darauf verzichten, einen Telnet-Client mit "listen 1" mitlaufen zu lassen.

Dies steht nun in Version 0.8.29 zur Verfügung.

Danke schön! Runter geladen, installiert, Upload angestoßen (!), getestet: Siehe da, es läuft alles bestens Daher konnte ich mir natürlich Zeitmessungen nicht verkneifen:

---------------------------------------
Auszeit    bis Power=1     Abbruch nach
---------------------------------------
   10         35            
   10         50
   10         14   
   10         31
   10         38
   10         38   
   10         37
   10         51
---------------------------------------

Auch wenn diese geringe Zahl an Testläufen nicht repräsentativ sein kann, so wage ich doch ein erstes Fazit:

• Die zuvor aufgetretenen großen Ausreisser nach oben wurden nicht mehr beobachtet.
• Auch die Werte im mittleren Bereich haben sich im Allgemeinen verkürzt.

Von daher hat der Wechsel "vom Abfrage-Modus auf den Lausch-Modus" wohl die erhoffte Wirkung erzielt

Übrigens: Bei meinem heutigen Handling mit LMS/Adapter/Skript habe ich erneut zweimal die Situation gehabt, dass nach dem Einschalten des Clients keine Power/Connected-Änderung an mein Skript gemeldet wurde. Da ich gerade parallel einen Telnet-Client zwecks LMS-Beobachtung mitlaufen hatte, konnte ich jedoch die "Unschuld" des Adapters belegen: Der LMS selbst hatte die Status-Änderung nicht über die listen-Schiene signalisiert.

[OliverIO]

@hsteinme Das ist schön das es jetzt funktioniert.

[hsteinme]

Mein Favorite-Refresh-Setting steht auf Standard, also auf 6 Stunden. Gelegentlich strukturiere ich meine SqueezeBox-Favoriten um. Da ich dann nicht bis zu 6 Stunden warten möchte, stellt sich die Frage, ob es eine Möglichkeit gibt, einen Favorite-Refresh manuell anzustoßen.

Der Adapter-Restart gehört nicht zu diesen Möglichkeiten. Das Favorite-Refresh-Setting runter und dann wieder rauf zu drehen, ist sicherlich eine Möglichkeit, aber nicht meine allerliebste.

[OliverIO]

@hsteinme
ja gibt es.
In den Objekten unter Server gibt es einen Kommandoknopf getFavorites

[hsteinme]

Upps! Hatte ich gesucht - und übersehen. Sorry & Danke!

[hsteinme]

Das Löschen von Favoriten hinterlässt "Leichen" im Favoriten-Objektbaum von SqueezeboxRPC. Ein Beispiel:

• Die Ausgangslage:
  

• Der Eintrag "Test eins" wird auf dem LMS gelöscht:
  

• Der Button squeezeboxrpc.0.Server.getFavorites wird gedrückt. Das Objektfenster im Browser wird zur Vorsicht geschlossen. Es wird ein neues Objektfenster im Browser geöffnet:
  

Man sieht nun:

• Der Eintrag "Test zwei" ist nach oben gerutscht, um den vorherigen Platz von "Test eins" einzunehmen.
• Auf dem bisherigen Platz von "Test zwei" bleibt jedoch sein alter Eintrag stehen (siehe Timestamps)

[OliverIO]

Ja, der objektbaum hinterlässt manchmal artefakte. Die Objekte existieren eigentlich nicht mehr, sondern kommen wahrscheinlich aus dem Browser Cache
Oben links gibt es für den objektbaum ein aktualisieren Knopf. Spätestens dann müssten diese Zombie Objekte weg sein. Wenn nicht, dann schauen wir weiter.

Technisch wird bei jedem aktualisieren im Hintergrund alle Favoriten states gelöscht und dann neu angelegt.

[hsteinme]

@OliverIO sagte in Test Adapter SqueezeboxRPC v0.8.x Latest:

Die Objekte existieren eigentlich nicht mehr, sondern kommen wahrscheinlich aus dem Browser Cache
Oben links gibt es für den objektbaum ein aktualisieren Knopf. Spätestens dann müssten diese Zombie Objekte weg sein. Wenn nicht, dann schauen wir weiter.

Ja, dann lass uns mal bitte weiterschauen.

Der Refresh-Knopf brachte keine Heilung.

Nachdem zwei Stunden nach dem Löschvorgang vier verschiedene Browser auf demselben PC sowie zwei verschiedene Browser auf einem zweiten PC immer noch den Zombie im Objekt-Fenster anzeigten, habe ich dann meinen Knopf für das Auslesen des Favoriten-Objektbaums bemüht. Das Log zeigt dann folgendes an:

2020-02-04 16:59:46.144 - info: javascript.0 script.js.common.MultiMedia.SqueezeBoxFavorites: Debug Info: FavoriteId: 1.0
2020-02-04 16:59:46.144 - info: javascript.0 script.js.common.MultiMedia.SqueezeBoxFavorites: Debug Info: FavoriteName: DR+P8+Jazz .
2020-02-04 16:59:46.144 - info: javascript.0 script.js.common.MultiMedia.SqueezeBoxFavorites: Debug Info: FavoriteId: 1.1
2020-02-04 16:59:46.144 - info: javascript.0 script.js.common.MultiMedia.SqueezeBoxFavorites: Debug Info: FavoriteName: Test zwei
2020-02-04 16:59:46.144 - info: javascript.0 script.js.common.MultiMedia.SqueezeBoxFavorites: Debug Info: FavoriteId: 1.2
2020-02-04 16:59:46.144 - info: javascript.0 script.js.common.MultiMedia.SqueezeBoxFavorites: Debug Info: FavoriteName: Test zwei
2020-02-04 16:59:46.145 - info: javascript.0 script.js.common.MultiMedia.SqueezeBoxFavorites: Debug Info: FavoriteId: 10.0
2020-02-04 16:59:46.145 - info: javascript.0 script.js.common.MultiMedia.SqueezeBoxFavorites: Debug Info: FavoriteName: Ö1 .

Das scheint also kein reines Anzeigeproblem zu sein.

Hier zum Quercheck mein Code-Schnipsel, der obige Logeinträge erzeugt:

    AnfangsLaenge = FavoritesAccessKey.split('.').length;    
    TrefferListe  = $(FavoritesAccessKey + '.*.id');
    TrefferListe.each(function (Key, Position) {
        Tmp = Key.split('.');
        if(Tmp.length == (AnfangsLaenge + 2)) {
            if (getState(NachbarKey(Key, 'isaudio')).val) {
                if (getState(NachbarKey(Key, 'type')).val == 'audio') {
                    Id = getState(Key).val;
                    Log(true, 'FavoriteId: ' + Id);
                    Name = getState(NachbarKey(Key, 'Name')).val;
                    Log(true, 'FavoriteName: ' + Name);

Technisch wird bei jedem aktualisieren im Hintergrund alle Favoriten states gelöscht und dann neu angelegt.

Vielleicht läuft ja in dieser Ecke etwas schief. Wäre schön, wenn Du da nochmal rein schauen könntest. Besten Dank im Voraus.