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

Gardena Garden Pump - "Failed to setup, check the logs" #125112

Closed
a5mithwh opened this issue Sep 2, 2024 · 2 comments · Fixed by #125175
Closed

Gardena Garden Pump - "Failed to setup, check the logs" #125112

a5mithwh opened this issue Sep 2, 2024 · 2 comments · Fixed by #125175

Comments

@a5mithwh
Copy link

a5mithwh commented Sep 2, 2024

The problem

When trying to connect to a Gardena 6500 pump, the device says Failed! and HA reports Failed to set up: Check the logs almost instantly.

I'm using an ESP32 device (this one) https://www.az-delivery.uk/products/esp32-developmentboard and have followed the guides to get bluetooth proxy running. It sees the device when in pairing mode, but never connects.

Config is as follows on ESPHome

`esphome:
name: bluetooth
friendly_name: Bluetooth

esp32:
board: esp32dev
framework:
type: esp-idf

Enable logging

logger:
level: VERBOSE

Enable Home Assistant API

api:
encryption:
key: "************"

ota:

  • platform: esphome
    password: "************"

wifi:
ssid: !secret wifi_ssid
password: !secret wifi_password

Enable fallback hotspot (captive portal) in case wifi connection fails

ap:
ssid: "Bluetooth Fallback Hotspot"
password: "**********"

captive_portal:

esp32_ble_tracker:
scan_parameters:
active: True

bluetooth_proxy:
active: True

`

Tried with and without the interval & window values set to 1100ms within esp32_ble_tracker.

