Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

"socket.send() raised exception." appear randomly in logs #26446

Closed
SelcouthGuy opened this issue Sep 5, 2019 · 23 comments
Closed

"socket.send() raised exception." appear randomly in logs #26446

SelcouthGuy opened this issue Sep 5, 2019 · 23 comments
Labels

Comments

@SelcouthGuy
Copy link

SelcouthGuy commented Sep 5, 2019

Home Assistant release with the issue:

0.98.3

Last working Home Assistant release (if known):
unknown

Operating environment (Hass.io/Docker/Windows/etc.):

Hassbian on RPI3B+

Component/platform:

https://www.home-assistant.io/components/websocket_api/

Description of problem:
I see a lot of warnings in logs that socket.send() raised exception (44 times in last 12h). Baloob said that warnings need to be fixed but I don't see any report for this warning so I'm creating this one. People which have same spam by this exception please add emoji to this post.

socket.send() raised exception.
9:33 AM components/websocket_api/http.py (WARNING) - message first occured at September 4, 2019, 9:35 PM and shows up 44 times

Problem-relevant configuration.yaml entries and (fill out even if it seems unimportant):

Traceback (if applicable):

Additional information:
I've set logger to debug for websocket_api with the hope that it will help to obtain more information but I'm not sure if it will be usefull (part of log attached below).

logger:
  default: info
  logs:
    yeelight: info
    homeassistant.components.websocket_api: debug
2019-09-05 09:30:57 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=group.all_switches, old_state=<state group.all_switches=on; entity_id=('switch.zigbee2mqtt_main_join', 'switch.swiatla_led_w_kuchni'), order=4, auto=True, friendly_name=all switches, hidden=True @ 2019-09-05T09:28:15.187475+02:00>, new_state=<state group.all_switches=off; entity_id=('switch.zigbee2mqtt_main_join', 'switch.swiatla_led_w_kuchni'), order=4, auto=True, friendly_name=all switches, hidden=True @ 2019-09-05T09:30:57.170410+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=09:30; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:30:01.011269+02:00>, new_state=<state sensor.time=09:31; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:31:01.011579+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2019-09-05, 09:30; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.013840+02:00>, new_state=<state sensor.date_time=2019-09-05, 09:31; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.014155+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time_iso, old_state=<state sensor.date_time_iso=2019-09-05T09:30:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.016176+02:00>, new_state=<state sensor.date_time_iso=2019-09-05T09:31:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.016495+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_date, old_state=<state sensor.time_date=09:30, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.018540+02:00>, new_state=<state sensor.time_date=09:31, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.018872+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_utc, old_state=<state sensor.time_utc=07:30; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:30:01.020836+02:00>, new_state=<state sensor.time_utc=07:31; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:31:01.021162+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=09:30; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:30:01.011269+02:00>, new_state=<state sensor.time=09:31; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:31:01.011579+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2019-09-05, 09:30; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.013840+02:00>, new_state=<state sensor.date_time=2019-09-05, 09:31; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.014155+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time_iso, old_state=<state sensor.date_time_iso=2019-09-05T09:30:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.016176+02:00>, new_state=<state sensor.date_time_iso=2019-09-05T09:31:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.016495+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_date, old_state=<state sensor.time_date=09:30, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.018540+02:00>, new_state=<state sensor.time_date=09:31, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.018872+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_utc, old_state=<state sensor.time_utc=07:30; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:30:01.020836+02:00>, new_state=<state sensor.time_utc=07:31; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:31:01.021162+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=09:30; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:30:01.011269+02:00>, new_state=<state sensor.time=09:31; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:31:01.011579+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2019-09-05, 09:30; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.013840+02:00>, new_state=<state sensor.date_time=2019-09-05, 09:31; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.014155+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time_iso, old_state=<state sensor.date_time_iso=2019-09-05T09:30:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.016176+02:00>, new_state=<state sensor.date_time_iso=2019-09-05T09:31:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.016495+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_date, old_state=<state sensor.time_date=09:30, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.018540+02:00>, new_state=<state sensor.time_date=09:31, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.018872+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_utc, old_state=<state sensor.time_utc=07:30; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:30:01.020836+02:00>, new_state=<state sensor.time_utc=07:31; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:31:01.021162+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=09:30; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:30:01.011269+02:00>, new_state=<state sensor.time=09:31; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:31:01.011579+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2019-09-05, 09:30; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.013840+02:00>, new_state=<state sensor.date_time=2019-09-05, 09:31; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.014155+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time_iso, old_state=<state sensor.date_time_iso=2019-09-05T09:30:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.016176+02:00>, new_state=<state sensor.date_time_iso=2019-09-05T09:31:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.016495+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_date, old_state=<state sensor.time_date=09:30, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:30:01.018540+02:00>, new_state=<state sensor.time_date=09:31, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.018872+02:00>>}
2019-09-05 09:31:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_utc, old_state=<state sensor.time_utc=07:30; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:30:01.020836+02:00>, new_state=<state sensor.time_utc=07:31; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:31:01.021162+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=09:31; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:31:01.011579+02:00>, new_state=<state sensor.time=09:32; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:32:01.010985+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2019-09-05, 09:31; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.014155+02:00>, new_state=<state sensor.date_time=2019-09-05, 09:32; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.013609+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time_iso, old_state=<state sensor.date_time_iso=2019-09-05T09:31:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.016495+02:00>, new_state=<state sensor.date_time_iso=2019-09-05T09:32:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.018013+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_date, old_state=<state sensor.time_date=09:31, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.018872+02:00>, new_state=<state sensor.time_date=09:32, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.021407+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_utc, old_state=<state sensor.time_utc=07:31; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:31:01.021162+02:00>, new_state=<state sensor.time_utc=07:32; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:32:01.023874+02:00>>}

