Hello,
not sure if this is the right place for my question, if not maybe someone can point me in the right direction.
My issue is that, if at least one speaker out of the ones I defined statically is offline during startup, no other Sonos speaker are shown either.
I can reproduce this, if I e.g. pull the plug on one speaker, and restart HASS it takes abut 2 minutes till it eventually times out trying to reach this speaker. See the logs at the enf od my post.
Eventually, HASS starts up, but no Sonos speaker is shown. It’s seem to be either “all-or-nothing”, which is unfortunate for me. As I have the Sonos speaker and HASS not in the same subnet, I have to define the speakers statically, right?
If all speaker are online, everything works as expected. Startup is quick, and all three speakers are shown.
If it helps, I’m running HASS version 0.81.2, which today was the newest version available via PIP, inside a Fedor 28 linux container.
Any help is appreciated,
Ralph
Log:
Config directory: /root/.homeassistant
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded websocket_api from homeassistant.components.websocket_api
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.bootstrap] Home Assistant core initialized
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded mqtt from homeassistant.components.mqtt
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up mqtt
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain mqtt took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded frontend from homeassistant.components.frontend
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded api from homeassistant.components.api
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded http from homeassistant.components.http
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded system_log from homeassistant.components.system_log
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded auth from homeassistant.components.auth
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded onboarding from homeassistant.components.onboarding
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded lovelace from homeassistant.components.lovelace
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded history from homeassistant.components.history
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded recorder from homeassistant.components.recorder
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up lovelace
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain lovelace took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up http
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain http took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up recorder
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up api
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up websocket_api
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain websocket_api took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up system_log
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain system_log took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up auth
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain auth took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up onboarding
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain api took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain onboarding took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up frontend
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain recorder took 0.4 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain frontend took 0.4 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up history
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain history took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config from homeassistant.components.config
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded logbook from homeassistant.components.logbook
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded tts from homeassistant.components.tts
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded tts.google from homeassistant.components.tts.google
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded cloud from homeassistant.components.cloud
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded media_player from homeassistant.components.media_player
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded media_player.braviatv from homeassistant.components.media_player.braviatv
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded media_player.plex from homeassistant.components.media_player.plex
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded group from homeassistant.components.group
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up group
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain group took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded weather from homeassistant.components.weather
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded weather.darksky from homeassistant.components.weather.darksky
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up weather
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded sonos from homeassistant.components.sonos
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up sonos
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain sonos took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded map from homeassistant.components.map
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up map
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain map took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded automation from homeassistant.components.automation
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded updater from homeassistant.components.updater
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up updater
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded sun from homeassistant.components.sun
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up sun
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain sun took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded hue from homeassistant.components.hue
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up hue
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain hue took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded influxdb from homeassistant.components.influxdb
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up influxdb
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded sensor from homeassistant.components.sensor
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded sensor.sonarr from homeassistant.components.sensor.sonarr
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded sensor.nzbget from homeassistant.components.sensor.nzbget
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded sensor.mqtt from homeassistant.components.sensor.mqtt
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded sensor.influxdb from homeassistant.components.sensor.influxdb
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded sensor.season from homeassistant.components.sensor.season
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up sensor
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded history_graph from homeassistant.components.history_graph
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded conversation from homeassistant.components.conversation
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.components.weather] Setting up weather.darksky
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded persistent_notification from homeassistant.components.persistent_notification
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.sonarr
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.nzbget
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain updater took 0.1 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up config
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up logbook
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain logbook took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up media_player
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up automation
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain automation took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up history_graph
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setting up conversation
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.setup] Setup of domain conversation took 0.0 seconds.
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.device_registry from homeassistant.components.config.device_registry
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.auth_provider_homeassistant from homeassistant.components.config.auth_provider_homeassistant
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.core from homeassistant.components.config.core
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.entity_registry from homeassistant.components.config.entity_registry
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.group from homeassistant.components.config.group
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.hassbian from homeassistant.components.config.hassbian
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.config_entries from homeassistant.components.config.config_entries
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.script from homeassistant.components.config.script
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.automation from homeassistant.components.config.automation
2018-10-31 20:13:48 INFO (MainThread) [homeassistant.loader] Loaded config.auth from homeassistant.components.config.auth
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.loader] Loaded config.customize from homeassistant.components.config.customize
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mqtt
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setup of domain influxdb took 0.1 seconds.
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setup of domain config took 0.0 seconds.
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.season
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.influxdb
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setting up tts
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setting up cloud
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setup of domain cloud took 0.0 seconds.
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.braviatv
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setup of domain history_graph took 0.1 seconds.
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.braviatv
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.plex
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.braviatv
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setup of domain tts took 0.0 seconds.
2018-10-31 20:13:49 INFO (SyncWorker_2) [homeassistant.components.media_player.plex] Discovery configuration done (no token needed)
2018-10-31 20:13:49 INFO (SyncWorker_2) [homeassistant.components.media_player.plex] Connected to: http://192.168.1.132:32400
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.loader] Loaded light from homeassistant.components.light
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setting up light
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setup of domain light took 0.0 seconds.
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.loader] Loaded light.hue from homeassistant.components.light.hue
2018-10-31 20:13:49 INFO (SyncWorker_8) [braviarc.braviarc] {
"result": [],
"id": 1
}
2018-10-31 20:13:49 INFO (SyncWorker_3) [braviarc.braviarc] {
"result": [],
"id": 1
}
2018-10-31 20:13:49 INFO (SyncWorker_1) [homeassistant.components.sensor.influxdb] Rendering where: <homeassistant.helpers.template.Template object at 0x7f8c12d812b0>
2018-10-31 20:13:49 INFO (SyncWorker_1) [homeassistant.components.sensor.influxdb] Running query: select min(temperature) as value from "thermal" where "device" = 'weatherstation' and time > now() - 1h
2018-10-31 20:13:49 INFO (SyncWorker_6) [homeassistant.components.sensor.influxdb] Rendering where: <homeassistant.helpers.template.Template object at 0x7f8c12d810f0>
2018-10-31 20:13:49 INFO (SyncWorker_6) [homeassistant.components.sensor.influxdb] Running query: select last(temperature) as value from "thermal" where "device" = 'weatherstation'
2018-10-31 20:13:49 INFO (SyncWorker_5) [homeassistant.components.sensor.influxdb] Rendering where: <homeassistant.helpers.template.Template object at 0x7f8c12d81358>
2018-10-31 20:13:49 INFO (SyncWorker_5) [homeassistant.components.sensor.influxdb] Running query: select max(temperature) as value from "thermal" where "device" = 'weatherstation' and time > now() - 1h
2018-10-31 20:13:49 INFO (SyncWorker_0) [braviarc.braviarc] {
"result": [],
"id": 1
}
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setup of domain sensor took 0.4 seconds.
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.setup] Setup of domain media_player took 0.4 seconds.
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.loader] Loaded media_player.sonos from homeassistant.components.media_player.sonos
2018-10-31 20:13:49 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.sonos
Here it hangs about 2 minutes before it continues
2018-10-31 20:16:00 WARNING (MainThread) [homeassistant.components.weather] Setup of platform darksky is taking over 10 seconds.
2018-10-31 20:16:00 ERROR (MainThread) [homeassistant.components.hue] Error connecting to the Hue bridge at 192.168.2.135
2018-10-31 20:16:00 ERROR (MainThread) [homeassistant.components.hue] Error connecting to the Hue bridge at 192.168.2.135. Retrying in 2 seconds
2018-10-31 20:16:00 INFO (MainThread) [homeassistant.components.light] Setting up light.hue
2018-10-31 20:16:00 INFO (MainThread) [homeassistant.setup] Setup of domain weather took 131.4 seconds.
2018-10-31 20:16:00 INFO (MainThread) [homeassistant.bootstrap] Home Assistant initialized in 132.02s
2018-10-31 20:16:00 INFO (MainThread) [homeassistant.core] Starting Home Assistant
2018-10-31 20:16:00 INFO (MainThread) [homeassistant.core] Timer:starting
2018-10-31 20:16:01 INFO (SyncWorker_0) [homeassistant.components.sensor.influxdb] Rendering where: <homeassistant.helpers.template.Template object at 0x7f8c12d812b0>
2018-10-31 20:16:01 INFO (SyncWorker_0) [homeassistant.components.sensor.influxdb] Running query: select min(temperature) as value from "thermal" where "device" = 'weatherstation' and time > now() - 1h
2018-10-31 20:16:01 INFO (SyncWorker_2) [homeassistant.components.sensor.influxdb] Rendering where: <homeassistant.helpers.template.Template object at 0x7f8c12d81358>
2018-10-31 20:16:01 INFO (SyncWorker_2) [homeassistant.components.sensor.influxdb] Running query: select max(temperature) as value from "thermal" where "device" = 'weatherstation' and time > now() - 1h
2018-10-31 20:16:01 INFO (SyncWorker_6) [homeassistant.components.sensor.influxdb] Rendering where: <homeassistant.helpers.template.Template object at 0x7f8c12d810f0>
2018-10-31 20:16:01 INFO (SyncWorker_6) [homeassistant.components.sensor.influxdb] Running query: select last(temperature) as value from "thermal" where "device" = 'weatherstation'
2018-10-31 20:16:03 INFO (MainThread) [homeassistant.components.light] Setting up light.hue
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.components.http.view] Serving /api/websocket to 192.168.1.66 (auth: False)
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded ifttt from homeassistant.components.ifttt
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded hangouts from homeassistant.components.hangouts
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded cast from homeassistant.components.cast
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded zone from homeassistant.components.zone
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded unifi from homeassistant.components.unifi
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded zwave from homeassistant.components.zwave
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded deconz from homeassistant.components.deconz
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded nest from homeassistant.components.nest
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded upnp from homeassistant.components.upnp
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded lifx from homeassistant.components.lifx
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded tradfri from homeassistant.components.tradfri
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded openuv from homeassistant.components.openuv
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded smhi from homeassistant.components.smhi
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded ios from homeassistant.components.ios
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded homematicip_cloud from homeassistant.components.homematicip_cloud
2018-10-31 20:16:09 INFO (MainThread) [homeassistant.loader] Loaded simplisafe from homeassistant.components.simplisafe
2018-10-31 20:17:03 INFO (SyncWorker_7) [homeassistant.components.sensor.influxdb] Rendering where: <homeassistant.helpers.template.Template object at 0x7f8c12d81358>
2018-10-31 20:17:03 INFO (SyncWorker_7) [homeassistant.components.sensor.influxdb] Running query: select max(temperature) as value from "thermal" where "device" = 'weatherstation' and time > now() - 1h
2018-10-31 20:17:03 INFO (SyncWorker_8) [homeassistant.components.sensor.influxdb] Rendering where: <homeassistant.helpers.template.Template object at 0x7f8c12d810f0>
2018-10-31 20:17:03 INFO (SyncWorker_8) [homeassistant.components.sensor.influxdb] Running query: select last(temperature) as value from "thermal" where "device" = 'weatherstation'
2018-10-31 20:17:03 INFO (SyncWorker_3) [homeassistant.components.sensor.influxdb] Rendering where: <homeassistant.helpers.template.Template object at 0x7f8c12d812b0>
2018-10-31 20:17:03 INFO (SyncWorker_3) [homeassistant.components.sensor.influxdb] Running query: select min(temperature) as value from "thermal" where "device" = 'weatherstation' and time > now() - 1h
2018-10-31 20:17:06 INFO (MainThread) [homeassistant.components.http.view] Serving /api/websocket to 192.168.1.66 (auth: False)
2018-10-31 20:17:07 INFO (MainThread) [homeassistant.components.http.view] Serving /api/websocket to 192.168.1.66 (auth: False)
2018-10-31 20:17:13 INFO (MainThread) [homeassistant.components.http.view] Serving /api/history/period/2018-10-30T20:17:13.116Z to 192.168.1.66 (auth: True)
2018-10-31 20:17:13 INFO (MainThread) [homeassistant.components.http.view] Serving /api/history/period/2018-10-31T20:17:13.116Z to 192.168.1.66 (auth: True)
2018-10-31 20:17:18 INFO (MainThread) [homeassistant.components.http.view] Serving /api/history/period/2018-10-31T20:17:13.467Z to 192.168.1.66 (auth: True)
2018-10-31 20:17:23 INFO (MainThread) [homeassistant.components.http.view] Serving /api/history/period/2018-10-31T20:17:18.133Z to 192.168.1.66 (auth: True)