search

rhasspy / wyoming-satellite

Remote voice satellite using Wyoming protocol
MIT License
716 stars 105 forks source link

Satellite Disconnects Every 5 minutes #206

Closed jeremy-parks01 closed 2 months ago

jeremy-parks01 commented 3 months ago

I have an issue related to the satellite that I just can't put my finger on. The short of it is, the satellite loses connection every 5 minutes like clockwork. I followed the tutorial at https://github.com/rhasspy/wyoming-satellite/blob/master/docs/tutorial_2mic.md and all other functions are working other than the connection drop/reconnect every 5 minutes and the associated flashing LED's

Hardware: HA Server: RPi 4 B (Docker) v. 2024.7.0 Wired Ethernet Satellite: RPi Zero 2W with ReSpeaker 2Mic HAT Wireless Ethernet

What I have tried:

Logs from HA

2024-08-12 05:55:11.525 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s) 2024-08-12 06:05:11.563 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s) 2024-08-12 06:10:11.566 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s) 2024-08-12 06:15:11.497 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s) 2024-08-12 06:20:11.530 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s) 2024-08-12 06:25:11.589 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s) 2024-08-12 06:30:11.547 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s) 2024-08-12 06:35:11.408 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s)

DEBUG LOGGING WAS ENABLED

2024-08-12 06:40:11.560 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] TimeoutError: 2024-08-12 06:40:11.560 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s) 2024-08-12 06:40:12.735 INFO (MainThread) [homeassistant.components.wyoming.wake_word] Detection(name='yo_gigi', timestamp=4350, speaker=None) 2024-08-12 06:40:14.562 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] Disconnecting from satellite 2024-08-12 06:40:14.563 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] Connecting to satellite at 192.168.5.213:10700 2024-08-12 06:40:14.568 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] Connected to satellite 2024-08-12 06:40:14.614 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] Updated client info: Info(asr=[], tts=[], handle=[], intent=[], wake=[WakeProgram(name='openwakeword', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='An open-source audio wake word (or phrase) detection framework with a focus on performance and simplicity.', version='1.10.0', models=[WakeModel(name='hey_jarvis_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='hey jarvis', version='v0.1', languages=[], phrase='hey jarvis'), WakeModel(name='ok_nabu_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='ok nabu', version='v0.1', languages=[], phrase='ok nabu'), WakeModel(name='alexa_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='alexa', version='v0.1', languages=[], phrase='alexa'), WakeModel(name='hey_rhasspy_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='hey rhasspy', version='v0.1', languages=[], phrase='hey rhasspy'), WakeModel(name='hey_mycroft_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='hey mycroft', version='v0.1', languages=[], phrase='hey mycroft'), WakeModel(name='yo_gigi', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='yo gigi', version=None, languages=[], phrase='yo gigi'), WakeModel(name='hey_ariel', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='hey ariel', version=None, languages=[], phrase='hey ariel')])], satellite=Satellite(name='Primary Bedroom Satellite', attribution=Attribution(name='', url=''), installed=True, description='Primary Bedroom Satellite', version='1.3.0', area=None, snd_format=None)) 2024-08-12 06:40:18.864 INFO (MainThread) [homeassistant.helpers.intent] Triggering intent handler <OnOffIntentHandler - HassTurnOn> 2024-08-12 06:40:18.870 INFO (MainThread) [homeassistant.helpers.intent] Triggering intent handler <OnOffIntentHandler - HassTurnOn> 2024-08-12 06:40:55.595 INFO (MainThread) [homeassistant.components.automation.assist_start_my_day] Assist - Start My Day: Running automation actions 2024-08-12 06:40:55.595 INFO (MainThread) [homeassistant.components.automation.assist_start_my_day] Assist - Start My Day: Executing step call service 2024-08-12 06:40:56.843 INFO (MainThread) [homeassistant.components.automation.assist_start_my_day] Assist - Start My Day: Executing step call service 2024-08-12 06:40:56.984 INFO (MainThread) [homeassistant.components.automation.assist_start_my_day] Assist - Start My Day: Executing step delay 0:05:00 2024-08-12 06:44:02.733 DEBUG (MainThread) [homeassistant.components.wyoming.config_flow] Zeroconf discovery info: ZeroconfServiceInfo(ip_address=ZeroconfIPv4Address('192.168.5.213'), ip_addresses=[ZeroconfIPv4Address('192.168.5.213')], port=10700, hostname='d83addf1672e._wyoming._tcp.local.', type='_wyoming._tcp.local.', name='d83addf1672e._wyoming._tcp.local.', properties={})

2024-08-12 06:45:11.541 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] TimeoutError: 2024-08-12 06:45:11.541 WARNING (MainThread) [homeassistant.components.wyoming.satellite] Satellite has been disconnected. Reconnecting in 10 second(s) 2024-08-12 06:45:14.542 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] Disconnecting from satellite 2024-08-12 06:45:14.544 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] Connecting to satellite at 192.168.5.213:10700 2024-08-12 06:45:14.550 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] Connected to satellite 2024-08-12 06:45:14.570 DEBUG (MainThread) [homeassistant.components.wyoming.satellite] Updated client info: Info(asr=[], tts=[], handle=[], intent=[], wake=[WakeProgram(name='openwakeword', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='An open-source audio wake word (or phrase) detection framework with a focus on performance and simplicity.', version='1.10.0', models=[WakeModel(name='hey_jarvis_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='hey jarvis', version='v0.1', languages=[], phrase='hey jarvis'), WakeModel(name='ok_nabu_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='ok nabu', version='v0.1', languages=[], phrase='ok nabu'), WakeModel(name='alexa_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='alexa', version='v0.1', languages=[], phrase='alexa'), WakeModel(name='hey_rhasspy_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='hey rhasspy', version='v0.1', languages=[], phrase='hey rhasspy'), WakeModel(name='hey_mycroft_v0.1', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='hey mycroft', version='v0.1', languages=[], phrase='hey mycroft'), WakeModel(name='yo_gigi', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='yo gigi', version=None, languages=[], phrase='yo gigi'), WakeModel(name='hey_ariel', attribution=Attribution(name='dscripka', url='https://github.com/dscripka/openWakeWord'), installed=True, description='hey ariel', version=None, languages=[], phrase='hey ariel')])], satellite=Satellite(name='Primary Bedroom Satellite', attribution=Attribution(name='', url=''), installed=True, description='Primary Bedroom Satellite', version='1.3.0', area=None, snd_format=None))

Logs from Wyoming Satellite

Aug 12 05:55:11 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 05:55:11 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 05:55:11 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 05:55:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 44411764274886 Aug 12 05:55:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 05:55:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 05:55:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 05:55:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 05:55:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 44711925198585 Aug 12 05:55:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 05:55:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 05:55:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:00:10 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:00:10 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:00:10 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:00:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 44711925198585 Aug 12 06:00:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:00:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:00:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:00:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:00:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 45011986600778 Aug 12 06:00:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:00:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 06:00:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:05:10 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:05:10 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:05:10 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:05:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 45011986600778 Aug 12 06:05:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:05:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:05:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:05:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:05:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 45311973460948 Aug 12 06:05:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:05:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 06:05:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:10:10 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:10:10 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:10:10 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:10:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 45311973460948 Aug 12 06:10:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:10:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:10:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:10:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:10:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 45611974016061 Aug 12 06:10:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:10:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 06:10:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:15:11 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:15:11 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:15:11 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:15:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 45611974016061 Aug 12 06:15:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:15:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:15:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:15:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:15:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 45911891009596 Aug 12 06:15:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:15:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 06:15:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:20:10 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:20:10 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:20:10 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:20:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 45911891009596 Aug 12 06:20:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:20:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:20:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:20:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:20:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 46211925918447 Aug 12 06:20:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:20:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 06:20:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:25:10 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:25:10 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:25:10 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:25:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 46211925918447 Aug 12 06:25:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:25:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:25:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:25:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:25:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 46511987734052 Aug 12 06:25:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:25:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 06:25:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:30:11 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:30:11 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:30:11 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:30:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 46511987734052 Aug 12 06:30:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:30:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:30:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:30:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:30:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 46811962251946 Aug 12 06:30:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:30:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 06:30:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:35:11 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:35:11 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:35:11 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:35:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 46811962251946 Aug 12 06:35:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:35:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:35:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:35:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:35:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 47111801599994 Aug 12 06:35:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:35:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 06:35:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:40:10 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:40:10 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:40:10 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:40:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 47111801599994 Aug 12 06:40:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:40:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:40:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:40:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:40:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 47411953328051 Aug 12 06:40:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:40:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word Aug 12 06:40:16 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:45:10 wyo-satellite-01 run[1819]: WARNING:root:Did not receive ping response within timeout Aug 12 06:45:10 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:45:10 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:45:11 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 47411953328051 Aug 12 06:45:11 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:45:11 wyo-satellite-01 run[1819]: DEBUG:root:Ping enabled Aug 12 06:45:14 wyo-satellite-01 run[1819]: DEBUG:root:Server disconnected Aug 12 06:45:14 wyo-satellite-01 run[1819]: INFO:root:Disconnected from server Aug 12 06:45:14 wyo-satellite-01 run[1819]: DEBUG:root:Server set: 47711935756292 Aug 12 06:45:14 wyo-satellite-01 run[1819]: INFO:root:Connected to server Aug 12 06:45:14 wyo-satellite-01 run[1819]: INFO:root:Waiting for wake word

jeremy-parks01 commented 2 months ago

After a network upgrade (Eero), this issue has subsided. Marking as resolved.

Camouflagge commented 1 month ago

I had the same problem, how was it fixed exactly, all 3 satellites restart every 30 seconds and connect and the flashing of the LED gets annoying at some point

jeremy-parks01 commented 1 month ago

I applied an update to my WiFi router which seemed to eliminate this particular issue but I ended up abandoning the Wyoming Satellite altogether as it's just not ready for real world use. I finally caved and bought the Nabu Casa subscription to leverage my existing Amazon Echo devices to avoid my wife tossing me out of the house. I do plan to revisit this project at some point in the future as I hate being hitched to Amazon.