Louisvdw / dbus-serialbattery

Battery Monitor driver for serial battery in VenusOS GX systems
MIT License
534 stars 164 forks source link

JKBMS BLE - Not connecting #819

Closed itgenmar closed 8 months ago

itgenmar commented 1 year ago

Describe the problem

**Jk BMS : JK_bd4a24s4p

Serial number Hardware v11.XW SOFTWARE V11.25 POWER ON 13 TIMES TOTL TIMES 1D14H30M0S FIST ON DATE : 2023-04024 VERSION V4.15.7**

Getting the following error in the logs, no connection to venus os.

@40000000650f32362410d384
@40000000650f32362410db54 connect and scrape on address: 20:22:08:25:17:41
@40000000650f32362410eaf4 btloop
@40000000650f32362410eedc reconnect
@40000000650f32362410f6ac Exiting bt-loop
@40000000650f323634403e5c Missing device address argument
@40000000650f323737c83084 INFO:SerialBattery:Starting dbus-serialbattery
@40000000650f323737d7b914 INFO:SerialBattery:dbus-serialbattery v1.0.20230531
@40000000650f3238126df2ec INFO:SerialBattery:Init of Jkbms_Ble at 20:22:08:25:17:41
@40000000650f323812745f74 INFO:SerialBattery:Test of Jkbms_Ble at 20:22:08:25:17:41
@40000000650f324723e42dd4 ERROR:SerialBattery:ERROR >>> No battery connection at Jkbms_Ble
@40000000650f324723e7a874
@40000000650f324723e7b42c connect and scrape on address: 20:22:08:25:17:41
@40000000650f324723e7bfe4 btloop
@40000000650f324723e7c7b4 reconnect
@40000000650f324723e7cb9c Exiting bt-loop
@40000000650f324733b0a88c Missing device address argument
@40000000650f324837f02ecc INFO:SerialBattery:Starting dbus-serialbattery
@40000000650f324837fed0e4 INFO:SerialBattery:dbus-serialbattery v1.0.20230531
@40000000650f3249137efd5c INFO:SerialBattery:Init of Jkbms_Ble at 20:22:08:25:17:41
@40000000650f324913853b04 INFO:SerialBattery:Test of Jkbms_Ble at 20:22:08:25:17:41
@40000000650f325823de6d2c ERROR:SerialBattery:ERROR >>> No battery connection at Jkbms_Ble

Driver version

v1.0.20230531

Venus OS device type

Raspberry Pi

Venus OS version

latest

BMS type

JKBMS / Heltec BMS

Cell count

7

Connection type

Bluetooth

Config file

[DEFAULT]

; If you want to add custom values/settings, then check the values/settings you want to change in "config.default.ini"
; and insert them below to persist future driver updates.

; Example (remove the semicolon ";" to uncomment and activate the value/setting):
; MAX_BATTERY_CHARGE_CURRENT = 50.0
; MAX_BATTERY_DISCHARGE_CURRENT = 60.0

BLUETOOTH_BMS = Jkbms_Ble 20:22:08:25:17:41

BMS_TYPE = Jkbms

Relevant log output

@40000000650f32362410d384
@40000000650f32362410db54 connect and scrape on address: 20:22:08:25:17:41
@40000000650f32362410eaf4 btloop
@40000000650f32362410eedc reconnect
@40000000650f32362410f6ac Exiting bt-loop
@40000000650f323634403e5c Missing device address argument
@40000000650f323737c83084 INFO:SerialBattery:Starting dbus-serialbattery
@40000000650f323737d7b914 INFO:SerialBattery:dbus-serialbattery v1.0.20230531
@40000000650f3238126df2ec INFO:SerialBattery:Init of Jkbms_Ble at 20:22:08:25:17:41
@40000000650f323812745f74 INFO:SerialBattery:Test of Jkbms_Ble at 20:22:08:25:17:41
@40000000650f324723e42dd4 ERROR:SerialBattery:ERROR >>> No battery connection at Jkbms_Ble
@40000000650f324723e7a874

Any other information that may be helpful

No response

itgenmar commented 8 months ago

HI Manuel,

i made sure to disconnect all other devices, i have bought another raspberry pi and still doesn't work.

here are the logs from dbus-serial battery version: v1.1.20240128dev with Venus OS version 3.14. and attached Bluethootlctl logs

