#1752 BLOC Trial-2: USB wireless suspend/resume failure at setup phase

Zarro Boogs per Child bugtracker at laptop.org
Mon Jul 2 16:29:51 EDT 2007


#1752: USB wireless suspend/resume failure at setup phase
-----------------------+----------------------------------------------------
  Reporter:  marcelo   |       Owner:  richard
      Type:  defect    |      Status:  new    
  Priority:  blocker   |   Milestone:  Trial-2
 Component:  wireless  |     Version:         
Resolution:            |    Keywords:         
  Verified:  0         |  
-----------------------+----------------------------------------------------
Changes (by cjb):

 * cc: dilinger (added)

Comment:

 With wireless firmware 16.p0 I fail quickly.  On first resume:

 {{{
 [  560.802889] olpc_do_sleep!
 +r[    0.089394] Timeout waiting for EC to read command!
 [    0.888823] usb usb1: root hub lost power or was reset
 [    1.132052] usb_reset_device!
 [    1.212156] hub_port_wait_reset: portstatus=503 portchange=10
 [    1.361627] hub_port_wait_reset: portstatus=503 portchange=10
 [    1.441649] devpath 1 ep0out 3strikes
 [    1.670587] devpath 1 ep0out 3strikes
 [    1.898855] usb 1-1: device not accepting address 2, error -71
 [    1.981515] hub_port_wait_reset: portstatus=503 portchange=10
 [    2.128364] hub_port_wait_reset: portstatus=503 portchange=10
 [    2.241735] devpath 1 ep0in 3strikes
 [    2.263542] usb 1-1: device descriptor read/all, error -71
 [    2.352074] hub_port_wait_reset: portstatus=503 portchange=10
 [    2.471837] devpath 1 ep0in 3strikes
 [    2.494652] usb 1-1: device descriptor read/8, error -71
 [    2.651779] devpath 1 ep0in 3strikes
 [    2.674995] usb 1-1: device descriptor read/8, error -71
 [    2.870479] hub_port_wait_reset: portstatus=503 portchange=10
 [    2.990001] old descriptor:
 [    3.013106] bLength: 12
 [    3.035505] bDescriptorType: 1
 [    3.058345] bcdUSB: 200
 [    3.080465] bDeviceClass: 0
 [    3.102676] bDeviceSubClass: 0
 [    3.124918] bDeviceProtocol: 0
 [    3.146855] bMaxPacketSize0: 40
 [    3.168882] idVendor: 1286
 [    3.190148] idProduct: 2001
 [    3.211139] bcdDevice: 3107
 [    3.231915] iManufacturer: 1
 [    3.252753] iProduct: 2
 [    3.272615] iSerialNumber: 0
 [    3.292416] bNumConfigurations: 1
 [    3.312581] new descriptor:
 [    3.332417] bLength: 12
 [    3.351422] bDescriptorType: 1
 [    3.370887] bcdUSB: 200
 [    3.389498] bDeviceClass: 0
 [    3.408444] bDeviceSubClass: 0
 [    3.427513] bDeviceProtocol: 0
 [    3.446280] bMaxPacketSize0: 40
 [    3.464734] idVendor: 1286
 [    3.482461] idProduct: 2001
 [    3.499882] bcdDevice: 3105
 [    3.517425] iManufacturer: 1
 [    3.534724] iProduct: 2
 [    3.551657] iSerialNumber: 0
 [    3.568682] bNumConfigurations: 1
 [    3.586346] USB_REQ_SET_CONFIGURATION!
 [    3.606603] devpath 1 ep0out 3strikes
 [    3.624703] dev->type = c068ae78
 [    3.641540] devpath 1 ep2out 3strikes
 [    3.658557] devpath 1 ep3in 3strikes
 [    3.675041] calling resume directly!
 [    3.691909] devpath 1 ep2out 3strikes
 [    3.708074] devpath 1 ep3in 3strikes
 [    3.799525] Restarting tasks ... <3>hub 1-0:1.0: port 1 disabled by hub
 (EMI.
 [    3.899555] done.
 -bash-3.1# [    5.117960] hub_port_wait_reset: portstatus=503
 portchange=10
 [    5.258437] hub_port_wait_reset: portstatus=503 portchange=10
 [    6.881403] devpath 1 ep2out 3strikes
 [    6.898634] devpath 1 ep3in 3strikes
 [    7.980491] devpath 1 ep2out 3strikes
 [    9.079246] devpath 1 ep2out 3strikes
 [    9.369582] libertas: firmware not ready
 [   10.176052] devpath 1 ep2out 3strikes
 [   11.273981] devpath 1 ep2out 3strikes
 [   12.379469] usb_reset_device!
 [   12.455757] hub_port_wait_reset: portstatus=503 portchange=12
 [   12.592978] hub_port_wait_reset: portstatus=503 portchange=12
 [   12.709215] devpath 1 ep0in 3strikes
 [   12.727176] usb 1-1: device descriptor read/all, error -71
 [   12.805816] hub_port_wait_reset: portstatus=503 portchange=10
 [   12.943040] hub_port_wait_reset: portstatus=503 portchange=10
 [   13.060172] USB_REQ_SET_CONFIGURATION!
 [   13.092709] Resetting OLPC wireless...
 [   13.278743] devpath 1 ep2out 3strikes
 [   13.298012] devpath 1 ep3in 3strikes
 [   14.375533] usb_reset_device!
 [   14.458645] hub_port_wait_reset: portstatus=503 portchange=11
 [   14.480786] hub_port_wait_reset: connection bounced!
 [   14.502137] logical disconnect on port 1
 [   14.522655] libertas: firmware init failed
 [   16.664580] usb8xxx: probe of 1-1:1.0 failed with error -12
 [   16.914708] hub_port_wait_reset: portstatus=503 portchange=10
 [   17.058184] hub_port_wait_reset: portstatus=503 portchange=10
 [   17.175289] devpath 1 ep0in 3strikes
 [   17.196685] usb 1-1: device descriptor read/all, error -71
 [   17.277889] hub_port_wait_reset: portstatus=503 portchange=10
 [   17.426858] hub_port_wait_reset: portstatus=503 portchange=10
 [   17.540093] devpath 1 ep0in 3strikes
 [   17.562213] devpath 1 ep0in 3strikes
 [   17.584083] devpath 1 ep0in 3strikes
 [   17.605705] devpath 1 ep0in 3strikes
 [   17.627451] devpath 1 ep0out 3strikes
 [   17.648639] usb 1-1: can't set config #1, error -71
 [   17.670807] hub 1-0:1.0: port 1 disabled by hub (EMI?), re-enabling...
 [   17.754308] hub_port_wait_reset: portstatus=503 portchange=10
 [   17.894403] hub_port_wait_reset: portstatus=503 portchange=12
 [   18.045126] devpath 1 ep3in 3strikes
 [   18.157364] devpath 1 ep2out 3strikes
 [   20.356524] usb_reset_device!
 [   20.432817] hub_port_wait_reset: portstatus=503 portchange=12
 [   20.575915] hub_port_wait_reset: portstatus=503 portchange=12
 [   20.655011] libertas: firmware not ready
 [   20.704653] devpath 1 ep0in 3strikes
 [   20.725973] usb 1-1: device descriptor read/all, error -71
 [   20.804755] hub_port_wait_reset: portstatus=503 portchange=10
 [   20.945351] hub_port_wait_reset: portstatus=503 portchange=12
 [   21.052603] USB_REQ_SET_CONFIGURATION!
 [   21.075831] devpath 1 ep0out 3strikes
 [   21.111156] Resetting OLPC wireless...
 [   21.132697] devpath 1 ep2out 3strikes
 [   21.305050] devpath 1 ep2out 3strikes
 [   21.325972] devpath 1 ep3in 3strikes
 [   22.405690] usb_reset_device!
 [   22.480575] hub_port_wait_reset: portstatus=503 portchange=13
 [   22.504016] hub_port_wait_reset: connection bounced!
 [   22.526615] logical disconnect on port 1
 [   22.547939] libertas: firmware init failed
 [   22.633298] usb8xxx: probe of 1-1:1.0 failed with error -12
 [   22.713412] hub_port_wait_reset: portstatus=503 portchange=10
 [   22.853011] hub_port_wait_reset: portstatus=503 portchange=10
 [   22.964880] devpath 1 ep0in 3strikes
 [   22.985691] usb 1-1: unable to read config index 0 descriptor/all
 [   23.009853] usb 1-1: can't read configurations, error -71
 [   23.092719] hub_port_wait_reset: portstatus=503 portchange=10
 [   23.229944] hub_port_wait_reset: portstatus=503 portchange=10
 [   23.474399] devpath 1 ep3in 3strikes
 [   23.571140] devpath 1 ep2out 3strikes
 [   25.774965] usb_reset_device!
 [   25.855217] hub_port_wait_reset: portstatus=503 portchange=12
 [   26.005062] hub_port_wait_reset: portstatus=503 portchange=12
 [   26.125671] devpath 1 ep0in 3strikes
 [   26.147952] old descriptor:
 [   26.169191] bLength: 12
 [   26.189501] bDescriptorType: 1
 [   26.210055] bcdUSB: 200
 [   26.230073] bDeviceClass: 0
 [   26.250026] bDeviceSubClass: 0
 [   26.270192] bDeviceProtocol: 0
 [   26.290146] bMaxPacketSize0: 40
 [   26.309794] idVendor: 1286
 [   26.329416] idProduct: 2001
 [   26.348511] bcdDevice: 3107
 [   26.367397] iManufacturer: 1
 [   26.386068] iProduct: 2
 [   26.403856] iSerialNumber: 0
 [   26.422284] bNumConfigurations: 1
 [   26.440832] new descriptor:
 [   26.458712] bLength: 12
 [   26.476072] bDescriptorType: 1
 [   26.494015] bcdUSB: 200
 [   26.511433] bDeviceClass: 0
 [   26.529281] bDeviceSubClass: 0
 [   26.547251] bDeviceProtocol: 0
 [   26.564764] bMaxPacketSize0: 40
 [   26.582215] idVendor: 1286
 [   26.598964] idProduct: 2001
 [   26.615594] bcdDevice: 3107
 [   26.631824] iManufacturer: 1
 [   26.647720] iProduct: 2
 [   26.663310] iSerialNumber: 0
 [   26.678963] bNumConfigurations: 1
 [   26.694814] devpath 1 ep0out 3strikes
 [   26.710745] USB_REQ_SET_CONFIGURATION!
 [   26.726809] devpath 1 ep0out 3strikes
 [   26.742816] usb 1-1: can't restore configuration #1 (error=-71)
 [   26.761442] logical disconnect on port 1
 [   26.778192] libertas: firmware init failed
 [   27.274618] usb8xxx: probe of 1-1:1.0 failed with error -12
 [   27.348948] hub_port_wait_reset: portstatus=503 portchange=10
 [   27.432563] devpath 1 ep0in 3strikes
 [   27.449804] devpath 1 ep0in 3strikes
 [   27.466676] devpath 1 ep0in 3strikes
 [   27.538792] hub_port_wait_reset: portstatus=503 portchange=12
 [   27.608514] usb 1-1: device descriptor read/64, error -71
 [   27.794621] hub_port_wait_reset: portstatus=503 portchange=12
 [   27.871742] devpath 1 ep0out 3strikes
 [   28.103232] devpath 1 ep0out 3strikes
 [   28.328971] usb 1-1: device not accepting address 9, error -71
 [   28.413784] hub_port_wait_reset: portstatus=100 portchange=10
 [   28.435041] hub_port_wait_reset: device went away!
 }}}

 With 15.5, it successfully resumes a few times, but then:

 {{{
 +r[    0.089589] Timeout waiting for EC to read command!
 [    0.709093] usb usb1: root hub lost power or was reset
 [    0.950367] usb_reset_device!
 [    1.031939] hub_port_wait_reset: portstatus=503 portchange=10
 }}}

 and we're hung forever after the hub_port_wait_reset.

 It would be good to able to rule out the EC from these bugs, given the
 timeouts; we'll need Richard/Andres for that.

-- 
Ticket URL: <http://dev.laptop.org/ticket/1752#comment:20>
One Laptop Per Child <http://laptop.org/>



More information about the Bugs mailing list