2019-09-05 09:32:01 WARNING (MainThread) [asyncio] socket.send() raised exception.

2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=09:31; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:31:01.011579+02:00>, new_state=<state sensor.time=09:32; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:32:01.010985+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2019-09-05, 09:31; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.014155+02:00>, new_state=<state sensor.date_time=2019-09-05, 09:32; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.013609+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time_iso, old_state=<state sensor.date_time_iso=2019-09-05T09:31:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.016495+02:00>, new_state=<state sensor.date_time_iso=2019-09-05T09:32:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.018013+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_date, old_state=<state sensor.time_date=09:31, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.018872+02:00>, new_state=<state sensor.time_date=09:32, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.021407+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_utc, old_state=<state sensor.time_utc=07:31; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:31:01.021162+02:00>, new_state=<state sensor.time_utc=07:32; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:32:01.023874+02:00>>}

2019-09-05 09:32:01 WARNING (MainThread) [asyncio] socket.send() raised exception.

2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=09:31; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:31:01.011579+02:00>, new_state=<state sensor.time=09:32; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:32:01.010985+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2019-09-05, 09:31; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.014155+02:00>, new_state=<state sensor.date_time=2019-09-05, 09:32; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.013609+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time_iso, old_state=<state sensor.date_time_iso=2019-09-05T09:31:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.016495+02:00>, new_state=<state sensor.date_time_iso=2019-09-05T09:32:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.018013+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_date, old_state=<state sensor.time_date=09:31, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.018872+02:00>, new_state=<state sensor.time_date=09:32, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.021407+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_utc, old_state=<state sensor.time_utc=07:31; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:31:01.021162+02:00>, new_state=<state sensor.time_utc=07:32; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:32:01.023874+02:00>>}

2019-09-05 09:32:01 WARNING (MainThread) [asyncio] socket.send() raised exception.

2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=09:31; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:31:01.011579+02:00>, new_state=<state sensor.time=09:32; friendly_name=Time, icon=mdi:clock @ 2019-09-05T09:32:01.010985+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2019-09-05, 09:31; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.014155+02:00>, new_state=<state sensor.date_time=2019-09-05, 09:32; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.013609+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.date_time_iso, old_state=<state sensor.date_time_iso=2019-09-05T09:31:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.016495+02:00>, new_state=<state sensor.date_time_iso=2019-09-05T09:32:00; friendly_name=Date & Time ISO, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.018013+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_date, old_state=<state sensor.time_date=09:31, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:31:01.018872+02:00>, new_state=<state sensor.time_date=09:32, 2019-09-05; friendly_name=Time & Date, icon=mdi:calendar-clock @ 2019-09-05T09:32:01.021407+02:00>>}
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Sending {'id': 2, 'type': 'event', 'event': <Event state_changed[L]: entity_id=sensor.time_utc, old_state=<state sensor.time_utc=07:31; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:31:01.021162+02:00>, new_state=<state sensor.time_utc=07:32; friendly_name=Time (UTC), icon=mdi:clock @ 2019-09-05T09:32:01.023874+02:00>>}