2024-02-16 12:14:35.776104500 INFO:Bluetooth details
2024-02-16 12:14:35.802350500 Attempting to disconnect from 20:22:08:25:17:41
2024-02-16 12:14:35.802356500 Successful disconnected
2024-02-16 12:14:40.847744500 Device 20:22:08:25:17:41 (public)
2024-02-16 12:14:40.847750500   Alias: JK_BD4A24S04
2024-02-16 12:14:40.847752500   Paired: no
2024-02-16 12:14:40.847754500   Trusted: yes
2024-02-16 12:14:40.847756500   Blocked: no
2024-02-16 12:14:40.847758500   Connected: no
2024-02-16 12:14:40.847759500   LegacyPairing: no
2024-02-16 12:14:40.847761500   RSSI: -52
2024-02-16 12:14:40.848721500
2024-02-16 12:14:42.689852500 INFO:SerialBattery:
2024-02-16 12:14:42.690264500 INFO:SerialBattery:Starting dbus-serialbattery
2024-02-16 12:14:42.691173500 INFO:SerialBattery:dbus-serialbattery v1.1.20240128dev
2024-02-16 12:14:43.173352500 INFO:SerialBattery:Init of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:14:43.173819500 INFO:SerialBattery:Test of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:14:43.177375500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1995792400 scraping thread: 1968174176
2024-02-16 12:14:43.180485500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:14:43.621520500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:14:43.622157500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:14:44.471306500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:14:46.660927500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:14:46.664185500 DEBUG:SerialBattery:scraping thread ended: reseting bluetooth and restarting
2024-02-16 12:14:46.664982500 INFO:SerialBattery:Reset of system Bluetooth daemon triggered
2024-02-16 12:14:46.795317500 [CHG] Device 20:22:08:25:17:41 RSSI: -52
2024-02-16 12:14:46.795324500 [CHG] Device 20:22:08:25:17:41 RSSI: -54
2024-02-16 12:14:46.795328500 [CHG] Device 20:22:08:25:17:41 RSSI is nil
2024-02-16 12:14:48.773704500 Starting bluetooth: bluetoothd.
2024-02-16 12:14:48.801741500 INFO:SerialBattery:System Bluetooth daemon should have been restarted
2024-02-16 12:14:50.805918500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1995792400 scraping thread: 1968174176
2024-02-16 12:14:50.807668500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:14:50.808463500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:14:50.808867500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:14:51.725389500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:14:53.675049500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:14:53.705640500 ERROR:SerialBattery:No BMS found at 20:22:08:25:17:41
2024-02-16 12:14:53.706201500 ERROR:SerialBattery:ERROR >>> No battery connection at Jkbms_Ble
2024-02-16 12:14:54.018067500
2024-02-16 12:14:54.018172500 INFO:Bluetooth details
2024-02-16 12:14:54.057696500 Attempting to disconnect from 20:22:08:25:17:41
2024-02-16 12:14:54.057702500 Successful disconnected
2024-02-16 12:14:59.107082500 Device 20:22:08:25:17:41 (public)
2024-02-16 12:14:59.107088500   Alias: JK_BD4A24S04
2024-02-16 12:14:59.107090500   Paired: no
2024-02-16 12:14:59.107092500   Trusted: yes
2024-02-16 12:14:59.107094500   Blocked: no
2024-02-16 12:14:59.107095500   Connected: no
2024-02-16 12:14:59.107097500   LegacyPairing: no
2024-02-16 12:14:59.107099500   RSSI: -51
2024-02-16 12:14:59.109409500
2024-02-16 12:15:00.310530500 INFO:SerialBattery:
2024-02-16 12:15:00.310944500 INFO:SerialBattery:Starting dbus-serialbattery
2024-02-16 12:15:00.311866500 INFO:SerialBattery:dbus-serialbattery v1.1.20240128dev
2024-02-16 12:15:00.705659500 INFO:SerialBattery:Init of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:15:00.706227500 INFO:SerialBattery:Test of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:15:00.710353500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1996455952 scraping thread: 1971319904
2024-02-16 12:15:00.713371500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:15:01.030024500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:15:01.030441500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:15:02.444238500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:15:04.695378500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:15:04.700729500 DEBUG:SerialBattery:scraping thread ended: reseting bluetooth and restarting
2024-02-16 12:15:04.700739500 INFO:SerialBattery:Reset of system Bluetooth daemon triggered
2024-02-16 12:15:04.827114500 [CHG] Device 20:22:08:25:17:41 RSSI: -51
2024-02-16 12:15:04.827120500 [CHG] Device 20:22:08:25:17:41 RSSI: -54
2024-02-16 12:15:04.827124500 [CHG] Device 20:22:08:25:17:41 RSSI is nil
2024-02-16 12:15:06.795482500 Starting bluetooth: bluetoothd.
2024-02-16 12:15:06.816425500 INFO:SerialBattery:System Bluetooth daemon should have been restarted
2024-02-16 12:15:08.820788500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1996455952 scraping thread: 1971319904
2024-02-16 12:15:08.822856500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:15:08.823777500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:15:08.824384500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:15:09.693192500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:15:11.694493500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:15:11.726837500 ERROR:SerialBattery:No BMS found at 20:22:08:25:17:41
2024-02-16 12:15:11.727349500 ERROR:SerialBattery:ERROR >>> No battery connection at Jkbms_Ble
2024-02-16 12:15:12.021105500
2024-02-16 12:15:12.021111500 INFO:Bluetooth details
2024-02-16 12:15:12.058186500 Attempting to disconnect from 20:22:08:25:17:41
2024-02-16 12:15:12.058191500 Successful disconnected
2024-02-16 12:15:17.115819500 Device 20:22:08:25:17:41 (public)
2024-02-16 12:15:17.115825500   Alias: JK_BD4A24S04
2024-02-16 12:15:17.115828500   Paired: no
2024-02-16 12:15:17.115829500   Trusted: yes
2024-02-16 12:15:17.115831500   Blocked: no
2024-02-16 12:15:17.115833500   Connected: no
2024-02-16 12:15:17.115835500   LegacyPairing: no
2024-02-16 12:15:17.115837500   RSSI: -51
2024-02-16 12:15:17.117106500
2024-02-16 12:15:18.286709500 INFO:SerialBattery:
2024-02-16 12:15:18.287362500 INFO:SerialBattery:Starting dbus-serialbattery
2024-02-16 12:15:18.288414500 INFO:SerialBattery:dbus-serialbattery v1.1.20240128dev
2024-02-16 12:15:18.675449500 INFO:SerialBattery:Init of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:15:18.676165500 INFO:SerialBattery:Test of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:15:18.680128500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1995812880 scraping thread: 1970271328
2024-02-16 12:15:18.682478500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:15:18.995031500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:15:18.995645500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:15:20.423946500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:15:22.685051500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:15:22.689953500 DEBUG:SerialBattery:scraping thread ended: reseting bluetooth and restarting
2024-02-16 12:15:22.690422500 INFO:SerialBattery:Reset of system Bluetooth daemon triggered
2024-02-16 12:15:22.796305500 [CHG] Device 20:22:08:25:17:41 RSSI: -51
2024-02-16 12:15:22.796313500 [CHG] Device 20:22:08:25:17:41 RSSI: -52
2024-02-16 12:15:22.796317500 [CHG] Device 20:22:08:25:17:41 RSSI is nil
2024-02-16 12:15:24.785675500 Starting bluetooth: bluetoothd.
2024-02-16 12:15:24.806992500 INFO:SerialBattery:System Bluetooth daemon should have been restarted
2024-02-16 12:15:26.811298500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1995812880 scraping thread: 1970271328
2024-02-16 12:15:26.813208500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:15:26.814012500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:15:26.814417500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:15:27.688664500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:15:29.689586500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:15:29.700635500 ERROR:SerialBattery:No BMS found at 20:22:08:25:17:41
2024-02-16 12:15:29.701097500 ERROR:SerialBattery:ERROR >>> No battery connection at Jkbms_Ble
2024-02-16 12:15:29.982358500
2024-02-16 12:15:29.982465500 INFO:Bluetooth details
2024-02-16 12:15:30.030227500 Attempting to disconnect from 20:22:08:25:17:41
2024-02-16 12:15:30.030235500 Successful disconnected
2024-02-16 12:15:35.080916500 Device 20:22:08:25:17:41 (public)
2024-02-16 12:15:35.080922500   Alias: JK_BD4A24S04
2024-02-16 12:15:35.080924500   Paired: no
2024-02-16 12:15:35.080926500   Trusted: yes
2024-02-16 12:15:35.080928500   Blocked: no
2024-02-16 12:15:35.080929500   Connected: no
2024-02-16 12:15:35.080931500   LegacyPairing: no
2024-02-16 12:15:35.080933500   RSSI: -51
2024-02-16 12:15:35.081864500
2024-02-16 12:15:36.284553500 INFO:SerialBattery:
2024-02-16 12:15:36.284966500 INFO:SerialBattery:Starting dbus-serialbattery
2024-02-16 12:15:36.285895500 INFO:SerialBattery:dbus-serialbattery v1.1.20240128dev
2024-02-16 12:15:36.671222500 INFO:SerialBattery:Init of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:15:36.671646500 INFO:SerialBattery:Test of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:15:36.676255500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1996013584 scraping thread: 1970271328
2024-02-16 12:15:36.678724500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:15:37.048793500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:15:37.049267500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:15:38.415632500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:15:40.673660500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:15:40.677058500 DEBUG:SerialBattery:scraping thread ended: reseting bluetooth and restarting
2024-02-16 12:15:40.677561500 INFO:SerialBattery:Reset of system Bluetooth daemon triggered
2024-02-16 12:15:40.839570500 [CHG] Device 20:22:08:25:17:41 RSSI: -51
2024-02-16 12:15:40.839578500 [CHG] Device 20:22:08:25:17:41 RSSI: -51
2024-02-16 12:15:40.839581500 [CHG] Device 20:22:08:25:17:41 RSSI is nil
2024-02-16 12:15:42.775755500 Starting bluetooth: bluetoothd.
2024-02-16 12:15:42.797831500 INFO:SerialBattery:System Bluetooth daemon should have been restarted
2024-02-16 12:15:44.802089500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1996013584 scraping thread: 1970271328
2024-02-16 12:15:44.803920500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:15:44.804749500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:15:44.805163500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:15:45.728724500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:15:47.681158500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:15:47.692699500 ERROR:SerialBattery:No BMS found at 20:22:08:25:17:41
2024-02-16 12:15:47.693572500 ERROR:SerialBattery:ERROR >>> No battery connection at Jkbms_Ble
2024-02-16 12:15:48.006614500
2024-02-16 12:15:48.006722500 INFO:Bluetooth details
2024-02-16 12:15:48.052022500 Attempting to disconnect from 20:22:08:25:17:41
2024-02-16 12:15:48.052027500 Successful disconnected
tail: /data/log/dbus-blebattery.0/current has been replaced; following end of new file
2024-02-16 12:15:53.117747500
2024-02-16 12:15:54.249960500 INFO:SerialBattery:
2024-02-16 12:15:54.250379500 INFO:SerialBattery:Starting dbus-serialbattery
2024-02-16 12:15:54.251306500 INFO:SerialBattery:dbus-serialbattery v1.1.20240128dev
2024-02-16 12:15:54.634199500 INFO:SerialBattery:Init of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:15:54.634633500 INFO:SerialBattery:Test of Jkbms_Ble at 20:22:08:25:17:41
2024-02-16 12:15:54.637883500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1995849744 scraping thread: 1970271328
2024-02-16 12:15:54.640528500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:15:54.941695500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:15:54.942130500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:15:56.461327500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:15:58.669486500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:15:58.673426500 DEBUG:SerialBattery:scraping thread ended: reseting bluetooth and restarting
2024-02-16 12:15:58.674009500 INFO:SerialBattery:Reset of system Bluetooth daemon triggered
2024-02-16 12:15:58.809151500 [CHG] Device 20:22:08:25:17:41 RSSI: -51
2024-02-16 12:15:58.809158500 [CHG] Device 20:22:08:25:17:41 RSSI: -54
2024-02-16 12:15:58.809162500 [CHG] Device 20:22:08:25:17:41 RSSI is nil
2024-02-16 12:16:00.777176500 Starting bluetooth: bluetoothd.
2024-02-16 12:16:00.802427500 INFO:SerialBattery:System Bluetooth daemon should have been restarted
2024-02-16 12:16:02.806713500 DEBUG:SerialBattery:scraping thread started -> main thread id: 1995849744 scraping thread: 1970271328
2024-02-16 12:16:02.808834500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): Connect and scrape on address: 20:22:08:25:17:41
2024-02-16 12:16:02.809779500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): btloop
2024-02-16 12:16:02.810309500 DEBUG:SerialBattery:--> asy_connect_and_scrape(): reconnect
2024-02-16 12:16:03.697904500 INFO:SerialBattery:--> asy_connect_and_scrape(): error while connecting to bt: BleakError('Characteristic with UUID 00002a24-0000-1000-8000-00805f9b34fb could not be found!') of type <class 'bleak.exc.BleakError'> in /opt/victronenergy/dbus-serialbattery/bms/jkbms_brn.py line #455
2024-02-16 12:16:05.701166500 INFO:SerialBattery:--> asy_connect_and_scrape(): Exit
2024-02-16 12:16:05.754829500 ERROR:SerialBattery:No BMS found at 20:22:08:25:17:41
2024-02-16 12:16:05.755308500 ERROR:SerialBattery:ERROR >>> No battery connection at Jkbms_Ble
2024-02-16 12:16:06.039079500
2024-02-16 12:16:06.039359500 INFO:Bluetooth details
2024-02-16 12:16:06.096313500 Attempting to disconnect from 20:22:08:25:17:41
2024-02-16 12:16:06.096320500 Successful disconnected

