New issue
Advanced search Search tips

Issue 711286 link

Starred by 2 users
Status: WontFix
Owner: ----
Closed: Apr 2017
Cc:
jlebel@chromium.org
Components:
EstimatedDays: ----
NextAction: ----
OS: Mac
Pri: 3
Type: Bug



Sign in to add a comment

bluetooth: mac: Can't read too long "Characteristic User Description" descriptor.

Project Member Reported by fbeaufort@chromium.org, Apr 13 2017 
Google Chrome	59.0.3070.0 (Official Build) canary (64-bit)
Revision	daf91016aa4560f3c0f72d50eee762eed996fc0e-refs/heads/master@{#464226}
OS	Mac OS X

What steps will reproduce the problem?
(1) Use BLE Peripheral Simulator Android App and advertise Health Thermometer Service
(2) Go to https://googlechrome.github.io/samples/web-bluetooth/read-descriptors-async-await.html?service=health_thermometer&characteristic=measurement_interval
(3) Click "Read Descriptors"

What is the expected result?
I should get all descriptors from "Measurement Interval" characteristic.

What happens instead?
It is stuck to read "Characteristic User Description" descriptor:

See logs below:

[23289:775:0413/153200.354918:VERBOSE1:bluetooth_low_energy_device_mac.mm(394)] <BluetoothLowEnergyDeviceMac F2:B0:BD:BF:77:37/0x7fc6aa822ab0, "Pixel François">: Discovery complete.
[23289:775:0413/153200.354988:VERBOSE2:bluetooth_device.cc(457)] Looking for service: 00001809-0000-1000-8000-00805f9b34fb
[23289:775:0413/153200.355304:VERBOSE2:bluetooth_device.cc(459)] Service in cache: 00001809-0000-1000-8000-00805f9b34fb
[23289:775:0413/153200.357913:VERBOSE1:bluetooth_remote_gatt_descriptor_mac.mm(107)] <BluetoothRemoteGattServiceMac 00002901-0000-1000-8000-00805f9b34fb/0x7fc6a884c5d0, characteristic: 00002a21-0000-1000-8000-00805f9b34fb/0x7fc6a8dd2450>: Read value.

Comment 1 by fbeaufort@chromium.org, Apr 13 2017 

And here are ADB logs:

04-13 15:39:51.950 12669 12680 D io.github.webbluetoothcg.bletestperipheral.Peripheral: Device tried to read descriptor: 00002901-0000-1000-8000-00805f9b34fb
04-13 15:39:51.950 12669 12680 D io.github.webbluetoothcg.bletestperipheral.Peripheral: Value: [84, 104, 105, 115, 32, 99, 104, 97, 114, 97, 99, 116, 101, 114, 105, 115, 116, 105, 99, 32, 105, 115, 32, 117, 115, 101, 100, 32, 116, 111, 32, 101, 110, 97, 98, 108, 101, 32, 97, 110, 100, 32, 99, 111, 110, 116, 114, 111, 108, 32, 116, 104, 101, 32, 105, 110, 116, 101, 114, 118, 97, 108, 32, 98, 101, 116, 119, 101, 101, 110, 32, 99, 111, 110, 115, 101, 99, 117, 116, 105, 118, 101, 32, 116, 101, 109, 112, 101, 114, 97, 116, 117, 114, 101, 32, 109, 101, 97, 115, 117, 114, 101, 109, 101, 110, 116, 115, 46]
04-13 15:39:51.956  1461  1916 W bt_att  : attribute value too long, to be truncated to 103
04-13 15:39:51.956  1461  1563 D BtGatt.GattService: onResponseSendCompleted() handle=48
04-13 15:39:51.995 12669 13023 D io.github.webbluetoothcg.bletestperipheral.Peripheral: Device tried to read descriptor: 00002901-0000-1000-8000-00805f9b34fb
04-13 15:39:51.996 12669 13023 D io.github.webbluetoothcg.bletestperipheral.Peripheral: Value: [84, 104, 105, 115, 32, 99, 104, 97, 114, 97, 99, 116, 101, 114, 105, 115, 116, 105, 99, 32, 105, 115, 32, 117, 115, 101, 100, 32, 116, 111, 32, 101, 110, 97, 98, 108, 101, 32, 97, 110, 100, 32, 99, 111, 110, 116, 114, 111, 108, 32, 116, 104, 101, 32, 105, 110, 116, 101, 114, 118, 97, 108, 32, 98, 101, 116, 119, 101, 101, 110, 32, 99, 111, 110, 115, 101, 99, 117, 116, 105, 118, 101, 32, 116, 101, 109, 112, 101, 114, 97, 116, 117, 114, 101, 32, 109, 101, 97, 115, 117, 114, 101, 109, 101, 110, 116, 115, 46]
04-13 15:39:52.000  1461  1563 D BtGatt.GattService: onResponseSendCompleted() handle=48

Comment 2 by jlebel@chromium.org, Apr 13 2017 

Log from packetlogger
[avr. 13 16:04:51.218]  [ATT Send]  Read By Group Type Request - Start Handle:0x0001 - End Handle:0xffff - UUID:2800 (GATT Primary Service Declaration)
[avr. 13 16:04:51.218]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) ****
[avr. 13 16:04:51.218]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0de0 ****
[avr. 13 16:04:51.239]  [ATT Receive]  Read By Group Type Response
[avr. 13 16:04:51.240]  [HCI COMMAND]  [200E] LE Create Connection Cancel
[avr. 13 16:04:51.240]  [KERNEL DEBUG]  [0x4000] [IOBluetoothHCIRequest][Start] --  OpCode 0x200E (LE Create Connection Cancel) from: blued (128)  Synchronous  status: 0x00 (kIOReturnSuccess) state: 2 (BUSY) timeout: 6543
[avr. 13 16:04:51.241]  [HCI EVENT]  Command Complete [200E] - Command Disallowed - LE Create Connection Cancel
[avr. 13 16:04:51.241]  [KERNEL]  Received Command Disallowed (0x0C) error -- In UHE mode?
[avr. 13 16:04:51.241]  [HCI COMMAND]  [FCFE] VSC - Read Local Firmware Info - Info Type: Read Current Bluetooth Mode
[avr. 13 16:04:51.241]  [KERNEL DEBUG]  [0xD000] [IOBluetoothHCIRequest][Start] --  OpCode 0xFCFE (Broadcom VSC -- Read Local Firmware Info) from: kernel_task (0)  Synchronous  status: 0x00 (kIOReturnSuccess) state: 2 (BUSY) timeout: 5000
[avr. 13 16:04:51.242]  [HCI EVENT]  Command Complete [FCFE] - Read Local Firmware Info
[avr. 13 16:04:51.242]  [KERNEL]  Not in UHE Mode -- continue
[avr. 13 16:04:51.243]  [HCI COMMAND]  [2012] LE Remove Device From White List - 71:7B:52:0D:8D:E9
[avr. 13 16:04:51.243]  [KERNEL DEBUG]  [0x6000] [IOBluetoothHCIRequest][Start] --  OpCode 0x2012 (LE Remove Device From White List) from: blued (128)  Synchronous  status: 0x00 (kIOReturnSuccess) state: 2 (BUSY) timeout: 6543
[avr. 13 16:04:51.245]  [HCI EVENT]  Command Complete [2012] - LE Remove Device From White List
[avr. 13 16:04:51.248]  [HCI COMMAND]  [200D] LE Create Connection - 00:00:00:00:00:00, Scan Window/Interval: 11.25ms/640ms, Min/Max Conn Interval: 7.5ms/15ms 
[avr. 13 16:04:51.248]  [KERNEL DEBUG]  [0x1000] [IOBluetoothHCIRequest][Start] --  OpCode 0x200D (LE Create Connection) from: blued (128)  Synchronous  status: 0x00 (kIOReturnSuccess) state: 2 (BUSY) timeout: 6543
[avr. 13 16:04:51.250]  [HCI EVENT]  Command Status - LE Create Connection
[avr. 13 16:04:51.252]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf0720 for ACL packet 0xffffff80ada2b700 (local copy of memory descriptor 0xffffff80ccc26140) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.252]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) 
[avr. 13 16:04:51.252]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf0de0 for ACL packet 0xffffff80ada2b700 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.252]  [ATT Send]  Read By Type Request - Start Handle:0x0001 - End Handle:0x0005 - UUID:2803 (GATT Characteristic Declaration)
[avr. 13 16:04:51.252]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) ****
[avr. 13 16:04:51.252]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0720 ****
[avr. 13 16:04:51.262]  [HCI EVENT]  Number of Completed Packets - Connection Handle: 0x0041 - Packets: 0x0002  
[avr. 13 16:04:51.262]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Before decrement -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) 
[avr. 13 16:04:51.262]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80afc5b300 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.262]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf0de0 for ACL packet 0xffffff80ada2b700 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.262]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Connection Handle = 0x0041 -- BTDevice->decrementNumberOfOutstandingPacketsBy() returned 2 -- lowPriorityACLPackets = 2, midPriorityACLPackets = 0, highPriorityACLPackets = 0 
[avr. 13 16:04:51.262]  [KERNEL DEBUG]  **** [IOBluetoothHostController][DecrementOutstandingACLPackets] - decremented - Delta: Classic L(0) M(0) H(0) LE L(2) M(0) H(0) - Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) ****
[avr. 13 16:04:51.272]  [ATT Receive]  Read By Type Response
[avr. 13 16:04:51.273]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf0de0 for ACL packet 0xffffff80c7e90700 (local copy of memory descriptor 0xffffff80c8173980) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.273]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) 
[avr. 13 16:04:51.273]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80c7e90700 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.273]  [ATT Send]  Read By Type Request - Start Handle:0x0004 - End Handle:0x0005 - UUID:2803 (GATT Characteristic Declaration)
[avr. 13 16:04:51.273]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) ****
[avr. 13 16:04:51.273]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0de0 ****
[avr. 13 16:04:51.295]  [ATT Receive]  Error Response - Attribute Handle: 0x0004 - Error Code: 0x0A - Attribute Not Found
[avr. 13 16:04:51.295]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf0de0 for ACL packet 0xffffff80afc5b300 (local copy of memory descriptor 0xffffff80dca8a140) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.295]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) 
[avr. 13 16:04:51.295]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf1620 for ACL packet 0xffffff80afc5b300 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.295]  [ATT Send]  Read By Type Request - Start Handle:0x0014 - End Handle:0x001c - UUID:2803 (GATT Characteristic Declaration)
[avr. 13 16:04:51.295]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) ****
[avr. 13 16:04:51.296]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0de0 ****
[avr. 13 16:04:51.307]  [HCI EVENT]  Number of Completed Packets - Connection Handle: 0x0041 - Packets: 0x0002  
[avr. 13 16:04:51.307]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Before decrement -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) 
[avr. 13 16:04:51.307]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80c7e90700 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.307]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf1620 for ACL packet 0xffffff80afc5b300 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.307]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Connection Handle = 0x0041 -- BTDevice->decrementNumberOfOutstandingPacketsBy() returned 2 -- lowPriorityACLPackets = 2, midPriorityACLPackets = 0, highPriorityACLPackets = 0 
[avr. 13 16:04:51.307]  [KERNEL DEBUG]  **** [IOBluetoothHostController][DecrementOutstandingACLPackets] - decremented - Delta: Classic L(0) M(0) H(0) LE L(2) M(0) H(0) - Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) ****
[avr. 13 16:04:51.318]  [ATT Receive]  Read By Type Response
[avr. 13 16:04:51.318]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf1620 for ACL packet 0xffffff80d2166900 (local copy of memory descriptor 0xffffff80d1c8ef00) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.318]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) 
[avr. 13 16:04:51.318]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2166900 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.318]  [ATT Send]  Read By Type Request - Start Handle:0x001b - End Handle:0x001c - UUID:2803 (GATT Characteristic Declaration)
[avr. 13 16:04:51.318]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) ****
[avr. 13 16:04:51.318]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf1620 ****
[avr. 13 16:04:51.340]  [ATT Receive]  Error Response - Attribute Handle: 0x001B - Error Code: 0x0A - Attribute Not Found
[avr. 13 16:04:51.340]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf1620 for ACL packet 0xffffff80d2166c00 (local copy of memory descriptor 0xffffff80ca902140) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.340]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) 
[avr. 13 16:04:51.340]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf0de0 for ACL packet 0xffffff80d2166c00 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.340]  [ATT Send]  Read By Type Request - Start Handle:0x0028 - End Handle:0xffff - UUID:2803 (GATT Characteristic Declaration)
[avr. 13 16:04:51.340]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) ****
[avr. 13 16:04:51.340]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf1620 ****
[avr. 13 16:04:51.352]  [HCI EVENT]  Number of Completed Packets - Connection Handle: 0x0041 - Packets: 0x0002  
[avr. 13 16:04:51.352]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Before decrement -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) 
[avr. 13 16:04:51.352]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2166900 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.352]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf0de0 for ACL packet 0xffffff80d2166c00 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.352]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Connection Handle = 0x0041 -- BTDevice->decrementNumberOfOutstandingPacketsBy() returned 2 -- lowPriorityACLPackets = 2, midPriorityACLPackets = 0, highPriorityACLPackets = 0 
[avr. 13 16:04:51.352]  [KERNEL DEBUG]  **** [IOBluetoothHostController][DecrementOutstandingACLPackets] - decremented - Delta: Classic L(0) M(0) H(0) LE L(2) M(0) H(0) - Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) ****
[avr. 13 16:04:51.362]  [ATT Receive]  Read By Type Response
[avr. 13 16:04:51.363]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf0de0 for ACL packet 0xffffff80d2166900 (local copy of memory descriptor 0xffffff80d40b9300) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.363]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) 
[avr. 13 16:04:51.363]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2166900 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.363]  [ATT Send]  Read By Type Request - Start Handle:0x002f - End Handle:0xffff - UUID:2803 (GATT Characteristic Declaration)
[avr. 13 16:04:51.363]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) ****
[avr. 13 16:04:51.363]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0de0 ****
[avr. 13 16:04:51.385]  [ATT Receive]  Error Response - Attribute Handle: 0x002F - Error Code: 0x0A - Attribute Not Found
[avr. 13 16:04:51.385]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf10e0 for ACL packet 0xffffff80d2166100 (local copy of memory descriptor 0xffffff80c2ce2440) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.385]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) 
[avr. 13 16:04:51.385]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf0f00 for ACL packet 0xffffff80d2166100 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.385]  [ATT Send]  Find Information Request - Start Handle:0x0004 - End Handle:0x0005
[avr. 13 16:04:51.385]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) ****
[avr. 13 16:04:51.386]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf10e0 ****
[avr. 13 16:04:51.398]  [HCI EVENT]  Number of Completed Packets - Connection Handle: 0x0041 - Packets: 0x0002  
[avr. 13 16:04:51.398]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Before decrement -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) 
[avr. 13 16:04:51.398]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2166900 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.398]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf0f00 for ACL packet 0xffffff80d2166100 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.398]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Connection Handle = 0x0041 -- BTDevice->decrementNumberOfOutstandingPacketsBy() returned 2 -- lowPriorityACLPackets = 2, midPriorityACLPackets = 0, highPriorityACLPackets = 0 
[avr. 13 16:04:51.398]  [KERNEL DEBUG]  **** [IOBluetoothHostController][DecrementOutstandingACLPackets] - decremented - Delta: Classic L(0) M(0) H(0) LE L(2) M(0) H(0) - Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) ****
[avr. 13 16:04:51.407]  [ATT Receive]  Error Response - Attribute Handle: 0x0004 - Error Code: 0x0A - Attribute Not Found
[avr. 13 16:04:51.408]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf0f00 for ACL packet 0xffffff80d2166900 (local copy of memory descriptor 0xffffff80d63c8c40) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.408]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) 
[avr. 13 16:04:51.408]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2166900 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.408]  [ATT Send]  Find Information Request - Start Handle:0x002b - End Handle:0x002c
[avr. 13 16:04:51.408]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) ****
[avr. 13 16:04:51.408]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0f00 ****
[avr. 13 16:04:51.430]  [ATT Receive]  Find Information Response
[avr. 13 16:04:51.431]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf0f00 for ACL packet 0xffffff80d2189600 (local copy of memory descriptor 0xffffff80c807d180) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.431]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) 
[avr. 13 16:04:51.431]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf0780 for ACL packet 0xffffff80d2189600 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.431]  [ATT Send]  Find Information Request - Start Handle:0x002f - End Handle:0xffff
[avr. 13 16:04:51.431]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) ****
[avr. 13 16:04:51.431]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0f00 ****
[avr. 13 16:04:51.442]  [HCI EVENT]  Number of Completed Packets - Connection Handle: 0x0041 - Packets: 0x0002  
[avr. 13 16:04:51.442]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Before decrement -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) 
[avr. 13 16:04:51.442]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2166900 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.442]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf0780 for ACL packet 0xffffff80d2189600 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.442]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Connection Handle = 0x0041 -- BTDevice->decrementNumberOfOutstandingPacketsBy() returned 2 -- lowPriorityACLPackets = 2, midPriorityACLPackets = 0, highPriorityACLPackets = 0 
[avr. 13 16:04:51.442]  [KERNEL DEBUG]  **** [IOBluetoothHostController][DecrementOutstandingACLPackets] - decremented - Delta: Classic L(0) M(0) H(0) LE L(2) M(0) H(0) - Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) ****
[avr. 13 16:04:51.452]  [ATT Receive]  Find Information Response
[avr. 13 16:04:51.453]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf0780 for ACL packet 0xffffff80d2189600 (local copy of memory descriptor 0xffffff80c9d6dac0) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.453]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) 
[avr. 13 16:04:51.453]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2189600 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.453]  [ATT Send]  Find Information Request - Start Handle:0x0031 - End Handle:0xffff
[avr. 13 16:04:51.453]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) ****
[avr. 13 16:04:51.453]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0780 ****
[avr. 13 16:04:51.475]  [ATT Receive]  Error Response - Attribute Handle: 0x0031 - Error Code: 0x0A - Attribute Not Found
[avr. 13 16:04:51.548]  [HCI COMMAND]  [1009] Read Device Address
[avr. 13 16:04:51.548]  [KERNEL DEBUG]  [0x4000] [IOBluetoothHCIRequest][Start] --  OpCode 0x1009 (Read Device Address) from: Chromium (60705)  Synchronous  status: 0x00 (kIOReturnSuccess) state: 2 (BUSY) timeout: 4321
[avr. 13 16:04:51.549]  [HCI EVENT]  Command Complete [1009] - Read Device Address - 9C:35:EB:EF:41:69
[avr. 13 16:04:51.685]  [HCI EVENT]  Number of Completed Packets - Connection Handle: 0x0041 - Packets: 0x0001  
[avr. 13 16:04:51.685]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Before decrement -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) 
[avr. 13 16:04:51.685]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2189600 -- numOutstandingHWPackets = 1, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.685]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Connection Handle = 0x0041 -- BTDevice->decrementNumberOfOutstandingPacketsBy() returned 1 -- lowPriorityACLPackets = 1, midPriorityACLPackets = 0, highPriorityACLPackets = 0 
[avr. 13 16:04:51.685]  [KERNEL DEBUG]  **** [IOBluetoothHostController][DecrementOutstandingACLPackets] - decremented - Delta: Classic L(0) M(0) H(0) LE L(1) M(0) H(0) - Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) ****
[avr. 13 16:04:51.705]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf0240 for ACL packet 0xffffff80d2189600 (local copy of memory descriptor 0xffffff80dca05f80) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.705]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) 
[avr. 13 16:04:51.705]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2189600 -- result = kIOReturnSuccess -- Start ACL Packet timer 
               **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2189600 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.705]  [ATT Send]  Read Request - Handle:0x0030