2019-09-05 09:32:01 WARNING (MainThread) [asyncio] socket.send() raised exception.

2019-09-05 09:32:01 INFO (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Connection closed by client
2019-09-05 09:32:01 INFO (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Connection closed by client
2019-09-05 09:32:01 INFO (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Connection closed by client
2019-09-05 09:32:01 INFO (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Connection closed by client

2019-09-05 09:32:01 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602740336] Disconnected
2019-09-05 09:32:01 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1400554160] Disconnected
2019-09-05 09:32:01 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1393531280] Disconnected
2019-09-05 09:32:01 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-09-05 09:32:01 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602898928] Disconnected
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Connected
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Sending {'type': 'auth_required', 'ha_version': '0.98.3'}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'auth', 'access_token': 'vyG3eXAiOiJKV1QiLCJhbGc3OiJIec15iJ9.eyJpc3MiOiIyNjU3NzdiNjgfsY0ZDFiOTQyNmViYjIzZTM3MWUeZiIsImlhdCI6MeU2NzY2ODdaswiZXhwIjoxNTY3NjY5OTE4fQ.1tg5xleeOJP0yAybu8AUKuGttgUbrm3asPCCq8VaNUg'}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received access_token
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Auth OK
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Sending {'type': 'auth_ok', 'ha_version': '0.98.3'}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'subscribe_events', 'event_type': 'state_changed', 'id': 2}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'subscribe_events', 'event_type': 'component_loaded', 'id': 3}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'subscribe_events', 'event_type': 'core_config_updated', 'id': 4}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'subscribe_events', 'event_type': 'service_registered', 'id': 5}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'subscribe_events', 'event_type': 'service_removed', 'id': 6}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'subscribe_events', 'event_type': 'panels_updated', 'id': 7}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'subscribe_events', 'event_type': 'themes_updated', 'id': 8}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'subscribe_events', 'event_type': 'persistent_notifications_updated', 'id': 9}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'subscribe_events', 'event_type': 'lovelace_updated', 'id': 10}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'get_states', 'id': 11}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'get_config', 'id': 12}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'get_services', 'id': 13}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'get_panels', 'id': 14}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_themes', 'id': 15}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'auth/current_user', 'id': 16}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'lovelace/config', 'force': False, 'id': 17}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_translations', 'language': 'en', 'id': 18}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'persistent_notification/get', 'id': 19}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 20}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 21}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 22}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 23}
2019-09-05 09:32:02 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 24}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 25}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 26}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 27}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 28}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 29}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 30}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 31}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Received {'type': 'frontend/get_user_data', 'key': 'core', 'id': 32}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Sending {'id': 2, 'type': 'result', 'success': True, 'result': None}
2019-09-05 09:32:03 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection.1602237712] Sending {'id': 3, 'type': 'result', 'success': True, 'result': None}
(...)
@stale
Copy link

stale bot commented Dec 5, 2019

There hasn't been any activity on this issue recently. Due to the high number of incoming GitHub notifications, we have to clean some of the old issues, as many of them have already been resolved with the latest updates.
Please make sure to update to the latest Home Assistant version and check if that solves the issue. Let us know if that works for you by adding a comment 👍
This issue now has been marked as stale and will be closed if no further activity occurs. Thank you for your contributions.

@stale stale bot added the stale label Dec 5, 2019
@SelcouthGuy
Copy link
Author

@stainlessray @Herjar @aletiffi @glassbase @darkkatarsis @martikainen87 Would you be so kind as to check if this issue still persists and update topic before close?
I don't have this issue anymore but I don't have the same installation as when topic was created. If you still have this issue with the latest Home Assistant version then please make an update. Thank you!

@stale stale bot removed the stale label Dec 5, 2019
@stainlessray
Copy link

@stainlessray @Herjar @aletiffi @glassbase @darkkatarsis @martikainen87 Would you be so kind as to check if this issue still persists and update topic before close?
I don't have this issue anymore but I don't have the same installation as when topic was created. If you still have this issue with the latest Home Assistant version then please make an update. Thank you!

I had to throw away that instance and move on. The issue consumed it. I moved to a Docker install after that. I continued to try and troubleshoot this for a week or so. Then moved on.

@martikainen87
Copy link

