Bug 217023 - [Intel AX200] hci0: Malformed MSFT vendor event: 0x02
Summary: [Intel AX200] hci0: Malformed MSFT vendor event: 0x02
Status: NEW
Alias: None
Product: Drivers
Classification: Unclassified
Component: Bluetooth (show other bugs)
Hardware: Intel Linux
: P1 normal
Assignee: linux-bluetooth@vger.kernel.org
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2023-02-11 11:27 UTC by Arda
Modified: 2024-03-29 17:59 UTC (History)
10 users (show)

See Also:
Kernel Version: 6.1.10_1
Subsystem:
Regression: No
Bisected commit-id:


Attachments
dmesg (76.57 KB, text/plain)
2023-02-11 11:27 UTC, Arda
Details
attachment-20917-0.html (347 bytes, text/html)
2023-07-25 18:44 UTC, Mathias Bavay
Details

Description Arda 2023-02-11 11:27:28 UTC
Created attachment 303714 [details]
dmesg

Hello,

First of all, my bluetooth adapter is;
04:00.0 Network controller: Intel Corporation Wi-Fi 6 AX200 (rev 1a)

I see the following message everytime on tty when i boot the pc.

"Bluetooth: hci0: Malformed MSFT vendor event: 0x02"

But bluetooth + wi-fi is fully functional. And it seems to be a common issue with users who have the same hardware (Intel AX200).

https://bbs.archlinux.org/viewtopic.php?id=276815
Comment 1 Tanuj Bagaria 2023-03-01 15:53:49 UTC
Same error, older hardware. see details below.

```
$ sudo dmesg
[   29.392310] Bluetooth: hci0: Malformed MSFT vendor event: 0x02
```

```
$ uname -a
Linux jungle 6.1.14-hardened1-1-hardened #1 SMP PREEMPT_DYNAMIC Sat, 25 Feb 2023 13:15:09 +0000 x86_64 GNU/Linux
```

```
$ lspci
3c:00.0 Network controller: Intel Corporation Wireless 8265 / 8275 (rev 78)
```

```
$ lscpu
Intel(R) Core(TM) i5-7Y54 CPU @ 1.20GHz
```
Comment 2 Mathias Bavay 2023-03-10 07:27:42 UTC
Same error on newer Intel hardware (AX210), since I've started using kernel 5.19.x (compiled by Ubuntu). My bluetooth keyboard and mouse also now need ~1 second when the desktop is loaded before being usable. With my previous kernel (5.15.x), this error message did not appear and I could use the keyboard right away, without the small lag that I now experience.

$ lsusb | grep Bluetooth
Bus 001 Device 002: ID 8087:0032 Intel Corp. AX210 Bluetooth

$ dmesg | grep hci0
[   18.025550] Bluetooth: hci0: Device revision is 0
[   18.025553] Bluetooth: hci0: Secure boot is enabled
[   18.025554] Bluetooth: hci0: OTP lock is enabled
[   18.025555] Bluetooth: hci0: API lock is enabled
[   18.025556] Bluetooth: hci0: Debug lock is disabled
[   18.025557] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[   18.025558] Bluetooth: hci0: Bootloader timestamp 2019.40 buildtype 1 build 38
[   18.026909] Bluetooth: hci0: Found device firmware: intel/ibt-0041-0041.sfi
[   18.026936] Bluetooth: hci0: Boot Address: 0x100800
[   18.026938] Bluetooth: hci0: Firmware Version: 132-5.22
[   19.585644] Bluetooth: hci0: Waiting for firmware download to complete
[   19.585655] Bluetooth: hci0: Firmware loaded in 1522209 usecs
[   19.585821] Bluetooth: hci0: Waiting for device to boot
[   19.612549] Bluetooth: hci0: Device booted in 26194 usecs
[   19.612617] Bluetooth: hci0: Malformed MSFT vendor event: 0x02
[   19.613943] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-0041-0041.ddc
[   19.615693] Bluetooth: hci0: Applying Intel DDC parameters completed
[   19.618707] Bluetooth: hci0: Firmware timestamp 2022.5 buildtype 1 build 38020
[   19.865890] Bluetooth: hci0: Bad flag given (0x1) vs supported (0x0)
[   19.866093] Bluetooth: hci0: Bad flag given (0x1) vs supported (0x0)