bluetoothctl both logs running in the same time

root@raspberrypi2:~# bluetoothctl
Agent registered
[CHG] Controller B8:27:EB:83:A6:83 Pairable: yes
[CHG] Controller B8:27:EB:83:A6:83 Powered: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
Agent unregistered
[DEL] Device 20:22:08:25:17:41 JK_BD4A24S04
[DEL] Controller B8:27:EB:83:A6:83 BlueZ 5.55 [default]
Agent registered
[bluetooth]# 
[CHG] Controller B8:27:EB:83:A6:83 Powered: yes
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -52
[CHG] Device 20:22:08:25:17:41 ManufacturerData Key: 0x4b4a
[CHG] Device 20:22:08:25:17:41 ManufacturerData Value:
  00 01                                            ..
[CHG] Device 20:22:08:25:17:41 AdvertisingFlags:
  06                                               .
[CHG] Device 20:22:08:25:17:41 RSSI: -54
[CHG] Device 20:22:08:25:17:41 Connected: yes
[NEW] Primary Service (Handle 0x5884)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Descriptor (Handle 0x4ae4)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Powered: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 RSSI is nil
Agent unregistered
[DEL] Characteristic (Handle 0x97b4)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Descriptor (Handle 0xe2bc)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[DEL] Characteristic (Handle 0x3cf0)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Primary Service (Handle 0x0020)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Device 20:22:08:25:17:41 JK_BD4A24S04
[DEL] Controller B8:27:EB:83:A6:83 BlueZ 5.55 [default]
Agent registered
[CHG] Controller B8:27:EB:83:A6:83 Powered: yes
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -54
[CHG] Device 20:22:08:25:17:41 ManufacturerData Key: 0x4b4a
[CHG] Device 20:22:08:25:17:41 ManufacturerData Value:
  00 01                                            ..
