core: IMAP still causes errors in release 2023.4.0
The problem
Still getting the same errors in my log file for IMAP
What version of Home Assistant Core has the issue?
2023.4.0
What was the last working version of Home Assistant Core?
2023.3.x
What type of installation are you running?
Home Assistant Supervised
Integration causing the issue
IMAP
Link to integration documentation on our website
https://www.home-assistant.io/integrations/imap/
Diagnostics information
No response
Example YAML snippet
GUI Config
Anything in the logs that might be useful for us?
2023-04-06 08:10:21.897 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data:
2023-04-06 08:11:10.975 ERROR (MainThread) [homeassistant] Error doing job: application protocol failed to receive SSL data
Traceback (most recent call last):
File "/usr/local/lib/python3.10/asyncio/sslproto.py", line 551, in data_received
self._app_protocol.data_received(chunk)
File "/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py", line 343, in data_received
self._handle_responses(self.incomplete_line + d, self._handle_line, self.current_command)
File "/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py", line 372, in _handle_responses
cmd = line_handler(line, current_cmd)
File "/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py", line 393, in _handle_line
self._response_done(line)
File "/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py", line 629, in _response_done
raise Abort('unexpected tagged response with pending sync command (%s) response: %s' %
aioimaplib.aioimaplib.Abort: unexpected tagged response with pending sync command (LAFL9 CLOSE) response: b'BAD Could not parse command'
### Additional information
Still the same as the 2 issues raised against the beta
About this issue
- Original URL
- State: closed
- Created a year ago
- Comments: 18 (8 by maintainers)
I too confirm what @DavidFW1960 is seeing. Every 30mins when IMAP reconnects to maintain the IDLE connection the status of the entity changes from valid number -> unknown-> unavailable. This plays havoc with automations !! Before 2023.4.0 this behavior was not seen. Occasionally the entity would go unavailable but rarely.
Log file usually gives this error every 30mins. 2023-04-06 03:15:19.519 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 03:44:51.929 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 04:14:24.354 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 04:43:56.149 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 05:13:27.992 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 05:43:00.305 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 06:12:32.631 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 06:42:05.408 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 07:11:37.195 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 07:41:09.541 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 08:10:42.442 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 08:40:15.071 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data:
Occasionally it says this 2023-04-06 02:44:01.622 ERROR (MainThread) [homeassistant] Error doing job: application protocol failed to receive SSL data Traceback (most recent call last): File “/usr/local/lib/python3.10/asyncio/sslproto.py”, line 551, in data_received self._app_protocol.data_received(chunk) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 343, in data_received self._handle_responses(self.incomplete_line + d, self._handle_line, self.current_command) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 372, in _handle_responses cmd = line_handler(line, current_cmd) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 393, in _handle_line self._response_done(line) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 629, in _response_done raise Abort(‘unexpected tagged response with pending sync command (%s) response: %s’ % aioimaplib.aioimaplib.Abort: unexpected tagged response with pending sync command (NIIK13 CLOSE) response: b’OK Success’ 2023-04-06 02:44:11.114 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: 2023-04-06 02:44:23.299 ERROR (MainThread) [homeassistant] Error doing job: application protocol failed to receive SSL data Traceback (most recent call last): File “/usr/local/lib/python3.10/asyncio/sslproto.py”, line 551, in data_received self._app_protocol.data_received(chunk) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 343, in data_received self._handle_responses(self.incomplete_line + d, self._handle_line, self.current_command) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 384, in _handle_responses self._handle_responses(tail, line_handler) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 372, in _handle_responses cmd = line_handler(line, current_cmd) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 393, in _handle_line self._response_done(line) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 636, in _response_done raise Abort(‘unexpected tagged (%s) response: %s’ % (tag, response)) aioimaplib.aioimaplib.Abort: unexpected tagged (b’OMBM5’) response: b’OK SEARCH completed (Success)’ 2023-04-06 02:44:42.957 ERROR (MainThread) [homeassistant] Error doing job: Task exception was never retrieved Traceback (most recent call last): File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 208, in wait raise self._exception File “/usr/src/homeassistant/homeassistant/components/imap/coordinator.py”, line 276, in _async_wait_push_loop number_of_messages = await self._async_fetch_number_of_messages() File “/usr/src/homeassistant/homeassistant/components/imap/coordinator.py”, line 199, in _async_fetch_number_of_messages await self._async_process_event(last_message_id) File “/usr/src/homeassistant/homeassistant/components/imap/coordinator.py”, line 158, in _async_process_event response = await self.imap_client.fetch(last_message_id, “BODY.PEEK[]”) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 724, in fetch return await self.protocol.fetch(message_set, message_parts, timeout=self.timeout) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 505, in fetch return await self.execute( File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 427, in execute await command.wait() File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 208, in wait raise self._exception aioimaplib.aioimaplib.CommandTimeout: OMBM7 FETCH 43 BODY.PEEK[] 2023-04-06 02:44:55.264 ERROR (MainThread) [homeassistant] Error doing job: application protocol failed to receive SSL data Traceback (most recent call last): File “/usr/local/lib/python3.10/asyncio/sslproto.py”, line 551, in data_received self._app_protocol.data_received(chunk) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 343, in data_received self._handle_responses(self.incomplete_line + d, self._handle_line, self.current_command) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 384, in _handle_responses self._handle_responses(tail, line_handler) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 372, in _handle_responses cmd = line_handler(line, current_cmd) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 393, in _handle_line self._response_done(line) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 636, in _response_done raise Abort(‘unexpected tagged (%s) response: %s’ % (tag, response)) aioimaplib.aioimaplib.Abort: unexpected tagged (b’NNAF5’) response: b’OK SEARCH completed (Success)’ 2023-04-06 02:45:14.846 ERROR (MainThread) [homeassistant] Error doing job: Task exception was never retrieved Traceback (most recent call last): File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 208, in wait raise self._exception File “/usr/src/homeassistant/homeassistant/components/imap/coordinator.py”, line 276, in _async_wait_push_loop number_of_messages = await self._async_fetch_number_of_messages() File “/usr/src/homeassistant/homeassistant/components/imap/coordinator.py”, line 199, in _async_fetch_number_of_messages await self._async_process_event(last_message_id) File “/usr/src/homeassistant/homeassistant/components/imap/coordinator.py”, line 158, in _async_process_event response = await self.imap_client.fetch(last_message_id, “BODY.PEEK[]”) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 724, in fetch return await self.protocol.fetch(message_set, message_parts, timeout=self.timeout) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 505, in fetch return await self.execute( File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 427, in execute await command.wait() File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 208, in wait raise self._exception aioimaplib.aioimaplib.CommandTimeout: NNAF7 FETCH 43 BODY.PEEK[] 2023-04-06 02:45:27.200 ERROR (MainThread) [homeassistant] Error doing job: application protocol failed to receive SSL data Traceback (most recent call last): File “/usr/local/lib/python3.10/asyncio/sslproto.py”, line 551, in data_received self._app_protocol.data_received(chunk) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 343, in data_received self._handle_responses(self.incomplete_line + d, self._handle_line, self.current_command) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 384, in _handle_responses self._handle_responses(tail, line_handler) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 372, in _handle_responses cmd = line_handler(line, current_cmd) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 393, in _handle_line self._response_done(line) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 629, in _response_done raise Abort(‘unexpected tagged response with pending sync command (%s) response: %s’ % aioimaplib.aioimaplib.Abort: unexpected tagged response with pending sync command (HMHL8 IDLE) response: b’OK Success’ 2023-04-06 02:45:36.859 ERROR (MainThread) [homeassistant] Error doing job: Task exception was never retrieved Traceback (most recent call last): File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 208, in wait raise self._exception File “/usr/src/homeassistant/homeassistant/components/imap/coordinator.py”, line 276, in _async_wait_push_loop number_of_messages = await self._async_fetch_number_of_messages() File “/usr/src/homeassistant/homeassistant/components/imap/coordinator.py”, line 199, in _async_fetch_number_of_messages await self._async_process_event(last_message_id) File “/usr/src/homeassistant/homeassistant/components/imap/coordinator.py”, line 158, in _async_process_event response = await self.imap_client.fetch(last_message_id, “BODY.PEEK[]”) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 724, in fetch return await self.protocol.fetch(message_set, message_parts, timeout=self.timeout) File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 505, in fetch return await self.execute( File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 427, in execute await command.wait() File “/usr/local/lib/python3.10/site-packages/aioimaplib/aioimaplib.py”, line 208, in wait raise self._exception aioimaplib.aioimaplib.CommandTimeout: HMHL9 FETCH 43 BODY.PEEK[] 2023-04-06 02:45:46.861 ERROR (MainThread) [homeassistant.components.imap.coordinator] Error requesting imap data: HMHL9 FETCH 43 BODY.PEEK[] 2023-04-06 02:46:49.692 ERROR (MainThread) [homeassistant] Error doing job: Task was destroyed but it is pending!
I have the same issue. Started happening immediately after 2023.4 update