home-assistant / core

:house_with_garden: Open source home automation that puts local control and privacy first.
https://www.home-assistant.io
Apache License 2.0
72.63k stars 30.39k forks source link

Shelly 2.5 switches unavailable in HA when upgrading to 0.118.4 with Shelly vanilla firmware ⩾ 1.9.0 #43740

Closed fvinas closed 3 years ago

fvinas commented 3 years ago

The problem

When upgrading from 0.117(.?) to 0.118.4, my Shelly 2.5 devices (FW 1.9.2) became unavailable. To be more precise:

Environment

Problem-relevant configuration.yaml

No specifics in configuration.yaml at this stage.

Traceback/Error logs

2020-11-29 11:01:45 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 11:01:56 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 11:01:56 WARNING (MainThread) [homeassistant.config_entries] Config entry for shelly not ready yet. Retrying in 80 seconds
2020-11-29 11:01:56 WARNING (MainThread) [homeassistant.config_entries] Config entry for shelly not ready yet. Retrying in 80 seconds
2020-11-29 11:01:56 WARNING (MainThread) [homeassistant.config_entries] Config entry for shelly not ready yet. Retrying in 80 seconds
2020-11-29 11:02:00 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 11:02:00 WARNING (MainThread) [homeassistant.config_entries] Config entry for shelly not ready yet. Retrying in 80 seconds
2020-11-29 11:02:00 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 11:02:00 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data

Manually updated lines refer to Shelly devices that still work with HA (I just hide their names), while – I guess – the four Config entry for shelly not ready yet lines refer to the failing interfacing of the 2.5 switches. Of course this log extract happens very periodically within the core container.

Additional information

Shelly 2.5 upgraded to last firmware 20201128-102046/v1.9.2 Working Shelly Dimmers & 1 upgraded to last firmware 20201124-092706/v1.9.0 Cannot say if 0.118.4 did work with previous version of the Shelly firmwares since I updated all at once (my bad).

probot-home-assistant[bot] commented 3 years ago

Hey there @balloob, @bieniu, @thecode, mind taking a look at this issue as its been labeled with an integration (shelly) you are listed as a codeowner for? Thanks! (message by CodeOwnersMention)

bieniu commented 3 years ago

Config entry for shelly not ready yet means the device is not accessible at HA start. Please remove those devices from HA and try to add them again and post the log if errors occur.

chemelli74 commented 3 years ago

Sorry cannot confirm, Shelly 2.5 with 1.9.2 both in relay and roller mode works fine here.

Can you please add info logging and show home-assistant.log from the beginning ?

Simone

fvinas commented 3 years ago

Thank you both for your help; I removed the 2.5 switches from HA and they are discovered and proposed in the Integrations page, but adding leads to a Failed to connect error message – no associated entry in the core logs.

Configuration is:

logger:
  logs:
    homeassistant.components.shelly: debug
    aioshelly: debug

shelly:
  discovery: true
  # version: true # add version sensor
  sensors: # sensors to show, can be override on each device
    - current_consumption
    - total_consumption
    - switch
    - over_power
    - over_temp

