#9836 HIGH Not Tri: Invalid opcode in Libertas if_sdio_interrupt() routine

[Zarro Boogs per Child]

#9836: Invalid opcode in Libertas if_sdio_interrupt() routine
--------------------------+-------------------------------------------------
 Reporter:  dsaxena       |                 Owner:             
     Type:  defect        |                Status:  new        
 Priority:  high          |             Milestone:  Not Triaged
Component:  not assigned  |               Version:  1.5-B3     
 Keywords:                |           Next_action:  never set  
 Verified:  0             |   Deployment_affected:             
Blockedby:                |              Blocking:             
--------------------------+-------------------------------------------------
 Seen while running suspend/resume loop without Network Manager and with a
 hosting pinging the XO-1.5 machine.

 {{{
 [  626.372744] Kernel BUG at d0d256d0 [verbose debug info unavailable]
 [  626.372881] invalid opcode: 0000 [#1] PREEMPT
 [  626.372881] last sysfs file: /sys/power/state
 [  626.372881] Modules linked in: fuse uinput mousedev libertas_sdio
 psmouse serio_raw libertas lib80211 [last unloaded: scsi_wait_scan]
 [  626.372881]
 [  626.372881] Pid: 1440, comm: ksdioirqd/mmc1 Tainted: G        W
 (2.6.31.6 #10) XO
 [  626.372881] EIP: 0060:[<d0d256d0>] EFLAGS: 00010002 CPU: 0
 [  626.372881] EIP is at if_sdio_interrupt+0x3f7/0x7c7 [libertas_sdio]
 [  626.372881] EAX: 00000755 EBX: ca500000 ECX: c9b2c340 EDX: 00000001
 [  626.372881] ESI: c9b2c340 EDI: 00000113 EBP: ca1ebf78 ESP: ca1ebf50
 [  626.372881]  DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068
 [  626.372881] Process ksdioirqd/mmc1 (pid: 1440, ti=ca1eb000
 task=c9901a50 task.ti=ca1eb000)
 [  626.372881] Stack:
 [  626.372881]  00000001 00000286 c9b2c340 00000113 00000000 00000000
 00000000 00000000
 [  626.372881] <0> c99300c0 7fffffff ca1ebfac b067419f c99bd0e0 00000000
 c99bd274 00000001
 [  626.372881] <0> c99300c0 00000001 00000001 02000000 cae70e18 c99bd0e0
 b06740bb ca1ebfe0
 [  626.372881] Call Trace:
 [  626.372881]  [<b067419f>] ? sdio_irq_thread+0xe4/0x1d1
 [  626.372881]  [<b06740bb>] ? sdio_irq_thread+0x0/0x1d1
 [  626.372881]  [<b04325c1>] ? kthread+0x6d/0x72
 [  626.372881]  [<b0432554>] ? kthread+0x0/0x72
 [  626.372881]  [<b0403103>] ? kernel_thread_helper+0x7/0x10
 [  626.372881] Code: 78 1d 00 00 e8 c5 58 a3 df 31 d2 8b 4d e0 89 45 dc 8b
 45 e0 80 b8 48 0b 00 00 00 0f 94 c2 8d 82 54 07 00 00 83 7c 81 0c 00 74 04
 <0f> 0b eb fe 8b 75 e0 8b 4d e4 89 4c 86 0c 69 c2 08 09 00 00 8b
 [  626.372881] EIP: [<d0d256d0>] if_sdio_interrupt+0x3f7/0x7c7
 [libertas_sdio] SS:ESP 0068:ca1ebf50
 [  626.372881] ---[ end trace ba4980c0365b189d ]---
 [  626.372881] note: ksdioirqd/mmc1[1440] exited with preempt_count 1
 [  626.557480] libertas leave: if_sdio_host_to_card(), ret 0
 [  626.573277] BUG: spinlock lockup on CPU#0, lbs_main/1792, c9b2e0b8
 [  626.573277] Pid: 1792, comm: lbs_main Tainted: G      D W  2.6.31.6 #10
 [  626.573277] Call Trace:
 [  626.573277]  [<b07591bf>] ? printk+0x14/0x1d
 [  626.573277]  [<b0580634>] _raw_spin_lock+0xc0/0xe0
 [  626.573277]  [<b075af70>] _spin_lock_irq+0x1d/0x20
 [  626.573277]  [<cb9ac9e2>] lbs_thread+0x548/0x6b8 [libertas]
 [  626.573277]  [<b041ca06>] ? default_wake_function+0x0/0x12
 [  626.573277]  [<cb9ac49a>] ? lbs_thread+0x0/0x6b8 [libertas]
 [  626.573277]  [<b04325c1>] kthread+0x6d/0x72
 [  626.573277]  [<b0432554>] ? kthread+0x0/0x72
 [  626.573277]  [<b0403103>] kernel_thread_helper+0x7/0x10
 }}}

 This same run included a few tx timeouts prior to this, but not 100% sure
 they are related to this issue or a separate issue:

 {{{
 [  511.005055] WARNING: at net/sched/sch_generic.c:246
 dev_watchdog+0x102/0x17f()
 [  511.012715] Hardware name: XO
 [  511.015857] NETDEV WATCHDOG: eth0 (libertas_sdio): transmit queue 0
 timed out
 [  511.023434] Modules linked in: fuse uinput mousedev libertas_sdio
 psmouse serio_raw libertas lib80211 [last unloaded: scsi_wait_scan]
 [  511.036390] Pid: 0, comm: swapper Not tainted 2.6.31.6 #10
 [  511.042187] Call Trace:
 [  511.044780]  [<b042066e>] warn_slowpath_common+0x6a/0x81
 [  511.050428]  [<b06de896>] ? dev_watchdog+0x102/0x17f
 [  511.055676]  [<b04206c3>] warn_slowpath_fmt+0x29/0x2c
 [  511.061052]  [<b06de896>] dev_watchdog+0x102/0x17f
 [  511.066124]  [<b075ae47>] ? _spin_unlock_irqrestore+0x1c/0x31
 [  511.072215]  [<b0580b96>] ? debug_object_deactivate+0x9a/0xc2
 [  511.078305]  [<b04287ac>] ? cascade+0x50/0x63
 [  511.082936]  [<b06de794>] ? dev_watchdog+0x0/0x17f
 [  511.088001]  [<b042890b>] run_timer_softirq+0x14c/0x1a2
 [  511.093595]  [<b0425433>] __do_softirq+0xaf/0x16e
 [  511.098611]  [<b0425384>] ? __do_softirq+0x0/0x16e
 [  511.103706]  <IRQ>  [<b0425173>] ? irq_exit+0x30/0x67
 [  511.109100]  [<b0403b41>] ? do_IRQ+0x78/0x8b
 [  511.113635]  [<b0402f69>] ? common_interrupt+0x29/0x30
 [  511.119083]  [<b05d800a>] ? acpi_idle_enter_bm+0x23f/0x26a
 [  511.124913]  [<b066e1c9>] ? cpuidle_idle_call+0x5f/0x96
 [  511.130454]  [<b0401bc3>] ? cpu_idle+0x3b/0x68
 [  511.135193]  [<b07508cb>] ? rest_init+0x6b/0x6d
 [  511.140037]  [<b08fb6ba>] ? start_kernel+0x29a/0x29f
 [  511.145317]  [<b08fb06b>] ? i386_start_kernel+0x6b/0x72
 [  511.150852] ---[ end trace ba4980c0365b189c ]---
 [  511.155735] libertas: tx watch dog timeout
 }}}

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