Problem with station constantly disassociated/authenticated/associated

mlist000 mlist000
Thu Jul 17 08:51:51 PDT 2008


Jouni Malinen wrote:
> On Wed, Jul 16, 2008 at 11:40:26PM +0200, mlist000 wrote:
>
>   
>> I am using hostapd version 0.6.3. (This same error occurs on 0.5.8.and 
>> 0.5.10)
>>     
>
> Which driver and driver version are you using? Is this an open network
> or are you using WPA or IEEE 802.1X?
>   

I am using a Compaq WL100 pcmcia card. I have Fedora Core 6 installed on 
this machine so I am using the am using the hostap_cs driver that comes 
with this.

I currently have the network in open mode.
>   
>> In the example of the N95, I get repeated error messages "Too Short Data".
>>     
>
> I haven't seen this in my tests with N95, but I don't remember whether I
> have tested this with Host AP driver (it was more likely with madwifi).
>   

I should state that I am using the phone currently without a sim card. 
(The performance is a little better with the sim).
I have seen on a newsgroup someone else with the same problem with an 
N95 but with a DLink wifi router. They initially thought the problem was 
with the phone because disabling power saving seemed to correct the 
problem. However they found the problem was fixed with a firmware update 
to the router. This meant they could use the N95 in power saving mode 
without problems.
>   
>> I added a few debug print statements which gave:
>>     
>
>   
>> Data Len is 18   ---   should be more than 18
>> Data Left is 0   ---   total len is 18 ----  802.11 hdr len is 18
>> Too short data frame
>> Data Left is 0   ---   should be more than rfc1042 hdr(6)
>>     
>
> It would be interesting to see the full contents of that frame
> (wpa_hexdump(...)).
>
>   

