Status der Player werden nicht aktualisiert nach Starten der Radio-Wiedergabe über Alexa - Sonos App zeigt es aber richtig an

[fmranger]

Wenn die Radio-Wiedergabe mittels Sprachbefehl oder Alexa-App gestartet wird,
zeigt die Sonos-App die Wiedergabe an aber in ioBroker werden die States nicht aktualisiert.

z.B. werden folgende States nicht aktualisiert
sonos.0.root.xxx.state_simple
sonos.0.root.xxx.current_station
sonos.0.root.xxx.state
sonos.0.root.xxx.current_artist
sonos.0.root.xxx.current_title

Wenn statt einem Radiosender über Spotify Musik gestartet wird, dann sind die States im ioBroker korrekt.

Das Verhalten ist bei unterschiedlichen Sonos-Geräten identisch.
Sonos Play1 über Alexa-Echo-Dot
Sonos One

Versions:

• Sonos-Adapter version: 2.2.3
• Alexa-Adapter version: 3.19.9
• JS-Controller version: 4.0.23
• Node version: v16.18.0

[fmranger]

Ergänzung:
Auch wenn über die Sonos-App die Radiowiedergabe gestoppt und wieder gestartet wird, ändert sich in den ioBroker States nichts.

Die Änderungen an der Lautstärke über die Sonos-App werden in ioBroker aktualsiert.
Auch das Mute wird im State richtig angezeigt.
sonos.0.root.xxx.muted

Die Änderungen an der Lautstärke werden auch im Debug protokolliert.
group-volume: Volume for http://xxx:1400: 0
volume: Volume for http://xxx:1400: 4
mute: Mute for http://xxx:1400: false

In den States des Alexa2-Adapters werden unter Player die Werte korrekt angezeigt.
z.B. alexa2.0.Echo-Devices.xxx.Player.currentState

[Apollon77]

Bitte Debug Level Log posten

[fmranger]

Debug-LOG-Level