$ uname -a
Linux 5.19.0-35-generic #36~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Fri Feb 17 15:17:25 UTC 2 x86_64 x86_64 x86_64 GNU/Linux

$ lscpu
Intel(R) Core(TM) i7-9750H CPU @ 2.60GHz
Comment 3 Paul Menzel 2023-03-10 07:54:03 UTC
@Mathias, please create a separate issue for the regression also attaching the btmon logs with both Linux kernel versions. Please mention the bug report number in here.

(Best would be, if you could bisect the regression. Ubuntu offers Linux kernel mainline builds [1], which make for a good start.)


[1]: https://kernel.ubuntu.com/~kernel-ppa/mainline/
Comment 4 Iyán 2023-04-20 09:27:29 UTC
Same error message on every boot with Intel Corporation Wi-Fi 6 AX201.
Comment 5 Karl Bach 2023-04-26 04:41:18 UTC
Same error on boot for me with AMD CPU und Intel Wifi AX210:

dmesg
[   12.374403] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   12.374413] Bluetooth: BNEP filters: protocol multicast
[   12.374421] Bluetooth: BNEP socket layer initialized
[   13.343660] Bluetooth: hci0: Waiting for firmware download to complete
[   13.343931] Bluetooth: hci0: Firmware loaded in 1275748 usecs
[   13.344049] Bluetooth: hci0: Waiting for device to boot
[   13.373944] Bluetooth: hci0: Malformed MSFT vendor event: 0x02
[   13.373952] Bluetooth: hci0: Device booted in 29263 usecs
[   13.374278] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-0041-0041.ddc
[   13.382017] Bluetooth: hci0: Applying Intel DDC parameters completed
[   13.390994] Bluetooth: hci0: Firmware timestamp 2022.5 buildtype 1 build 38020
[   13.563429] loop42: detected capacity change from 0 to 8
[   13.623805] NET: Registered PF_ALG protocol family
[   13.791859] Bluetooth: hci0: Bad flag given (0x1) vs supported (0x0)
[   13.802577] Bluetooth: RFCOMM TTY layer initialized
[   13.802593] Bluetooth: RFCOMM socket layer initialized
[   13.802605] Bluetooth: RFCOMM ver 1.11



lscpu
AMD Ryzen 7 2700U with Radeon Vega Mobile Gfx

lsusb
Bus 001 Device 002: ID 8087:0032 Intel Corp. AX210 Bluetooth

lsb_release -a
No LSB modules are available.
Distributor ID:	Ubuntu
Description:	Ubuntu 22.04.2 LTS
Release:	22.04
Codename:	jammy

uname -a
Linux NB-1 5.19.0-41-generic #42~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Tue Apr 18 17:40:00 UTC 2 x86_64 x86_64 x86_64 GNU/Linux
Comment 6 André Barata 2023-07-25 11:49:36 UTC
Same error here, Intel Killer WiFi 6E AX1675

Bus 003 Device 006: ID 8087:0033 Intel Corp. 

dmesg | grep hci0
[    6.616282] Bluetooth: hci0: Device revision is 0
[    6.616287] Bluetooth: hci0: Secure boot is enabled
[    6.616289] Bluetooth: hci0: OTP lock is enabled
[    6.616290] Bluetooth: hci0: API lock is enabled
[    6.616291] Bluetooth: hci0: Debug lock is disabled
[    6.616292] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[    6.616294] Bluetooth: hci0: Bootloader timestamp 2019.40 buildtype 1 build 38
[    6.677948] Bluetooth: hci0: Found device firmware: intel/ibt-0040-0041.sfi
[    6.677973] Bluetooth: hci0: Boot Address: 0x100800
[    6.677975] Bluetooth: hci0: Firmware Version: 98-13.23
[    8.301161] Bluetooth: hci0: Waiting for firmware download to complete
[    8.301242] Bluetooth: hci0: Firmware loaded in 1585261 usecs
[    8.301285] Bluetooth: hci0: Waiting for device to boot
[    8.317241] Bluetooth: hci0: Device booted in 15612 usecs
[    8.317365] Bluetooth: hci0: Malformed MSFT vendor event: 0x02
[    8.317557] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-0040-0041.ddc
[    8.320382] Bluetooth: hci0: Applying Intel DDC parameters completed
[    8.323374] Bluetooth: hci0: Firmware timestamp 2023.13 buildtype 1 build 62562
[    8.469680] Bluetooth: hci0: Bad flag given (0x1) vs supported (0x0)

