#7458 BLOC 8.2.0 (: Intermitent suspend/resume lockup

[Zarro Boogs per Child]

#7458: Intermitent suspend/resume lockup
----------------------------+-----------------------------------------------
   Reporter:  dsaxena       |       Owner:  dsaxena                          
       Type:  defect        |      Status:  new                              
   Priority:  blocker       |   Milestone:  8.2.0 (was Update.2)             
  Component:  not assigned  |     Version:  Development build as of this date
 Resolution:                |    Keywords:  joyride-2131:-                   
Next_action:  diagnose      |    Verified:  0                                
  Blockedby:                |    Blocking:  7393                             
----------------------------+-----------------------------------------------

Comment(by jcardona):

 {{{
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.088069] libertas host:
 CMD_RESP: response 0x8045, seq 142, size 8, jiffies 282254
 }}}

 Firmware response to the CMD_802_11_HOST_SLEEP_ACTIVATE command:  USB
 endpoints are now disabled.

 {{{
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.088105] libertas thread: main-
 thread 111: intcounter=0 currenttxskb=00000000 dnld_sent=0
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.088132] libertas thread: main-
 thread sleeping... Conn=0 IntC=0 PS_mode=0 PS_State=0
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.088550] ehci_bus_suspend:
 USBCMD: 0x10009
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.088568] ehci_bus_suspend:
 USBSTS: 0x8
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.088585] ehci_bus_suspend:
 USBCMD: 0x10009
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.088601] ehci_bus_suspend:
 USBSTS: 0x8
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.088926] ehci_bus_suspend:
 USBCMD: 0x10008
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.088942] ehci_bus_suspend:
 USBSTS: 0x1008
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.110373] ehci_pci_suspend:
 USBCMD: 0x10008
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.110373] ehci_pci_suspend:
 USBSTS: 0x1008
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.146903] olpc-ec:  running cmd
 0x1c
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.149947] olpc-ec:  received 0xff
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.149947] olpc-ec:  running cmd
 0x1b
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.149947] olpc-ec:  sending cmd
 arg 0xbb
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.149947] olpc-ec:  running cmd
 0x32
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.149947] olpc-ec:  timeout
 waiting for EC to read command!
 }}}

 The last command seems to have failed.  We should see a
 {{{'olpc_do_sleep!'}}} message and we do not.

 {{{
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.149947] olpc-ec:  running cmd
 0x84
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.149947] olpc-ec:  received 0x20
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.150039] olpc-pm:  SCI 0x20
 received
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.150059] olpc-ec:  running cmd
 0x84
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.159947] olpc-ec:  received 0x0
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.160013] olpc-pm:  SCI 0x0
 received
 }}}

 We never see a {{{olpc-ec:  running cmd 0x24}}} which wakes up the
 firmware via GPIO, so
 the USB endpoints are not restored.

 {{{
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.176786] PM: Writing back config
 space on device 0000:00:0c.1 at offset 1 (was 2b00002, writing 2b00006)
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.176916] PM: Writing back config
 space on device 0000:00:0c.2 at offset 1 (was 2b00002, writing 2b00006)
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.196629] PCI: Setting latency
 timer of device 0000:00:0f.3 to 64
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.208007] PCI: Setting latency
 timer of device 0000:00:0f.4 to 64
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.262198] PCI: Setting latency
 timer of device 0000:00:0f.5 to 64
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.489425] libertas host:
 PREP_CMD: command 0x001f
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.489448] libertas host:
 QUEUE_CMD: inserted command 0x001f into cmdpendingq
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.489487] libertas thread: main-
 thread 222 (waking up): intcounter=0 currenttxskb=00000000 dnld_sent=0
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.489516] libertas thread: main-
 thread 333: intcounter=0 currenttxskb=00000000 dnld_sent=0
 Jul 11 18:42:53 xo-14-68-7A kernel: [ 3173.489555] devpath 1 ep3in
 3strikes
 }}}

 ... and so the command fails to be transmitted.

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