Re: [PATCH 1/1] Bluetooth:L2CAP check FEAT success

From: Nick Pelly <hidden>
Date: 2010-02-12 00:50:24

On Tue, Feb 9, 2010 at 6:52 PM, Liejun Tao [off-list ref] wrote:

ping

On Wed, Feb 3, 2010 at 12:13 PM, Liejun Tao [off-list ref] wrot=

e:

quoted

Hi Marcel,

quoted

Hi Liejun,

I might have an idea what is going here. Can you send me the whole
hcidump -X -V from the Create Connection to the Connection Refused
without having it mangled via your mailer.

Regards

Marcel

In my source, function l2cap_security_cfm & l2cap_information_rsp is
almost same as 2.6.33-rc6.

Ed's log looks almost same as mine.
There migh be minor vairaty like

1.sometimes after Info Req: type 2, there is a Info Req: type 3.

HCI sniffer - Bluetooth packet analyzer ver 1.42

device: hci0 snap_len: 1028 filter: 0xffffffff

2010-02-03 18:03:47.446807 < HCI Command: Create Connection
(0x01|0x0005) plen 13

=E1 =E1bdaddr 00:24:9F:AC:1E:EA ptype 0xcc18 rswitch 0x01 clkoffset 0x00=

quoted

=E1 =E1Packet type: DM1 DM3 DM5 DH1 DH3 DH5

2010-02-03 18:03:47.455749 > HCI Event: Command Status (0x0f) plen 4

=E1 =E1Create Connection (0x01|0x0005) status 0x00 ncmd 1

2010-02-03 18:03:47.993408 > HCI Event: Link Key Request (0x17) plen 6

=E1 =E1bdaddr 00:24:9F:AC:1E:EA

2010-02-03 18:03:47.997131 < HCI Command: Link Key Request Reply
(0x01|0x000b) plen 22

=E1 =E1bdaddr 00:24:9F:AC:1E:EA key 09F010B636EBEC8A3E0E81BBD7AE1CAA

2010-02-03 18:03:47.997802 > HCI Event: Command Complete (0x0e) plen 10

=E1 =E1Link Key Request Reply (0x01|0x000b) ncmd 1

=E1 =E1status 0x00 bdaddr 00:24:9F:AC:1E:EA

2010-02-03 18:03:48.014465 > HCI Event: Connect Complete (0x03) plen 11

=E1 =E1status 0x00 handle 1 bdaddr 00:24:9F:AC:1E:EA type ACL encrypt 0x=

quoted

2010-02-03 18:03:48.014678 < HCI Command: Read Remote Supported
Features (0x01|0x001b) plen 2

=E1 =E1handle 1

2010-02-03 18:03:48.015563 > HCI Event: Command Status (0x0f) plen 4

=E1 =E1Read Remote Supported Features (0x01|0x001b) status 0x00 ncmd 1

2010-02-03 18:03:48.022430 < HCI Command: Remote Name Request
(0x01|0x0019) plen 10

=E1 =E1bdaddr 00:24:9F:AC:1E:EA mode 2 clkoffset 0x0000

2010-02-03 18:03:48.023437 > HCI Event: Command Status (0x0f) plen 4

=E1 =E1Remote Name Request (0x01|0x0019) status 0x00 ncmd 1

2010-02-03 18:03:48.024230 > HCI Event: Max Slots Change (0x1b) plen 3

=E1 =E1handle 1 slots 5

2010-02-03 18:03:48.028198 > HCI Event: Read Remote Supported Features
(0x0b) plen 11

=E1 =E1status 0x00 handle 1

=E1 =E1Features: 0xbf 0xfe 0x8f 0xfe 0x98 0x19 0x00 0x80

2010-02-03 18:03:48.028320 < ACL data: handle 1 flags 0x02 dlen 10

=E1 =E1L2CAP(s): Info req: type 2

