"Properties of unknown characteristic changed" log messages spam |
||||
Issue descriptionChrome Version : 51.0.2694.1 OS Version: 8134.0.0 Flag: chrome://flags/#enable-web-bluetooth What steps will reproduce the problem? 1. Advertise Battery with BLE Peripheral Simulator Android App (https://play.google.com/store/apps/details?id=io.github.webbluetoothcg.bletestperipheral) 2. Go to https://googlechrome.github.io/samples/web-bluetooth/device-disconnect.html 3. Enter battery_service in Service field and click "Scan" As you can see in file:///home/chronos/user/log/chrome, messages contain plenty of "Properties of unknown characteristic changed" log messages. See https://cs.chromium.org/#chromium/src/device/bluetooth/bluetooth_remote_gatt_service_bluez.cc&q=%22Properties%20of%20unknown%20characteristic%20changed%22&sq=package:chromium&l=314 Here are my logs: [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1155)] requestDevice called with the following filters: [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1157)] Name: [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1158)] Name Prefix: [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1159)] Services: [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1160)] [ [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1162)] 0000180f-0000-1000-8000-00805f9b34fb [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1163)] ] [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1166)] requestDevice called with the following optional services: [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1269)] Populating 6 devices in chooser 5 [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1272)] EC:1B:D8:E7:FD:03 [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1272)] F4:F8:C7:3C:DB:C1 [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1272)] CA:54:48:65:A6:45 [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1272)] 74:DA:F9:23:29:2E [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1272)] 7C:13:F7:60:D9:16 [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1272)] FB:1F:30:C2:94:EA [18978:18978:0406/131753:VERBOSE1:bluetooth_adapter_bluez.cc(1114)] AddDiscoverySession [18978:18978:0406/131753:VERBOSE1:bluetooth_adapter_bluez.cc(1410)] OnSetDiscoveryFilter [18978:18978:0406/131753:VERBOSE1:bluetooth_adapter_bluez.cc(1295)] OnStartDiscovery [18978:18978:0406/131753:VERBOSE1:bluetooth_adapter.cc(268)] BluetoothAdapter::OnStartDiscoverySession [18978:18978:0406/131753:VERBOSE1:bluetooth_dispatcher_host.cc(1294)] Started discovery session for 5 [18978:18978:0406/131754:VERBOSE1:bluetooth_adapter_bluez.cc(934)] Discovering changed: 1 [18978:18978:0406/131754:VERBOSE1:bluetooth_dispatcher_host.cc(542)] Adding device to all choosers: 43:E9:77:06:EF:83 [18978:18978:0406/131755:VERBOSE1:bluetooth_allowed_devices_map.cc(47)] Adding a device to Map of Allowed Devices. [18978:18978:0406/131755:VERBOSE1:bluetooth_allowed_devices_map.cc(72)] Id generated for device: wbcibWOJQE4BnaM9Qkpm6A== [18978:18978:0406/131755:VERBOSE1:bluetooth_dispatcher_host.cc(1414)] Device: Nexus 5X [18978:18978:0406/131755:VERBOSE1:bluetooth_dispatcher_host.cc(1415)] UUIDs: [18978:18978:0406/131755:VERBOSE1:bluetooth_dispatcher_host.cc(1421)] Allowed: 0000180f-0000-1000-8000-00805f9b34fb [18978:18978:0406/131755:VERBOSE1:bluetooth_discovery_session.cc(43)] Stopping device discovery session. [18978:18978:0406/131755:VERBOSE1:bluetooth_adapter_bluez.cc(1177)] RemoveDiscoverySession [18978:18978:0406/131755:VERBOSE1:bluetooth_adapter_bluez.cc(1342)] OnStopDiscovery [18978:18978:0406/131755:VERBOSE1:bluetooth_adapter_bluez.cc(934)] Discovering changed: 0 [18978:18978:0406/131755:VERBOSE1:bluetooth_device_bluez.cc(372)] /org/bluez/hci0/dev_43_E9_77_06_EF_83: Connecting, 1 in progress [18978:18978:0406/131755:VERBOSE1:bluetooth_device_bluez.cc(617)] /org/bluez/hci0/dev_43_E9_77_06_EF_83: Connecting [18978:18978:0406/131756:VERBOSE1:bluetooth_device_bluez.cc(633)] /org/bluez/hci0/dev_43_E9_77_06_EF_83: Connected, 0 still in progress [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001: UUID [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001: Device [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001: Primary [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001: Characteristics [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(85)] Remote GATT service added: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001 [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE1:bluetooth_device_bluez.cc(558)] Adding new remote GATT service for device: 43:E9:77:06:EF:83 [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(40)] Creating remote GATT service with identifier: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001, UUID: 00001801-0000-1000-8000-00805f9b34fb [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001/char0002: UUID [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001/char0002: Service [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001/char0002: Notifying [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001/char0002: Flags [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001/char0002: Descriptors [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(202)] Remote GATT characteristic added: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001/char0002 [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(275)] Adding new remote GATT characteristic for GATT service: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001, UUID: 00001801-0000-1000-8000-00805f9b34fb [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_characteristic_bluez.cc(45)] Creating remote GATT characteristic with identifier: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001/char0002, UUID: 00002a05-0000-1000-8000-00805f9b34fb [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028: UUID [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028: Device [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028: Primary [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028: Characteristics [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(85)] Remote GATT service added: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028 [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE2:bluetooth_device_bluez.cc(554)] Remote GATT service does not belong to this device. [18978:18978:0406/131758:VERBOSE1:bluetooth_device_bluez.cc(558)] Adding new remote GATT service for device: 43:E9:77:06:EF:83 [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(40)] Creating remote GATT service with identifier: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028, UUID: 0000180f-0000-1000-8000-00805f9b34fb [18978:18978:0406/131758:VERBOSE2:bluetooth_remote_gatt_service_bluez.cc(271)] Remote GATT characteristic does not belong to this service. [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028/char0029: UUID [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028/char0029: Service [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028/char0029: Notifying [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028/char0029: Flags [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028/char0029: Descriptors [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(314)] Properties of unknown characteristic changed [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_characteristic_client.cc(202)] Remote GATT characteristic added: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028/char0029 [18978:18978:0406/131758:VERBOSE2:bluetooth_remote_gatt_service_bluez.cc(271)] Remote GATT characteristic does not belong to this service. [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(275)] Adding new remote GATT characteristic for GATT service: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028, UUID: 0000180f-0000-1000-8000-00805f9b34fb [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_characteristic_bluez.cc(45)] Creating remote GATT characteristic with identifier: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028/char0029, UUID: 00002a19-0000-1000-8000-00805f9b34fb [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001: Characteristics [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(234)] Service property changed: "Characteristics", /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001 [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(250)] All characteristics were discovered for service: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0001 [18978:18978:0406/131758:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028: Characteristics [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(234)] Service property changed: "Characteristics", /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028 [18978:18978:0406/131758:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(250)] All characteristics were discovered for service: /org/bluez/hci0/dev_43_E9_77_06_EF_83/service0028 [18978:18978:0406/131758:VERBOSE1:bluetooth_dispatcher_host.cc(570)] Services discovered for device: 43:E9:77:06:EF:83
,
Apr 6 2016
,
Apr 15 2016
,
May 12 2016
For info, I can still reproduce this issue with Google Chrome 52.0.2717.5 (Official Build) dev (64-bit) Logs are below: [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(940)] requestDevice called with the following filters: [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(942)] Name: [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(943)] Name Prefix: [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(944)] Services: [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(945)] [ [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(947)] 0000180f-0000-1000-8000-00805f9b34fb [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(948)] ] [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(951)] requestDevice called with the following optional services: [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(1078)] Populating 1 devices in chooser 1 [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(1081)] AC:E6:4B:05:88:2D [8906:8906:0512/125140:VERBOSE1:bluetooth_adapter_bluez.cc(1139)] AddDiscoverySession [8906:8906:0512/125140:VERBOSE1:bluetooth_adapter_bluez.cc(1435)] OnSetDiscoveryFilter [8906:8906:0512/125140:VERBOSE1:bluetooth_adapter_bluez.cc(1320)] OnStartDiscovery [8906:8906:0512/125140:VERBOSE1:bluetooth_adapter.cc(280)] BluetoothAdapter::OnStartDiscoverySession [8906:8906:0512/125140:VERBOSE1:bluetooth_dispatcher_host.cc(1103)] Started discovery session for 1 [8906:8906:0512/125141:VERBOSE1:bluetooth_adapter_bluez.cc(943)] Discovering changed: 1 [8906:8906:0512/125141:WARNING:arc_bluetooth_bridge.cc(683)] no Bluetooth instance available [8906:8906:0512/125141:VERBOSE1:bluetooth_dispatcher_host.cc(561)] Adding device to all choosers: 71:88:0A:BF:CE:ED [8906:8906:0512/125141:WARNING:arc_bluetooth_bridge.cc(683)] no Bluetooth instance available [8906:8906:0512/125141:VERBOSE1:bluetooth_dispatcher_host.cc(561)] Adding device to all choosers: CD:36:32:47:CA:1C [8906:8906:0512/125142:VERBOSE1:bluetooth_allowed_devices_map.cc(47)] Adding a device to Map of Allowed Devices. [8906:8906:0512/125142:VERBOSE1:bluetooth_allowed_devices_map.cc(72)] Id generated for device: z6jI7OjNfTo1O/gDSujvkw== [8906:8906:0512/125142:VERBOSE1:bluetooth_dispatcher_host.cc(1223)] Device: Nexus 5X [8906:8906:0512/125142:VERBOSE1:bluetooth_dispatcher_host.cc(1224)] UUIDs: [8906:8906:0512/125142:VERBOSE1:bluetooth_dispatcher_host.cc(1230)] Allowed: 0000180f-0000-1000-8000-00805f9b34fb [8906:8906:0512/125142:VERBOSE1:bluetooth_discovery_session.cc(45)] Stopping device discovery session. [8906:8906:0512/125142:VERBOSE1:bluetooth_adapter_bluez.cc(1202)] RemoveDiscoverySession [8906:8906:0512/125142:VERBOSE1:bluetooth_adapter_bluez.cc(1367)] OnStopDiscovery [8906:8906:0512/125142:VERBOSE1:bluetooth_device_bluez.cc(373)] /org/bluez/hci0/dev_71_88_0A_BF_CE_ED: Connecting, 1 in progress [8906:8906:0512/125142:VERBOSE1:bluetooth_device_bluez.cc(618)] /org/bluez/hci0/dev_71_88_0A_BF_CE_ED: Connecting [8906:8906:0512/125142:VERBOSE1:bluetooth_adapter_bluez.cc(943)] Discovering changed: 0 [8906:8906:0512/125142:VERBOSE1:bluetooth_event_router.cc(221)] Releasing Adapter. [8906:8906:0512/125143:VERBOSE1:bluetooth_device_bluez.cc(634)] /org/bluez/hci0/dev_71_88_0A_BF_CE_ED: Connected, 0 still in progress [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001: UUID [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001: Device [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001: Primary [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_service_client.cc(85)] Remote GATT service added: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001 [8906:8906:0512/125145:VERBOSE2:bluetooth_device_bluez.cc(555)] Remote GATT service does not belong to this device. [8906:8906:0512/125145:VERBOSE1:bluetooth_device_bluez.cc(559)] Adding new remote GATT service for device: 71:88:0A:BF:CE:ED [8906:8906:0512/125145:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(28)] Creating remote GATT service with identifier: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001 [8906:8906:0512/125145:VERBOSE2:bluetooth_device_bluez.cc(555)] Remote GATT service does not belong to this device. [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001/char0002: UUID [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001/char0002: Service [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001/char0002: Notifying [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001/char0002: Flags [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(202)] Remote GATT characteristic added: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001/char0002 [8906:8906:0512/125145:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(202)] Adding new remote GATT characteristic for GATT service: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001, UUID: 00001801-0000-1000-8000-00805f9b34fb [8906:8906:0512/125145:VERBOSE1:bluetooth_remote_gatt_characteristic_bluez.cc(50)] Creating remote GATT characteristic with identifier: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0001/char0002, UUID: 00002a05-0000-1000-8000-00805f9b34fb [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028: UUID [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028: Device [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_service_client.cc(115)] Remote GATT service property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028: Primary [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_service_client.cc(85)] Remote GATT service added: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028 [8906:8906:0512/125145:VERBOSE2:bluetooth_device_bluez.cc(555)] Remote GATT service does not belong to this device. [8906:8906:0512/125145:VERBOSE1:bluetooth_device_bluez.cc(559)] Adding new remote GATT service for device: 71:88:0A:BF:CE:ED [8906:8906:0512/125145:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(28)] Creating remote GATT service with identifier: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028 [8906:8906:0512/125145:VERBOSE2:bluetooth_remote_gatt_service_bluez.cc(198)] Remote GATT characteristic does not belong to this service. [8906:8906:0512/125145:VERBOSE2:bluetooth_device_bluez.cc(555)] Remote GATT service does not belong to this device. [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028/char0029: UUID [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028/char0029: Service [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028/char0029: Notifying [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(233)] Remote GATT characteristic property changed: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028/char0029: Flags [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE3:bluetooth_remote_gatt_service_bluez.cc(241)] Properties of unknown characteristic changed [8906:8906:0512/125145:VERBOSE2:bluetooth_gatt_characteristic_client.cc(202)] Remote GATT characteristic added: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028/char0029 [8906:8906:0512/125145:VERBOSE2:bluetooth_remote_gatt_service_bluez.cc(198)] Remote GATT characteristic does not belong to this service. [8906:8906:0512/125145:VERBOSE1:bluetooth_remote_gatt_service_bluez.cc(202)] Adding new remote GATT characteristic for GATT service: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028, UUID: 0000180f-0000-1000-8000-00805f9b34fb [8906:8906:0512/125145:VERBOSE1:bluetooth_remote_gatt_characteristic_bluez.cc(50)] Creating remote GATT characteristic with identifier: /org/bluez/hci0/dev_71_88_0A_BF_CE_ED/service0028/char0029, UUID: 00002a19-0000-1000-8000-00805f9b34fb
,
May 12 2016
@rkc, could this be related to https://bugs.chromium.org/p/chromium/issues/detail?id=604166?
,
May 12 2016
I think this is WAI. When a service gets created it adds itself to the list of observers for the BluetoothGattServiceClient and BluetoothGattCharacteristicClient. These two clients notify *all* observers of any services or characteristics added. The logs are a bit spammy, but then again they are VLOG(3).
,
Jun 17 2016
I'm not sure to get it. What are *all* the observers there?
,
Jun 17 2016
In the bluez implementation there are clients that are actively listening for changes in the corresponding Bluez objects. For example the BluetoothGattCharacteristicClient is listening for changes in *any* characteristics, same thing with the BluetoothGattServiceClient. When these clients receive an event from bluez they notify its observers of this change. When a BluetoothRemoteGattServiceBluez object is created, it adds itself as an observer of BluetoothGattCharacteristicClient, meaning it will be notified of changes to *any* characteristics. Imagine there as a device with two services A and B. Service A contains characteristic C and service B contains characteristic D. When "D" changes services "A" and "B" will be notified of a change in a characteristic. "A" will notice that "D" is not in "A" and log "Properties of unknown characteristic changed". "B" will notice that "D" is in "B" process the event. |
||||
►
Sign in to add a comment |
||||
Comment 1 by fbeaufort@chromium.org
, Apr 6 2016And here are my dbus messages with `sudo dbus-monitor --system`: signal sender=:1.20 -> dest=(null destination) serial=1681 path=/org/bluez/hci0; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Adapter1" array [ dict entry( string "Discovering" variant boolean true ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1682 path=/; interface=org.freedesktop.DBus.ObjectManager; member=InterfacesAdded object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9" array [ dict entry( string "org.freedesktop.DBus.Introspectable" array [ ] ) dict entry( string "org.bluez.Device1" array [ dict entry( string "Address" variant string "70:70:B2:BD:79:C9" ) dict entry( string "Name" variant string "Nexus 5X" ) dict entry( string "Alias" variant string "Nexus 5X" ) dict entry( string "Paired" variant boolean false ) dict entry( string "Trusted" variant boolean false ) dict entry( string "Blocked" variant boolean false ) dict entry( string "LegacyPairing" variant boolean false ) dict entry( string "RSSI" variant int16 -60 ) dict entry( string "Connected" variant boolean false ) dict entry( string "UUIDs" variant array [ string "0000180f-0000-1000-8000-00805f9b34fb" ] ) dict entry( string "Adapter" variant object path "/org/bluez/hci0" ) dict entry( string "TxPower" variant int16 -7 ) ] ) dict entry( string "org.freedesktop.DBus.Properties" array [ ] ) ] signal sender=:1.20 -> dest=(null destination) serial=1684 path=/; interface=org.freedesktop.DBus.ObjectManager; member=InterfacesAdded object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9" array [ dict entry( string "org.chromium.BluetoothDevice" array [ ] ) ] signal sender=:1.20 -> dest=(null destination) serial=1686 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "RSSI" variant int16 -60 ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1687 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "RSSI" variant int16 -60 ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1688 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "RSSI" variant int16 -57 ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1689 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "RSSI" variant int16 -57 ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1690 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "RSSI" variant int16 -60 ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1691 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "RSSI" variant int16 -63 ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1692 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ ] array [ string "TxPower" string "RSSI" ] signal sender=:1.20 -> dest=(null destination) serial=1694 path=/org/bluez/hci0; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Adapter1" array [ dict entry( string "Discovering" variant boolean false ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1695 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "Connected" variant boolean true ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1697 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "Trusted" variant boolean true ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1699 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "UUIDs" variant array [ string "00001800-0000-1000-8000-00805f9b34fb" string "00001801-0000-1000-8000-00805f9b34fb" string "0000180f-0000-1000-8000-00805f9b34fb" ] ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1700 path=/; interface=org.freedesktop.DBus.ObjectManager; member=InterfacesAdded object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0001" array [ dict entry( string "org.freedesktop.DBus.Introspectable" array [ ] ) dict entry( string "org.bluez.GattService1" array [ dict entry( string "UUID" variant string "00001801-0000-1000-8000-00805f9b34fb" ) dict entry( string "Device" variant object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9" ) dict entry( string "Primary" variant boolean true ) dict entry( string "Characteristics" variant array [ ] ) ] ) dict entry( string "org.freedesktop.DBus.Properties" array [ ] ) ] signal sender=:1.20 -> dest=(null destination) serial=1701 path=/; interface=org.freedesktop.DBus.ObjectManager; member=InterfacesAdded object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0001/char0002" array [ dict entry( string "org.freedesktop.DBus.Introspectable" array [ ] ) dict entry( string "org.bluez.GattCharacteristic1" array [ dict entry( string "UUID" variant string "00002a05-0000-1000-8000-00805f9b34fb" ) dict entry( string "Service" variant object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0001" ) dict entry( string "Notifying" variant boolean false ) dict entry( string "Flags" variant array [ string "indicate" ] ) dict entry( string "Descriptors" variant array [ ] ) ] ) dict entry( string "org.freedesktop.DBus.Properties" array [ ] ) ] signal sender=:1.20 -> dest=(null destination) serial=1702 path=/; interface=org.freedesktop.DBus.ObjectManager; member=InterfacesAdded object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0028" array [ dict entry( string "org.freedesktop.DBus.Introspectable" array [ ] ) dict entry( string "org.bluez.GattService1" array [ dict entry( string "UUID" variant string "0000180f-0000-1000-8000-00805f9b34fb" ) dict entry( string "Device" variant object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9" ) dict entry( string "Primary" variant boolean true ) dict entry( string "Characteristics" variant array [ ] ) ] ) dict entry( string "org.freedesktop.DBus.Properties" array [ ] ) ] signal sender=:1.20 -> dest=(null destination) serial=1703 path=/; interface=org.freedesktop.DBus.ObjectManager; member=InterfacesAdded object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0028/char0029" array [ dict entry( string "org.freedesktop.DBus.Introspectable" array [ ] ) dict entry( string "org.bluez.GattCharacteristic1" array [ dict entry( string "UUID" variant string "00002a19-0000-1000-8000-00805f9b34fb" ) dict entry( string "Service" variant object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0028" ) dict entry( string "Notifying" variant boolean false ) dict entry( string "Flags" variant array [ string "read" string "notify" ] ) dict entry( string "Descriptors" variant array [ ] ) ] ) dict entry( string "org.freedesktop.DBus.Properties" array [ ] ) ] signal sender=:1.20 -> dest=(null destination) serial=1704 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0001; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.GattService1" array [ dict entry( string "Characteristics" variant array [ object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0001/char0002" ] ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1705 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0028; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.GattService1" array [ dict entry( string "Characteristics" variant array [ object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0028/char0029" ] ) ] array [ ] signal sender=:1.20 -> dest=(null destination) serial=1706 path=/org/bluez/hci0/dev_70_70_B2_BD_79_C9; interface=org.freedesktop.DBus.Properties; member=PropertiesChanged string "org.bluez.Device1" array [ dict entry( string "GattServices" variant array [ object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0001" object path "/org/bluez/hci0/dev_70_70_B2_BD_79_C9/service0028" ] ) ] array [ ]