[CHG] Device 20:22:08:25:17:41 AdvertisingFlags:
  06                                               .
[CHG] Device 20:22:08:25:17:41 RSSI is nil
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 Connected: yes
[NEW] Primary Service (Handle 0x5884)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Descriptor (Handle 0x4e44)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -51
[CHG] Device 20:22:08:25:17:41 RSSI: -54
[CHG] Device 20:22:08:25:17:41 Connected: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Powered: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 RSSI is nil
Agent unregistered
[DEL] Characteristic (Handle 0xaed4)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Descriptor (Handle 0xe2bc)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[DEL] Characteristic (Handle 0x97e8)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Primary Service (Handle 0x0020)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Device 20:22:08:25:17:41 JK_BD4A24S04
[DEL] Controller B8:27:EB:83:A6:83 BlueZ 5.55 [default]
Agent registered
[CHG] Controller B8:27:EB:83:A6:83 Powered: yes
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -51
[CHG] Device 20:22:08:25:17:41 ManufacturerData Key: 0x4b4a
[CHG] Device 20:22:08:25:17:41 ManufacturerData Value:
  00 01                                            ..
[CHG] Device 20:22:08:25:17:41 AdvertisingFlags:
  06                                               .
[CHG] Device 20:22:08:25:17:41 RSSI is nil
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 Connected: yes
[NEW] Primary Service (Handle 0x5884)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Descriptor (Handle 0xc0a4)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -51
[CHG] Device 20:22:08:25:17:41 RSSI: -52
[CHG] Device 20:22:08:25:17:41 Connected: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Powered: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 RSSI is nil
Agent unregistered
[DEL] Characteristic (Handle 0x63b4)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Descriptor (Handle 0xe2bc)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[DEL] Characteristic (Handle 0xef40)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Primary Service (Handle 0x0020)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Device 20:22:08:25:17:41 JK_BD4A24S04
[DEL] Controller B8:27:EB:83:A6:83 BlueZ 5.55 [default]
Agent registered
[CHG] Controller B8:27:EB:83:A6:83 Powered: yes
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -50
[CHG] Device 20:22:08:25:17:41 ManufacturerData Key: 0x4b4a
[CHG] Device 20:22:08:25:17:41 ManufacturerData Value:
  00 01                                            ..