2010-02-03 18:03:48.031616 > HCI Event: Number of Completed Packets
(0x13) plen 5

=E1 =E1handle 1 packets 1

2010-02-03 18:03:48.039977 > HCI Event: Remote Name Req Complete (0x07) =

plen 255

quoted

=E1 =E1status 0x00 bdaddr 00:24:9F:AC:1E:EA name 'BlackBerry 8900'

2010-02-03 18:03:48.042755 > ACL data: handle 1 flags 0x02 dlen 12

=E1 =E1L2CAP(s): Info rsp: type 2 result 1

=E1 =E1 =E1Not supported

2010-02-03 18:03:48.042846 < ACL data: handle 1 flags 0x02 dlen 10

=E1 =E1L2CAP(s): Info req: type 3

2010-02-03 18:03:48.045226 > HCI Event: Number of Completed Packets
(0x13) plen 5

=E1 =E1handle 1 packets 1

2010-02-03 18:03:48.090545 > HCI Event: Encrypt Change (0x08) plen 4

=E1 =E1status 0x00 handle 1 encrypt 0x01

2010-02-03 18:03:48.090728 < ACL data: handle 1 flags 0x02 dlen 12

=E1 =E1L2CAP(s): Connect req: psm 3 scid 0x0040

2010-02-03 18:03:48.094024 > HCI Event: Number of Completed Packets
(0x13) plen 5

=E1 =E1handle 1 packets 1

2010-02-03 18:03:48.094146 > ACL data: handle 1 flags 0x02 dlen 12

=E1 =E1L2CAP(s): Info rsp: type 3 result 1

=E1 =E1 =E1Not supported

2010-02-03 18:03:48.094238 < ACL data: handle 1 flags 0x02 dlen 12

=E1 =E1L2CAP(s): Connect req: psm 3 scid 0x0040

2010-02-03 18:03:48.096618 > HCI Event: Number of Completed Packets
(0x13) plen 5

=E1 =E1handle 1 packets 1

2010-02-03 18:03:48.104003 > ACL data: handle 1 flags 0x02 dlen 16

=E1 =E1L2CAP(s): Connect rsp: dcid 0x0040 scid 0x0040 result 0 status 0

=E1 =E1 =E1Connection successful

2010-02-03 18:03:48.104095 < ACL data: handle 1 flags 0x02 dlen 16

=E1 =E1L2CAP(s): Config req: dcid 0x0040 flags 0x00 clen 4

=E1 =E1 =E1MTU 1013

2010-02-03 18:03:48.104125 > ACL data: handle 1 flags 0x02 dlen 16

=E1 =E1L2CAP(s): Config req: dcid 0x0040 flags 0x00 clen 4

=E1 =E1 =E1MTU 1024

2010-02-03 18:03:48.104156 < ACL data: handle 1 flags 0x02 dlen 18

=E1 =E1L2CAP(s): Config rsp: scid 0x0040 flags 0x00 result 0 clen 4

=E1 =E1 =E1MTU 1024

2010-02-03 18:03:48.104339 > ACL data: handle 1 flags 0x02 dlen 16

=E1 =E1L2CAP(s): Connect rsp: dcid 0x0041 scid 0x0040 result 4 status 0

=E1 =E1 =E1Connection refused - no resources available

2010-02-03 18:03:48.107696 > HCI Event: Number of Completed Packets
(0x13) plen 5

=E1 =E1handle 1 packets 2

2010-02-03 18:03:48.115264 > ACL data: handle 1 flags 0x02 dlen 14

=E1 =E1L2CAP(s): Config rsp: scid 0x0040 flags 0x00 result 0 clen 0

=E1 =E1 =E1Success

2010-02-03 18:03:48.115386 > ACL data: handle 1 flags 0x02 dlen 12

=E1 =E1L2CAP(s): Disconn req: dcid 0x0040 scid 0x0040

2010-02-03 18:03:50.101531 < HCI Command: Disconnect (0x01|0x0006) plen =

