search

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
73.81k stars 30.9k forks source link

hdmi_cec fails with Exception in callback setup.<locals>._new_device #66199

Closed mmalina closed 2 years ago

mmalina commented 2 years ago

The problem

It seems the hdmi_cec integration is broken in HA Core 2022.2. It fails to load.

I am using a custom add-on for pycec, but the hdmi_cec integration won't even start.

What version of Home Assistant Core has the issue?

core-2022.2.5

What was the last working version of Home Assistant Core?

core-2021.12

What type of installation are you running?

Home Assistant OS

Integration causing the issue

hdmi_cec

Link to integration documentation on our website

https://www.home-assistant.io/integrations/hdmi_cec/

Diagnostics information

No response

Example YAML snippet

hdmi_cec:
  host: 58c14403-pi-cec
  devices:
    0: TV
    1: Pi
    2: Apple TV

Anything in the logs that might be useful for us?

Logger: homeassistant
Source: components/hdmi_cec/__init__.py:336 
First occurred: 6:09:16 PM (2 occurrences) 
Last logged: 6:09:16 PM

Error doing job: Exception in callback setup.<locals>._new_device(<pycec.networ...at 0x6dd21b68>) at /usr/src/homeassistant/homeassistant/components/hdmi_cec/__init__.py:333
Error doing job: Exception in callback setup.<locals>._new_device(<pycec.networ...at 0x6a82a3d0>) at /usr/src/homeassistant/homeassistant/components/hdmi_cec/__init__.py:333
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/asyncio/events.py", line 80, in _run
    self._context.run(self._callback, *self._args)
  File "/usr/src/homeassistant/homeassistant/components/hdmi_cec/__init__.py", line 336, in _new_device
    hass.data[DOMAIN][key] = device
KeyError: 'hdmi_cec'

Additional information

No response

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

hdmi_cec documentation hdmi_cec source (message by IssueLinks)

mmalina commented 2 years ago

I think this is a duplicate of https://github.com/home-assistant/core/issues/66106

It was supposed to be fixed in https://github.com/home-assistant/core/pull/66172 and init no longer fails, but the integration still doesn't work for me in 2022.2.6.

Now I'm getting this:

Logger: homeassistant.components.switch
Source: components/hdmi_cec/switch.py:30 
Integration: Switch ([documentation](https://www.home-assistant.io/integrations/switch), [issues](https://github.com/home-assistant/home-assistant/issues?q=is%3Aissue+is%3Aopen+label%3A%22integration%3A+switch%22)) 
First occurred: 10:14:02 AM (2 occurrences) 
Last logged: 10:14:02 AM

Error while setting up hdmi_cec platform for switch
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/helpers/entity_platform.py", line 249, in _async_setup_platform
    await asyncio.shield(task)
  File "/usr/local/lib/python3.9/concurrent/futures/thread.py", line 52, in run
    result = self.fn(*self.args, **self.kwargs)
  File "/usr/src/homeassistant/homeassistant/components/hdmi_cec/switch.py", line 30, in setup_platform
    hdmi_device = hass.data[DOMAIN][device]
TypeError: 'EntityComponent' object is not subscriptable

@hamper can you confirm?

Cc: @epenet

nick8888 commented 2 years ago

I'm getting same error as @mmalina above.

epenet commented 2 years ago

Could you please enable logging in your configuration and post the results?

logger:
  default: info
  logs:
    homeassistant.components.hdmi_cec: debug
mmalina commented 2 years ago

@epenet I did that and restarted HA (Settings -> Server Controls -> Restart). But I don't see any debug info logged in the log. I am still only seeing the same error that I posted above. Any suggestions?

mmalina commented 2 years ago

Sorry, I checked the full log now and there actually is something, but not much.

2022-02-14 10:48:17 INFO (MainThread) [homeassistant.setup] Setup of domain logger took 0.0 seconds
2022-02-14 10:48:17 INFO (MainThread) [homeassistant.setup] Setup of domain recorder took 0.2 seconds
2022-02-14 10:48:17 INFO (MainThread) [homeassistant.bootstrap] Setting up stage 1: {'http', 'config', 'device_automation', 'diagnostics', 'frontend', 'image', 'auth', 'person', 'system_log', 'api', 'websocket_api', 'webhook', 'search', 'hassio', 'onboarding', 'cloud', 'lovelace', 'analytics'}
2022-02-14 10:48:17 INFO (MainThread) [homeassistant.setup] Setting up http
2022-02-14 10:48:17 INFO (MainThread) [homeassistant.setup] Setting up device_automation
2022-02-14 10:48:17 INFO (MainThread) [homeassistant.setup] Setup of domain device_automation took 0.0 seconds
2022-02-14 10:48:17 INFO (MainThread) [homeassistant.setup] Setting up lovelace
2022-02-14 10:48:17 INFO (MainThread) [homeassistant.setup] Setup of domain lovelace took 0.0 seconds
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setup of domain http took 0.3 seconds
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setting up config
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setting up diagnostics
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setting up auth
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setup of domain auth took 0.0 seconds
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setting up api
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setup of domain api took 0.0 seconds
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setting up websocket_api
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setup of domain websocket_api took 0.0 seconds
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setting up webhook
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setup of domain webhook took 0.0 seconds
2022-02-14 10:48:18 INFO (MainThread) [homeassistant.setup] Setting up hassio
2022-02-14 10:48:19 INFO (MainThread) [homeassistant.setup] Setup of domain config took 1.2 seconds
2022-02-14 10:48:19 INFO (MainThread) [homeassistant.setup] Setup of domain diagnostics took 1.2 seconds
2022-02-14 10:48:19 INFO (MainThread) [homeassistant.setup] Setting up image
2022-02-14 10:48:19 INFO (MainThread) [homeassistant.setup] Setting up search
2022-02-14 10:48:19 INFO (MainThread) [homeassistant.setup] Setup of domain search took 0.0 seconds
2022-02-14 10:48:19 INFO (MainThread) [homeassistant.setup] Setting up analytics
2022-02-14 10:48:19 INFO (MainThread) [homeassistant.setup] Setup of domain image took 0.1 seconds
2022-02-14 10:48:19 INFO (MainThread) [homeassistant.setup] Setup of domain analytics took 0.0 seconds
2022-02-14 10:48:19 INFO (SyncWorker_0) [homeassistant.loader] Loaded google_assistant from homeassistant.components.google_assistant
2022-02-14 10:48:19 INFO (SyncWorker_4) [homeassistant.loader] Loaded alexa from homeassistant.components.alexa
2022-02-14 10:48:19 INFO (MainThread) [homeassistant.setup] Setting up person
2022-02-14 10:48:19 INFO (SyncWorker_2) [homeassistant.loader] Loaded media_player from homeassistant.components.media_player
2022-02-14 10:48:21 INFO (MainThread) [homeassistant.setup] Setting up cloud
2022-02-14 10:48:21 INFO (MainThread) [homeassistant.setup] Setup of domain person took 2.1 seconds
2022-02-14 10:48:21 INFO (MainThread) [homeassistant.setup] Setup of domain cloud took 0.1 seconds
2022-02-14 10:48:21 INFO (MainThread) [homeassistant.setup] Setting up onboarding
2022-02-14 10:48:21 INFO (MainThread) [homeassistant.helpers.storage] Migrating onboarding storage from 1.1 to 4.1
2022-02-14 10:48:21 INFO (MainThread) [homeassistant.setup] Setup of domain onboarding took 0.0 seconds
2022-02-14 10:48:21 INFO (SyncWorker_3) [homeassistant.loader] Loaded panel_custom from homeassistant.components.panel_custom
2022-02-14 10:48:21 INFO (MainThread) [homeassistant.setup] Setting up frontend
2022-02-14 10:48:21 INFO (MainThread) [homeassistant.setup] Setup of domain frontend took 0.0 seconds
2022-02-14 10:48:21 INFO (MainThread) [homeassistant.components.http] Now listening on port 8123
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setup of domain hassio took 5.7 seconds
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.bootstrap] Setting up stage 2: {'dhcp', 'group', 'updater', 'input_select', 'usb', 'hdmi_cec', 'cover', 'trace', 'mqtt', 'ssdp', 'input_datetime', 'ffmpeg', 'rest_command', 'weather', 'my', 'counter', 'panasonic_viera', 'input_number', 'automation', 'zone', 'onewire', 'sun', 'sensor', 'input_boolean', 'homekit', 'tasmota', 'switch', 'energy', 'input_text', 'mobile_app', 'deconz', 'light', 'system_health', 'blueprint', 'tts', 'tag', 'zeroconf', 'map', 'input_button', 'device_tracker', 'logbook', 'camera', 'media_source', 'default_config', 'timer', 'shelly', 'notify', 'hue', 'scene', 'script', 'history', 'climate', 'discovery', 'network', 'yamaha_musiccast'}
2022-02-14 10:48:24 INFO (SyncWorker_1) [homeassistant.loader] Loaded binary_sensor from homeassistant.components.binary_sensor
2022-02-14 10:48:24 INFO (SyncWorker_4) [homeassistant.loader] Loaded time_date from homeassistant.components.time_date
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up dhcp
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setup of domain dhcp took 0.0 seconds
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up group
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up updater
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setup of domain updater took 0.0 seconds
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up input_select
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up hdmi_cec
2022-02-14 10:48:24 DEBUG (SyncWorker_0) [homeassistant.components.hdmi_cec] Parsing config OrderedDict([(0, 'TV'), (1, 'Pi'), (2, 'Apple TV')])
2022-02-14 10:48:24 DEBUG (SyncWorker_0) [homeassistant.components.hdmi_cec] Parsed devices: {'TV': [0, 0, 0, 0], 'Pi': [1, 0, 0, 0], 'Apple TV': [2, 0, 0, 0]}
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up trace
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setup of domain trace took 0.0 seconds
2022-02-14 10:48:24 INFO (SyncWorker_3) [homeassistant.loader] Loaded template from homeassistant.components.template
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up input_datetime
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up ffmpeg
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up rest_command
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setup of domain rest_command took 0.0 seconds
2022-02-14 10:48:24 INFO (SyncWorker_1) [homeassistant.loader] Loaded darksky from homeassistant.components.darksky
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up my
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setup of domain my took 0.0 seconds
2022-02-14 10:48:24 INFO (MainThread) [homeassistant.setup] Setting up counter
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up panasonic_viera
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setup of domain panasonic_viera took 0.0 seconds
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up input_number
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up zone
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up onewire
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setup of domain onewire took 0.0 seconds
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up sun
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setup of domain sun took 0.1 seconds
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up input_boolean
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up input_text
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up light
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up system_health
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up blueprint
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setup of domain blueprint took 0.0 seconds
2022-02-14 10:48:25 INFO (MainThread) [homeassistant.setup] Setting up tag
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up map
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setup of domain map took 0.0 seconds
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up input_button
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up logbook
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up camera
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up media_source
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up timer
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up scene
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant
2022-02-14 10:48:26 INFO (SyncWorker_3) [homeassistant.loader] Loaded smtp from homeassistant.components.smtp
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up history
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setup of domain history took 0.0 seconds
2022-02-14 10:48:26 INFO (SyncWorker_4) [homeassistant.loader] Loaded generic_thermostat from homeassistant.components.generic_thermostat
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up binary_sensor
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setup of domain binary_sensor took 0.0 seconds
2022-02-14 10:48:26 INFO (SyncWorker_1) [homeassistant.loader] Loaded rest from homeassistant.components.rest
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up weather
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setup of domain weather took 0.0 seconds
2022-02-14 10:48:26 WARNING (MainThread) [homeassistant.components.onewire.onewirehub] Using the 1-Wire integration via SysBus is deprecated and will be removed in Home Assistant Core 2022.6; this integration is being adjusted to comply with Architectural Decision Record 0019, more information can be found here: https://github.com/home-assistant/architecture/blob/master/adr/0019-GPIO.md Access via OWServer is still supported
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setup of domain light took 0.5 seconds
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up notify
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setup of domain group took 1.9 seconds
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setting up usb
2022-02-14 10:48:26 INFO (MainThread) [homeassistant.setup] Setup of domain usb took 0.0 seconds
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.setup] Setting up mqtt
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.setup] Setup of domain mqtt took 0.0 seconds
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.components.weather] Setting up weather.darksky
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.setup] Setup of domain system_health took 1.0 seconds
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.setup] Setup of domain logbook took 1.0 seconds
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.setup] Setup of domain media_source took 1.0 seconds
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.setup] Setup of domain scene took 1.0 seconds
2022-02-14 10:48:27 INFO (SyncWorker_1) [homeassistant.loader] Loaded google_translate from homeassistant.components.google_translate
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.components.notify] Setting up notify.smtp
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.setup] Setting up network
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.setup] Setup of domain network took 0.0 seconds
2022-02-14 10:48:27 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.hassio
2022-02-14 10:48:28 INFO (MainThread) [homeassistant.setup] Setup of domain ffmpeg took 4.0 seconds
2022-02-14 10:48:28 INFO (MainThread) [homeassistant.setup] Setup of domain hdmi_cec took 4.0 seconds
2022-02-14 10:48:28 INFO (MainThread) [homeassistant.setup] Setting up energy
2022-02-14 10:48:28 INFO (MainThread) [homeassistant.setup] Setup of domain energy took 0.0 seconds
2022-02-14 10:48:28 INFO (MainThread) [homeassistant.components.light] Setting up light.group
2022-02-14 10:48:29 INFO (MainThread) [homeassistant.setup] Setting up cover
2022-02-14 10:48:29 INFO (MainThread) [homeassistant.setup] Setup of domain cover took 0.0 seconds
2022-02-14 10:48:29 INFO (MainThread) [homeassistant.setup] Setting up tts
2022-02-14 10:48:29 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.updater
2022-02-14 10:48:29 INFO (MainThread) [homeassistant.setup] Setting up switch
2022-02-14 10:48:29 INFO (MainThread) [homeassistant.setup] Setup of domain switch took 0.0 seconds
2022-02-14 10:48:29 INFO (MainThread) [homeassistant.setup] Setting up sensor
2022-02-14 10:48:29 INFO (MainThread) [homeassistant.setup] Setup of domain sensor took 0.0 seconds
2022-02-14 10:48:29 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.time_date
2022-02-14 10:48:29 INFO (Thread-3) [homeassistant.components.mqtt] Connected to MQTT server core-mosquitto:1883 (0)
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setting up template
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain template took 0.0 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain input_select took 5.4 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain input_number took 4.3 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain tag took 4.0 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.onewire
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.onewire
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.switch] Setting up switch.onewire
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain counter took 5.1 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain camera took 4.1 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setting up zeroconf
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.light] Setting up light.switch
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setting up rest
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain rest took 0.0 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.hassio
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setting up shelly
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain shelly took 0.0 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setting up climate
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain climate took 0.0 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.cover] Setting up cover.template
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.switch] Setting up switch.template
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.template
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.climate] Setting up climate.generic_thermostat
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setting up media_player
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.setup] Setup of domain media_player took 0.2 seconds
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.rest
2022-02-14 10:48:30 INFO (SyncWorker_4) [homeassistant.loader] Loaded remote from homeassistant.components.remote
2022-02-14 10:48:30 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.energy
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setup of domain input_text took 5.1 seconds
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setup of domain input_button took 5.0 seconds
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.components.shelly.utils] Starting CoAP context with UDP port 5683
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setup of domain zeroconf took 0.5 seconds
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setting up deconz
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setup of domain deconz took 0.0 seconds
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.panasonic_viera
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setting up remote
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setup of domain remote took 0.0 seconds
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setting up hue
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setup of domain hue took 0.0 seconds
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setup of domain timer took 5.8 seconds
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.setup] Setup of domain notify took 5.4 seconds
2022-02-14 10:48:31 INFO (MainThread) [homeassistant.components.remote] Setting up remote.panasonic_viera
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setup of domain tts took 2.6 seconds
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setting up ssdp
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setup of domain ssdp took 0.0 seconds
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setup of domain input_datetime took 7.3 seconds
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setting up homekit
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setup of domain homekit took 0.0 seconds
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setting up discovery
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setup of domain discovery took 0.0 seconds
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setup of domain input_boolean took 6.5 seconds
2022-02-14 10:48:32 INFO (MainThread) [homeassistant.setup] Setting up script
2022-02-14 10:48:34 INFO (MainThread) [homeassistant.setup] Setting up mobile_app
2022-02-14 10:48:34 INFO (MainThread) [homeassistant.setup] Setup of domain zone took 9.1 seconds
2022-02-14 10:48:35 INFO (MainThread) [homeassistant.setup] Setting up yamaha_musiccast
2022-02-14 10:48:35 INFO (MainThread) [homeassistant.setup] Setup of domain yamaha_musiccast took 0.0 seconds
2022-02-14 10:48:36 INFO (MainThread) [homeassistant.setup] Setting up device_tracker
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setup of domain mobile_app took 2.3 seconds
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.deconz
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.climate] Setting up climate.deconz
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.cover] Setting up cover.deconz
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.light] Setting up light.deconz
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.scene] Setting up scene.deconz
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.deconz
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.switch] Setting up switch.deconz
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.generic_thermostat.climate] Obtained current and target temperature. Generic thermostat active. 21.0, 20.5
2022-02-14 10:48:37 INFO (SyncWorker_2) [homeassistant.loader] Loaded fan from homeassistant.components.fan
2022-02-14 10:48:37 INFO (SyncWorker_0) [homeassistant.loader] Loaded lock from homeassistant.components.lock
2022-02-14 10:48:37 INFO (SyncWorker_3) [homeassistant.loader] Loaded alarm_control_panel from homeassistant.components.alarm_control_panel
2022-02-14 10:48:37 INFO (SyncWorker_5) [homeassistant.loader] Loaded number from homeassistant.components.number
2022-02-14 10:48:37 INFO (SyncWorker_6) [homeassistant.loader] Loaded siren from homeassistant.components.siren
2022-02-14 10:48:37 WARNING (MainThread) [aiohue.util] Value {} of type <class 'dict'> is invalid for Device.identify, expected value of type typing.Optional[aiohue.v2.models.feature.IdentifyFeature]
2022-02-14 10:48:37 WARNING (MainThread) [aiohue.util] Value {} of type <class 'dict'> is invalid for Device.identify, expected value of type typing.Optional[aiohue.v2.models.feature.IdentifyFeature]
2022-02-14 10:48:37 WARNING (MainThread) [aiohue.util] Value {} of type <class 'dict'> is invalid for Device.identify, expected value of type typing.Optional[aiohue.v2.models.feature.IdentifyFeature]
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setup of domain script took 4.9 seconds
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setting up fan
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setup of domain fan took 0.0 seconds
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setting up lock
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setup of domain lock took 0.0 seconds
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setting up alarm_control_panel
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setup of domain alarm_control_panel took 0.0 seconds
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setting up number
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setup of domain number took 0.0 seconds
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setting up siren
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setup of domain siren took 0.0 seconds
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setting up automation
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setting up tasmota
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.setup] Setup of domain tasmota took 0.0 seconds
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.notify] Setting up notify.mobile_app
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mobile_app
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.mobile_app
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mobile_app
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.mobile_app
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mobile_app
2022-02-14 10:48:37 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.mobile_app
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.fan] Setting up fan.deconz
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.lock] Setting up lock.deconz
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.alarm_control_panel] Setting up alarm_control_panel.deconz
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.number] Setting up number.deconz
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.siren] Setting up siren.deconz
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.hue
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.light] Setting up light.hue
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.scene] Setting up scene.hue
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.hue
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.switch] Setting up switch.hue
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.device_tracker] Setting up device_tracker.mqtt
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.tasmota
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.cover] Setting up cover.tasmota
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.fan] Setting up fan.tasmota
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.light] Setting up light.tasmota
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.tasmota
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.components.switch] Setting up switch.tasmota
2022-02-14 10:48:38 INFO (MainThread) [pydeconz.websocket] Connected to deCONZ (core-deconz)
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.setup] Setup of domain automation took 0.8 seconds
2022-02-14 10:48:38 INFO (MainThread) [homeassistant.setup] Setup of domain device_tracker took 1.6 seconds
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.setup] Setting up default_config
2022-02-14 10:48:39 INFO (SyncWorker_2) [homeassistant.loader] Loaded stream from homeassistant.components.stream
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.device_tracker] Setting up device_tracker.mobile_app
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.device_tracker] Setting up device_tracker.mobile_app
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.device_tracker] Setting up device_tracker.mobile_app
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.setup] Setting up stream
2022-02-14 10:48:39 INFO (SyncWorker_0) [homeassistant.loader] Loaded button from homeassistant.components.button
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.setup] Setup of domain stream took 0.0 seconds
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.setup] Setting up button
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.setup] Setup of domain button took 0.0 seconds
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.setup] Setup of domain default_config took 0.3 seconds
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.cover] Setting up cover.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.light] Setting up light.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.switch] Setting up switch.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.cover] Setting up cover.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.light] Setting up light.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.switch] Setting up switch.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.button] Setting up button.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.button] Setting up button.shelly
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.yamaha_musiccast
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.number] Setting up number.yamaha_musiccast
2022-02-14 10:48:39 INFO (SyncWorker_6) [homeassistant.loader] Loaded select from homeassistant.components.select
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.setup] Setting up select
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.setup] Setup of domain select took 0.0 seconds
2022-02-14 10:48:39 INFO (MainThread) [homeassistant.components.select] Setting up select.yamaha_musiccast
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.bootstrap] Home Assistant initialized in 25.11s
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.core] Starting Home Assistant
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.core] Timer:starting
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.zeroconf] Starting Zeroconf broadcast
2022-02-14 10:48:40 INFO (SyncWorker_1) [pycec] HDMI network starting...
2022-02-14 10:48:40 INFO (SyncWorker_3) [homeassistant.loader] Loaded spotify from homeassistant.components.spotify
2022-02-14 10:48:40 WARNING (SyncWorker_0) [pycec] Not initialized. Waiting for init.
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.tv_turned_on] Initialized trigger TV turned on
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.tv_turned_off] Initialized trigger TV turned off
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.lights_on_in_the_evening] Initialized trigger Lights on in the evening
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.sound_controller_volume_down] Initialized trigger Sound Controller Volume Down
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.sound_controller_volume_up] Initialized trigger Sound Controller Volume Up
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.sound_controller_volume_stop] Initialized trigger Sound Controller Volume Stop
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.sound_controller_switch_yamaha] Initialized trigger Sound Controller Turn On
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.lights_off] Initialized trigger Lights off
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.freezer_open_alert] Initialized trigger Freezer Open Alert
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.turn_off_heating] Initialized trigger Turn off heating
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.sound_controller_pause_resume_spotify] Initialized trigger Sound Controller Pause/Resume Spotify
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.sound_controller_mute_unmute] Initialized trigger Sound Controller Mute/Unmute
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.nightstand_switch_all_off] Initialized trigger Nightstand Switch Off
2022-02-14 10:48:40 INFO (MainThread) [homeassistant.components.automation.airplay_turned_off] Initialized trigger Airplay Turned Off
2022-02-14 10:48:41 INFO (MainThread) [pyhap.accessory_driver] Starting accessory Home Assistant Bridge on address 192.168.1.50, port 21063.
2022-02-14 10:48:41 INFO (SyncWorker_3) [homeassistant.loader] Loaded homekit_controller from homeassistant.components.homekit_controller
2022-02-14 10:48:41 INFO (SyncWorker_0) [homeassistant.loader] Loaded zha from homeassistant.components.zha
2022-02-14 10:48:41 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:48:55 INFO (SyncWorker_5) [homeassistant.loader] Loaded apple_tv from homeassistant.components.apple_tv
2022-02-14 10:48:58 INFO (MainThread) [homeassistant.components.switch] Setting up switch.hdmi_cec
2022-02-14 10:48:58 INFO (SyncWorker_4) [homeassistant.components.hdmi_cec.switch] Setting up HDMI devices ['hdmi_cec.hdmi_0']
2022-02-14 10:48:58 INFO (MainThread) [homeassistant.components.switch] Setting up switch.hdmi_cec
2022-02-14 10:48:58 INFO (SyncWorker_3) [homeassistant.components.hdmi_cec.switch] Setting up HDMI devices ['hdmi_cec.hdmi_4']
2022-02-14 10:48:58 WARNING (MainThread) [homeassistant.components.media_player] Updating panasonic_viera media_player took longer than the scheduled update interval 0:00:10
2022-02-14 10:48:58 ERROR (MainThread) [homeassistant.components.switch] Error while setting up hdmi_cec platform for switch
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/helpers/entity_platform.py", line 249, in _async_setup_platform
await asyncio.shield(task)
File "/usr/local/lib/python3.9/concurrent/futures/thread.py", line 52, in run
result = self.fn(*self.args, **self.kwargs)
File "/usr/src/homeassistant/homeassistant/components/hdmi_cec/switch.py", line 30, in setup_platform
hdmi_device = hass.data[DOMAIN][device]
TypeError: 'EntityComponent' object is not subscriptable
2022-02-14 10:48:58 ERROR (MainThread) [homeassistant.components.switch] Error while setting up hdmi_cec platform for switch
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/helpers/entity_platform.py", line 249, in _async_setup_platform
await asyncio.shield(task)
File "/usr/local/lib/python3.9/concurrent/futures/thread.py", line 52, in run
result = self.fn(*self.args, **self.kwargs)
File "/usr/src/homeassistant/homeassistant/components/hdmi_cec/switch.py", line 30, in setup_platform
hdmi_device = hass.data[DOMAIN][device]
TypeError: 'EntityComponent' object is not subscriptable
2022-02-14 10:48:58 INFO (MainThread) [pyhap.hap_protocol] ('192.168.1.58', 52303): Connection made to Home Assistant Bridge
2022-02-14 10:48:58 INFO (MainThread) [pyhap.hap_protocol] ('192.168.1.43', 49310): Connection made to Home Assistant Bridge
2022-02-14 10:48:58 INFO (MainThread) [pyhap.hap_protocol] ('192.168.1.64', 50143): Connection made to Home Assistant Bridge
2022-02-14 10:48:58 INFO (MainThread) [pyhap.hap_protocol] ('192.168.1.68', 62169): Connection made to Home Assistant Bridge
2022-02-14 10:49:05 INFO (MainThread) [pyhap.hap_protocol] ('192.168.1.68', 62170): Connection made to Home Assistant Bridge
2022-02-14 10:49:11 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:49:17 INFO (SyncWorker_1) [homeassistant.loader] Loaded dlna_dmr from homeassistant.components.dlna_dmr
2022-02-14 10:49:42 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:50:12 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:50:40 DEBUG (SyncWorker_2) [homeassistant.components.hdmi_cec] Reached _adapter_watchdog
2022-02-14 10:50:42 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:51:12 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:51:42 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:52:13 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:52:40 DEBUG (SyncWorker_3) [homeassistant.components.hdmi_cec] Reached _adapter_watchdog
2022-02-14 10:52:43 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:53:13 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:53:43 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:54:13 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:54:40 DEBUG (SyncWorker_7) [homeassistant.components.hdmi_cec] Reached _adapter_watchdog
2022-02-14 10:54:44 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:55:14 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:55:44 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:56:14 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:56:40 DEBUG (SyncWorker_0) [homeassistant.components.hdmi_cec] Reached _adapter_watchdog
2022-02-14 10:56:44 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:57:15 INFO (SyncWorker_0) [pycec] Looking for new devices...
2022-02-14 10:57:45 INFO (SyncWorker_0) [pycec] Looking for new devices...
nick8888 commented 2 years ago