Have factory reset the pump, put it into Pairing, which changes to Failed when I go through the Add Device > Gardena > Submit (interstingly it also does this if i remove the device from the app on my iPhone but don't forget the device within Bluetooth settings).

Running low on ideas and available documentation. My next step is to drain the pump, bring it in the house and within range of my server with built in bluetooth to see if that changes anything.

What version of Home Assistant Core has the issue?

core-2024.8.3

What was the last working version of Home Assistant Core?

No response

What type of installation are you running?

Home Assistant Supervised

Integration causing the issue

gardena_bluetooth

Link to integration documentation on our website

https://www.home-assistant.io/integrations/gardena_bluetooth/

Diagnostics information

2024-09-02 22:22:46.477 ERROR (MainThread) [homeassistant.config_entries] Error setting up entry Gardena Garden Pump for gardena_bluetooth
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/config_entries.py", line 604, in async_setup
result = await component.async_setup_entry(hass, self)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/src/homeassistant/homeassistant/components/gardena_bluetooth/init.py", line 59, in async_setup_entry
name = await client.read_char(
^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.12/site-packages/gardena_bluetooth/client.py", line 176, in read_char
return char.decode(await self.read_char_raw(char.uuid))
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.12/site-packages/gardena_bluetooth/parse.py", line 105, in decode
return data.partition("b\x00")[0].decode("utf-8", "replace")
^^^^^^^^^^^^^^^^^^^^^^^
TypeError: a bytes-like object is required, not 'str'
2024-09-02 22:23:24.054 DEBUG (MainThread) [gardena_bluetooth.client] Connecting to 70:B9:50:5F:DD:D9
2024-09-02 22:23:24.054 DEBUG (MainThread) [bleak_esphome.connect] bluetooth [A8:42:E3:CC:F5:04]: Checking can connect, available=True, ble_connections_free=3 result=True
2024-09-02 22:23:24.067 DEBUG (MainThread) [bleak_esphome.backend.device] bluetooth [A8:42:E3:CC:F5:04]: BLE connection limits: used=1 free=2 limit=3
2024-09-02 22:23:24.772 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: Connection state changed to connected=True mtu=247 error=0
2024-09-02 22:23:24.772 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: connected, registering for disconnected callbacks
2024-09-02 22:23:24.773 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: Cached services hit
2024-09-02 22:23:24.773 DEBUG (MainThread) [gardena_bluetooth.client] Connected to 70:B9:50:5F:DD:D9
2024-09-02 22:23:24.794 DEBUG (MainThread) [bleak_esphome.backend.device] bluetooth [A8:42:E3:CC:F5:04]: BLE connection limits: used=1 free=2 limit=3
2024-09-02 22:23:24.907 DEBUG (MainThread) [homeassistant.components.gardena_bluetooth.config_flow] Found device with model: 09059
2024-09-02 22:23:24.907 DEBUG (MainThread) [gardena_bluetooth.client] Disconnecting from 70:B9:50:5F:DD:D9
2024-09-02 22:23:24.973 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: Connection state changed to connected=False mtu=0 error=0
2024-09-02 22:23:24.973 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: BLE device disconnected
2024-09-02 22:23:24.973 DEBUG (MainThread) [bleak_esphome.backend.device] bluetooth [A8:42:E3:CC:F5:04]: BLE connection limits: used=0 free=3 limit=3
2024-09-02 22:23:24.974 DEBUG (MainThread) [gardena_bluetooth.client] Connecting to 70:B9:50:5F:DD:D9
2024-09-02 22:23:24.974 DEBUG (MainThread) [bleak_esphome.connect] bluetooth [A8:42:E3:CC:F5:04]: Checking can connect, available=True, ble_connections_free=3 result=True
2024-09-02 22:23:25.007 DEBUG (MainThread) [bleak_esphome.backend.device] bluetooth [A8:42:E3:CC:F5:04]: BLE connection limits: used=1 free=2 limit=3
2024-09-02 22:23:25.284 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: Connection state changed to connected=True mtu=247 error=0
2024-09-02 22:23:25.284 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: connected, registering for disconnected callbacks
2024-09-02 22:23:25.284 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: Cached services hit
2024-09-02 22:23:25.284 DEBUG (MainThread) [gardena_bluetooth.client] Connected to 70:B9:50:5F:DD:D9
2024-09-02 22:23:25.285 DEBUG (MainThread) [bleak_esphome.backend.device] bluetooth [A8:42:E3:CC:F5:04]: BLE connection limits: used=1 free=2 limit=3
2024-09-02 22:23:25.689 ERROR (MainThread) [homeassistant.config_entries] Error setting up entry Gardena Garden Pump for gardena_bluetooth
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/config_entries.py", line 604, in async_setup
result = await component.async_setup_entry(hass, self)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/src/homeassistant/homeassistant/components/gardena_bluetooth/init.py", line 59, in async_setup_entry
name = await client.read_char(
^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.12/site-packages/gardena_bluetooth/client.py", line 176, in read_char
return char.decode(await self.read_char_raw(char.uuid))
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.12/site-packages/gardena_bluetooth/parse.py", line 105, in decode
return data.partition("b\x00")[0].decode("utf-8", "replace")
^^^^^^^^^^^^^^^^^^^^^^^
TypeError: a bytes-like object is required, not 'str'
2024-09-02 22:23:30.690 DEBUG (MainThread) [gardena_bluetooth.client] Disconnecting from 70:B9:50:5F:DD:D9
2024-09-02 22:23:30.811 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: Connection state changed to connected=False mtu=0 error=0
2024-09-02 22:23:30.811 DEBUG (MainThread) [bleak_esphome.backend.client] bluetooth [A8:42:E3:CC:F5:04]: Garden Pump - 70:B9:50:5F:DD:D9: BLE device disconnected
2024-09-02 22:23:30.811 DEBUG (MainThread) [bleak_esphome.backend.device] bluetooth [A8:42:E3:CC:F5:04]: BLE connection limits: used=0 free=3 limit=3
2024-09-02 22:23:50.009 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0): ['org.bluez.Adapter1', {'Discovering': <dbus_fast.signature.Variant ('b', False)>}, []]
2024-09-02 22:23:50.015 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0): ['org.bluez.Adapter1', {'Discovering': <dbus_fast.signature.Variant ('b', True)>}, []]
2024-09-02 22:23:50.354 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_51_94_C3_5E_44_16', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.Device1': {'Address': <dbus_fast.signature.Variant ('s', 51:94:C3:5E:44:16)>, 'AddressType': <dbus_fast.signature.Variant ('s', random)>, 'Alias': <dbus_fast.signature.Variant ('s', 51-94-C3-5E-44-16)>, 'Paired': <dbus_fast.signature.Variant ('b', False)>, 'Bonded': <dbus_fast.signature.Variant ('b', False)>, 'Trusted': <dbus_fast.signature.Variant ('b', False)>, 'Blocked': <dbus_fast.signature.Variant ('b', False)>, 'LegacyPairing': <dbus_fast.signature.Variant ('b', False)>, 'RSSI': <dbus_fast.signature.Variant ('n', -85)>, 'Connected': <dbus_fast.signature.Variant ('b', False)>, 'UUIDs': <dbus_fast.signature.Variant ('as', [])>, 'Adapter': <dbus_fast.signature.Variant ('o', /org/bluez/hci0)>, 'ManufacturerData': <dbus_fast.signature.Variant ('a{qv}', {76: <dbus_fast.signature.Variant ('ay', bytearray(b'\x10\x070\x1f\xa4\xcf\xf4z('))>})>, 'TxPower': <dbus_fast.signature.Variant ('n', 12)>, 'ServicesResolved': <dbus_fast.signature.Variant ('b', False)>}, 'org.freedesktop.DBus.Properties': {}}]
2024-09-02 22:23:50.624 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:51.176 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -85)>}, []]
2024-09-02 22:23:51.451 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:51.612 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_74_5C_7B_BE_E7_4B', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.Device1': {'Address': <dbus_fast.signature.Variant ('s', 74:5C:7B:BE:E7:4B)>, 'AddressType': <dbus_fast.signature.Variant ('s', random)>, 'Alias': <dbus_fast.signature.Variant ('s', 74-5C-7B-BE-E7-4B)>, 'Paired': <dbus_fast.signature.Variant ('b', False)>, 'Bonded': <dbus_fast.signature.Variant ('b', False)>, 'Trusted': <dbus_fast.signature.Variant ('b', False)>, 'Blocked': <dbus_fast.signature.Variant ('b', False)>, 'LegacyPairing': <dbus_fast.signature.Variant ('b', False)>, 'RSSI': <dbus_fast.signature.Variant ('n', -85)>, 'Connected': <dbus_fast.signature.Variant ('b', False)>, 'UUIDs': <dbus_fast.signature.Variant ('as', [])>, 'Adapter': <dbus_fast.signature.Variant ('o', /org/bluez/hci0)>, 'ManufacturerData': <dbus_fast.signature.Variant ('a{qv}', {76: <dbus_fast.signature.Variant ('ay', bytearray(b'\x16\x08\x00q\x93\x8a\xb1~\xd0\x00'))>})>, 'ServicesResolved': <dbus_fast.signature.Variant ('b', False)>}, 'org.freedesktop.DBus.Properties': {}}]
2024-09-02 22:23:51.644 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_D7_E3_F8_9A_F0_99', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.Device1': {'Address': <dbus_fast.signature.Variant ('s', D7:E3:F8:9A:F0:99)>, 'AddressType': <dbus_fast.signature.Variant ('s', random)>, 'Alias': <dbus_fast.signature.Variant ('s', D7-E3-F8-9A-F0-99)>, 'Paired': <dbus_fast.signature.Variant ('b', False)>, 'Bonded': <dbus_fast.signature.Variant ('b', False)>, 'Trusted': <dbus_fast.signature.Variant ('b', False)>, 'Blocked': <dbus_fast.signature.Variant ('b', False)>, 'LegacyPairing': <dbus_fast.signature.Variant ('b', False)>, 'RSSI': <dbus_fast.signature.Variant ('n', -88)>, 'Connected': <dbus_fast.signature.Variant ('b', False)>, 'UUIDs': <dbus_fast.signature.Variant ('as', [])>, 'Adapter': <dbus_fast.signature.Variant ('o', /org/bluez/hci0)>, 'ManufacturerData': <dbus_fast.signature.Variant ('a{qv}', {76: <dbus_fast.signature.Variant ('ay', bytearray(b'\x12\x02\x00\x02'))>})>, 'ServicesResolved': <dbus_fast.signature.Variant ('b', False)>}, 'org.freedesktop.DBus.Properties': {}}]
2024-09-02 22:23:51.729 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -85)>}, []]
2024-09-02 22:23:52.008 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -85)>}, []]
2024-09-02 22:23:52.278 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:52.822 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -85)>}, []]
2024-09-02 22:23:53.103 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -85)>}, []]
2024-09-02 22:23:53.383 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -85)>}, []]
2024-09-02 22:23:53.616 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_74_5C_7B_BE_E7_4B): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:53.650 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_D7_E3_F8_9A_F0_99): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:53.659 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:55.038 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -85)>}, []]
2024-09-02 22:23:55.315 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -85)>}, []]
2024-09-02 22:23:55.593 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -85)>}, []]
2024-09-02 22:23:55.616 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_74_5C_7B_BE_E7_4B): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:55.650 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_D7_E3_F8_9A_F0_99): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:55.868 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:56.138 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]
2024-09-02 22:23:56.413 DEBUG (MainThread) [bleak.backends.bluezdbus.manager] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_51_94_C3_5E_44_16): ['org.bluez.Device1', {'RSSI': <dbus_fast.signature.Variant ('n', -88)>}, []]

Example YAML snippet

No response

Anything in the logs that might be useful for us?

No response

Additional information

No response

@home-assistant
Copy link

home-assistant bot commented Sep 2, 2024

Hey there @elupus, mind taking a look at this issue as it has been labeled with an integration (gardena_bluetooth) you are listed as a code owner for? Thanks!

Code owner commands

Code owners of gardena_bluetooth can trigger bot actions by commenting:

  • @home-assistant close Closes the issue.
  • @home-assistant rename Awesome new title Renames the issue.
  • @home-assistant reopen Reopen the issue.
  • @home-assistant unassign gardena_bluetooth Removes the current integration label and assignees on the issue, add the integration domain after the command.
  • @home-assistant add-label needs-more-information Add a label (needs-more-information, problem in dependency, problem in custom component) to the issue.
  • @home-assistant remove-label needs-more-information Remove a label (needs-more-information, problem in dependency, problem in custom component) on the issue.

(message by CodeOwnersMention)


gardena_bluetooth documentation
gardena_bluetooth source
(message by IssueLinks)

@elupus
Copy link
Contributor

elupus commented Sep 3, 2024

I think i know what is wrong (or at least i see a bug in the code) will see when i can get a chance to look at it.

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

Successfully merging a pull request may close this issue.

2 participants