ioBroker.chromecast icon indicating copy to clipboard operation
ioBroker.chromecast copied to clipboard

Published 20 hours ago • verified publisher icon iobroker-community-adapters

[Bug]: Chromecast is changing volume always during speech

Open maxpd1 opened this issue 3 years ago • 49 comments

Hello,

I noticed that in the morning every announcement is loud for a short time and then quiet shortly after. Since I couldn't remember having something like this installed, I checked the log. Indeed, there the volume is reduced from 70 to 25. How do I find out what is responsible for this change? Because I can't find anything in the script that executes the voice message.

I even downloaded all scripts and then searched them with Notepad++ for 70 and 25. But there is nothing related to the volume.

2021-08-04 07:56:58.527 - info: chromecast.0 (7062) Received keep alive for disconnected device Google Home Wohnzimmer

  | 2021-08-04 07:56:58.528 - info: chromecast.0 (7062) Reconnecting Google Home Wohnzimmer to 192.168.xxx.xx:xxxx   | 2021-08-04 07:57:16.666 - info: sayit.3 (7028) saying: Wir bekommen heute Höchsttemperaturen von 21 Grad und Bewölkt mit leichtem RegenDie heutige Inzidenz liegt bei 26und im Landkreis sind es 30Achso, und außerdem ist heute die Müllabfuhr von der Gelben Tonne   | 2021-08-04 07:57:23.575 - info: sayit.3 (7028) Copied file "/opt/iobroker/iobroker-data/sayit/sayit.3.say.mp3" to "/opt/iobroker/cache/6606acccf6ea35710xxxxxxxxxxxxx.mp3"   | ------2021-08-04 07:57:23.623 - info: sayit.3 (7028) Set "chromecast.0.Iobrokergruppe.player.announcement to {"url":"http://192.168.xxx.xx:xxxx/state/sayit.3.tts.mp3"[,"volume":70}]   | 2021-08-04 07:57:23.631 - info: chromecast.0 (7062) Iobrokergruppe - Try to launch default player   | 2021-08-04 07:57:23.886 - info: chromecast.0 (7062) Iobrokergruppe - Try to join player   | 2021-08-04 07:57:23.889 - info: chromecast.0 (7062) Iobrokergruppe - Connected player   | 2021-08-04 07:57:23.890 - info: chromecast.0 (7062) Iobrokergruppe - Default player lauched   | 2021-08-04 07:57:23.890 - info: chromecast.0 (7062) Iobrokergruppe - Connected player   | 2021-08-04 07:57:23.891 - info: chromecast.0 (7062) Iobrokergruppe - Player joint   | 2021-08-04 07:57:23.892 - info: chromecast.0 (7062) Iobrokergruppe - Try to play announcement - "http://192.168.xxx.xx:xxxx/state/sayit.3.tts.mp3"   | 2021-08-04 07:57:23.893 - info: chromecast.0 (7062) Iobrokergruppe - Try to play url - http://192.168.xxx.xx:xxxx/state/sayit.3.tts.mp3   | 2021-08-04 07:57:24.012 - info: chromecast.0 (7062) Iobrokergruppe - Closing mediaInfo   | 2021-08-04 07:57:24.013 - info: chromecast.0 (7062) Iobrokergruppe - Try to play playlist with 1 items   | 2021-08-04 07:57:24.018 - info: chromecast.0 (7062) Küche - Try to join player   | 2021-08-04 07:57:24.019 - info: chromecast.0 (7062) Küche - Connected player   | 2021-08-04 07:57:24.020 - info: chromecast.0 (7062) Küche - Player joint   | -------2021-08-04 07:57:24.600 - info: chromecast.0 (7062) Iobrokergruppe - set volume to 70]   | 2021-08-04 07:57:25.620 - info: chromecast.0 (7062) Iobrokergruppe - Playing - http://192.168.xxx.xx:xxxx/state/sayit.3.tts.mp3   | 2021-08-04 07:57:25.622 - info: chromecast.0 (7062) Iobrokergruppe - Playing playlist with 1 items   | 2021-08-04 07:57:26.500 - info: chromecast.0 (7062) Iobrokergruppe - Finished playing announcement   | 2021-08-04 07:57:27.175 - info: chromecast.0 (7062) Iobrokergruppe - Playing - http://192.168.xxx.xx:xxxx/state/sayit.3.tts.mp3   | -------2021-08-04 07:57:27.364 - info: chromecast.0 (7062) Iobrokergruppe - set volume to 25]

