home-assistant / core

:house_with_garden: Open source home automation that puts local control and privacy first.
https://www.home-assistant.io
Apache License 2.0
72.4k stars 30.3k forks source link

Govee BLE: H5174 shows correct temperature/humidity/battery, then values go to "Unavailable" #82175

Closed tomuta closed 1 year ago

tomuta commented 1 year ago

The problem

The Govee BLE integration discovered my H5174 BLE thermometer and correctly added it. Initially it showed the correct values for temperature/humidity/battery, but then about 1-2 minutes later they change to "Unavailable". I tried deleting it and re-adding it, but it does the same every time.

What version of Home Assistant Core has the issue?

2022.11.2

What was the last working version of Home Assistant Core?

No response

What type of installation are you running?

Home Assistant Container

Integration causing the issue

govee_ble

Link to integration documentation on our website

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

Diagnostics information

No response

Example YAML snippet

No response

Anything in the logs that might be useful for us?

Nothing seems to be logged

Additional information

No response

home-assistant[bot] commented 1 year ago

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

Code owner commands Code owners of `govee_ble` can trigger bot actions by commenting: - `@home-assistant close` Closes the issue. - `@home-assistant rename Awesome new title` Change the title of the issue. - `@home-assistant reopen` Reopen the issue. - `@home-assistant unassign govee_ble` Removes the current integration label and assignees on the issue, add the integration domain after the command.

(message by CodeOwnersMention)


govee_ble documentation govee_ble source (message by IssueLinks)

bdraco commented 1 year ago

How far away is the device from your Bluetooth adapter?

tomuta commented 1 year ago

Probably 5 meters/15 feet away. I placed it right next to the machine and the issue remains. Regardless of distance, I do see it regularly broadcast when watching it with hcitool lescan. The battery level reported was 58% right after adding it. I can delete and re-add it, and every single time I see the correct values right after adding it, but then they permanently revert to "Unavailable".

bjobo commented 1 year ago

I observe the same problem using a Govee H5075 an the latest Home Assistant Version 2022.11.4.

The device irregularly shows the status unavailable. In the history graph (see screenshot below) you can see that there are some gaps, however I don't know if they are related to the (un)availability.

When I use the Govee app there are no gaps. Also the HA system is constantly available. There is no difference if the device is a few centimeters or a few meters away.

My system: Home Assistant 2022.11.4; Supervisor 2022.10.2; Operating System 9.3; Running on a Raspberry Pi 3 (32-bit). Govee device: H5075; Software version: 1.04.06; Hardware version: 1.03.02.

[EDIT] I activated homeassistant.components.bluetooth: debug. The sensor became available at19:54:56 and went unavailable at around 19:57. Then it went available again at 20:01:32 and back unavaliable at around 20:02.

