ZHA not working with elelabs Pi Shield after removing CLI config and move to GUI

rexkani commented 4 years ago

The problem

ZHA not working with elelabs Pi Shield after removing CLI config and move to GUI. ZHA used to be working on my HA until last update to homeassistant: 0.110.4 yesterday.

all my zigbee devices are missing entries now, and i cannot deploy ZHA integration.

Environment

arch: armv7 channel: stable docker: 19.03.8 hassos: "4.8" homeassistant: 0.110.4 hostname: hassio logging: info machine: raspberrypi3 supervisor: "227" supported_arch:

armv7
armhf
Home Assistant Core release with the issue: 0.110.4
Last working Home Assistant Core release (if known): 0.108.x
Operating environment (Home Assistant/Supervised/Docker/venv):
Integration causing this issue: zha
Link to integration documentation on our website: https://www.home-assistant.io/integrations/zha/

Problem-relevant `configuration.yaml`

#zha:
# usb_path: /dev/ttyAMA0
# database_path: zigbee.db
# baudrate: 115200

Traceback/Error logs

2020-06-05 06:56:02 DEBUG (MainThread) [bellows.ezsp] Resetting EZSP
2020-06-05 06:56:05 DEBUG (MainThread) [bellows.ezsp] Unsuccessful radio probe of '/dev/ttyAMA0' port
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/bellows/ezsp.py", line 46, in probe
    await asyncio.wait_for(ezsp._probe(), timeout=PROBE_TIMEOUT)
  File "/usr/local/lib/python3.7/asyncio/tasks.py", line 449, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError
2020-06-05 06:56:05 DEBUG (MainThread) [zigpy_deconz.uart] Connection made
2020-06-05 06:56:05 DEBUG (MainThread) [zigpy_deconz.api] Command Command.device_state (0, 0, 0)
2020-06-05 06:56:05 DEBUG (MainThread) [zigpy_deconz.uart] Send: 0x0702000800000000
2020-06-05 06:56:06 WARNING (MainThread) [zigpy_deconz.api] No response to 'Command.device_state' command with seq id '0x02'
2020-06-05 06:56:06 DEBUG (MainThread) [zigpy_deconz.api] Unsuccessful radio probe of '/dev/ttyAMA0' port
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/zigpy_deconz/api.py", line 356, in probe
    await asyncio.wait_for(api._probe(), timeout=PROBE_TIMEOUT)
  File "/usr/local/lib/python3.7/asyncio/tasks.py", line 442, in wait_for
    return fut.result()
  File "/usr/local/lib/python3.7/site-packages/zigpy_deconz/api.py", line 372, in _probe
    await self.device_state()
  File "/usr/local/lib/python3.7/site-packages/zigpy_deconz/api.py", line 289, in _command
    return await asyncio.wait_for(fut, timeout=COMMAND_TIMEOUT)
  File "/usr/local/lib/python3.7/asyncio/tasks.py", line 449, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError
2020-06-05 06:56:06 DEBUG (MainThread) [zigpy_cc.uart] Connecting on port /dev/ttyAMA0 with boudrate 115200
2020-06-05 06:56:06 DEBUG (MainThread) [zigpy_cc.uart] Connection made
2020-06-05 06:56:07 DEBUG (MainThread) [zigpy_cc.api] --> SREQ SYS version tsn: None {}
2020-06-05 06:56:07 DEBUG (MainThread) [zigpy_cc.uart] Send: b'\xfe\x00!\x02#'
2020-06-05 06:56:08 DEBUG (MainThread) [zigpy_cc.api] Unsuccessful radio probe of '/dev/ttyAMA0' port
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/zigpy_cc/api.py", line 260, in probe
    await asyncio.wait_for(api._probe(), timeout=COMMAND_TIMEOUT)
  File "/usr/local/lib/python3.7/asyncio/tasks.py", line 449, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError
2020-06-05 06:56:08 DEBUG (MainThread) [zigpy_zigate.uart] Connection made
2020-06-05 06:56:08 DEBUG (MainThread) [zigpy_zigate.uart] Send: 0x2 b'01'
2020-06-05 06:56:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame to send: b'\x00\x02\x00\x01\x02\x01'
2020-06-05 06:56:08 DEBUG (MainThread) [zigpy_zigate.uart] Frame escaped: b'\x02\x10\x02\x12\x02\x10\x02\x11\x02\x12\x02\x11'
2020-06-05 06:56:09 DEBUG (MainThread) [zigpy_zigate.api] Unsuccessful radio probe of '/dev/ttyAMA0' port
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/zigpy_zigate/api.py", line 172, in probe
    await asyncio.wait_for(api._probe(), timeout=COMMAND_TIMEOUT)
  File "/usr/local/lib/python3.7/asyncio/tasks.py", line 449, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError
2020-06-05 06:56:09 DEBUG (MainThread) [zigpy_xbee.uart] Connection made
2020-06-05 06:56:09 DEBUG (MainThread) [zigpy_xbee.api] at command: AP (2,)
2020-06-05 06:56:09 DEBUG (MainThread) [zigpy_xbee.api] Command at (b'AP', b'\x02')
2020-06-05 06:56:09 DEBUG (MainThread) [zigpy_xbee.uart] Sending: b'\x08\x01AP\x02'
2020-06-05 06:56:10 WARNING (MainThread) [zigpy_xbee.api] at: No response to AP command
2020-06-05 06:56:11 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:12 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=camera.bedroom, old_state=<state camera.bedroom=unavailable; friendly_name=bedroom, entity_picture=/api/camera_proxy/camera.bedroom?token=3b56a95ec9331b21659139d49ba29abc6a4c8c5bad3f6c9e3566cf730fac8549, supported_features=0 @ 2020-06-05T14:47:04.752973+08:00>, new_state=<state camera.bedroom=unavailable; friendly_name=bedroom, entity_picture=/api/camera_proxy/camera.bedroom?token=aaeb3c01011e233de7743ef42e0dbe7bc8ab839ec933f073d5129b2fc281aa96, supported_features=0 @ 2020-06-05T14:47:04.752973+08:00>>
2020-06-05 06:56:13 WARNING (MainThread) [zigpy_cc.api] Waiter timeout: <Waiter matcher=<Matcher type=CommandType.SRSP subsystem=Subsystem.SYS command=version payload={}> future=<Future cancelled> timeout=6000 sequence=None>
2020-06-05 06:56:13 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:13 DEBUG (MainThread) [zigpy_xbee.api] Failed to enter AT command mode at 57600bps, trying 1200 next
2020-06-05 06:56:15 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:17 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:17 DEBUG (MainThread) [zigpy_xbee.api] Failed to enter AT command mode at 1200bps, trying 2400 next
2020-06-05 06:56:18 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:20 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:20 DEBUG (MainThread) [zigpy_xbee.api] Failed to enter AT command mode at 2400bps, trying 4800 next
2020-06-05 06:56:21 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:23 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:23 DEBUG (MainThread) [zigpy_xbee.api] Failed to enter AT command mode at 4800bps, trying 9600 next
2020-06-05 06:56:24 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:26 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:26 DEBUG (MainThread) [zigpy_xbee.api] Failed to enter AT command mode at 9600bps, trying 19200 next
2020-06-05 06:56:28 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:30 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:30 DEBUG (MainThread) [zigpy_xbee.api] Failed to enter AT command mode at 19200bps, trying 38400 next
2020-06-05 06:56:31 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:33 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:33 DEBUG (MainThread) [zigpy_xbee.api] Failed to enter AT command mode at 38400bps, trying 57600 next
2020-06-05 06:56:34 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:36 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:36 DEBUG (MainThread) [zigpy_xbee.api] Failed to enter AT command mode at 57600bps, trying 115200 next
2020-06-05 06:56:37 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:39 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:39 DEBUG (MainThread) [zigpy_xbee.api] Failed to enter AT command mode at 115200bps, trying 230400 next
2020-06-05 06:56:40 DEBUG (MainThread) [zigpy_xbee.uart] Command mode sending b'+++' to uart
2020-06-05 06:56:42 DEBUG (MainThread) [zigpy_xbee.api] Command mode no response to AT '+++' command
2020-06-05 06:56:42 DEBUG (MainThread) [zigpy_xbee.api] Couldn't enter AT command mode at any known baudrate.Configure XBee manually for escaped API mode ATAP2
2020-06-05 06:56:42 DEBUG (MainThread) [zigpy_xbee.api] Unsuccessful radio probe of '/dev/ttyAMA0' port
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/zigpy_xbee/api.py", line 593, in _probe
    await self._at_command("AP", 2)
  File "/usr/local/lib/python3.7/site-packages/zigpy_xbee/api.py", line 383, in _at_partial
    timeout=AT_COMMAND_TIMEOUT,
  File "/usr/local/lib/python3.7/asyncio/tasks.py", line 449, in wait_for
    raise futures.TimeoutError()
concurrent.futures._base.TimeoutError

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/zigpy_xbee/api.py", line 575, in probe
    await asyncio.wait_for(api._probe(), timeout=PROBE_TIMEOUT)
  File "/usr/local/lib/python3.7/asyncio/tasks.py", line 442, in wait_for
    return fut.result()
  File "/usr/local/lib/python3.7/site-packages/zigpy_xbee/api.py", line 596, in _probe
    raise APIException("Failed to configure XBee for API mode")
zigpy.exceptions.APIException: Failed to configure XBee for API mode

Additional information

Adminiuga commented 4 years ago

Roll back to hass.os 3.13

Adminiuga commented 4 years ago

See https://github.com/home-assistant/operating-system/pull/706 for details

Adminiuga commented 4 years ago

Fixed by https://github.com/home-assistant/operating-system/pull/706

Adminiuga commented 4 years ago

Re-open if the problem still persists after the bass os roll back.

rexkani commented 4 years ago

Problem solved, THANKS!

home-assistant / core