$ uname -a
Linux MSI.Home 6.4.4-200.fc38.x86_64 #1 SMP PREEMPT_DYNAMIC Wed Jul 19 16:32:49 UTC 2023 x86_64 GNU/Linux

$ lscpu
12th Gen Intel(R) Core(TM) i7-1280P
Comment 7 Mathias Bavay 2023-07-25 18:44:09 UTC
Created attachment 304695 [details]
attachment-20917-0.html

I am out of the office from Saturday 14.07.2023 until Monday 07.08.2023. Please consider sending your email again when I will be back at the office.
Comment 8 André Barata 2023-08-18 10:00:36 UTC
Same error here, Intel Killer WiFi 6E AX1675

Bus 003 Device 006: ID 8087:0033 Intel Corp. 

dmesg | grep hci0
[    6.616282] Bluetooth: hci0: Device revision is 0
[    6.616287] Bluetooth: hci0: Secure boot is enabled
[    6.616289] Bluetooth: hci0: OTP lock is enabled
[    6.616290] Bluetooth: hci0: API lock is enabled
[    6.616291] Bluetooth: hci0: Debug lock is disabled
[    6.616292] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[    6.616294] Bluetooth: hci0: Bootloader timestamp 2019.40 buildtype 1 build 38
[    6.677948] Bluetooth: hci0: Found device firmware: intel/ibt-0040-0041.sfi
[    6.677973] Bluetooth: hci0: Boot Address: 0x100800
[    6.677975] Bluetooth: hci0: Firmware Version: 98-13.23
[    8.301161] Bluetooth: hci0: Waiting for firmware download to complete
[    8.301242] Bluetooth: hci0: Firmware loaded in 1585261 usecs
[    8.301285] Bluetooth: hci0: Waiting for device to boot
[    8.317241] Bluetooth: hci0: Device booted in 15612 usecs
[    8.317365] Bluetooth: hci0: Malformed MSFT vendor event: 0x02
[    8.317557] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-0040-0041.ddc
[    8.320382] Bluetooth: hci0: Applying Intel DDC parameters completed
[    8.323374] Bluetooth: hci0: Firmware timestamp 2023.13 buildtype 1 build 62562
[    8.469680] Bluetooth: hci0: Bad flag given (0x1) vs supported (0x0)

$ uname -a
Linux MSI.Home 6.4.10-200.fc38.x86_64 #1 SMP PREEMPT_DYNAMIC Wed Jul 19 16:32:49 UTC 2023 x86_64 GNU/Linux

$ lscpu
12th Gen Intel(R) Core(TM) i7-1280P
Comment 9 Nelson 2023-10-05 00:21:29 UTC
- LT: HP ProBook 430 G8
- Kernel Version: 6.4.12-zen1-1-zen

lsusb | grep -i bluetooth
Bus 003 Device 005: ID 8087:0026 Intel Corp. AX201 Bluetooth

rfkill list
0: hci0: Bluetooth
    Soft blocked: no
    Hard blocked: no
1: phy0: Wireless LAN
    Soft blocked: no
    Hard blocked: no

journalctl -p err -b
sep 01 22:07:54 amida kernel: Bluetooth: hci0: Malformed MSFT vendor event: 0x02

