search

alandtse / alexa_media_player

This is a custom component to allow control of Amazon Alexa devices in Home Assistant using the unofficial Alexa API.
Apache License 2.0
1.36k stars 264 forks source link

New Alexa devices not appearing #272

Closed gmalbert closed 4 years ago

gmalbert commented 4 years ago

Describe the bug A clear and concise description of what the bug is. I added an Echo to my house (and network), but it doesn't show up in the media_players section, though I can use it normally on my network.

I also changed the name of one of my echos that had been showing up in HA from Kitchen to Office, and the media_player name still shows as media_player.kitchen in states even though the friendly name is Office. On the UI, it shows its friendly name as Office

The new echo was named Kitchen. I don't know whether that affected how this program works or not. I deleted the pickle file several times and restarted, but I'm still not finding the new echo and the old echo hasn't changed its name. Using the current version of your program: 1.41. To Reproduce Steps to reproduce the behavior:

  1. Go to '...'
  2. Click on '....'
  3. Scroll down to '....'
  4. See error

Expected behavior A clear and concise description of what you expected to happen. Expected behavior is that new echo will appear and renamed echo will change name consistent with its friendly name. Screenshots If applicable, add screenshots to help explain your problem.

System details

Additional context Add any other context about the problem here.

alandtse commented 4 years ago

Please check that the communications setting is enabled for each device in the app. If that is confirmed, please enable debugging and provide the logs. The wiki will show you how.

gmalbert commented 4 years ago

I added the debug: True into the configuration.yaml, but it doesn't generate the html files as the wiki indicated. Do you want me to do or through logger?

alandtse commented 4 years ago

Debug true is only needed for testing login issues. Logger is needed for everything else. Please also confirm your region and url you are using.

gmalbert commented 4 years ago

URL is amazon.com. I am in the US but don't have a region set anywhere if that's what you were asking.

