Return-Path: MIME-Version: 1.0 In-Reply-To: References: From: =?UTF-8?Q?Fran=C3=A7ois_Beaufort?= Date: Mon, 29 Feb 2016 15:24:41 +0100 Message-ID: Subject: Re: What does mean "GattServices is nil" ? To: Luiz Augusto von Dentz Cc: BlueZ development Content-Type: text/plain; charset=UTF-8 Sender: linux-bluetooth-owner@vger.kernel.org List-ID: For info, here's the flow I'm using to compile Bluez on a Chromebook: https://github.com/beaufortfrancois/sandbox/blob/gh-pages/web-bluetooth/Bluez.md On Mon, Feb 29, 2016 at 3:24 PM, François Beaufort wrote: > I've given another try with latest master branch which contains your > "fix not clearing database after discovery" patch > (7664e160d8fe69e1ce6b48b6de5b3d3eb4db0d13) and I still don't have any > luck to get connected ;( > > See http://pastebin.com/raw/m44xVGY6 > > On Fri, Feb 26, 2016 at 4:34 PM, Luiz Augusto von Dentz > wrote: >> Hi François, >> >> Actually this is caused by the following: >> >> bluetoothd[6917]: Unable to register GATT service with handle 0x0012 >> for device F1:6F:DE:EC:F1:D6 >> bluetoothd[6917]: Unable to register GATT service with handle 0x0016 >> for device F1:6F:DE:EC:F1:D6 >> bluetoothd[6917]: Unable to register GATT service with handle 0x0019 >> for device F1:6F:DE:EC:F1:D6 >> >> Perhaps you forgot to enable the experimental flags (-E), anyway the >> patch Ive mentioned is not yet pushed, I thought you would be able to >> pick it for the mailing list. >> >> On Fri, Feb 26, 2016 at 4:59 PM, François Beaufort >> wrote: >>> After updating to your last patch >>> (http://git.kernel.org/cgit/bluetooth/bluez.git/commit/?id=d205d58b285542f845d59cab24793de7c12f4aca), >>> here's what I'm seeing now: http://pastebin.com/raw/4CXw36A5 >>> As you can see, list-attributes doesn't list all attributes anymore ;) >>> >>> On Thu, Feb 25, 2016 at 3:33 PM, François Beaufort >>> wrote: >>>> And here's the diff which shows that more services are discovered >>>> somehow: https://www.diffchecker.com/m20m9ga1 >>>> >>>> On Thu, Feb 25, 2016 at 3:29 PM, François Beaufort >>>> wrote: >>>>> Here are bluetoothd logs for Pixel 2015 (working): >>>>> http://pastebin.com/raw/uShisSPw >>>>> And here are the ones for the Pixel 2013 (failing): >>>>> http://pastebin.com/raw/4arEF8qu >>>>> >>>>> On Thu, Feb 25, 2016 at 3:03 PM, Luiz Augusto von Dentz >>>>> wrote: >>>>>> Hi François, >>>>>> >>>>>> >>>>>> On Thu, Feb 25, 2016 at 3:59 PM, François Beaufort >>>>>> wrote: >>>>>>> Here's an interesting bit, I've tried with Chromebook Pixel 2013 and >>>>>>> Chromebook Pixel 2015 (different chipsets) and the results are >>>>>>> differents >>>>>>> >>>>>>> Chromebook Pixel 2013 fails to get GATT Services: >>>>>>> http://pastebin.com/raw/gsi63kWg >>>>>> >>>>>> Perhaps something else is affecting that, do you have the bluetoothd logs? >>>>>> >>>>>>> Chromebook Pixel 2015 can discover all of them: http://pastebin.com/raw/z5vr0B3P >>>>>>> >>>>>>> Does that make some kind of sense? >>>>>>> >>>>>>> On Wed, Feb 17, 2016 at 6:12 PM, François Beaufort >>>>>>> wrote: >>>>>>>> I didn't have a chance to try your patches sadly. >>>>>>>> Feel free to push them as it will still be valuable for sure. >>>>>>>> >>>>>>>> On Tue, Feb 16, 2016 at 12:49 PM, Luiz Augusto von Dentz >>>>>>>> wrote: >>>>>>>>> Hi François, >>>>>>>>> >>>>>>>>> On Mon, Feb 15, 2016 at 2:32 PM, Luiz Augusto von Dentz >>>>>>>>> wrote: >>>>>>>>>> Hi François, >>>>>>>>>> >>>>>>>>>> On Mon, Feb 15, 2016 at 12:20 PM, François Beaufort >>>>>>>>>> wrote: >>>>>>>>>>> And here are my bluetoothd logs when enabling debug mode: >>>>>>>>>>> http://pastebin.com/raw/WjRVrMk5 >>>>>>>>>>> >>>>>>>>>>> bluetoothd[21655]: src/device.c:device_connect_le() Connection attempt >>>>>>>>>>> to: F1:6F:DE:EC:F1:D6 >>>>>>>>>>> bluetoothd[21655]: src/adapter.c:connect_failed_callback() hci0 >>>>>>>>>>> F1:6F:DE:EC:F1:D6 status 2 >>>>>>>>>>> bluetoothd[21655]: plugins/policy.c:conn_fail_cb() status 2 >>>>>>>>>>> bluetoothd[21655]: src/adapter.c:bonding_attempt_complete() hci0 >>>>>>>>>>> bdaddr F1:6F:DE:EC:F1:D6 type 2 status 0x2 >>>>>>>>>>> bluetoothd[21655]: src/device.c:device_bonding_complete() bonding >>>>>>>>>>> (nil) status 0x02 >>>>>>>>>>> bluetoothd[21655]: src/device.c:device_bonding_failed() status 2 >>>>>>>>>>> bluetoothd[21655]: src/adapter.c:resume_discovery() >>>>>>>>>>> bluetoothd[21655]: src/device.c:att_connect_cb() connect error: >>>>>>>>>>> Transport endpoint is not connected (107) >>>>>>>>>>> bluetoothd[21655]: src/adapter.c:connected_callback() hci0 device >>>>>>>>>>> F1:6F:DE:EC:F1:D6 connected eir_len 24 >>>>>>>>>>> bluetoothd[21655]: attrib/gattrib.c:g_attrib_ref() 0x7f3ccfe929b0: >>>>>>>>>>> g_attrib_ref=1 >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_gatt_db() Restoring >>>>>>>>>>> F1:6F:DE:EC:F1:D6 gatt database from file >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_service() loading service: >>>>>>>>>>> 0x0001, end: 0x0007, uuid: 1800 >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_service() loading service: >>>>>>>>>>> 0x0008, end: 0x000b, uuid: 00001801-0000-1000-8000-00805f9b34fb >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_service() loading service: >>>>>>>>>>> 0x0012, end: 0x0019, uuid: 0000180d-0000-1000-8000-00805f9b34fb >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_service() loading service: >>>>>>>>>>> 0x001a, end: 0xffff, uuid: 0000180a-0000-1000-8000-00805f9b34fb >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_chrc() loading characteristic >>>>>>>>>>> handle: 0x0002, value handle: 0x0003, properties 0x000a uuid: 2a00 >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_chrc() loading characteristic >>>>>>>>>>> handle: 0x0004, value handle: 0x0005, properties 0x0002 uuid: 2a01 >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_chrc() loading characteristic >>>>>>>>>>> handle: 0x0006, value handle: 0x0007, properties 0x0002 uuid: 2a04 >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_chrc() loading characteristic >>>>>>>>>>> handle: 0x0009, value handle: 0x000a, properties 0x0020 uuid: >>>>>>>>>>> 00002a05-0000-1000-8000-00805f9b34fb >>>>>>>>>>> bluetoothd[21655]: src/device.c:load_chrc() loading characteristic >>>>>>>>>>> handle: 0x000a, value handle: 0x000b, properties 0x0010 uuid: >>>>>>>>>>> 6e400003-b5a3-f393-e0a9-e50e24dcca9e >>>>>>>>>>> bluetoothd[21655]: saving characteristic to db failed >>>>>>>>>>> bluetoothd[21655]: Unable to load gatt db from file for F1:6F:DE:EC:F1:D6 >>>>>>>>>>> bluetoothd[21655]: src/gatt-client.c:btd_gatt_client_connected() >>>>>>>>>>> Device connected. >>>>>>>>>>> bluetoothd[21655]: src/device.c:att_browse_cb() ATT connection successful >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() MTU exchange complete, with MTU: 23 >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() Primary services found: 5 >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() start: 0x0001, end: >>>>>>>>>>> 0x0007, uuid: 00001800-0000-1000-8000-00805f9b34fb >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() start: 0x0008, end: >>>>>>>>>>> 0x000b, uuid: 00001801-0000-1000-8000-00805f9b34fb >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() start: 0x000c, end: >>>>>>>>>>> 0x0011, uuid: 00001530-1212-efde-1523-785feabcd123 >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() start: 0x0012, end: >>>>>>>>>>> 0x0019, uuid: 0000180d-0000-1000-8000-00805f9b34fb >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() start: 0x001a, end: >>>>>>>>>>> 0xffff, uuid: 0000180a-0000-1000-8000-00805f9b34fb >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() Secondary service >>>>>>>>>>> discovery failed. ATT ECODE: 0x0a >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() Characteristics found: 1 >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() start: 0x0009, end: >>>>>>>>>>> 0x000b, value: 0x000a, props: 0x20, uuid: 00002a05-0000-1 >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_debug() Failed to initialize gatt-client >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_client_ready_cb() status: failed, error: 10 >>>>>>>>>>> bluetoothd[21655]: src/device.c:device_svc_resolved() >>>>>>>>>>> /org/bluez/hci0/dev_F1_6F_DE_EC_F1_D6 err -5 >>>>>>>>>>> bluetoothd[21655]: src/device.c:gatt_service_removed() start: 0x0001, >>>>>>>>>>> end: 0x0007 >>>>>>>>>> >>>>>>>>>> It turns out it was the cache malfunctioning, it does clear the cache >>>>>>>>>> properly before storing the services when it changed so you would end >>>>>>>>>> up with new and old services which obviously does not work as the >>>>>>>>>> ranges tend to overlap. >>>>>>>>> >>>>>>>>> Have you tried my patches? I will probably push them today if you don't object. >>>>>>>>> >>>>>>>>> >>>>>>>>> >>>>>>>>> -- >>>>>>>>> Luiz Augusto von Dentz >>>>>> >>>>>> >>>>>> >>>>>> -- >>>>>> Luiz Augusto von Dentz >> >> >> >> -- >> Luiz Augusto von Dentz