dmesg | grep Bluetooth
[    2.135878] Bluetooth: Core ver 2.22
[    2.135896] Bluetooth: HCI device and connection manager initialized
[    2.135901] Bluetooth: HCI socket layer initialized
[    2.135904] Bluetooth: L2CAP socket layer initialized
[    2.135907] Bluetooth: SCO socket layer initialized
[    2.215220] Bluetooth: hci0: Bootloader revision 0.4 build 0 week 30 2018
[    2.216228] Bluetooth: hci0: Device revision is 2
[    2.216231] Bluetooth: hci0: Secure boot is enabled
[    2.216232] Bluetooth: hci0: OTP lock is enabled
[    2.216233] Bluetooth: hci0: API lock is enabled
[    2.216234] Bluetooth: hci0: Debug lock is disabled
[    2.216235] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[    2.224767] Bluetooth: hci0: Found device firmware: intel/ibt-19-0-4.sfi
[    2.224796] Bluetooth: hci0: Boot Address: 0x24800
[    2.224797] Bluetooth: hci0: Firmware Version: 206-22.23
[    2.312520] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[    2.312523] Bluetooth: BNEP filters: protocol multicast
[    2.312527] Bluetooth: BNEP socket layer initialized
[    3.954983] Bluetooth: hci0: Waiting for firmware download to complete
[    3.955209] Bluetooth: hci0: Firmware loaded in 1689881 usecs
[    3.955250] Bluetooth: hci0: Waiting for device to boot
[    3.970455] Bluetooth: hci0: Device booted in 14875 usecs
[    3.970474] Bluetooth: hci0: Malformed MSFT vendor event: 0x02
[    3.980165] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-19-0-4.ddc
[    3.982432] Bluetooth: hci0: Applying Intel DDC parameters completed
[    3.983427] Bluetooth: hci0: Firmware revision 0.4 build 206 week 22 2023
[    4.052609] Bluetooth: MGMT ver 1.22
[   42.896475] Bluetooth: RFCOMM TTY layer initialized
[   42.896481] Bluetooth: RFCOMM socket layer initialized
[   42.896484] Bluetooth: RFCOMM ver 1.11

Despite the error, my Bluetooth devices seem to be functioning correctly. However, I'd like to address this error if possible.
Comment 10 grivel bugsky 2024-03-29 17:59:46 UTC
My report for an:

Manufacturer: ASUSTeK COMPUTER INC.
Product Name: ROG Zephyrus G16 GU603VI_GU603VI

https://linux-hardware.org/?probe=e7501b45b5

Error initial : [6.736003] Bluetooth: hci0: Malformed MSFT vendor event: 0x02.

0: phy0: Wireless LAN
	Soft blocked: no
	Hard blocked: no
1: hci0: Bluetooth
	Soft blocked: no
	Hard blocked: no
	
Linux polmton 6.5.0-26-generic #26-Ubuntu SMP PREEMPT_DYNAMIC Tue Mar 5 21:19:28 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux$