maxpd1 avatar Aug 12 '21 19:08 maxpd1

Can I provide any further information?

maxpd1 avatar Aug 20 '21 17:08 maxpd1

Still no solution for this problem

maxpd1 avatar Nov 19 '21 08:11 maxpd1

Sayit Adapter keeps volume but chromecast adapter changes it but not initialized by any blockly script. So what trigger is changing "status.volume"?

maxpd1 avatar Dec 10 '21 09:12 maxpd1

Please test v3.0.1. But be aware this version has breaking changes. You also need to install net-tools by hand as this will not be installed automatically.

Jey-Cee avatar Jan 13 '22 20:01 Jey-Cee

I installed it and will report in the next days. Thank you!

maxpd1 avatar Jan 14 '22 06:01 maxpd1

Seems not to work:

image

Is it possible that also a new group was added? There was no speech until I realised that a cryptical new group was added.

The first one was my group which isn't working anymore and below a new one with a strange name:

image

And in the log I see error even if I insalled net tools and restarted every instance:

image

maxpd1 avatar Jan 14 '22 07:01 maxpd1

The breaking change is that devices now identified by their MAC. Therfore net-tools has to be installed, you have to install it by hand. And you have to delete all objects and restart the adapter, then you see the new structure.

Jey-Cee avatar Jan 14 '22 07:01 Jey-Cee

Unfortunately volume is still changed after 2 seconds:

`

chromecast.0 2022-01-15 08:11:17.789 info Update client status: Küche
chromecast.0 2022-01-15 08:11:17.785 info Update client status: Google_Home_Wohnzimmer
chromecast.0 2022-01-15 08:11:17.779 info Update client status: Iobrokergruppe
chromecast.0 2022-01-15 08:11:17.778 info Update client status: Badezimmer
sonoff.0 2022-01-15 08:11:11.609 warn Client "WLAN Steckdose A" not connected
chromecast.0 2022-01-15 08:11:07.172 info Iobrokergruppe - Playing - http://- IP - /state/sayit.3.tts.mp3
chromecast.0 2022-01-15 08:11:06.966 info Update client status: Badezimmer
chromecast.0 2022-01-15 08:11:06.898 info Update client status: Küche
chromecast.0 2022-01-15 08:11:06.884 info Update client status: Google_Home_Wohnzimmer
chromecast.0 2022-01-15 08:11:06.873 info Iobrokergruppe - set volume to 25
chromecast.0 2022-01-15 08:11:06.872 info Update client status: Iobrokergruppe
chromecast.0 2022-01-15 08:11:06.693 info Iobrokergruppe - Finished playing announcement
chromecast.0 2022-01-15 08:11:06.249 info Iobrokergruppe - Playing playlist with 1 items
chromecast.0 2022-01-15 08:11:06.247 info Iobrokergruppe - Playing - http://- IP - /state/sayit.3.tts.mp3
chromecast.0 2022-01-15 08:11:05.349 info Update client status: Google_Home_Wohnzimmer
chromecast.0 2022-01-15 08:11:05.346 info Update client status: Küche
chromecast.0 2022-01-15 08:11:05.342 info Update client status: Iobrokergruppe
chromecast.0 2022-01-15 08:11:05.335 info Update client status: Badezimmer
chromecast.0 2022-01-15 08:11:04.529 info Update client status: Iobrokergruppe
chromecast.0 2022-01-15 08:11:04.516 info Update client status: Badezimmer
chromecast.0 2022-01-15 08:11:04.408 info Update client status: Küche
chromecast.0 2022-01-15 08:11:04.404 info Iobrokergruppe - set volume to 100
chromecast.0 2022-01-15 08:11:04.404 info Update client status: Iobrokergruppe
chromecast.0 2022-01-15 08:11:04.402 info Update client status: Google_Home_Wohnzimmer
chromecast.0 2022-01-15 08:11:04.237 info Iobrokergruppe - Try to play playlist with 1 items
chromecast.0 2022-01-15 08:11:04.236 info Iobrokergruppe - Closing mediaInfo
chromecast.0 2022-01-15 08:11:04.222 info Küche - Player joint
chromecast.0 2022-01-15 08:11:04.222 info Küche - Connected player
chromecast.0 2022-01-15 08:11:04.220 info Küche - Try to join player
chromecast.0 2022-01-15 08:11:04.219 info Update client status: Küche
chromecast.0 2022-01-15 08:11:04.186 info Google Home Wohnzimmer - Player joint
chromecast.0 2022-01-15 08:11:04.185 info Google Home Wohnzimmer - Connected player
chromecast.0 2022-01-15 08:11:04.182 info Google Home Wohnzimmer - Try to join player
chromecast.0 2022-01-15 08:11:04.181 info Update client status: Google_Home_Wohnzimmer
chromecast.0 2022-01-15 08:11:04.174 info Iobrokergruppe - Try to play url - http://- IP - /state/sayit.3.tts.mp3
chromecast.0 2022-01-15 08:11:04.174 info Iobrokergruppe - Try to play announcement - "http://- IP - /state/sayit.3.tts.mp3"
chromecast.0 2022-01-15 08:11:04.173 info Iobrokergruppe - Player joint
chromecast.0 2022-01-15 08:11:04.173 info Iobrokergruppe - Connected player
chromecast.0 2022-01-15 08:11:04.173 info Iobrokergruppe - Default player lauched
chromecast.0 2022-01-15 08:11:04.172 info Iobrokergruppe - Connected player
chromecast.0 2022-01-15 08:11:04.170 info Iobrokergruppe - Try to join player
chromecast.0 2022-01-15 08:11:04.170 info Update client status: Iobrokergruppe
chromecast.0 2022-01-15 08:11:03.997 info Update client status: Badezimmer
chromecast.0 2022-01-15 08:11:03.852 info Iobrokergruppe - Try to launch default player
sayit.3 2022-01-15 08:11:03.819 info Set "chromecast.0.groups.74705643db2e46e4b5b11081d1ac0aaf.player.announcement to {"url":"http://- IP - /state/sayit.3.tts.mp3","volume":100}
sayit.3 2022-01-15 08:11:03.811 info Copied file "/opt/iobroker/iobroker-data/sayit/sayit.3.say.mp3" to "/opt/iobroker/cache/ab95bf9589f13f3e06cb7eab0872ab1c.mp3"
shelly.0 2022-01-15 08:11:03.717 warn State value to set for "shelly.0.SHDM-1#F3A7ED#1.temperatureF" has value "112.38" greater than max "100"
yeelight-2.0 2022-01-15 08:11:03.624 info State value to set for "yeelight-2.0.Hinter_TV.control.ct" has to be type "string" but received type "number"
yeelight-2.0 2022-01-15 08:11:03.624 info State value to set for "yeelight-2.0.Hinter_TV.control.active_bright" has to be type "string" but received type "number"
zigbee.0 2022-01-15 08:11:03.393 warn Send command to 0x847127fffe173b19 failed with: Code 205 (No network route)
sayit.3 2022-01-15 08:11:02.920 info saying: Wir bekommen heute Höchsttemperaturen von 5 Grad und Bewölkt. Die heutige Inzidenz im Bundeland liegt bei 444 und im Landkreis Ort sind es 415.
`

maxpd1 avatar Jan 15 '22 11:01 maxpd1

Turn the log level for the chromecast instace to debug, then you should see who is changing it.

Jey-Cee avatar Jan 15 '22 11:01 Jey-Cee

Tried to find it out since weeks. But also debug mode doesn't give me additional hints.