2022-10-23 17:49:35.254 - debug: sonos.0 (9813) Redis Objects: Use Redis connection: 0.0.0.0:9001
2022-10-23 17:49:35.369 - debug: sonos.0 (9813) Objects client ready ... initialize now
2022-10-23 17:49:35.372 - debug: sonos.0 (9813) Objects create System PubSub Client
2022-10-23 17:49:35.374 - debug: sonos.0 (9813) Objects create User PubSub Client
2022-10-23 17:49:35.543 - debug: sonos.0 (9813) Objects client initialize lua scripts
2022-10-23 17:49:35.554 - debug: sonos.0 (9813) Objects connected to redis: 0.0.0.0:9001
2022-10-23 17:49:35.643 - debug: sonos.0 (9813) Redis States: Use Redis connection: 0.0.0.0:6379
2022-10-23 17:49:35.654 - debug: sonos.0 (9813) States create System PubSub Client
2022-10-23 17:49:35.656 - debug: sonos.0 (9813) States create User PubSub Client
2022-10-23 17:49:35.675 - debug: sonos.0 (9813) States connected to redis: 0.0.0.0:6379
2022-10-23 17:49:36.119 - info: sonos.0 (9813) starting. Version 2.2.3 in /opt/iobroker/node_modules/iobroker.sonos, node: v16.18.0, js-controller: 4.0.23
2022-10-23 17:49:36.269 - debug: sonos.0 (9813) Initialize known devices: [{"type":"device","common":{"name":"root"},"native":{},"from":"system.adapter.sonos.0","user":"system.user.admin","ts":1661274581298,"_id":"sonos.0.root","acl":{"object":1636,"owner":"system.user.admin","ownerGroup":"system.group.user"}}]
2022-10-23 17:49:36.326 - debug: sonos.0 (9813) Channels of root: [{"type":"channel","common":{"role":"media.music","name":"Schlafzimmer Sonos"},"native":{"ip":"xxx.xxx.x.17"},"from":"system.adapter.sonos.0","user":"system.user.admin","ts":1661274642255,"_id":"sonos.0.root.xxx_xxx_x_17","acl":{"object":1636,"owner":"system.user.admin","ownerGroup":"system.group.user"}},{"type":"channel","common":{"role":"media.music","name":"Bastelzimmer Sonos"},"native":{"ip":"xxx.xxx.x.16"},"from":"system.adapter.sonos.0","user":"system.user.admin","ts":1661274642848,"_id":"sonos.0.root.xxx_xxx_x_16","acl":{"object":1636,"owner":"system.user.admin","ownerGroup":"system.group.user"}},{"type":"channel","common":{"role":"media.music","name":"Wohnzimmer Sonos"},"native":{"ip":"xxx.xxx.x.11"},"from":"system.adapter.sonos.0","user":"system.user.admin","ts":1661274643397,"_id":"sonos.0.root.xxx_xxx_x_11","acl":{"object":1636,"owner":"system.user.admin","ownerGroup":"system.group.user"}},{"type":"channel","common":{"role":"media.music","name":"Küche Sonos"},"native":{"ip":"xxx.xxx.x.12"},"from":"system.adapter.sonos.0","user":"system.user.admin","ts":1661274643917,"_id":"sonos.0.root.xxx_xxx_x_12","acl":{"object":1636,"owner":"system.user.admin","ownerGroup":"system.group.user"}}]
2022-10-23 17:49:36.328 - debug: sonos.0 (9813) Process channel: sonos.0.root.xxx_xxx_x_17
2022-10-23 17:49:36.357 - debug: sonos.0 (9813) Process channel: sonos.0.root.xxx_xxx_x_16
2022-10-23 17:49:36.375 - debug: sonos.0 (9813) Process channel: sonos.0.root.xxx_xxx_x_11
2022-10-23 17:49:36.418 - debug: sonos.0 (9813) Process channel: sonos.0.root.xxx_xxx_x_12
2022-10-23 17:49:37.271 - debug: sonos.0 (9813) > playbackState: PAUSED_PLAYBACK -
2022-10-23 17:49:37.274 - debug: sonos.0 (9813) Cover exists. Try reading from fs
2022-10-23 17:49:37.302 - debug: sonos.0 (9813) mute: Mute for http://xxx.xxx.x.12:1400: false
2022-10-23 17:49:37.303 - debug: sonos.0 (9813) volume: Volume for http://xxx.xxx.x.12:1400: 13
2022-10-23 17:49:37.310 - debug: sonos.0 (9813) mute: Mute for http://xxx.xxx.x.16:1400: false
2022-10-23 17:49:37.311 - debug: sonos.0 (9813) volume: Volume for http://xxx.xxx.x.16:1400: 25
2022-10-23 17:49:37.318 - debug: sonos.0 (9813) mute: Mute for http://xxx.xxx.x.17:1400: false
2022-10-23 17:49:37.320 - debug: sonos.0 (9813) volume: Volume for http://xxx.xxx.x.17:1400: 18
2022-10-23 17:49:37.362 - debug: sonos.0 (9813) > playbackState: STOPPED - SWR3
2022-10-23 17:49:37.365 - debug: sonos.0 (9813) Cover exists. Try reading from fs
2022-10-23 17:49:37.410 - debug: sonos.0 (9813) > playbackState: PLAYING -
2022-10-23 17:49:37.412 - debug: sonos.0 (9813) Cover exists. Try reading from fs
2022-10-23 17:49:37.414 - debug: sonos.0 (9813) mute: Mute for http://xxx.xxx.x.12:1400: false
2022-10-23 17:49:37.415 - debug: sonos.0 (9813) group_muted: groupMuted for http://xxx.xxx.x.12:1400: false
2022-10-23 17:49:37.422 - debug: sonos.0 (9813) mute: Mute for http://xxx.xxx.x.11:1400: false
2022-10-23 17:49:37.423 - debug: sonos.0 (9813) volume: Volume for http://xxx.xxx.x.11:1400: 12
2022-10-23 17:49:37.426 - debug: sonos.0 (9813) mute: Mute for http://xxx.xxx.x.16:1400: false
2022-10-23 17:49:37.426 - debug: sonos.0 (9813) group_muted: groupMuted for http://xxx.xxx.x.16:1400: false
2022-10-23 17:49:37.429 - debug: sonos.0 (9813) mute: Mute for http://xxx.xxx.x.17:1400: false
2022-10-23 17:49:37.430 - debug: sonos.0 (9813) group_muted: groupMuted for http://xxx.xxx.x.17:1400: false
2022-10-23 17:49:37.448 - debug: sonos.0 (9813) group-volume: Volume for http://xxx.xxx.x.12:1400: 13
2022-10-23 17:49:37.449 - debug: sonos.0 (9813) group-volume: Volume for http://xxx.xxx.x.16:1400: 25
2022-10-23 17:49:37.450 - debug: sonos.0 (9813) group-volume: Volume for http://xxx.xxx.x.17:1400: 18
2022-10-23 17:49:37.502 - debug: sonos.0 (9813) mute: Mute for http://xxx.xxx.x.11:1400: false
2022-10-23 17:49:37.503 - debug: sonos.0 (9813) group_muted: groupMuted for http://xxx.xxx.x.11:1400: false
2022-10-23 17:49:37.526 - debug: sonos.0 (9813) group-volume: Volume for http://xxx.xxx.x.11:1400: 12
2022-10-23 17:50:39.742 - debug: sonos.0 (9813) > playbackState: STOPPED - Wiedergabe gestartet über Alexa
2022-10-23 17:50:39.743 - debug: sonos.0 (9813) Cover exists. Try reading from fs
2022-10-23 17:52:17.612 - debug: sonos.0 (9813) > playbackState: STOPPED - SWR3 - Wiedergabe über App gestoppt
2022-10-23 17:52:17.615 - debug: sonos.0 (9813) Cover exists. Try reading from fs
2022-10-23 17:52:21.995 - debug: sonos.0 (9813) > playbackState: PLAYING - Wiedergabe mit Sonos Radio Sender über App gestartet
2022-10-23 17:52:23.368 - debug: sonos.0 (9813) > playbackState: PLAYING - SWR3 Verkehrszentrum - Stau-Infos telefonisch unter 07221-9282
2022-10-23 17:52:30.108 - debug: sonos.0 (9813) > playbackState: STOPPED - Wiedergabe über App gestoppt

