batmon-ha icon indicating copy to clipboard operation
batmon-ha copied to clipboard

Paused command, have to cancel the command for it to go on.

Open djismgaming opened this issue 3 years ago • 7 comments

Hi,

I do have a bit of an issue which I found no other instance here.

I configured the standalone version on a 1GB RAM La Frite using Armbian 22.08.6 Jammy with Linux 5.10.147-meson64. Had to install bluez using apt-get install bluez before batmon-ha could use it.

Then executed all the standalone commands from https://github.com/fl4p/batmon-ha/blob/master/doc/Standalone.md

Also configured options.json like this. (Don't know why but the command seems to not read my options.json file inside the batmon-ha directory, as the standalone directions state so far. I read the log output and it was asking for it on /data/options.json):

ismael@lafrite:~/batmon-ha$ cat /data/options.json
{
  "devices": [
    {
      "address": "C8:47:8C:E8:4F:07",
      "type": "jk",
      "alias": "bateria-casa"
    },
    {
      "address": "DA:88:D3:60:A0:50",
      "type": "victron",
      "alias": "bateria-aires",
      "pin": "XXXXXX"
    }
  ],
  "mqtt_broker": "192.168.0.2",
  "mqtt_user": "user",
  "mqtt_password": "password",
  "concurrent_sampling": true,
  "keep_alive": false,
  "verbose_log": true,
  "sample_period": 10.0,
  "invert_current": true
}
ismael@lafrite:~/batmon-ha$

The command stays like this indefinitely (why I used the work "paused" 😄): INFO [sampling.py:41] connecting bms JKBt(C8:47:8C:E8:4F:07)

I have to manually cancel it with Ctrl+C for it to begin stopping it and actually reads the BMSs and sends the data to via MQTT to the Home Assistant OS VM.

Code clip in question:

INFO     [main.py:201] Fetching 1 BMS + 1 others concurrently, period=10.00s, keep_alive=False
INFO     [sampling.py:41] connecting bms JKBt(C8:47:8C:E8:4F:07)
^CINFO     [main.py:263] exit signal handler...
INFO     [jikong.py:114] normal connect failed, connecting with scanner
ERROR    [base_events.py:1744] Task exception was never retrieved

Full log of the command execution and cancellation with Ctrl+C while I wrote this issue entry. It was paused for a good 5 minutes until I executed the cancel hotkey:

 _            _____     _ _
| |    __ _  |  ___| __(_) |_ ___
| |   / _` | | |_ | '__| | __/ _ \
| |__| (_| | |  _|| |  | | ||  __/
|_____\__,_| |_|  |_|  |_|\__\___|

Welcome to Armbian 22.08.6 Jammy with Linux 5.10.147-meson64

System load:   2%               Up time:       9:27
Memory usage:  22% of 926M      IP:            172.17.0.1 192.168.0.15
CPU temp:      45°C             Usage of /:    4% of 56G
RX today:      29.1 MiB

[ 0 security updates available, 1 updates total: apt upgrade ]
Last check: 2022-11-08 00:16

Last login: Tue Nov  8 00:16:47 2022 from 192.168.0.11
ismael@lafrite:~$ cd batmon-ha/
ismael@lafrite:~/batmon-ha$ python3 main.py
INFO     [main.py:68] BT Discovery:
INFO     [main.py:73] BT Device   bateria-casa   address=C8:47:8C:E8:4F:07
INFO     [main.py:73] BT Device   bateria-aires   address=DA:88:D3:60:A0:50
INFO     [main.py:73] BT Device   02-5D-39-58-42-5E   address=02:5D:39:58:42:5E
INFO     [main.py:73] BT Device   47-2F-1B-4C-56-42   address=47:2F:1B:4C:56:42
INFO     [main.py:73] BT Device   4A-B3-ED-39-9A-8F   address=4A:B3:ED:39:9A:8F
INFO     [main.py:73] BT Device   Core400s   address=78:E3:6D:AE:8E:FE
INFO     [main.py:136] Verbose logging enabled
INFO     [victron.py:63] Connecting None to pair
ERROR    [main.py:172] Error pairing victron device: Device with address None was not found.
INFO     [main.py:178] connecting mqtt [email protected]
INFO     [main.py:201] Fetching 1 BMS + 1 others concurrently, period=10.00s, keep_alive=False
INFO     [sampling.py:41] connecting bms JKBt(C8:47:8C:E8:4F:07)
^CINFO     [main.py:263] exit signal handler...
INFO     [jikong.py:114] normal connect failed, connecting with scanner
ERROR    [base_events.py:1744] Task exception was never retrieved
future: <Task finished name='Task-2' coro=<PairingAgentBlueZDBus.register() done, defined at /home/ismael/.local/lib/python3.10/site-packages/bleak/backends/bluezdbus/agent.py:72> exception=BrokenPipeError(32, 'Broken pipe')>
Traceback (most recent call last):
  File "/home/ismael/.local/lib/python3.10/site-packages/bleak/backends/bluezdbus/agent.py", line 85, in register
    bus = await MessageBus(bus_type=BusType.SYSTEM).connect()
  File "/home/ismael/.local/lib/python3.10/site-packages/dbus_next/aio/message_bus.py", line 149, in connect
    await self._authenticate()
  File "/home/ismael/.local/lib/python3.10/site-packages/dbus_next/aio/message_bus.py", line 392, in _authenticate
    await self._loop.sock_sendall(self._sock, Authenticator._format_line(response))
  File "/usr/lib/python3.10/asyncio/selector_events.py", line 441, in sock_sendall
    n = sock.send(data)
BrokenPipeError: [Errno 32] Broken pipe
INFO     [sampling.py:47] connected bms JKBt(C8:47:8C:E8:4F:07)!
INFO     [sampling.py:64] bateria-casa subscribing for {'charge': True, 'discharge': True} switch change
INFO     [mqtt_util.py:297] subscribe homeassistant/switch/bateria-casa/charge/set
INFO     [mqtt_util.py:297] subscribe homeassistant/switch/bateria-casa/discharge/set
INFO     [sampling.py:68] bateria-casa result@2022-11-08T09:57:06.224081 BmsSample(U=54.7V,I=45.06A,P=2467W,q=279.8Ah/380.0,mos=35.3°C)
INFO     [sampling.py:75] bateria-casa volt=3426,3420,3422,3423,3425,3420,3417,3425,3417,3421,3418,3422,3421,3420,3420,3425 temp=[28.7, 28.5]
INFO     [sampling.py:100] JKBt(C8:47:8C:E8:4F:07) times: connect=814.19s fetch=0.62s
INFO     [victron.py:63] Connecting DA:88:D3:60:A0:50 to pair
INFO     [main.py:249] Shutting down ...
INFO     [main.py:254] Disconnecting JKBt(C8:47:8C:E8:4F:07)
INFO     [main.py:263] exit signal handler...
ismael@lafrite:~/batmon-ha$

By the way, I always see this in the output althoug you see victron is configured with a valid address in the options.json: ERROR [main.py:172] Error pairing victron device: Device with address None was not found.

djismgaming avatar Nov 08 '22 14:11 djismgaming

I'll try removing victron and just leaving the jk bms, just in case.

djismgaming avatar Nov 08 '22 14:11 djismgaming

New options.json:

ismael@lafrite:~/batmon-ha$ cat /data/options.json
{
  "devices": [
    {
      "address": "C8:47:8C:E8:4F:07",
      "type": "jk",
      "alias": "bateria-casa"
    }
  ],
  "mqtt_broker": "192.168.0.2",
  "mqtt_user": "user",
  "mqtt_password": "password",
  "concurrent_sampling": true,
  "keep_alive": false,
  "verbose_log": true,
  "sample_period": 10.0,
  "invert_current": true
}
ismael@lafrite:~/batmon-ha$

Tried with just the jk bms but same result? Though the command now showed DEBUG log lines.

After a lot of these DEBUG lines, I cancelled the command:

DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
^CINFO     [main.py:263] exit signal handler...
INFO     [jikong.py:114] normal connect failed, connecting with scanner
DEBUG    [bt.py:27] starting scan

Full log output:

ismael@lafrite:~/batmon-ha$ python3 main.py
INFO     [main.py:68] BT Discovery:
INFO     [main.py:73] BT Device   bateria-casa   address=C8:47:8C:E8:4F:07
INFO     [main.py:73] BT Device   FA-5E-90-A3-2E-C7   address=FA:5E:90:A3:2E:C7
INFO     [main.py:73] BT Device   bateria-aires   address=DA:88:D3:60:A0:50
INFO     [main.py:73] BT Device   1F-70-20-26-1A-E8   address=1F:70:20:26:1A:E8
INFO     [main.py:73] BT Device   4F-A6-24-06-1D-52   address=4F:A6:24:06:1D:52
INFO     [main.py:73] BT Device   54-AC-1F-F6-88-32   address=54:AC:1F:F6:88:32
INFO     [main.py:73] BT Device   F3-36-C7-1E-F2-29   address=F3:36:C7:1E:F2:29
INFO     [main.py:73] BT Device   Core400s   address=78:E3:6D:AE:8E:FE
INFO     [main.py:136] Verbose logging enabled
INFO     [main.py:178] connecting mqtt [email protected]
DEBUG    [client.py:2529] Sending CONNECT (u1, p1, wr0, wq0, wf0, c1, k60) client_id=b''
INFO     [main.py:201] Fetching 1 BMS + 0 others concurrently, period=10.00s, keep_alive=False
INFO     [sampling.py:41] connecting bms JKBt(C8:47:8C:E8:4F:07)
DEBUG    [client.py:181] Connecting to device @ C8:47:8C:E8:4F:07 with hci0
DEBUG    [client.py:2529] Received CONNACK (0, 0)
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
DEBUG    [client.py:2529] Sending PINGREQ
DEBUG    [client.py:2529] Received PINGRESP
^CINFO     [main.py:263] exit signal handler...
INFO     [jikong.py:114] normal connect failed, connecting with scanner
DEBUG    [bt.py:27] starting scan
DEBUG    [scanner.py:132] cached devices: {'/org/bluez/hci0/dev_DA_88_D3_60_A0_50': {'Address': 'DA:88:D3:60:A0:50', 'AddressType': 'random', 'Name': 'bateria-aires', 'Alias': 'bateria-aires', 'Paired': True, 'Trusted': True, 'Blocked': False, 'LegacyPairing': False, 'Connected': False, 'UUIDs': ['00001800-0000-1000-8000-00805f9b34fb', '00001801-0000-1000-8000-00805f9b34fb', '306b0001-b081-4037-83dc-e59fcc3cdfd0', '65970000-4bda-4c1e-af4b-551c4cf74769', '68c10001-b17f-4d3a-a290-34ad6499937c', '97580001-ddf1-48be-b73e-182664615d8e'], 'Adapter': '/org/bluez/hci0', 'ManufacturerData': {737: b'\x10\x02\x89\xa3\x02{\x8f]\xe0\x0bm\xfa\xccF\xed\x8e\xef\x1a/\xc72G\x86'}, 'ServicesResolved': False}}
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0): ['org.bluez.Adapter1', {'Discovering': <dbus_next.signature.Variant ('b', True)>}, []]
DEBUG    [client.py:507] Disconnecting (None)
DEBUG    [client.py:513] already disconnected (None)
DEBUG    [bt.py:43] retry after error Device C8:47:8C:E8:4F:07 not discovered (set())
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_DA_88_D3_60_A0_50): ['org.bluez.Device1', {'RSSI': <dbus_next.signature.Variant ('n', -79)>, 'ManufacturerData': <dbus_next.signature.Variant ('a{qv}', {737: <dbus_next.signature.Variant ('ay', b'\x10\x02\x89\xa3\x02%\x93]\xaa\xbd\x88!\xc6:\x05O\xad\x87\x99\x94\x16(~')>})>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.Device1': {'Address': <dbus_next.signature.Variant ('s', C8:47:8C:E8:4F:07)>, 'AddressType': <dbus_next.signature.Variant ('s', public)>, 'Name': <dbus_next.signature.Variant ('s', bateria-casa)>, 'Alias': <dbus_next.signature.Variant ('s', bateria-casa)>, 'Paired': <dbus_next.signature.Variant ('b', False)>, 'Trusted': <dbus_next.signature.Variant ('b', False)>, 'Blocked': <dbus_next.signature.Variant ('b', False)>, 'LegacyPairing': <dbus_next.signature.Variant ('b', False)>, 'RSSI': <dbus_next.signature.Variant ('n', -83)>, 'Connected': <dbus_next.signature.Variant ('b', False)>, 'UUIDs': <dbus_next.signature.Variant ('as', ['0000ffe0-0000-1000-8000-00805f9b34fb', '0000fee7-0000-1000-8000-00805f9b34fb'])>, 'Adapter': <dbus_next.signature.Variant ('o', /org/bluez/hci0)>, 'ManufacturerData': <dbus_next.signature.Variant ('a{qv}', {2917: <dbus_next.signature.Variant ('ay', b'\x88\xa0\xc8G\x8c\xe8O\x07')>})>, 'ServicesResolved': <dbus_next.signature.Variant ('b', False)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_DA_88_D3_60_A0_50): ['org.bluez.Device1', {'RSSI': <dbus_next.signature.Variant ('n', -80)>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'RSSI': <dbus_next.signature.Variant ('n', -77)>}, []]
DEBUG    [bt.py:37] connect attempt 2
DEBUG    [client.py:181] Connecting to device @ C8:47:8C:E8:4F:07 with hci0
DEBUG    [scanner.py:132] cached devices: {'/org/bluez/hci0/dev_C8_47_8C_E8_4F_07': {'Address': 'C8:47:8C:E8:4F:07', 'AddressType': 'public', 'Name': 'bateria-casa', 'Alias': 'bateria-casa', 'Paired': False, 'Trusted': False, 'Blocked': False, 'LegacyPairing': False, 'RSSI': -77, 'Connected': False, 'UUIDs': ['0000ffe0-0000-1000-8000-00805f9b34fb', '0000fee7-0000-1000-8000-00805f9b34fb'], 'Adapter': '/org/bluez/hci0', 'ManufacturerData': {2917: b'\x88\xa0\xc8G\x8c\xe8O\x07'}, 'ServicesResolved': False}, '/org/bluez/hci0/dev_DA_88_D3_60_A0_50': {'Address': 'DA:88:D3:60:A0:50', 'AddressType': 'random', 'Name': 'bateria-aires', 'Alias': 'bateria-aires', 'Paired': True, 'Trusted': True, 'Blocked': False, 'LegacyPairing': False, 'RSSI': -80, 'Connected': False, 'UUIDs': ['00001800-0000-1000-8000-00805f9b34fb', '00001801-0000-1000-8000-00805f9b34fb', '306b0001-b081-4037-83dc-e59fcc3cdfd0', '65970000-4bda-4c1e-af4b-551c4cf74769', '68c10001-b17f-4d3a-a290-34ad6499937c', '97580001-ddf1-48be-b73e-182664615d8e'], 'Adapter': '/org/bluez/hci0', 'ManufacturerData': {737: b'\x10\x02\x89\xa3\x02%\x93]\xaa\xbd\x88!\xc6:\x05O\xad\x87\x99\x94\x16(~'}, 'ServicesResolved': False}}
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_DA_88_D3_60_A0_50): ['org.bluez.Device1', {'RSSI': <dbus_next.signature.Variant ('n', -84)>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'RSSI': <dbus_next.signature.Variant ('n', -77)>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_DA_88_D3_60_A0_50): ['org.bluez.Device1', {'RSSI': <dbus_next.signature.Variant ('n', -84)>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'RSSI': <dbus_next.signature.Variant ('n', -77)>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0): ['org.bluez.Adapter1', {'Discovering': <dbus_next.signature.Variant ('b', False)>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'Connected': <dbus_next.signature.Variant ('b', True)>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'Connected': <dbus_next.signature.Variant ('b', True)>}, []]
DEBUG    [client.py:387] Connection successful (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07)
DEBUG    [client.py:734] Waiting for ServicesResolved (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07)
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', 00001801-0000-1000-8000-00805f9b34fb)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a/char000b', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a05-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['read', 'indicate'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a/char000b/desc000d', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a/char000b)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', 0000ffe0-0000-1000-8000-00805f9b34fb)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char000f', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 0000ffe2-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['write-without-response'])>, 'WriteAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 0000ffe1-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['write-without-response', 'write', 'notify'])>, 'WriteAcquired': <dbus_next.signature.Variant ('b', False)>, 'NotifyAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011/desc0013', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', 0000180a-0000-1000-8000-00805f9b34fb)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0015', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a29-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0017', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a24-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0019', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a25-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char001b', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a27-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char001d', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a26-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char001f', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a28-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0021', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a23-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0023', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a2a-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0025', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a50-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', 0000180f-0000-1000-8000-00805f9b34fb)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027/char0028', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a19-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['read', 'notify'])>, 'NotifyAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027/char0028/desc002a', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027/char0028)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', f000ffc0-0451-4000-b000-000000000000)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', f000ffc1-0451-4000-b000-000000000000)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['write-without-response', 'write', 'notify'])>, 'WriteAcquired': <dbus_next.signature.Variant ('b', False)>, 'NotifyAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c/desc002e', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c/desc002f', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002901-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', f000ffc2-0451-4000-b000-000000000000)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['write-without-response', 'write', 'notify'])>, 'WriteAcquired': <dbus_next.signature.Variant ('b', False)>, 'NotifyAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030/desc0032', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030/desc0033', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002901-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'UUIDs': <dbus_next.signature.Variant ('as', ['00001800-0000-1000-8000-00805f9b34fb', '00001801-0000-1000-8000-00805f9b34fb', '0000180a-0000-1000-8000-00805f9b34fb', '0000180f-0000-1000-8000-00805f9b34fb', '0000ffe0-0000-1000-8000-00805f9b34fb', 'f000ffc0-0451-4000-b000-000000000000'])>, 'ServicesResolved': <dbus_next.signature.Variant ('b', True)>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', 00001801-0000-1000-8000-00805f9b34fb)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a/char000b', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a05-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['read', 'indicate'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a/char000b/desc000d', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000a/char000b)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', 0000ffe0-0000-1000-8000-00805f9b34fb)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char000f', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 0000ffe2-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['write-without-response'])>, 'WriteAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 0000ffe1-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['write-without-response', 'write', 'notify'])>, 'WriteAcquired': <dbus_next.signature.Variant ('b', False)>, 'NotifyAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011/desc0013', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', 0000180a-0000-1000-8000-00805f9b34fb)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0015', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a29-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0017', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a24-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0019', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a25-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char001b', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a27-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char001d', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a26-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char001f', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a28-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0021', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a23-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0023', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a2a-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014/char0025', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a50-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0014)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Flags': <dbus_next.signature.Variant ('as', ['read'])>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', 0000180f-0000-1000-8000-00805f9b34fb)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027/char0028', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', 00002a19-0000-1000-8000-00805f9b34fb)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['read', 'notify'])>, 'NotifyAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027/char0028/desc002a', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service0027/char0028)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattService1': {'UUID': <dbus_next.signature.Variant ('s', f000ffc0-0451-4000-b000-000000000000)>, 'Device': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07)>, 'Primary': <dbus_next.signature.Variant ('b', True)>, 'Includes': <dbus_next.signature.Variant ('ao', [])>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', f000ffc1-0451-4000-b000-000000000000)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['write-without-response', 'write', 'notify'])>, 'WriteAcquired': <dbus_next.signature.Variant ('b', False)>, 'NotifyAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c/desc002e', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c/desc002f', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002901-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char002c)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattCharacteristic1': {'UUID': <dbus_next.signature.Variant ('s', f000ffc2-0451-4000-b000-000000000000)>, 'Service': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>, 'Notifying': <dbus_next.signature.Variant ('b', False)>, 'Flags': <dbus_next.signature.Variant ('as', ['write-without-response', 'write', 'notify'])>, 'WriteAcquired': <dbus_next.signature.Variant ('b', False)>, 'NotifyAcquired': <dbus_next.signature.Variant ('b', False)>, 'MTU': <dbus_next.signature.Variant ('q', 131)>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030/desc0032', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002902-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030/desc0033', {'org.freedesktop.DBus.Introspectable': {}, 'org.bluez.GattDescriptor1': {'UUID': <dbus_next.signature.Variant ('s', 00002901-0000-1000-8000-00805f9b34fb)>, 'Characteristic': <dbus_next.signature.Variant ('o', /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service002b/char0030)>, 'Value': <dbus_next.signature.Variant ('ay', b'')>}, 'org.freedesktop.DBus.Properties': {}}]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'UUIDs': <dbus_next.signature.Variant ('as', ['00001800-0000-1000-8000-00805f9b34fb', '00001801-0000-1000-8000-00805f9b34fb', '0000180a-0000-1000-8000-00805f9b34fb', '0000180f-0000-1000-8000-00805f9b34fb', '0000ffe0-0000-1000-8000-00805f9b34fb', 'f000ffc0-0451-4000-b000-000000000000'])>, 'ServicesResolved': <dbus_next.signature.Variant ('b', True)>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'Modalias': <dbus_next.signature.Variant ('s', usb:v045Ep0040d0300)>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'Modalias': <dbus_next.signature.Variant ('s', usb:v045Ep0040d0300)>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Notifying': <dbus_next.signature.Variant ('b', True)>}, []]
DEBUG    [jikong.py:136] write b'\xaaU\x90\xeb\x97\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x11'
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Notifying': <dbus_next.signature.Variant ('b', True)>}, []]
DEBUG    [client.py:967] Write Characteristic 0000ffe1-0000-1000-8000-00805f9b34fb | /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011: b'\xaaU\x90\xeb\x97\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x11'
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded (/): ['/org/bluez/hci0/dev_C8_47_8C_E8_4F_07', {'org.bluez.Battery1': {'Percentage': <dbus_next.signature.Variant ('y', 0)>}}]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x03\xc6JK-B2A20S20P\x00\x00\x00\x0010.XW\x00\x00\x0010.10\x00\x00\x00\x88\xc2\x00\x00\x02\x00\x00\x00bateria-casa\x00\x00\x00\x001234\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00221107\x00\x002082309650\x000000\x00Input Userdata\x00\x00123456\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:72] header, clear buf bytearray(b'')
DEBUG    [jikong.py:77] bms msg(128) (buf128): 55 aa eb 90 3 c6 4a 4b 2d 42 32 41 32 30 53 32 30 50 0 0 0 0 31 30 2e 58 57 0 0 0 31 30 2e 31 30 0 0 0 88 c2 0 0 2 0 0 0 62 61 74 65 72 69 61 2d 63 61 73 61 0 0 0 0 31 32 33 34 0 0 0 0 0 0 0 0 0 0 0 0 32 32 31 31 30 37 0 0 32 30 38 32 33 30 39 36 35 30 0 30 30 30 30 0 49 6e 70 75 74 20 55 73 65 72 64 61 74 61 0 0 31 32 33 34 35 36 0 0 0 0

DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x03\xc6JK-B2A20S20P\x00\x00\x00\x0010.XW\x00\x00\x0010.10\x00\x00\x00\x88\xc2\x00\x00\x02\x00\x00\x00bateria-casa\x00\x00\x00\x001234\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00221107\x00\x002082309650\x000000\x00Input Userdata\x00\x00123456\x00\x00\x00\x00')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf150): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(128) (buf278): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0

DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x90')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf300): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 90

DEBUG    [jikong.py:99] got response 3 (len300)
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x90')>}, []]
DEBUG    [jikong.py:136] write b'\xaaU\x90\xeb\x96\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x10'
DEBUG    [client.py:967] Write Characteristic 0000ffe1-0000-1000-8000-00805f9b34fb | /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011: b'\xaaU\x90\xeb\x96\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x10'
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')>}, []]
DEBUG    [jikong.py:77] bms msg(20) (buf20): aa 55 90 eb c8 1 1 0 0 0 0 0 0 0 0 0 0 0 0 44

DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x01\xc6X\x02\x00\x00(\n\x00\x00Z\n\x00\x00\x10\x0e\x00\x00\xde\r\x00\x00\n\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xc4\t\x00\x00\xf0I\x02\x00\x1e\x00\x00\x00<\x00\x00\x00@\r\x03\x00,\x01\x00\x00<\x00\x00\x00<\x00\x00\x00\xd0\x07\x00\x00\xbc\x02\x00\x00X\x02\x00\x00\xbc\x02\x00\x00X\x02\x00\x008\xff\xff\xff\x9c\xff\xff\xff\x84\x03\x00\x00\xbc\x02\x00\x00\x10\x00\x00\x00\x01\x00\x00\x00\x01\x00\x00\x00\x01\x00')>}, []]
DEBUG    [jikong.py:72] header, clear buf bytearray(b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')
DEBUG    [jikong.py:77] bms msg(128) (buf128): 55 aa eb 90 1 c6 58 2 0 0 28 a 0 0 5a a 0 0 10 e 0 0 de d 0 0 a 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 c4 9 0 0 f0 49 2 0 1e 0 0 0 3c 0 0 0 40 d 3 0 2c 1 0 0 3c 0 0 0 3c 0 0 0 d0 7 0 0 bc 2 0 0 58 2 0 0 bc 2 0 0 58 2 0 0 38 ff ff ff 9c ff ff ff 84 3 0 0 bc 2 0 0 10 0 0 0 1 0 0 0 1 0 0 0 1 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00`\xcc\x05\x00\xdc\x05\x00\x00\xb8\x0b\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf150): 0 0 60 cc 5 0 dc 5 0 0 b8 b 0 0 0 0 0 0 0 0 0 0

DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x01\xc6X\x02\x00\x00(\n\x00\x00Z\n\x00\x00\x10\x0e\x00\x00\xde\r\x00\x00\n\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xc4\t\x00\x00\xf0I\x02\x00\x1e\x00\x00\x00<\x00\x00\x00@\r\x03\x00,\x01\x00\x00<\x00\x00\x00<\x00\x00\x00\xd0\x07\x00\x00\xbc\x02\x00\x00X\x02\x00\x00\xbc\x02\x00\x00X\x02\x00\x008\xff\xff\xff\x9c\xff\xff\xff\x84\x03\x00\x00\xbc\x02\x00\x00\x10\x00\x00\x00\x01\x00\x00\x00\x01\x00\x00\x00\x01\x00')>}, []]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00`\xcc\x05\x00\xdc\x05\x00\x00\xb8\x0b\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(128) (buf278): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0

DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x9d')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf300): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 9d

DEBUG    [jikong.py:99] got response 1 (len300)
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x9d')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')>}, []]
DEBUG    [jikong.py:77] bms msg(20) (buf20): aa 55 90 eb c8 1 1 0 0 0 0 0 0 0 0 0 0 0 0 44

DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x02\xc66\r8\r4\r7\r2\r7\r2\r6\r5\r8\r6\r8\r6\r5\r<\r6\r\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\x00\x006\r\x07\x00\x0e\x001\x002\x001\x002\x001\x002\x001\x002\x001\x001\x001\x001\x001\x002\x001\x000\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00[\xd3\x00\x00D\x02\x0f\x00\x86H')>}, []]
DEBUG    [jikong.py:72] header, clear buf bytearray(b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')
DEBUG    [jikong.py:77] bms msg(128) (buf128): 55 aa eb 90 2 c6 36 d 38 d 34 d 37 d 32 d 37 d 32 d 36 d 35 d 38 d 36 d 38 d 36 d 35 d 3c d 36 d 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ff ff 0 0 36 d 7 0 e 0 31 0 32 0 31 0 32 0 31 0 32 0 31 0 32 0 31 0 31 0 31 0 31 0 31 0 32 0 31 0 30 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 5b d3 0 0 44 2 f 0 86 48

DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x02\xc66\r8\r4\r7\r2\r7\r2\r6\r5\r8\r6\r8\r6\r5\r<\r6\r\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\x00\x006\r\x07\x00\x0e\x001\x002\x001\x002\x001\x002\x001\x002\x001\x001\x001\x001\x001\x002\x001\x000\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00[\xd3\x00\x00D\x02\x0f\x00\x86H')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b"\x00\x00'\x01!\x01Y\x01\x00\x00\x00\x00\x00M\x8e\x82\x04\x00`\xcc\x05\x00")>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf150): 0 0 27 1 21 1 59 1 0 0 0 0 0 4d 8e 82 4 0 60 cc 5 0

DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b"\x00\x00'\x01!\x01Y\x01\x00\x00\x00\x00\x00M\x8e\x82\x04\x00`\xcc\x05\x00")>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\xd9\x1f\x00\x00d\x00-\n\x14\xc3\x00\x00\x01\x01I\x06\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x07\x00\x01\x00\x00\x00\xc7\x03`\x00\x00\x00\xf2|=@\x00\x00\x00\x00\xe2\x04\x00\x00\x00\x00\x00\x01\x00\x05\x00\x00\xa2\x9e\x07\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(128) (buf278): 0 0 0 0 d9 1f 0 0 64 0 2d a 14 c3 0 0 1 1 49 6 0 0 0 0 0 0 0 0 0 0 0 0 7 0 1 0 0 0 c7 3 60 0 0 0 f2 7c 3d 40 0 0 0 0 e2 4 0 0 0 0 0 1 0 5 0 0 a2 9e 7 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0

DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\xd9\x1f\x00\x00d\x00-\n\x14\xc3\x00\x00\x01\x01I\x06\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x07\x00\x01\x00\x00\x00\xc7\x03`\x00\x00\x00\xf2|=@\x00\x00\x00\x00\xe2\x04\x00\x00\x00\x00\x00\x01\x00\x05\x00\x00\xa2\x9e\x07\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00p')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf300): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 70

DEBUG    [jikong.py:99] got response 2 (len300)
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00p')>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {}, ['RSSI']]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {}, ['RSSI']]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_DA_88_D3_60_A0_50): ['org.bluez.Device1', {}, ['RSSI']]
DEBUG    [scanner.py:282] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0): ['org.bluez.Adapter1', {'Discovering': <dbus_next.signature.Variant ('b', False)>}, []]
DEBUG    [jikong.py:136] write b'\xaaU\x90\xeb\x97\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x11'
DEBUG    [client.py:967] Write Characteristic 0000ffe1-0000-1000-8000-00805f9b34fb | /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011: b'\xaaU\x90\xeb\x97\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x11'
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x03\xc7JK-B2A20S20P\x00\x00\x00\x0010.XW\x00\x00\x0010.10\x00\x00\x00\x88\xc2\x00\x00\x02\x00\x00\x00bateria-casa\x00\x00\x00\x001234\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00221107\x00\x002082309650\x000000\x00Input Userdata\x00\x00123456\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:72] header, clear buf bytearray(b'')
DEBUG    [jikong.py:77] bms msg(128) (buf128): 55 aa eb 90 3 c7 4a 4b 2d 42 32 41 32 30 53 32 30 50 0 0 0 0 31 30 2e 58 57 0 0 0 31 30 2e 31 30 0 0 0 88 c2 0 0 2 0 0 0 62 61 74 65 72 69 61 2d 63 61 73 61 0 0 0 0 31 32 33 34 0 0 0 0 0 0 0 0 0 0 0 0 32 32 31 31 30 37 0 0 32 30 38 32 33 30 39 36 35 30 0 30 30 30 30 0 49 6e 70 75 74 20 55 73 65 72 64 61 74 61 0 0 31 32 33 34 35 36 0 0 0 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf150): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(128) (buf278): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x91')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf300): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 91

DEBUG    [jikong.py:99] got response 3 (len300)
DEBUG    [jikong.py:136] write b'\xaaU\x90\xeb\x96\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x10'
DEBUG    [client.py:967] Write Characteristic 0000ffe1-0000-1000-8000-00805f9b34fb | /org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011: b'\xaaU\x90\xeb\x96\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x10'
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')>}, []]
DEBUG    [jikong.py:77] bms msg(20) (buf20): aa 55 90 eb c8 1 1 0 0 0 0 0 0 0 0 0 0 0 0 44

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x01\xc7X\x02\x00\x00(\n\x00\x00Z\n\x00\x00\x10\x0e\x00\x00\xde\r\x00\x00\n\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xc4\t\x00\x00\xf0I\x02\x00\x1e\x00\x00\x00<\x00\x00\x00@\r\x03\x00,\x01\x00\x00<\x00\x00\x00<\x00\x00\x00\xd0\x07\x00\x00\xbc\x02\x00\x00X\x02\x00\x00\xbc\x02\x00\x00X\x02\x00\x008\xff\xff\xff\x9c\xff\xff\xff\x84\x03\x00\x00\xbc\x02\x00\x00\x10\x00\x00\x00\x01\x00\x00\x00\x01\x00\x00\x00\x01\x00')>}, []]
DEBUG    [jikong.py:72] header, clear buf bytearray(b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')
DEBUG    [jikong.py:77] bms msg(128) (buf128): 55 aa eb 90 1 c7 58 2 0 0 28 a 0 0 5a a 0 0 10 e 0 0 de d 0 0 a 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 c4 9 0 0 f0 49 2 0 1e 0 0 0 3c 0 0 0 40 d 3 0 2c 1 0 0 3c 0 0 0 3c 0 0 0 d0 7 0 0 bc 2 0 0 58 2 0 0 bc 2 0 0 58 2 0 0 38 ff ff ff 9c ff ff ff 84 3 0 0 bc 2 0 0 10 0 0 0 1 0 0 0 1 0 0 0 1 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00`\xcc\x05\x00\xdc\x05\x00\x00\xb8\x0b\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf150): 0 0 60 cc 5 0 dc 5 0 0 b8 b 0 0 0 0 0 0 0 0 0 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(128) (buf278): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x9e')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf300): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 9e

DEBUG    [jikong.py:99] got response 1 (len300)
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')>}, []]
DEBUG    [jikong.py:77] bms msg(20) (buf20): aa 55 90 eb c8 1 1 0 0 0 0 0 0 0 0 0 0 0 0 44

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x02\xc7<\r4\r;\r7\r8\r8\r4\r8\r6\r<\r5\r<\r2\r8\r8\r:\r\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\x00\x008\r\x07\x00\x0e\x001\x002\x001\x002\x001\x002\x001\x002\x001\x001\x001\x001\x001\x002\x001\x000\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x7f\xd3\x00\x00\x9dV\x0f\x00\x86H')>}, []]
DEBUG    [jikong.py:72] header, clear buf bytearray(b'\xaaU\x90\xeb\xc8\x01\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00D')
DEBUG    [jikong.py:77] bms msg(128) (buf128): 55 aa eb 90 2 c7 3c d 34 d 3b d 37 d 38 d 38 d 34 d 38 d 36 d 3c d 35 d 3c d 32 d 38 d 38 d 3a d 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ff ff 0 0 38 d 7 0 e 0 31 0 32 0 31 0 32 0 31 0 32 0 31 0 32 0 31 0 31 0 31 0 31 0 31 0 32 0 31 0 30 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 7f d3 0 0 9d 56 f 0 86 48

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b"\x00\x00'\x01!\x01Y\x01\x00\x00\x00\x00\x00M\x92\x82\x04\x00`\xcc\x05\x00")>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf150): 0 0 27 1 21 1 59 1 0 0 0 0 0 4d 92 82 4 0 60 cc 5 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\xd9\x1f\x00\x00d\x00-\n\x15\xc3\x00\x00\x01\x01I\x06\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x07\x00\x01\x00\x00\x00\xc7\x03`\x00\x00\x00\xf2|=@\x00\x00\x00\x00\xe2\x04\x00\x00\x00\x00\x00\x01\x00\x05\x00\x00\xab\x9e\x07\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(128) (buf278): 0 0 0 0 d9 1f 0 0 64 0 2d a 15 c3 0 0 1 1 49 6 0 0 0 0 0 0 0 0 0 0 0 0 7 0 1 0 0 0 c7 3 60 0 0 0 f2 7c 3d 40 0 0 0 0 e2 4 0 0 0 0 0 1 0 5 0 0 ab 9e 7 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00m')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf300): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 6d

DEBUG    [jikong.py:99] got response 2 (len300)
INFO     [sampling.py:47] connected bms JKBt(C8:47:8C:E8:4F:07)!
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'U\xaa\xeb\x90\x02\xc8<\r:\r6\r:\r7\r6\r8\r1\r:\r6\r8\r5\r6\r6\r;\r:\r\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\x00\x008\r\x0b\x00\x00\x071\x002\x001\x002\x001\x002\x001\x002\x001\x001\x001\x001\x001\x002\x001\x000\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x7f\xd3\x00\x00\x9dV\x0f\x00\xd0M')>}, []]
DEBUG    [jikong.py:72] header, clear buf bytearray(b'')
DEBUG    [jikong.py:77] bms msg(128) (buf128): 55 aa eb 90 2 c8 3c d 3a d 36 d 3a d 37 d 36 d 38 d 31 d 3a d 36 d 38 d 35 d 36 d 36 d 3b d 3a d 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ff ff 0 0 38 d b 0 0 7 31 0 32 0 31 0 32 0 31 0 32 0 31 0 32 0 31 0 31 0 31 0 31 0 31 0 32 0 31 0 30 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 7f d3 0 0 9d 56 f 0 d0 4d

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b"\x00\x00'\x01!\x01Y\x01\x00\x00\xae\xf8\x02M\x95\x82\x04\x00`\xcc\x05\x00")>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf150): 0 0 27 1 21 1 59 1 0 0 ae f8 2 4d 95 82 4 0 60 cc 5 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\xd9\x1f\x00\x00d\x00\x9f\x02\x15\xc3\x00\x00\x01\x01H\x06\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x07\x00\x01\x00\x00\x00\xc7\x03g\x00\x00\x00\xf2|=@\xcc\x00\x00\x00\xe2\x04\x00\x00\x00\x00\x00\x01\x00\x05\x00\x00\xb1\x9e\x07\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')>}, []]
DEBUG    [jikong.py:77] bms msg(128) (buf278): 0 0 0 0 d9 1f 0 0 64 0 9f 2 15 c3 0 0 1 1 48 6 0 0 0 0 0 0 0 0 0 0 0 0 7 0 1 0 0 0 c7 3 67 0 0 0 f2 7c 3d 40 cc 0 0 0 e2 4 0 0 0 0 0 1 0 5 0 0 b1 9e 7 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0

DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Value': <dbus_next.signature.Variant ('ay', b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xa4')>}, []]
DEBUG    [jikong.py:77] bms msg(22) (buf300): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 a4

DEBUG    [jikong.py:99] got response 2 (len300)
INFO     [sampling.py:64] bateria-casa subscribing for {'charge': True, 'discharge': True} switch change
INFO     [mqtt_util.py:297] subscribe homeassistant/switch/bateria-casa/charge/set
DEBUG    [client.py:2529] Sending SUBSCRIBE (d0, m1) [(b'homeassistant/switch/bateria-casa/charge/set', 2)]
INFO     [mqtt_util.py:297] subscribe homeassistant/switch/bateria-casa/discharge/set
DEBUG    [client.py:2529] Sending SUBSCRIBE (d0, m2) [(b'homeassistant/switch/bateria-casa/discharge/set', 2)]
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m3), 'b'bateria-casa/soc/total_voltage'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m4), 'b'bateria-casa/soc/current'', ... (5 bytes)
DEBUG    [client.py:2529] Received SUBACK
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m5), 'b'bateria-casa/soc/balance_current'', ... (6 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m6), 'b'bateria-casa/soc/soc_percent'', ... (5 bytes)
DEBUG    [client.py:2529] Received SUBACK
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m7), 'b'bateria-casa/soc/power'', ... (4 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m8), 'b'bateria-casa/soc/capacity'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m9), 'b'bateria-casa/soc/cycle_capacity'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m10), 'b'bateria-casa/mosfet_status/capacity_ah'', ... (6 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m11), 'b'bateria-casa/mosfet_status/temperature'', ... (4 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m12), 'b'bateria-casa/bms/uptime'', ... (3 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m13), 'b'bateria-casa/switch/charge'', ... (2 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m14), 'b'bateria-casa/switch/discharge'', ... (2 bytes)
INFO     [sampling.py:68] bateria-casa result@2022-11-08T10:27:54.270145 BmsSample(U=54.1V,I=19.92A,P=1079W,q=295.6Ah/380.0,mos=34.5°C)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m15), 'b'bateria-casa/cell_voltages/1'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m16), 'b'bateria-casa/cell_voltages/2'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m17), 'b'bateria-casa/cell_voltages/3'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m18), 'b'bateria-casa/cell_voltages/4'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m19), 'b'bateria-casa/cell_voltages/5'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m20), 'b'bateria-casa/cell_voltages/6'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m21), 'b'bateria-casa/cell_voltages/7'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m22), 'b'bateria-casa/cell_voltages/8'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m23), 'b'bateria-casa/cell_voltages/9'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m24), 'b'bateria-casa/cell_voltages/10'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m25), 'b'bateria-casa/cell_voltages/11'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m26), 'b'bateria-casa/cell_voltages/12'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m27), 'b'bateria-casa/cell_voltages/13'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m28), 'b'bateria-casa/cell_voltages/14'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m29), 'b'bateria-casa/cell_voltages/15'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m30), 'b'bateria-casa/cell_voltages/16'', ... (5 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m31), 'b'bateria-casa/temperatures/1'', ... (4 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m32), 'b'bateria-casa/temperatures/2'', ... (4 bytes)
INFO     [sampling.py:75] bateria-casa volt=3388,3386,3382,3386,3383,3382,3384,3377,3386,3382,3384,3381,3382,3382,3387,3386 temp=[29.5, 28.9]
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m33), 'b'homeassistant/sensor/bateria-casa/_soc_total_voltage/config'', ... (441 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m34), 'b'homeassistant/sensor/bateria-casa/_soc_current/config'', ... (387 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m35), 'b'homeassistant/sensor/bateria-casa/_soc_balance_current/config'', ... (451 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m36), 'b'homeassistant/sensor/bateria-casa/_soc_soc_percent/config'', ... (426 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m37), 'b'homeassistant/sensor/bateria-casa/_soc_power/config'', ... (398 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m38), 'b'homeassistant/sensor/bateria-casa/_soc_capacity/config'', ... (365 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m39), 'b'homeassistant/sensor/bateria-casa/_soc_cycle_capacity/config'', ... (389 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m40), 'b'homeassistant/sensor/bateria-casa/_mosfet_status_capacity_ah/config'', ... (417 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m41), 'b'homeassistant/sensor/bateria-casa/_mosfet_status_temperature/config'', ... (480 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m42), 'b'homeassistant/sensor/bateria-casa/_bms_uptime/config'', ... (420 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m43), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_1/config'', ... (403 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m44), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_2/config'', ... (403 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m45), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_3/config'', ... (403 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m46), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_4/config'', ... (403 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m47), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_5/config'', ... (403 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m48), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_6/config'', ... (403 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m49), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_7/config'', ... (403 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m50), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_8/config'', ... (403 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m51), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_9/config'', ... (403 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m52), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_10/config'', ... (407 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m53), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_11/config'', ... (407 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m54), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_12/config'', ... (407 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m55), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_13/config'', ... (407 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m56), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_14/config'', ... (407 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m57), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_15/config'', ... (407 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m58), 'b'homeassistant/sensor/bateria-casa/_cell_voltages_16/config'', ... (407 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m59), 'b'homeassistant/sensor/bateria-casa/_temperatures_1/config'', ... (409 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m60), 'b'homeassistant/sensor/bateria-casa/_temperatures_2/config'', ... (409 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m61), 'b'homeassistant/switch/bateria-casa/charge/config'', ... (417 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m62), 'b'homeassistant/binary_sensor/bateria-casa/charge/config'', ... (424 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m63), 'b'homeassistant/switch/bateria-casa/discharge/config'', ... (432 bytes)
DEBUG    [client.py:2529] Sending PUBLISH (d0, q0, r0, m64), 'b'homeassistant/binary_sensor/bateria-casa/discharge/config'', ... (439 bytes)
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07/service000e/char0011): ['org.bluez.GattCharacteristic1', {'Notifying': <dbus_next.signature.Variant ('b', False)>}, []]
DEBUG    [client.py:507] Disconnecting (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07)
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'ServicesResolved': <dbus_next.signature.Variant ('b', False)>}, []]
DEBUG    [client.py:1123] received D-Bus signal: org.freedesktop.DBus.Properties.PropertiesChanged (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07): ['org.bluez.Device1', {'Connected': <dbus_next.signature.Variant ('b', False)>}, []]
DEBUG    [client.py:1182] Device disconnected (/org/bluez/hci0/dev_C8_47_8C_E8_4F_07)
DEBUG    [client.py:438] _remove_signal_handlers(/org/bluez/hci0/dev_C8_47_8C_E8_4F_07)
DEBUG    [client.py:465] _disconnect_message_bus(/org/bluez/hci0/dev_C8_47_8C_E8_4F_07)
INFO     [sampling.py:100] JKBt(C8:47:8C:E8:4F:07) times: connect=941.70s fetch=0.69s
INFO     [main.py:249] Shutting down ...
INFO     [main.py:254] Disconnecting JKBt(C8:47:8C:E8:4F:07)
INFO     [main.py:263] exit signal handler...
ismael@lafrite:~/batmon-ha$