2022-01-16 08:13:26.597 - info: sayit.3 (26637) saying: Wir bekommen heute Höchsttemperaturen von 2 Grad und Bedeckt mit Schneeschauern. Die heutige Inzidenz im Bundesland liegt bei 462 und im Landkreis Ort sind es 436.
2022-01-16 08:13:26.863 - warn: zigbee.0 (1732) Send command to 0x847127fffe173b19 failed with: Code 205 (No network route)
2022-01-16 08:13:27.473 - info: sayit.3 (26637) Copied file "/opt/iobroker/iobroker-data/sayit/sayit.3.say.mp3" to "/opt/iobroker/cache/b4584f977c066240e485f20123f9a76a.mp3"
2022-01-16 08:13:27.481 - info: sayit.3 (26637) Set "chromecast.0.groups.74705643db2e46e4b5b11081d1ac0aaf.player.announcement to {"url":"http://- IP -/state/sayit.3.tts.mp3","volume":100}
2022-01-16 08:13:27.494 - debug: chromecast.0 (5405) Iobrokergruppe - device stateChange player.announcement {"val":"{\"url\":\"http://- IP -/state/sayit.3.tts.mp3\",\"volume\":100}","ack":false,"ts":1642317207490,"q":0,"from":"system.adapter.sayit.3","user":"system.user.admin","lc":1642188867898}
2022-01-16 08:13:27.494 - info: chromecast.0 (5405) Iobrokergruppe - Try to launch default player
2022-01-16 08:13:27.627 - info: chromecast.0 (5405) Update client status: Badezimmer
2022-01-16 08:13:27.706 - info: chromecast.0 (5405) Update client status: Iobrokergruppe
2022-01-16 08:13:27.707 - info: chromecast.0 (5405) Iobrokergruppe - Try to join player
2022-01-16 08:13:27.708 - info: chromecast.0 (5405) Iobrokergruppe - Connected player
2022-01-16 08:13:27.709 - info: chromecast.0 (5405) Iobrokergruppe - Default player lauched
2022-01-16 08:13:27.709 - info: chromecast.0 (5405) Iobrokergruppe - Connected player
2022-01-16 08:13:27.709 - info: chromecast.0 (5405) Iobrokergruppe - Player joint
2022-01-16 08:13:27.710 - info: chromecast.0 (5405) Iobrokergruppe - Try to play announcement - "http://- IP -/state/sayit.3.tts.mp3"
2022-01-16 08:13:27.710 - info: chromecast.0 (5405) Iobrokergruppe - Try to play url - http://- IP -/state/sayit.3.tts.mp3
2022-01-16 08:13:27.734 - debug: chromecast.0 (5405) Iobrokergruppe - Connected to http://- IP -/state/sayit.3.tts.mp3
{
'content-type': 'audio/mpeg',
'content-length': '69478',
etag: 'W/"10f66-yOrFxRX/svWI46I4OMjCBtwY5lE"',
date: 'Sun, 16 Jan 2022 07:13:27 GMT',
connection: 'close'
}
2022-01-16 08:13:27.735 - debug: chromecast.0 (5405) Iobrokergruppe - Detected audio/mpeg as contentType
2022-01-16 08:13:27.735 - info: chromecast.0 (5405) Iobrokergruppe - Closing mediaInfo
2022-01-16 08:13:27.735 - info: chromecast.0 (5405) Iobrokergruppe - Try to play playlist with 1 items
2022-01-16 08:13:27.816 - info: chromecast.0 (5405) Update client status: Küche
2022-01-16 08:13:27.816 - info: chromecast.0 (5405) Küche - Try to join player
2022-01-16 08:13:27.817 - info: chromecast.0 (5405) Küche - Connected player
2022-01-16 08:13:27.818 - info: chromecast.0 (5405) Küche - Player joint
2022-01-16 08:13:27.821 - info: chromecast.0 (5405) Update client status: Google_Home_Wohnzimmer
2022-01-16 08:13:27.822 - info: chromecast.0 (5405) Google Home Wohnzimmer - Try to join player
2022-01-16 08:13:27.823 - info: chromecast.0 (5405) Google Home Wohnzimmer - Connected player
2022-01-16 08:13:27.824 - info: chromecast.0 (5405) Google Home Wohnzimmer - Player joint
2022-01-16 08:13:27.913 - debug: chromecast.0 (5405) Google_Home_Wohnzimmer - 20dfb9c84e37.player.state value unchanged -> SKIP
2022-01-16 08:13:28.369 - info: chromecast.0 (5405) Update client status: Küche
2022-01-16 08:13:28.377 - info: chromecast.0 (5405) Update client status: Google_Home_Wohnzimmer
2022-01-16 08:13:28.413 - info: chromecast.0 (5405) Update client status: Iobrokergruppe
2022-01-16 08:13:28.414 - info: chromecast.0 (5405) Iobrokergruppe - set volume to 100
2022-01-16 08:13:28.555 - info: chromecast.0 (5405) Update client status: Iobrokergruppe
2022-01-16 08:13:28.562 - info: chromecast.0 (5405) Update client status: Badezimmer
2022-01-16 08:13:28.595 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.state value unchanged -> SKIP
2022-01-16 08:13:28.596 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.state value unchanged -> SKIP
2022-01-16 08:13:28.647 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.status.playerState value unchanged -> SKIP
2022-01-16 08:13:28.648 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.media.contentType value unchanged -> SKIP
2022-01-16 08:13:28.650 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.contentId value unchanged -> SKIP
2022-01-16 08:13:28.650 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.metadata.title value unchanged -> SKIP
2022-01-16 08:13:28.651 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.status.playerState value unchanged -> SKIP
2022-01-16 08:13:28.718 - info: chromecast.0 (5405) Update client status: Badezimmer
2022-01-16 08:13:28.726 - info: chromecast.0 (5405) Update client status: Iobrokergruppe
2022-01-16 08:13:28.728 - info: chromecast.0 (5405) Update client status: Google_Home_Wohnzimmer
2022-01-16 08:13:28.768 - info: chromecast.0 (5405) Update client status: Küche
2022-01-16 08:13:29.835 - info: chromecast.0 (5405) Iobrokergruppe - Playing - http://- IP -/state/sayit.3.tts.mp3
2022-01-16 08:13:29.836 - info: chromecast.0 (5405) Iobrokergruppe - Playing playlist with 1 items
2022-01-16 08:13:29.839 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.state value unchanged -> SKIP
2022-01-16 08:13:29.840 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.currentTime value unchanged -> SKIP
2022-01-16 08:13:29.840 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.media.streamType value unchanged -> SKIP
2022-01-16 08:13:29.840 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.state value unchanged -> SKIP
2022-01-16 08:13:29.844 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.currentTime value unchanged -> SKIP
2022-01-16 08:13:29.847 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.state value unchanged -> SKIP
2022-01-16 08:13:29.847 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.currentTime value unchanged -> SKIP
2022-01-16 08:13:30.743 - info: chromecast.0 (5405) Iobrokergruppe - Finished playing announcement
2022-01-16 08:13:30.745 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.state value unchanged -> SKIP
2022-01-16 08:13:30.745 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.currentTime value unchanged -> SKIP
2022-01-16 08:13:30.746 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.state value unchanged -> SKIP
2022-01-16 08:13:30.746 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.currentTime value unchanged -> SKIP
2022-01-16 08:13:30.838 - info: chromecast.0 (5405) Iobrokergruppe - Playing - http://- IP -/state/sayit.3.tts.mp3
2022-01-16 08:13:30.840 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.state value unchanged -> SKIP
2022-01-16 08:13:30.841 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.currentTime value unchanged -> SKIP
2022-01-16 08:13:30.842 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.state value unchanged -> SKIP
2022-01-16 08:13:30.844 - debug: chromecast.0 (5405) Iobrokergruppe - groups.74705643db2e46e4b5b11081d1ac0aaf.player.currentTime value unchanged -> SKIP
2022-01-16 08:13:30.915 - info: yeelight-2.0 (25388) State value to set for "yeelight-2.0.Hinter_TV.control.active_bright" has to be type "string" but received type "number"
2022-01-16 08:13:30.917 - info: yeelight-2.0 (25388) State value to set for "yeelight-2.0.Hinter_TV.control.ct" has to be type "string" but received type "number"
2022-01-16 08:13:30.944 - info: chromecast.0 (5405) Update client status: Google_Home_Wohnzimmer
2022-01-16 08:13:30.991 - info: chromecast.0 (5405) Update client status: Küche
2022-01-16 08:13:31.000 - info: chromecast.0 (5405) Update client status: Iobrokergruppe
2022-01-16 08:13:31.000 - info: chromecast.0 (5405) Iobrokergruppe - set volume to 27
2022-01-16 08:13:31.040 - info: chromecast.0 (5405) Update client status: Iobrokergruppe
2022-01-16 08:13:31.089 - info: chromecast.0 (5405) Update client status: Badezimmer