[    4.961218] Bluetooth: hci0: Device revision is 0
[    4.961221] Bluetooth: hci0: Secure boot is enabled
[    4.961223] Bluetooth: hci0: OTP lock is enabled
[    4.961223] Bluetooth: hci0: API lock is enabled
[    4.961224] Bluetooth: hci0: Debug lock is disabled
[    4.961225] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[    4.961226] Bluetooth: hci0: Bootloader timestamp 2019.40 buildtype 1 build 38
[    4.963975] Bluetooth: hci0: Found device firmware: intel/ibt-0040-0041.sfi
[    4.963996] Bluetooth: hci0: Boot Address: 0x100800
[    4.963997] Bluetooth: hci0: Firmware Version: 98-13.23
[    6.412347] Bluetooth: hci0: Waiting for firmware download to complete
[    6.413186] Bluetooth: hci0: Firmware loaded in 1415242 usecs
[    6.413217] Bluetooth: hci0: Waiting for device to boot
[    6.429192] Bluetooth: hci0: Device booted in 15615 usecs
[    6.429195] Bluetooth: hci0: Malformed MSFT vendor event: 0x02
[    6.429344] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-0040-0041.ddc
[    6.433886] Bluetooth: hci0: Applying Intel DDC parameters achieved
[    6.436212] Bluetooth: hci0: Firmware timestamp 2023.13 build type 1 build 62562
[    4.821065] Bluetooth: Core ver 2.22
[    4.821103] Bluetooth: HCI device and connection manager initialized
[    4.821108] Bluetooth: HCI socket layer initialized
[    4.821111] Bluetooth: L2CAP socket layer initialized
[    4.821115] Bluetooth: SCO socket layer initialized
[    4.961218] Bluetooth: hci0: Device revision is 0
[    4.961221] Bluetooth: hci0: Secure boot is enabled
[    4.961223] Bluetooth: hci0: OTP lock is enabled
[    4.961223] Bluetooth: hci0: API lock is enabled
[    4.961224] Bluetooth: hci0: Debug lock is disabled
[    4.961225] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[    4.961226] Bluetooth: hci0: Bootloader timestamp 2019.40 buildtype 1 build 38
[    4.963975] Bluetooth: hci0: Found device firmware: intel/ibt-0040-0041.sfi
[    4.963996] Bluetooth: hci0: Boot Address: 0x100800
[    4.963997] Bluetooth: hci0: Firmware Version: 98-13.23
[    5.046967] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[    5.046971] Bluetooth: BNEP filters: protocol multicast
[    5.046975] Bluetooth: BNEP socket layer initialized
[    6.412347] Bluetooth: hci0: Waiting for firmware download to complete
[    6.413186] Bluetooth: hci0: Firmware loaded in 1415242 usecs
[    6.413217] Bluetooth: hci0: Waiting for device to boot
[    6.429192] Bluetooth: hci0: Device booted in 15615 usecs
[    6.429195] Bluetooth: hci0: Malformed MSFT vendor event: 0x02
[    6.429344] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-0040-0041.ddc
[    6.433886] Bluetooth: hci0: Applying Intel DDC parameters completed
[    6.436212] Bluetooth: hci0: Firmware timestamp 2023.13 buildtype 1 build 62562
[    6.506296] Bluetooth: MGMT ver 1.22
[    6.519923] Bluetooth: RFCOMM TTY layer initialized
[    6.519929] Bluetooth: RFCOMM socket layer initialized
[    6.519934] Bluetooth: RFCOMM ver 1.11
[    4.961218] Bluetooth: hci0: Device revision is 0
[    4.961221] Bluetooth: hci0: Secure boot is enabled
[    4.961223] Bluetooth: hci0: OTP lock is enabled
[    4.961223] Bluetooth: hci0: API lock is enabled
[    4.961224] Bluetooth: hci0: Debug lock is disabled
[    4.961225] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[    4.961226] Bluetooth: hci0: Bootloader timestamp 2019.40 buildtype 1 build 38
[    4.963975] Bluetooth: hci0: Found device firmware: intel/ibt-0040-0041.sfi
[    4.963996] Bluetooth: hci0: Boot Address: 0x100800
[    4.963997] Bluetooth: hci0: Firmware Version: 98-13.23
[    6.412347] Bluetooth: hci0: Waiting for firmware download to complete
[    6.413186] Bluetooth: hci0: Firmware loaded in 1415242 usecs
[    6.413217] Bluetooth: hci0: Waiting for device to boot
[    6.429192] Bluetooth: hci0: Device booted in 15615 usecs
[    6.429195] Bluetooth: hci0: Malformed MSFT vendor event: 0x02
[    6.429344] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-0040-0041.ddc
[    6.433886] Bluetooth: hci0: Applying Intel DDC parameters completed
[    6.436212] Bluetooth: hci0: Firmware timestamp 2023.13 buildtype 1 build 62562


description: Bluetooth wireless interface
product: AX211 Bluetooth

  *-network
       description: Ethernet interface
       product: Raptor Lake PCH CNVi WiFi
       vendor: Intel Corporation
       physical id: 14.3
       bus info: pci@0000:00:14.3
       logical name: wlo1
       version: 01
       serial: 0e:0e:c5:26:e5:be
       width: 64 bits
       clock: 33MHz
       capabilities: pm msi pciexpress msix bus_master cap_list ethernet physical
       configuration: broadcast=yes driver=iwlwifi driverversion=6.5.0-26-generic firmware=83.e8f84e98.0 so-a0-gf-a0-83.uc ip=192.168.0.130 latency=0 link=yes multicast=yes
       resources: iomemory:620-61f irq:16 memory:622f284000-622f287fff
  *-network
       description: Ethernet interface
       product: RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller
       vendor: Realtek Semiconductor Co., Ltd.
       physical id: 0
       bus info: pci@0000:39:00.0
       logical name: enp57s0
       version: 15
       serial: 08:bf:b8:2f:21:e0
       capacity: 1Gbit/s
       width: 64 bits
       clock: 33MHz
       capabilities: pm msi pciexpress msix bus_master cap_list ethernet physical tp mii 10bt 10bt-fd 100bt 100bt-fd 1000bt-fd autonegotiation
       configuration: autonegotiation=on broadcast=yes driver=r8169 driverversion=6.5.0-26-generic firmware=rtl8168h-2_0.0.2 02/26/15 latency=0 link=no multicast=yes port=twisted pair
       resources: irq:18 ioport:3000(size=256) memory:60204000-60204fff memory:60200000-60203fff

...

Note You need to log in before you can comment on or make changes to this bug.