gmalbert commented 4 years ago
``` 9-08-09 12:50:09 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for alexa_media 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-09 12:50:09 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-09 12:50:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:09 INFO (MainThread) [homeassistant.setup] Setup of domain logger took 0.0 seconds. 2019-08-09 12:50:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:09 INFO (MainThread) [homeassistant.setup] Setting up http 2019-08-09 12:50:09 INFO (MainThread) [homeassistant.setup] Setup of domain http took 0.0 seconds. 2019-08-09 12:50:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:09 INFO (MainThread) [homeassistant.setup] Setting up system_log 2019-08-09 12:50:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:09 INFO (MainThread) [homeassistant.setup] Setup of domain system_log took 0.0 seconds. 2019-08-09 12:50:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:09 INFO (MainThread) [homeassistant.setup] Setting up recorder 2019-08-09 12:50:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:10 DEBUG (Recorder) [homeassistant.components.recorder] Connected to recorder database 2019-08-09 12:50:10 INFO (MainThread) [homeassistant.setup] Setup of domain recorder took 0.7 seconds. 2019-08-09 12:50:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:10 DEBUG (MainThread) [homeassistant.bootstrap] Setting up {'wemo', 'config', 'zone', 'input_select', 'webhook', 'updater', 'script', 'eufy', 'emulated_roku', 'auth', 'binary_sensor', 'roku', 'input_text', 'cloud', 'emulated_hue', 'automation', 'alexa_media', 'weather', 'sun', 'simplisafe', 'remote', 'ecobee', 'input_number', 'api', 'scene', 'http', 'input_boolean', 'hue', 'system_health', 'zwave', 'lovelace', 'configurator', 'hacs', 'logbook', 'frontend', 'onboarding', 'group', 'sensor', 'mobile_app', 'websocket_api', 'device_tracker', 'mqtt', 'switch', 'zeroconf', 'discovery', 'nest', 'person', 'cover', 'stream', 'history', 'ios', 'light', 'notify'} 2019-08-09 12:50:10 INFO (MainThread) [homeassistant.setup] Setting up wemo 2019-08-09 12:50:10 INFO (MainThread) [homeassistant.setup] Setting up zone 2019-08-09 12:50:10 INFO (MainThread) [homeassistant.setup] Setup of domain zone took 0.0 seconds. 2019-08-09 12:50:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:10 INFO (MainThread) [homeassistant.setup] Setting up input_select 2019-08-09 12:50:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:10 INFO (MainThread) [homeassistant.setup] Setting up updater 2019-08-09 12:50:10 INFO (MainThread) [homeassistant.setup] Setting up eufy 2019-08-09 12:50:11 INFO (MainThread) [homeassistant.setup] Setting up emulated_roku 2019-08-09 12:50:11 INFO (MainThread) [homeassistant.setup] Setup of domain emulated_roku took 0.0 seconds. 2019-08-09 12:50:11 DEBUG (MainThread) [homeassistant.components.emulated_roku] Intializing emulated_roku Home Assistant on 192.168.1.38:8060 2019-08-09 12:50:11 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:11 INFO (SyncWorker_3) [homeassistant.loader] Loaded template from homeassistant.components.template 2019-08-09 12:50:11 INFO (MainThread) [homeassistant.setup] Setting up roku 2019-08-09 12:50:11 INFO (MainThread) [homeassistant.setup] Setting up input_text 2019-08-09 12:50:11 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setting up emulated_hue 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setup of domain emulated_hue took 0.0 seconds. 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setting up alexa_media 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setting up sun 2019-08-09 12:50:12 INFO (SyncWorker_0) [homeassistant.loader] Loaded darksky from homeassistant.components.darksky 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.components.sun] sun pXXXXXX 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.components.sun] sun XXXXXXX: elevation=XXXX azimuth=179.55 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.components.sun] next time: 2019-08-09T16:51:16+00:00 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setup of domain sun took 0.1 seconds. 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setting up simplisafe 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setup of domain simplisafe took 0.0 seconds. 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setting up input_number 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setting up scene 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setting up input_boolean 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:12 INFO (SyncWorker_7) [custom_components.alexa_media] ------------------------------------------------------------------- alexa_media Version: 1.4.1 This is a custom component If you have any issues with this you need to open an issue here: https://github.com/keatontaylor/alexa_media_player/issues ------------------------------------------------------------------- 2019-08-09 12:50:12 INFO (SyncWorker_7) [custom_components.alexa_media] Loaded alexapy==0.7.1 2019-08-09 12:50:12 DEBUG (SyncWorker_7) [alexapy.alexalogin] Trying cookie from file /config/alexa_media.XXXX@gmail.com.pickle 2019-08-09 12:50:12 DEBUG (SyncWorker_7) [alexapy.alexalogin] cookie loaded: , , , , , , , ]> 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setting up hue 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setup of domain hue took 0.0 seconds. 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setting up zwave 2019-08-09 12:50:12 INFO (MainThread) [homeassistant.setup] Setup of domain zwave took 0.0 seconds. 2019-08-09 12:50:13 DEBUG (SyncWorker_7) [alexapy.alexalogin] Logged in as XXXX@gmail.com 2019-08-09 12:50:13 DEBUG (SyncWorker_7) [alexapy.alexalogin] Using cookies to log in 2019-08-09 12:50:13 DEBUG (SyncWorker_7) [alexapy.alexalogin] Log in successful with cookies 2019-08-09 12:50:13 DEBUG (SyncWorker_7) [custom_components.alexa_media] Setting up Alexa devices 2019-08-09 12:50:14 INFO (MainThread) [homeassistant.components.zwave] Z-Wave USB path is /dev/ttyACM0 2019-08-09 12:50:14 INFO (MainThread) [homeassistant.setup] Setting up lovelace 2019-08-09 12:50:14 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:14 INFO (MainThread) [homeassistant.setup] Setup of domain lovelace took 0.0 seconds. 2019-08-09 12:50:14 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:14 INFO (MainThread) [homeassistant.setup] Setting up configurator 2019-08-09 12:50:14 INFO (MainThread) [homeassistant.setup] Setup of domain configurator took 0.0 seconds. 2019-08-09 12:50:14 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:14 INFO (MainThread) [homeassistant.setup] Setting up hacs 2019-08-09 12:50:14 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-09 12:50:14 INFO (MainThread) [homeassistant.setup] Setting up group 2019-08-09 12:50:14 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:14 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:14 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:14 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:14 INFO (MainThread) [homeassistant.setup] Setup of domain group took 0.0 seconds. 2019-08-09 12:50:14 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:14 INFO (SyncWorker_3) [homeassistant.loader] Loaded rest from homeassistant.components.rest 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up discovery 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain discovery took 0.1 seconds. 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up nest 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain nest took 0.0 seconds. 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.components.nest] proceeding with setup 2019-08-09 12:50:15 INFO (SyncWorker_4) [nest.nest] Open data stream 2019-08-09 12:50:15 DEBUG (SyncWorker_4) [nest.nest] >> STREAM https://developer-api.nest.com/ 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up person 2019-08-09 12:50:15 INFO (SyncWorker_2) [homeassistant.loader] Loaded pushbullet from homeassistant.components.pushbullet 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 DEBUG (SyncWorker_6) [roku] /query/device-info 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.scene] Setting up scene.homeassistant 2019-08-09 12:50:15 DEBUG (SyncWorker_7) [alexapy.alexawebsocket] Connecting to wss://dp-gw-na-js.amazon.com/?x-amz-device-type=ALEGCNGL9K0HM&x-amz-device-serial=XXXX with Cookie: at-main=XXX; csrf=-563659294; sess-at-main="XXX"; session-id=XXX9091019; session-id-time=2195986597l; session-token="XXX"; ubid-main=135-4028607-0580218; x-main=XXXX; 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (SyncWorker_7) [custom_components.alexa_media] g******t@gmail.com: Websocket created: 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain wemo took 4.4 seconds. 2019-08-09 12:50:15 DEBUG (SyncWorker_6) [roku] /query/device-info 2019-08-09 12:50:15 DEBUG (SyncWorker_6) [roku] /query/device-info 2019-08-09 12:50:15 DEBUG (SyncWorker_6) [roku] /query/device-info 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain updater took 4.5 seconds. 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (Wemo HTTP Thread) [pywemo.subscribe] Listening on port 8989 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up binary_sensor 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain eufy took 4.5 seconds. 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (Thread-3) [alexapy.alexawebsocket] Initating Handshake. 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up weather 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain alexa_media took 3.2 seconds. 2019-08-09 12:50:15 DEBUG (SyncWorker_4) [nest.nest] << 307 2019-08-09 12:50:15 DEBUG (SyncWorker_4) [nest.nest] >> STREAM https://firebase-apiserver08-tah01-iad01.dapi.production.nest.com:9553/ 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [openzwave] Create network object. 2019-08-09 12:50:15 DEBUG (MainThread) [openzwave] Use sqlite version : ('3.16.2',) 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (SyncWorker_2) [homeassistant.loader] Loaded mqtt_room from homeassistant.components.mqtt_room 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up notify 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up config 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling , new_state=None> 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up webhook 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain webhook took 0.0 seconds. 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up script 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain script took 0.0 seconds. 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up auth 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain auth took 0.0 seconds. 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.binary_sensor] Setting up binary_sensor.template 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.components.weather] Setting up weather.darksky 2019-08-09 12:50:15 INFO (SyncWorker_3) [homeassistant.loader] Loaded harmony from homeassistant.components.harmony 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up ecobee 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up api 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up system_health 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain system_health took 0.0 seconds. 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up websocket_api 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain websocket_api took 0.0 seconds. 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (SyncWorker_8) [homeassistant.loader] Loaded nmap_tracker from homeassistant.components.nmap_tracker 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setting up mqtt 2019-08-09 12:50:15 INFO (MainThread) [homeassistant.setup] Setup of domain mqtt took 0.0 seconds. 2019-08-09 12:50:15 INFO (SyncWorker_9) [homeassistant.loader] Loaded command_line from homeassistant.components.command_line 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling , new_state=None> 2019-08-09 12:50:15 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:15 INFO (SyncWorker_0) [homeassistant.loader] Loaded myq from homeassistant.components.myq 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setting up stream 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setup of domain stream took 0.0 seconds. 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setting up history 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setup of domain history took 0.0 seconds. 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setting up light 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.components.notify] Setting up notify.pushbullet 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.components.notify] Setting up notify.alexa_media 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:16 INFO (SyncWorker_3) [homeassistant.loader] Loaded climate from homeassistant.components.climate 2019-08-09 12:50:16 INFO (SyncWorker_2) [homeassistant.loader] Loaded lock from homeassistant.components.lock 2019-08-09 12:50:16 INFO (SyncWorker_3) [homeassistant.loader] Loaded fan from homeassistant.components.fan 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setting up sensor 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.components.light] Setting up light.group 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setup of domain roku took 5.2 seconds. 2019-08-09 12:50:16 INFO (SyncWorker_5) [homeassistant.loader] Loaded media_player from homeassistant.components.media_player 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (Thread-3) [alexapy.alexawebsocket] Encoding WebSocket Handshake MSG. 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setting up remote 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setup of domain api took 0.7 seconds. 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.template 2019-08-09 12:50:16 INFO (SyncWorker_6) [homeassistant.loader] Loaded ping from homeassistant.components.ping 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.rest 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.darksky 2019-08-09 12:50:16 DEBUG (SyncWorker_2) [homeassistant.components.rest.sensor] Updating from http://192.168.1.16/api/XXXXX/sensors/4 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.components.mqtt] Subscribing to homeassistant/# 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setting up switch 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setting up cover 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setup of domain ecobee took 1.0 seconds. 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 INFO (MainThread) [homeassistant.setup] Setup of domain config took 1.1 seconds. 2019-08-09 12:50:16 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:16 DEBUG (SyncWorker_4) [nest.nest] << 200 2019-08-09 12:50:16 DEBUG (Thread-5) [nest.nest] Starting event loop. 2019-08-09 12:50:16 DEBUG (Thread-5) [sseclient] Initialized SSE client from event source .generate at 0x7f7c540c55d0> 2019-08-09 12:50:17 DEBUG (Thread-3) [alexapy.alexawebsocket] Encoding Gateway Handshake MSG. 2019-08-09 12:50:17 INFO (MainThread) [homeassistant.setup] Setting up cloud 2019-08-09 12:50:18 DEBUG (Thread-3) [alexapy.alexawebsocket] Encoding Gateway Register MSG. 2019-08-09 12:50:18 DEBUG (Thread-3) [custom_components.alexa_media] g******t@gmail.com: Websocket succesfully connected 2019-08-09 12:50:18 DEBUG (Thread-3) [alexapy.alexawebsocket] Received WebSocket MSG. 2019-08-09 12:50:18 DEBUG (Thread-3) [alexapy.alexawebsocket] Received b'0xbafef3f3 0x000000cd {"protocolName":"A:H","parameters":{"AlphaProtocolHandler.supportedEncodings":"GZIP","AlphaProtocolHandler.maxFragmentSize":"16000","AlphaProtocolHandler.receiveWindowSize":"16"}}TUNE' 2019-08-09 12:50:18 DEBUG (Thread-3) [alexapy.alexawebsocket] Received WebSocket MSG. 2019-08-09 12:50:18 DEBUG (Thread-3) [alexapy.alexawebsocket] Received b'MSG 0x00000361 0x674eb662 f 0x00000001 0xcdbdb8b8 0x000000b9 ACK 0x00000003 1.0 0x00000024 01e09e62-f504-476c-85c8-9c97c8da26ed 0x00000064 0x0000016978ff598c 0x0000016c7749bf0d END FABE' 2019-08-09 12:50:18 DEBUG (Thread-3) [alexapy.alexawebsocket] Received ACK MSG for Registration. 2019-08-09 12:50:18 DEBUG (Thread-5) [sseclient] Dispatching put event, 13144 bytes... 2019-08-09 12:50:18 DEBUG (Thread-5) [nest.nest] <<< put event 2019-08-09 12:50:18 INFO (SyncWorker_4) [nest.nest] Event loop started. 2019-08-09 12:50:18 INFO (MainThread) [homeassistant.setup] Setting up automation 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setting up mobile_app 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setting up onboarding 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.remote] Setting up remote.harmony 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.remote] Setting up remote.harmony 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.remote] Setting up remote.harmony 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.remote] Setting up remote.harmony 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setting up climate 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setup of domain climate took 0.0 seconds. 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.switch] Setting up switch.command_line 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.cover] Setting up cover.myq 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.helpers.restore_state] Created cache with ['automation.leaving_now', 'automation.close_garage_door', 'automation.plex_webhook', 'automation.open_garage_door', 'automation.plex_movie_room', 'automation.almost_home', 'automation.plex_great_room', 'input_number.officefan_power', 'input_number.thermostat_temp_slider', 'input_text.alexa_text', 'input_select.danielle_presence', 'input_select.ecobee_status', 'input_select.greg_presence', 'input_select.alexa_options', 'input_select.security_system_status', 'input_boolean.back_porch_sensor', 'input_boolean.leaving_now', 'input_boolean.in_movieroom', 'input_boolean.basement_sensor', 'input_boolean.listen_to_music', 'input_boolean.override_outsidelights', 'input_boolean.override_guests', 'input_boolean.play_ps4', 'input_boolean.override_officefan', 'input_boolean.almost_home', 'input_boolean.watch_movies', 'person.greg', 'person.danielle', 'device_tracker.greg_s_iphone'] 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.harmony.remote] Loading Harmony Platform: Watch TV at 192.168.1.36:8088, startup activity: 37049160 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.harmonyapi] 192.168.1.36: Initialize 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.harmonyclient] 192.168.1.36: Initialize HUB 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Registering handler Activity_Changed with UUID XXX-4120-bc64-8506521ea124 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Registering handler Notification_Received with UUID XXXX9 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.harmony.remote] Watch TV: Connecting 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Starting connect. 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Retrieving Harmony Hub information. 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Sending post request: {'id ': 1, 'cmd': 'setup.account?getProvisionInfo', 'params': {}} 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.harmony.remote] Loading Harmony Platform: Nintendo Switch at 192.168.1.36:8088, startup activity: 39029668 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.harmonyapi] 192.168.1.36: Initialize 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.harmonyclient] 192.168.1.36: Initialize HUB 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Registering handler Activity_Changed with UUID XXX4f1c-8cce-0a96626c3482 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Registering handler Notification_Received with UUID XXXX2cb9 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.harmony.remote] Nintendo Switch: Connecting 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Starting connect. 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Retrieving Harmony Hub information. 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Sending post request: {'id ': 1, 'cmd': 'setup.account?getProvisionInfo', 'params': {}} 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.harmony.remote] Loading Harmony Platform: Play PS4 at 192.168.1.36:8088, startup activity: 25662122 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.harmonyapi] 192.168.1.36: Initialize 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.harmonyclient] 192.168.1.36: Initialize HUB 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Registering handler Activity_Changed with UUID 47dc2472-5dd6-44de-94e1-25fb1f18ed23 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Registering handler Notification_Received with UUID XXX 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.harmony.remote] Play PS4: Connecting 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Starting connect. 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Retrieving Harmony Hub information. 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Sending post request: {'id ': 1, 'cmd': 'setup.account?getProvisionInfo', 'params': {}} 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.harmony.remote] Loading Harmony Platform: Movie Room at 192.168.1.36:8088, startup activity: 25692038 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.harmonyapi] 192.168.1.36: Initialize 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.harmonyclient] 192.168.1.36: Initialize HUB 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Registering handler Activity_Changed with UUID XXXX 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Registering handler Notification_Received with UUID XXXX 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.harmony.remote] Movie Room: Connecting 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Starting connect. 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Retrieving Harmony Hub information. 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.hubconnector] 192.168.1.36: Sending post request: {'id ': 1, 'cmd': 'setup.account?getProvisionInfo', 'params': {}} 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.climate] Setting up climate.zwave 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for iphonedetect 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-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setting up device_tracker 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.mqtt] Subscribing to homeassistant/# 2019-08-09 12:50:19 DEBUG (MainThread) [pymyq.api] Requesting security token. 2019-08-09 12:50:19 DEBUG (MainThread) [pymyq.api] 12:50:19.296887 Initiating request to https://myqexternal.myqdevice.com/api/v4/User/Validate 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.nest] async_setup_nest is done 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Callback handler started 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Callback handler started 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Callback handler started 2019-08-09 12:50:19 DEBUG (MainThread) [aioharmony.responsehandler] Callback handler started 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setting up zeroconf 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mqtt 2019-08-09 12:50:19 DEBUG (SyncWorker_3) [homeassistant.components.rest.sensor] Updating from http://192.168.1.16/api/XXvXXXp-9av/sensors/4 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mqtt 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mqtt 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mqtt 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] g******t@gmail.com: Found 19 devices, 1 bluetooth 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for B************1FW 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for B************1FW 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for 0************F0W 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for 0************F0W 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for G************G25 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for G************G25 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for G************126 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for G************126 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for G************721 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for G************721 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for 9************5GR 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for 9************5GR 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for 5****************************da3 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for G************6GP 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.climate] Setting up climate.nest 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.helpers.storage] Migrating onboarding storage from 1 to 3 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.components.climate] Setting up climate.ecobee 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for G************6GP 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setting up lock 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for G************445 2019-08-09 12:50:19 INFO (SyncWorker_0) [homeassistant.components.ecobee.climate] Loading ecobee thermostat component with hold_temp set to False 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for G************445 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for 4****************************09b 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for 5****************************74c 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for 5****************************74c 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for G************721 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for G************721 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setup of domain lock took 0.0 seconds. 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for G************2EE 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for G************2EE 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for 2****************************060 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for 2****************************060 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setting up fan 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for G************335 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for G************335 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for 7****************************8A5 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for 7****************************8A5 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for A**********FC4 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for A**********FC4 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for 7************L9U 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for 7************L9U 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for 7************L9U 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] Locale en-us found for A****************************789 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] DND False found for A****************************789 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setup of domain fan took 0.0 seconds. 2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] g******t@gmail.com: Existing: [] New: ['Office', "Gregory's 2nd Fire", 'Nursery', 'My Dash', "Gregory's 3rd Fire", 'Great Room', 'Downstairs', 'Bedroom', 'Basement', 'Upstairs', 'First Floor Ecobee', 'Basement Dash', 'Fire HD 10 tablet', 'Guest Room', 'Kitchen', 'This Device', "Gregory's Alexa Apps", "danielle's Fire TV", "danielle's Alexa Apps"]; Filtered by: include_devices: [] exclude_devices:[] 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setup of domain notify took 4.1 seconds. 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Loaded automation automation.leaving_now with state True from state storage last state 2019-08-09 12:50:19 INFO (SyncWorker_3) [homeassistant.loader] Loaded camera from homeassistant.components.camera 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Loaded automation automation.close_garage_door with state True from state storage last state 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Loaded automation automation.plex_webhook with state True from state storage last state 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Automation automation.plex_webhook initial state True overridden from config initial_state 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Loaded automation automation.open_garage_door with state True from state storage last state 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Loaded automation automation.plex_movie_room with state True from state storage last state 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Automation automation.plex_movie_room initial state True overridden from config initial_state 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Loaded automation automation.almost_home with state True from state storage last state 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Loaded automation automation.plex_great_room with state True from state storage last state 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.components.automation] Automation automation.plex_great_room initial state True overridden from config initial_state 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setup of domain mobile_app took 0.8 seconds. 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setup of domain onboarding took 0.8 seconds. 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setting up media_player 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setup of domain media_player took 0.1 seconds. 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:19 INFO (MainThread) [homeassistant.setup] Setup of domain scene took 7.3 seconds. 2019-08-09 12:50:19 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.components.lock] Setting up lock.zwave 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.components.fan] Setting up fan.zwave 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.mqtt_room 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.components.mqtt] Subscribing to plex/update/movieroom 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.components.mqtt] Subscribing to plex/update/greatroom 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.components.mqtt] Subscribing to monitor/basement/XXXX 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.components.mqtt] Subscribing to room_presence/basement 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.setup] Setup of domain automation took 1.2 seconds. 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.setup] Setup of domain input_select took 9.3 seconds. 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.setup] Setup of domain input_text took 8.9 seconds. 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.setup] Setup of domain input_number took 7.4 seconds. 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.setup] Setup of domain input_boolean took 7.4 seconds. 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.setup] Setup of domain person took 4.9 seconds. 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 INFO (MainThread) [homeassistant.setup] Setup of domain binary_sensor took 4.7 seconds. 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling > 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 INFO (SyncWorker_0) [homeassistant.loader] Loaded alarm_control_panel from homeassistant.components.alarm_control_panel 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling 2019-08-09 12:50:20 DEBUG (MainThread) [homeassistant.core] Bus:Handling

EDIT: Collapsed logs

gmalbert commented 4 years ago

If you need more, I can add it, but I kept getting errors that my comment was too long.

alandtse commented 4 years ago

The component has loaded the following media_players including one called Office and one called Kitchen.

2019-08-09 12:50:19 DEBUG (SyncWorker_7) [custom_components.alexa_media] g******t@gmail.com: Existing: [] New: ['Office', "Gregory's 2nd Fire", 'Nursery', 'My Dash', "Gregory's 3rd Fire", 'Great Room', 'Downstairs', 'Bedroom', 'Basement', 'Upstairs', 'First Floor Ecobee', 'Basement Dash', 'Fire HD 10 tablet', 'Guest Room', 'Kitchen', 'This Device', "Gregory's Alexa Apps", "danielle's Fire TV", "danielle's Alexa Apps"]; Filtered by: include_devices: [] exclude_devices:[]

Are you saying you don't see both? The component is reporting it's creating both. Can you please show me the section of your Entity Registry for both those media_players?

When you renamed the component, where did you rename it? Was it in HA or in Alexa? Did you rename the entitiy_id or the friendly name? You may try removing both from the Entity Registry as it will be readded automatically when it detects them being interacted with by voice (reboot shouldn't be needed).

For the logs, you should probably change the logger default setting to something like critical so you don't get all the extra entries. It'll save on the size and also provide more info. It actually stopped before all the media_players were refreshed.

gmalbert commented 4 years ago

I'm seeing the one with the friendly name "Office" under media_player.kitchen, but I'm not seeing the one with the friendly name "Kitchen". Essentially, I'm not seeing the new echo. When I renamed the device, I did so in the Alexa app. I just changed the Friendly Name in the Alexa app. I didn't rename it in HA.

Oh god, you're gonna kill me. The new kitchen echo is named gregory's echo in the entity registry (see below). It was there, but it just wasn't showing with the name I named it. I'm so sorry to have taken your time, but I really appreciate the help. I'll look at the entity registry next time as it didn't occur to me until you mentioned it.

{
                "config_entry_id": null,
                "device_id": null,
                "disabled_by": null,
                "entity_id": "media_player.gregory_s_echo",
                "name": null,
                "platform": "alexa_media",
                "unique_id": "XXXXXXX"
            },
alandtse commented 4 years ago

Glad you found it. I haven't tested out the interactions of renaming in Amazon and how it treats it in HA. I think if HA already has a name for it, it won't automatically update it unless you delete the entity in HA. HA identifies everything by it's unique_id.

I'll go ahead and close this out.