[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

[bluetooth-dev] Problems with timeout on l2cap connections



Hi all,

I am testing the OpenBT stack against a device equipped with 1.1 qualified software and hardware. I'm am trying to make a rfcomm connection but it failes when it is waiting for the L2CA_Config_ind. I get a timeout, but as far as I know there should be no wait left to wake up.

I have some doubts on the following debug line:
lp_connect_cfm, wake up flag not set

Im running the stack on an etrax 100 lx dev-board with almost the latest CVS stack. I am using CSR Casira with my etrax dev-board.

Are there anyone out there who has got a clue what is going on here?

Here is my log, all the lines containing PETER are added by me and are in swedish so you can just neglect them.

BT (driver) bt_ioctl: HCINQUIRY

hci_inquiry (9):
0x01 0x01 0x04 0x05 0x33 0x8b 0x9e 0x0a 0x05
BD addr 1

BD (6):
0x00 0x02 0x5b 0xff 0x06 0x76
BT (driver) bt_close on line 7
BT (driver) Unregistering tty on line 7
BT (driver) bt_open on line 7
BT (driver) Registering tty on line 7 (btmain)
BT (driver) Now 1 open fd:s for ttyBTC [btmain]
BT (driver) bt_ioctl: BTCONNECT
BT (driver) bt_connect : Connecting srv ch 1 on line 0
          RFCOMM rfcomm_connect_req: server channel:1, line:0
          RFCOMM rfcomm_connect_req: PETER: Vi är initiator

          RFCOMM rfcomm_connect_req: PETER: Vi hade ingen L2CAP uppkoppling

    L2CAP get_con: look for connections in state ANY_STATE (7)
    L2CAP get_con: connection not found
    L2CAP get_lcon: lcid 64 con_list.count = 0
    L2CAP get_lcon: connection lcid : 64 not found
    L2CAP create_con: rcid 0
    L2CAP init_flow

bd (6):
0x76 0x06 0xff 0x5b 0x02 0x00
show_con: insert_con (64:0) [CLOSED] [RFCOMM] r_mtu[672] C[yes] link_up[no]
    L2CAP insert_con: now 1 connections
    L2CAP l2ca_connect_req: create new baseband link
    L2CAP get_con: look for connections in state ANY_STATE (7)
l2ca_connect_req: wait baseband, sleep on wq 0xc0156824
    L2CAP lp_connect_cfm: Success! (hci_handle : 40)
    L2CAP lp_connect_cfm: bd 00:02:5B:FF:06:76
    L2CAP get_con: look for connections in state CLOSED (0)
lp_connect_cfm (pos), wake up wq 0xc0156824
    L2CAP We are client
    L2CAP Current state of (64:0) is W4_L2CAP_CONNECT_RSP
lp_connect_cfm, wake up flag not set
BT SYS: process_event: ACL link is up
l2ca_connect_req: wait baseband, woke up !
    L2CAP l2ca_connect_reqPETER: nu har vi väntat klart på basbandslänken

    L2CAP l2ca_connect_reqPETER: nu väntar vi på L2CAP uppkoppling.

l2ca_connect_req: wait rsp, sleep on wq 0xc0156824
    L2CAP process_response: Got response: 0x3 id:1
    L2CAP process_response: Got connection response
    L2CAP get_lcon: lcid 64 con_list.count = 1
l2cap con rsp, wake up wq 0xc0156824
    L2CAP Current state of (64:64) is CONFIG
    L2CAP l2ca_connect_cfm: rCID 64, result 0
    L2CAP get_upper: Try to retrieve psm 0x3
    L2CAP get_upper: Actually got psm:0x3
          RFCOMM rfcomm_connect_cfm: status 0
          RFCOMM PETER: Server channel = 1
          RFCOMM rfcomm_connect_cfm: PETER: L2CAP conf was not done...
    L2CAP l2ca_config_req remote cid 64, in_mtu 0
    L2CAP l2cap_config_req: inmtu : 0, local mtu : 672

l2cap options:  (0):
    L2CAP PETER: före sändningen av config req
    L2CAP PETER: efter sändningen av config req
          RFCOMM PETER: Config request skickad och rfcomm_connect_cfm klar

l2ca_connect_req: wait rsp, woke up !
    L2CAP l2ca_connect_reqPETER: nu har vi väntat klart på L2CAP uppkoppling.

          RFCOMM rfcomm_connect_req: PETER: Nu skall vi ha en L2CAP uppkoppling
BT SYS: l2ca_timeoutind
l2ca_timeoutind , wake up flag not set
BT SYS: PETER: l2ca_timeoutind, wq 0xc0156824
BT SYS: PETER: l2ca_timeoutind, conf_req_sent = 1
BT SYS: PETER: l2ca_timeoutind, conf_req_ready = 0
BT SYS: PETER: l2ca_timeoutind, conf_rsp_ready = 0
BT SYS: PETER: l2ca_timeoutind, c_flags = 0
BT SYS: PETER: l2ca_timeoutind, local_cid = 64
BT SYS: PETER: l2ca_timeoutind, remote_cid = 64
BT SYS: wq_timeout