maxpd1 avatar Jan 16 '22 07:01 maxpd1

Other ideas to identify the cause of volume change?

maxpd1 avatar Jan 27 '22 06:01 maxpd1

I am seeing this problem too with 2.3.1. Will upgrade to ~~v3.0.1~~ master (as there is no v3.0.1 & v3.0.0 is broken) as advised and report any changes.

raintonr avatar Jan 30 '22 06:01 raintonr

Will upgrade to ~v3.0.1~ master (as there is no v3.0.1 & v3.0.0 is broken) as advised and report any changes.

Nope - still broken. Things to note:

  • We have spoken notifications via SayIt through a Google Nest Mini. I'm strictly talking about IOB generated stuff below - nothing from the actual Google device or Google services.
  • Before I activated 'Goodnight' mode last night I looked at the Nest Mini in the Google Home Android App. It showed volume of 45% even though we never change volume on that device and it was set at 100% earlier in the day.
  • Sure enough, SayIt notification was low (45%) volume.
  • I looked at the Google Android App and yes, volume was 45% so put it back at 100% manually in that app.
  • This morning before activating 'Awake' I checked again. Google Home App showed 100% volume.
  • Somehow, when our 'Good morning' announcement came out it was low volume again though.
  • Checked the Google Home App and volume was indeed back at 45%.
  • Looking at the IOB log (included below) Chromecast adapter thought the volume was 100%.
  • However, manually looking at the Object tree in admin interface, chromecast.0.d4f54780bd1c.player.volume shows 45% directly after all this happened.
  • I then manually updated chromecast.0.d4f54780bd1c.player.volume to 100% and the player volume changed and also showed as 100% in the Google Home App.

