#2799 HIGH Update.: wireles assoc failure
Zarro Boogs per Child
bugtracker at laptop.org
Mon Dec 10 01:02:23 EST 2007
#2799: wireles assoc failure
-----------------------+----------------------------------------------------
Reporter: dwmw2 | Owner: jcardona
Type: defect | Status: closed
Priority: high | Milestone: Update.1
Component: wireless | Version:
Resolution: fixed | Keywords:
Verified: 0 |
-----------------------+----------------------------------------------------
Comment(by dwmw2):
Still happening for me intermittently with 5.110.20.p42. (upstream driver)
{{{
[ 1148.326711] libertas assoc: Association Request:
[ 1148.326723] flags: 0x00000012
[ 1148.326730] SSID: 'media lab 802.11'
[ 1148.326738] chann: 11
[ 1148.326744] band: 0
[ 1148.326750] mode: 2
[ 1148.326756] BSSID: 00:00:00:00:00:00
[ 1148.326764] secinfo:
[ 1148.326770] auth_mode: 1
[ 1148.358444] libertas assoc: SSID 'media lab 802.11' requested
[ 1148.364346] libertas scan: numchannels 4, bsstype 3, filteredscan 0
[ 1148.370818] libertas scan: chan_count 11, last_scanned_channel 0
[ 1148.376981] libertas scan: scanning 4 of 11 channels
[ 1148.382138] libertas host: PREP_CMD: command 0x0006
[ 1148.387162] libertas host: QUEUE_CMD: inserted command 0x0006 into
cmdpendingq
[ 1148.394563] libertas host: PREP_CMD: wait for response
[ 1148.399901] libertas thread: main-thread 222 (waking up): intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1148.409624] libertas thread: main-thread 333: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1148.418247] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1148.426869] libertas host: EXEC_NEXT_CMD: sending command 0x0006
[ 1148.433030] libertas host: DNLD_CMD: command 0x0006, size 83, jiffies
848304
[ 1148.440255] usb8xxx usbd: 1-2:*** type = 1
[ 1148.444468] usb8xxx usbd: 1-2:size after = 83
[ 1148.449003] libertas cmd: DNLD_CMD: sent command 0x0006, jiffies 848320
[ 1148.455870] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1148.464541] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1148.897776] usb8xxx usbd (INT): 1-2:Recv length = 0xb7, Recv type =
0xF00DFACE
[ 1148.905239] libertas thread (INT): lbs_interrupt: intcounter=0
[ 1148.911197] usb8xxx usbd (INT): 1-2:Wake up main thread to handle cmd
response
[ 1148.918741] libertas thread: main-thread 222 (waking up): intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1148.928442] libertas thread: main-thread 333: intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1148.937071] usb8xxx usbd: 1-2:Int cause is 0x8
[ 1148.941591] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1148.950158] libertas thread: main-thread: cmd response ready
[ 1148.956397] libertas host: CMD_RESP: response 0x8006, size 179, jiffies
848827
[ 1148.963820] libertas scan: SCAN_RESP: bssdescriptsize 156
[ 1148.969358] libertas scan: SCAN_RESP: scan results 1
[ 1148.974462] libertas scan: process_bss: BSSID 00:1a:a2:be:0d:c0
[ 1148.980531] libertas scan: process_bss: RSSI 48
[ 1148.985190] libertas scan: process_bss: capabilities 0x0421
[ 1148.990900] libertas scan: process_bss: IE len 135
[ 1148.995826] libertas scan: got SSID IE: 'media lab 802.11', len 16
[ 1149.002153] libertas scan: got RATES IE
[ 1149.006108] libertas scan: got DS IE, channel 1
[ 1149.010769] libertas scan: got IE 0x002a, len 1
[ 1149.015433] libertas scan: got RATESEX IE
[ 1149.019569] libertas scan: got IE 0x0085, len 30
[ 1149.024313] libertas scan: got IE 0x0096, len 6
[ 1149.028976] libertas scan: got generiec IE: 00:40:96:01, len 6
[ 1149.034954] libertas scan: got generiec IE: 00:40:96:03, len 5
[ 1149.040930] libertas scan: got generiec IE: 00:40:96:0b, len 5
[ 1149.046903] libertas scan: got generiec IE: 00:40:96:14, len 5
[ 1149.052886] libertas scan: got generiec IE: 00:50:f2:02, len 24
[ 1149.058964] libertas scan: SCAN_RESP: BSSID 00:1a:a2:be:0d:c0
[ 1149.064905] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.073541] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1149.084850] libertas scan: scanning 4 of 7 channels
[ 1149.089962] libertas host: PREP_CMD: command 0x0006
[ 1149.095006] libertas host: QUEUE_CMD: inserted command 0x0006 into
cmdpendingq
[ 1149.102412] libertas host: PREP_CMD: wait for response
[ 1149.108242] libertas thread: main-thread 222 (waking up): intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.118263] libertas thread: main-thread 333: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.126949] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.135652] libertas host: EXEC_NEXT_CMD: sending command 0x0006
[ 1149.141830] libertas host: DNLD_CMD: command 0x0006, size 83, jiffies
849013
[ 1149.149044] usb8xxx usbd: 1-2:*** type = 1
[ 1149.153256] usb8xxx usbd: 1-2:size after = 83
[ 1149.157787] libertas cmd: DNLD_CMD: sent command 0x0006, jiffies 849029
[ 1149.164694] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.173361] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1149.604776] usb8xxx usbd (INT): 1-2:Recv length = 0xf, Recv type =
0xF00DFACE
[ 1149.612151] libertas thread (INT): lbs_interrupt: intcounter=0
[ 1149.618109] usb8xxx usbd (INT): 1-2:Wake up main thread to handle cmd
response
[ 1149.625652] libertas thread: main-thread 222 (waking up): intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1149.635391] libertas thread: main-thread 333: intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1149.644028] usb8xxx usbd: 1-2:Int cause is 0x8
[ 1149.648541] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.657104] libertas thread: main-thread: cmd response ready
[ 1149.662923] libertas host: CMD_RESP: response 0x8006, size 11, jiffies
849534
[ 1149.670230] libertas scan: SCAN_RESP: bssdescriptsize 0
[ 1149.675618] libertas scan: SCAN_RESP: scan results 0
[ 1149.680764] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.689406] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1149.697663] libertas scan: scanning 3 of 3 channels
[ 1149.702738] libertas host: PREP_CMD: command 0x0006
[ 1149.707768] libertas host: QUEUE_CMD: inserted command 0x0006 into
cmdpendingq
[ 1149.715167] libertas host: PREP_CMD: wait for response
[ 1149.720471] libertas thread: main-thread 222 (waking up): intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.730162] libertas thread: main-thread 333: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.738785] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.747414] libertas host: EXEC_NEXT_CMD: sending command 0x0006
[ 1149.753580] libertas host: DNLD_CMD: command 0x0006, size 76, jiffies
849624
[ 1149.760792] usb8xxx usbd: 1-2:*** type = 1
[ 1149.765002] usb8xxx usbd: 1-2:size after = 76
[ 1149.769528] libertas cmd: DNLD_CMD: sent command 0x0006, jiffies 849640
[ 1149.776388] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1149.785053] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1150.104776] usb8xxx usbd (INT): 1-2:Recv length = 0xb7, Recv type =
0xF00DFACE
[ 1150.112240] libertas thread (INT): lbs_interrupt: intcounter=0
[ 1150.118198] usb8xxx usbd (INT): 1-2:Wake up main thread to handle cmd
response
[ 1150.125741] libertas thread: main-thread 222 (waking up): intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1150.135588] libertas thread: main-thread 333: intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1150.144231] usb8xxx usbd: 1-2:Int cause is 0x8
[ 1150.148748] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.157318] libertas thread: main-thread: cmd response ready
[ 1150.163130] libertas host: CMD_RESP: response 0x8006, size 179, jiffies
850034
[ 1150.170529] libertas scan: SCAN_RESP: bssdescriptsize 156
[ 1150.176069] libertas scan: SCAN_RESP: scan results 1
[ 1150.181170] libertas scan: process_bss: BSSID 00:1a:a2:be:09:b0
[ 1150.187253] libertas scan: process_bss: RSSI 61
[ 1150.191910] libertas scan: process_bss: capabilities 0x0021
[ 1150.197637] libertas scan: process_bss: IE len 135
[ 1150.202558] libertas scan: got SSID IE: 'media lab 802.11', len 16
[ 1150.208891] libertas scan: got RATES IE
[ 1150.212845] libertas scan: got DS IE, channel 11
[ 1150.217584] libertas scan: got IE 0x002a, len 1
[ 1150.222232] libertas scan: got RATESEX IE
[ 1150.226364] libertas scan: got IE 0x0085, len 30
[ 1150.231101] libertas scan: got IE 0x0096, len 6
[ 1150.235754] libertas scan: got generiec IE: 00:40:96:01, len 6
[ 1150.241736] libertas scan: got generiec IE: 00:40:96:03, len 5
[ 1150.247722] libertas scan: got generiec IE: 00:40:96:0b, len 5
[ 1150.253698] libertas scan: got generiec IE: 00:40:96:14, len 5
[ 1150.259680] libertas scan: got generiec IE: 00:50:f2:02, len 24
[ 1150.265824] usb8xxx usbd (INT): 1-2:Recv length = 0x5c, Recv type =
0xBEADC0DE
[ 1150.273515] libertas scan: SCAN_RESP: BSSID 00:1a:a2:be:09:b0
[ 1150.279483] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.288117] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1150.296496] libertas scan: scan table:
[ 1150.300474] libertas scan: 00: BSSID 00:1a:a2:be:0d:c0, RSSI 48, SSID
'media lab 802.11'
[ 1150.308769] libertas scan: 01: BSSID 00:1a:a2:be:09:b0, RSSI 61, SSID
'media lab 802.11'
[ 1150.317134] libertas host: PREP_CMD: command 0x0011
[ 1150.322173] libertas host: QUEUE_CMD: inserted command 0x0011 into
cmdpendingq
[ 1150.329579] libertas host: PREP_CMD: wait for response
[ 1150.335187] libertas thread: main-thread 222 (waking up): intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.344896] libertas thread: main-thread 333: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.353527] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.362158] libertas host: EXEC_NEXT_CMD: sending command 0x0011
[ 1150.368323] libertas host: DNLD_CMD: command 0x0011, size 25, jiffies
850239
[ 1150.375535] usb8xxx usbd: 1-2:*** type = 1
[ 1150.379763] usb8xxx usbd: 1-2:size after = 25
[ 1150.384302] libertas cmd: DNLD_CMD: sent command 0x0011, jiffies 850255
[ 1150.391195] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.399915] usb8xxx usbd (INT): 1-2:Recv length = 0x1d, Recv type =
0xF00DFACE
[ 1150.407412] libertas thread (INT): lbs_interrupt: intcounter=0
[ 1150.413419] usb8xxx usbd (INT): 1-2:Wake up main thread to handle cmd
response
[ 1150.420984] libertas thread: main-thread 222 (waking up): intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1150.430699] libertas thread: main-thread 333: intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1150.439322] usb8xxx usbd: 1-2:Int cause is 0x8
[ 1150.443840] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.452407] libertas thread: main-thread: cmd response ready
[ 1150.458220] libertas host: CMD_RESP: response 0x8011, size 25, jiffies
850329
[ 1150.465569] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.474214] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1150.482447] libertas host: PREP_CMD: command 0x001c
[ 1150.487477] libertas host: QUEUE_CMD: inserted command 0x001c into
cmdpendingq
[ 1150.494868] libertas host: PREP_CMD: wait for response
[ 1150.500167] libertas thread: main-thread 222 (waking up): intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.509863] libertas thread: main-thread 333: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.518489] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.527116] libertas host: EXEC_NEXT_CMD: sending command 0x001c
[ 1150.533269] libertas host: DNLD_CMD: command 0x001c, size 12, jiffies
850404
[ 1150.540484] usb8xxx usbd: 1-2:*** type = 1
[ 1150.544700] usb8xxx usbd: 1-2:size after = 12
[ 1150.549230] libertas cmd: DNLD_CMD: sent command 0x001c, jiffies 850420
[ 1150.556125] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.564846] usb8xxx usbd (INT): 1-2:Recv length = 0x10, Recv type =
0xF00DFACE
[ 1150.572343] libertas thread (INT): lbs_interrupt: intcounter=0
[ 1150.578350] usb8xxx usbd (INT): 1-2:Wake up main thread to handle cmd
response
[ 1150.585915] libertas thread: main-thread 222 (waking up): intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1150.595638] libertas thread: main-thread 333: intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1150.604271] usb8xxx usbd: 1-2:Int cause is 0x8
[ 1150.608799] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.617357] libertas thread: main-thread: cmd response ready
[ 1150.623187] libertas host: CMD_RESP: response 0x801c, size 12, jiffies
850494
[ 1150.630561] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.639200] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1150.647405] libertas cmd: RADIO_SET: radio 1, preamble 2
[ 1150.652894] libertas host: PREP_CMD: command 0x0050
[ 1150.657923] libertas assoc: ASSOC_CMD: num rates 12
[ 1150.662940] libertas assoc: ASSOC_CMD: capability 0x0421
[ 1150.668401] libertas host: QUEUE_CMD: inserted command 0x0050 into
cmdpendingq
[ 1150.675808] libertas host: PREP_CMD: wait for response
[ 1150.684280] libertas thread: main-thread 222 (waking up): intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.693988] libertas thread: main-thread 333: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.702623] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.711248] libertas host: EXEC_NEXT_CMD: sending command 0x0050
[ 1150.717411] libertas host: DNLD_CMD: command 0x0050, size 72, jiffies
850588
[ 1150.724641] usb8xxx usbd: 1-2:*** type = 1
[ 1150.728854] usb8xxx usbd: 1-2:size after = 72
[ 1150.733385] libertas cmd: DNLD_CMD: sent command 0x0050, jiffies 850604
[ 1150.740251] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1150.748925] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1151.299780] usb8xxx usbd (INT): 1-2:Recv length = 0x12, Recv type =
0xF00DFACE
[ 1151.307239] libertas thread (INT): lbs_interrupt: intcounter=0
[ 1151.313201] usb8xxx usbd (INT): 1-2:Wake up main thread to handle cmd
response
[ 1151.320746] libertas thread: main-thread 222 (waking up): intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1151.330466] libertas thread: main-thread 333: intcounter=1
currenttxskb=00000000 dnld_sent=0
[ 1151.339096] usb8xxx usbd: 1-2:Int cause is 0x8
[ 1151.343612] libertas thread: main-thread 444: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1151.352184] libertas thread: main-thread: cmd response ready
[ 1151.358016] libertas host: CMD_RESP: response 0x8012, size 14, jiffies
851229
[ 1151.365327] libertas assoc: ASSOC_RESP: authentication refused by AP
[ 1151.371883] libertas thread: main-thread 111: intcounter=0
currenttxskb=00000000 dnld_sent=0
[ 1151.380536] libertas thread: main-thread sleeping... Conn=1 IntC=0
PS_mode=0 PS_State=0
[ 1151.388789] libertas assoc: ASSOC: association unsuccessful, not
connected
[ 1151.395848] libertas assoc: ASSOC: reconfiguration attempt
unsuccessful: -1
}}}
--
Ticket URL: <http://dev.laptop.org/ticket/2799#comment:12>
One Laptop Per Child <http://dev.laptop.org>
OLPC bug tracking system
More information about the Bugs
mailing list