#4470 BLOC Update.: WLAN stops working after good functionality

[Zarro Boogs per Child]

#4470: WLAN stops working after good functionality
-----------------------+----------------------------------------------------
  Reporter:  kimquirk  |       Owner:  dwmw2   
      Type:  defect    |      Status:  new     
  Priority:  blocker   |   Milestone:  Update.1
 Component:  wireless  |     Version:          
Resolution:            |    Keywords:          
  Verified:  1         |  
-----------------------+----------------------------------------------------

Comment(by dwmw2):

 Again...

 {{{
 [ 2515.822326] libertas tx (INT): SendSinglePacket succeeds
 [ 2515.825131] usb8xxx usbd (INT): 1-1:URB status is successfull
 [ 2515.828079] libertas leave (INT): SendSinglePacket():171, ret 0
 [ 2515.831087] libertas leave (INT): libertas_process_tx():241, ret 0
 [ 2515.834338] libertas leave (INT): libertas_mesh_pre_start_xmit():571,
 ret 0
 [ 2515.837932] libertas thread: main-thread 222 (waking up): intcounter=0
 curre0
 [ 2515.842871] libertas thread: main-thread 333: intcounter=0
 currenttxskb=00000
 [ 2515.847164] libertas thread: main-thread 444: intcounter=0
 currenttxskb=00000
 [ 2515.851544] libertas enter: libertas_execute_next_command():1683
 [ 2515.854596] libertas leave: libertas_execute_next_command():1824
 [ 2515.857644] libertas thread: main-thread 111: intcounter=0
 currenttxskb=00000
 [ 2515.862047] libertas thread: main-thread sleeping... Conn=0 IntC=0
 PS_mode=00
 [ 2515.888957] usb8xxx enter (INT): if_usb_receive():655
 [ 2515.891634] usb8xxx usbd (INT): 1-1:Recv length = 0xcb
 [ 2515.894258] usb8xxx usbd (INT): 1-1:Receive type = 0xBEADC0DE
 [ 2515.897185] usb8xxx usbd (INT): 1-1:Receive type after = 0xBEADC0DE
 [ 2515.900482] libertas enter (INT): libertas_process_rxed_packet():174
 [ 2515.903731] libertas rx (INT): rx data: skb->len-sizeof(RxPd) = 199-20
 = 179
 [ 2515.907408] libertas enter (INT): wlan_compute_rssi():109
 [ 2515.910171] libertas rx (INT): rxpd: SNR 79, NF 90
 [ 2515.912599] libertas rx (INT): before computing SNR: SNR-avg = 40, NF-
 avg = 9
 [ 2515.916378] libertas rx (INT): after computing SNR: SNR-avg = 46, NF-
 avg = 89
 [ 2515.919994] libertas leave (INT): wlan_compute_rssi():134
 [ 2515.922743] libertas rx (INT): rx data: size of actual packet 171
 [ 2515.925955] libertas rx (INT): skb->data cc85ca3a
 [ 2515.928356] libertas leave (INT): libertas_process_rxed_packet():273,
 ret 0
 [ 2515.932006] usb8xxx leave (INT): if_usb_receive():712
 [ 2516.427241] usb8xxx enter (INT): if_usb_receive():655
 [ 2516.429833] usb8xxx usbd (INT): 1-1:Recv length = 0xa5
 [ 2516.432566] usb8xxx usbd (INT): 1-1:Receive type = 0xBEADC0DE
 [ 2516.435507] usb8xxx usbd (INT): 1-1:Receive type after = 0xBEADC0DE
 [ 2516.438696] libertas enter (INT): libertas_process_rxed_packet():174
 [ 2516.442027] libertas rx (INT): rx data: skb->len-sizeof(RxPd) = 161-20
 = 141
 [ 2516.445601] libertas enter (INT): wlan_compute_rssi():109
 [ 2516.448356] libertas rx (INT): rxpd: SNR 63, NF 89
 [ 2516.450801] libertas rx (INT): before computing SNR: SNR-avg = 46, NF-
 avg = 9
 [ 2516.454565] libertas rx (INT): after computing SNR: SNR-avg = 50, NF-
 avg = 89
 [ 2516.458202] libertas leave (INT): wlan_compute_rssi():134
 [ 2516.460935] libertas rx (INT): rx data: size of actual packet 133
 [ 2516.464111] libertas rx (INT): skb->data caa0c2c2
 [ 2516.466520] libertas leave (INT): libertas_process_rxed_packet():273,
 ret 0
 [ 2516.470186] usb8xxx leave (INT): if_usb_receive():712
 [ 2518.857908] olpc-ec:  running cmd 0x26
 [ 2518.862866] olpc-ec:  sending cmd arg 0x1
 [ 2535.132911] libertas enter (INT): libertas_mesh_pre_start_xmit():561
 [ 2535.136228] libertas enter (INT): libertas_process_tx():225
 [ 2535.139113] libertas enter (INT): SendSinglePacket():70
 [ 2535.141906] usb8xxx usbd (INT): 1-1:*** type = 0
 [ 2535.144290] usb8xxx usbd (INT): 1-1:size after = 140
 [ 2535.146874] libertas tx (INT): SendSinglePacket succeeds
 [ 2535.149721] libertas leave (INT): SendSinglePacket():171, ret 0
 [ 2535.152758] libertas leave (INT): libertas_process_tx():241, ret 0
 [ 2535.155949] libertas leave (INT): libertas_mesh_pre_start_xmit():571,
 ret 0
 [ 2539.415089] NETDEV WATCHDOG: eth0: transmit timed out
 }}}

 The C1 machine doesn't seem to be turning off its DCON, which might
 explain the difference (although hopefully the power situation is a lot
 better there and it really is fixed). More investigation in the morning...

-- 
Ticket URL: <http://dev.laptop.org/ticket/4470#comment:74>
One Laptop Per Child <http://dev.laptop.org>
OLPC bug tracking system