[avr. 13 16:04:51.705]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) ****
[avr. 13 16:04:51.705]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0240 ****
[avr. 13 16:04:51.734]  [BADL RECEIVE]  Channel ID: 0x0004  Length: 0x0068 (104) [ 0B 54 68 69 73 20 63 68 61 72 61 63 74 65 72 69 ... ]
[avr. 13 16:04:51.734]  [ACL RECEIVE]  Data [Handle: 0x0041, Packet Boundary Flags: 0x1, Length: 0x001B (27)]
[avr. 13 16:04:51.735]  [ACL RECEIVE]  Data [Handle: 0x0041, Packet Boundary Flags: 0x1, Length: 0x001B (27)]
[avr. 13 16:04:51.745]  [ACL RECEIVE]  Data [Handle: 0x0041, Packet Boundary Flags: 0x1, Length: 0x001B (27)]
[avr. 13 16:04:51.746]  [KERNEL DEBUG]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWrite] -- add Bulk Out Write Timer 0xffffff80cfbf0960 for ACL packet 0xffffff80d2189900 (local copy of memory descriptor 0xffffff80d4070a00) -- Start Bulk Out Write timer 
[avr. 13 16:04:51.746]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Handle 0x0041 -- Before increment -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(1) M(0) H(0) 
[avr. 13 16:04:51.746]  [KERNEL DEBUG]  **** [IOBluetoothHostController][SendACLData] -- Connection Handle 0x0041 -- add ACL Timer 0xffffff80cfbf1d40 for ACL packet 0xffffff80d2189900 -- result = kIOReturnSuccess -- Start ACL Packet timer 
[avr. 13 16:04:51.746]  [ATT Send]  Read Blob Request
[avr. 13 16:04:51.746]  [KERNEL DEBUG]  **** [IOBluetoothHostController][TransferACLPacketToHW] -- Handle 0x0041 -- SendACLData() success -- incremented -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) ****
[avr. 13 16:04:51.746]  [NOTE]  **** [IOBluetoothHostControllerUSBTransport][BulkOutWriteCompleteAction] -- removed Bulk Out Write Timer 0xffffff80cfbf0960 ****
[avr. 13 16:04:51.758]  [HCI EVENT]  Number of Completed Packets - Connection Handle: 0x0041 - Packets: 0x0002  
[avr. 13 16:04:51.758]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Before decrement -- Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) 
[avr. 13 16:04:51.758]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf1200 for ACL packet 0xffffff80d2189600 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.758]  [NOTE]  **** [IOBluetoothDevice][decrementNumberOfOutstandingPacketsBy] -- Handle 0x0041 -- remove ACL Timer 0xffffff80cfbf1d40 for ACL packet 0xffffff80d2189900 -- numOutstandingHWPackets = 2, mNumNotDequeuedAckedPackets = 0, mDestroyDeviceCalled = FALSE -- hostController = 0xffffff80c1aec800 ****
[avr. 13 16:04:51.758]  [KERNEL DEBUG]  **** [IOBluetoothHostController][ProcessNumberOfCompletedPacketsEvent] -- Connection Handle = 0x0041 -- BTDevice->decrementNumberOfOutstandingPacketsBy() returned 2 -- lowPriorityACLPackets = 2, midPriorityACLPackets = 0, highPriorityACLPackets = 0 
[avr. 13 16:04:51.758]  [KERNEL DEBUG]  **** [IOBluetoothHostController][DecrementOutstandingACLPackets] - decremented - Delta: Classic L(0) M(0) H(0) LE L(2) M(0) H(0) - Device: Classic: L(0) M(0) H(0) LE: L(2) M(0) H(0) - ACL Pkt: In Q: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) - Outstanding: Classic: L(0) M(0) H(0) LE: L(0) M(0) H(0) ****
[avr. 13 16:04:51.779]  [ATT Receive]  Error Response - Attribute Handle: 0x0030 - Error Code: 0x07 - Invalid Offset
[avr. 13 16:04:52.052]  [HCI COMMAND]  [1009] Read Device Address
[avr. 13 16:04:52.052]  [KERNEL DEBUG]  [0x0000] [IOBluetoothHCIRequest][Start] --  OpCode 0x1009 (Read Device Address) from: Chromium (60705)  Synchronous  status: 0x00 (kIOReturnSuccess) state: 2 (BUSY) timeout: 4321
[avr. 13 16:04:52.053]  [HCI EVENT]  Command Complete [1009] - Read Device Address - 9C:35:EB:EF:41:69
[avr. 13 16:04:52.555]  [HCI COMMAND]  [1009] Read Device Address

