[ath9k-devel] 2.6.27-rc5 + w1.fi patches = crash (No ProbeResp + WARNING: at kernel/softirq.c:136)

[Mats Johannesson <spamcan1@abrasax.se>]

On Fri, 29 Aug 2008 10:49:43 +0300 Jouni Malinen wrote:
> On Aug 29, 2008, at 9:32 AM, Mats Johannesson wrote:
[...]
> > [snip]
> Would you be able to easily test whether you'll get the same problem  
> with wireless-testing plus the patches from w1.fi? I'm currently  
> running that on my laptop and haven't been able to reproduce this  
> issue so far. Did you do anything special with the connection when  
> the issue showed up?

Built wireless-testing and applied w1.fi patches
(mac80211_iwassocreqie.patch and mac80211_fix_debugfs_netdev.patch were
in Linville's tree...)

Used the same .config as with the -rc5 kernel, but turned on
CONFIG_KALLSYMS

Switched to the nv X driver (gods such a slow piece of ... mumble ...)

As with the -rc5+w1.fi combo the wireless-testing+w1.fi show less
sensitivity than a plain -rc5 (I had to rescan with the Wicd Manager to
see my router, -rc5 detects it on boot).

Anyway, below is the result. One difference was that the driver managed
to rise from the dead - but it looked kind of flaky:

Aug 29 13:56:34 sleipner kernel: ADDRCONF(NETDEV_UP): ath0: link is not ready
Aug 29 13:56:34 sleipner kernel: ath0: authenticate with AP 00:1b:11:60:7a:3d
Aug 29 13:56:34 sleipner kernel: ath0: authenticated
Aug 29 13:56:34 sleipner kernel: ath0: associate with AP 00:1b:11:60:7a:3d
Aug 29 13:56:34 sleipner kernel: ath0: RX AssocResp from 00:1b:11:60:7a:3d (capab=0x431 status=0 aid=2)
Aug 29 13:56:34 sleipner kernel: ath0: associated
Aug 29 13:56:34 sleipner kernel: ADDRCONF(NETDEV_CHANGE): ath0: link becomes ready
Aug 29 13:56:35 sleipner kernel: ath0: authenticate with AP 00:1b:11:60:7a:3d
Aug 29 13:56:35 sleipner kernel: ath0: authenticated
Aug 29 13:56:35 sleipner kernel: ath0: associate with AP 00:1b:11:60:7a:3d
Aug 29 13:56:35 sleipner kernel: ath0: RX ReassocResp from 00:1b:11:60:7a:3d (capab=0x431 status=0 aid=2)
Aug 29 13:56:35 sleipner kernel: ath0: associated
Aug 29 13:56:35 sleipner kernel: warning: `dhclient' uses 32-bit capabilities (legacy support in use)
Aug 29 13:56:45 sleipner kernel: ath0: no IPv6 routers present
Aug 29 14:09:53 sleipner kernel: ath0: No ProbeResp from current AP 00:1b:11:60:7a:3d - assume out of range
Aug 29 14:09:53 sleipner kernel: ------------[ cut here ]------------
Aug 29 14:09:53 sleipner kernel: WARNING: at kernel/softirq.c:136 local_bh_enable+0x3c/0xab()
Aug 29 14:09:53 sleipner kernel: Modules linked in: aes_x86_64 aes_generic snd_rtctimer cpufreq_userspace cpufreq_stats powernow_k8 freq_table wacom fan dock sbp2 scsi_mod lp arc4 ecb crypto_blkcipher cryptomgr crypto_algapi ath9k mac80211 cfg80211 pcmcia snd_via82xx snd_ac97_codec ac97_bus snd_pcm_oss snd_mixer_oss snd_pcm snd_page_alloc snd_mpu401_uart snd_seq_dummy snd_seq_oss snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_device via_ircc k8temp ehci_hcd thermal ohci1394 r8169 snd uhci_hcd irda ieee1394 yenta_socket rsrc_nonstatic hwmon bitrev crc32 crc_ccitt soundcore usbcore pcmcia_core processor ac wmi battery button thermal_sys evdev
Aug 29 14:09:53 sleipner kernel: Pid: 1029, comm: ath9k Not tainted 2.6.27-rc4-wt-w1fi-wl #1
Aug 29 14:09:53 sleipner kernel: 
Aug 29 14:09:53 sleipner kernel: Call Trace:
Aug 29 14:09:53 sleipner kernel:  [<ffffffff802278d8>] warn_on_slowpath+0x51/0x77
Aug 29 14:09:53 sleipner kernel:  [<ffffffff80224c51>] check_preempt_wakeup+0xf3/0x123
Aug 29 14:09:53 sleipner kernel:  [<ffffffff80239658>] autoremove_wake_function+0x9/0x2e
Aug 29 14:09:53 sleipner kernel:  [<ffffffff8022c281>] local_bh_enable+0x3c/0xab
Aug 29 14:09:53 sleipner kernel:  [<ffffffffa01ab75a>] ath_rx_node_cleanup+0x38/0x6e [ath9k]
Aug 29 14:09:53 sleipner kernel:  [<ffffffffa01b2280>] ath_node_detach+0x3b/0xb6 [ath9k]
Aug 29 14:09:53 sleipner kernel:  [<ffffffffa01ab09f>] ath9k_sta_notify+0x12b/0x165 [ath9k]
Aug 29 14:09:53 sleipner kernel:  [<ffffffff802366cf>] queue_work+0x1d/0x49
Aug 29 14:09:53 sleipner kernel:  [<ffffffffa018c3fc>] add_todo+0x70/0x99 [mac80211]
Aug 29 14:09:53 sleipner kernel:  [<ffffffffa017de76>] __sta_info_unlink+0x16b/0x19e [mac80211]
Aug 29 14:09:53 sleipner kernel:  [<ffffffffa017e6ed>] sta_info_unlink+0x18/0x43 [mac80211]
Aug 29 14:09:53 sleipner kernel:  [<ffffffffa0182732>] ieee80211_associated+0xaa/0x16d [mac80211]
Aug 29 14:09:53 sleipner kernel:  [<ffffffffa0184a1a>] ieee80211_sta_work+0x4fb/0x6b4 [mac80211]
Aug 29 14:09:53 sleipner kernel:  [<ffffffff80469c58>] thread_return+0x30/0xa9
Aug 29 14:09:53 sleipner kernel:  [<ffffffffa018451f>] ieee80211_sta_work+0x0/0x6b4 [mac80211]
Aug 29 14:09:53 sleipner kernel:  [<ffffffff802362c2>] run_workqueue+0xb1/0x17a
Aug 29 14:09:53 sleipner kernel:  [<ffffffff80236be9>] worker_thread+0xd0/0xdb
Aug 29 14:09:53 sleipner kernel:  [<ffffffff8023964f>] autoremove_wake_function+0x0/0x2e
Aug 29 14:09:53 sleipner kernel:  [<ffffffff80236b19>] worker_thread+0x0/0xdb
Aug 29 14:09:53 sleipner kernel:  [<ffffffff8023954a>] kthread+0x47/0x75
Aug 29 14:09:53 sleipner kernel:  [<ffffffff80223121>] schedule_tail+0x18/0x50
Aug 29 14:09:53 sleipner kernel:  [<ffffffff8020bc49>] child_rip+0xa/0x11
Aug 29 14:09:53 sleipner kernel:  [<ffffffff80239503>] kthread+0x0/0x75
Aug 29 14:09:53 sleipner kernel:  [<ffffffff8020bc3f>] child_rip+0x0/0x11
Aug 29 14:09:53 sleipner kernel: 
Aug 29 14:09:53 sleipner kernel: ---[ end trace e9bb5da661055827 ]---
Aug 29 14:09:54 sleipner kernel: ath0: authenticate with AP 00:1b:11:60:7a:3d
Aug 29 14:09:54 sleipner last message repeated 3 times
Aug 29 14:09:54 sleipner kernel: ath0: authentication with AP 00:1b:11:60:7a:3d timed out
Aug 29 14:10:06 sleipner kernel: ath0: direct probe to AP 00:1b:11:60:7a:3d try 1
Aug 29 14:10:06 sleipner kernel: ath0: direct probe to AP 00:1b:11:60:7a:3d try 2
Aug 29 14:10:06 sleipner kernel: ath0: direct probe to AP 00:1b:11:60:7a:3d try 3
Aug 29 14:10:06 sleipner kernel: ath0: direct probe to AP 00:1b:11:60:7a:3d timed out
Aug 29 14:10:17 sleipner kernel: ath0 direct probe responded
Aug 29 14:10:17 sleipner kernel: ath0: authenticate with AP 00:1b:11:60:7a:3d
Aug 29 14:10:17 sleipner kernel: ath0: authenticate with AP 00:1b:11:60:7a:3d
Aug 29 14:10:17 sleipner kernel: ath0: authenticated
Aug 29 14:10:17 sleipner kernel: ath0: associate with AP 00:1b:11:60:7a:3d
Aug 29 14:10:17 sleipner kernel: ath0: RX ReassocResp from 00:1b:11:60:7a:3d (capab=0x431 status=0 aid=2)
Aug 29 14:10:17 sleipner kernel: ath0: associated
Aug 29 14:10:18 sleipner kernel: ath0: authenticate with AP 00:1b:11:60:7a:3d
Aug 29 14:10:18 sleipner kernel: ath0: authenticated
Aug 29 14:10:18 sleipner kernel: ath0: associate with AP 00:1b:11:60:7a:3d
Aug 29 14:10:18 sleipner kernel: ath0: RX ReassocResp from 00:1b:11:60:7a:3d (capab=0x431 status=0 aid=2)
Aug 29 14:10:18 sleipner kernel: ath0: associated

Mvh
Mats