#9588 HIGH Not Tri: WLAN timeouts during suspend/resume

Zarro Boogs per Child bugtracker at laptop.org
Mon Nov 2 17:16:03 EST 2009


#9588: WLAN timeouts during suspend/resume
--------------------------+-------------------------------------------------
 Reporter:  dsaxena       |                 Owner:               
     Type:  defect        |                Status:  new          
 Priority:  high          |             Milestone:  Not Triaged  
Component:  not assigned  |               Version:  not specified
 Keywords:                |           Next_action:  never set    
 Verified:  0             |   Deployment_affected:               
Blockedby:                |              Blocking:               
--------------------------+-------------------------------------------------
 We get a spurious IRQ 22 as we go into suspend and then we are never able
 to recover the WLAN chip.

 {{{
 [root at localhost dev]# echo mem > /sys/power/state
 [ 2026.665133] PM: Syncing filesystems ... done.
 [ 2029.656811] PM: Preparing system for mem sleep
 [ 2029.662035] Freezing user space processes ... (elapsed 0.00 seconds)
 done.
 [ 2029.671255] Freezing remaining freezable tasks ... (elapsed 0.00
 seconds) done.
 [ 2029.679323] PM: Entering mem sleep
 [ 2029.683541] dcon_source_switch to DCON
 [ 2030.180103] olpc-dcon: Timeout entering DCON mode; expect a screen
 glitch.
 [ 2030.187559] olpc-dcon: The DCON has control
 [ 2030.192263] HDA Intel 0000:00:14.0: PCI INT A disabled
 [ 2030.210119] ehci_hcd 0000:00:10.4: PCI INT D disabled
 [ 2030.215646] ehci_hcd 0000:00:10.4: PME# disabled
 [ 2030.240109] uhci_hcd 0000:00:10.1: PCI INT B disabled
 [ 2030.245625] uhci_hcd 0000:00:10.1: PME# disabled
 [ 2030.270105] uhci_hcd 0000:00:10.0: PCI INT A disabled
 [ 2030.275620] uhci_hcd 0000:00:10.0: PME# disabled
 [ 2030.300158] mmc_suspend_host: turning off power on mmc0
 [ 2030.305824] sdhci_set_ios: power off for mmc0 from b0639830
 [ 2030.310134] sdhci_set_power: new power value = 0
 [ 2030.316910] mmc_suspend_host: turning off power on mmc1
 [ 2030.322596] sdhci_set_ios: power off for mmc1 from b0639830
 [ 2030.328640] mmc2:0001:1: suspend: PM flags = 0x3
 [ 2030.333668] mmc_suspend_host: leaving power as is on mmc2
 [ 2033.887167] irq 22: nobody cared (try booting with the "irqpoll"
 option)
 [ 2033.887182] Pid: 2421, comm: bash Not tainted 2.6.30.1 #4
 [ 2033.887189] Call Trace:
 [ 2033.887213]  [<b0441bb4>] __report_bad_irq+0x2e/0x6f
 [ 2033.887225]  [<b0441cea>] note_interrupt+0xf5/0x14b
 [ 2033.887238]  [<b044222f>] handle_fasteoi_irq+0x8d/0xb0
 [ 2033.887251]  [<b04421a2>] ? handle_fasteoi_irq+0x0/0xb0
 [ 2033.887258]  <IRQ>  [<b040396e>] ? do_IRQ+0x34/0x73
 [ 2033.887288]  [<b0402ee9>] ? common_interrupt+0x29/0x30
 [ 2033.887307]  [<b057182a>] ? viafb_wait_engine_idle+0x5a/0x74
 [ 2033.887326]  [<b056906b>] ? viafb_sync+0x11/0x15
 [ 2033.887340]  [<b05690c1>] ? viafb_suspend+0x52/0x81
 [ 2033.887358]  [<b05542b2>] ? pci_pm_suspend+0x5d/0x174
 [ 2033.887373]  [<b05c2a5a>] ? pm_op+0x21/0x5b
 [ 2033.887385]  [<b05c2e6e>] ? device_suspend+0x278/0x34b
 [ 2033.887401]  [<b0439aa6>] ? suspend_devices_and_enter+0x38/0x165
 [ 2033.887413]  [<b0439d1a>] ? enter_state+0x122/0x178
 [ 2033.887426]  [<b0439e05>] ? state_store+0x95/0xa9
 [ 2033.887438]  [<b0439d70>] ? state_store+0x0/0xa9
 [ 2033.887451]  [<b053e6e1>] ? kobj_attr_store+0x16/0x22
 [ 2033.887466]  [<b04aac35>] ? sysfs_write_file+0xbf/0xea
 [ 2033.887485]  [<b0470ebf>] ? vfs_write+0x8a/0x103
 [ 2033.887496]  [<b04aab76>] ? sysfs_write_file+0x0/0xea
 [ 2033.887509]  [<b0470fcf>] ? sys_write+0x3b/0x60
 [ 2033.887521]  [<b04028f4>] ? sysenter_do_call+0x12/0x26
 [ 2033.887529] handlers:
 [ 2033.887534] [<b05fadcb>] (usb_hcd_irq+0x0/0x56)
 [ 2033.887551] Disabling IRQ #22
 [ 2036.701490] ACPI handle has no context!
 [ 2036.870139] ACPI: Preparing to enter system sleep state S3
 +r[ 2036.970022] Back to C!
 [ 2036.970022] ACPI: Waking up from system sleep state S3
 [ 2036.970022] sdhci-pci 0000:00:0c.0: restoring config space at offset
 0xf (was 0x100, writi
 ng 0x10a)
 [ 2036.987304] sdhci-pci 0000:00:0c.0: restoring config space at offset
 0x6 (was 0x0, writing
  0x80002000)
 [ 2036.997416] sdhci-pci 0000:00:0c.0: restoring config space at offset
 0x5 (was 0x0, writing
  0x80001000)
 [ 2037.007892] sdhci-pci 0000:00:0c.0: restoring config space at offset
 0x4 (was 0x0, writing
  0x80000000)
 [ 2037.018005] sdhci-pci 0000:00:0c.0: restoring config space at offset
 0x1 (was 0x2100000, w
 riting 0x2100006)
 [ 2037.040043] uhci_hcd 0000:00:10.0: restoring config space at offset 0xf
 (was 0x100, writin
 g 0x10a)
 [ 2037.049780] uhci_hcd 0000:00:10.0: restoring config space at offset 0x3
 (was 0x800000, wri
 ting 0x802000)
 [ 2037.060139] uhci_hcd 0000:00:10.0: restoring config space at offset 0x1
 (was 0x2100000, wr
 iting 0x2100003)
 [ 2037.090036] uhci_hcd 0000:00:10.1: restoring config space at offset 0xf
 (was 0x200, writin
 g 0x209)
 [ 2037.099770] uhci_hcd 0000:00:10.1: restoring config space at offset 0x3
 (was 0x800000, wri
 ting 0x802000)
 [ 2037.110076] uhci_hcd 0000:00:10.1: restoring config space at offset 0x1
 (was 0x2100000, wr
 iting 0x2100003)
 [ 2037.140039] ehci_hcd 0000:00:10.4: restoring config space at offset 0xf
 (was 0x400, writin
 g 0x40a)
 [ 2037.149776] ehci_hcd 0000:00:10.4: restoring config space at offset 0x3
 (was 0x800000, wri
 ting 0x802008)
 [ 2037.160085] ehci_hcd 0000:00:10.4: restoring config space at offset 0x1
 (was 0x2100000, wr
 iting 0x2100012)
 [ 2037.170628] pci 0000:00:11.7: restoring config space at offset 0x3 (was
 0x0, writing 0x200
 0)
 [ 2037.179803] HDA Intel 0000:00:14.0: restoring config space at offset
 0xf (was 0x100, writi
 ng 0x109)
 [ 2037.189646] HDA Intel 0000:00:14.0: restoring config space at offset
 0x4 (was 0x4, writing
  0x80004004)
 [ 2037.199759] HDA Intel 0000:00:14.0: restoring config space at offset
 0x1 (was 0x100000, wr
 iting 0x100002)
 [ 2037.312171] pci 0000:00:00.0: wake-up capability disabled by ACPI
 [ 2037.318894] viafb 0000:00:01.0: PCI INT A -> GSI 16 (level, low) -> IRQ
 16
 [ 2037.326465] sdhci-pci 0000:00:0c.0: setting latency timer to 64
 [ 2037.332943] sdhci_set_power: new power value = 14
 [ 2037.629331] sdhci-pci 0000:00:0c.0: setting latency timer to 64
 [ 2037.635828] sdhci-pci 0000:00:0c.0: setting latency timer to 64
 [ 2037.642270] sdhci_set_power: new power value = 14
 [ 2037.693202] sdhci_set_ios: power off for mmc1 from b0639830
 [ 2037.699249] sdhci_set_power: new power value = 0
 [ 2043.280096] mmc2: Timeout waiting for hardware interrupt.
 [ 2043.285957] sdhci: ============== REGISTER DUMP ==============
 [ 2043.290087] sdhci: Sys addr: 0x00000000 | Version:  0x00000000
 [ 2043.290087] sdhci: Blk size: 0x00000000 | Blk cnt:  0x00000000
 [ 2043.290087] sdhci: Argument: 0x00000000 | Trn mode: 0x00000000
 [ 2043.290087] sdhci: Present:  0x01d70000 | Host ctl: 0x00000002
 [ 2043.290087] sdhci: Power:    0x0000000f | Blk gap:  0x00000000
 [ 2043.290087] sdhci: Wake-up:  0x00000000 | Clock:    0x00000107
 [ 2043.290087] sdhci: Timeout:  0x00000000 | Int stat: 0x00000000
 [ 2043.290087] sdhci: Int enab: 0x00ff0003 | Sig enab: 0x00ff0003
 [ 2043.290087] sdhci: AC12 err: 0x00000000 | Slot int: 0x00000000
 [ 2043.290087] sdhci: Caps:     0x056030b0 | Max curr: 0x00f001f0
 [ 2043.290087] sdhci: ===========================================
 [ 2043.367409] mmc2:0001:1: resume: we're back
 [ 2043.372030] uhci_hcd 0000:00:10.0: PME# disabled
 [ 2043.377060] uhci_hcd 0000:00:10.0: PCI INT A -> GSI 20 (level, low) ->
 IRQ 20
 [ 2043.384858] uhci_hcd 0000:00:10.0: PME# disabled
 [ 2043.389892] usb usb2: root hub lost power or was reset
 [ 2043.395540] uhci_hcd 0000:00:10.1: PME# disabled
 [ 2043.400561] uhci_hcd 0000:00:10.1: PCI INT B -> GSI 22 (level, low) ->
 IRQ 22
 [ 2043.408304] uhci_hcd 0000:00:10.1: PME# disabled
 [ 2043.413352] usb usb3: root hub lost power or was reset
 [ 2043.418982] ehci_hcd 0000:00:10.4: PME# disabled
 [ 2043.424013] ehci_hcd 0000:00:10.4: PCI INT D -> GSI 23 (level, low) ->
 IRQ 23
 [ 2043.431770] ehci_hcd 0000:00:10.4: PME# disabled
 [ 2043.436805] pci 0000:00:11.0: PME# disabled
 [ 2043.441415] HDA Intel 0000:00:14.0: PCI INT A -> GSI 17 (level, low) ->
 IRQ 17
 [ 2043.449252] HDA Intel 0000:00:14.0: setting latency timer to 64
 [ 2043.474261] dcon_source_switch to CPU
 [ 2043.525033] PM: Finishing wakeup.
 [ 2043.528649] olpc-dcon: scanline interrupt w/CPU
 [ 2043.533587] Restarting tasks ... done.
 [root at localhost dev]# [ 2043.708104] olpc-dcon: scanline interrupt w/CPU
 [ 2043.767091] olpc-dcon: scanline interrupt w/CPU
 [ 2043.786956] olpc-dcon: scanline interrupt w/CPU
 [ 2043.806827] olpc-dcon: scanline interrupt w/CPU
 [ 2043.866747] olpc-dcon: scanline interrupt w/CPU
 [ 2043.985910] olpc-dcon: scanline interrupt w/CPU
 [ 2044.026179] olpc-dcon: scanline interrupt w/CPU
 [ 2044.045245] olpc-dcon: scanline interrupt w/CPU
 [ 2044.462529] olpc-dcon: scanline interrupt w/CPU
 [ 2044.480128] olpc-dcon:  Timeout entering CPU mode; expect a screen
 glitch.
 [ 2044.487608] olpc-dcon: scanline interrupt w/CPU
 [ 2044.495825] olpc-dcon: The CPU has control
 [ 2044.922982] input: PS/2 Synaptics TouchPad as
 /devices/platform/i8042/serio1/input/input8
 [ 2046.000103] ------------[ cut here ]------------
 [ 2046.005137] WARNING: at net/sched/sch_generic.c:226
 dev_watchdog+0xf5/0x172()
 [ 2046.012895] Hardware name: XO
 [ 2046.016117] NETDEV WATCHDOG: eth0 (libertas_sdio): transmit timed out
 [ 2046.023112] Modules linked in: fuse uinput mousedev psmouse serio_raw
 libertas_sdio libert
 as lib80211 [last unloaded: scsi_wait_scan]
 [ 2046.036321] Pid: 0, comm: swapper Not tainted 2.6.30.1 #4
 [ 2046.042187] Call Trace:
 [ 2046.044852]  [<b04199ce>] warn_slowpath_common+0x65/0x7c
 [ 2046.050628]  [<b06a3a21>] ? dev_watchdog+0xf5/0x172
 [ 2046.055927]  [<b0419a19>] warn_slowpath_fmt+0x24/0x27
 [ 2046.061425]  [<b06a3a21>] dev_watchdog+0xf5/0x172
 [ 2046.066542]  [<b071c84e>] ? _spin_unlock_irqrestore+0x17/0x2c
 [ 2046.072792]  [<b0546caa>] ? debug_object_deactivate+0x9a/0xc2
 [ 2046.079032]  [<b0441b35>] ? poll_spurious_irqs+0x0/0x51
 [ 2046.084721]  [<b06a392c>] ? dev_watchdog+0x0/0x172
 [ 2046.089919]  [<b042085a>] run_timer_softirq+0x13b/0x194
 [ 2046.095607]  [<b06a392c>] ? dev_watchdog+0x0/0x172
 [ 2046.100828]  [<b041db8f>] __do_softirq+0x9e/0x15f
 [ 2046.105934]  [<b041daf1>] ? __do_softirq+0x0/0x15f
 [ 2046.111147]  <IRQ>  [<b041d8f9>] ? irq_exit+0x2b/0x62
 [ 2046.116657]  [<b040399a>] ? do_IRQ+0x60/0x73
 [ 2046.121353]  [<b0402ee9>] ? common_interrupt+0x29/0x30
 [ 2046.126927]  [<b059c39a>] ? acpi_idle_enter_bm+0x23a/0x265
 [ 2046.132895]  [<b0638b26>] ? cpuidle_idle_call+0x57/0x8d
 [ 2046.138563]  [<b0401b88>] ? cpu_idle+0x36/0x66
 [ 2046.143408]  [<b07127ce>] ? rest_init+0x66/0x68
 [ 2046.148326]  [<b0897938>] ? start_kernel+0x286/0x28b
 [ 2046.153726]  [<b0897311>] ? i386_start_kernel+0x6b/0x72
 [ 2046.159393] ---[ end trace 68ba1aa1454667f2 ]---
 [ 2046.164414] libertas: tx watch dog timeout
 }}}

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


More information about the Bugs mailing list