Here is a (quasi-) full dump of the logs – just dropped irrelevant & private lines (remaining Config entry for shelly not ready yet is a priori coming from a Shelly DW2 that I didn't fully install yet):


2020-11-29 13:37:03 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant.
2020-11-29 13:37:03 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for fontawesome which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant.
2020-11-29 13:37:03 INFO (MainThread) [homeassistant.setup] Setup of domain logger took 0.0 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up recorder
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up http
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain http took 0.0 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up system_log
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain system_log took 0.0 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain recorder took 0.3 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.bootstrap] Setting up stage 1: {'device_automation', 'hassio', 'auth', 'lovelace', 'image', 'cloud', 'search', 'http', 'webhook', 'onboarding', 'system_log', 'alexa', 'frontend', 'config', 'websocket_api', 'person', 'api'}
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up device_automation
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain device_automation took 0.0 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up hassio
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up auth
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain auth took 0.0 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up lovelace
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up image
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up webhook
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain webhook took 0.0 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up alexa
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain alexa took 0.0 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up config
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up websocket_api
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain websocket_api took 0.0 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setting up api
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain api took 0.0 seconds
2020-11-29 13:37:04 INFO (MainThread) [homeassistant.setup] Setup of domain config took 0.1 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setting up cloud
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setup of domain image took 0.9 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setting up search
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setup of domain search took 0.0 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setup of domain lovelace took 0.9 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setting up person
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setup of domain cloud took 0.1 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setup of domain person took 0.1 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setting up onboarding
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setup of domain onboarding took 0.0 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setting up frontend
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setup of domain frontend took 0.0 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setup of domain hassio took 1.4 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.bootstrap] Setting up stage 2: {'met', 'light', 'map', 'zwave', 'hacs', 'input_datetime', 'unifi', 'logbook', 'zone', 'automation', 'counter', 'discovery', 'tplink', 'switch', 'input_number', 'default_config', 'python_script', 'sun', 'timer', 'binary_sensor', 'sensor', 'notify', 'input_boolean', 'shelly', 'input_text', 'history', 'tag', 'updater', 'ssdp', 'script', 'zeroconf', 'rfxtrx', 'blueprint', 'media_source', 'group', 'input_select', 'scene', 'fontawesome', 'persistent_notification', 'media_player', 'system_health', 'device_tracker', 'synology_dsm', 'cover', 'twilio', 'ios', 'mobile_app'}
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setting up met
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setup of domain met took 0.0 seconds
2020-11-29 13:37:05 INFO (MainThread) [homeassistant.setup] Setting up light
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up map
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain map took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up zwave
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain zwave took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up input_datetime
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up unifi
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up logbook
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up zone
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up counter
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up tplink
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain tplink took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up switch
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain switch took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up input_number
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up python_script
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up sun
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain sun took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up timer
2020-11-29 13:37:06 INFO (SyncWorker_5) [homeassistant.loader] Loaded workday from homeassistant.components.workday
2020-11-29 13:37:06 INFO (SyncWorker_3) [homeassistant.loader] Loaded template from homeassistant.components.template
2020-11-29 13:37:06 INFO (SyncWorker_3) [homeassistant.loader] Loaded smtp from homeassistant.components.smtp
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up input_boolean
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up shelly
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain shelly took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up input_text
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up history
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain history took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up tag
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up updater
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain updater took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up zeroconf
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up rfxtrx
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain rfxtrx took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up blueprint
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain blueprint took 0.0 seconds
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up media_source
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up group
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up input_select
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up scene
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up fontawesome
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain fontawesome took 0.0 seconds
2020-11-29 13:37:06 INFO (SyncWorker_0) [homeassistant.loader] Loaded soundtouch from homeassistant.components.soundtouch
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up system_health
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setting up twilio
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain twilio took 0.0 seconds
2020-11-29 13:37:06 INFO (SyncWorker_11) [homeassistant.loader] Loaded command_line from homeassistant.components.command_line
2020-11-29 13:37:06 INFO (MainThread) [homeassistant.setup] Setup of domain light took 0.3 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.light] Setting up light.switch
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.light] Setting up light.switch
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.light] Setting up light.switch
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setting up binary_sensor
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain binary_sensor took 0.0 seconds
2020-11-29 13:37:07 INFO (SyncWorker_10) [homeassistant.loader] Loaded twilio_sms from homeassistant.components.twilio_sms
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain zeroconf took 1.5 seconds
2020-11-29 13:37:07 DEBUG (Thread-5) [RFXtrx] Send: 0x0d 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setting up hacs
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain hacs took 0.0 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setting up cover
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain cover took 0.0 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain logbook took 1.8 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.workday
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.workday
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.workday
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.workday
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.workday
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.workday
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain media_source took 1.7 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain group took 1.7 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain scene took 1.7 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain system_health took 1.7 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setting up synology_dsm
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain synology_dsm took 0.0 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain unifi took 1.9 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.components.cover] Setting up cover.command_line
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain counter took 1.9 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain input_number took 1.9 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain timer took 1.8 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain input_text took 1.8 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain input_boolean took 1.8 seconds
2020-11-29 13:37:07 INFO (MainThread) [homeassistant.setup] Setup of domain tag took 1.8 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up sensor
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain sensor took 0.0 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain python_script took 2.2 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.light] Setting up light.group
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up media_player
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain media_player took 0.0 seconds
2020-11-29 13:37:08 INFO (SyncWorker_14) [homeassistant.loader] Loaded climate from homeassistant.components.climate
2020-11-29 13:37:08 INFO (SyncWorker_11) [homeassistant.loader] Loaded fan from homeassistant.components.fan
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.updater
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.template
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up script
2020-11-29 13:37:08 INFO (SyncWorker_9) [homeassistant.loader] Loaded lock from homeassistant.components.lock
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.soundtouch
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain zone took 2.7 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.zwave
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.cover] Setting up cover.zwave
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.light] Setting up light.zwave
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.zwave
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up notify
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up discovery
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain discovery took 0.0 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up ssdp
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain ssdp took 0.0 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up climate
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain climate took 0.0 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up fan
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain fan took 0.0 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.notify] Setting up notify.twilio_sms
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.notify] Setting up notify.smtp
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up lock
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain lock took 0.0 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain script took 0.1 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.climate] Setting up climate.zwave
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.fan] Setting up fan.zwave
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.lock] Setting up lock.zwave
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.rfxtrx
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.light] Setting up light.rfxtrx
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.rfxtrx
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.components.cover] Setting up cover.rfxtrx
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up device_tracker
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain input_datetime took 2.9 seconds
2020-11-29 13:37:08 INFO (MainThread) [custom_components.hacs]
-------------------------------------------------------------------
HACS (Home Assistant Community Store)