[CHG] Device 20:22:08:25:17:41 AdvertisingFlags:
  06                                               .
[CHG] Device 20:22:08:25:17:41 RSSI is nil
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 Connected: yes
[NEW] Primary Service (Handle 0x5884)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Descriptor (Handle 0xeddc)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -51
[CHG] Device 20:22:08:25:17:41 RSSI: -51
[CHG] Device 20:22:08:25:17:41 Connected: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Powered: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 RSSI is nil
Agent unregistered
[DEL] Characteristic (Handle 0x3cbc)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Descriptor (Handle 0xe2bc)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[DEL] Characteristic (Handle 0x63e8)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Primary Service (Handle 0x0020)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Device 20:22:08:25:17:41 JK_BD4A24S04
[DEL] Controller B8:27:EB:83:A6:83 BlueZ 5.55 [default]
Agent registered
[CHG] Controller B8:27:EB:83:A6:83 Powered: yes
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -51
[CHG] Device 20:22:08:25:17:41 ManufacturerData Key: 0x4b4a
[CHG] Device 20:22:08:25:17:41 ManufacturerData Value:
  00 01                                            ..
[CHG] Device 20:22:08:25:17:41 AdvertisingFlags:
  06                                               .
[CHG] Device 20:22:08:25:17:41 RSSI is nil
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 Connected: yes
[NEW] Primary Service (Handle 0x5884)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Descriptor (Handle 0xe6c4)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -51
[CHG] Device 20:22:08:25:17:41 RSSI: -54
[CHG] Device 20:22:08:25:17:41 Connected: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Powered: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 RSSI is nil
Agent unregistered
[DEL] Characteristic (Handle 0x9cdc)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Descriptor (Handle 0xe2bc)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[DEL] Characteristic (Handle 0xe300)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Primary Service (Handle 0x0020)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[DEL] Device 20:22:08:25:17:41 JK_BD4A24S04
[DEL] Controller B8:27:EB:83:A6:83 BlueZ 5.55 [default]
Agent registered
[CHG] Controller B8:27:EB:83:A6:83 Powered: yes
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -51
[CHG] Device 20:22:08:25:17:41 ManufacturerData Key: 0x4b4a
[CHG] Device 20:22:08:25:17:41 ManufacturerData Value:
  00 01                                            ..
[CHG] Device 20:22:08:25:17:41 AdvertisingFlags:
  06                                               .
[CHG] Device 20:22:08:25:17:41 RSSI is nil
[CHG] Controller B8:27:EB:83:A6:83 Discovering: no
[CHG] Device 20:22:08:25:17:41 Connected: yes
[NEW] Primary Service (Handle 0x5884)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001
        0000ffe0-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0002
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Characteristic (Handle 0x585c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004
        0000ffe1-0000-1000-8000-00805f9b34fb
        Unknown
[NEW] Descriptor (Handle 0xd73c)
        /org/bluez/hci0/dev_20_22_08_25_17_41/service0001/char0004/desc0006
        00002902-0000-1000-8000-00805f9b34fb
        Client Characteristic Configuration
[CHG] Device 20:22:08:25:17:41 ServicesResolved: yes
[CHG] Device 20:22:08:25:17:41 ServicesResolved: no
[CHG] Device 20:22:08:25:17:41 Connected: no
[CHG] Controller B8:27:EB:83:A6:83 Discovering: yes
[CHG] Device 20:22:08:25:17:41 RSSI: -52
mr-manuel commented 8 months ago

Could you write me on Discord?

mr-manuel commented 8 months ago

Fixed with v1.2.20240223dev.