Now... I have no idea how useful any of this is, but seems figuring out why Chromecast adapter logs volume as 100% when it's really 45% is a good place to start. Also figuring out what exactly put the device at 45% the day before is necessary. I did check all the 'Digital Wellbeing', etc. settings and there's nothing in there that should be doing this.,

2022-01-31 07:44:04.939  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:04.941  - info: chromecast.0 (8039) Nest Mini - Try to join player
2022-01-31 07:44:04.944  - info: chromecast.0 (8039) Nest Mini - Connected player
2022-01-31 07:44:04.945  - info: chromecast.0 (8039) Nest Mini - Default player lauched
2022-01-31 07:44:04.946  - info: chromecast.0 (8039) Nest Mini - Connected player
2022-01-31 07:44:04.947  - info: chromecast.0 (8039) Nest Mini - Player joint
2022-01-31 07:44:04.947  - info: chromecast.0 (8039) Nest Mini - Try to play announcement - "http://10.1.1.30:8082/state/sayit.0.tts.mp3"
2022-01-31 07:44:04.948  - info: chromecast.0 (8039) Nest Mini - setting volume to same value 100 - ignored
2022-01-31 07:44:04.948  - info: chromecast.0 (8039) Nest Mini - Try to play url - http://10.1.1.30:8082/state/sayit.0.tts.mp3
2022-01-31 07:44:04.957  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:04.957  - info: chromecast.0 (8039) Nest Mini - Try to join player
2022-01-31 07:44:04.961  - info: chromecast.0 (8039) Nest Mini - Connected player
2022-01-31 07:44:04.961  - info: chromecast.0 (8039) Nest Mini - Default player lauched
2022-01-31 07:44:04.962  - info: chromecast.0 (8039) Nest Mini - Connected player
2022-01-31 07:44:04.963  - info: chromecast.0 (8039) Nest Mini - Player joint
2022-01-31 07:44:04.964  - info: chromecast.0 (8039) Nest Mini - Try to play announcement - "http://10.1.1.30:8082/state/sayit.0.tts.mp3"
2022-01-31 07:44:04.964  - info: chromecast.0 (8039) Nest Mini - setting volume to same value 100 - ignored
2022-01-31 07:44:04.965  - info: chromecast.0 (8039) Nest Mini - Try to play url - http://10.1.1.30:8082/state/sayit.0.tts.mp3
2022-01-31 07:44:05.024  - info: chromecast.0 (8039) Nest Mini - Closing mediaInfo
2022-01-31 07:44:05.025  - info: chromecast.0 (8039) Nest Mini - Try to play playlist with 1 items
2022-01-31 07:44:05.027  - info: chromecast.0 (8039) Nest Mini - Closing mediaInfo
2022-01-31 07:44:05.028  - info: chromecast.0 (8039) Nest Mini - Try to play playlist with 1 items
2022-01-31 07:44:05.212  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:05.213  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:05.531  - info: chromecast.0 (8039) Nest Mini - Playing - http://10.1.1.30:8082/state/sayit.0.tts.mp3
2022-01-31 07:44:05.534  - info: chromecast.0 (8039) Nest Mini - Playing playlist with 1 items
2022-01-31 07:44:05.540  - info: chromecast.0 (8039) Nest Mini - Playing - http://10.1.1.30:8082/state/sayit.0.tts.mp3
2022-01-31 07:44:05.541  - info: chromecast.0 (8039) Nest Mini - Playing playlist with 1 items
2022-01-31 07:44:05.551  - info: chromecast.0 (8039) Nest Mini - Finished playing announcement
2022-01-31 07:44:05.552  - info: chromecast.0 (8039) Nest Mini - setting volume to same value 100 - ignored
2022-01-31 07:44:05.558  - info: chromecast.0 (8039) Nest Mini - Finished playing announcement
2022-01-31 07:44:05.559  - info: chromecast.0 (8039) Nest Mini - setting volume to same value 100 - ignored
2022-01-31 07:44:05.564  - info: chromecast.0 (8039) Nest Mini - getStatus
2022-01-31 07:44:05.578  - info: chromecast.0 (8039) Nest Mini - getStatus
2022-01-31 07:44:05.580  - info: chromecast.0 (8039) Nest Mini - getStatus
2022-01-31 07:44:05.595  - info: chromecast.0 (8039) Nest Mini - getStatus
2022-01-31 07:44:05.599  - info: chromecast.0 (8039) Nest Mini - getStatus
2022-01-31 07:44:05.602  - info: chromecast.0 (8039) Nest Mini - getStatus
2022-01-31 07:44:05.605  - info: chromecast.0 (8039) Nest Mini - getStatus
2022-01-31 07:44:05.610  - info: chromecast.0 (8039) Nest Mini - getStatus
2022-01-31 07:44:05.625  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:05.626  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:05.661  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:05.663  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:05.665  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:05.666  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:05.723  - info: chromecast.0 (8039) Nest Mini - Playing - http://10.1.1.30:8082/state/sayit.0.tts.mp3
2022-01-31 07:44:05.729  - info: chromecast.0 (8039) Nest Mini - Playing - http://10.1.1.30:8082/state/sayit.0.tts.mp3
2022-01-31 07:44:07.066  - info: chromecast.0 (8039) Update client status: Nest_Mini
2022-01-31 07:44:07.069  - info: chromecast.0 (8039) Update client status: Nest_Mini