Version: 1.6.2
This is a custom integration
If you have any issues with this you need to open an issue here:
https://github.com/hacs/integration/issues
-------------------------------------------------------------------

2020-11-29 13:37:08 INFO (MainThread) [custom_components.hacs] Setup task HacsSetupTask.WEBSOCKET
2020-11-29 13:37:08 INFO (MainThread) [custom_components.hacs] Setup task HacsSetupTask.FRONTEND
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain device_tracker took 0.0 seconds
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setting up automation
2020-11-29 13:37:08 INFO (MainThread) [homeassistant.setup] Setup of domain input_select took 2.7 seconds
2020-11-29 13:37:08 INFO (MainThread) [custom_components.hacs] Setup task HacsSetupTask.CATEGORIES
2020-11-29 13:37:09 INFO (MainThread) [homeassistant.setup] Setting up ios
2020-11-29 13:37:09 INFO (MainThread) [homeassistant.setup] Setup of domain ios took 0.1 seconds
2020-11-29 13:37:09 INFO (MainThread) [homeassistant.setup] Setup of domain automation took 0.2 seconds
2020-11-29 13:37:09 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.ios
2020-11-29 13:37:09 INFO (MainThread) [homeassistant.components.updater] Submitted analytics to Home Assistant servers. Information submitted includes {}
2020-11-29 13:37:09 INFO (MainThread) [homeassistant.setup] Setup of domain notify took 1.1 seconds
2020-11-29 13:37:09 INFO (SyncWorker_4) [homeassistant.loader] Loaded weather from homeassistant.components.weather
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.setup] Setting up weather
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.setup] Setup of domain weather took 0.0 seconds
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.components.notify] Setting up notify.ios
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.components.weather] Setting up weather.met
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.setup] Setting up mobile_app
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.setup] Setup of domain mobile_app took 0.1 seconds
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.components.notify] Setting up notify.mobile_app
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mobile_app
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.mobile_app
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.components.device_tracker] Setting up device_tracker.mobile_app
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.setup] Setting up default_config
2020-11-29 13:37:10 INFO (SyncWorker_3) [homeassistant.loader] Loaded stream from homeassistant.components.stream
2020-11-29 13:37:10 INFO (MainThread) [custom_components.hacs] Setup task HacsSetupTask.HACS_REPO
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.setup] Setting up stream
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.setup] Setup of domain stream took 0.0 seconds
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.setup] Setup of domain default_config took 0.1 seconds
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.components.device_tracker] Setting up device_tracker.unifi
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.unifi
2020-11-29 13:37:10 INFO (MainThread) [homeassistant.components.tplink.common] Discovered 2 TP-Link smart home device(s)
2020-11-29 13:37:11 INFO (MainThread) [custom_components.hacs.repository.integration.hacs.integration] Registration completed
2020-11-29 13:37:11 INFO (MainThread) [custom_components.hacs.data] Restore started
2020-11-29 13:37:12 WARNING (MainThread) [homeassistant.config_entries] Config entry for shelly not ready yet. Retrying in 5 seconds
2020-11-29 13:37:12 INFO (MainThread) [custom_components.hacs.data] Restore done
2020-11-29 13:37:12 INFO (MainThread) [custom_components.hacs] Setup task HacsSetupTask.SENSOR
2020-11-29 13:37:12 INFO (MainThread) [custom_components.hacs] Stage changed: HacsStage.WAITING
2020-11-29 13:37:12 INFO (MainThread) [custom_components.hacs] Setup complete, waiting for Home Assistant before startup tasks starts
2020-11-29 13:37:12 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.hacs
2020-11-29 13:37:14 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:14 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:15 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:18 WARNING (MainThread) [homeassistant.config_entries] Config entry for shelly not ready yet. Retrying in 5 seconds
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.cover] Setting up cover.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.light] Setting up light.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.cover] Setting up cover.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.light] Setting up light.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.cover] Setting up cover.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.light] Setting up light.shelly
2020-11-29 13:37:18 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.shelly
2020-11-29 13:37:20 WARNING (MainThread) [homeassistant.config_entries] Config entry for shelly not ready yet. Retrying in 10 seconds
2020-11-29 13:37:20 INFO (MainThread) [homeassistant.bootstrap] Home Assistant initialized in 16.75s
2020-11-29 13:37:20 INFO (MainThread) [homeassistant.core] Starting Home Assistant
2020-11-29 13:37:20 INFO (SyncWorker_0) [openzwave] Start Openzwave network.
2020-11-29 13:37:20 INFO (Dummy-6) [openzwave] Driver ready using library Static Controller version Z-Wave 4.54
2020-11-29 13:37:20 INFO (Dummy-6) [openzwave] home_id 0xd0d51e45, controller node id is 1
2020-11-29 13:37:20 INFO (SyncWorker_46) [homeassistant.components.zeroconf] Starting Zeroconf broadcast
2020-11-29 13:37:20 WARNING (SyncWorker_46) [zeroconf] Error sending through socket 11
Traceback (most recent call last):
  File "/usr/local/lib/python3.8/site-packages/zeroconf/__init__.py", line 2914, in send
    bytes_sent = s.sendto(packet, 0, (real_addr, port))
