SonosController NodeServer

simplextech · October 16, 2020

Just now, Bumbershoot said:

Thanks so much for your work on this. Restarted, and I'll keep watching it.

Thanks to you and everyone else for testing and having patience on these issues. I know they are annoying those of you using the NS.

bcdavis75 · October 16, 2020

13 hours ago, simplextech said:

Thanks to you and everyone else for testing and having patience on these issues. I know they are annoying those of you using the NS.

Well it's not like the nodeserver is overpriced Happy to help iron out the kinks. This nodeserver will be hugely popular.

Incidentally, I just received a new SOnos component (a Sonos Port). At some point this weekend, I'm going to add it to my system AND upgrade from S1 to S2. I'm sure I restart will be in order but, if there's anything special you want me to track or observe, let me know.

simplextech · October 16, 2020

4 hours ago, bcdavis75 said:

I just received a new SOnos component (a Sonos Port)

I don't have one of those so I've not doing any testing around it. It currently (likely) won't show up as a node for anything but I'm wondering if it's possible. I'll have to look at the API again and see if there's anything available.

glarsen · October 16, 2020

4 minutes ago, simplextech said:

I don't have one of those so I've not doing any testing around it. It currently (likely) won't show up as a node for anything but I'm wondering if it's possible. I'll have to look at the API again and see if there's anything available.

I have one and it works fine.

simplextech · October 16, 2020

9 minutes ago, glarsen said:

I have one and it works fine.

"works"? As in how? I didn't code anything specific for the port so I don't know if/how it shows up as nodes or anything.

glarsen · October 16, 2020

2 minutes ago, simplextech said:

"works"? As in how? I didn't code anything specific for the port so I don't know if/how it shows up as nodes or anything.

It appears as a player in the nodeserver:

and like this in the AC:
image.png.56b83b338a94d008d130728aa02ab950.png

It is part of a group and behaves just as the old ZonePlayer did.

bcdavis75 · October 16, 2020

Yeah. Adding was no problem for me. I did a rediscover and Update Profile from the admin console and a few seconds later, the new node appeared. I didn't even have to restart the nodeserver.

carealtor · October 16, 2020

I don't have a Port, but I do have several Connects. In fact, that's all I have. They are just another Sonos device.

bcdavis75 · October 17, 2020

Well, this should make everyone happy. I replaced my router today. Upgraded from a Unifi USG to a Dream Machine Pro. Doesn't get to. much more disruptive then that BUT... the nodeserver was still working just fine when I finally had a network again. No restart required.

Bumbershoot · October 18, 2020

Hi @simplextech, I thought you might be interested to know that the nodeserver survived this string of errors. I was able to successfully play, change volume, etc., after the errors occurred.

Thanks again!

