Closed Lucus123 closed 5 years ago
Paste the full startup log for home assistant
full startup log:
2019-08-01 10:43:24 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 do experience issues with Home Assistant.
2019-08-01 10:43:24 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=logger, service=set_default_level>
2019-08-01 10:43:24 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=logger, service=set_level>
2019-08-01 10:43:24 INFO (MainThread) [homeassistant.setup] Setup of domain logger took 0.0 seconds.
2019-08-01 10:43:24 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=logger>
2019-08-01 10:43:24 INFO (MainThread) [homeassistant.setup] Setting up http
2019-08-01 10:43:24 INFO (MainThread) [homeassistant.setup] Setup of domain http took 0.0 seconds.
2019-08-01 10:43:24 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=http>
2019-08-01 10:43:24 INFO (MainThread) [homeassistant.setup] Setting up system_log
2019-08-01 10:43:24 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=system_log, service=clear>
2019-08-01 10:43:24 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=system_log, service=write>
2019-08-01 10:43:24 INFO (MainThread) [homeassistant.setup] Setup of domain system_log took 0.0 seconds.
2019-08-01 10:43:24 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=system_log>
2019-08-01 10:43:24 INFO (MainThread) [homeassistant.setup] Setting up recorder
2019-08-01 10:43:24 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=recorder, service=purge>
2019-08-01 10:43:25 DEBUG (Recorder) [homeassistant.components.recorder] Connected to recorder database
2019-08-01 10:43:25 INFO (MainThread) [homeassistant.setup] Setup of domain recorder took 0.7 seconds.
2019-08-01 10:43:25 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=recorder>
2019-08-01 10:43:25 DEBUG (MainThread) [homeassistant.bootstrap] Setting up {'person', 'panel_iframe', 'script', 'cloud', 'cast', 'onboarding', 'tts', 'automation', 'tradfri', 'switch', 'config', 'google_assistant', 'frontend', 'met', 'auth', 'map', 'api', 'mobile_app', 'ssdp', 'updater', 'websocket_api', 'hacs', '$
2019-08-01 10:43:25 INFO (MainThread) [homeassistant.setup] Setting up person
2019-08-01 10:43:25 INFO (MainThread) [homeassistant.setup] Setting up cast
2019-08-01 10:43:25 INFO (MainThread) [homeassistant.setup] Setup of domain cast took 0.0 seconds.
2019-08-01 10:43:25 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=cast>
2019-08-01 10:43:25 INFO (MainThread) [homeassistant.setup] Setting up tradfri
2019-08-01 10:43:25 INFO (MainThread) [homeassistant.setup] Setup of domain tradfri took 0.0 seconds.
2019-08-01 10:43:25 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15011', '15012']
2019-08-01 10:43:25 INFO (MainThread) [homeassistant.setup] Setting up met
2019-08-01 10:43:25 INFO (MainThread) [homeassistant.setup] Setup of domain met took 0.0 seconds.
2019-08-01 10:43:25 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=met>
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setting up ssdp
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setup of domain ssdp took 0.0 seconds.
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=ssdp>
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setting up updater
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setup of domain updater took 0.0 seconds.
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=updater>
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setting up hacs
2019-08-01 10:43:26 INFO (MainThread) [custom_components.hacs]
-------------------------------------------------------------------
HACS (Home Assistant Community Store)
Version: 0.12.1
This is a custom integration
If you have any issues with this you need to open an issue here:
https://github.com/custom-components/hacs/issues
-------------------------------------------------------------------
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setting up group
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setting up lovelace
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setup of domain lovelace took 0.0 seconds.
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=lovelace>
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setting up sun
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.components.sun] sun phase_update@2019-08-01T09:43:26.768241+00:00: phase=day
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.components.sun] sun position_update@2019-08-01T09:43:26.768241+00:00: elevation=48.43 azimuth=133.51
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sun.sun, old_state=None, new_state=<state sun.sun=above_horizon; next_dawn=2019-08-02T03:20:01+00:00, next_dusk=2019-08-01T20:11:52+00:00, next_midnight=2019-08-01T23:44:59+00:00, next_noon=2019-08-01T11:45:0$
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.components.sun] next time: 2019-08-01T11:45:03+00:00
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setup of domain sun took 0.1 seconds.
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=sun>
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setting up wake_on_lan
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=wake_on_lan, service=send_magic_packet>
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setup of domain wake_on_lan took 0.0 seconds.
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=wake_on_lan>
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.components.ssdp] Scanning
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.persons, old_state=None, new_state=<state group.persons=unknown; entity_id=('device_tracker.luuk_2', 'device_tracker.marjolein_2'), order=0, friendly_name=Wie is waar? @ 2019-08-01T11:43:26.892219+02:00$
2019-08-01 10:43:26 INFO (SyncWorker_6) [homeassistant.loader] Loaded weather from homeassistant.components.weather
2019-08-01 10:43:26 INFO (SyncWorker_13) [homeassistant.loader] Loaded google_translate from homeassistant.components.google_translate
2019-08-01 10:43:26 INFO (MainThread) [homeassistant.setup] Setting up config
2019-08-01 10:43:26 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up google_assistant
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=google_assistant, service=request_sync>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain google_assistant took 0.0 seconds.
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=google_assistant>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up auth
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain auth took 0.0 seconds.
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=auth>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up api
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up websocket_api
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain websocket_api took 0.0 seconds.
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=websocket_api>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up webhook
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain webhook took 0.0 seconds.
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up webhook
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain webhook took 0.0 seconds.
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=webhook>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up system_health
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain system_health took 0.0 seconds.
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=system_health>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up history
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain history took 0.0 seconds.
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=history>
2019-08-01 10:43:28 INFO (SyncWorker_15) [homeassistant.loader] Loaded webostv from homeassistant.components.webostv
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.config_entries>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.group>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.core>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.customize>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.area_registry>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.device_registry>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.entity_registry>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.auth>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.auth_provider_homeassistant>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.script>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.automation>
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.verwarming, old_state=None, new_state=<state group.verwarming=unknown; entity_id=('switch.openhaard',), order=1, friendly_name=Verwarming @ 2019-08-01T11:43:28.391661+02:00>>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up weather
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain weather took 0.0 seconds.
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=weather>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up tts
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain api took 0.1 seconds.
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=api>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.components.weather] Setting up weather.met
2019-08-01 10:43:28 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x68f45470: Type.CON GET (ID 38409, token b'\x00\x00kl') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:28 DEBUG (MainThread) [coap] Exchange added, message ID: 38409.
2019-08-01 10:43:28 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:28 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b6c, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setup of domain config took 1.6 seconds.
2019-08-01 10:43:28 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config>
2019-08-01 10:43:28 INFO (SyncWorker_18) [homeassistant.loader] Loaded kodi from homeassistant.components.kodi
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up onboarding
2019-08-01 10:43:28 INFO (MainThread) [homeassistant.setup] Setting up cloud
2019-08-01 10:43:29 INFO (MainThread) [homeassistant.setup] Setting up mobile_app
2019-08-01 10:43:29 INFO (MainThread) [homeassistant.setup] Setting up gpslogger
2019-08-01 10:43:29 INFO (MainThread) [homeassistant.setup] Setup of domain gpslogger took 0.0 seconds.
2019-08-01 10:43:29 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=gpslogger>
2019-08-01 10:43:29 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.lights, old_state=None, new_state=<state group.lights=unknown; entity_id=('light.schemerlamp', 'light.bank', 'light.tafel', 'light.deur', 'sensor.tradfri_remote_control'), order=2, friendly_name=Woonkam$
2019-08-01 10:43:29 DEBUG (SyncWorker_16) [homeassistant.util.json] JSON file not found: /home/homeassistant/.homeassistant/.storage/mobile_app
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up media_player
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up zeroconf
2019-08-01 10:43:30 INFO (SyncWorker_6) [homeassistant.loader] Loaded device_tracker from homeassistant.components.device_tracker
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.kodi
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=group, service=reload>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=group, service=set>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=group, service=remove>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=group, service=set_visibility>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain group took 3.5 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=group>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=kodi_add_to_playlist>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=kodi_call_method>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain mobile_app took 0.2 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=mobile_app>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.helpers.restore_state] Created cache with ['person.luuk', 'person.marjolein', 'device_tracker.luuk_2', 'device_tracker.marjolein_2']
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain onboarding took 1.6 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=onboarding>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=tts, service=google_translate_say>
2019-08-01 10:43:30 INFO (SyncWorker_7) [homeassistant.loader] Loaded zone from homeassistant.components.zone
2019-08-01 10:43:30 INFO (SyncWorker_14) [homeassistant.loader] Loaded configurator from homeassistant.components.configurator
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up script
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=script, service=reload>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=script, service=turn_on>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=script, service=turn_off>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=script, service=toggle>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain script took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=script>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up automation
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=trigger>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=reload>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=toggle>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=turn_on>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=turn_off>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain automation took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=automation>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain automation took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=automation>
2019-08-01 10:43:30 INFO (SyncWorker_15) [homeassistant.loader] Loaded command_line from homeassistant.components.command_line
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=tts, service=clear_cache>
2019-08-01 10:43:30 INFO (SyncWorker_17) [homeassistant.loader] Loaded notify from homeassistant.components.notify
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain tts took 1.8 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=tts>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up configurator
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain configurator took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=configurator>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=person.marjolein, old_state=None, new_state=<state person.marjolein=not_home; editable=True, id=64cde2e68d8d4c20bb491c3a6cc2e843, latitude=52.0355989, longitude=5.3450631, gps_accuracy=19.2450008392334, sourc$
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=person.luuk, old_state=None, new_state=<state person.luuk=not_home; editable=True, id=4477aca308f14be7a775cfcd70d3541c, latitude=51.97816905469018, longitude=5.343193419157231, gps_accuracy=6.0, source=person$
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up frontend
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain frontend took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=frontend>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up switch
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up notify
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain notify took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=notify>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up zone
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain zone took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=zone>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.switch] Setting up switch.command_line
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain person took 4.9 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=person>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event platform_discovered[L]: service=load_platform.notify, platform=mobile_app, discovered=>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=zone.home, old_state=None, new_state=<state zone.home=zoning; hidden=True, latitude=51.9851023186331, longitude=5.333105251193047, radius=100, friendly_name=Huize Neele, icon=mdi:home @ 2019-08-01T11:43:30.32$
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.webostv
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up panel_iframe
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain panel_iframe took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=panel_iframe>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up map
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain map took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=map>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up logbook
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=logbook, service=log>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain logbook took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=logbook>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.kodi.media_player] Unable to fetch kodi data
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.components.kodi.media_player] Unable to fetch kodi data
Traceback (most recent call last):
File "/srv/homeassistant/lib/python3.7/site-packages/aiohttp/connector.py", line 924, in _wrap_create_connection
await self._loop.create_connection(*args, **kwargs))
File "/usr/lib/python3.7/asyncio/base_events.py", line 959, in create_connection
raise exceptions[0]
File "/usr/lib/python3.7/asyncio/base_events.py", line 946, in create_connection
await self.sock_connect(sock, address)
File "/usr/lib/python3.7/asyncio/selector_events.py", line 464, in sock_connect
return await fut
File "/usr/lib/python3.7/asyncio/selector_events.py", line 494, in _sock_connect_cb
raise OSError(err, f'Connect call failed {address}')
ConnectionRefusedError: [Errno 111] Connect call failed ('192.168.1.21', 8080)
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/srv/homeassistant/lib/python3.7/site-packages/jsonrpc_async/jsonrpc.py", line 29, in send_message
response = yield from self._request(data=message.serialize())
File "/srv/homeassistant/lib/python3.7/site-packages/aiohttp/client.py", line 476, in _request
timeout=real_timeout
File "/srv/homeassistant/lib/python3.7/site-packages/aiohttp/connector.py", line 522, in connect
proto = await self._create_connection(req, traces, timeout)
File "/srv/homeassistant/lib/python3.7/site-packages/aiohttp/connector.py", line 854, in _create_connection
req, traces, timeout)
File "/srv/homeassistant/lib/python3.7/site-packages/aiohttp/connector.py", line 992, in _create_direct_connection
raise last_exc
File "/srv/homeassistant/lib/python3.7/site-packages/aiohttp/connector.py", line 974, in _create_direct_connection
req=req, client_error=client_error)
File "/srv/homeassistant/lib/python3.7/site-packages/aiohttp/connector.py", line 931, in _wrap_create_connection
raise client_error(req.connection_key, exc) from exc
aiohttp.client_exceptions.ClientConnectorError: Cannot connect to host 192.168.1.21:8080 ssl:None [Connect call failed ('192.168.1.21', 8080)]
During handling of the above exception, another exception occurred:
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/kodi/media_player.py", line 396, in _get_players
return await self.server.Player.GetActivePlayers()
File "/srv/homeassistant/lib/python3.7/site-packages/jsonrpc_async/jsonrpc.py", line 31, in send_message
raise TransportError('Transport Error', message, exc)
jsonrpc_base.jsonrpc.TransportError: ("Error calling method 'Player.GetActivePlayers': Transport Error", ClientConnectorError(111, "Connect call failed ('192.168.1.21', 8080)"))
2019-08-01 10:43:30 DEBUG (SyncWorker_16) [pylgtv.webos_client] load keyfile from /home/homeassistant/.homeassistant/webostv.conf
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=media_player.kodi, old_state=None, new_state=<state media_player.kodi=off; friendly_name=Kodi, supported_features=54847 @ 2019-08-01T11:43:30.487389+02:00>>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=cloud, service=remote_connect>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=cloud, service=remote_disconnect>
2019-08-01 10:43:30 DEBUG (SyncWorker_16) [pylgtv.webos_client] getting client_key for 192.168.1.12 from /home/homeassistant/.homeassistant/webostv.conf
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain cloud took 1.9 seconds.
2019-08-01 10:43:30 DEBUG (SyncWorker_16) [pylgtv.webos_client] load keyfile from /home/homeassistant/.homeassistant/webostv.conf
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=cloud>
2019-08-01 10:43:30 DEBUG (SyncWorker_16) [pylgtv.webos_client] getting client_key for 192.168.1.12 from /home/homeassistant/.homeassistant/webostv.conf
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.notify] Setting up notify.mobile_app
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=notify, service=notify>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up device_tracker
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=switch.openhaard, old_state=None, new_state=<state switch.openhaard=off; friendly_name=openhaard, assumed_state=True @ 2019-08-01T11:43:30.521141+02:00>>
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x68a8dbf0: Type.ACK 2.05 Content (ID 38409, token b'\x00\x00kl') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 457 byte(s) payload>
2019-08-01 10:43:30 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Exchange removed, message ID: 38409.
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x68a8dbf0: Type.ACK 2.05 Content (ID 38409, token b'\x00\x00kl') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 457 byte(s) payload>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.components.ssdp] Error parsing http://192.168.1.102:8080/upnp: syntax error: line 1, column 0
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=device_tracker, service=see>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain device_tracker took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=device_tracker>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.verwarming, old_state=<state group.verwarming=unknown; entity_id=('switch.openhaard',), order=1, friendly_name=Verwarming @ 2019-08-01T11:43:28.391661+02:00>, new_state=<state group.verwarming=off; enti$
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9107":1,"9054":0,"9061":0,"9023":"0.tradfri.pool.ntp.org","9078":1,"9077":27,"9071":0,"9059":1564652610,"9200":"6bd3c643-220b-40ba-a4eb-3fcf4d7090dc","9060":"2019-08-01T09:43:30.022856Z","9062":0,"9083":"N/A","9029"$
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=tradfri>
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/places
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/brewdog
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/weatheralerts
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/wienerlinien
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/sensor.rpi_power
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/sensor.untappd
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/authenticated
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/unsplash
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/combined
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/feedparser
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/sensor.personalcapital
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/sensor.trakt
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/climate.e_thermostaat
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/media_player.braviatv_psk
2019-08-01 10:43:30 INFO (MainThread) [custom_components.hacs.restore] custom-components/sensor.sonarr_upcoming_media
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event panels_updated[L]>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=hacs, service=install>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=hacs, service=register>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain hacs took 4.2 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=hacs>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=group, service=set, service_data=object_id=all_devices, visible=False, name=all devices, entities=[]>
2019-08-01 10:43:30 DEBUG (SyncWorker_19) [asyncio] Using selector: EpollSelector
2019-08-01 10:43:30 DEBUG (SyncWorker_19) [pylgtv.webos_client] send command to ws://192.168.1.12:3000
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.device_tracker] Setting up device_tracker.gpslogger
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=group, service=set, service_data=object_id=all_switches, name=all switches, visible=False, entities=['switch.openhaard']>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=switch, service=turn_off>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=switch, service=turn_on>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=switch, service=toggle>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain switch took 0.3 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=switch>
2019-08-01 10:43:30 INFO (SyncWorker_6) [homeassistant.loader] Loaded light from homeassistant.components.light
2019-08-01 10:43:30 INFO (SyncWorker_10) [homeassistant.loader] Loaded sensor from homeassistant.components.sensor
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.all_devices, old_state=None, new_state=<state group.all_devices=unknown; entity_id=(), order=3, auto=True, friendly_name=all devices, hidden=True @ 2019-08-01T11:43:30.655968+02:00>>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.switch] Setting up switch.tradfri
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001']
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up sensor
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain sensor took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=sensor>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.tradfri
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event platform_discovered[L]: service=load_platform.sensor, platform=hacs, discovered=>
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66de2f50: Type.CON GET (ID 38410, token b'\x00\x00km') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Exchange added, message ID: 38410.
2019-08-01 10:43:30 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:30 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b6d, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001']
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.all_switches, old_state=None, new_state=<state group.all_switches=off; entity_id=('switch.openhaard',), order=4, auto=True, friendly_name=all switches, hidden=True, assumed_state=True @ 2019-08-01T11:43$
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=device_tracker.luuk_2, old_state=None, new_state=<state device_tracker.luuk_2=not_home; source_type=gps, battery_level=97.0, latitude=51.97816905469018, longitude=5.343193419157231, gps_accuracy=6.0, altitude$
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.all_switches, old_state=None, new_state=<state group.all_switches=off; entity_id=('switch.openhaard',), order=4, auto=True, friendly_name=all switches, hidden=True, assumed_state=True @ 2019-08-01T11:43$
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=device_tracker.luuk_2, old_state=None, new_state=<state device_tracker.luuk_2=not_home; source_type=gps, battery_level=97.0, latitude=51.97816905469018, longitude=5.343193419157231, gps_accuracy=6.0, altitude$
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=device_tracker.marjolein_2, old_state=None, new_state=<state device_tracker.marjolein_2=not_home; source_type=gps, battery_level=91.0, latitude=52.0355989, longitude=5.3450631, gps_accuracy=19.2450008392334, $
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setting up light
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.hacs
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:30 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:30 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b6e, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x66df3110: Type.ACK 2.05 Content (ID 38410, token b'\x00\x00km') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 31 byte(s) payload>
2019-08-01 10:43:30 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Exchange removed, message ID: 38410.
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x68f53530: Type.CON GET (ID 38411, token b'\x00\x00kn') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Exchange added, message ID: 38411.
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x66df3110: Type.ACK 2.05 Content (ID 38410, token b'\x00\x00km') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 31 byte(s) payload>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.persons, old_state=<state group.persons=unknown; entity_id=('device_tracker.luuk_2', 'device_tracker.marjolein_2'), order=0, friendly_name=Wie is waar? @ 2019-08-01T11:43:26.892219+02:00>, new_state=<st$
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=light, service=turn_on>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=light, service=turn_off>
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=light, service=toggle>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.setup] Setup of domain light took 0.0 seconds.
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=light>
2019-08-01 10:43:30 INFO (MainThread) [homeassistant.components.light] Setting up light.tradfri
2019-08-01 10:43:30 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.hacs, old_state=None, new_state=<state sensor.hacs=unknown; unit_of_measurement=pending update(s), friendly_name=hacs, icon=mdi:package @ 2019-08-01T11:43:30.759051+02:00>>
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: [65551,65555,65556,65553,65552]
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001']
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65551]
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65555]
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65556]
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65553]
2019-08-01 10:43:30 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65552]
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x66e01590: Type.ACK 2.05 Content (ID 38411, token b'\x00\x00kn') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 31 byte(s) payload>
2019-08-01 10:43:30 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Exchange removed, message ID: 38411.
2019-08-01 10:43:30 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x66e01590: Type.ACK 2.05 Content (ID 38411, token b'\x00\x00kn') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 31 byte(s) payload>
2019-08-01 10:43:30 DEBUG (zeroconf-ServiceBrowser__googlecast._tcp.local.) [homeassistant.components.zeroconf] Discovered new device Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local. {'host': '192.168.1.17', 'port': 8009, 'hostname': '6287e74c-228a-bb9b-1d11-46756ce42b79.local.', 'type': '_google$
2019-08-01 10:43:30 DEBUG (zeroconf-ServiceBrowser__googlecast._tcp.local.) [homeassistant.components.zeroconf] Discovered new device Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local. {'host': '192.168.1.17', 'port': 43008, 'hostname': '6287e74c-228a-bb9b-1d11-46756ce42b79.local.', 'type': $
2019-08-01 10:43:31 DEBUG (zeroconf-ServiceBrowser__googlecast._tcp.local.) [homeassistant.components.zeroconf] Discovered new device Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local. {'host': '192.168.1.21', 'port': 8009, 'hostname': '0b3c502c-13f6-c1f5-b525-5ae234fb0d4b.local.', 'type': '_$
2019-08-01 10:43:31 DEBUG (zeroconf-ServiceBrowser__coap._udp.local.) [homeassistant.components.zeroconf] Discovered new device gw-a0c9a0677d15._coap._udp.local. {'host': '192.168.1.16', 'port': 5684, 'hostname': 'TRADFRI-Gateway-a0c9a0677d15.local.', 'type': '_coap._udp.local.', 'name': 'gw-a0c9a0677d15._coap._udp$
2019-08-01 10:43:31 DEBUG (zeroconf-ServiceBrowser__hap._tcp.local.) [homeassistant.components.zeroconf] Discovered new device TRADFRI gateway._hap._tcp.local. {'host': '192.168.1.16', 'port': 80, 'hostname': 'TRADFRI-Gateway-a0c9a0677d15.local.', 'type': '_hap._tcp.local.', 'name': 'TRADFRI gateway._hap._tcp.local$
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=weather.huize_neele, old_state=None, new_state=<state weather.huize_neele=partlycloudy; temperature=20.7, humidity=74, pressure=1015.9, wind_bearing=221.4, wind_speed=17.6, attribution=Weather forecast from m$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66e75f90: Type.CON GET (ID 38412, token b'\x00\x00ko') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38412.
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b6f, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b70, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b71, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b72, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b73, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b74, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: [65551,65555,65556,65553,65552]
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65551]
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65555]
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65556]
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65553]
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65552]
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event config_entry_discovered[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event config_entry_discovered[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event config_entry_discovered[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event config_entry_discovered[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service=create, service_data=title=New devices discovered, message=We have discovered new devices on your network. [Check it out](/config/integrations), notification_id=config_entry_disco$
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service=dismiss, service_data=notification_id=config_entry_discovery>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service=create, service_data=title=New devices discovered, message=We have discovered new devices on your network. [Check it out](/config/integrations), notification_id=config_entry_disco$
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service=dismiss, service_data=notification_id=config_entry_discovery>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service=create, service_data=title=New devices discovered, message=We have discovered new devices on your network. [Check it out](/config/integrations), notification_id=config_entry_disco$
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service=dismiss, service_data=notification_id=config_entry_discovery>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service=create, service_data=title=New devices discovered, message=We have discovered new devices on your network. [Check it out](/config/integrations), notification_id=config_entry_disco$
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service=dismiss, service_data=notification_id=config_entry_discovery>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service=dismiss, service_data=notification_id=config_entry_discovery>
2019-08-01 10:43:31 INFO (MainThread) [homeassistant.setup] Setup of domain zeroconf took 1.8 seconds.
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=zeroconf>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x69044490: Type.ACK 2.05 Content (ID 38412, token b'\x00\x00ko') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 31 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=zeroconf>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x69044490: Type.ACK 2.05 Content (ID 38412, token b'\x00\x00ko') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 31 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38412.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66df3cf0: Type.CON GET (ID 38413, token b'\x00\x00kp') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38413.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x69044490: Type.ACK 2.05 Content (ID 38412, token b'\x00\x00ko') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 31 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b75, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b76, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b77, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b78, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b79, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=persistent_notification.config_entry_discovery, old_state=None, new_state=<state persistent_notification.config_entry_discovery=notifying; title=New devices discovered, message=We have discovered new devices $
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event persistent_notifications_updated[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=persistent_notification.config_entry_discovery, old_state=<state persistent_notification.config_entry_discovery=notifying; title=New devices discovered, message=We have discovered new devices on your network.$
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event persistent_notifications_updated[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=persistent_notification.config_entry_discovery, old_state=None, new_state=<state persistent_notification.config_entry_discovery=notifying; title=New devices discovered, message=We have discovered new devices $
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event persistent_notifications_updated[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=persistent_notification.config_entry_discovery, old_state=<state persistent_notification.config_entry_discovery=notifying; title=New devices discovered, message=We have discovered new devices on your network.$
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event persistent_notifications_updated[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=persistent_notification.config_entry_discovery, old_state=None, new_state=<state persistent_notification.config_entry_discovery=notifying; title=New devices discovered, message=We have discovered new devices $
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event persistent_notifications_updated[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=persistent_notification.config_entry_discovery, old_state=<state persistent_notification.config_entry_discovery=notifying; title=New devices discovered, message=We have discovered new devices on your network.$
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event persistent_notifications_updated[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=persistent_notification.config_entry_discovery, old_state=None, new_state=<state persistent_notification.config_entry_discovery=notifying; title=New devices discovered, message=We have discovered new devices $
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event persistent_notifications_updated[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=persistent_notification.config_entry_discovery, old_state=<state persistent_notification.config_entry_discovery=notifying; title=New devices discovered, message=We have discovered new devices on your network.$
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event persistent_notifications_updated[L]>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: [65551,65555,65556,65553,65552]
2019-08-01 10:43:31 INFO (MainThread) [homeassistant.setup] Setting up default_config
2019-08-01 10:43:31 INFO (MainThread) [homeassistant.setup] Setup of domain default_config took 0.0 seconds.
2019-08-01 10:43:31 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=default_config>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65551]
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65555]
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65556]
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65553]
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Executing 192.168.1.16 get ['15001', 65552]
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x64518650: Type.ACK 2.05 Content (ID 38413, token b'\x00\x00kp') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 220 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38413.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66df3ff0: Type.CON GET (ID 38414, token b'\x00\x00kq') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38414.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x64518650: Type.ACK 2.05 Content (ID 38413, token b'\x00\x00kp') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 220 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b7a, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b7b, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b7c, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b7d, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:31 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b7e, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"TRADFRI remote control","9002":1560189283,"9020":1564605234,"9054":0,"9003":65551,"9019":1,"5750":0,"3":{"0":"IKEA of Sweden","1":"TRADFRI remote control","2":"","3":"1.2.223","6":3,"9":21},"15009":[{"9003":0$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x64518e70: Type.ACK 2.05 Content (ID 38414, token b'\x00\x00kq') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38414.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66ded050: Type.CON GET (ID 38415, token b'\x00\x00kr') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38415.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x64518e70: Type.ACK 2.05 Content (ID 38414, token b'\x00\x00kq') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Deur","9002":1560189499,"9020":1564569481,"9054":0,"9003":65555,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 CWS opal 600lm","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"58$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x6451b470: Type.ACK 2.05 Content (ID 38415, token b'\x00\x00kr') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 297 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38415.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66ded030: Type.CON GET (ID 38416, token b'\x00\x00ks') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38415.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66ded030: Type.CON GET (ID 38416, token b'\x00\x00ks') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38416.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x6451b470: Type.ACK 2.05 Content (ID 38415, token b'\x00\x00kr') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 297 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Schemerlamp","9002":1560189529,"9020":1564651826,"9054":0,"9003":65556,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 CWS opal 600lm","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x66df3fd0: Type.ACK 2.05 Content (ID 38416, token b'\x00\x00ks') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 289 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38416.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66df3df0: Type.CON GET (ID 38417, token b'\x00\x00kt') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38417.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x66df3fd0: Type.ACK 2.05 Content (ID 38416, token b'\x00\x00ks') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 289 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Bank","9002":1560189373,"9020":1564606459,"9054":0,"9003":65553,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 C/WS opal 600","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"585$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x6451b470: Type.ACK 2.05 Content (ID 38417, token b'\x00\x00kt') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38417.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66f50e30: Type.CON GET (ID 38418, token b'\x00\x00ku') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38418.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x6451b470: Type.ACK 2.05 Content (ID 38417, token b'\x00\x00kt') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Tafel","9002":1560189313,"9020":1564606472,"9054":0,"9003":65552,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 C/WS opal 600","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"58$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x66de2f10: Type.ACK 2.05 Content (ID 38418, token b'\x00\x00ku') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 220 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38418.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66de2e30: Type.CON GET (ID 38419, token b'\x00\x00kv') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38419.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x66de2f10: Type.ACK 2.05 Content (ID 38418, token b'\x00\x00ku') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 220 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"TRADFRI remote control","9002":1560189283,"9020":1564605234,"9054":0,"9003":65551,"9019":1,"5750":0,"3":{"0":"IKEA of Sweden","1":"TRADFRI remote control","2":"","3":"1.2.223","6":3,"9":21},"15009":[{"9003":0$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x66ecff70: Type.ACK 2.05 Content (ID 38419, token b'\x00\x00kv') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38419.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x67f87b90: Type.CON GET (ID 38420, token b'\x00\x00kw') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38420.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x66ecff70: Type.ACK 2.05 Content (ID 38419, token b'\x00\x00kv') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Deur","9002":1560189499,"9020":1564569481,"9054":0,"9003":65555,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 CWS opal 600lm","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"58$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x64527c10: Type.ACK 2.05 Content (ID 38420, token b'\x00\x00kw') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 297 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38420.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66de2e90: Type.CON GET (ID 38421, token b'\x00\x00kx') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38421.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x64527c10: Type.ACK 2.05 Content (ID 38420, token b'\x00\x00kw') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 297 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Schemerlamp","9002":1560189529,"9020":1564651826,"9054":0,"9003":65556,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 CWS opal 600lm","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x64527c10: Type.ACK 2.05 Content (ID 38421, token b'\x00\x00kx') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 289 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange removed, message ID: 38421.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66db7e10: Type.CON GET (ID 38422, token b'\x00\x00ky') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Exchange added, message ID: 38422.
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x64527c10: Type.ACK 2.05 Content (ID 38421, token b'\x00\x00kx') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 289 byte(s) payload>
2019-08-01 10:43:31 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Bank","9002":1560189373,"9020":1564606459,"9054":0,"9003":65553,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 C/WS opal 600","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"585$
2019-08-01 10:43:31 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x64527c10: Type.ACK 2.05 Content (ID 38422, token b'\x00\x00ky') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38422.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66e755d0: Type.CON GET (ID 38423, token b'\x00\x00kz') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38423.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x64527c10: Type.ACK 2.05 Content (ID 38422, token b'\x00\x00ky') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Tafel","9002":1560189313,"9020":1564606472,"9054":0,"9003":65552,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 C/WS opal 600","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"58$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x68f53870: Type.ACK 2.05 Content (ID 38423, token b'\x00\x00kz') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 220 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38423.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66e75270: Type.CON GET (ID 38424, token b'\x00\x00k{') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38424.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x68f53870: Type.ACK 2.05 Content (ID 38423, token b'\x00\x00kz') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 220 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"TRADFRI remote control","9002":1560189283,"9020":1564605234,"9054":0,"9003":65551,"9019":1,"5750":0,"3":{"0":"IKEA of Sweden","1":"TRADFRI remote control","2":"","3":"1.2.223","6":3,"9":21},"15009":[{"9003":0$
2019-08-01 10:43:32 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.tradfri_remote_control, old_state=None, new_state=<state sensor.tradfri_remote_control=21; manufacturer=IKEA of Sweden, model_number=TRADFRI remote control, serial=, firmware_version=1.2.223, power_sou$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x68a8db10: Type.ACK 2.05 Content (ID 38424, token b'\x00\x00k{') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38424.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x67f95cb0: Type.CON GET (ID 38425, token b'\x00\x00k|') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38425.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x68a8db10: Type.ACK 2.05 Content (ID 38424, token b'\x00\x00k{') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Deur","9002":1560189499,"9020":1564569481,"9054":0,"9003":65555,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 CWS opal 600lm","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"58$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b7f, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x69059210: Type.ACK 2.05 Content (ID 38425, token b'\x00\x00k|') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 297 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38425.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x65d6fbb0: Type.CON GET (ID 38426, token b'\x00\x00k}') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38426.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x69059210: Type.ACK 2.05 Content (ID 38425, token b'\x00\x00k|') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 297 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Schemerlamp","9002":1560189529,"9020":1564651826,"9054":0,"9003":65556,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 CWS opal 600lm","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x69059210: Type.ACK 2.05 Content (ID 38426, token b'\x00\x00k}') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 289 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Schemerlamp","9002":1560189529,"9020":1564651826,"9054":0,"9003":65556,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 CWS opal 600lm","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x69059210: Type.ACK 2.05 Content (ID 38426, token b'\x00\x00k}') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 289 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38426.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x68a8dd70: Type.CON GET (ID 38427, token b'\x00\x00k~') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38427.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x69059210: Type.ACK 2.05 Content (ID 38426, token b'\x00\x00k}') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 289 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Bank","9002":1560189373,"9020":1564606459,"9054":0,"9003":65553,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 C/WS opal 600","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"585$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x65d71cf0: Type.ACK 2.05 Content (ID 38427, token b'\x00\x00k~') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38427.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x6452bd50: Type.CON GET (ID 38428, token b'\x00\x00k\x7f') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 4 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38428.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x65d71cf0: Type.ACK 2.05 Content (ID 38427, token b'\x00\x00k~') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 2 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Tafel","9002":1560189313,"9020":1564606472,"9054":0,"9003":65552,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 C/WS opal 600","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"58$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x66e752d0: Type.ACK 2.05 Content (ID 38428, token b'\x00\x00k\x7f') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 220 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38428.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x66e752d0: Type.ACK 2.05 Content (ID 38428, token b'\x00\x00k\x7f') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 220 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"TRADFRI remote control","9002":1560189283,"9020":1564605234,"9054":0,"9003":65551,"9019":1,"5750":0,"3":{"0":"IKEA of Sweden","1":"TRADFRI remote control","2":"","3":"1.2.223","6":3,"9":21},"15009":[{"9003":0$
2019-08-01 10:43:32 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.schemerlamp, old_state=None, new_state=<state light.schemerlamp=off; friendly_name=Schemerlamp, supported_features=49 @ 2019-08-01T11:43:32.072428+02:00>>
2019-08-01 10:43:32 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.bank, old_state=None, new_state=<state light.bank=off; friendly_name=Bank, supported_features=49 @ 2019-08-01T11:43:32.075593+02:00>>
2019-08-01 10:43:32 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.deur, old_state=None, new_state=<state light.deur=off; friendly_name=Deur, supported_features=49 @ 2019-08-01T11:43:32.079111+02:00>>
2019-08-01 10:43:32 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=light.tafel, old_state=None, new_state=<state light.tafel=off; friendly_name=Tafel, supported_features=49 @ 2019-08-01T11:43:32.082553+02:00>>
2019-08-01 10:43:32 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.lights, old_state=<state group.lights=unknown; entity_id=('light.schemerlamp', 'light.bank', 'light.tafel', 'light.deur', 'sensor.tradfri_remote_control'), order=2, friendly_name=Woonkamer Verlichting @$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66dc85f0: Type.CON GET (ID 38429, token b'\x00\x00k\x80') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 4 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38429.
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b80, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b81, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b82, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Message to <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470> put into backlog
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Timeout is 93.0
2019-08-01 10:43:32 DEBUG (MainThread) [coap.requester] Sending request - Token: 00006b83, Remote: <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>
2019-08-01 10:43:32 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=group, service=set, service_data=object_id=all_lights, name=all lights, visible=False, entities=['light.bank', 'light.deur', 'light.schemerlamp', 'light.tafel']>
2019-08-01 10:43:32 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=group.all_lights, old_state=None, new_state=<state group.all_lights=off; entity_id=('light.bank', 'light.deur', 'light.schemerlamp', 'light.tafel'), order=5, auto=True, friendly_name=all lights, hidden=True @$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x66df3e90: Type.ACK 2.05 Content (ID 38429, token b'\x00\x00k\x80') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 297 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38429.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66de2590: Type.CON GET (ID 38430, token b'\x00\x00k\x81') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 4 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38430.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x66df3e90: Type.ACK 2.05 Content (ID 38429, token b'\x00\x00k\x80') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 297 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Schemerlamp","9002":1560189529,"9020":1564651826,"9054":0,"9003":65556,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 CWS opal 600lm","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x69044550: Type.ACK 2.05 Content (ID 38430, token b'\x00\x00k\x81') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 289 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38430.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x6451b470: Type.CON GET (ID 38431, token b'\x00\x00k\x82') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 4 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38431.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x69044550: Type.ACK 2.05 Content (ID 38430, token b'\x00\x00k\x81') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 289 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Bank","9002":1560189373,"9020":1564606459,"9054":0,"9003":65553,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 C/WS opal 600","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"585$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x65d78cf0: Type.ACK 2.05 Content (ID 38431, token b'\x00\x00k\x82') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38431.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Sending message <aiocoap.Message at 0x66df3210: Type.CON GET (ID 38432, token b'\x00\x00k\x83') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 4 option(s)>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange added, message ID: 38432.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x65d78cf0: Type.ACK 2.05 Content (ID 38431, token b'\x00\x00k\x82') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Deur","9002":1560189499,"9020":1564569481,"9054":0,"9003":65555,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 CWS opal 600lm","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"58$
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Incoming message <aiocoap.Message at 0x64532210: Type.ACK 2.05 Content (ID 38432, token b'\x00\x00k\x83') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [coap] New unique message received
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Exchange removed, message ID: 38432.
2019-08-01 10:43:32 DEBUG (MainThread) [coap] Received Response: <aiocoap.Message at 0x64532210: Type.ACK 2.05 Content (ID 38432, token b'\x00\x00k\x83') remote <aiocoap.transports.tinydtls.DTLSClientConnection object at 0x6880a470>, 3 option(s), 290 byte(s) payload>
2019-08-01 10:43:32 DEBUG (MainThread) [pytradfri.api.aiocoap_api] Status: 2.05 Content, Received: {"9001":"Tafel","9002":1560189313,"9020":1564606472,"9054":0,"9003":65552,"9019":1,"5750":2,"3":{"0":"IKEA of Sweden","1":"TRADFRI bulb E27 C/WS opal 600","2":"","3":"1.3.009","6":1},"3311":[{"5850":0,"5708":52400,"58$
2019-08-01 10:43:33 DEBUG (SyncWorker_19) [pylgtv.webos_client] command failed to connect to ws://192.168.1.12:3000
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=media_player.tv_woonkamer, old_state=None, new_state=<state media_player.tv_woonkamer=off; friendly_name=TV Woonkamer, supported_features=20413 @ 2019-08-01T11:43:33.793306+02:00>>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=turn_on>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=turn_off>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=toggle>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=volume_up>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=volume_down>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_play_pause>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_play>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_pause>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_stop>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_next_track>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_previous_track>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=clear_playlist>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_previous_track>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=clear_playlist>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=volume_set>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=volume_mute>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_seek>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=select_source>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=select_sound_mode>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=play_media>
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=shuffle_set>
2019-08-01 10:43:33 INFO (MainThread) [homeassistant.setup] Setup of domain media_player took 3.8 seconds.
2019-08-01 10:43:33 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=media_player>
2019-08-01 10:43:33 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.cast
2019-08-01 10:43:34 DEBUG (SyncWorker_18) [homeassistant.components.cast.media_player] Starting internal pychromecast discovery.
2019-08-01 10:43:34 DEBUG (zeroconf-ServiceBrowser__googlecast._tcp.local.) [pychromecast.discovery] add_service _googlecast._tcp.local., Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local.
2019-08-01 10:43:34 DEBUG (zeroconf-ServiceBrowser__googlecast._tcp.local.) [homeassistant.components.cast.media_player] Discovered chromecast ChromecastInfo(host='192.168.1.17', port=8009, service='Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local.', uuid='6287e74c-228a-bb9b-1d11-46756ce42b79', ma$
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.components.cast.media_player] _async_create_cast_device: ChromecastInfo(host='192.168.1.17', port=8009, service='Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local.', uuid='6287e74c-228a-bb9b-1d11-46756ce42b79', manufacturer='Google Inc.', model_$
2019-08-01 10:43:34 DEBUG (zeroconf-ServiceBrowser__googlecast._tcp.local.) [pychromecast.discovery] add_service _googlecast._tcp.local., Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local.
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=media_player.chromecast, old_state=None, new_state=<state media_player.chromecast=unavailable; friendly_name=Chromecast, supported_features=21389 @ 2019-08-01T11:43:34.311834+02:00>>
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.components.cast.media_player] [media_player.chromecast Chromecast (192.168.1.17:8009)] Connecting to cast device by service {'Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local.'}
2019-08-01 10:43:34 DEBUG (zeroconf-ServiceBrowser__googlecast._tcp.local.) [homeassistant.components.cast.media_player] Discovered chromecast ChromecastInfo(host='192.168.1.17', port=43008, service='Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local.', uuid='a508307f-aea4-4310-aaea-3e5e06a30$
2019-08-01 10:43:34 DEBUG (SyncWorker_17) [pychromecast] _get_chromecast_from_service {'Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local.'}
2019-08-01 10:43:34 DEBUG (zeroconf-ServiceBrowser__googlecast._tcp.local.) [pychromecast.discovery] add_service _googlecast._tcp.local., Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local.
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.components.cast.media_player] _async_create_cast_device: ChromecastInfo(host='192.168.1.17', port=43008, service='Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local.', uuid='a508307f-aea4-4310-aaea-3e5e06a30df0', manufacturer='', model_nam$
2019-08-01 10:43:34 INFO (SyncWorker_17) [pychromecast] Querying device status
2019-08-01 10:43:34 DEBUG (SyncWorker_17) [pychromecast.discovery] get_info_from_service resolved service Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local. to service_info ServiceInfo(type='_googlecast._tcp.local.', name='Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local.', addres$
2019-08-01 10:43:34 DEBUG (SyncWorker_17) [pychromecast.dial] Resolved service Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local. to 192.168.1.17
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=media_player.thuisgroep, old_state=None, new_state=<state media_player.thuisgroep=unavailable; friendly_name=Thuisgroep, supported_features=21389 @ 2019-08-01T11:43:34.343152+02:00>>
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.components.cast.media_player] [media_player.thuisgroep Thuisgroep (192.168.1.17:43008)] Connecting to cast device by service {'Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local.'}
2019-08-01 10:43:34 DEBUG (SyncWorker_8) [pychromecast] _get_chromecast_from_service {'Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local.'}
2019-08-01 10:43:34 INFO (SyncWorker_8) [pychromecast] Querying device status
2019-08-01 10:43:34 DEBUG (SyncWorker_8) [pychromecast.discovery] get_info_from_service resolved service Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local. to service_info ServiceInfo(type='_googlecast._tcp.local.', name='Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.lo$
2019-08-01 10:43:34 DEBUG (SyncWorker_8) [pychromecast.dial] Resolved service Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local. to 192.168.1.17
2019-08-01 10:43:34 DEBUG (zeroconf-ServiceBrowser__googlecast._tcp.local.) [homeassistant.components.cast.media_player] Discovered chromecast ChromecastInfo(host='192.168.1.21', port=8009, service='Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local.', uuid='0b3c502c-13f6-c1f5-b525-5ae234fb0d4$
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.socket_client] [None:8009] connection listener: 67fe2310 (CastStatusListener)
2019-08-01 10:43:34 DEBUG (Thread-2) [homeassistant.components.cast.media_player] [media_player.chromecast Chromecast (192.168.1.17:8009)] Received cast device connection status: CONNECTING
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.discovery] get_info_from_service resolved service Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local. to service_info ServiceInfo(type='_googlecast._tcp.local.', name='Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local.', addresses=[$
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.components.cast.media_player] _async_create_cast_device: ChromecastInfo(host='192.168.1.21', port=8009, service='Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local.', uuid='0b3c502c-13f6-c1f5-b525-5ae234fb0d4b', manufacturer='Unknown manufa$
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.socket_client] [Chromecast:8009] Resolved service Chromecast-6287e74c228abb9b1d1146756ce42b79._googlecast._tcp.local. to 192.168.1.17:8009
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.socket_client] [Chromecast:8009] Connecting to 192.168.1.17:8009
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [None:8009] connection listener: 643cf8f0 (CastStatusListener)
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=media_player.woonkamer, old_state=None, new_state=<state media_player.woonkamer=unavailable; friendly_name=Woonkamer, supported_features=21389 @ 2019-08-01T11:43:34.394385+02:00>>
2019-08-01 10:43:34 DEBUG (Thread-3) [homeassistant.components.cast.media_player] [media_player.thuisgroep Thuisgroep (192.168.1.17:43008)] Received cast device connection status: CONNECTING
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.components.cast.media_player] [media_player.woonkamer Woonkamer (192.168.1.21:8009)] Connecting to cast device by service {'Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local.'}
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [None:8009] connection listener: 643cf890 (Listener)
2019-08-01 10:43:34 DEBUG (SyncWorker_1) [pychromecast] _get_chromecast_from_service {'Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local.'}
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.discovery] get_info_from_service resolved service Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local. to service_info ServiceInfo(type='_googlecast._tcp.local.', name='Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local.$
2019-08-01 10:43:34 INFO (SyncWorker_1) [pychromecast] Querying device status
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:8009] Resolved service Google-Cast-Group-a508307faea44310aaea3e5e06a30df0._googlecast._tcp.local. to 192.168.1.17:43008
2019-08-01 10:43:34 DEBUG (SyncWorker_1) [pychromecast.discovery] get_info_from_service resolved service Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local. to service_info ServiceInfo(type='_googlecast._tcp.local.', name='Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.loca$
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:43008] Connecting to 192.168.1.17:43008
2019-08-01 10:43:34 DEBUG (SyncWorker_1) [pychromecast.dial] Resolved service Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local. to 192.168.1.21
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.socket_client] [Chromecast:8009] connection listener: 67fe2310 (CastStatusListener)
2019-08-01 10:43:34 DEBUG (Thread-2) [homeassistant.components.cast.media_player] [media_player.chromecast Chromecast (192.168.1.17:8009)] Received cast device connection status: CONNECTED
2019-08-01 10:43:34 DEBUG (Thread-2) [homeassistant.components.cast.media_player] [media_player.chromecast Chromecast (192.168.1.17:8009)] Cast device availability changed: CONNECTED
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=media_player.chromecast, old_state=<state media_player.chromecast=unavailable; friendly_name=Chromecast, supported_features=21389 @ 2019-08-01T11:43:34.311834+02:00>, new_state=<state media_player.chromecast=$
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.controllers] Receiver:Updating status
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.socket_client] [Chromecast:8009] Sending: Message urn:x-cast:com.google.cast.tp.connection from sender-0 to receiver-0: {'type': 'CONNECT', 'origin': {}, 'userAgent': 'PyChromecast', 'senderInfo': {'sdkType': 2, 'version': '15.605.1.3', 'browserVersion': '44.0.2403$
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.socket_client] [None:8009] connection listener: 68b04450 (CastStatusListener)
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.socket_client] [Chromecast:8009] Sending: Message urn:x-cast:com.google.cast.receiver from sender-0 to receiver-0: {'type': 'GET_STATUS', 'requestId': 1}
2019-08-01 10:43:34 DEBUG (Thread-4) [homeassistant.components.cast.media_player] [media_player.woonkamer Woonkamer (192.168.1.21:8009)] Received cast device connection status: CONNECTING
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.discovery] get_info_from_service resolved service Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local. to service_info ServiceInfo(type='_googlecast._tcp.local.', name='Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local.',$
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.socket_client] [Chromecast:8009] Connected!
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.socket_client] [Woonkamer:8009] Resolved service Google-Home-Mini-0b3c502c13f6c1f5b5255ae234fb0d4b._googlecast._tcp.local. to 192.168.1.21:8009
2019-08-01 10:43:34 DEBUG (Thread-2) [root] Thread started...
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.socket_client] [Woonkamer:8009] Connecting to 192.168.1.21:8009
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:43008] connection listener: 643cf8f0 (CastStatusListener)
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.socket_client] [Chromecast:8009] Received: Message urn:x-cast:com.google.cast.receiver from receiver-0 to sender-0: {'requestId': 1, 'status': {'applications': [{'appId': 'E8C28D3C', 'displayName': 'Backdrop', 'iconUrl': '', 'isIdleScreen': True, 'launchedFromCloud$
2019-08-01 10:43:34 DEBUG (Thread-3) [homeassistant.components.cast.media_player] [media_player.thuisgroep Thuisgroep (192.168.1.17:43008)] Received cast device connection status: CONNECTED
2019-08-01 10:43:34 DEBUG (Thread-2) [pychromecast.controllers] Received status: CastStatus(is_active_input=False, is_stand_by=True, volume_level=1.0, volume_muted=False, app_id='E8C28D3C', display_name='Backdrop', namespaces=['urn:x-cast:com.google.cast.debugoverlay', 'urn:x-cast:com.google.cast.cac', 'urn:x-cast:$
2019-08-01 10:43:34 DEBUG (Thread-3) [homeassistant.components.cast.media_player] [media_player.thuisgroep Thuisgroep (192.168.1.17:43008)] Cast device availability changed: CONNECTED
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=media_player.thuisgroep, old_state=<state media_player.thuisgroep=unavailable; friendly_name=Thuisgroep, supported_features=21389 @ 2019-08-01T11:43:34.343152+02:00>, new_state=<state media_player.thuisgroep=$
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:43008] connection listener: 643cf890 (Listener)
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:43008] Sending: Message urn:x-cast:com.google.cast.tp.connection from sender-0 to receiver-0: {'type': 'CONNECT', 'origin': {}, 'userAgent': 'PyChromecast', 'senderInfo': {'sdkType': 2, 'version': '15.605.1.3', 'browserVersion': '44.0.240$
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:43008] Sending: Message urn:x-cast:com.google.cast.multizone from sender-0 to receiver-0: {'type': 'GET_STATUS', 'requestId': 1}
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.controllers] Receiver:Updating status
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:43008] Sending: Message urn:x-cast:com.google.cast.receiver from sender-0 to receiver-0: {'type': 'GET_STATUS', 'requestId': 2}
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:43008] Connected!
2019-08-01 10:43:34 DEBUG (Thread-3) [root] Thread started...
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.socket_client] [Woonkamer:8009] connection listener: 68b04450 (CastStatusListener)
2019-08-01 10:43:34 DEBUG (Thread-4) [homeassistant.components.cast.media_player] [media_player.woonkamer Woonkamer (192.168.1.21:8009)] Received cast device connection status: CONNECTED
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.socket_client] [Woonkamer:8009] connection listener: 68b04450 (CastStatusListener)
2019-08-01 10:43:34 DEBUG (Thread-4) [homeassistant.components.cast.media_player] [media_player.woonkamer Woonkamer (192.168.1.21:8009)] Received cast device connection status: CONNECTED
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:43008] Received: Message urn:x-cast:com.google.cast.multizone from receiver-0 to sender-0: {'requestId': 1, 'status': {'devices': [{'capabilities': 196613, 'deviceId': '6287e74c-228a-bb9b-1d11-46756ce42b79', 'name': 'Chromecast', 'volume'$
2019-08-01 10:43:34 DEBUG (Thread-4) [homeassistant.components.cast.media_player] [media_player.woonkamer Woonkamer (192.168.1.21:8009)] Cast device availability changed: CONNECTED
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.controllers.multizone] (a508307f-aea4-4310-aaea-3e5e06a30df0) Added members ['6287e74c-228a-bb9b-1d11-46756ce42b79'], Removed members: []
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.controllers] Receiver:Updating status
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=media_player.woonkamer, old_state=<state media_player.woonkamer=unavailable; friendly_name=Woonkamer, supported_features=21389 @ 2019-08-01T11:43:34.394385+02:00>, new_state=<state media_player.woonkamer=off;$
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.controllers.multizone] (a508307f-aea4-4310-aaea-3e5e06a30df0) Added member 6287e74c-228a-bb9b-1d11-46756ce42b79(Chromecast), members: {'6287e74c-228a-bb9b-1d11-46756ce42b79': 'Chromecast'}
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.socket_client] [Woonkamer:8009] Sending: Message urn:x-cast:com.google.cast.tp.connection from sender-0 to receiver-0: {'type': 'CONNECT', 'origin': {}, 'userAgent': 'PyChromecast', 'senderInfo': {'sdkType': 2, 'version': '15.605.1.3', 'browserVersion': '44.0.2403.$
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.socket_client] [Thuisgroep:43008] Received: Message urn:x-cast:com.google.cast.receiver from receiver-0 to sender-0: {'requestId': 2, 'status': {'userEq': {}, 'volume': {'controlType': 'attenuation', 'level': 1.0, 'muted': False, 'stepInterval': 0.05000000074505806$
2019-08-01 10:43:34 DEBUG (Thread-3) [pychromecast.controllers] Received status: CastStatus(is_active_input=None, is_stand_by=None, volume_level=1.0, volume_muted=False, app_id=None, display_name=None, namespaces=[], session_id=None, transport_id=None, status_text='')
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.socket_client] [Woonkamer:8009] Sending: Message urn:x-cast:com.google.cast.receiver from sender-0 to receiver-0: {'type': 'GET_STATUS', 'requestId': 1}
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.socket_client] [Woonkamer:8009] Connected!
2019-08-01 10:43:34 DEBUG (Thread-4) [root] Thread started...
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.socket_client] [Woonkamer:8009] Received: Message urn:x-cast:com.google.cast.receiver from receiver-0 to sender-0: {'requestId': 1, 'status': {'userEq': {'high_shelf': {'frequency': 4500.0, 'gain_db': 0.0, 'quality': 0.707}, 'low_shelf': {'frequency': 150.0, 'gain_$
2019-08-01 10:43:34 DEBUG (Thread-4) [pychromecast.controllers] Received status: CastStatus(is_active_input=None, is_stand_by=None, volume_level=0.800000011920929, volume_muted=False, app_id=None, display_name=None, namespaces=[], session_id=None, transport_id=None, status_text='')
2019-08-01 10:43:34 INFO (MainThread) [homeassistant.bootstrap] Home Assistant initialized in 10.66s
2019-08-01 10:43:34 INFO (MainThread) [homeassistant.core] Starting Home Assistant
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event homeassistant_start[L]>
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.components.person] Subscribe to device trackers for person.marjolein
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.components.person] Subscribe to device trackers for person.luuk
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.helpers.restore_state] Dumping states
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=person.marjolein, old_state=<state person.marjolein=not_home; editable=True, id=64cde2e68d8d4c20bb491c3a6cc2e843, latitude=52.0355989, longitude=5.3450631, gps_accuracy=19.2450008392334, source=person.marjole$
2019-08-01 10:43:34 DEBUG (SyncWorker_5) [homeassistant.helpers.storage] Writing data for core.restore_state
2019-08-01 10:43:34 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=person.luuk, old_state=<state person.luuk=not_home; editable=True, id=4477aca308f14be7a775cfcd70d3541c, latitude=51.97816905469018, longitude=5.343193419157231, gps_accuracy=6.0, source=person.luuk, user_id=6$
2019-08-01 10:43:34 INFO (MainThread) [custom_components.hacs] Runing startup tasks.
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.token] 9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7
2019-08-01 10:43:34 INFO (MainThread) [custom_components.hacs] Trying to load existing data.
2019-08-01 10:43:34 INFO (MainThread) [custom_components.hacs] Running scheduled update of installed repositories
2019-08-01 10:43:34 INFO (MainThread) [custom_components.hacs] Fetching updated blacklist
2019-08-01 10:43:34 INFO (MainThread) [homeassistant.core] Timer:starting
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.blacklist] custom-cards/boilerplate-card
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.blacklist] custom-cards/custom-card-helpers
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.blacklist] custom-cards/information
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.blacklist] custom-cards/tracker-card
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.blacklist] custom-components/blueprint
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.blacklist] custom-components/information
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.blacklist] ljmerza/waze-card
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.blacklist] custom-components/custom_updater
2019-08-01 10:43:34 DEBUG (MainThread) [custom_components.hacs.blacklist] boralyl/hass-smartthinq
2019-08-01 10:43:36 INFO (MainThread) [custom_components.hacs.integration] Fetching updated repository list
2019-08-01 10:43:39 DEBUG (MainThread) [homeassistant.components.http.view] Serving /auth/token to 213.125.155.60 (auth: False)
2019-08-01 10:43:39 DEBUG (MainThread) [homeassistant.components.http.view] Serving /api/websocket to 213.125.155.60 (auth: False)
2019-08-01 10:43:39 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Connected
2019-08-01 10:43:39 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'type': 'auth_required', 'ha_version': '0.96.5'}
2019-08-01 10:43:39 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'auth', 'access_token': 'eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJpc3MiOiI0YmIyZWM2YTE3ZGM0ZGI4YTJiYTYxNzA4YzVlNTJhNiIsImlhdCI6MTU2NDY1MjYxOSwiZXhwIjoxNTY0NjU0NDE5fQ.cdZ1psutfBAvh1RGPzAeaNbej6$
2019-08-01 10:43:39 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received access_token
2019-08-01 10:43:39 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Auth OK
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'type': 'auth_ok', 'ha_version': '0.96.5'}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'subscribe_events', 'event_type': 'state_changed', 'id': 2}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'subscribe_events', 'event_type': 'component_loaded', 'id': 3}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'subscribe_events', 'event_type': 'core_config_updated', 'id': 4}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'subscribe_events', 'event_type': 'service_registered', 'id': 5}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'subscribe_events', 'event_type': 'service_removed', 'id': 6}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'subscribe_events', 'event_type': 'panels_updated', 'id': 7}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'subscribe_events', 'event_type': 'themes_updated', 'id': 8}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'subscribe_events', 'event_type': 'persistent_notifications_updated', 'id': 9}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'subscribe_events', 'event_type': 'lovelace_updated', 'id': 10}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'get_states', 'id': 11}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'get_config', 'id': 12}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'get_services', 'id': 13}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'get_panels', 'id': 14}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'frontend/get_themes', 'id': 15}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'auth/current_user', 'id': 16}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 2, 'type': 'result', 'success': True, 'result': None}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 3, 'type': 'result', 'success': True, 'result': None}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 4, 'type': 'result', 'success': True, 'result': None}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 5, 'type': 'result', 'success': True, 'result': None}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 6, 'type': 'result', 'success': True, 'result': None}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 7, 'type': 'result', 'success': True, 'result': None}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 8, 'type': 'result', 'success': True, 'result': None}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 9, 'type': 'result', 'success': True, 'result': None}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 10, 'type': 'result', 'success': True, 'result': None}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 11, 'type': 'result', 'success': True, 'result': [<state sun.sun=above_horizon; next_dawn=2019-08-02T03:20:01+00:00, next_dusk=2019-08-01T20:11:52+00:00, next_midnight=2019-08-01T23:44:59+00:00,$
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 12, 'type': 'result', 'success': True, 'result': {'latitude': 51.9851023186331, 'longitude': 5.333105251193047, 'elevation': 0, 'unit_system': {'length': 'km', 'mass': 'g', 'pressure': 'Pa', 'te$
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 14, 'type': 'result', 'success': True, 'result': {'lovelace': {'component_name': 'lovelace', 'icon': None, 'title': None, 'config': {'mode': 'storage'}, 'url_path': 'lovelace', 'require_admin': $
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 15, 'type': 'result', 'success': True, 'result': {'themes': {}, 'default_theme': 'default'}}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'lovelace/config', 'force': False, 'id': 17}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'frontend/get_translations', 'language': 'nl', 'id': 18}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'persistent_notification/get', 'id': 19}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'frontend/get_translations', 'language': 'nl', 'id': 18}
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Received {'type': 'persistent_notification/get', 'id': 19}
2019-08-01 10:43:40 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /home/homeassistant/.homeassistant/.storage/auth_module.totp
2019-08-01 10:43:40 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 19, 'type': 'result', 'success': True, 'result': []}
2019-08-01 10:43:40 INFO (SyncWorker_7) [homeassistant.loader] Loaded wemo from homeassistant.components.wemo
2019-08-01 10:43:41 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/overview to 213.125.155.60 (auth: False)
2019-08-01 10:43:41 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (overview) called
2019-08-01 10:43:41 INFO (SyncWorker_11) [homeassistant.loader] Loaded lifx from homeassistant.components.lifx
2019-08-01 10:43:41 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 16, 'type': 'result', 'success': True, 'result': {'id': '60b0c26cbb4c467a9ea7364e271d42ae', 'name': 'Luuk', 'is_owner': True, 'is_admin': True, 'credentials': [{'auth_provider_type': 'homeassist$
2019-08-01 10:43:41 INFO (SyncWorker_12) [homeassistant.loader] Loaded ios from homeassistant.components.ios
2019-08-01 10:43:41 DEBUG (SyncWorker_9) [homeassistant.helpers.storage] Writing data for auth
2019-08-01 10:43:41 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 13, 'type': 'result', 'success': True, 'result': {'persistent_notification': {'create': {'description': 'Show a notification in the frontend.', 'fields': OrderedDict([('message', OrderedDict([('$
2019-08-01 10:43:41 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {"id": 17, "type": "result", "success": true, "result": {"resources": [{"type": "module", "url": "https://cdn.jsdelivr.net/gh/bramkragten/custom-ui@master/weather-card/weather-card.min.js"}, {"type": "$
2019-08-01 10:43:41 INFO (SyncWorker_8) [homeassistant.loader] Loaded ambiclimate from homeassistant.components.ambiclimate
2019-08-01 10:43:41 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/overview to 213.125.155.60 (auth: False)
2019-08-01 10:43:41 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (overview) called
2019-08-01 10:43:41 INFO (SyncWorker_17) [homeassistant.loader] Loaded logi_circle from homeassistant.components.logi_circle
2019-08-01 10:43:41 INFO (SyncWorker_10) [homeassistant.loader] Loaded notion from homeassistant.components.notion
2019-08-01 10:43:41 INFO (SyncWorker_7) [homeassistant.loader] Loaded openuv from homeassistant.components.openuv
2019-08-01 10:43:41 INFO (SyncWorker_5) [homeassistant.loader] Loaded life360 from homeassistant.components.life360
2019-08-01 10:43:41 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/materialize.min.css.gz to 213.125.155.60 (auth: False)
2019-08-01 10:43:41 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:43:41 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/all.min.css.gz to 213.125.155.60 (auth: False)
2019-08-01 10:43:41 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:43:41 INFO (SyncWorker_3) [homeassistant.loader] Loaded iqvia from homeassistant.components.iqvia
2019-08-01 10:43:41 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/static/hacs.css to 213.125.155.60 (auth: False)
2019-08-01 10:43:41 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:43:41 INFO (SyncWorker_9) [homeassistant.loader] Loaded tplink from homeassistant.components.tplink
2019-08-01 10:43:41 INFO (SyncWorker_0) [homeassistant.loader] Loaded zha from homeassistant.components.zha
2019-08-01 10:43:42 INFO (SyncWorker_1) [homeassistant.loader] Loaded nest from homeassistant.components.nest
2019-08-01 10:43:42 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/materialize.min.js.gz to 213.125.155.60 (auth: False)
2019-08-01 10:43:42 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:43:42 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/hacs.js to 213.125.155.60 (auth: False)
2019-08-01 10:43:42 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:43:42 INFO (SyncWorker_12) [homeassistant.loader] Loaded ipma from homeassistant.components.ipma
2019-08-01 10:43:42 INFO (SyncWorker_4) [homeassistant.loader] Loaded deconz from homeassistant.components.deconz
2019-08-01 10:43:42 INFO (SyncWorker_10) [homeassistant.loader] Loaded ifttt from homeassistant.components.ifttt
2019-08-01 10:43:42 INFO (SyncWorker_7) [homeassistant.loader] Loaded hangouts from homeassistant.components.hangouts
2019-08-01 10:43:42 INFO (SyncWorker_5) [homeassistant.loader] Loaded simplisafe from homeassistant.components.simplisafe
2019-08-01 10:43:42 INFO (SyncWorker_13) [homeassistant.loader] Loaded somfy from homeassistant.components.somfy
2019-08-01 10:43:42 INFO (SyncWorker_3) [homeassistant.loader] Loaded zwave from homeassistant.components.zwave
2019-08-01 10:43:42 INFO (SyncWorker_16) [homeassistant.loader] Loaded heos from homeassistant.components.heos
2019-08-01 10:43:42 INFO (SyncWorker_15) [homeassistant.loader] Loaded upnp from homeassistant.components.upnp
2019-08-01 10:43:42 INFO (SyncWorker_17) [homeassistant.loader] Loaded ps4 from homeassistant.components.ps4
2019-08-01 10:43:42 INFO (SyncWorker_2) [homeassistant.loader] Loaded plaato from homeassistant.components.plaato
2019-08-01 10:43:42 INFO (SyncWorker_19) [homeassistant.loader] Loaded point from homeassistant.components.point
2019-08-01 10:43:42 INFO (SyncWorker_0) [homeassistant.loader] Loaded tellduslive from homeassistant.components.tellduslive
2019-08-01 10:43:42 INFO (SyncWorker_14) [homeassistant.loader] Loaded unifi from homeassistant.components.unifi
2019-08-01 10:43:42 INFO (SyncWorker_11) [homeassistant.loader] Loaded adguard from homeassistant.components.adguard
2019-08-01 10:43:42 INFO (SyncWorker_1) [homeassistant.loader] Loaded rainmachine from homeassistant.components.rainmachine
2019-08-01 10:43:42 INFO (SyncWorker_6) [homeassistant.loader] Loaded smhi from homeassistant.components.smhi
2019-08-01 10:43:42 INFO (SyncWorker_16) [homeassistant.loader] Loaded luftdaten from homeassistant.components.luftdaten
2019-08-01 10:43:42 INFO (SyncWorker_12) [homeassistant.loader] Loaded twilio from homeassistant.components.twilio
2019-08-01 10:43:42 INFO (SyncWorker_9) [homeassistant.loader] Loaded smartthings from homeassistant.components.smartthings
2019-08-01 10:43:42 INFO (SyncWorker_4) [homeassistant.loader] Loaded locative from homeassistant.components.locative
2019-08-01 10:43:42 INFO (SyncWorker_18) [homeassistant.loader] Loaded sonos from homeassistant.components.sonos
2019-08-01 10:43:42 INFO (SyncWorker_10) [homeassistant.loader] Loaded hue from homeassistant.components.hue
2019-08-01 10:43:42 INFO (SyncWorker_7) [homeassistant.loader] Loaded dialogflow from homeassistant.components.dialogflow
2019-08-01 10:43:42 INFO (SyncWorker_5) [homeassistant.loader] Loaded wwlln from homeassistant.components.wwlln
2019-08-01 10:43:42 INFO (SyncWorker_13) [homeassistant.loader] Loaded daikin from homeassistant.components.daikin
2019-08-01 10:43:42 INFO (SyncWorker_3) [homeassistant.loader] Loaded esphome from homeassistant.components.esphome
2019-08-01 10:43:42 INFO (SyncWorker_16) [homeassistant.loader] Loaded mailgun from homeassistant.components.mailgun
2019-08-01 10:43:42 INFO (SyncWorker_15) [homeassistant.loader] Loaded homematicip_cloud from homeassistant.components.homematicip_cloud
2019-08-01 10:43:42 INFO (SyncWorker_17) [homeassistant.loader] Loaded axis from homeassistant.components.axis
2019-08-01 10:43:42 INFO (SyncWorker_2) [homeassistant.loader] Loaded homekit_controller from homeassistant.components.homekit_controller
2019-08-01 10:43:42 INFO (SyncWorker_19) [homeassistant.loader] Loaded geofency from homeassistant.components.geofency
2019-08-01 10:43:42 INFO (SyncWorker_0) [homeassistant.loader] Loaded emulated_roku from homeassistant.components.emulated_roku
2019-08-01 10:43:42 INFO (SyncWorker_14) [homeassistant.loader] Loaded owntracks from homeassistant.components.owntracks
2019-08-01 10:43:42 INFO (SyncWorker_11) [homeassistant.loader] Loaded ambient_station from homeassistant.components.ambient_station
2019-08-01 10:43:42 INFO (SyncWorker_1) [homeassistant.loader] Loaded mqtt from homeassistant.components.mqtt
2019-08-01 10:43:42 INFO (SyncWorker_6) [homeassistant.loader] Loaded toon from homeassistant.components.toon
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/light/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/recorder/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/script/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/kodi/.translations/media_player.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/tradfri/.translations/light.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/notion/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/tts/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/automation/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/switch/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/automation/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/switch/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/gpslogger/.translations/device_tracker.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/sensor/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/cast/.translations/media_player.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/configurator/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/ssdp/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/homeassistant/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/updater/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/notify/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/webhook/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /home/homeassistant/.homeassistant/custom_components/hacs/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/tradfri/.translations/switch.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /home/homeassistant/.homeassistant/custom_components/hacs/.translations/sensor.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/group/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/lovelace/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/zeroconf/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/sun/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/media_player/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/system_log/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/person/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/panel_iframe/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/cloud/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/command_line/.translations/switch.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/config/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/google_assistant/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/frontend/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/map/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/api/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/wwlln/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/device_tracker/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/weather/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/webostv/.translations/media_player.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/websocket_api/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/system_health/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/mobile_app/.translations/notify.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/history/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/logbook/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/met/.translations/weather.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/http/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/wake_on_lan/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/logger/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/tradfri/.translations/sensor.nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/default_config/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_8) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/persistent_notification/.translations/nl.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/light/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/recorder/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/script/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/kodi/.translations/media_player.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/tradfri/.translations/light.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/tts/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/automation/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/switch/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/gpslogger/.translations/device_tracker.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/sensor/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/cast/.translations/media_player.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/configurator/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/ssdp/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/homeassistant/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/updater/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/notify/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/webhook/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /home/homeassistant/.homeassistant/custom_components/hacs/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/tradfri/.translations/switch.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /home/homeassistant/.homeassistant/custom_components/hacs/.translations/sensor.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/group/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/lovelace/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/zeroconf/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/sun/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/media_player/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/system_log/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/person/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/panel_iframe/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/cloud/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/command_line/.translations/switch.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/config/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/google_assistant/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/frontend/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/map/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/api/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/map/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/api/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/device_tracker/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/weather/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/webostv/.translations/media_player.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/websocket_api/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/system_health/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/mobile_app/.translations/notify.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/history/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/logbook/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/met/.translations/weather.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/http/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/wake_on_lan/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/logger/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/tradfri/.translations/sensor.en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/default_config/.translations/en.json
2019-08-01 10:43:42 DEBUG (SyncWorker_12) [homeassistant.util.json] JSON file not found: /srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/persistent_notification/.translations/en.json
2019-08-01 10:43:42 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 18, 'type': 'result', 'success': True, 'result': {'resources': {'component.wemo.config.abort.no_devices_found': 'Geen Wemo-apparaten gevonden op het netwerk.', 'component.wemo.config.abort.singl$
2019-08-01 10:43:44 DEBUG (SyncWorker_9) [asyncio] Using selector: EpollSelector
2019-08-01 10:43:44 DEBUG (SyncWorker_9) [pylgtv.webos_client] send command to ws://192.168.1.12:3000
2019-08-01 10:43:47 DEBUG (SyncWorker_9) [pylgtv.webos_client] command failed to connect to ws://192.168.1.12:3000
2019-08-01 10:43:54 INFO (MainThread) [custom_components.hacs.plugin] Fetching updated repository list
2019-08-01 10:43:55 DEBUG (MainThread) [homeassistant.components.http.view] Serving /api/history/period/2019-07-31T22:00:00.000Z to 213.125.155.60 (auth: True)
2019-08-01 10:43:55 DEBUG (SyncWorker_10) [homeassistant.components.recorder.util] converting 93 rows to native objects took 0.099019s
2019-08-01 10:43:55 DEBUG (SyncWorker_10) [homeassistant.components.history] get_significant_states took 0.110602s
2019-08-01 10:43:55 DEBUG (SyncWorker_10) [homeassistant.components.history] getting 0 first datapoints took 0.009284s
2019-08-01 10:43:55 DEBUG (MainThread) [homeassistant.components.history] Extracted 84 states in 0.125311s
2019-08-01 10:43:57 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/overview to 213.125.155.60 (auth: False)
2019-08-01 10:43:57 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (overview) called
2019-08-01 10:43:57 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/materialize.min.css.gz to 213.125.155.60 (auth: False)
2019-08-01 10:43:57 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:43:57 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/all.min.css.gz to 213.125.155.60 (auth: False)
2019-08-01 10:43:57 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:43:57 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/materialize.min.js.gz to 213.125.155.60 (auth: False)
2019-08-01 10:43:57 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:43:57 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/static/hacs.css to 213.125.155.60 (auth: False)
2019-08-01 10:43:57 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:43:57 DEBUG (MainThread) [homeassistant.components.http.view] Serving /hacsweb/9dedebb0-2d70-409f-b0dd-e95c3b394035-fd770e10-0aec-488b-b3be-39dbca8cbda7/static/hacs.js to 213.125.155.60 (auth: False)
2019-08-01 10:43:57 DEBUG (MainThread) [custom_components.hacs.web] Endpoint (static) called
2019-08-01 10:44:01 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.hacs, old_state=<state sensor.hacs=unknown; unit_of_measurement=pending update(s), friendly_name=hacs, icon=mdi:package @ 2019-08-01T11:43:30.759051+02:00>, new_state=<state sensor.hacs=0; unit_of_meas$
2019-08-01 10:44:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1725833424] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.hacs, old_state=<state sensor.hacs=unknown; unit_of_measurement=pending update(s), friendly_name=hacs, icon=mdi:package @ 2$
2019-08-01 10:44:06 DEBUG (SyncWorker_15) [asyncio] Using selector: EpollSelector
2019-08-01 10:44:06 DEBUG (SyncWorker_15) [pylgtv.webos_client] send command to ws://192.168.1.12:3000
2019-08-01 10:44:09 DEBUG (SyncWorker_15) [pylgtv.webos_client] command failed to connect to ws://192.168.1.12:3000
Something looks really off here.
It should load a lot more.
Paste the content of .storage/hacs
{
"hacs": {
"view": "Grid",
"schema": "4",
"endpoints": {}
},
"repositories": {
"131915802": {
"custom": false,
"description": "Component to integrate with OpenStreetMap Reverse Geocode (PLACE)",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "b51a5fb",
"name": "Places",
"new": true,
"repository_name": "custom-components/places",
"repository_type": "integration",
"show_beta": false,
"topics": [],
"track": true,
"last_release_tag": "1.3",
"version_installed": null,
"selected_tag": null
},
"139892990": {
"custom": false,
"description": "\ud83c\udf7b Display information about random beers from Brewdog as a sensor in Home Assistant, you can use this in a push notification next time you visit a bar.",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "0b938d4",
"name": "BrewDog",
"new": true,
"repository_name": "custom-components/brewdog",
"repository_type": "integration",
"show_beta": false,
"topics": [
"api",
"brewdog",
"custom-components",
"home-assistant",
"homeassistant",
"integration",
"punkapi"
],
"track": true,
"last_release_tag": null,
"version_installed": null,
"selected_tag": null
},
"139894340": {
"custom": false,
"description": "A sensor that give you information from alerts.weather.gov.",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "9acd01b",
"name": "Weatheralerts",
"new": true,
"repository_name": "custom-components/weatheralerts",
"repository_type": "integration",
"show_beta": false,
"topics": [
"custom-components",
"home-assistant",
"homeassistant",
"weatheralerts"
],
"track": true,
"last_release_tag": null,
"version_installed": null,
"selected_tag": null
},
"139894509": {
"custom": false,
"description": "A sensor that give you information about next departure from spesified stop.",
"hide": false,
"installed_commit": null,
"installed": false,
"installed_commit": null,
"installed": false,
"last_commit": "d07110b",
"name": "Wienerlinien",
"new": true,
"repository_name": "custom-components/wienerlinien",
"repository_type": "integration",
"show_beta": false,
"topics": [
"custom-components",
"home-assistant",
"homeassistant",
"wiener-linien"
],
"track": true,
"last_release_tag": null,
"version_installed": null,
"selected_tag": null
},
"140146811": {
"custom": false,
"description": "A Custom component for Home-Assistant that checks if your Raspberry Pi power supply is giving enough voltage from the kernel.",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "b1e63c8",
"name": "Raspberry Pi Power Supply Checker",
"new": true,
"repository_name": "custom-components/sensor.rpi_power",
"repository_type": "integration",
"show_beta": false,
"topics": [
"community-driven",
"component",
"homeassistant",
"power",
"raspberry-pi",
"sensor"
],
"track": true,
"last_release_tag": "0.1.5",
"version_installed": null,
"selected_tag": null
},
"140146868": {
"custom": false,
"description": "\ud83c\udf7b Untappd Integration",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "f3ee99b",
"name": "Untappd",
"new": true,
"repository_name": "custom-components/sensor.untappd",
"repository_type": "integration",
"show_beta": false,
"topics": [
"automations",
"badges",
"beer",
"homeassistant",
"homeassistant-components",
"untappd",
"untappd-api"
],
"track": true,
"last_release_tag": "0.1.5",
"version_installed": null,
"selected_tag": null
},
"140169152": {
"custom": false,
"description": "A platform which allows you to get information about sucessfull logins to Home Assistant.",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "894b962",
"name": "Authenticated",
"new": true,
"repository_name": "custom-components/authenticated",
"new": true,
"repository_name": "custom-components/authenticated",
"repository_type": "integration",
"show_beta": false,
"topics": [
"custom-components",
"home-assistant",
"homeassistant",
"security"
],
"track": true,
"last_release_tag": "1.1.1",
"version_installed": null,
"selected_tag": null
},
"143647651": {
"custom": false,
"description": "A camera platform that give you random images from Unsplash presented as a camera feed.",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "814bc72",
"name": "Unsplash",
"new": true,
"repository_name": "custom-components/unsplash",
"repository_type": "integration",
"show_beta": false,
"topics": [
"camera",
"home-assistant",
"integration",
"unsplash",
"unsplash-api"
],
"track": true,
"last_release_tag": "0.5.0",
"version_installed": null,
"selected_tag": null
},
"143741845": {
"custom": false,
"description": "A camera platform that give you a combined feed of your defined camera entities.",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "c5a00d0",
"name": "Camera combined",
"new": true,
"repository_name": "custom-components/combined",
"repository_type": "integration",
"show_beta": false,
"topics": [],
"track": true,
"last_release_tag": "0.1.0",
"version_installed": null,
"selected_tag": null
},
"145180996": {
"custom": false,
"description": "\ud83d\udcf0 RSS Feed Integration",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "675378d",
"name": "Feedparser",
"new": true,
"repository_name": "custom-components/feedparser",
"repository_type": "integration",
"show_beta": false,
"topics": [],
"track": true,
"last_release_tag": "0.0.9",
"version_installed": null,
"selected_tag": null
},
"145777833": {
"custom": false,
"description": "\ud83d\udcb5 Personal Capital Integration for Bank Account Monitoring",
"hide": false,
"installed_commit": null,
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "72785ef",
"name": "Personal Capital",
"new": true,
"repository_name": "custom-components/sensor.personalcapital",
"repository_type": "integration",
"show_beta": false,
"topics": [],
"track": true,
"last_release_tag": "0.1.1",
"version_installed": null,
"selected_tag": null
},
"146379582": {
"custom": false,
"description": "\ud83d\udcfa Trakt Integration for Upcoming Media Card",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "2d5071c",
"name": "Trakt",
"new": true,
"repository_name": "custom-components/sensor.trakt",
"repository_type": "integration",
"show_beta": false,
"topics": [],
"track": true,
"last_release_tag": "1.0.2",
"version_installed": null,
"selected_tag": null
},
"146510412": {
"custom": false,
"description": "E-Thermostaat (ICY) component for Home Assistant",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "81f56b4",
"name": "ICY E-thermostaat",
"new": true,
"repository_name": "custom-components/climate.e_thermostaat",
"repository_type": "integration",
"show_beta": false,
"topics": [
"e-thermostaat",
"home-assistant",
"icy"
],
"track": true,
"last_release_tag": "0.3.1",
"version_installed": null,
"selected_tag": null
},
"146660369": {
"custom": false,
"description": "Sony Bravia TV (Pre-Shared Key) component for Home Assistant",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "0c9c3ed",
"name": "Bravia TV PSK",
"new": true,
"repository_name": "custom-components/media_player.braviatv_psk",
"repository_type": "integration",
"show_beta": false,
"topics": [
"bravia",
"home-assistant",
"psk",
"sony"
],
"track": true,
"last_release_tag": "0.3.0",
"version_installed": null,
"selected_tag": null
},
"146792954": {
"custom": false,
"146792954": {
"custom": false,
"description": "\ud83d\udcfa Sonarr component to feed Upcoming Media Card.",
"hide": false,
"installed_commit": null,
"installed": false,
"last_commit": "ade2b8e",
"name": "Sonarr Upcoming Media",
"new": true,
"repository_name": "custom-components/sensor.sonarr_upcoming_media",
"repository_type": "integration",
"show_beta": false,
"topics": [],
"track": true,
"last_release_tag": "0.2.1",
"version_installed": null,
"selected_tag": null
}
}
}
There is your issue, that file is no longer valis json.. (This can happen if you have manually changed that file.) If you have a backup of it, overwrite it with that file. if not delete it and restart HA (you will not get your overview back, but HACS will start working again.
fixed it: i have remove the .storage/hacs file, then removed the /custom_components/hacs folder then i commented out the hacs parts in the config file, renamed the home-assistant database then restarted homeassistant, after that i re-cloned the git repository and did the install process again. problem solved, everything runs.
probable cause: restarting the home-assistant service while the .storage/hacs file was being populated with data causing it to go corrupt.
Version of HACS
newest
Describe the bug
when accessing hacs page, the overview page i empty, every item in the store tab is set to "new" and whenever i access the settings tab it throws an error 500
Debug log