OSError: [Errno 126] No error information
2020-11-29 13:37:21 INFO (MainThread) [homeassistant.core] Timer:starting
2020-11-29 13:37:21 INFO (MainThread) [custom_components.hacs] Stage changed: HacsStage.STARTUP
2020-11-29 13:37:21 INFO (MainThread) [custom_components.hacs] setup task HacsSetupTask.CATEGORIES
2020-11-29 13:37:21 INFO (MainThread) [custom_components.hacs] Loading known repositories
2020-11-29 13:37:24 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:24 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.shelly
2020-11-29 13:37:24 INFO (MainThread) [homeassistant.components.cover] Setting up cover.shelly
2020-11-29 13:37:24 INFO (MainThread) [homeassistant.components.light] Setting up light.shelly
2020-11-29 13:37:24 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.shelly
2020-11-29 13:37:24 INFO (SyncWorker_3) [homeassistant.loader] Loaded ipp from homeassistant.components.ipp
2020-11-29 13:37:29 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:29 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:30 INFO (MainThread) [custom_components.hacs] Stage changed: HacsStage.RUNNING
2020-11-29 13:37:30 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:33 WARNING (MainThread) [homeassistant.config_entries] Config entry for shelly not ready yet. Retrying in 20 seconds
2020-11-29 13:37:36 INFO (SyncWorker_38) [homeassistant.loader] Loaded upnp from homeassistant.components.upnp
2020-11-29 13:37:39 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:44 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:44 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:45 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:54 DEBUG (MainThread) [homeassistant.components.shelly] Manually updated <hidden> data
2020-11-29 13:37:56 WARNING (MainThread) [homeassistant.config_entries] Config entry for shelly not ready yet. Retrying in 40 seconds
…
bieniu commented 3 years ago
shelly:
  discovery: true
  # version: true # add version sensor
  sensors: # sensors to show, can be override on each device
    - current_consumption
    - total_consumption
    - switch
    - over_power
    - over_temp

