From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: X-Spam-Checker-Version: SpamAssassin 3.4.0 (2014-02-07) on aws-us-west-2-korg-lkml-1.web.codeaurora.org Received: from vger.kernel.org (vger.kernel.org [23.128.96.18]) by smtp.lore.kernel.org (Postfix) with ESMTP id E0C57C433F5 for ; Fri, 1 Apr 2022 21:50:12 +0000 (UTC) Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1346949AbiDAVwA (ORCPT ); Fri, 1 Apr 2022 17:52:00 -0400 Received: from lindbergh.monkeyblade.net ([23.128.96.19]:48308 "EHLO lindbergh.monkeyblade.net" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1345926AbiDAVv7 (ORCPT ); Fri, 1 Apr 2022 17:51:59 -0400 Received: from mail-yb1-xb31.google.com (mail-yb1-xb31.google.com [IPv6:2607:f8b0:4864:20::b31]) by lindbergh.monkeyblade.net (Postfix) with ESMTPS id 58EC1141FFF for ; Fri, 1 Apr 2022 14:50:08 -0700 (PDT) Received: by mail-yb1-xb31.google.com with SMTP id f38so7321412ybi.3 for ; Fri, 01 Apr 2022 14:50:08 -0700 (PDT) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=20210112; h=mime-version:references:in-reply-to:from:date:message-id:subject:to :cc; bh=sYj82IJvaYhn2cV3w0EO6uV2O8/dJnHP7eb+01gMmV0=; b=Gl8yH0iuZNT7yHvNJFGL3pI0pBfoOGp0c1Y3/0hpxKd4XBfvBxGXoN6RtKEAHnrIXX dQaTKCKf51pfF479t1vpkyWMZ8UA+nKxFGMNsI6v8aWwfS0MsiFxCEnEfM8o3Mnspv0c VHAuvn2WN98mzoESy9x+RvoEMlulzxgMXvkPNrZoitqerGE4Wyv2lOdlmmPjOrdD+wun p67LQLCcZ+V08UgJaHUOI3b0q9aggr7ylq+dEH4q0REH4A0F/A26OuSaeIaeKyHavHLU vFN4rjwlHCoKY+560thCeYD5PuFrc+Le7UpmNfGitKU02zLiw+SXIQmQDuUzMaw1Kccd Yx9Q== X-Google-DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=1e100.net; s=20210112; h=x-gm-message-state:mime-version:references:in-reply-to:from:date :message-id:subject:to:cc; bh=sYj82IJvaYhn2cV3w0EO6uV2O8/dJnHP7eb+01gMmV0=; b=4P5SWex4+k974ZkfCpD4foxVP3kC9uYDIEkCpCnFzIxfqvTtOWsHuL3QJezz3GiIHg vr2A9X691YN5WEN3yyx0EdiXEa1eQAOrJ0BUXJTuIJBV2k1psokjT+XGyoDaF3LICwCr YDHu9aneUQb/KWV88CDb6BLcifrcfNLcLtr669TmyqEVsmEGV+NVQLBelHpv7PoizHem nrFmh9cQy+nTTxzZGYw4eMnJ5yhHekFhXElBdrZxE7oDNnYJC/O/jE6l+BcfLwqmDF7R Yf1N01mXWLi49HUjK99Wnm+IiOoXBj/mOtVF5lWt/iFw+ecjcyffNNbu+UGHJhg+A/u1 ttdg== X-Gm-Message-State: AOAM531VJW8N3ULtvL63cYMUFXGj8ToUfmqWc5rb/EiAtr2Sxx8vbndc KGeDY9tSeEZA2xzcGcGVHnkjG+Kt1LT6Fcmv3VSC2brj1l0= X-Google-Smtp-Source: ABdhPJwEFZnmmqNPYjtG78x6vv+5feM4uy4NEvy4w+xxFmKKQDDGLVfEb+hD0vb1gS+SdNUN3N2GLro+uG+02okBbAY= X-Received: by 2002:a25:a467:0:b0:61e:1b4a:7700 with SMTP id f94-20020a25a467000000b0061e1b4a7700mr10758580ybi.390.1648849807305; Fri, 01 Apr 2022 14:50:07 -0700 (PDT) MIME-Version: 1.0 References: In-Reply-To: From: Luiz Augusto von Dentz Date: Fri, 1 Apr 2022 14:49:56 -0700 Message-ID: Subject: Re: GATT issue, possible bluez bug? To: Adam Pigg Cc: "linux-bluetooth@vger.kernel.org" Content-Type: text/plain; charset="UTF-8" Precedence: bulk List-ID: X-Mailing-List: linux-bluetooth@vger.kernel.org Hi Adam, On Fri, Apr 1, 2022 at 1:12 PM Adam Pigg wrote: > > Hi Luiz > > On Mon, 28 Mar 2022 at 17:37, Adam Pigg wrote: > > > > Hi Luiz > > > > On Wed, 23 Mar 2022 at 19:57, Adam Pigg wrote: > > > > > > Hi Luiz > > > > > > Thanks for having the patience with me on this.... > > > > > > On Wed, 23 Mar 2022 at 19:46, Luiz Augusto von Dentz > > > wrote: > > > > > > > > Hi Adam, > > > > > > > > On Wed, Mar 23, 2022 at 7:46 AM Adam Pigg wrote: > > > > > > > > > > On Wed, 23 Mar 2022 at 13:36, Adam Pigg wrote: > > > > > > > > > > > > Hi Luiz > > > > > > > > > > > > On Wed, 23 Mar 2022 at 09:11, Adam Pigg wrote: > > > > > > > > > > > > > > Hi Luiz > > > > > > > > > > > > > > Good that you clearly know more about this than me!... > > > > > > > > > > > > > > On Tue, 22 Mar 2022 at 23:44, Luiz Augusto von Dentz > > > > > > > wrote: > > > > > > > > > > > > > > > > Hi Adam, > > > > > > > > > > > > > > > > On Tue, Mar 22, 2022 at 4:35 PM Luiz Augusto von Dentz > > > > > > > > wrote: > > > > > > > > > > > > > > > > > > Hi Adam, > > > > > > > > > > > > > > > > > > On Tue, Mar 22, 2022 at 4:09 PM Adam Pigg wrote: > > > > > > > > > > > > > > > > > > > > Thanks Luiz > > > > > > > > > > > > > > > > > > > > On Tue, 22 Mar 2022 at 21:35, Luiz Augusto von Dentz > > > > > > > > > > wrote: > > > > > > > > > > > > > > > > > > > > > > Hi Adam, > > > > > > > > > > > > > > > > > > > > > > On Tue, Mar 22, 2022 at 3:40 AM Adam Pigg wrote: > > > > > > > > > > > > > > > > > > > > > > > > Hi Luiz > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > On Tue, 22 Mar 2022 at 07:55, Adam Pigg wrote: > > > > > > > > > > > > > > > > > > > > > > > > > > Hi Luiz > > > > > > > > > > > > > > > > > > > > > > > > > > On Tue, 22 Mar 2022 at 00:44, Luiz Augusto von Dentz > > > > > > > > > > > > > wrote: > > > > > > > > > > > > > > > > > > > > > > > > > > > > Hi Adam, > > > > > > > > > > > > > > > > > > > > > > > > > > > > On Mon, Mar 21, 2022 at 4:03 PM Adam Pigg wrote: > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > Hi > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > A bit of background, I write a linux desktop/mobile app called > > > > > > > > > > > > > > > Amazfish which interfaces with several watches over BLE using their > > > > > > > > > > > > > > > GATT services. To do this, I use the bluez dbus api (technically a > > > > > > > > > > > > > > > thin wrapper around it I wrote called qble > > > > > > > > > > > > > > > https://github.com/piggz/qble) > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > All has been good so far, I support several generations of > > > > > > > > > > > > > > > Huami/Amazfit watches, as well as the open source Pinetime and > > > > > > > > > > > > > > > Bangle.js. For the Amazfit watches, i have implementations for older > > > > > > > > > > > > > > > devies such as the Bip, and newer ones such as the GTS. > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > Much of the reverse engineering comes from the Android Gadget Bridge > > > > > > > > > > > > > > > project, which supports many more devices. > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > My community of users donated to buy me a newer device called a GTR2, > > > > > > > > > > > > > > > which, according to the GB devs uses the same protocol as the slightly > > > > > > > > > > > > > > > older GTS, and the packet captures I have from Android would support > > > > > > > > > > > > > > > this. > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > But this is where my trouble starts with Bluez, my existing > > > > > > > > > > > > > > > implementation doesnt work at all. Normally, after a connection, I > > > > > > > > > > > > > > > would wait for the ServicesResolved signal, which happens pretty fast > > > > > > > > > > > > > > > on all other devices, but on the GTR2, it takes about 30 seconds, by > > > > > > > > > > > > > > > which time, the watch has disconnected. (i get a disconnected signal > > > > > > > > > > > > > > > immediately after the ServicesResolved signal) > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > To rule out my code, I have tried several things: > > > > > > > > > > > > > > > Gatttool > > > > > > > > > > > > > > > With gattool, i can connect, get the services, enable a notification, > > > > > > > > > > > > > > > write a value and get the expected results seemingly fine > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > Python-gatt (using the bluez dbus api) > > > > > > > > > > > > > > > Im unable to iterate the services, like my app, it takes 30 seconds to > > > > > > > > > > > > > > > get the signal and then swiftly disconnects > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > Gattlib (https://github.com/labapart/gattlib) > > > > > > > > > > > > > > > Gattlib is interesting as it appears to have "borrowed" much of its > > > > > > > > > > > > > > > code directly from bluez. When built against the system bluez, if the > > > > > > > > > > > > > > > version is > 5.42, it will use the dbus api. When I do this, again im > > > > > > > > > > > > > > > unable to list services on the watch. However, if I edit the build to > > > > > > > > > > > > > > > force it to use its internal gatt implementation, which appears to be > > > > > > > > > > > > > > > the same one used by gatttool, then, it IS able to interrogate the > > > > > > > > > > > > > > > watch. > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > I have attached 3 files > > > > > > > > > > > > > > > 1. test python program which should print services, and associated btmon > > > > > > > > > > > > > > > 2. btmon output while using gatttool > > > > > > > > > > > > > > > 3. btmon output running gattlib discover example > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > Note, other than discovery, I havnt been able to get gattlib to > > > > > > > > > > > > > > > read/write/notify! > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > It seems as though I may be triggering a bug in the bluez dbus api? > > > > > > > > > > > > > > > Can anyone suggest anything? > > > > > > > > > > > > > > > > > > > > > > > > > > > > What version are you using? I would first try with the latest to see > > > > > > > > > > > > > > if that something already fixed. > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > Im using 5.63 already, which is the latest tag (on opensuse tumbleweed) > > > > > > > > > > > > > > > > > > > > > > > > > > I'll also try bluetoothctl and attach logs using that, though I > > > > > > > > > > > > > suspect it will behave the same as the python library and my own > > > > > > > > > > > > > library. > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > Attached is the output of btmon while using bluetoothctl > > > > > > > > > > > > > > > > > > > > > > > > bluetoothctl behaves the same as my lib and python, it is unable to > > > > > > > > > > > > list services, and after a while, emits the ServicesResolved and > > > > > > > > > > > > disconnected messages at the same time. Im sure it should be able to > > > > > > > > > > > > list the services immediately after connect just like gatttool can. > > > > > > > > > > > > > > > > > > > > > > Looks like there is multiple rounds of MTU Exchange, not sure if that > > > > > > > > > > > is actually a problem but the spec does say it shall only be sent once > > > > > > > > > > > per client: > > > > > > > > > > > > > > > > > > > > > > BLUETOOTH CORE SPECIFICATION Version 5.3 | Vol 3, Part F > > > > > > > > > > > page 1424: > > > > > > > > > > > > > > > > > > > > > > This request shall only be sent once during a connection by the client. > > > > > > > > > > > > > > > > > > > > > > There is also no response to frame #30: > > > > > > > > > > > < ACL Data TX: Handle 3585 flags 0x00 dlen 7 > > > > > > > > > > > > > > > > > > > > > > #30 [hci0] 26.641557 > > > > > > > > > > > ATT: Read Request (0x0a) len 2 > > > > > > > > > > > Handle: 0x0018 > > > > > > > > > > > > > > > > > > > > > > So after 30 seconds (ATT timeout) without receiving any response it disconnects: > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > So, the verdict is that the watch isnt acting to spec right? > > > > > > > > > > > > > > > > > > > > Why does gatttool work ok, is it a completely different implementation? > > > > > > > > > > > > > > > > > > > > I understand if wouldnt be to spec, but would it be possible to make > > > > > > > > > > bluez more resilient to devices not acting to spec? Android and iOS > > > > > > > > > > work just fine in this regard, so could bluez handle mis-behaving > > > > > > > > > > devices more flexibly? > > > > > > > > > > > > > > > > > > That I can't really explain, perhaps it is timing related, something > > > > > > > > > with Exchange MTU since it appears to stop the device from responding > > > > > > > > > when it happens a second time. > > > > > > > > > > > > > > > > > > > Do you have any suggestions for things I could try? I looked for > > > > > > > > > > similar lines in the working gatttool log, and it doesnt have anything > > > > > > > > > > like that, seems to send flags 0x00 dlen 9 (instead of 7?) ... how is > > > > > > > > > > it behaving differently? > > > > > > > > > > > > > > > > > > Not sure really, does Android/iOS Exchange the MTU? Maybe we need a > > > > > > > > > timer to start it later or perhaps the problem first response to > > > > > > > > > exchange MTU does actually use the final_mtu which makes the watch to > > > > > > > > > trigger yet another exchange to have both rx and tx MTU the same so > > > > > > > > > try with the following change: > > > > > > > > > > > > > > > > > > diff --git a/src/shared/gatt-server.c b/src/shared/gatt-server.c > > > > > > > > > index 2adb4afbf..d326782bf 100644 > > > > > > > > > --- a/src/shared/gatt-server.c > > > > > > > > > +++ b/src/shared/gatt-server.c > > > > > > > > > @@ -1499,7 +1499,7 @@ static void exchange_mtu_cb(struct bt_att_chan > > > > > > > > > *chan, uint8_t opcode, > > > > > > > > > final_mtu = MAX(MIN(client_rx_mtu, server->mtu), BT_ATT_DEFAULT_LE_MTU); > > > > > > > > > > > > > > > > > > /* Respond with the server MTU */ > > > > > > > > > - put_le16(server->mtu, rsp_pdu); > > > > > > > > > + put_le16(final_mtu, rsp_pdu); > > > > > > > > > bt_att_chan_send_rsp(chan, BT_ATT_OP_MTU_RSP, rsp_pdu, 2); > > > > > > > > > > > > > > > > > > /* Set MTU to be the minimum */ > > > > > > > > > > > > > > > > Hmm Im not sure if this will work since the peripheral seems to > > > > > > > > respond different values 252 vs 247, also the spec does say that: > > > > > > > > > > > > > > > > 'The Server Rx MTU parameter shall be set to the *maximum size* of the > > > > > > > > Attribute protocol PDU that the server can receive. > > > > > > > > The server and client shall set ATT_MTU to the *minimum of the Client Rx MTU > > > > > > > > and the Server Rx MTU*. The size is the same to ensure that a client can > > > > > > > > correctly detect the final packet of a long attribute read.' > > > > > > > > > > > > > > > > So my interpretation is that the minimum is calculated after the > > > > > > > > Exchange is complete so it doesn't require the Server MTU to be > > > > > > > > limited by the Client MTU, anyway if Android and iOS does apply the > > > > > > > > minimum logic before responding we can do the same. > > > > > > > > > > > > > > > > > > > > > > Maybe it will help if I attach an android packet capture.... > > > > > > > > > > > > > > The attachedhttps://marc.info/?l=linux-bluetooth&m=164799909020040&w=2 > > > > > > > log can be opened in Wireshark, and to my untrained eye, it looks like > > > > > > > the MTU negotiation is at packets 451 and 452, and 247 is used? > > > > > > > > > > > > > > Ill try and get the proposed patch built and see how it behaves > > > > > > > > > > > > Attached if the btmon and bluetoothctl. It doesnt seem to be there quite yet. > > > > > > > > > > > > There was one point before i applied the patch where bluetoothctl > > > > > > seemed to list the attributes quickly, but i havnt been able to > > > > > > reproduce that again with or without the patch. > > > > > > > > > > > > > > > > For completeness, also attached the output of my program and btmon > > > > > > > > > > My program should connect, wait for resolved signal, then read a char, > > > > > enable some notifications, and do a write. You can see the 30 second > > > > > wait between connect, resolved, and quickly followed by a disconnect. > > > > > > > > > > > > < ACL Data TX: Handle 3585 flags 0x00 dlen 7 > > > > > > > > #22 [hci0] 12.507730 > > > > ATT: Exchange MTU Request (0x02) len 2 > > > > Client RX MTU: 517 > > > > > ACL Data RX: Handle 3585 flags 0x02 dlen 7 #23 [hci0] 12.556081 > > > > ATT: Exchange MTU Request (0x02) len 2 > > > > Client RX MTU: 247 > > > > < ACL Data TX: Handle 3585 flags 0x00 dlen 7 > > > > > > > > #24 [hci0] 12.556256 > > > > ATT: Exchange MTU Response (0x03) len 2 > > > > Server RX MTU: 247 > > > > > ACL Data RX: Handle 3585 flags 0x02 dlen 7 #27 [hci0] 12.655972 > > > > ATT: Exchange MTU Response (0x03) len 2 > > > > Server RX MTU: 252 > > > > > > > > So we are now responding with 247 and the peripheral responds with 252 > > > > to our request :/, so we would need to probably delay our request or > > > > something, that said we are the central so I really which we don't > > > > have to do it since that would penalize well behaving devices, could > > > > we perhaps inform the vendor about these issues? I'd considered this > > > > to be really bad behavior from the remote side since they are not > > > > following the spec in many respects as even their MTU changes from > > > > request to response and it does multiple rounds of Exchange MTU and > > > > stop responding while doing it. > > > > > > > > > > I can certainly look into how to contact Huami/Amazfit ... I wouldnt > > > count on a response though! > > > > > > I see you looked at the android log already. > > > > > > Do you have an idea for a patch I could try out? Im deep in this now > > > anyway, and over-wrote my system bluez :D > > > > > > Its strange how they have messed up this generation of device as all > > > the older ones work fine, and I imagine they must just build on the > > > old code base. > > > > > > > I have submitted a support request to Amazfit, describing the issue > > and linking to the details in the ML... maybe they will read it! > > > > Do you think there is anything I can try to make bluez work in the > > mean time, even just on my own device? > > > I had another go at making this work before attempting to write my own > gatt lib (!) and i seem to have got it to work, though I dont know if > it will be acceptable to bluez, or if there is another way. > > Probably easiest with the diff: > diff --git a/profiles/gap/gas.c b/profiles/gap/gas.c > index ea3249be9..701677e0a 100644 > --- a/profiles/gap/gas.c > +++ b/profiles/gap/gas.c > @@ -142,8 +142,8 @@ static void read_appearance_cb(bool success, > uint8_t att_ecode, > > static void handle_appearance(struct gas *gas, uint16_t value_handle) > { > - if (!bt_gatt_client_read_value(gas->client, value_handle, > - read_appearance_cb, gas, NULL)) > + //if (!bt_gatt_client_read_value(gas->client, value_handle, > + // read_appearance_cb, gas, NULL)) > DBG("Failed to send request to read appearance"); Does disabling the read make it work? Does it stop the second MTU exchange? > } > > diff --git a/src/shared/gatt-server.c b/src/shared/gatt-server.c > index 776e5ce2b..ac0fac1fc 100644 > --- a/src/shared/gatt-server.c > +++ b/src/shared/gatt-server.c > @@ -1498,7 +1498,8 @@ static void exchange_mtu_cb(struct bt_att_chan > *chan, uint8_t opcode, > final_mtu = MAX(MIN(client_rx_mtu, server->mtu), BT_ATT_DEFAULT_LE_MTU); > > /* Respond with the server MTU */ > - put_le16(server->mtu, rsp_pdu); > + //put_le16(server->mtu, rsp_pdu); > + put_le16(final_mtu, rsp_pdu); > bt_att_chan_send_rsp(chan, BT_ATT_OP_MTU_RSP, rsp_pdu, 2); > > /* Set MTU to be the minimum */ > > I was running bluetoothd with -n -d, and noticed that the read to the > appearance was failing, so, I commented it out. The read to the name > works ok and happens just prior to reading the appearance. > > I gather it only reads the appearance if the char exists, so, i dont > know why that fail, however I dont see 2a01 in the list of > services/characteristics, which is the appearance one right? #define GATT_CHARAC_APPEARANCE 0x2A01 You don't see it on bluetoothd logs or over D-Bus? The latter may not contain all the attributes since some are claimed. > Any thoughts? > > Cheers > > > > > Thanks > > > > > > > > > > > > > > > > > > Thanks > > > > > > > > > > > > > > > > > > > > > > > > > > Thanks > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > < HCI Command: Disconnect (0x01|0x0006) plen 3 > > > > > > > > > > > > > > > > > > > > > > #48 [hci0] 58.673128 > > > > > > > > > > > Handle: 3585 > > > > > > > > > > > Reason: Remote User Terminated Connection (0x13) > > > > > > > > > > > > > > > > > > > > > > > Thanks > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > -- > > > > > > > > > > > > > > Luiz Augusto von Dentz > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > -- > > > > > > > > > > > Luiz Augusto von Dentz > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > -- > > > > > > > > > Luiz Augusto von Dentz > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > > -- > > > > > > > > Luiz Augusto von Dentz > > > > > > > > > > > > > > > > -- > > > > Luiz Augusto von Dentz -- Luiz Augusto von Dentz