quoted

=E1 =E1handle 1 reason 0x13

=E1 =E1Reason: Remote User Terminated Connection

2010-02-03 18:03:50.102508 > HCI Event: Command Status (0x0f) plen 4

=E1 =E1Disconnect (0x01|0x0006) status 0x00 ncmd 1

2010-02-03 18:03:50.105438 > HCI Event: Disconn Complete (0x05) plen 4

=E1 =E1status 0x00 handle 1 reason 0x16

=E1 =E1Reason: Connection Terminated by Local Host


2. sometimes Encrypt Change is before Info Req: type 2

HCI sniffer - Bluetooth packet analyzer ver 1.42

2010-02-03 17:58:29.214416 < HCI Command: Create Connection
(0x01|0x0005) plen 13

=E1 =E1bdaddr 00:24:9F:AC:1E:EA ptype 0xcc18 rswitch 0x01 clkoffset 0x00=

quoted

=E1 =E1Packet type: DM1 DM3 DM5 DH1 DH3 DH5

2010-02-03 17:58:29.234832 > HCI Event: Command Status (0x0f) plen 4

=E1 =E1Create Connection (0x01|0x0005) status 0x00 ncmd 1

2010-02-03 17:58:30.559875 > HCI Event: Link Key Request (0x17) plen 6

=E1 =E1bdaddr 00:24:9F:AC:1E:EA

2010-02-03 17:58:30.563995 < HCI Command: Link Key Request Reply
(0x01|0x000b) plen 22

=E1 =E1bdaddr 00:24:9F:AC:1E:EA key 09F010B636EBEC8A3E0E81BBD7AE1CAA

2010-02-03 17:58:30.564819 > HCI Event: Command Complete (0x0e) plen 10

=E1 =E1Link Key Request Reply (0x01|0x000b) ncmd 1

=E1 =E1status 0x00 bdaddr 00:24:9F:AC:1E:EA

2010-02-03 17:58:30.580596 > HCI Event: Connect Complete (0x03) plen 11

=E1 =E1status 0x00 handle 1 bdaddr 00:24:9F:AC:1E:EA type ACL encrypt 0x=

quoted

2010-02-03 17:58:30.580779 < HCI Command: Read Remote Supported
Features (0x01|0x001b) plen 2

=E1 =E1handle 1

2010-02-03 17:58:30.581634 > HCI Event: Command Status (0x0f) plen 4

=E1 =E1Read Remote Supported Features (0x01|0x001b) status 0x00 ncmd 1

2010-02-03 17:58:30.587951 > HCI Event: Max Slots Change (0x1b) plen 3

=E1 =E1handle 1 slots 5

2010-02-03 17:58:30.590515 > HCI Event: Read Remote Supported Features
(0x0b) plen 11

=E1 =E1status 0x00 handle 1

=E1 =E1Features: 0xbf 0xfe 0x8f 0xfe 0x98 0x19 0x00 0x80

2010-02-03 17:58:30.590667 < ACL data: handle 1 flags 0x02 dlen 10

=E1 =E1L2CAP(s): Info req: type 2

2010-02-03 17:58:30.593902 > HCI Event: Number of Completed Packets
(0x13) plen 5

=E1 =E1handle 1 packets 1

2010-02-03 17:58:30.600280 < HCI Command: Remote Name Request
(0x01|0x0019) plen 10

=E1 =E1bdaddr 00:24:9F:AC:1E:EA mode 2 clkoffset 0x0000

2010-02-03 17:58:30.600799 > HCI Event: Command Status (0x0f) plen 4

=E1 =E1Remote Name Request (0x01|0x0019) status 0x00 ncmd 1

2010-02-03 17:58:30.615020 > HCI Event: Remote Name Req Complete (0x07) =

plen 255

quoted

=E1 =E1status 0x00 bdaddr 00:24:9F:AC:1E:EA name 'BlackBerry 8900'