Shelly integration doesn't support yaml configuration. Maybe this is for ShellyForHass?

fvinas commented 3 years ago

Thank you again and good spot 👍 , I copied it somewhere while splitting up my config file but it had no effect - just dropped it to get a cleaner config file :-).

Still since I'm using the Shelly integration the issue remains there (Shelly 2.5 discovered but couldn't add them).

fvinas commented 3 years ago

One additional element: I just added a Shelly Dimmer 2 (FW 1.9.0) with no issue at all, while the 2.5 switches (FW 1.9.2) are all discovered but with no way to be added. All (working & not working) are connected to the same WiFi network and VLAN.

bieniu commented 3 years ago

Could you downgrade firmware to 1.9.0 on one of the problematic devices?

thecode commented 3 years ago

You can downgrade using this url: http://`__ip__`/ota?url=http://archive.shelly-faq.de/version/v1.9.0/SHSW-25.zip Replace __ip__ with your device IP address.

fvinas commented 3 years ago

Didn't work neither when downgrading FW to 1.9.0 but it works again with 1.8.5 (while 1.9.0 is working with the other devices apart 2.5 Switches).

fvinas commented 3 years ago

(EDIT: changed title to reflect this finding regarding firmware version)

thecode commented 3 years ago

@fvinas We are trying to discuss this with Shelly devs, Can you upgrade 1 device to 1.9.0 and confirm that only 1.8.5 is working for you? There are no other reports of 1.9.0 causing problems. Please also reboot the device after and if possible update 2 devices just to make sure

fvinas commented 3 years ago

@thecode thank you, just upgraded two Shelly 2.5 1.8.5 that were working with HA to 1.9.0, rebooted and confirm both are discovered but cannot be added.

chemelli74 commented 3 years ago

@thecode thank you, just upgraded two Shelly 2.5 1.8.5 that were working with HA to 1.9.0, rebooted and confirm both are discovered but cannot be added.

Can you please show a screenshot of the error you receive while trying to add the device ?

Simone

fvinas commented 3 years ago

@chemelli74, sure, please find it below:

image

then when clicking the Submit button, it rotates for a few seconds, then:

image

chemelli74 commented 3 years ago

@fvinas, do you have access to ssh on your HA ? Can you replace 1 file if we provide it ?

Simone

bieniu commented 3 years ago

Or we can prepare a custom component for you with a modified file?

fvinas commented 3 years ago

of course 👍 happy to help!

bieniu commented 3 years ago

I've prepared a modified integration for you. You can use it as a custom component or replace config_flow.py and __init__.py in your HA installation. Repo: https://github.com/bieniu/ha-shelly-test-1.9.2

fvinas commented 3 years ago

I used it as a custom component but it doesn't change (HA discovered but was unable to connect to a Shelly 2.5 equipped with FW 1.9.0).

thecode commented 3 years ago

In addition if you want to test, this is a prerelease version FW for Shelly 2.5, I tested it locally on my setup, but I do not experience any errors with 1.9.x. It has a small change in cloud connection which might cause problems: http://**__ip__**/ota?url=http://repo.shelly.cloud/firmware/rc/SHSW-25.zip

bieniu commented 3 years ago

there should be a lot more info about shelly in the log with this custom version of the integration. Please post the log.

fvinas commented 3 years ago

@thecode: nope doesn't work neither with 1.9.3-rc1