2020-10-18 20:44:05,669 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-18 20:44:05,732 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b9022afa-14: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': 'roZHbM9lq6', 'development': False, 'userId': '569cdd4a92cbdbfb2ce7da16', 'isyVersion': '5.2.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1NjljZGQ0YTkyY2JkYmZiMmNlN2RhMTYiLCJpZCI6IjAwOjIxOmI5OjAyOjJhOmZhIiwicHJvZmlsZU51bSI6MTQsInBhc3N3b3JkIjoicm9aSGJNOWxxNiJ9', 'timeAdded': 1598755682280, 'id': '00:21:b9:02:2a:fa', 'shortPoll': '60', 'timeStarted': 1602953045157, 'version': '0.2.00', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1598755697416, 'timeStarted': 0}, 'g347e5cd1c390': {'address': 'g347e5cd1c390', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '326.875398ms', 'timeAdded': 1602953055615, 'success': False, 'isPrimary': False, 'name': 'Sonos Livivg Room', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'GROUP', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '3', 'uom': '25'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'FAV': {'value': '0', 'uom': '25'}, 'GV1': {'value': '0', 'uom': '2'}, 'SVOL': {'value': '40', 'uom': '51'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'g48a6b845abe8': {'address': 'g48a6b845abe8', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'value': '30', 'uom': '51'}}, 'elapsed': '525.788069ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Master Bedroom', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953061020, 'timeStarted': 0}, 'g949f3e1ec6c0': {'address': 'g949f3e1ec6c0', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '70.330043ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Office', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953068258, 'timeStarted': 0}, 'g949f3e1ed682': {'address': 'g949f3e1ed682', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '422.555539ms', 'timeAdded': 1602953061020, 'success': False, 'isPrimary': False, 'name': 'Sonos Kitchen', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'GROUP', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '3', 'uom': '25'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'FAV': {'value': '0', 'uom': '25'}, 'GV1': {'value': '0', 'uom': '2'}, 'SVOL': {'value': '34', 'uom': '51'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'gb8e93778812a': {'address': 'gb8e93778812a', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'uom': '51', 'value': '12'}}, 'elapsed': '223.301972ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Media Room', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953055615, 'timeStarted': 0}, 'groups': {'address': 'groups', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '123.184499ms', 'timeAdded': 1602953055615, 'success': False, 'isPrimary': True, 'name': 'Sonos Groups', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PARENT', 'drivers': {'ST': {'value': '1', 'uom': '2'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'p347e5cd1c390': {'address': 'p347e5cd1c390', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '528.814ms', 'timeAdded': 1602953068259, 'success': False, 'isPrimary': False, 'name': 'Sonos Livivg Room', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '40', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'p48a6b845abe8': {'address': 'p48a6b845abe8', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '329.056957ms', 'timeAdded': 1602953075744, 'success': False, 'isPrimary': False, 'name': 'Sonos Master Bedroom', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '30', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'p949f3e1ec6c0': {'address': 'p949f3e1ec6c0', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '231.961929ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953075744, 'timeStarted': 0}, 'p949f3e1ed682': {'address': 'p949f3e1ed682', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '284.250971ms', 'timeAdded': 1602953070977, 'success': False, 'isPrimary': False, 'name': 'Sonos Kitchen', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '34', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'pb8e93778812a': {'address': 'pb8e93778812a', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '12'}}, 'elapsed': '513.485641ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Media Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953070977, 'timeStarted': 0}, 'players': {'address': 'players', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '313.925124ms', 'timeAdded': 1602953068258, 'success': False, 'isPrimary': True, 'name': 'Sonos Players', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PARENT', 'drivers': {'ST': {'value': '1', 'uom': '2'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': 'zRnLdjeQtPOnToghhtDkqQpxFx5Z', 'refresh_token': 'IAYegHqnO14cmLOFVvL3HKceA1TKgdus', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'SAY_TTS-10': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-1': 'Someone is at the front door', 'language': 'en-us', 'SAY_TTS-4': 'Someone is at the side door by the garage', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'Brad is arriving', 'SAY_TTS-3': 'Someone is on the deck', 'codec': 'mp3', 'api_key': '79d231a856ed4e37b3d17d9ff39524a5'}, 'profileNum': '14', 'notices': {}, 'worker': 'sonoscontroller-0021b9022afa-14', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-18 20:44:05,733 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-18 21:19:05,588 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b9022afa-14: {'command': {'address': 'p347e5cd1c390', 'cmd': 'SAYTTS', 'value': '2', 'uom': '25', 'query': {}}}
2020-10-18 21:19:05,589 [MQTT      ] [DEBUG] Received Message: {'command': {'address': 'p347e5cd1c390', 'cmd': 'SAYTTS', 'value': '2', 'uom': '25', 'query': {}}}
2020-10-18 21:19:05,590 [Controller] [INFO ] Sending to VoiceRSS for Player: RINCON_347E5CD1C39001400
2020-10-18 21:19:05,599 [Controller] [DEBUG] VoiceRSS Payload: {'name': 'Sonos TTS', 'appId': 'net.simplextech', 'streamUrl': 'http://api.voicerss.org/?key=79d231a856ed4e37b3d17d9ff39524a5&hl=en-us&c=mp3&f=24khz_16bit_stereo&src=Brad%20is%20arriving', 'clipType': 'CUSTOM', 'priority': 'high'}
2020-10-18 21:19:06,010 [Controller] [DEBUG] Success: b'{"id":"ea41a4ce-41c4-4a4a-9c2b-f1931ca21a98","name":"Sonos TTS","appId":"net.simplextech","priority":"HIGH","clipType":"CUSTOM","status":"INACTIVE"}'
2020-10-18 21:19:06,010 [Controller] [INFO ] send_say_tts: True
2020-10-18 21:47:17,897 [Controller] [ERROR] Error sonos_control.get_groups
2020-10-18 21:47:17,898 [Controller] [ERROR] shortPoll:sonos_groups: Sonos Groups is None
2020-10-18 21:47:28,358 [Controller] [ERROR] Error sonos_control.get_players
2020-10-18 21:47:28,359 [Controller] [ERROR] shortPoll: SonosControl.get_players is None
2020-10-18 21:48:18,005 [Controller] [ERROR] Error sonos_control.get_groups
2020-10-18 21:48:18,006 [Controller] [ERROR] shortPoll:sonos_groups: Sonos Groups is None
2020-10-18 21:48:21,848 [Controller] [ERROR] Error sonos_control.get_players
2020-10-18 21:48:21,849 [Controller] [ERROR] shortPoll: SonosControl.get_players is None
2020-10-18 21:49:17,982 [Controller] [ERROR] Error sonos_control.get_groups
2020-10-18 21:49:17,982 [Controller] [ERROR] shortPoll:sonos_groups: Sonos Groups is None
2020-10-18 21:49:28,363 [Controller] [ERROR] Error sonos_control.get_players
2020-10-18 21:49:28,364 [Controller] [ERROR] shortPoll: SonosControl.get_players is None
2020-10-18 21:50:18,015 [Controller] [ERROR] Error sonos_control.get_groups
2020-10-18 21:50:18,015 [Controller] [ERROR] shortPoll:sonos_groups: Sonos Groups is None
2020-10-18 21:50:21,771 [Controller] [ERROR] Error sonos_control.get_players
2020-10-18 21:50:21,772 [Controller] [ERROR] shortPoll: SonosControl.get_players is None
2020-10-18 21:51:10,796 [Controller] [ERROR] Error sonos_control.get_groups
2020-10-18 21:51:10,796 [Controller] [ERROR] shortPoll:sonos_groups: Sonos Groups is None
2020-10-18 21:51:14,081 [Controller] [ERROR] Error sonos_control.get_players
2020-10-18 21:51:14,082 [Controller] [ERROR] shortPoll: SonosControl.get_players is None
2020-10-18 21:52:10,839 [Controller] [ERROR] Error sonos_control.get_groups
2020-10-18 21:52:10,840 [Controller] [ERROR] shortPoll:sonos_groups: Sonos Groups is None
2020-10-18 21:52:14,162 [Controller] [ERROR] Error sonos_control.get_players
2020-10-18 21:52:14,180 [Controller] [ERROR] shortPoll: SonosControl.get_players is None
2020-10-18 21:53:11,316 [Controller] [ERROR] shortPoll:group_volume: None
2020-10-18 21:53:11,530 [Controller] [ERROR] shortPoll:group_volume: None
2020-10-18 21:53:19,746 [Controller] [ERROR] shortPoll: SonosControl.get_player_volume is None
2020-10-18 21:53:23,421 [Controller] [ERROR] shortPoll: SonosControl.get_player_volume is None
2020-10-18 21:54:08,449 [Controller] [ERROR] shortPoll:group_volume: None
2020-10-18 21:54:12,392 [Controller] [ERROR] shortPoll:group_volume: None
2020-10-18 21:57:08,465 [Controller] [ERROR] shortPoll:group_volume: None
2020-10-18 22:44:06,419 [Controller] [INFO ] Sending customData to Polyglot.
2020-10-18 22:44:06,419 [Controller] [DEBUG] Sent Message: [prod/ns] : {"customdata": {"access_token": "3Aueb15H6XOUI0KGVmaKHUvr9BRy", "refresh_token": "IAYegHqnO14cmLOFVvL3HKceA1TKgdus", "expires_in": 86399}, "userId": "569cdd4a92cbdbfb2ce7da16", "topic": "prod/ns/sonoscontroller-0021b9022afa-14", "profileNum": "14", "id": "00:21:b9:02:2a:fa"}
2020-10-18 22:44:06,420 [Controller] [INFO ] Sending notices to Polyglot.
2020-10-18 22:44:06,420 [Controller] [DEBUG] Sent Message: [prod/ns] : {"notices": {}, "userId": "569cdd4a92cbdbfb2ce7da16", "topic": "prod/ns/sonoscontroller-0021b9022afa-14", "profileNum": "14", "id": "00:21:b9:02:2a:fa"}
2020-10-18 22:44:06,712 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b9022afa-14: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': 'roZHbM9lq6', 'development': False, 'userId': '569cdd4a92cbdbfb2ce7da16', 'isyVersion': '5.2.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1NjljZGQ0YTkyY2JkYmZiMmNlN2RhMTYiLCJpZCI6IjAwOjIxOmI5OjAyOjJhOmZhIiwicHJvZmlsZU51bSI6MTQsInBhc3N3b3JkIjoicm9aSGJNOWxxNiJ9', 'timeAdded': 1598755682280, 'id': '00:21:b9:02:2a:fa', 'shortPoll': '60', 'timeStarted': 1602953045157, 'version': '0.2.00', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1598755697416, 'timeStarted': 0}, 'g347e5cd1c390': {'address': 'g347e5cd1c390', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '326.875398ms', 'timeAdded': 1602953055615, 'success': False, 'isPrimary': False, 'name': 'Sonos Livivg Room', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'GROUP', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '3', 'uom': '25'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'FAV': {'value': '0', 'uom': '25'}, 'GV1': {'value': '0', 'uom': '2'}, 'SVOL': {'value': '40', 'uom': '51'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'g48a6b845abe8': {'address': 'g48a6b845abe8', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'value': '30', 'uom': '51'}}, 'elapsed': '525.788069ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Master Bedroom', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953061020, 'timeStarted': 0}, 'g949f3e1ec6c0': {'address': 'g949f3e1ec6c0', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '70.330043ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Office', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953068258, 'timeStarted': 0}, 'g949f3e1ed682': {'address': 'g949f3e1ed682', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '422.555539ms', 'timeAdded': 1602953061020, 'success': False, 'isPrimary': False, 'name': 'Sonos Kitchen', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'GROUP', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '3', 'uom': '25'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'FAV': {'value': '0', 'uom': '25'}, 'GV1': {'value': '0', 'uom': '2'}, 'SVOL': {'value': '34', 'uom': '51'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'gb8e93778812a': {'address': 'gb8e93778812a', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'uom': '51', 'value': '12'}}, 'elapsed': '223.301972ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Media Room', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953055615, 'timeStarted': 0}, 'groups': {'address': 'groups', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '123.184499ms', 'timeAdded': 1602953055615, 'success': False, 'isPrimary': True, 'name': 'Sonos Groups', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PARENT', 'drivers': {'ST': {'value': '1', 'uom': '2'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'p347e5cd1c390': {'address': 'p347e5cd1c390', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '528.814ms', 'timeAdded': 1602953068259, 'success': False, 'isPrimary': False, 'name': 'Sonos Livivg Room', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '40', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'p48a6b845abe8': {'address': 'p48a6b845abe8', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '329.056957ms', 'timeAdded': 1602953075744, 'success': False, 'isPrimary': False, 'name': 'Sonos Master Bedroom', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '30', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'p949f3e1ec6c0': {'address': 'p949f3e1ec6c0', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '231.961929ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953075744, 'timeStarted': 0}, 'p949f3e1ed682': {'address': 'p949f3e1ed682', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '284.250971ms', 'timeAdded': 1602953070977, 'success': False, 'isPrimary': False, 'name': 'Sonos Kitchen', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '34', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'pb8e93778812a': {'address': 'pb8e93778812a', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '12'}}, 'elapsed': '513.485641ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Media Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953070977, 'timeStarted': 0}, 'players': {'address': 'players', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '313.925124ms', 'timeAdded': 1602953068258, 'success': False, 'isPrimary': True, 'name': 'Sonos Players', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PARENT', 'drivers': {'ST': {'value': '1', 'uom': '2'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': '3Aueb15H6XOUI0KGVmaKHUvr9BRy', 'refresh_token': 'IAYegHqnO14cmLOFVvL3HKceA1TKgdus', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'SAY_TTS-10': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-1': 'Someone is at the front door', 'language': 'en-us', 'SAY_TTS-4': 'Someone is at the side door by the garage', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'Brad is arriving', 'SAY_TTS-3': 'Someone is on the deck', 'codec': 'mp3', 'api_key': '79d231a856ed4e37b3d17d9ff39524a5'}, 'profileNum': '14', 'notices': {}, 'worker': 'sonoscontroller-0021b9022afa-14', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-18 22:44:06,713 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-18 22:44:06,758 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b9022afa-14: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': 'roZHbM9lq6', 'development': False, 'userId': '569cdd4a92cbdbfb2ce7da16', 'isyVersion': '5.2.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1NjljZGQ0YTkyY2JkYmZiMmNlN2RhMTYiLCJpZCI6IjAwOjIxOmI5OjAyOjJhOmZhIiwicHJvZmlsZU51bSI6MTQsInBhc3N3b3JkIjoicm9aSGJNOWxxNiJ9', 'timeAdded': 1598755682280, 'id': '00:21:b9:02:2a:fa', 'shortPoll': '60', 'timeStarted': 1602953045157, 'version': '0.2.00', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1598755697416, 'timeStarted': 0}, 'g347e5cd1c390': {'address': 'g347e5cd1c390', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '326.875398ms', 'timeAdded': 1602953055615, 'success': False, 'isPrimary': False, 'name': 'Sonos Livivg Room', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'GROUP', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '3', 'uom': '25'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'FAV': {'value': '0', 'uom': '25'}, 'GV1': {'value': '0', 'uom': '2'}, 'SVOL': {'value': '40', 'uom': '51'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'g48a6b845abe8': {'address': 'g48a6b845abe8', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'value': '30', 'uom': '51'}}, 'elapsed': '525.788069ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Master Bedroom', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953061020, 'timeStarted': 0}, 'g949f3e1ec6c0': {'address': 'g949f3e1ec6c0', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '70.330043ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Office', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953068258, 'timeStarted': 0}, 'g949f3e1ed682': {'address': 'g949f3e1ed682', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '422.555539ms', 'timeAdded': 1602953061020, 'success': False, 'isPrimary': False, 'name': 'Sonos Kitchen', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'GROUP', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '3', 'uom': '25'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'FAV': {'value': '0', 'uom': '25'}, 'GV1': {'value': '0', 'uom': '2'}, 'SVOL': {'value': '34', 'uom': '51'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'gb8e93778812a': {'address': 'gb8e93778812a', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'uom': '51', 'value': '12'}}, 'elapsed': '223.301972ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Media Room', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953055615, 'timeStarted': 0}, 'groups': {'address': 'groups', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '123.184499ms', 'timeAdded': 1602953055615, 'success': False, 'isPrimary': True, 'name': 'Sonos Groups', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PARENT', 'drivers': {'ST': {'value': '1', 'uom': '2'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'p347e5cd1c390': {'address': 'p347e5cd1c390', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '528.814ms', 'timeAdded': 1602953068259, 'success': False, 'isPrimary': False, 'name': 'Sonos Livivg Room', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '40', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'p48a6b845abe8': {'address': 'p48a6b845abe8', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '329.056957ms', 'timeAdded': 1602953075744, 'success': False, 'isPrimary': False, 'name': 'Sonos Master Bedroom', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '30', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'p949f3e1ec6c0': {'address': 'p949f3e1ec6c0', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '231.961929ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953075744, 'timeStarted': 0}, 'p949f3e1ed682': {'address': 'p949f3e1ed682', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '284.250971ms', 'timeAdded': 1602953070977, 'success': False, 'isPrimary': False, 'name': 'Sonos Kitchen', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '34', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'pb8e93778812a': {'address': 'pb8e93778812a', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '12'}}, 'elapsed': '513.485641ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Media Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953070977, 'timeStarted': 0}, 'players': {'address': 'players', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '313.925124ms', 'timeAdded': 1602953068258, 'success': False, 'isPrimary': True, 'name': 'Sonos Players', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PARENT', 'drivers': {'ST': {'value': '1', 'uom': '2'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': '3Aueb15H6XOUI0KGVmaKHUvr9BRy', 'refresh_token': 'IAYegHqnO14cmLOFVvL3HKceA1TKgdus', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'SAY_TTS-10': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-1': 'Someone is at the front door', 'language': 'en-us', 'SAY_TTS-4': 'Someone is at the side door by the garage', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'Brad is arriving', 'SAY_TTS-3': 'Someone is on the deck', 'codec': 'mp3', 'api_key': '79d231a856ed4e37b3d17d9ff39524a5'}, 'profileNum': '14', 'notices': {}, 'worker': 'sonoscontroller-0021b9022afa-14', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-18 22:44:06,758 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-18 23:30:54,772 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b9022afa-14: {'command': {'address': 'g949f3e1ec6c0', 'cmd': 'PLAY', 'query': {}}}
2020-10-18 23:30:54,774 [MQTT      ] [DEBUG] Received Message: {'command': {'address': 'g949f3e1ec6c0', 'cmd': 'PLAY', 'query': {}}}
2020-10-18 23:30:57,630 [Controller] [INFO ] Updating Driver g949f3e1ec6c0 - ST: 1 uom: 25
2020-10-18 23:30:59,262 [Drivers   ] [DEBUG] Sent Message: [prod/ns] : {"batch": {"status": [{"address": "g949f3e1ec6c0", "driver": "ST", "value": "1", "uom": "25"}]}, "userId": "569cdd4a92cbdbfb2ce7da16", "topic": "prod/ns/sonoscontroller-0021b9022afa-14", "profileNum": "14", "id": "00:21:b9:02:2a:fa"}
, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'uom': '51', 'value': '12'}}, 'elapsed': '223.301972ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Media Room', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953055615, 'timeStarted': 0}, 'groups': {'address': 'groups', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '123.184499ms', 'timeAdded': 1602953055615, 'success': False, 'isPrimary': True, 'name': 'Sonos Groups', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PARENT', 'drivers': {'ST': {'value': '1', 'uom': '2'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'p347e5cd1c390': {'address': 'p347e5cd1c390', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '528.814ms', 'timeAdded': 1602953068259, 'success': False, 'isPrimary': False, 'name': 'Sonos Livivg Room', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '40', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'p48a6b845abe8': {'address': 'p48a6b845abe8', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '329.056957ms', 'timeAdded': 1602953075744, 'success': False, 'isPrimary': False, 'name': 'Sonos Master Bedroom', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '30', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'p949f3e1ec6c0': {'address': 'p949f3e1ec6c0', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '231.961929ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953075744, 'timeStarted': 0}, 'p949f3e1ed682': {'address': 'p949f3e1ed682', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '284.250971ms', 'timeAdded': 1602953070977, 'success': False, 'isPrimary': False, 'name': 'Sonos Kitchen', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PLAYER', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'value': '34', 'uom': '51'}, 'SAYTTS': {'value': '0', 'uom': '25'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}, 'pb8e93778812a': {'address': 'pb8e93778812a', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '12'}}, 'elapsed': '513.485641ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Media Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953070977, 'timeStarted': 0}, 'players': {'address': 'players', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '313.925124ms', 'timeAdded': 1602953068258, 'success': False, 'isPrimary': True, 'name': 'Sonos Players', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'PARENT', 'drivers': {'ST': {'value': '1', 'uom': '2'}}, 'seq': False, 'primary': 'players', 'statusCode': 400}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': '3Aueb15H6XOUI0KGVmaKHUvr9BRy', 'refresh_token': 'IAYegHqnO14cmLOFVvL3HKceA1TKgdus', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'SAY_TTS-10': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-1': 'Someone is at the front door', 'language': 'en-us', 'SAY_TTS-4': 'Someone is at the side door by the garage', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'Brad is arriving', 'SAY_TTS-3': 'Someone is on the deck', 'codec': 'mp3', 'api_key': '79d231a856ed4e37b3d17d9ff39524a5'}, 'profileNum': '14', 'notices': {}, 'worker': 'sonoscontroller-0021b9022afa-14', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-18 23:31:00,073 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b9022afa-14: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': 'roZHbM9lq6', 'development': False, 'userId': '569cdd4a92cbdbfb2ce7da16', 'isyVersion': '5.2.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1NjljZGQ0YTkyY2JkYmZiMmNlN2RhMTYiLCJpZCI6IjAwOjIxOmI5OjAyOjJhOmZhIiwicHJvZmlsZU51bSI6MTQsInBhc3N3b3JkIjoicm9aSGJNOWxxNiJ9', 'timeAdded': 1598755682280, 'id': '00:21:b9:02:2a:fa', 'shortPoll': '60', 'timeStarted': 1602953045157, 'version': '0.2.00', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1598755697416, 'timeStarted': 0}, 'g347e5cd1c390': {'address': 'g347e5cd1c390', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '326.875398ms', 'timeAdded': 1602953055615, 'success': False, 'isPrimary': False, 'name': 'Sonos Livivg Room', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'GROUP', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '3', 'uom': '25'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'FAV': {'value': '0', 'uom': '25'}, 'GV1': {'value': '0', 'uom': '2'}, 'SVOL': {'value': '40', 'uom': '51'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'g48a6b845abe8': {'address': 'g48a6b845abe8', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '4'}, 'SVOL': {'value': '30', 'uom': '51'}}, 'elapsed': '525.788069ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Master Bedroom', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953061020, 'timeStarted': 0}, 'g949f3e1ec6c0': {'address': 'g949f3e1ec6c0', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '70.330043ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Office', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1602953068258, 'timeStarted': 0}, 'g949f3e1ed682': {'address': 'g949f3e1ed682', 'timeStarted': 0, 'error': False, 'isController': False, 'elapsed': '422.555539ms', 'timeAdded': 1602953061020, 'success': False, 'isPrimary': False, 'name': 'Sonos Kitchen', 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'nodedefid': 'GROUP', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'ST': {'value': '3', 'uom': '25'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'FAV': {'value': '0', 'uom': '25'}, 'GV1': {'value': '0', 'uom': '2'}, 'SVOL': {'value': '34', 'uom': '51'}}, 'seq': False, 'primary': 'groups', 'statusCode': 400}, 'gb8e93778812a': {'address': 'gb8e93778812a', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'value': '0', 'uom': '2'}, 'GV1': {'value': '0', 'uom': '2'}
2020-10-18 23:31:00,073 [MQTT      ] [DEBUG] Recieved Message: config

glarsen · October 19, 2020

Mine showed some strange behavior this morning too. It seems to have cleared without intervention and everything functions normally. Don't you love a good mystery?

Edit: Oops, try this file Didn't notice I had 2 stored.

sonoscontroller-0021b900ee84-8 (1).txt

simplextech · October 19, 2020

35 minutes ago, glarsen said:

Mine showed some strange behavior this morning too. It seems to have cleared without intervention and everything functions normally. Don't you love a good mystery?

sonoscontroller-0021b900ee84-8.txt 356.88 kB · 0 downloads

Funny... your log time stamp shows a date of October 7th..... ???

Bumbershoot · October 20, 2020

It ran for over 48 hours, but it didn't survive this one...

2020-10-20 02:44:05,981 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-20 02:49:27,424 [Controller] [ERROR] Exception in thread Controller:
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 677, in urlopen
    chunked=chunked,
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 381, in _make_request
    self._validate_conn(conn)
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 978, in _validate_conn
    conn.connect()
  File "/usr/local/lib/python3.7/site-packages/urllib3/connection.py", line 371, in connect
    ssl_context=context,
  File "/usr/local/lib/python3.7/site-packages/urllib3/util/ssl_.py", line 384, in ssl_wrap_socket
    return context.wrap_socket(sock, server_hostname=server_hostname)
  File "/usr/local/lib/python3.7/ssl.py", line 412, in wrap_socket
    session=session
  File "/usr/local/lib/python3.7/ssl.py", line 853, in _create
    self.do_handshake()
  File "/usr/local/lib/python3.7/ssl.py", line 1117, in do_handshake
    self._sslobj.do_handshake()
ConnectionResetError: [Errno 104] Connection reset by peer

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/requests/adapters.py", line 449, in send
    timeout=timeout
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 727, in urlopen
    method, url, error=e, _pool=self, _stacktrace=sys.exc_info()[2]
  File "/usr/local/lib/python3.7/site-packages/urllib3/util/retry.py", line 403, in increment
    raise six.reraise(type(error), error, _stacktrace)
  File "/usr/local/lib/python3.7/site-packages/urllib3/packages/six.py", line 734, in reraise
    raise value.with_traceback(tb)
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 677, in urlopen
    chunked=chunked,
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 381, in _make_request
    self._validate_conn(conn)
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 978, in _validate_conn
    conn.connect()
  File "/usr/local/lib/python3.7/site-packages/urllib3/connection.py", line 371, in connect
    ssl_context=context,
  File "/usr/local/lib/python3.7/site-packages/urllib3/util/ssl_.py", line 384, in ssl_wrap_socket
    return context.wrap_socket(sock, server_hostname=server_hostname)
  File "/usr/local/lib/python3.7/ssl.py", line 412, in wrap_socket
    session=session
  File "/usr/local/lib/python3.7/ssl.py", line 853, in _create
    self.do_handshake()
  File "/usr/local/lib/python3.7/ssl.py", line 1117, in do_handshake
    self._sslobj.do_handshake()
urllib3.exceptions.ProtocolError: ('Connection aborted.', ConnectionResetError(104, 'Connection reset by peer'))

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.7/threading.py", line 917, in _bootstrap_inner
    self.run()
  File "/usr/local/lib/python3.7/threading.py", line 865, in run
    self._target(*self._args, **self._kwargs)
  File "/usr/local/lib/python3.7/site-packages/pgc_interface/pgc_interface.py", line 795, in _parseInput
    self.shortPoll()
  File "./SonosController.py", line 193, in shortPoll
    sonos_groups = self.SonosControl.get_groups(household)
  File "/app/nodeserver/sonos/sonos_control.py", line 107, in get_groups
    r_json = self.sonos_get_api(groups_url)
  File "/app/nodeserver/sonos/sonos_control.py", line 46, in sonos_get_api
    req = requests.get(url, headers=self.headers)
  File "/usr/local/lib/python3.7/site-packages/requests/api.py", line 76, in get
    return request('get', url, params=params, **kwargs)
  File "/usr/local/lib/python3.7/site-packages/requests/api.py", line 61, in request
    return session.request(method=method, url=url, **kwargs)
  File "/usr/local/lib/python3.7/site-packages/requests/sessions.py", line 530, in request
    resp = self.send(prep, **send_kwargs)
  File "/usr/local/lib/python3.7/site-packages/requests/sessions.py", line 643, in send
    r = adapter.send(request, **kwargs)
  File "/usr/local/lib/python3.7/site-packages/requests/adapters.py", line 498, in send
    raise ConnectionError(err, request=request)
requests.exceptions.ConnectionError: ('Connection aborted.', ConnectionResetError(104, 'Connection reset by peer'))
2020-10-20 11:52:18,227 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b9022afa-14: {'command': {'address': 'g949f3e1ec6c0', 'cmd': 'PLAY', 'query': {}}}
2020-10-20 11:52:18,228 [MQTT      ] [DEBUG] Received Message: {'command': {'address': 'g949f3e1ec6c0', 'cmd': 'PLAY', 'query': {}}}

simplextech · October 20, 2020

1 hour ago, Bumbershoot said:

self._sslobj.do_handshake() ConnectionResetError: [Errno 104] Connection reset by peer

again looks like an SSL issue from that error message.

glarsen · October 20, 2020

2020-10-20 03:01:05,605 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-20 03:28:15,571 [Controller] [ERROR] Exception in thread Controller:
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 677, in urlopen
    chunked=chunked,
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 381, in _make_request
    self._validate_conn(conn)
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 978, in _validate_conn
    conn.connect()
  File "/usr/local/lib/python3.7/site-packages/urllib3/connection.py", line 371, in connect
    ssl_context=context,
  File "/usr/local/lib/python3.7/site-packages/urllib3/util/ssl_.py", line 384, in ssl_wrap_socket
    return context.wrap_socket(sock, server_hostname=server_hostname)
  File "/usr/local/lib/python3.7/ssl.py", line 412, in wrap_socket
    session=session
  File "/usr/local/lib/python3.7/ssl.py", line 853, in _create
    self.do_handshake()
  File "/usr/local/lib/python3.7/ssl.py", line 1117, in do_handshake
    self._sslobj.do_handshake()
ConnectionResetError: [Errno 104] Connection reset by peer

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/requests/adapters.py", line 449, in send
    timeout=timeout
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 727, in urlopen
    method, url, error=e, _pool=self, _stacktrace=sys.exc_info()[2]
  File "/usr/local/lib/python3.7/site-packages/urllib3/util/retry.py", line 403, in increment
    raise six.reraise(type(error), error, _stacktrace)
  File "/usr/local/lib/python3.7/site-packages/urllib3/packages/six.py", line 734, in reraise
    raise value.with_traceback(tb)
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 677, in urlopen
    chunked=chunked,
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 381, in _make_request
    self._validate_conn(conn)
  File "/usr/local/lib/python3.7/site-packages/urllib3/connectionpool.py", line 978, in _validate_conn
    conn.connect()
  File "/usr/local/lib/python3.7/site-packages/urllib3/connection.py", line 371, in connect
    ssl_context=context,
  File "/usr/local/lib/python3.7/site-packages/urllib3/util/ssl_.py", line 384, in ssl_wrap_socket
    return context.wrap_socket(sock, server_hostname=server_hostname)
  File "/usr/local/lib/python3.7/ssl.py", line 412, in wrap_socket
    session=session
  File "/usr/local/lib/python3.7/ssl.py", line 853, in _create
    self.do_handshake()
  File "/usr/local/lib/python3.7/ssl.py", line 1117, in do_handshake
    self._sslobj.do_handshake()
urllib3.exceptions.ProtocolError: ('Connection aborted.', ConnectionResetError(104, 'Connection reset by peer'))

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.7/threading.py", line 917, in _bootstrap_inner
    self.run()
  File "/usr/local/lib/python3.7/threading.py", line 865, in run
    self._target(*self._args, **self._kwargs)
  File "/usr/local/lib/python3.7/site-packages/pgc_interface/pgc_interface.py", line 795, in _parseInput
    self.shortPoll()
  File "./SonosController.py", line 241, in shortPoll
    player_volume = self.SonosControl.get_player_volume(player_id)
  File "/app/nodeserver/sonos/sonos_control.py", line 182, in get_player_volume
    r_json = self.sonos_get_api(player_volume_url)
  File "/app/nodeserver/sonos/sonos_control.py", line 46, in sonos_get_api
    req = requests.get(url, headers=self.headers)
  File "/usr/local/lib/python3.7/site-packages/requests/api.py", line 76, in get
    return request('get', url, params=params, **kwargs)
  File "/usr/local/lib/python3.7/site-packages/requests/api.py", line 61, in request
    return session.request(method=method, url=url, **kwargs)
  File "/usr/local/lib/python3.7/site-packages/requests/sessions.py", line 530, in request
    resp = self.send(prep, **send_kwargs)
  File "/usr/local/lib/python3.7/site-packages/requests/sessions.py", line 643, in send
    r = adapter.send(request, **kwargs)
  File "/usr/local/lib/python3.7/site-packages/requests/adapters.py", line 498, in send
    raise ConnectionError(err, request=request)
requests.exceptions.ConnectionError: ('Connection aborted.', ConnectionResetError(104, 'Connection reset by peer'))

Same thing here, about 3/4 of an hour later.

simplextech · October 20, 2020

2 minutes ago, glarsen said:

File "/usr/local/lib/python3.7/ssl.py", line 1117, in do_handshake self._sslobj.do_handshake() ConnectionResetError: [Errno 104] Connection reset by peer

same...

simplextech · October 20, 2020

Just pushed an update that adds some additional error catches to the name_resolution check and moved the voice rss call to use the standardized sonos_api_post function. That's the last of the little things I can see currently where anything "might" be having issues and not being caught. Anything further and it's going to be deeper in the stack.

glarsen · October 22, 2020

This happened at the point of a program execution this evening, thus the programmed operation did not occur. Manually running the program later worked, so the nodeserver recovered.

2020-10-22 01:42:51,573 [Controller] [INFO ] Sending customData to Polyglot.
2020-10-22 01:42:51,575 [Controller] [DEBUG] Sent Message: [prod/ns] : {"customdata": {"access_token": "Z2V8XY7lDlQDvIlqoQA1fFiVQXIj", "refresh_token": "YUTsRba5XH0To1bo71J8xl40qyboHdw2", "expires_in": 86399}, "userId": "5a1311c6fdbae12be43f38ab", "topic": "prod/ns/sonoscontroller-0021b900ee84-8", "profileNum": "8", "id": "00:21:b9:00:ee:84"}
2020-10-22 01:42:51,575 [Controller] [INFO ] Sending notices to Polyglot.
2020-10-22 01:42:51,576 [Controller] [DEBUG] Sent Message: [prod/ns] : {"notices": {}, "userId": "5a1311c6fdbae12be43f38ab", "topic": "prod/ns/sonoscontroller-0021b900ee84-8", "profileNum": "8", "id": "00:21:b9:00:ee:84"}
2020-10-22 01:42:51,962 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': '6HwGgmnSJB', 'development': False, 'userId': '5a1311c6fdbae12be43f38ab', 'isyVersion': '5.3.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1YTEzMTFjNmZkYmFlMTJiZTQzZjM4YWIiLCJpZCI6IjAwOjIxOmI5OjAwOmVlOjg0IiwicHJvZmlsZU51bSI6OCwicGFzc3dvcmQiOiI2SHdHZ21uU0pCIn0', 'timeAdded': 1602802570379, 'id': '00:21:b9:00:ee:84', 'shortPoll': '60', 'timeStarted': 1603232204011, 'version': '0.2.20', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1602802587944, 'timeStarted': 0}, 'g48a6b862d396': {'address': 'g48a6b862d396', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'uom': '2', 'value': '0'}, 'GV1': {'uom': '2', 'value': '0'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '18'}}, 'elapsed': '245.690056ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room ', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'groups': {'address': 'groups', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '138.78059ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Groups', 'nodedefid': 'PARENT', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'p48a6b81acf2e': {'address': 'p48a6b81acf2e', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '5'}}, 'elapsed': '756.612304ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Master Bedroom', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'p48a6b822aeb2': {'address': 'p48a6b822aeb2', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '55'}}, 'elapsed': '708.580152ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Garage', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201398686, 'timeStarted': 0}, 'p48a6b862d396': {'address': 'p48a6b862d396', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '646.240252ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'pb8e937587f00': {'address': 'pb8e937587f00', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '475.735759ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d0874': {'address': 'pb8e9375d0874', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '230.486919ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Powder Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d11ea': {'address': 'pb8e9375d11ea', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '15'}}, 'elapsed': '369.190838ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Patio', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'players': {'address': 'players', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '357.595867ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Players', 'nodedefid': 'PARENT', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': 'Z2V8XY7lDlQDvIlqoQA1fFiVQXIj', 'refresh_token': 'YUTsRba5XH0To1bo71J8xl40qyboHdw2', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-10': 'empty', 'SAY_TTS-1': 'This is  a test message', 'language': 'en-us', 'SAY_TTS-4': 'empty', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'empty', 'SAY_TTS-3': 'empty', 'codec': 'mp3', 'api_key': '13a2708b10c34a03b2f68000ce401cc8'}, 'profileNum': '8', 'notices': {}, 'worker': 'sonoscontroller-0021b900ee84-8', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-22 01:42:51,962 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-22 01:42:52,004 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': '6HwGgmnSJB', 'development': False, 'userId': '5a1311c6fdbae12be43f38ab', 'isyVersion': '5.3.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1YTEzMTFjNmZkYmFlMTJiZTQzZjM4YWIiLCJpZCI6IjAwOjIxOmI5OjAwOmVlOjg0IiwicHJvZmlsZU51bSI6OCwicGFzc3dvcmQiOiI2SHdHZ21uU0pCIn0', 'timeAdded': 1602802570379, 'id': '00:21:b9:00:ee:84', 'shortPoll': '60', 'timeStarted': 1603232204011, 'version': '0.2.20', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1602802587944, 'timeStarted': 0}, 'g48a6b862d396': {'address': 'g48a6b862d396', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'uom': '2', 'value': '0'}, 'GV1': {'uom': '2', 'value': '0'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '18'}}, 'elapsed': '245.690056ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room ', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'groups': {'address': 'groups', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '138.78059ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Groups', 'nodedefid': 'PARENT', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'p48a6b81acf2e': {'address': 'p48a6b81acf2e', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '5'}}, 'elapsed': '756.612304ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Master Bedroom', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'p48a6b822aeb2': {'address': 'p48a6b822aeb2', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '55'}}, 'elapsed': '708.580152ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Garage', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201398686, 'timeStarted': 0}, 'p48a6b862d396': {'address': 'p48a6b862d396', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '646.240252ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'pb8e937587f00': {'address': 'pb8e937587f00', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '475.735759ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d0874': {'address': 'pb8e9375d0874', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '230.486919ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Powder Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d11ea': {'address': 'pb8e9375d11ea', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '15'}}, 'elapsed': '369.190838ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Patio', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'players': {'address': 'players', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '357.595867ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Players', 'nodedefid': 'PARENT', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': 'HEUNI4quMWGI8F1LCG0eWp4me2g1', 'refresh_token': 'YUTsRba5XH0To1bo71J8xl40qyboHdw2', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-10': 'empty', 'SAY_TTS-1': 'This is  a test message', 'language': 'en-us', 'SAY_TTS-4': 'empty', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'empty', 'SAY_TTS-3': 'empty', 'codec': 'mp3', 'api_key': '13a2708b10c34a03b2f68000ce401cc8'}, 'profileNum': '8', 'notices': {}, 'worker': 'sonoscontroller-0021b900ee84-8', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-22 01:42:52,005 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-22 03:00:15,293 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'command': {'address': 'g48a6b862d396', 'cmd': 'PLAYLST', 'value': '8', 'uom': '25', 'query': {}}}
2020-10-22 03:00:15,294 [MQTT      ] [DEBUG] Received Message: {'command': {'address': 'g48a6b862d396', 'cmd': 'PLAYLST', 'value': '8', 'uom': '25', 'query': {}}}
2020-10-22 03:00:15,882 [Controller] [ERROR] SonosControl.sonos_api: b'{"fault":{"faultstring":"Invalid Access Token","detail":{"errorcode":"keymanagement.service.invalid_access_token"}}}'
2020-10-22 03:00:15,883 [Controller] [ERROR] sonos_control.set_playlist
2020-10-22 03:00:15,883 [Controller] [ERROR] Error: False
2020-10-22 03:00:26,193 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'command': {'address': 'g48a6b862d396', 'cmd': 'PLAY', 'query': {}}}
2020-10-22 03:00:26,193 [MQTT      ] [DEBUG] Received Message: {'command': {'address': 'g48a6b862d396', 'cmd': 'PLAY', 'query': {}}}
2020-10-22 03:00:28,513 [Controller] [ERROR] SonosControl.sonos_api: b'{"fault":{"faultstring":"Invalid Access Token","detail":{"errorcode":"keymanagement.service.invalid_access_token"}}}'
2020-10-22 03:00:28,514 [Controller] [ERROR] sonos_control.set_play
2020-10-22 03:00:28,514 [Controller] [ERROR] Error: False
2020-10-22 03:01:02,432 [Controller] [INFO ] Updating Driver g48a6b862d396 - SVOL: 13 uom: 51
2020-10-22 03:01:03,539 [Drivers   ] [DEBUG] Sent Message: [prod/ns] : {"batch": {"status": [{"address": "g48a6b862d396", "driver": "SVOL", "value": "13", "uom": "51"}]}, "userId": "5a1311c6fdbae12be43f38ab", "topic": "prod/ns/sonoscontroller-0021b900ee84-8", "profileNum": "8", "id": "00:21:b9:00:ee:84"}
2020-10-22 03:01:05,110 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': '6HwGgmnSJB', 'development': False, 'userId': '5a1311c6fdbae12be43f38ab', 'isyVersion': '5.3.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1YTEzMTFjNmZkYmFlMTJiZTQzZjM4YWIiLCJpZCI6IjAwOjIxOmI5OjAwOmVlOjg0IiwicHJvZmlsZU51bSI6OCwicGFzc3dvcmQiOiI2SHdHZ21uU0pCIn0', 'timeAdded': 1602802570379, 'id': '00:21:b9:00:ee:84', 'shortPoll': '60', 'timeStarted': 1603232204011, 'version': '0.2.20', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1602802587944, 'timeStarted': 0}, 'g48a6b862d396': {'address': 'g48a6b862d396', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'uom': '2', 'value': '0'}, 'GV1': {'uom': '2', 'value': '0'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '13'}}, 'elapsed': '245.690056ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room ', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'groups': {'address': 'groups', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '138.78059ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Groups', 'nodedefid': 'PARENT', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'p48a6b81acf2e': {'address': 'p48a6b81acf2e', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '5'}}, 'elapsed': '756.612304ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Master Bedroom', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'p48a6b822aeb2': {'address': 'p48a6b822aeb2', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '55'}}, 'elapsed': '708.580152ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Garage', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201398686, 'timeStarted': 0}, 'p48a6b862d396': {'address': 'p48a6b862d396', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '20'}}, 'elapsed': '646.240252ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'pb8e937587f00': {'address': 'pb8e937587f00', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '475.735759ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d0874': {'address': 'pb8e9375d0874', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '230.486919ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Powder Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d11ea': {'address': 'pb8e9375d11ea', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '15'}}, 'elapsed': '369.190838ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Patio', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'players': {'address': 'players', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '357.595867ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Players', 'nodedefid': 'PARENT', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': 'Z2V8XY7lDlQDvIlqoQA1fFiVQXIj', 'refresh_token': 'YUTsRba5XH0To1bo71J8xl40qyboHdw2', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-10': 'empty', 'SAY_TTS-1': 'This is  a test message', 'language': 'en-us', 'SAY_TTS-4': 'empty', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'empty', 'SAY_TTS-3': 'empty', 'codec': 'mp3', 'api_key': '13a2708b10c34a03b2f68000ce401cc8'}, 'profileNum': '8', 'notices': {}, 'worker': 'sonoscontroller-0021b900ee84-8', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-22 03:01:05,110 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-22 03:01:09,086 [Controller] [INFO ] Updating Driver p48a6b862d396 - SVOL: 5 uom: 51
2020-10-22 03:01:12,430 [Controller] [INFO ] Updating Driver p48a6b81acf2e - SVOL: 1 uom: 51
2020-10-22 03:01:13,579 [Drivers   ] [DEBUG] Sent Message: [prod/ns] : {"batch": {"status": [{"address": "p48a6b862d396", "driver": "SVOL", "value": "5", "uom": "51"}, {"address": "p48a6b81acf2e", "driver": "SVOL", "value": "1", "uom": "51"}]}, "userId": "5a1311c6fdbae12be43f38ab", "topic": "prod/ns/sonoscontroller-0021b900ee84-8", "profileNum": "8", "id": "00:21:b9:00:ee:84"}
2020-10-22 03:01:14,214 [Controller] [INFO ] Updating Driver pb8e9375d0874 - SVOL: 2 uom: 51
2020-10-22 03:01:15,049 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': '6HwGgmnSJB', 'development': False, 'userId': '5a1311c6fdbae12be43f38ab', 'isyVersion': '5.3.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1YTEzMTFjNmZkYmFlMTJiZTQzZjM4YWIiLCJpZCI6IjAwOjIxOmI5OjAwOmVlOjg0IiwicHJvZmlsZU51bSI6OCwicGFzc3dvcmQiOiI2SHdHZ21uU0pCIn0', 'timeAdded': 1602802570379, 'id': '00:21:b9:00:ee:84', 'shortPoll': '60', 'timeStarted': 1603232204011, 'version': '0.2.20', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1602802587944, 'timeStarted': 0}, 'g48a6b862d396': {'address': 'g48a6b862d396', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'uom': '2', 'value': '0'}, 'GV1': {'uom': '2', 'value': '0'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '13'}}, 'elapsed': '245.690056ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room ', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'groups': {'address': 'groups', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '138.78059ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Groups', 'nodedefid': 'PARENT', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'p48a6b81acf2e': {'address': 'p48a6b81acf2e', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '1'}}, 'elapsed': '756.612304ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Master Bedroom', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'p48a6b822aeb2': {'address': 'p48a6b822aeb2', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '55'}}, 'elapsed': '708.580152ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Garage', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201398686, 'timeStarted': 0}, 'p48a6b862d396': {'address': 'p48a6b862d396', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '5'}}, 'elapsed': '646.240252ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'pb8e937587f00': {'address': 'pb8e937587f00', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '475.735759ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d0874': {'address': 'pb8e9375d0874', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '230.486919ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Powder Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d11ea': {'address': 'pb8e9375d11ea', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '15'}}, 'elapsed': '369.190838ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Patio', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'players': {'address': 'players', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '357.595867ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Players', 'nodedefid': 'PARENT', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': 'Z2V8XY7lDlQDvIlqoQA1fFiVQXIj', 'refresh_token': 'YUTsRba5XH0To1bo71J8xl40qyboHdw2', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-10': 'empty', 'SAY_TTS-1': 'This is  a test message', 'language': 'en-us', 'SAY_TTS-4': 'empty', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'empty', 'SAY_TTS-3': 'empty', 'codec': 'mp3', 'api_key': '13a2708b10c34a03b2f68000ce401cc8'}, 'profileNum': '8', 'notices': {}, 'worker': 'sonoscontroller-0021b900ee84-8', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-22 03:01:18,427 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-22 03:01:18,587 [Drivers   ] [DEBUG] Sent Message: [prod/ns] : {"batch": {"status": [{"address": "pb8e9375d0874", "driver": "SVOL", "value": "2", "uom": "51"}]}, "userId": "5a1311c6fdbae12be43f38ab", "topic": "prod/ns/sonoscontroller-0021b900ee84-8", "profileNum": "8", "id": "00:21:b9:00:ee:84"}
2020-10-22 03:01:19,498 [Controller] [INFO ] Updating Driver pb8e9375d11ea - SVOL: 10 uom: 51
2020-10-22 03:01:21,498 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': '6HwGgmnSJB', 'development': False, 'userId': '5a1311c6fdbae12be43f38ab', 'isyVersion': '5.3.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1YTEzMTFjNmZkYmFlMTJiZTQzZjM4YWIiLCJpZCI6IjAwOjIxOmI5OjAwOmVlOjg0IiwicHJvZmlsZU51bSI6OCwicGFzc3dvcmQiOiI2SHdHZ21uU0pCIn0', 'timeAdded': 1602802570379, 'id': '00:21:b9:00:ee:84', 'shortPoll': '60', 'timeStarted': 1603232204011, 'version': '0.2.20', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1602802587944, 'timeStarted': 0}, 'g48a6b862d396': {'address': 'g48a6b862d396', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'uom': '2', 'value': '0'}, 'GV1': {'uom': '2', 'value': '0'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '13'}}, 'elapsed': '245.690056ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room ', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'groups': {'address': 'groups', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '138.78059ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Groups', 'nodedefid': 'PARENT', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'p48a6b81acf2e': {'address': 'p48a6b81acf2e', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '1'}}, 'elapsed': '756.612304ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Master Bedroom', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'p48a6b822aeb2': {'address': 'p48a6b822aeb2', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '55'}}, 'elapsed': '708.580152ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Garage', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201398686, 'timeStarted': 0}, 'p48a6b862d396': {'address': 'p48a6b862d396', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '5'}}, 'elapsed': '646.240252ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'pb8e937587f00': {'address': 'pb8e937587f00', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '475.735759ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d0874': {'address': 'pb8e9375d0874', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '2'}}, 'elapsed': '230.486919ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Powder Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d11ea': {'address': 'pb8e9375d11ea', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '15'}}, 'elapsed': '369.190838ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Patio', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'players': {'address': 'players', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '357.595867ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Players', 'nodedefid': 'PARENT', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': 'Z2V8XY7lDlQDvIlqoQA1fFiVQXIj', 'refresh_token': 'YUTsRba5XH0To1bo71J8xl40qyboHdw2', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-10': 'empty', 'SAY_TTS-1': 'This is  a test message', 'language': 'en-us', 'SAY_TTS-4': 'empty', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'empty', 'SAY_TTS-3': 'empty', 'codec': 'mp3', 'api_key': '13a2708b10c34a03b2f68000ce401cc8'}, 'profileNum': '8', 'notices': {}, 'worker': 'sonoscontroller-0021b900ee84-8', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-22 03:01:21,498 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-22 03:01:23,601 [Drivers   ] [DEBUG] Sent Message: [prod/ns] : {"batch": {"status": [{"address": "pb8e9375d11ea", "driver": "SVOL", "value": "10", "uom": "51"}]}, "userId": "5a1311c6fdbae12be43f38ab", "topic": "prod/ns/sonoscontroller-0021b900ee84-8", "profileNum": "8", "id": "00:21:b9:00:ee:84"}
2020-10-22 03:01:25,478 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': '6HwGgmnSJB', 'development': False, 'userId': '5a1311c6fdbae12be43f38ab', 'isyVersion': '5.3.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1YTEzMTFjNmZkYmFlMTJiZTQzZjM4YWIiLCJpZCI6IjAwOjIxOmI5OjAwOmVlOjg0IiwicHJvZmlsZU51bSI6OCwicGFzc3dvcmQiOiI2SHdHZ21uU0pCIn0', 'timeAdded': 1602802570379, 'id': '00:21:b9:00:ee:84', 'shortPoll': '60', 'timeStarted': 1603232204011, 'version': '0.2.20', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1602802587944, 'timeStarted': 0}, 'g48a6b862d396': {'address': 'g48a6b862d396', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'uom': '2', 'value': '0'}, 'GV1': {'uom': '2', 'value': '0'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '13'}}, 'elapsed': '245.690056ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room ', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'groups': {'address': 'groups', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '138.78059ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Groups', 'nodedefid': 'PARENT', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'p48a6b81acf2e': {'address': 'p48a6b81acf2e', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '1'}}, 'elapsed': '756.612304ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Master Bedroom', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'p48a6b822aeb2': {'address': 'p48a6b822aeb2', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '55'}}, 'elapsed': '708.580152ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Garage', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201398686, 'timeStarted': 0}, 'p48a6b862d396': {'address': 'p48a6b862d396', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '5'}}, 'elapsed': '646.240252ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'pb8e937587f00': {'address': 'pb8e937587f00', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '475.735759ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d0874': {'address': 'pb8e9375d0874', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '2'}}, 'elapsed': '230.486919ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Powder Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d11ea': {'address': 'pb8e9375d11ea', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '10'}}, 'elapsed': '369.190838ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Patio', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'players': {'address': 'players', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '357.595867ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Players', 'nodedefid': 'PARENT', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': 'Z2V8XY7lDlQDvIlqoQA1fFiVQXIj', 'refresh_token': 'YUTsRba5XH0To1bo71J8xl40qyboHdw2', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-10': 'empty', 'SAY_TTS-1': 'This is  a test message', 'language': 'en-us', 'SAY_TTS-4': 'empty', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'empty', 'SAY_TTS-3': 'empty', 'codec': 'mp3', 'api_key': '13a2708b10c34a03b2f68000ce401cc8'}, 'profileNum': '8', 'notices': {}, 'worker': 'sonoscontroller-0021b900ee84-8', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-22 03:01:25,478 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-22 03:42:51,820 [Controller] [INFO ] Sending customData to Polyglot.
2020-10-22 03:42:51,823 [Controller] [DEBUG] Sent Message: [prod/ns] : {"customdata": {"access_token": "l8rkoQxQN8qARnYvUDXXjxv41vs9", "refresh_token": "YUTsRba5XH0To1bo71J8xl40qyboHdw2", "expires_in": 86399}, "userId": "5a1311c6fdbae12be43f38ab", "topic": "prod/ns/sonoscontroller-0021b900ee84-8", "profileNum": "8", "id": "00:21:b9:00:ee:84"}
2020-10-22 03:42:51,826 [Controller] [INFO ] Sending notices to Polyglot.
2020-10-22 03:42:51,826 [Controller] [DEBUG] Sent Message: [prod/ns] : {"notices": {}, "userId": "5a1311c6fdbae12be43f38ab", "topic": "prod/ns/sonoscontroller-0021b900ee84-8", "profileNum": "8", "id": "00:21:b9:00:ee:84"}
2020-10-22 03:42:52,130 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': '6HwGgmnSJB', 'development': False, 'userId': '5a1311c6fdbae12be43f38ab', 'isyVersion': '5.3.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1YTEzMTFjNmZkYmFlMTJiZTQzZjM4YWIiLCJpZCI6IjAwOjIxOmI5OjAwOmVlOjg0IiwicHJvZmlsZU51bSI6OCwicGFzc3dvcmQiOiI2SHdHZ21uU0pCIn0', 'timeAdded': 1602802570379, 'id': '00:21:b9:00:ee:84', 'shortPoll': '60', 'timeStarted': 1603232204011, 'version': '0.2.20', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1602802587944, 'timeStarted': 0}, 'g48a6b862d396': {'address': 'g48a6b862d396', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'uom': '2', 'value': '0'}, 'GV1': {'uom': '2', 'value': '0'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '13'}}, 'elapsed': '245.690056ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room ', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'groups': {'address': 'groups', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '138.78059ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Groups', 'nodedefid': 'PARENT', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'p48a6b81acf2e': {'address': 'p48a6b81acf2e', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '1'}}, 'elapsed': '756.612304ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Master Bedroom', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'p48a6b822aeb2': {'address': 'p48a6b822aeb2', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '55'}}, 'elapsed': '708.580152ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Garage', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201398686, 'timeStarted': 0}, 'p48a6b862d396': {'address': 'p48a6b862d396', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '5'}}, 'elapsed': '646.240252ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'pb8e937587f00': {'address': 'pb8e937587f00', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '475.735759ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d0874': {'address': 'pb8e9375d0874', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '2'}}, 'elapsed': '230.486919ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Powder Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d11ea': {'address': 'pb8e9375d11ea', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '10'}}, 'elapsed': '369.190838ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Patio', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'players': {'address': 'players', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '357.595867ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Players', 'nodedefid': 'PARENT', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': 'Z2V8XY7lDlQDvIlqoQA1fFiVQXIj', 'refresh_token': 'YUTsRba5XH0To1bo71J8xl40qyboHdw2', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-10': 'empty', 'SAY_TTS-1': 'This is  a test message', 'language': 'en-us', 'SAY_TTS-4': 'empty', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'empty', 'SAY_TTS-3': 'empty', 'codec': 'mp3', 'api_key': '13a2708b10c34a03b2f68000ce401cc8'}, 'profileNum': '8', 'notices': {}, 'worker': 'sonoscontroller-0021b900ee84-8', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-22 03:42:52,131 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-22 03:42:53,306 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'config': {'firstRun': False, 'longPoll': '7200', 'logBucket': 'pgc-prod-logbucket-38dmw97ou252', 'oauth': {'test': {'clientId': '36f2a232-1260-4faf-a0eb-1795921fb806', 'redirectUrl': 'https://pgtest.isy.io/api/oauth/callback', 'secret': 'ddbef0df-13e1-4ac0-825b-44526e970a54'}, 'prod': {'clientId': 'f3dd2b06-e498-462e-bd6a-abdb0fb8b7ef', 'redirectUrl': 'https://polyglot.isy.io/api/oauth/callback', 'secret': 'eb29be52-1cee-4534-9417-250c9190a509'}}, 'url': 'https://github.com/simplextech/udi-poly-sonoscontroller.git', 'name': 'SonosController', 'language': 'python3', 'isyPassword': '6HwGgmnSJB', 'development': False, 'userId': '5a1311c6fdbae12be43f38ab', 'isyVersion': '5.3.0', 'pgUrl': 'https://lgpz727w3j.execute-api.us-east-1.amazonaws.com/prod/api/sys/nsgetioturl?params=eyJ1c2VySWQiOiI1YTEzMTFjNmZkYmFlMTJiZTQzZjM4YWIiLCJpZCI6IjAwOjIxOmI5OjAwOmVlOjg0IiwicHJvZmlsZU51bSI6OCwicGFzc3dvcmQiOiI2SHdHZ21uU0pCIn0', 'timeAdded': 1602802570379, 'id': '00:21:b9:00:ee:84', 'shortPoll': '60', 'timeStarted': 1603232204011, 'version': '0.2.20', 'nodes': {'controller': {'address': 'controller', 'drivers': {'ST': {'uom': 2, 'value': '1'}}, 'isController': True, 'isPrimary': True, 'name': 'Sonos Controller', 'nodedefid': 'controller', 'primary': 'controller', 'timeAdded': 1602802587944, 'timeStarted': 0}, 'g48a6b862d396': {'address': 'g48a6b862d396', 'drivers': {'FAV': {'value': '0', 'uom': '25'}, 'GV0': {'uom': '2', 'value': '0'}, 'GV1': {'uom': '2', 'value': '0'}, 'PLAYLST': {'value': '0', 'uom': '25'}, 'ST': {'uom': '25', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '13'}}, 'elapsed': '245.690056ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room ', 'nodedefid': 'GROUP', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'groups': {'address': 'groups', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '138.78059ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Groups', 'nodedefid': 'PARENT', 'primary': 'groups', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}, 'p48a6b81acf2e': {'address': 'p48a6b81acf2e', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '1'}}, 'elapsed': '756.612304ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Master Bedroom', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'p48a6b822aeb2': {'address': 'p48a6b822aeb2', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '55'}}, 'elapsed': '708.580152ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Garage', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201398686, 'timeStarted': 0}, 'p48a6b862d396': {'address': 'p48a6b862d396', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '5'}}, 'elapsed': '646.240252ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Living Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201387618, 'timeStarted': 0}, 'pb8e937587f00': {'address': 'pb8e937587f00', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '7'}}, 'elapsed': '475.735759ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Office', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d0874': {'address': 'pb8e9375d0874', 'drivers': {'GV0': {'uom': '2', 'value': '0'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'uom': '2', 'value': '1'}, 'SVOL': {'uom': '51', 'value': '2'}}, 'elapsed': '230.486919ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Powder Room', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'pb8e9375d11ea': {'address': 'pb8e9375d11ea', 'drivers': {'GV0': {'value': '0', 'uom': '2'}, 'SAYTTS': {'value': '0', 'uom': '25'}, 'ST': {'value': '1', 'uom': '2'}, 'SVOL': {'uom': '51', 'value': '10'}}, 'elapsed': '369.190838ms', 'error': False, 'isController': False, 'isPrimary': False, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Patio', 'nodedefid': 'PLAYER', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201392121, 'timeStarted': 0}, 'players': {'address': 'players', 'drivers': {'ST': {'uom': '2', 'value': '1'}}, 'elapsed': '357.595867ms', 'error': False, 'isController': False, 'isPrimary': True, 'json': {'RestResponse': {'reason': {'code': '5004'}, 'succeeded': 'false', 'status': '400'}}, 'name': 'Sonos Players', 'nodedefid': 'PARENT', 'primary': 'players', 'seq': False, 'statusCode': 400, 'success': False, 'timeAdded': 1603201382204, 'timeStarted': 0}}, 'netInfo': {'publicPort': 0, 'httpsIngress': False, 'publicIp': '3.89.244.35'}, 'customData': {'access_token': 'l8rkoQxQN8qARnYvUDXXjxv41vs9', 'refresh_token': 'YUTsRba5XH0To1bo71J8xl40qyboHdw2', 'expires_in': 86399}, 'connected': True, 'customParams': {'SAY_TTS-8': 'empty', 'SAY_TTS-9': 'empty', 'SAY_TTS-6': 'empty', 'SAY_TTS-7': 'empty', 'format': '24khz_16bit_stereo', 'SAY_TTS-10': 'empty', 'SAY_TTS-1': 'This is  a test message', 'language': 'en-us', 'SAY_TTS-4': 'empty', 'SAY_TTS-5': 'empty', 'SAY_TTS-2': 'empty', 'SAY_TTS-3': 'empty', 'codec': 'mp3', 'api_key': '13a2708b10c34a03b2f68000ce401cc8'}, 'profileNum': '8', 'notices': {}, 'worker': 'sonoscontroller-0021b900ee84-8', 'lastDisconnect': 0, 'isyUsername': 'pgc', 'type': 'cloud'}}
2020-10-22 03:42:53,307 [MQTT      ] [DEBUG] Recieved Message: config
2020-10-22 03:57:43,368 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'command': {'address': 'g48a6b862d396', 'cmd': 'PLAYLST', 'value': '8', 'uom': '25', 'query': {}}}
2020-10-22 03:57:43,368 [MQTT      ] [DEBUG] Received Message: {'command': {'address': 'g48a6b862d396', 'cmd': 'PLAYLST', 'value': '8', 'uom': '25', 'query': {}}}
2020-10-22 03:57:54,616 [MQTT      ] [DEBUG] MQTT Received Message: prod/ns/sonoscontroller-0021b900ee84-8: {'command': {'address': 'g48a6b862d396', 'cmd': 'PLAY', 'query': {}}}
2020-10-22 03:57:54,616 [MQTT      ] [DEBUG] Received Message: {'command': {'address': 'g48a6b862d396', 'cmd': 'PLAY', 'query': {}}}

Bumbershoot · October 22, 2020

FWIW, taking attempting to look at the log this morning produces this error, though the nodeserver was working. I gave it a restart, but the error persists. The nodeserver is otherwise operating.

simplextech · October 22, 2020

@glarsen, @Bumbershoot The log stream error I got nothing for you. That's polyglot and it retrieving the logs from the server instances running in the cluster.

The other log looks like it was trying to do things but failing. Likely due to name resolution or network issues but they were caught and handled and the NS didn't crash.

simplextech · October 22, 2020

Just because I stopped my instance and trying to start it again and it won't start. No logs, nothing. I'm wondering if there's something going on with PGC?

bcdavis75 · October 22, 2020

2 minutes ago, simplextech said:

Just because I stopped my instance and trying to start it again and it won't start. No logs, nothing. I'm wondering if there's something going on with PGC?

This happened to me a while back. I opened a ticket and Michel was able to fix whatever got clogged on the back end.

simplextech · October 22, 2020

1 minute ago, bcdavis75 said:

This happened to me a while back. I opened a ticket and Michel was able to fix whatever got clogged on the back end.

I just removed the NS and am trying to install it again. Not working. It claims it's installed but it never starts. From the error that @Bumbershootposted it's from kubernetes which is outside of what I can do anything with.

glarsen · October 22, 2020

I've experienced this same a while back. It required intervention by UDI to correct. My SonosController appears to be working now, I just can't retrieve the log. The other PGC nodeserver I run is working fine including the log display.

Michel Kohanim · October 22, 2020

All, looking into it.

With kind regards,
Michel

Sign In

SonosController NodeServer

Recommended Posts

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Link to comment

Share on other sites

Archived

Recently Browsing

Who's Online (See full list)

Forum Statistics