[Apollon77]

Wenn Du jetzt noch sagen könntest WANN zeitlich WAS passiert ist, sodass ich das Log versteheen könnte wäre das super hilfreich ... passt irgendwas der "Playback state "changes zu dem was Du getan hast?

[fmranger]

Habe es im Log ergänzt wann ich was gemacht habe.

Wenn in der Sonos-App angezeigt wird " Gestartet von Amazon Alexa" dann wird es im Sonos-Adapter nicht aktualisiert. Egal ob man startet oder stoppt über Alexa oder Sonos-App.

Bei der Verwendung von "Sonos-Radio" über die Sonos-App wird sofort der State im ioBroker aktualisiert.

[jpawlowski]

Nicht sicher, ob es hier einen Zusammenhang gibt, aber:
Mir ist auch grad aufgefallen, dass der alive-Status nicht von false auf true wechselt, wenn ein Sonos Gerät vom Strom getrennt war und wieder eingeschaltet wird. Es handelt sich hierbei allerdings um den Sub und Surroundspeaker

[Rello]

same here. nice find by @fmranger that its only related to radio.
i tested again. when playing something from the library it immediately changes the status correctly

[arndth]

Thanks for sharing. I just switched to a Playlist and back to radio and it is working again.

[fmranger]

@arndth
Within the sonos app it is working, but saying "alexa play radio" the state in iobroker is not updated.

[stale]

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs within the next 7 days. Please check if the issue is still relevant in the most current version of the adapter and tell us. Also check that all relevant details, logs and reproduction steps are included and update them if needed. Thank you for your contributions.
Dieses Problem wurde automatisch als veraltet markiert, da es in letzter Zeit keine Aktivitäten gab. Es wird geschlossen, wenn nicht innerhalb der nächsten 7 Tage weitere Aktivitäten stattfinden. Bitte überprüft, ob das Problem auch in der aktuellsten Version des Adapters noch relevant ist, und teilt uns dies mit. Überprüft auch, ob alle relevanten Details, Logs und Reproduktionsschritte enthalten sind bzw. aktualisiert diese. Vielen Dank für Eure Unterstützung.

[fmranger]

Das Problem ist leider immer noch vorhanden.

Node.js 18.16.0
NPM 9.5.1
IoBroker Admin 6.3.5
Alexa2 3.23.2
Sonos 2.2.3