@bieniu: I've put the custom component in debug loglevel, but no more than a mere: 2020-11-30 16:59:24 ERROR (MainThread) [custom_components.shelly.config_flow] (this is what happens when it goes wrong, I can post other pieces of shelly logs but couldn't see anything I could relate to the issue)

chemelli74 commented 3 years ago

@fvinas can you tell us more about your network ? For example how many vlans ? Is there anything like proxy, firewall, etc. ?

I see you are on Synology community package, what model of Syno are you on ?

Simone

chemelli74 commented 3 years ago

One more question are you device on DHCP or on fixed ip ?

Simone

fvinas commented 3 years ago

@chemelli74 HA is running inside a Synology DS918+ box within this Hass.io package https://community.home-assistant.io/t/hass-io-on-synology-dsm-native-package/125559, which manages the fleet of containers (core, supervisor, dns, multicast, …) and its docker network. I'm using only 1 (default) VLAN and all these tests are running with Synology firewall disabled. No proxy in between neither. All Shellys are configured with static IPs and a backup WiFi network as well (I tested with a DHCP conf but didn't work neither, also it doesn't seem to be an IP issue as it works like a charm from the Shelly UI for instance). No MQTT, no cloud enable on the Shelly itself.

Please find below a tcpdump trace run from the Syno:

# tcpdump 'ip host 192.168.185.198 and tcp port 80' -vv
tcpdump: listening on eth0, link-type EN10MB (Ethernet), capture size 262144 bytes

20:48:21.365329 IP (tos 0x0, ttl 64, id 10523, offset 0, flags [DF], proto TCP (6), length 60)
    patator.51010 > parents-radiateur.http: Flags [S], cksum 0xf47e (incorrect -> 0x39ab), seq 246353573, win 29200, options [mss 1460,sackOK,TS val 2605655998 ecr 0,nop,wscale 7], length 0
20:48:21.410126 IP (tos 0x0, ttl 255, id 4272, offset 0, flags [none], proto TCP (6), length 48)
    parents-radiateur.http > patator.51010: Flags [S.], cksum 0x60c6 (correct), seq 672835, ack 246353574, win 2144, options [mss 536,nop,nop,sackOK], length 0
20:48:21.410168 IP (tos 0x0, ttl 64, id 10524, offset 0, flags [DF], proto TCP (6), length 40)
    patator.51010 > parents-radiateur.http: Flags [.], cksum 0xf46a (incorrect -> 0x203e), seq 1, ack 1, win 29200, length 0