2022-11-22 19:54:54.742 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] Initializing bluetooth scanner with {'detection_callback': <bound method HaScanner._async_detection_callback of <homeassistant.components.bluetooth.scanner.HaScanner object at 0x59f1ecd0>>, 'scanning_mode': 'active', 'adapter': 'hci0'}
2022-11-22 19:54:54.744 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Starting bluetooth discovery attempt: (1/3)
2022-11-22 19:54:54.749 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): adapter stopped responding; executing reset
2022-11-22 19:54:54.919 WARNING (MainThread) [bluetooth_auto_recovery.recover] Bluetooth adapter hci0 successfully turned back ON
2022-11-22 19:54:55.926 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): adapter reset result: True
2022-11-22 19:54:55.926 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Starting bluetooth discovery attempt: (2/3)
2022-11-22 19:54:55.985 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: F3:33:89:67:45:EE AdvertisementData(local_name='98E7822FFDE830AEE9', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], tx_power=0, rssi=-74) connectable: True match: set() rssi: -74
2022-11-22 19:54:56.004 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: 17:CA:7E:D3:CF:C2 AdvertisementData(service_data={'0000fd6f-0000-1000-8000-00805f9b34fb': b'\xa8\xe9\x17\xa1P{\xf9Aj\xde\xe5\xbf\xb9\xc8\xca\xa9\x14\xbf30'}, service_uuids=['0000fd6f-0000-1000-8000-00805f9b34fb'], rssi=-74) connectable: True match: set() rssi: -74
2022-11-22 19:54:56.008 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: 30:41:B7:9E:F1:36 AdvertisementData(manufacturer_data={6: b'\x01\x0f \x02\xd3J9\x88[\xbe\xb0/(\xb2\x01}\x82\x06KbE\x90\x028\x91G\x02'}, rssi=-58) connectable: True match: set() rssi: -58
2022-11-22 19:54:56.051 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: ED:ED:24:47:53:63 AdvertisementData(local_name='98E78283DBD43096EB', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], tx_power=0, rssi=-78) connectable: True match: set() rssi: -78
2022-11-22 19:54:56.158 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: F3:33:B4:D8:93:6C AdvertisementData(local_name='98E782268E7430AEE9', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], tx_power=0, rssi=-85) connectable: True match: set() rssi: -85
2022-11-22 19:54:56.160 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: B8:BC:5B:6A:B6:33 AdvertisementData(manufacturer_data={117: b'B\x04\x01\x80`\xb8\xbc[j\xb63\xba\xbc[j\xb62\x01\x00\x00\x00\x00\x00\x00'}, rssi=-88) connectable: True match: set() rssi: -88
2022-11-22 19:54:56.249 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: 47:C9:BD:DB:D8:6E AdvertisementData(service_data={'0000fd6f-0000-1000-8000-00805f9b34fb': b'\x8e\x99\xb2\xd4\xa7\xc5R\xb1\x14m>\x98u\xd4\xd1\xee/.\xc3\x91'}, service_uuids=['0000fd6f-0000-1000-8000-00805f9b34fb'], rssi=-65) connectable: True match: set() rssi: -65
2022-11-22 19:54:56.518 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: A4:C1:38:04:CE:3E AdvertisementData(local_name='GVH5075_CE3E', manufacturer_data={60552: b'\x00\x03.\xacd\x00', 76: b'\x02\x15INTELLI_ROCKS_HWPu\xf2\xff\x0c'}, service_uuids=['0000ec88-0000-1000-8000-00805f9b34fb'], rssi=-27) connectable: True match: {'govee_ble', 'ibeacon'} rssi: -27
2022-11-22 19:54:56.738 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: F3:33:32:6A:15:58 AdvertisementData(local_name='98E7822FFD4230AEE9', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], tx_power=0, rssi=-85) connectable: True match: set() rssi: -85
2022-11-22 19:55:06.290 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: FA:BA:48:10:68:58 AdvertisementData(local_name='98E7820D9A2E3397E9', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], rssi=-92) connectable: True match: set() rssi: -92
2022-11-22 19:55:25.938 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 8.539973438018933
2022-11-22 19:55:55.939 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 27.33990409807302
2022-11-22 19:56:25.941 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 57.33978372719139
2022-11-22 19:56:55.943 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 87.33964922302403
2022-11-22 19:57:25.945 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 117.34950209921226
2022-11-22 19:57:25.946 INFO (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Bluetooth scanner has gone quiet for 90s, restarting
2022-11-22 19:57:25.946 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Stopping bluetooth discovery
2022-11-22 19:57:27.966 ERROR (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Error stopping scanner: [org.bluez.Error.InProgress] Operation already in progress
2022-11-22 19:57:27.969 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Starting bluetooth discovery attempt: (1/3)
2022-11-22 19:57:55.946 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 27.969852118985727
2022-11-22 19:58:25.947 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 57.96968392911367
2022-11-22 19:58:55.948 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 87.96950690308586
2022-11-22 19:59:25.949 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 117.96932201902382
2022-11-22 19:59:25.950 INFO (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Bluetooth scanner has gone quiet for 90s, restarting
2022-11-22 19:59:25.950 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Stopping bluetooth discovery
2022-11-22 19:59:25.955 ERROR (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Error stopping scanner: [org.bluez.Error.InProgress] Operation already in progress
2022-11-22 19:59:25.963 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): adapter stopped responding; executing reset
2022-11-22 19:59:30.981 WARNING (MainThread) [bluetooth_auto_recovery.recover] Bluetooth adapter hci0 could not be reset due to timeout
2022-11-22 19:59:30.987 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): adapter reset result: False
2022-11-22 19:59:30.987 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Starting bluetooth discovery attempt: (1/3)
2022-11-22 19:59:55.950 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 24.949839960085228
2022-11-22 20:00:25.951 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 54.949641876854
2022-11-22 20:00:55.952 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 84.95943819987588
2022-11-22 20:01:25.953 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 114.94922974705696
2022-11-22 20:01:25.954 INFO (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Bluetooth scanner has gone quiet for 90s, restarting
2022-11-22 20:01:25.954 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Stopping bluetooth discovery
2022-11-22 20:01:25.962 ERROR (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Error stopping scanner: [org.bluez.Error.NotReady] Resource Not Ready
2022-11-22 20:01:25.971 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): adapter stopped responding; executing reset
2022-11-22 20:01:30.277 WARNING (MainThread) [bluetooth_auto_recovery.recover] Bluetooth adapter hci0 successfully turned back ON
2022-11-22 20:01:31.284 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): adapter reset result: True
2022-11-22 20:01:31.285 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Starting bluetooth discovery attempt: (1/3)
2022-11-22 20:01:31.306 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: ED:ED:24:47:53:63 AdvertisementData(local_name='98E78283DBD43096EB', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], tx_power=0, rssi=-77) connectable: True match: set() rssi: -77
2022-11-22 20:01:31.331 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: F3:33:32:6A:15:58 AdvertisementData(local_name='98E7822FFD4230AEE9', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], tx_power=0, rssi=-89) connectable: True match: set() rssi: -89
2022-11-22 20:01:31.335 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: F3:33:89:67:45:EE AdvertisementData(local_name='98E7822FFDE830AEE9', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], tx_power=0, rssi=-79) connectable: True match: set() rssi: -79
2022-11-22 20:01:31.415 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: 14:B9:3F:5C:EE:83 AdvertisementData(manufacturer_data={6: b'\x01\x0f \x02P\xcc\xed\xd4\xad\\\x87\xb3g\x9fK\x97\x07\xf6W\xd1U\x8d?\x180\x8e\xcc'}, rssi=-58) connectable: True match: set() rssi: -58
2022-11-22 20:01:31.423 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: F3:33:B4:D8:93:6C AdvertisementData(local_name='98E782268E7430AEE9', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], tx_power=0, rssi=-76) connectable: True match: set() rssi: -76
2022-11-22 20:01:31.537 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: 17:CA:7E:D3:CF:C2 AdvertisementData(service_data={'0000fd6f-0000-1000-8000-00805f9b34fb': b'\xa8\xe9\x17\xa1P{\xf9Aj\xde\xe5\xbf\xb9\xc8\xca\xa9\x14\xbf30'}, service_uuids=['0000fd6f-0000-1000-8000-00805f9b34fb'], rssi=-76) connectable: True match: set() rssi: -76
2022-11-22 20:01:31.976 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: B8:BC:5B:6A:B6:33 AdvertisementData(manufacturer_data={117: b'B\x04\x01\x80`\xb8\xbc[j\xb63\xba\xbc[j\xb62\x01\x00\x00\x00\x00\x00\x00'}, rssi=-87) connectable: True match: set() rssi: -87
2022-11-22 20:01:32.199 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: FA:BA:48:10:68:58 AdvertisementData(local_name='98E7820D9A2E3397E9', manufacturer_data={1447: b'\x05\x10\x01\x00\x00\x00\x00\x00\x00\x02"\x00\xca'}, service_uuids=['0000fe07-0000-1000-8000-00805f9b34fb'], rssi=-90) connectable: True match: set() rssi: -90
2022-11-22 20:01:32.200 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: A4:C1:38:04:CE:3E AdvertisementData(local_name='GVH5075_CE3E', manufacturer_data={60552: b'\x00\x03.\xadd\x00', 76: b'\x02\x15INTELLI_ROCKS_HWPu\xf2\xff\x0c'}, service_uuids=['0000ec88-0000-1000-8000-00805f9b34fb'], rssi=-31) connectable: True match: set() rssi: -31
2022-11-22 20:01:55.954 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 2.939978956943378
2022-11-22 20:01:56.664 DEBUG (MainThread) [homeassistant.components.bluetooth.manager] B8:27:EB:97:5A:3A: A4:C1:38:04:CE:3E AdvertisementData(local_name='GVH5075_CE3E', manufacturer_data={60552: b'\x00\x03.\xabd\x00', 76: b'\x02\x15INTELLI_ROCKS_HWPu\xf2\xff\x0c'}, service_uuids=['0000ec88-0000-1000-8000-00805f9b34fb'], rssi=-28) connectable: True match: set() rssi: -28
2022-11-22 20:02:25.955 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 21.089847221039236
2022-11-22 20:02:55.956 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 51.08962699002586
2022-11-22 20:03:25.957 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 81.0894036879763
2022-11-22 20:03:56.098 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 111.22917659510858
2022-11-22 20:03:56.098 INFO (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Bluetooth scanner has gone quiet for 90s, restarting
2022-11-22 20:03:56.099 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Stopping bluetooth discovery
2022-11-22 20:03:58.127 ERROR (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Error stopping scanner: [org.bluez.Error.InProgress] Operation already in progress
2022-11-22 20:03:58.132 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Starting bluetooth discovery attempt: (1/3)

Screenshot ist not related to the log snippet Screenshot 2022-11-22 185509

bdraco commented 1 year ago

2022-11-22 20:03:56.098 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Scanner watchdog time_since_last_detection: 111.22917659510858 2022-11-22 20:03:56.098 INFO (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Bluetooth scanner has gone quiet for 90s, restarting 2022-11-22 20:03:56.099 DEBUG (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Stopping bluetooth discovery 2022-11-22 20:03:58.127 ERROR (MainThread) [homeassistant.components.bluetooth.scanner] hci0 (B8:27:EB:97:5A:3A): Error stopping scanner: [org.bluez.Error.InProgress] Operation already in progress

Do you have another integration that is making exclusive use of the adapter?

issue-triage-workflows[bot] commented 1 year ago

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.

bjobo commented 1 year ago

I did not further try to use the bluetooth on the Raspberry. With a EPS32 bluetooth proxy it works flawless. Thanks anyway.