I'm also using the pi-cec addon if that helps.

It was working prior to 2022.2

epenet commented 2 years ago

I think I've got it - should be fixed in #66504 It would be good if someone could test it...

mmalina commented 2 years ago

@epenet cool. Are there any instructions how to test a component with custom code? I'm using the fully managed HA on Raspberry Pi 3b+.

epenet commented 2 years ago

I'm really not sure on the best way to test... it depends on everyone's installation. Maybe something along those lines:

docker exec -it homeassistant bash
cd /usr/src/homeassistant/homeassistant/components/hdmi_cec/
curl https://raw.githubusercontent.com/home-assistant/core/tree/dev/homeassistant/components/hdmi_cec/__init__.py > __init__.py
curl https://raw.githubusercontent.com/home-assistant/core/tree/dev/homeassistant/components/hdmi_cec/manifest.json > manifest.json
curl https://raw.githubusercontent.com/home-assistant/core/tree/dev/homeassistant/components/hdmi_cec/media_player.py > media_player.py
curl https://raw.githubusercontent.com/home-assistant/core/tree/dev/homeassistant/components/hdmi_cec/services.yaml > services.yaml
curl https://raw.githubusercontent.com/home-assistant/core/tree/dev/homeassistant/components/hdmi_cec/switch.py > switch.py
epenet commented 2 years ago

@nick8888 I see your thumbs up => did you get a chance to test the fix?

mmalina commented 2 years ago

@epenet thanks. Would be nice if there was a more straightforward way of testing changes, other than overriding files in place :)

I overrode the files in /usr/src/homeassistant/homeassistant/components/hdmi_cec/ with the latest from dev, restarted HA and the errors are gone.

And it works!

epenet commented 2 years ago

Great, thanks for confirming.

Hamper commented 2 years ago

Latest files from dev works fine for me too

nick8888 commented 2 years ago

I can also confirm this issue is fixed. Many thanks.