Comment 3 by ortuno@chromium.org, Apr 17 2017

Cc: jlebel@chromium.org
Owner: ----
Status: WontFix (was: Untriaged)
That device looks broken. It shouldn't be returning such a long value for the CCC. It seems Android will stop reading the value if the value is too long but mac will continue to read.

Anyway, nothing we can do on our side.

Comment 4 by ortuno@chromium.org, Apr 17 2017 

fwiw: i tested this with a playbulb and had no problems.

Comment 5 by fbeaufort@chromium.org, Apr 21 2017

Summary: bluetooth: mac: Can't read too long "Characteristic User Description" descriptor. (was: bluetooth: mac: Can't read CCC descriptor)
Sorry for not being clear enough, what Mac can't read is NOT the CCC descriptor, it is the "Characteristic User Description" Descriptor: 00002901-0000-1000-8000-00805f9b34fb

There is no max length for this descriptor according to https://www.bluetooth.com/specifications/gatt/viewer?attributeXmlFile=org.bluetooth.descriptor.gatt.characteristic_user_description.xml

Device I use is my Pixel Phone with the BLE Peripheral Simulator Android app.

Comment 6 by fbeaufort@chromium.org, Apr 21 2017

Description: Show this description

Comment 7 by fbeaufort@chromium.org, Apr 24 2017 

FYI, I've just sent a PR at https://github.com/WebBluetoothCG/ble-test-peripheral-android/pull/87 to fix the root issue in the Android App.

Comment 8 by ortuno@chromium.org, Apr 26 2017 

Ah sorry for misreading the descriptor's name. Thanks for the patch!
►

Sign in to add a comment