Received management frame - hexdump(len=30): b0 00 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a c0 00 00 00 01 00 00 00
MGMT
mgmt::auth
authentication: STA=00:1d:e9:f7:8c:37 auth_alg=0 auth_transaction=1 
status_code=0 wep=0
  New STA
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: authentication OK (open system)
authentication reply: STA=00:1d:e9:f7:8c:37 auth_alg=0 
auth_transaction=2 resp=0 (IE len=0)
Received management frame - hexdump(len=30): b2 00 02 01 00 1d e9 f7 8c 
37 00 50 8b d0 47 1a 00 50 8b d0 47 1a c0 a6 00 00 02 00 00 00
MGMT (TX callback) ACK
mgmt::auth cb
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: authenticated
Received management frame - hexdump(len=42): 00 00 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a d0 00 01 00 14 00 00 06 66 65 72 
72 65 74 01 04 82 84 0b 16
MGMT
mgmt::assoc_req
association request: STA=00:1d:e9:f7:8c:37 capab_info=0x01 
listen_interval=20
  new AID 1
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: association OK (aid 1)
Received management frame - hexdump(len=36): 12 00 02 01 00 1d e9 f7 8c 
37 00 50 8b d0 47 1a 00 50 8b d0 47 1a d0 a6 01 00 00 00 01 c0 01 04 82 
84 0b 16
MGMT (TX callback) ACK
mgmt::assoc_resp cb
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: associated (aid 1, accounting 
session 487F5F8B-00000012)
Wireless event: cmd=0x8c03 len=20
Received management frame - hexdump(len=24): 48 01 00 00 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a e0 00
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 01 00 00 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a e0 00
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 40 02
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 40 02
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 01 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 00 03
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 01 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 00 03
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 10 03
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 10 03
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 20 03
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 20 03
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 30 03
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 30 03
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 40 03
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 40 03
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 50 03
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 50 03
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 60 03
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 60 03
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=26): a0 10 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 30 04 08 00
MGMT
mgmt::disassoc
disassocation: STA=00:1d:e9:f7:8c:37 reason_code=8
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: disassociated
Wireless event: cmd=0x8c04 len=20
Received management frame - hexdump(len=30): b0 00 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 50 04 00 00 01 00 00 00
MGMT
mgmt::auth
authentication: STA=00:1d:e9:f7:8c:37 auth_alg=0 auth_transaction=1 
status_code=0 wep=0
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: authentication OK (open system)
authentication reply: STA=00:1d:e9:f7:8c:37 auth_alg=0 
auth_transaction=2 resp=0 (IE len=0)
Received management frame - hexdump(len=30): b2 00 02 01 00 1d e9 f7 8c 
37 00 50 8b d0 47 1a 00 50 8b d0 47 1a d0 ad 00 00 02 00 00 00
MGMT (TX callback) ACK
mgmt::auth cb
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: authenticated
Received management frame - hexdump(len=48): 20 00 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 60 04 01 00 14 00 00 50 8b d0 47 
1a 00 06 66 65 72 72 65 74 01 04 82 84 0b 16
MGMT
mgmt::reassoc_req
reassociation request: STA=00:1d:e9:f7:8c:37 capab_info=0x01 
listen_interval=20 current_ap=00:50:8b:d0:47:1a
  old AID 1
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: association OK (aid 1)
Received management frame - hexdump(len=36): 32 00 02 01 00 1d e9 f7 8c 
37 00 50 8b d0 47 1a 00 50 8b d0 47 1a e0 ad 01 00 00 00 01 c0 01 04 82 
84 0b 16
MGMT (TX callback) ACK
mgmt::reassoc_resp cb
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: associated (aid 1, accounting 
session 487F5F8B-00000013)
Wireless event: cmd=0x8c03 len=20
Received management frame - hexdump(len=24): 48 01 00 00 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 70 04
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 01 00 00 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 70 04
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 80 04
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 80 04
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 90 04
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 90 04
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a a0 04
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a a0 04
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a b0 04
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a b0 04
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a c0 04
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a c0 04
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a d0 04
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a d0 04
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a e0 04
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a e0 04
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a f0 04
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a f0 04
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a b0 05
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a b0 05
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a c0 05
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a c0 05
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a d0 05
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a d0 05
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=26): a0 10 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a e0 05 08 00
MGMT
mgmt::disassoc
disassocation: STA=00:1d:e9:f7:8c:37 reason_code=8
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: disassociated
Wireless event: cmd=0x8c04 len=20
Received management frame - hexdump(len=30): b0 10 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 00 06 00 00 01 00 00 00
MGMT
mgmt::auth
authentication: STA=00:1d:e9:f7:8c:37 auth_alg=0 auth_transaction=1 
status_code=0 wep=0
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: authentication OK (open system)
authentication reply: STA=00:1d:e9:f7:8c:37 auth_alg=0 
auth_transaction=2 resp=0 (IE len=0)
Received management frame - hexdump(len=30): b2 00 02 01 00 1d e9 f7 8c 
37 00 50 8b d0 47 1a 00 50 8b d0 47 1a c0 ae 00 00 02 00 00 00
MGMT (TX callback) ACK
mgmt::auth cb
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: authenticated
Received management frame - hexdump(len=48): 20 10 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 10 06 01 00 14 00 00 50 8b d0 47 
1a 00 06 66 65 72 72 65 74 01 04 82 84 0b 16
MGMT
mgmt::reassoc_req
reassociation request: STA=00:1d:e9:f7:8c:37 capab_info=0x01 
listen_interval=20 current_ap=00:50:8b:d0:47:1a
  old AID 1
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: association OK (aid 1)
Received management frame - hexdump(len=36): 32 00 02 01 00 1d e9 f7 8c 
37 00 50 8b d0 47 1a 00 50 8b d0 47 1a d0 ae 01 00 00 00 01 c0 01 04 82 
84 0b 16
MGMT (TX callback) ACK
mgmt::reassoc_resp cb
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: associated (aid 1, accounting 
session 487F5F8B-00000014)
Wireless event: cmd=0x8c03 len=20
Received management frame - hexdump(len=24): 48 11 00 00 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 20 06
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 00 00 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 20 06
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 30 06
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 30 06
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 40 06
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 40 06
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=24): 48 11 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 50 06
DATA
Len is 18   ---   should be 18
*******  DATA FRAME *******  - hexdump(len=24): 48 11 02 01 00 50 8b d0 
47 1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 50 06
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6
Received management frame - hexdump(len=26): c0 10 02 01 00 50 8b d0 47 
1a 00 1d e9 f7 8c 37 00 50 8b d0 47 1a 60 06 03 00
MGMT
mgmt::deauth
deauthentication: STA=00:1d:e9:f7:8c:37 reason_code=3
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: deauthenticated
Wireless event: cmd=0x8c04 len=20



>> I have no trouble at the moment connecting Nokia N93 and E60. (Which are 
>> older phones).
>>
>> The difference with the connections is that the N95 specifies 
>> listen_interval=20. (The other devices all specify listen_interval=10).
>>
>> Could this be the problem ?
>>     
>
> I would not expect this to be the main reason, but the problem may be
> related to N95 power saving. I've seen it having major interop issues
> with many APs.. You could run a quick test by disabling power saving in
> the phone (Settings, Connection, Wireless LAN, Options|Advanced
> settings, disable automatic configuration, disable power saving). If
> this resolves the issue, I will try to figure out whether there would be
> a way of working around this somehow.
>
>   


When I diabled power saving mode - the constant 
association/disassociation problem appeared to stop.


wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: authenticated
wlan0: STA 00:1d:e9:f7:8c:37 IEEE 802.11: associated (aid 1, accounting 
session 487F5A07-00000000)
Len is 18   ---   should be 18
Left is 0   ---   len is 18 ----  hdr is 18
Too short data frame
Left is 0   ---   should be 6

I have been using the web page http://notari.tv as my test data. There 
is a picture on this webpage. Using the N95 I have had about a 2% chance 
of loading the picture on this page over wlan (hostapd). This page 
successfully loads over GPRS. Also, my other Nokia phones N93 and E60 
have no problems loading this page over wlan (hostapd).
With power saving disabled - the picture still did not load.



Thankyou.



More information about the Hostap mailing list