2010-02-03 17:58:30.639282 > HCI Event: Encrypt Change (0x08) plen 4

=E1 =E1status 0x00 handle 1 encrypt 0x01

2010-02-03 17:58:30.639434 < ACL data: handle 1 flags 0x02 dlen 12

=E1 =E1L2CAP(s): Connect req: psm 3 scid 0x0040

2010-02-03 17:58:30.642669 > HCI Event: Number of Completed Packets
(0x13) plen 5

=E1 =E1handle 1 packets 1

2010-02-03 17:58:30.642822 > ACL data: handle 1 flags 0x02 dlen 12

=E1 =E1L2CAP(s): Info rsp: type 2 result 1

=E1 =E1 =E1Not supported

2010-02-03 17:58:30.642883 < ACL data: handle 1 flags 0x02 dlen 12

=E1 =E1L2CAP(s): Connect req: psm 3 scid 0x0040

2010-02-03 17:58:30.645141 > HCI Event: Number of Completed Packets
(0x13) plen 5

=E1 =E1handle 1 packets 1

2010-02-03 17:58:30.652862 > ACL data: handle 1 flags 0x02 dlen 16

=E1 =E1L2CAP(s): Connect rsp: dcid 0x0040 scid 0x0040 result 0 status 0

=E1 =E1 =E1Connection successful

2010-02-03 17:58:30.652862 > ACL data: handle 1 flags 0x02 dlen 16

=E1 =E1L2CAP(s): Config req: dcid 0x0040 flags 0x00 clen 4

=E1 =E1 =E1MTU 1024

2010-02-03 17:58:30.652984 > ACL data: handle 1 flags 0x02 dlen 16

=E1 =E1L2CAP(s): Connect rsp: dcid 0x0041 scid 0x0040 result 4 status 0

=E1 =E1 =E1Connection refused - no resources available

2010-02-03 17:58:30.653137 < ACL data: handle 1 flags 0x02 dlen 16

=E1 =E1L2CAP(s): Config req: dcid 0x0040 flags 0x00 clen 4

=E1 =E1 =E1MTU 1013

2010-02-03 17:58:30.653198 < ACL data: handle 1 flags 0x02 dlen 18

=E1 =E1L2CAP(s): Config rsp: scid 0x0040 flags 0x00 result 0 clen 4

=E1 =E1 =E1MTU 1024

2010-02-03 17:58:30.657653 > HCI Event: Number of Completed Packets
(0x13) plen 5

=E1 =E1handle 1 packets 2

2010-02-03 17:58:30.665191 > ACL data: handle 1 flags 0x02 dlen 14

=E1 =E1L2CAP(s): Config rsp: scid 0x0040 flags 0x00 result 0 clen 0

=E1 =E1 =E1Success

2010-02-03 17:58:30.665283 > ACL data: handle 1 flags 0x02 dlen 12

=E1 =E1L2CAP(s): Disconn req: dcid 0x0040 scid 0x0040

2010-02-03 17:58:32.648467 < HCI Command: Disconnect (0x01|0x0006) plen =

quoted

=E1 =E1handle 1 reason 0x13

=E1 =E1Reason: Remote User Terminated Connection

2010-02-03 17:58:32.649322 > HCI Event: Command Status (0x0f) plen 4

=E1 =E1Disconnect (0x01|0x0006) status 0x00 ncmd 1

2010-02-03 17:58:32.652984 > HCI Event: Disconn Complete (0x05) plen 4

=E1 =E1status 0x00 handle 1 reason 0x16

=E1 =E1Reason: Connection Terminated by Local Host

Hi Marcel,

You said you had some idea what was going on here. Do you have a
better approach in mind to fix this?

Nick

`h`	back out one level
`j`	next message in thread
`k`	previous message in thread
`l`	drill in
`Esc`	close help / fold thread tree
`?`	toggle this help