djismgaming avatar Nov 08 '22 14:11 djismgaming

just for LOLs I created a little script to run the command and close it after 10 seconds of running. Works as a temporary workaround:

ismael@lafrite:~/batmon-ha$ cat batmon.sh
#!/bin/bash

# run batmon-ha
echo y|python3 ~/batmon-ha/main.py &
# save the process ID
batmonpid=$!
# sleep 10 seconds
sleep 10
# send SIGINT, which is usual behavior of Ctrl+C.
kill -SIGINT $batmonpid

just need to add it to cron now, temporarily 😉

djismgaming avatar Nov 08 '22 22:11 djismgaming

Had to do a little change to the script, as the threads where not being killed successfully on time and the 4 threads on the La Frite CPU would get overwhelmed after some time:

ismael@lafrite:~$ cat batmon.sh
#!/bin/bash

#run batmon-ha
echo y|python3 /home/ismael/batmon-ha/main.py &
# save the process ID
batmonpid=$!
# sleep 10 seconds
sleep 10
# send SIGINT, which is usual behavior of Ctrl+C
kill -2 $batmonpid
sleep 10
kill -15 $batmonpid

djismgaming avatar Nov 11 '22 14:11 djismgaming

The command stays like this indefinitely (why I used the work "paused" smile): INFO [sampling.py:41] connecting bms JKBt(C8:47:8C:E8:4F:07)

