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.53k stars 290 forks source link

Shuffle and repeat switches unavailable for all Alexa devices when not playing music #389

Closed mikeage closed 5 years ago

mikeage commented 5 years ago

Describe the bug After upgrading from 2.1 to 2.2.1, I now have 2 broken switches for each Alexa device; shuffle and repeat. The do not disturb switch is available.

This looks like it might be related to #361

I don't remember if I had switches at all in 2.1.

To Reproduce Start HA

Expected behavior No unavailable switches

System details

Logs Grep of alexa from my log. The serial numbers are redacted in the logs from alexa_media_player, but not alexapi, so I manually redacted them from there (using %s/G[0-9A-Z]\{12\}\([0-9A-Z]\{3\}\)/G***********\1/g and %s/A[0-9A-Z]\{10\}\([0-9A-Z]\{3\}\)/A***********\1/g)

2019-09-24 07:13:47 INFO (SyncWorker_1) [homeassistant.loader] Loaded alexa_media from custom_components.alexa_media
2019-09-24 07:13:47 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-09-24 07:13:47 INFO (SyncWorker_8) [homeassistant.loader] Loaded alexa from homeassistant.components.alexa
2019-09-24 07:13:49 INFO (MainThread) [homeassistant.setup] Setting up alexa_media
2019-09-24 07:13:49 INFO (MainThread) [homeassistant.setup] Setup of domain alexa_media took 0.0 seconds.
2019-09-24 07:13:49 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.async_setup_entry: Trying with limit 5 delay 5 catch_exceptions True
2019-09-24 07:13:49 INFO (MainThread) [custom_components.alexa_media]
alexa_media
https://github.com/custom-components/alexa_media_player/issues
2019-09-24 07:13:49 INFO (MainThread) [custom_components.alexa_media] Loaded alexapy==1.2.1
2019-09-24 07:13:49 DEBUG (MainThread) [alexapy.alexalogin] Trying to load pickled cookie from file /Users/mikeage/.homeassistant/alexa_media.amazon@mikeage.net.pickle
2019-09-24 07:13:50 INFO (MainThread) [homeassistant.setup] Setting up alexa
2019-09-24 07:13:50 INFO (MainThread) [homeassistant.setup] Setup of domain alexa took 0.0 seconds.
2019-09-24 07:13:50 DEBUG (MainThread) [alexapy.alexalogin] cookie loaded: <class 'dict'> {'at-main': 'Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O', 'csrf': '348696369', 'sess-at-main': 'vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8=', 'session-id': '143-9537593-1055442', 'session-id-time': '2187110889l', 'session-token': 'jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE=', 'ubid-main': '133-4767277-1843730', 'x-main': '0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB'}
2019-09-24 07:13:50 DEBUG (MainThread) [alexapy.alexalogin] Found dict cookie
2019-09-24 07:13:50 DEBUG (MainThread) [alexapy.alexalogin] Loaded 8 cookies
2019-09-24 07:13:50 DEBUG (MainThread) [alexapy.alexalogin] Testing whether logged in to alexa.amazon.com
2019-09-24 07:13:50 DEBUG (MainThread) [alexapy.alexalogin] Cookies: {'at-main': 'Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O', 'csrf': '348696369', 'sess-at-main': 'vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8=', 'session-id': '143-9537593-1055442', 'session-id-time': '2187110889l', 'session-token': 'jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE=', 'ubid-main': '133-4767277-1843730', 'x-main': '0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB'}
2019-09-24 07:13:50 DEBUG (MainThread) [alexapy.alexalogin] Session Cookies:
2019-09-24 07:13:50 DEBUG (MainThread) [alexapy.alexalogin] Header: {"User-Agent": "Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36", "Accept": "text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8", "Accept-Language": "*"}
2019-09-24 07:13:51 DEBUG (MainThread) [alexapy.alexalogin] GET:
https://alexa.amazon.com/api/bootstrap with
<CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')>
2019-09-24 07:13:51 DEBUG (MainThread) [alexapy.alexalogin] Logged in as amazon@mikeage.net
2019-09-24 07:13:51 DEBUG (MainThread) [alexapy.alexalogin] Using cookies to log in
2019-09-24 07:13:51 DEBUG (MainThread) [alexapy.alexalogin] Log in successful with cookies
2019-09-24 07:13:51 DEBUG (MainThread) [alexapy.alexalogin] Updating self._cookies with amazon.com session cookies:
2019-09-24 07:13:51 DEBUG (MainThread) [custom_components.alexa_media] Testing login status: {'login_successful': True}
2019-09-24 07:13:51 DEBUG (MainThread) [custom_components.alexa_media] Setting up Alexa devices for a****n@m*********t
2019-09-24 07:13:51 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: Websocket created: <alexapy.alexawebsocket.WebsocketEchoClient object at 0x10727f4e0>
2019-09-24 07:13:51 DEBUG (MainThread) [alexapy.alexawebsocket] Connecting to wss://dp-gw-na-js.amazon.com/?x-amz-device-type=ALEGCNGL9K0HM&x-amz-device-serial=133-4767277-1843730-1569298431000 with {'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/api/bootstrap', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main=vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8=; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token=jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE=; ubid-main=133-4767277-1843730; x-main=0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB; ', 'Origin': 'https://alexa.amazon.com'}
2019-09-24 07:13:52 DEBUG (MainThread) [alexapy.alexawebsocket] Initating Async Handshake.
2019-09-24 07:13:52 DEBUG (MainThread) [alexapy.alexawebsocket] Starting message parsing loop.
2019-09-24 07:13:52 DEBUG (MainThread) [alexapy.alexawebsocket] Encoding WebSocket Handshake MSG.
2019-09-24 07:13:52 DEBUG (MainThread) [alexapy.alexawebsocket] msg: WSMessage(type=<WSMsgType.BINARY: 2>, data=b'0xbafef3f3 0x000000cd {"protocolName":"A:H","parameters":{"AlphaProtocolHandler.supportedEncodings":"GZIP","AlphaProtocolHandler.maxFragmentSize":"16000","AlphaProtocolHandler.receiveWindowSize":"16"}}TUNE', extra='')
2019-09-24 07:13:52 DEBUG (MainThread) [alexapy.alexawebsocket] Received WebSocket MSG.
2019-09-24 07:13:52 DEBUG (MainThread) [alexapy.alexawebsocket] Received b'0xbafef3f3 0x000000cd {"protocolName":"A:H","parameters":{"AlphaProtocolHandler.supportedEncodings":"GZIP","AlphaProtocolHandler.maxFragmentSize":"16000","AlphaProtocolHandler.receiveWindowSize":"16"}}TUNE'
2019-09-24 07:13:53 DEBUG (MainThread) [alexapy.alexawebsocket] Encoding Gateway Handshake MSG.
2019-09-24 07:13:53 DEBUG (MainThread) [alexapy.alexawebsocket] Encoding Gateway Register MSG.
2019-09-24 07:13:53 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: Websocket succesfully connected
2019-09-24 07:13:53 DEBUG (MainThread) [alexapy.alexawebsocket] msg: WSMessage(type=<WSMsgType.BINARY: 2>, data=b'MSG 0x00000361 0x4ffd4d76 f 0x00000001 0xd0561cb9 0x000000b9 ACK 0x00000003 1.0 0x00000024 01e09e62-f504-476c-85c8-9c97c8da26ed 0x00000064 0x0000016978ff598c 0x0000016d6179c441 END FABE', extra='')
2019-09-24 07:13:53 DEBUG (MainThread) [alexapy.alexawebsocket] Received WebSocket MSG.
2019-09-24 07:13:53 DEBUG (MainThread) [alexapy.alexawebsocket] Received b'MSG 0x00000361 0x4ffd4d76 f 0x00000001 0xd0561cb9 0x000000b9 ACK 0x00000003 1.0 0x00000024 01e09e62-f504-476c-85c8-9c97c8da26ed 0x00000064 0x0000016978ff598c 0x0000016d6179c441 END FABE'
2019-09-24 07:13:53 DEBUG (MainThread) [alexapy.alexawebsocket] Received ACK MSG for Registration.
2019-09-24 07:13:53 DEBUG (MainThread) [alexapy.alexaapi] static GET: https://alexa.amazon.com/api/bootstrap <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/api/bootstrap', 'Origin': 'https://alexa.amazon.com', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:53 DEBUG (MainThread) [alexapy.alexaapi] static GET: https://alexa.amazon.com/api/devices-v2/device <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/api/bootstrap', 'Origin': 'https://alexa.amazon.com', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:54 DEBUG (MainThread) [alexapy.alexaapi] static GET: https://alexa.amazon.com/api/bluetooth?cached=false <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/api/bootstrap', 'Origin': 'https://alexa.amazon.com', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:55 DEBUG (MainThread) [alexapy.alexaapi] static GET: https://alexa.amazon.com/api/device-preferences <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/api/bootstrap', 'Origin': 'https://alexa.amazon.com', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:55 DEBUG (MainThread) [alexapy.alexaapi] static GET: https://alexa.amazon.com/api/dnd/device-status-list <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/api/bootstrap', 'Origin': 'https://alexa.amazon.com', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: Found 8 devices, 1 bluetooth
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] Locale en-us found for G************6AV
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] DND False found for G************6AV
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] Locale en-us found for G************3WM
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] DND False found for G************3WM
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] Locale en-us found for G************405
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] DND False found for G************405
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] Locale en-us found for G************76M
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] DND False found for G************76M
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] Locale en-us found for G************9S3
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] DND False found for G************9S3
2019-09-24 07:13:55 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: Existing: [] New: ['Parents Room', "Girls' Room", 'Boys Room', "Rivka's room", 'Living Room']; Filtered out by not being in include: [] or in exclude: ['This Device', 'This Device', "Michael's Alexa Apps"]
2019-09-24 07:13:56 DEBUG (MainThread) [alexapy.alexaapi] static GET: https://alexa.amazon.com/api/activities?startTime=&size=10&offset=1 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/api/bootstrap', 'Origin': 'https://alexa.amazon.com', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: Updated last_called: {'serialNumber': 'G************9S3', 'timestamp': 1569298220304}
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: last_called changed:  to {'serialNumber': 'G************9S3', 'timestamp': 1569298220304}
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.async_setup_entry: Try: 1/5 after waiting 0 seconds result: True
2019-09-24 07:13:56 INFO (MainThread) [homeassistant.components.notify] Setting up notify.alexa_media
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.notify.async_get_service: Trying with limit 5 delay 2 catch_exceptions True
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.notify] a****n@m*********t: Media player G************6AV not loaded yet; delaying load
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.notify.async_get_service: Try: 1/5 after waiting 0 seconds result: False
2019-09-24 07:13:56 INFO (MainThread) [homeassistant.components.switch] Setting up switch.alexa_media
2019-09-24 07:13:56 INFO (MainThread) [homeassistant.components.alarm_control_panel] Setting up alarm_control_panel.alexa_media
2019-09-24 07:13:56 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.alexa_media
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.switch.async_setup_platform: Trying with limit 5 delay 5 catch_exceptions True
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Loading switches
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Media player G************6AV not loaded yet; delaying load
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.switch.async_setup_platform: Try: 1/5 after waiting 0 seconds result: False
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.alarm_control_panel.async_setup_platform: Trying with limit 5 delay 2 catch_exceptions True
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.media_player.async_setup_platform: Trying with limit 5 delay 2 catch_exceptions True
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Parents Room
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.media_player] Parents Room: Last_called check: self: G************6AV reported:
2019-09-24 07:13:56 DEBUG (MainThread) [alexapy.alexaapi] static GET: https://alexa.amazon.com/api/phoenix <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.alarm_control_panel] a****n@m*********t: No Alexa Guard entity found
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.alarm_control_panel] a****n@m*********t: Skipping creation of uninitialized device: <Entity Alexa Guard: None>
2019-09-24 07:13:56 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.alarm_control_panel.async_setup_platform: Try: 1/5 after waiting 0 seconds result: True
2019-09-24 07:13:57 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********6AV&deviceType=A***********AYF&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Girls' Room
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.media_player] Girls' Room: Last_called check: self: G************3WM reported:
2019-09-24 07:13:57 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********3WM&deviceType=A***********AYF&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Boys Room
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.media_player] Boys Room: Last_called check: self: G************405 reported:
2019-09-24 07:13:57 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********405&deviceType=A***********AYF&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Rivka's room
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.media_player] Rivka's room: Last_called check: self: G************76M reported:
2019-09-24 07:13:57 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********76M&deviceType=A***********AYF&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Living Room
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.media_player] Living Room: Last_called check: self: G************9S3 reported:
2019-09-24 07:13:57 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********9S3&deviceType=A***********TXA&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.helpers] a****n@m*********t: Adding [<Entity Parents Room: standby>, <Entity Girls' Room: standby>, <Entity Boys Room: standby>, <Entity Rivka's room: standby>, <Entity Living Room: standby>]
2019-09-24 07:13:57 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.media_player.async_setup_platform: Try: 1/5 after waiting 0 seconds result: True
2019-09-24 07:14:00 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.notify.async_get_service: Try: 2/5 after waiting 4 seconds result: <custom_components.alexa_media.notify.AlexaNotificationService object at 0x1064a7da0>
2019-09-24 07:14:00 INFO (MainThread) [homeassistant.components.notify] Setting up notify.alexa_media
2019-09-24 07:14:00 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.notify.async_get_service: Trying with limit 5 delay 2 catch_exceptions True
2019-09-24 07:14:00 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.notify.async_get_service: Try: 1/5 after waiting 0 seconds result: <custom_components.alexa_media.notify.AlexaNotificationService object at 0x1066eaa58>
2019-09-24 07:14:06 WARNING (MainThread) [homeassistant.components.switch] Setup of platform alexa_media is taking over 10 seconds.
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Loading switches
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************6AV dnd switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************6AV shuffle switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************6AV repeat switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************3WM dnd switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************3WM shuffle switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************3WM repeat switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************405 dnd switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************405 shuffle switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************405 repeat switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************76M dnd switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************76M shuffle switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************76M repeat switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************9S3 dnd switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************9S3 shuffle switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.switch] a****n@m*********t: Found G************9S3 repeat switch with status: False
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.helpers] a****n@m*********t: Adding [<Entity Parents Room do not disturb switch: off>, <Entity Parents Room shuffle switch: off>, <Entity Parents Room repeat switch: off>, <Entity Girls' Room do not disturb switch: off>, <Entity Girls' Room shuffle switch: off>, <Entity Girls' Room repeat switch: off>, <Entity Boys Room do not disturb switch: off>, <Entity Boys Room shuffle switch: off>, <Entity Boys Room repeat switch: off>, <Entity Rivka's room do not disturb switch: off>, <Entity Rivka's room shuffle switch: off>, <Entity Rivka's room repeat switch: off>, <Entity Living Room do not disturb switch: off>, <Entity Living Room shuffle switch: off>, <Entity Living Room repeat switch: off>]
2019-09-24 07:14:06 DEBUG (MainThread) [custom_components.alexa_media.helpers] alexa_media.switch.async_setup_platform: Try: 2/5 after waiting 10 seconds result: True
2019-09-24 07:14:06 INFO (MainThread) [homeassistant.components.automation] Initialized trigger Turn off Alexas before Shabbat
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Living Room
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] Living Room: Last_called check: self: G************9S3 reported: G************9S3
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Parents Room
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] Parents Room: Last_called check: self: G************6AV reported: G************9S3
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Boys Room
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] Boys Room: Last_called check: self: G************405 reported: G************9S3
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Girls' Room
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] Girls' Room: Last_called check: self: G************3WM reported: G************9S3
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] a****n@m*********t: Refreshing Rivka's room
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] Rivka's room: Last_called check: self: G************76M reported: G************9S3
2019-09-24 07:14:08 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********9S3&deviceType=A***********TXA&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] Disabling polling for Living Room
2019-09-24 07:14:08 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********6AV&deviceType=A***********AYF&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:14:08 DEBUG (MainThread) [custom_components.alexa_media.media_player] Disabling polling for Parents Room
2019-09-24 07:14:09 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********3WM&deviceType=A***********AYF&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:14:09 DEBUG (MainThread) [custom_components.alexa_media.media_player] Disabling polling for Girls' Room
2019-09-24 07:14:09 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********405&deviceType=A***********AYF&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:14:09 DEBUG (MainThread) [custom_components.alexa_media.media_player] Disabling polling for Boys Room
2019-09-24 07:14:09 DEBUG (MainThread) [alexapy.alexaapi] GET: https://alexa.amazon.com/api/np/player?deviceSerialNumber=G***********76M&deviceType=A***********AYF&screenWidth=2560 <CIMultiDictProxy('Host': 'alexa.amazon.com', 'User-Agent': 'Mozilla/5.0 (Windows NT 6.3; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/68.0.3440.106 Safari/537.36', 'Accept': 'text/html,application/xhtml+xml, application/xml;q=0.9,*/*;q=0.8', 'Accept-Language': '*', 'Referer': 'https://alexa.amazon.com/spa/index.html', 'Origin': 'https://alexa.amazon.com', 'csrf': '348696369', 'Accept-Encoding': 'gzip, deflate', 'Cookie': 'at-main=Atza|IwEBINtg-_6kO5C9Dgj6_ypn0KFDXtHJeTyKjHhMzMZb2_KLOW69O6rz2mfU54GrXk-8a2c4dHwSXSNZqGJpcgHAJuxmIu63MmCdMguQ9b-VySfmxWM1BeOk6FTpcZKb0FpSbkzBvJ8Krzugr_itjY-xzYKw-UFf4vAq2hNLUQq89ZzTP_e95sxCjjWIAmGdBFBMJBZBZNv93Rcm7vtJI3kxYcjfW19P81D0VlIMdF1gcdgUHfO9BRGNC9-bE6V8TglP2Nru5OqJ6V2tIUX0ShmC80MU3kLfOY9I6PklvGYAAlIgeP8Vo1Uhsdp8yE02r0NEF83jrP0ERAQW_sJLgAVM1HG1hxsFmOVucCeoHZyeYCROrgePuOr62dw-j79DGaVYqBWl4NNok1WEh1H2kZZrAm7O; csrf=348696369; sess-at-main="vl06xBEjbih8HxJwL0yQBMrHqeQF/6LJsqs2/VlT7U8="; session-id=143-9537593-1055442; session-id-time=2187110889l; session-token="jHlb33lW1UfAZHTM8XLC35wgPD7DVOhi9mnxf2rsqORMzxq1wQZ26geC94rRqx2XUZUEaJZ2pyIQxqgwdyXnGsDbq6XhrFKzFTl7VP67HMyjcfTbMBWF6s1hmNuB6qQgoXSSVbXLOMJHRMFuZ+Oru5KqJ4w34ell2ldYdB3xTCAtrTCs7g/Rl4H8EccEVTJHocNkVJiCMLYHzgGPwmumhVMmXYsbX7fpuOnAUw7wqeE="; ubid-main=133-4767277-1843730; x-main="0dsZDcmwKC5@qJ7YoSXbmWwftjpLJ9CB"')> returned 200:OK:application/json
2019-09-24 07:14:09 DEBUG (MainThread) [custom_components.alexa_media.media_player] Disabling polling for Rivka's room
2019-09-24 07:16:55 DEBUG (MainThread) [alexapy.alexawebsocket] msg: WSMessage(type=<WSMsgType.BINARY: 2>, data=b'MSG 0x00000362 0x4ffe6c30 f 0x00000001 0x7153911e 0x00000225 GWM MSG 0x0000b479 0x0000005c urn:tcomm-endpoint:service:serviceName:DeeWebsiteMessagingService:domain:prod:realm:USAmazon 0x00000081 urn:tcomm-endpoint:device:customerId:A***********XKO:deviceType:ALEGCNGL9K0HM:deviceSerialNumber:133-4767277-1843730-1569298431000 {"payload":"{\\"destinationUserId\\":\\"A***********XKO\\",\\"dopplerId\\":{\\"deviceSerialNumber\\":\\"G***********6AV\\",\\"deviceType\\":\\"A***********AYF\\"},\\"isMuted\\":false,\\"volumeSetting\\":87}","command":"PUSH_VOLUME_CHANGE"}FABE', extra='')
2019-09-24 07:16:55 DEBUG (MainThread) [alexapy.alexawebsocket] Received WebSocket MSG.
2019-09-24 07:16:55 DEBUG (MainThread) [alexapy.alexawebsocket] Received b'MSG 0x00000362 0x4ffe6c30 f 0x00000001 0x7153911e 0x00000225 GWM MSG 0x0000b479 0x0000005c urn:tcomm-endpoint:service:serviceName:DeeWebsiteMessagingService:domain:prod:realm:USAmazon 0x00000081 urn:tcomm-endpoint:device:customerId:A***********XKO:deviceType:ALEGCNGL9K0HM:deviceSerialNumber:133-4767277-1843730-1569298431000 {"payload":"{\\"destinationUserId\\":\\"A***********XKO\\",\\"dopplerId\\":{\\"deviceSerialNumber\\":\\"G***********6AV\\",\\"deviceType\\":\\"A***********AYF\\"},\\"isMuted\\":false,\\"volumeSetting\\":87}","command":"PUSH_VOLUME_CHANGE"}FABE'
2019-09-24 07:16:55 DEBUG (MainThread) [alexapy.alexawebsocket] Received Standard MSG.
2019-09-24 07:16:55 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: Received websocket command: PUSH_VOLUME_CHANGE : {'destinationUserId': 'A**********XKO', 'dopplerId': {'deviceSerialNumber': 'G************6AV', 'deviceType': 'A***********AYF'}, 'isMuted': False, 'volumeSetting': 87}
2019-09-24 07:16:55 DEBUG (MainThread) [custom_components.alexa_media] Updating media_player volume: {'destinationUserId': 'A**********XKO', 'dopplerId': {'deviceSerialNumber': 'G************6AV', 'deviceType': 'A***********AYF'}, 'isMuted': False, 'volumeSetting': 87}
2019-09-24 07:16:55 DEBUG (MainThread) [alexapy.alexawebsocket] msg: WSMessage(type=<WSMsgType.BINARY: 2>, data=b'MSG 0x00000362 0x4ffe6c31 f 0x00000001 0x52fbaef8 0x0000022e GWM MSG 0x0000b479 0x0000005c urn:tcomm-endpoint:service:serviceName:DeeWebsiteMessagingService:domain:prod:realm:USAmazon 0x00000081 urn:tcomm-endpoint:device:customerId:A***********XKO:deviceType:ALEGCNGL9K0HM:deviceSerialNumber:133-4767277-1843730-1569298431000 {"payload":"{\\"destinationUserId\\":\\"A***********XKO\\",\\"bass\\":0,\\"treble\\":0,\\"dopplerId\\":{\\"deviceSerialNumber\\":\\"G***********6AV\\",\\"deviceType\\":\\"A***********AYF\\"},\\"midrange\\":0}","command":"PUSH_EQUALIZER_STATE_CHANGE"}FABE', extra='')
2019-09-24 07:16:55 DEBUG (MainThread) [alexapy.alexawebsocket] Received WebSocket MSG.
2019-09-24 07:16:55 DEBUG (MainThread) [alexapy.alexawebsocket] Received b'MSG 0x00000362 0x4ffe6c31 f 0x00000001 0x52fbaef8 0x0000022e GWM MSG 0x0000b479 0x0000005c urn:tcomm-endpoint:service:serviceName:DeeWebsiteMessagingService:domain:prod:realm:USAmazon 0x00000081 urn:tcomm-endpoint:device:customerId:A***********XKO:deviceType:ALEGCNGL9K0HM:deviceSerialNumber:133-4767277-1843730-1569298431000 {"payload":"{\\"destinationUserId\\":\\"A***********XKO\\",\\"bass\\":0,\\"treble\\":0,\\"dopplerId\\":{\\"deviceSerialNumber\\":\\"G***********6AV\\",\\"deviceType\\":\\"A***********AYF\\"},\\"midrange\\":0}","command":"PUSH_EQUALIZER_STATE_CHANGE"}FABE'
2019-09-24 07:16:55 DEBUG (MainThread) [alexapy.alexawebsocket] Received Standard MSG.
2019-09-24 07:16:55 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: Received websocket command: PUSH_EQUALIZER_STATE_CHANGE : {'destinationUserId': 'A**********XKO', 'bass': 0, 'treble': 0, 'dopplerId': {'deviceSerialNumber': 'G************6AV', 'deviceType': 'A***********AYF'}, 'midrange': 0}
2019-09-24 07:16:55 DEBUG (MainThread) [custom_components.alexa_media.media_player] Parents Room volume updated: 87
2019-09-24 07:18:48 DEBUG (MainThread) [alexapy.alexawebsocket] msg: WSMessage(type=<WSMsgType.BINARY: 2>, data=b'MSG 0x00000362 0x4fff0db2 f 0x00000001 0x744d924d 0x00000225 GWM MSG 0x0000b479 0x0000005c urn:tcomm-endpoint:service:serviceName:DeeWebsiteMessagingService:domain:prod:realm:USAmazon 0x00000081 urn:tcomm-endpoint:device:customerId:A***********XKO:deviceType:ALEGCNGL9K0HM:deviceSerialNumber:133-4767277-1843730-1569298431000 {"payload":"{\\"destinationUserId\\":\\"A***********XKO\\",\\"dopplerId\\":{\\"deviceSerialNumber\\":\\"G***********6AV\\",\\"deviceType\\":\\"A***********AYF\\"},\\"isMuted\\":false,\\"volumeSetting\\":87}","command":"PUSH_VOLUME_CHANGE"}FABE', extra='')
2019-09-24 07:18:48 DEBUG (MainThread) [alexapy.alexawebsocket] Received WebSocket MSG.
2019-09-24 07:18:48 DEBUG (MainThread) [alexapy.alexawebsocket] Received b'MSG 0x00000362 0x4fff0db2 f 0x00000001 0x744d924d 0x00000225 GWM MSG 0x0000b479 0x0000005c urn:tcomm-endpoint:service:serviceName:DeeWebsiteMessagingService:domain:prod:realm:USAmazon 0x00000081 urn:tcomm-endpoint:device:customerId:A***********XKO:deviceType:ALEGCNGL9K0HM:deviceSerialNumber:133-4767277-1843730-1569298431000 {"payload":"{\\"destinationUserId\\":\\"A***********XKO\\",\\"dopplerId\\":{\\"deviceSerialNumber\\":\\"G***********6AV\\",\\"deviceType\\":\\"A***********AYF\\"},\\"isMuted\\":false,\\"volumeSetting\\":87}","command":"PUSH_VOLUME_CHANGE"}FABE'
2019-09-24 07:18:48 DEBUG (MainThread) [alexapy.alexawebsocket] Received Standard MSG.
2019-09-24 07:18:48 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: Received websocket command: PUSH_VOLUME_CHANGE : {'destinationUserId': 'A**********XKO', 'dopplerId': {'deviceSerialNumber': 'G************6AV', 'deviceType': 'A***********AYF'}, 'isMuted': False, 'volumeSetting': 87}
2019-09-24 07:18:48 DEBUG (MainThread) [custom_components.alexa_media] Updating media_player volume: {'destinationUserId': 'A**********XKO', 'dopplerId': {'deviceSerialNumber': 'G************6AV', 'deviceType': 'A***********AYF'}, 'isMuted': False, 'volumeSetting': 87}
2019-09-24 07:18:48 DEBUG (MainThread) [alexapy.alexawebsocket] msg: WSMessage(type=<WSMsgType.BINARY: 2>, data=b'MSG 0x00000362 0x4fff0db3 f 0x00000001 0x55f5b027 0x0000022e GWM MSG 0x0000b479 0x0000005c urn:tcomm-endpoint:service:serviceName:DeeWebsiteMessagingService:domain:prod:realm:USAmazon 0x00000081 urn:tcomm-endpoint:device:customerId:A***********XKO:deviceType:ALEGCNGL9K0HM:deviceSerialNumber:133-4767277-1843730-1569298431000 {"payload":"{\\"destinationUserId\\":\\"A***********XKO\\",\\"bass\\":0,\\"treble\\":0,\\"dopplerId\\":{\\"deviceSerialNumber\\":\\"G***********6AV\\",\\"deviceType\\":\\"A***********AYF\\"},\\"midrange\\":0}","command":"PUSH_EQUALIZER_STATE_CHANGE"}FABE', extra='')
2019-09-24 07:18:48 DEBUG (MainThread) [alexapy.alexawebsocket] Received WebSocket MSG.
2019-09-24 07:18:48 DEBUG (MainThread) [alexapy.alexawebsocket] Received b'MSG 0x00000362 0x4fff0db3 f 0x00000001 0x55f5b027 0x0000022e GWM MSG 0x0000b479 0x0000005c urn:tcomm-endpoint:service:serviceName:DeeWebsiteMessagingService:domain:prod:realm:USAmazon 0x00000081 urn:tcomm-endpoint:device:customerId:A***********XKO:deviceType:ALEGCNGL9K0HM:deviceSerialNumber:133-4767277-1843730-1569298431000 {"payload":"{\\"destinationUserId\\":\\"A***********XKO\\",\\"bass\\":0,\\"treble\\":0,\\"dopplerId\\":{\\"deviceSerialNumber\\":\\"G***********6AV\\",\\"deviceType\\":\\"A***********AYF\\"},\\"midrange\\":0}","command":"PUSH_EQUALIZER_STATE_CHANGE"}FABE'
2019-09-24 07:18:48 DEBUG (MainThread) [alexapy.alexawebsocket] Received Standard MSG.
2019-09-24 07:18:48 DEBUG (MainThread) [custom_components.alexa_media] a****n@m*********t: Received websocket command: PUSH_EQUALIZER_STATE_CHANGE : {'destinationUserId': 'A**********XKO', 'bass': 0, 'treble': 0, 'dopplerId': {'deviceSerialNumber': 'G************6AV', 'deviceType': 'A***********AYF'}, 'midrange': 0}
2019-09-24 07:18:48 DEBUG (MainThread) [custom_components.alexa_media.media_player] Parents Room volume updated: 87

Additional context configuration.yaml:

alexa_media:
  accounts:
    - email: !secret alexa_email
      password: !secret alexa_password
      url: amazon.com
      debug: True
      exclude_devices:
        - "Michael's Alexa Apps"
        - "Tatyana's Alexa Apps"
        - "This Device"
...
logger:
  default: info
  logs:
    custom_components.alexa_media: debug
    alexapy: debug
alandtse commented 5 years ago

If you're referring to the fact they're unavailable, it's because they only are active if you are actually in a media mode which allows repeats or shuffles. Try to play something with a queue and the switches will become available. This is what the dev docs call for.

See also: https://community.home-assistant.io/t/echo-devices-alexa-as-media-player-testers-needed/58639/3247

mikeage commented 5 years ago

Ok, that makes sense. So the bug is with my understanding!

(I noticed it because I have a monster card showing me everything that's unavailable, assuming it represents a problem. I'll ignore these.)

Thanks.