I'm running in Docker and I had this issue in that environment, last couple of days I haven't seen it. updated from 102.2 to 102.3 and some HACS integrations was updated as well.

So it seems to be solved for me at least!

@SelcouthGuy
Copy link
Author

Hmmm this is very strange. I'm currently on 0.102.1 and I haven't seen this exception long time. Two days ago I turned on DEBUG logs to track one problem with my config and I see that socket.send() exception also appeared.

Logs:

2019-12-06 23:12:35 DEBUG (SyncWorker_12) [yeelight.main] Bulb<192.168.1.14:55443, type=BulbType.WhiteTemp> > {'id': 10804, 'method': 'get_prop', 'params': ['power', 'main_power', 'bright', 'ct', 'rgb', 'hue', 'sat', 'color_mode', 'bg_power', 'bg_lmode', 'bg_flowing', 'bg_ct', 'bg_bright', 'bg_hue', 'bg_sat', 'bg_rgb', 'nl_br', 'active_mode']}
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_motion_sensor_illuminance_2 with value 3
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_temperature with value -1.02
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_humidity with value 76.19
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_battery with value 74
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_temperature with value -1.17
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_temperature with value -1.17
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_humidity with value 76.19
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_battery with value 74
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_humidity with value 75.71
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_temperature with value -1.17
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_humidity with value 75.71
2019-12-06 23:12:39 DEBUG (SyncWorker_12) [yeelight.main] Bulb<192.168.1.14:55443, type=BulbType.WhiteTemp> < {'id': 10804, 'result': ['on', '', '100', '2700', '', '', '', '2', '', '', '', '', '', '', '', '', '', '']}
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] Received callback from sensor.xiaomi_temp_sensor_battery with value 74
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.plant] New data processed
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=23:11; friendly_name=Time, icon=mdi:clock @ 2019-12-06T23:11:01.011189+01:00>, new_state=<state sensor.time=23:12; friendly_name=Time, icon=mdi:clock @ 2019-12-06T23:12:39.221454+01:00>>
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2019-12-06, 23:11; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-12-06T23:11:01.019533+01:00>, new_state=<state sensor.date_time=2019-12-06, 23:12; friendly_name=Date & Time, icon=mdi:calendar-clock @ 2019-12-06T23:12:39.224959+01:00>>
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.ssdp] Scanning
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event timer_out_of_sync[L]: seconds=4.223410694859922>
2019-12-06 23:12:39 DEBUG (SyncWorker_19) [homeassistant.components.nmap_tracker.device_tracker] Scanning...
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=plant.bonsai, old_state=<state plant.bonsai=problem; problem=moisture high, sensors=moisture=sensor.xiaomi_temp_sensor_humidity, battery=sensor.xiaomi_temp_sensor_battery, temperature=sensor.xiaomi_temp_sensor_temperature, brightness=sensor.xiaomi_motion_sensor_illuminance_2, unit_of_measurement_dict=brightness=lx, temperature=°C, moisture=%, battery=%, moisture=76, battery=74, temperature=-1.02, brightness=3, max_brightness=259, friendly_name=bonsai @ 2019-12-06T13:35:43.105851+01:00>, new_state=<state plant.bonsai=problem; problem=moisture high, sensors=moisture=sensor.xiaomi_temp_sensor_humidity, battery=sensor.xiaomi_temp_sensor_battery, temperature=sensor.xiaomi_temp_sensor_temperature, brightness=sensor.xiaomi_motion_sensor_illuminance_2, unit_of_measurement_dict=brightness=lx, temperature=°C, moisture=%, battery=%, moisture=75, battery=74, temperature=-1.17, brightness=3, max_brightness=259, friendly_name=bonsai @ 2019-12-06T13:35:43.105851+01:00>>
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.uptime.sensor] New value: 3.8592054150231485
2019-12-06 23:12:39 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.http.view] Serving /auth/token to 192.168.1.1 (auth: False)
2019-12-06 23:12:39 DEBUG (SyncWorker_11) [homeassistant.components.command_line.sensor] Running command: curl -X GET 'http://192.168.1.41/admin/api.php?status'
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.components.http.view] Serving /api/websocket to 192.168.1.1 (auth: False)
2019-12-06 23:12:39 DEBUG (SyncWorker_16) [homeassistant.components.command_line.sensor] Running command: curl -m 3 -s https://google.pl/ > /dev/null && echo ON || echo OFF
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.load_1m, old_state=<state sensor.load_1m=3.54; unit_of_measurement= , friendly_name=Load (1m), icon=mdi:memory @ 2019-12-06T23:11:35.127754+01:00>, new_state=<state sensor.load_1m=5.93; unit_of_measurement= , friendly_name=Load (1m), icon=mdi:memory @ 2019-12-06T23:12:39.704975+01:00>>
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.memory_use, old_state=<state sensor.memory_use=435.2; unit_of_measurement=MiB, friendly_name=Memory use, icon=mdi:memory @ 2019-12-06T23:11:35.175768+01:00>, new_state=<state sensor.memory_use=436.4; unit_of_measurement=MiB, friendly_name=Memory use, icon=mdi:memory @ 2019-12-06T23:12:39.867265+01:00>>
2019-12-06 23:12:39 DEBUG (SyncWorker_19) [homeassistant.components.nmap_tracker.device_tracker] nmap scan successful
2019-12-06 23:12:39 DEBUG (SyncWorker_19) [homeassistant.components.nmap_tracker.device_tracker] Nmap last results [Device(mac= ALL TRUNCATED. NOT IMPORTANT]
2019-12-06 23:12:39 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.processor_use, old_state=<state sensor.processor_use=1; unit_of_measurement=%, friendly_name=Processor use, icon=mdi:memory @ 2019-12-06T23:11:35.089663+01:00>, new_state=<state sensor.processor_use=2; unit_of_measurement=%, friendly_name=Processor use, icon=mdi:memory @ 2019-12-06T23:12:39.945390+01:00>>
2019-12-06 23:12:39 DEBUG (SyncWorker_10) [homeassistant.components.command_line.sensor] Running command: /opt/vc/bin/vcgencmd measure_temp
2019-12-06 23:12:40 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.gpu_temperature, old_state=<state sensor.gpu_temperature=42.9; unit_of_measurement=°C, friendly_name=GPU Temperature @ 2019-12-06T23:09:10.923825+01:00>, new_state=<state sensor.gpu_temperature=44.0; unit_of_measurement=°C, friendly_name=GPU Temperature @ 2019-12-06T23:12:40.034122+01:00>>
2019-12-06 23:12:40 DEBUG (SyncWorker_14) [homeassistant.components.command_line.sensor] Running command: ssh -i /home/homeassistant/.ssh/id_rsa pi@192.168.1.41 cat /sys/class/thermal/thermal_zone0/temp
2019-12-06 23:12:40 DEBUG (SyncWorker_7) [homeassistant.components.command_line.sensor] Running command: cat /sys/class/thermal/thermal_zone0/temp
2019-12-06 23:12:40 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.cpu_temperature, old_state=<state sensor.cpu_temperature=42.9; unit_of_measurement=°C, friendly_name=CPU Temperature @ 2019-12-06T23:11:26.442806+01:00>, new_state=<state sensor.cpu_temperature=44.0; unit_of_measurement=°C, friendly_name=CPU Temperature @ 2019-12-06T23:12:40.608496+01:00>>
2019-12-06 23:12:41 DEBUG (SyncWorker_12) [homeassistant.helpers.storage] Writing data for auth
2019-12-06 23:12:50 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event automation_triggered[L]: name=Kitchen light OFF (motion sensor), entity_id=automation.kitchen_light_off_motion_sensor>

@PrathikGopal
Copy link

On 103.3 , HASSOS 3.7. I see the same

2019-12-21 20:01:54 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-21 20:01:54 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-21 20:01:54 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-21 20:01:54 WARNING (MainThread) [asyncio] socket.send() raised exception.
2019-12-21 20:01:54 WARNING (MainThread) [asyncio] socket.send() raised exception.

@Kalma-House
Copy link

On 103.5, Hassio, I see:

2020-01-27 19:19:03 WARNING (MainThread) [asyncio] socket.send() raised exception.
19:19 components/websocket_api/http.py (WARNING) - el mensaje se produjo por primera vez a las 19:19 y aparece 18 veces

@Nemesis24
Copy link

109.0 i've got the same!

Détails du journal ( WARNING )
Logger: asyncio
Source: components/hassio/ingress.py:154
First occurred: 7:01:13 (16 occurrences)
Last logged: 7:01:15

socket.send() raised exception.

@turbo4door
Copy link

turbo4door commented Jun 30, 2020

111.4 and this has just started happening to me. Raspberry Pi 4

2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-06-29 22:21:00 WARNING (MainThread) [asyncio] socket.send() raised exception.

@oopptt
Copy link

oopptt commented Oct 3, 2020

Hi guys,

version Home Assistant 0.115.6 and having same logs. Do we need to worry about?

2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.
2020-10-04 01:21:19 WARNING (MainThread) [asyncio] socket.send() raised exception.

Thanks in advance!

@Geoff571
Copy link

Geoff571 commented Nov 2, 2020

Same on 0.117.2

@Holland1
Copy link

Holland1 commented Nov 5, 2020

I have the same problem with 0.117.4, likely started somewhere with 0.116.x

This is an annoying bug, crashes my systems, a couple times per day

Source: /usr/local/lib/python3.8/asyncio/selector_events.py:903
First occurred: 2:07:07 AM (305 occurrences)
Last logged: 2:57:29 PM

socket.send() raised exception

@kyotodesertfox
Copy link

kyotodesertfox commented Jan 11, 2021

Also seeing this issue as well in the past week; as well as a plethora of other problems as well.

I can see my Google Cast (Home) devices, but I can no longer see states (everything shows Unavailable; but volume control works); Spotify integrations on the fritz; I have no idea where to start. There are errors showing up that HASS cannot connect to various streams; etc.

Small handful of my Zigbee devices are throwing errors: "Unable to find reference entitiy: " - yet they are controllable.

Some of my automations are triggering for no reason; and throwing errors.

Does this usually indicate a bad installation; and that I should probably start over (saving my configs)?

I am also having lights triggering when they aren't supposed to. Looking at the logbook shows that it was triggered by 'Home Assistant Cloud' each time something triggers on its own.

@github-actions
Copy link

There hasn't been any activity on this issue recently. Due to the high number of incoming GitHub notifications, we have to clean some of the old issues, as many of them have already been resolved with the latest updates.
Please make sure to update to the latest Home Assistant version and check if that solves the issue. Let us know if that works for you by adding a comment 👍
This issue has now been marked as stale and will be closed if no further activity occurs. Thank you for your contributions.

@pergolafabio
Copy link

You guys ever found out where it was coming from? See them now too

@paulius2k
Copy link

Same here, I have over 10,000 during the last 24h. It started a few hours after upgrading to core-2023.5.4.

@pergolafabio
Copy link

maybe its 2023.5.4 related?

@paulius2k
Copy link

@pergolafabio did you upgrade as well? did it start after that?

@pergolafabio
Copy link

Well, updated indeed to 2023.5.4
But i also updated localtuya to 5.2.0 , maybe localtuya is causing it? do you also use localtuya?

@paulius2k
Copy link

Yes, I have upgraded to Localtuya 5.2.0 in parallel with an upgrade to HA core-2023.5.4.

The strange thing is that I have restarted HA a few times an hour ago, and I see no asyncio errors anymore.

@pergolafabio
Copy link

Yeah, for me it comes back after about 1 or 2 hours after restart HA, but it's probably a localtuya issue, see here...

rospogrigio/localtuya#1406 (comment)

@paulius2k
Copy link

paulius2k commented May 26, 2023

Hmm. 4 hours after restart and no errors in the log. I'll keep on watching though.
Errors started again a little bit over 4 hours after HA restart.

@garry0garry
Copy link

garry0garry commented May 26, 2023

2023-05-26 14:45:33.907 WARNING (MainThread) [custom_components.localtuya.common] [324...7d7] Disconnected - waiting for discovery broadcast
2023-05-26 14:45:36.788 INFO (MainThread) [custom_components.localtuya.common] [324...7d7] Trying to connect to 192.168.50.180...
2023-05-26 14:45:36.813 INFO (MainThread) [custom_components.localtuya.common] [324...7d7] Successfully connected to 192.168.50.180
2023-05-26 14:46:48.907 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:47:03.912 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:47:18.918 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:47:33.922 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:47:48.927 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:48:03.932 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:48:18.938 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:48:33.944 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:48:48.949 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:49:03.954 WARNING (MainThread) [asyncio] socket.send() raised exception.
2023-05-26 14:49:18.959 WARNING (MainThread) [asyncio] socket.send() raised exception.

Disconnect -> Connect -> Aaaaa!

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Projects
None yet
Development

No branches or pull requests