I have to manually cancel it with Ctrl+C for it to begin stopping it and actually reads the BMSs and sends the data to via MQTT to the Home Assistant OS VM.

On my JK setup it "works" the same way. Nothing happens until ctrl-c, then some MQTT data coming and exit after some seconds.

rromrrom avatar Nov 24 '22 04:11 rromrrom

Looks like this has something to do with the addition of the Watchdog function (without it enabled it seems to create an infinite timeout in the sampling function). I only just picked this app up yesterday (running it in Docker on Alpine 3.15) but I experienced the exact same hang. Anyway, if you are still stuck on this try adding "watchdog: true" to your options.json file. Fixed it right up.

fixed4life avatar Nov 26 '22 18:11 fixed4life

"watchdog" optiond fixed issue for me. Thanks!

rromrrom avatar Nov 26 '22 20:11 rromrrom

Thanks for sharing your insight! Adding watchdog fixed for me as well. Now to test long term stability. Sharing my options,json for reference.

{
  "devices": [
    {
      "address": "B7:82:2P:Y9:DA:FB",
      "type": "jk",
      "alias": "battery2"
    }
],
  "mqtt_broker": "192.168.1.101",
  "mqtt_user": "USERNAME",
  "mqtt_password": "PASSWORD",
  "concurrent_sampling": false,
  "keep_alive": true,
  "verbose_log": true,
  "sample_period": 10.0,
  "invert_current": false,
  "watchdog": true
}

klarjr avatar Jan 17 '23 03:01 klarjr

I was having trouble connecting to my JBD bms's and enabling watchdog seems to have resolved the issue for me as well.

robwolff3 avatar Jan 25 '23 15:01 robwolff3

Thanks!

  1. setting the watchdog option
  2. setting the sample_period to 10
  3. removing two spaces before the ] in the devices array

These 3 solved this one for me so far.

djismgaming avatar Feb 06 '23 19:02 djismgaming

this has been fixed with https://github.com/fl4p/batmon-ha/commit/8ffdf275b439eae5195cb612bfbebc33b16974fa#diff-b10564ab7d2c520cdd0243874879fb0a782862c3c902ab535faabe57d5a505e1L116

The sleep was inside the watchdog branch causing a spinning loop if watchdog was disabled

fl4p avatar Feb 06 '23 20:02 fl4p