raintonr avatar Jan 31 '22 06:01 raintonr

As far as I understood sayit takes 45% of the value which is set up in the home mini.

Therefore I run sayit always with 100% (or let the option empty) and only change volume in the morning and evening in the Home Minis.

But nevertheless. Volume changes during a notification but without any pattern.

Chromecast adapter version doesn't matter. Since the beginning I use it.

maxpd1 avatar Jan 31 '22 12:01 maxpd1

As far as I understood sayit takes 45% of the value which is set up in the home mini.

Nope, not here. As you can see from the log snippet I shared above it only mentions 100% volume.

If 45% change is supposed to happen though... yech... it should only be an option as I always want full volume from our Nest Mini.

raintonr avatar Jan 31 '22 12:01 raintonr

Description from sayit adapter:

You can specify the volume of announcement in percent from current or given volume (not from maximal). E.g. if command is de;75;Gutes Wetterand "announce volume" is 50%, the announce will be played with volume 38% from 100% possible.

maxpd1 avatar Jan 31 '22 12:01 maxpd1

Nope. There is no volume setting in my SayIt adapter config page.

Edit: Sorry, there is for the 'Announcement' but that is... erm... just for the intro sound, right? It has no bearing on the spoken message? Moreover, I don't have any announcement configured so that volume won't (shouldn't) do anything anyway.

raintonr avatar Jan 31 '22 13:01 raintonr

OK, so I did a little more research on this. Users of other systems (other than ioBroker) have reported their devices resetting to 45% volume so looks like it's a Google 'feature'. Annoying!

I also find it irritating that the player will timeout and detach after around 5 minutes (Google Nest Mini) which causes the 'connection' sound to play on my next notification (can be turned off on Chromecast devices but not Google Nest Mini).

To counter these two problems I wrote a little keepalive script which periodically plays a sound (1s of silence - a real sound would get old really fast!) and sets the volume to 100%.

While a bit of a bodge it works here. I created a Gist with this script if anyone is interested:

https://gist.github.com/raintonr/67f2f269012051a453cbd8b91034a473

I guess it would be nice if such keepalive functionality could be included in the Chromecast adapter at some point? Any interest in that?

raintonr avatar Feb 04 '22 06:02 raintonr

In earlier versions I had a keep alive event in protocol. But it seems to miss in the current version. Nevertheless my Google Home Minis ( no Nest) don't change volume during the day by themselves.

image

Only 1 second after starting the message. Trigger unknown also with debug log. Log entry only written by chromecast adapter not by other adapters and without hint on the trigger.

maxpd1 avatar Feb 04 '22 10:02 maxpd1

How do I get rights with winscp to manipulate chromecast adapter files for testing by myself? the volume part is appearing in chromecast.js and chromecastDevice.js whereas I think that the problem is located in the last one. It's really annoying.

maxpd1 avatar Feb 10 '22 10:02 maxpd1

push before it's set on stale. problem still very annoying as speach output of every message has another volume

maxpd1 avatar Mar 24 '22 13:03 maxpd1

I had the same problem as you but when I set the text object in the sayit adapter with the language and the volume before the message comes it works for me. Probably this works for you too?

image

aortmannm avatar Jun 03 '22 05:06 aortmannm

thank you @aortmannm for your comment. Do you have any idea how this works in a blockly? As all my scripts are set up as blocklys.

maxpd1 avatar Jun 03 '22 06:06 maxpd1

yes, you can in blocky create JavaScript functions. See screenshot

image

aortmannm avatar Jun 03 '22 07:06 aortmannm

I am not sure how I get these 2 functions together

image

Despite that I control the volume of the google home minis externally in regards of daytime and not via say it adapter.

Perhaps i miss also some knowlege in another area. Because i dont' know how to put the javascript function into an If object

maxpd1 avatar Jun 03 '22 11:06 maxpd1

I still don't know how to connect the JS function with the blockly.

But when I think about it, in the blockly block the optional volume also stands above the text. But maintaining the volume field doesn't have an impact.

maxpd1 avatar Jun 24 '22 11:06 maxpd1

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.

stale[bot] avatar Sep 24 '22 09:09 stale[bot]

Problem still not solved.

maxpd1 avatar Sep 24 '22 19:09 maxpd1

@mcm1957 and @Apollon77 we discussed that a new adapter isn't the correct solution. so I leave comment to revive the topic again and to protect it from stale bot.

maxpd1 avatar Dec 27 '22 20:12 maxpd1

Here we are now running:

iobroker.sayit: 1.12.3 iobroker.chromecast: 3.1.0

Google Nest Mini. I tested 3 scenarios:

  1. Set volume on actual device to 100% volume. Works as expected. In the log we see setting volume to same value 100.
  2. Set volume on actual device to 40%. SayIt will change to 100%, play the TTS message, then revert volume to what it was. In log we see Nest Mini - set volume to 100, TTS, Nest Mini - set volume to 50.
  3. Set volume via state (sayit.0.tts.volume) to something other than 100%. This does not work. The announcement is still always played at 100% volume (same as 1. or 2. depending on what the actual device was set to before).

Furthermore, setting the volume of this device from the appropriate Chromecast adapter state (chromecast.0.xxxxxxxxxxxx.player.volume) works perfectly and the devices changes volume in real time.

This seems to point to the fact that there is a bug in the SayIt adapter where it is not correctly passing the volume in sayit.0.tts.volume to a Chromecast device before playing the TTS.

raintonr avatar Dec 28 '22 08:12 raintonr