20:48:21.411130 IP (tos 0x0, ttl 64, id 10525, offset 0, flags [DF], proto TCP (6), length 192)
    patator.51010 > parents-radiateur.http: Flags [P.], cksum 0xf502 (incorrect -> 0x0299), seq 1:153, ack 1, win 29200, length 152: HTTP, length: 152
    GET /shelly HTTP/1.1
    Host: 192.168.185.198
    User-Agent: HomeAssistant/0.118.4 aiohttp/3.7.1 Python/3.8
    Accept: */*
    Accept-Encoding: gzip, deflate

20:48:21.460868 IP (tos 0x0, ttl 255, id 4273, offset 0, flags [none], proto TCP (6), length 309)
    parents-radiateur.http > patator.51010: Flags [P.], cksum 0x6b4f (correct), seq 1:270, ack 153, win 1992, length 269: HTTP, length: 269
    HTTP/1.1 200 OK
    Server: Mongoose/6.11
    Connection: close
    Content-Type: application/json
    Content-Length: 155

    {"type":"SHSW-25","mac":"<hidden>","auth":false,"fw":"20201130-100223/v1.9.3-rc1@d221241b","longid":1,"num_outputs":2, "num_meters":2, "num_rollers":1}[!http]
20:48:21.460910 IP (tos 0x0, ttl 64, id 10526, offset 0, flags [DF], proto TCP (6), length 40)
    patator.51010 > parents-radiateur.http: Flags [.], cksum 0xf46a (incorrect -> 0x1b69), seq 153, ack 270, win 30016, length 0
20:48:21.462040 IP (tos 0x0, ttl 64, id 10527, offset 0, flags [DF], proto TCP (6), length 40)
    patator.51010 > parents-radiateur.http: Flags [F.], cksum 0xf46a (incorrect -> 0x1b68), seq 153, ack 270, win 30016, length 0
20:48:21.547390 IP (tos 0x0, ttl 255, id 4274, offset 0, flags [none], proto TCP (6), length 40)
    parents-radiateur.http > patator.51010: Flags [F.], cksum 0x88e0 (correct), seq 270, ack 153, win 1992, length 0
20:48:21.547454 IP (tos 0x0, ttl 64, id 10528, offset 0, flags [DF], proto TCP (6), length 40)
    patator.51010 > parents-radiateur.http: Flags [.], cksum 0xf46a (incorrect -> 0x1b67), seq 154, ack 271, win 30016, length 0
20:48:21.707175 IP (tos 0x0, ttl 64, id 10529, offset 0, flags [DF], proto TCP (6), length 40)
    patator.51010 > parents-radiateur.http: Flags [F.], cksum 0xf46a (incorrect -> 0x1b67), seq 153, ack 271, win 30016, length 0
20:48:21.724735 IP (tos 0x0, ttl 255, id 4276, offset 0, flags [none], proto TCP (6), length 40)
    parents-radiateur.http > patator.51010: Flags [.], cksum 0x88e0 (correct), seq 271, ack 154, win 1991, length 0
20:48:21.726944 IP (tos 0x0, ttl 255, id 4277, offset 0, flags [none], proto TCP (6), length 40)
    parents-radiateur.http > patator.51010: Flags [.], cksum 0x88e0 (correct), seq 271, ack 154, win 1991, length 0
thecode commented 3 years ago

I've found the root cause you are experiencing with firmware versions >1.8.5 for Shelly 2.5 The events from the device are based on UDP CoAP message, this message was increased in version 1.9.0 in order to provide future functionally for the device. Due to this increase this UDP packet is fragmented into two packets and reassembled, some systems does not reassemble this packet correctly. Please record traffic from device IP and port 5683. In addition try to check if this is a known issue for your system and what are the options to fix it. I'm discussing with Shelly Devs what can be done to overcome this problem in another way. If you have Shelly 3EM, it is already using a large CoAP packet and should not work for you.

fvinas commented 3 years ago

Good spot @thecode ! 👍

I can confirm, from the Syno a ping with 1500 (or less) bytes goes fine, while the same with 1501+ bytes fails, while it works from my laptop even with a higher size like 1800 bytes.

From the Syno:

ash-4.3# ping -s 1472 192.168.185.198
PING 192.168.185.198 (192.168.185.198) 1472(1500) bytes of data.
1480 bytes from 192.168.185.198: icmp_seq=1 ttl=255 time=71.7 ms
1480 bytes from 192.168.185.198: icmp_seq=2 ttl=255 time=39.6 ms
^C
--- 192.168.185.198 ping statistics ---
2 packets transmitted, 2 received, 0% packet loss, time 1001ms
rtt min/avg/max/mdev = 39.660/55.723/71.787/16.065 ms
ash-4.3# ping -s 1473 192.168.185.198
PING 192.168.185.198 (192.168.185.198) 1473(1501) bytes of data.
^C
--- 192.168.185.198 ping statistics ---
27 packets transmitted, 0 received, 100% packet loss, time 25999ms

Increasing the Syno eth0 MTU to somewhere above 1500 doesn't seem to change it, will investigate.

Let me know if you need additional elements that could be of help?

fvinas commented 3 years ago

And some UDP traces (I dropped advertising frames):

ash-4.3# tcpdump 'ip host 192.168.185.47 and udp port 5683' -vv
tcpdump: listening on eth0, link-type EN10MB (Ethernet), capture size 262144 bytes

22:09:43.962994 IP (tos 0x0, ttl 64, id 28322, offset 0, flags [DF], proto UDP (17), length 39)
    patator.5683 > antoine-radiateur.5683: [bad udp cksum 0xf3dd -> 0x7260!] UDP, length 11
22:09:44.046624 IP (tos 0x0, ttl 255, id 1683, offset 0, flags [none], proto UDP (17), length 1177)
    antoine-radiateur.5683 > patator.5683: [udp sum ok] UDP, length 1149
22:09:44.047416 IP (tos 0x0, ttl 64, id 28405, offset 0, flags [DF], proto UDP (17), length 39)
    patator.5683 > antoine-radiateur.5683: [bad udp cksum 0xf3dd -> 0x7251!] UDP, length 11
22:09:44.056917 IP (tos 0x0, ttl 255, id 1685, offset 0, flags [none], proto UDP (17), length 299)
    antoine-radiateur.5683 > patator.5683: [udp sum ok] UDP, length 271
22:09:45.864727 IP (tos 0x0, ttl 64, id 28766, offset 0, flags [DF], proto UDP (17), length 39)
    patator.5683 > antoine-radiateur.5683: [bad udp cksum 0xf3dd -> 0x7260!] UDP, length 11
22:09:45.894776 IP (tos 0x0, ttl 255, id 1705, offset 0, flags [none], proto UDP (17), length 1177)
    antoine-radiateur.5683 > patator.5683: [udp sum ok] UDP, length 1149
22:09:45.895435 IP (tos 0x0, ttl 64, id 28792, offset 0, flags [DF], proto UDP (17), length 39)
    patator.5683 > antoine-radiateur.5683: [bad udp cksum 0xf3dd -> 0x7251!] UDP, length 11
22:10:00.860918 IP (tos 0x0, ttl 64, id 33787, offset 0, flags [DF], proto UDP (17), length 39)
    patator.5683 > antoine-radiateur.5683: [bad udp cksum 0xf3dd -> 0x7260!] UDP, length 11
22:10:00.879612 IP (tos 0x0, ttl 255, id 1728, offset 0, flags [none], proto UDP (17), length 1177)
    antoine-radiateur.5683 > patator.5683: [udp sum ok] UDP, length 1149
22:10:00.880193 IP (tos 0x0, ttl 64, id 33797, offset 0, flags [DF], proto UDP (17), length 39)
    patator.5683 > antoine-radiateur.5683: [bad udp cksum 0xf3dd -> 0x7251!] UDP, length 11
22:10:00.929138 IP (tos 0x0, ttl 255, id 1729, offset 0, flags [none], proto UDP (17), length 299)
    antoine-radiateur.5683 > patator.5683: [udp sum ok] UDP, length 271
^C
14 packets captured
15 packets received by filter
0 packets dropped by kernel

ash-4.3# tcpdump 'ip host 192.168.185.198 and udp port 5683' -vv
tcpdump: listening on eth0, link-type EN10MB (Ethernet), capture size 262144 bytes

22:10:22.581315 IP (tos 0x0, ttl 64, id 43347, offset 0, flags [DF], proto UDP (17), length 39)
    patator.5683 > parents-radiateur.5683: [bad udp cksum 0xf474 -> 0x71c9!] UDP, length 11
22:10:22.641568 IP (tos 0x0, ttl 255, id 10739, offset 0, flags [+], proto UDP (17), length 1500)
    parents-radiateur.5683 > patator.5683: UDP, bad length 1485 > 1472 <===== !
thecode commented 3 years ago

You can update your Shelly 2.5 with the same URL as before, this should solve the problem for now, but I suggest to check why fragmented UDP packets are dropped on your system

fvinas commented 3 years ago

@thecode, I confirm this now works with FW 1.9.3-rc2, and will definitely investigate why these UDP fragmented packets are dropped (couldn't find anything relevant at this stage linked to some Synology OS specifics).

Thank you all for your help and time!

kaaspad commented 3 years ago

I know you guys closed this, but just wanted to say that I had the exact same problem. I have 60 Shelly devices at home, luckily only one out of the 60 is a shelly 2.5 setup as a relay (all others are setup as covers and then a bunch of dimmers). The only one that had a problem was the 2.5 setup as a relay - had the identical problem as @fvinas . I'm running 118.4 on a Virtual Box VM on windows. Network is Unifi UDM-Pro with separate VLAN for Shelly's (although they do connect to cloud) with two AP AC Pro's. Updating to 1.9.3-rc2 fixes the problem. Thankfully this was only on one switch.