#12016 NORM Not Tri: XO-1.5 mmc timeout on first resume cycle

Zarro Boogs per Child bugtracker at laptop.org
Tue Jul 17 15:32:06 EDT 2012


#12016: XO-1.5 mmc timeout on first resume cycle
-----------------------+----------------------------------------------------
 Reporter:  greenfeld  |                 Owner:                                   
     Type:  defect     |                Status:  new                              
 Priority:  normal     |             Milestone:  Not Triaged                      
Component:  kernel     |               Version:  Development build as of this date
 Keywords:             |           Next_action:  diagnose                         
 Verified:  0          |   Deployment_affected:                                   
Blockedby:             |              Blocking:                                   
-----------------------+----------------------------------------------------
 The first resume cycle on a XO-1.5 with 12.1.0 os18 may hit an MMC
 timeout.  Subsequent resume cycles do not seem to hit this (at least in a
 guaranteed manner).

 This seems to be reproducible on more than one XO-1.5, and causes a
 noticeable resume delay.

  1. Install 12.1.0 os18 on a XO-1.5.
  2. Click Next on the "Welcome" activity to get to the name screen.
  3. Hard power off the XO. (I did S/R testing first; you might not have
 to.)
  4. Power on the XO-1.5 again with serial attached.
  5. Wait until the XO goes into idle suspend.
  6. Press the "Fn" or "Shift" key to wake up the XO.
  7. A few seconds after the XO-1.5 wakes up it may log a mmc timeout.

 {{{
 [   28.618059] dcon_freeze_store: 0
 [   28.621578] dcon_source_switch to CPU
 [   28.654313] olpc-dcon: The CPU has control
 [   45.153218] PM: Syncing filesystems ... done.
 [   45.161108] Freezing user space processes ... (elapsed 0.01 seconds)
 done.
 [   45.182780] Freezing remaining freezable tasks ... (elapsed 0.01
 seconds) done.
 [   45.203369] dcon_source_switch to DCON
 [   45.243770] olpc-dcon: The DCON has control
 [   45.248536] i8042 kbd 00:04: wake-up capability enabled by ACPI
 [   45.254891] i8042 aux 00:03: wake-up capability disabled by ACPI
 [   45.262818] libertas_sdio mmc1:0001:1: mmc1:0001:1: suspend: PM flags =
 0x3
 [   45.270175] viafb_suspend!
 [   45.310076] PM: suspend of devices complete after 106.854 msecs
 [   45.390315] PM: late suspend of devices complete after 74.233 msecs
 [   45.396820] ACPI: Preparing to enter system sleep state S3
 [   45.500153] PM: Saving platform NVS memory
 +r[   45.500153] ACPI: Low-level resume complete
 [   45.500153] PM: Restoring platform NVS memory
 [   45.500153] ACPI: Waking up from system sleep state S3
 [   45.590483] PM: early resume of devices complete after 80.055 msecs
 [   45.597034] viafb_resume!
 [   45.600225] usb usb2: root hub lost power or was reset
 [   45.600277] libertas_sdio mmc1:0001:1: mmc1:0001:1: resume: we're back
 [   45.600399] usb usb3: root hub lost power or was reset
 [   45.600478] usb usb4: root hub lost power or was reset
 [   45.611226] viafb_resume: Init 3d engine!
 [   45.662012] i8042 kbd 00:04: wake-up capability disabled by ACPI
 [   55.460027] mmc2: Timeout waiting for hardware interrupt.
 [   55.465516] ------------[ cut here ]------------
 [   55.470014] WARNING: at drivers/mmc/host/sdhci.c:962
 sdhci_send_command+0x2b/0x87e()
 [   55.470014] Hardware name: XO
 [   55.470014] Modules linked in: fuse xt_tcpudp iptable_filter ip_tables
 x_tables mousedev uinput syscopyarea sysfillrect sysimgblt fb_sys_fops sis
 usbvga serio_raw psmouse libertas_sdio libertas via_camera videobuf_dma_sg
 videobuf_core [last unloaded: udlfb]
 [   55.470014] Pid: 0, comm: swapper Not tainted
 3.3.8_xo1.5-20120628.1739.olpc.137c3f8 #1
 [   55.470014] Call Trace:
 [   55.470014]  [<b0419d0e>] warn_slowpath_common+0x68/0x7d
 [   55.470014]  [<b063c345>] ? sdhci_send_command+0x2b/0x87e
 [   55.470014]  [<b0419d37>] warn_slowpath_null+0x14/0x18
 [   55.470014]  [<b063c345>] sdhci_send_command+0x2b/0x87e
 [   55.470014]  [<b063d291>] sdhci_finish_data+0x213/0x236
 [   55.470014]  [<b073f25a>] ? _raw_spin_unlock_irqrestore+0x1c/0x32
 [   55.470014]  [<b063d408>] sdhci_timeout_timer+0x5e/0xa6
 [   55.470014]  [<b042359b>] run_timer_softirq+0x1b2/0x2c0
 [   55.470014]  [<b063d3aa>] ? sdhci_finish_command+0xf6/0xf6
 [   55.470014]  [<b041e8c8>] __do_softirq+0xa6/0x196
 [   55.470014]  [<b041e822>] ?
 ftrace_define_fields_irq_handler_entry+0x45/0x45
 [   55.470014]  <IRQ>  [<b041eb53>] ? irq_exit+0x39/0x8f
 [   55.470014]  [<b0403234>] ? do_IRQ+0x7b/0x8e
 [   55.470014]  [<b0744029>] ? common_interrupt+0x29/0x30
 [   55.470014]  [<b05b34af>] ? acpi_idle_enter_simple+0x101/0x13a
 [   55.470014]  [<b062e995>] ? cpuidle_idle_call+0x104/0x238
 [   55.470014]  [<b04015ac>] ? cpu_idle+0x3e/0x7b
 [   55.470014]  [<b0731168>] ? rest_init+0x7c/0x7e
 [   55.470014]  [<b08ab67d>] ? start_kernel+0x2a0/0x2a5
 [   55.470014]  [<b08ab078>] ? i386_start_kernel+0x78/0x7d
 [   55.470014] ---[ end trace d5ae505a67754495 ]---
 [   55.626335] hpet1: lost 9 rtc interrupts
 [   55.631064] mmcblk0: error -110 transferring data, sector 4341888, nr
 128, cmd response 0x0, card status 0x0
 [   55.641709] end_request: I/O error, dev mmcblk0, sector 4341888
 [   55.647724] end_request: I/O error, dev mmcblk0, sector 4341896
 [   55.651680] end_request: I/O error, dev mmcblk0, sector 4341904
 [   55.651680] end_request: I/O error, dev mmcblk0, sector 4341912
 [   55.651680] end_request: I/O error, dev mmcblk0, sector 4341920
 [   55.651680] end_request: I/O error, dev mmcblk0, sector 4341928

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


More information about the Bugs mailing list