Comment 63 for bug 286285

Tom,

I got the kern.log entry mentioned at https://bugs.launchpad.net/ubuntu/intrepid/+source/linux/+bug/276990/comments/92 which is the patched (comment 85) behavior of that bug. The news is that I didn't use that patch, I used the patch from comment 52 in this bug.

The patch at https://bugs.launchpad.net/ubuntu/+source/linux/+bug/286285/comments/52 has eased both problems, the scheduling report churning into kern.log and turns the wrong command queue hang into a log event.

The entry that I received is
Nov 4 12:13:33 topol015 kernel: [20559.634756] ------------[ cut here ]------------
Nov 4 12:13:33 topol015 kernel: [20559.634774] WARNING: at drivers/net/wireless/iwlwifi/iwl-tx.c:1196 iwl_tx_cmd_complete+0x2c9/0x2d0 [iwlcore]()
Nov 4 12:13:33 topol015 kernel: [20559.634781] wrong command queue 63, command id 0x0
Nov 4 12:13:33 topol015 kernel: [20559.634786] Modules linked in: aes_i586 aes_generic af_packet binfmt_misc rfcomm bridge stp bnep sco l2cap bluetooth ipv6 ppdev acpi_cpufreq cpufreq_ondemand cpufreq_userspace cpufreq_conservative cpufreq_stats freq_table cpufreq_powersave container sbs pci_slot sbshc iptable_filter ip_tables x_tables coretemp sbp2 parport_pc lp parport joydev snd_hda_intel arc4 ecb crypto_blkcipher snd_pcm_oss snd_mixer_oss snd_pcm iwlagn snd_seq_dummy iwlcore snd_seq_oss uvcvideo rfkill snd_seq_midi compat_ioctl32 led_class videodev snd_rawmidi psmouse mac80211 v4l1_compat snd_seq_midi_event serio_raw pcspkr evdev nvidia(P) snd_seq cfg80211 i2c_core snd_timer snd_seq_device sdhci_pci snd sdhci video output ricoh_mmc mmc_core battery wmi soundcore ac button iTCO_wdt iTCO_vendor_support intel_agp agpgart snd_page_alloc shpchp pci_hotplug ext3 jbd mbcache sr_mod cdrom ata_generic sd_mod crc_t10dif sg ata_piix ahci ohci1394 pata_acpi ieee1394 libata scsi_mod dock r8169 ehci_hcd uhci_hcd usbcore t
Nov 4 12:13:33 topol015 kernel: ermal processor fan fbcon tileblit font bitblit softcursor fuse
Nov 4 12:13:33 topol015 kernel: [20559.635009] Pid: 5617, comm: Xorg Tainted: P 2.6.27-7-generic #1
Nov 4 12:13:33 topol015 kernel: [20559.635016] [<c0131d65>] warn_slowpath+0x65/0x90
Nov 4 12:13:33 topol015 kernel: [20559.635035] [<c0234775>] ? apparmor_socket_recvmsg+0x15/0x20
Nov 4 12:13:33 topol015 kernel: [20559.635048] [<c02e5036>] ? __sock_recvmsg+0x66/0x80
Nov 4 12:13:33 topol015 kernel: [20559.635059] [<c02e512c>] ? sock_aio_read+0xdc/0x120
Nov 4 12:13:33 topol015 kernel: [20559.635069] [<f8d8ef49>] iwl_tx_cmd_complete+0x2c9/0x2d0 [iwlcore]
Nov 4 12:13:33 topol015 kernel: [20559.635094] [<c01b1f19>] ? do_sync_read+0xd9/0x120
Nov 4 12:13:33 topol015 kernel: [20559.635106] [<f8cb2a49>] iwl_rx_handle+0xd9/0x260 [iwlagn]
Nov 4 12:13:33 topol015 kernel: [20559.635125] [<f8cb469d>] iwl4965_irq_tasklet+0x1ad/0x2f0 [iwlagn]
Nov 4 12:13:33 topol015 kernel: [20559.635140] [<c01e1fce>] ? inotify_inode_queue_event+0xe/0xe0
Nov 4 12:13:33 topol015 kernel: [20559.635152] [<c0137258>] tasklet_action+0x78/0x100
Nov 4 12:13:33 topol015 kernel: [20559.635161] [<c0137682>] __do_softirq+0x92/0x120
Nov 4 12:13:33 topol015 kernel: [20559.635169] [<c013776d>] do_softirq+0x5d/0x60
Nov 4 12:13:33 topol015 kernel: [20559.635176] [<c01378e5>] irq_exit+0x55/0x90
Nov 4 12:13:33 topol015 kernel: [20559.635184] [<c0106c1a>] do_IRQ+0x4a/0x80
Nov 4 12:13:33 topol015 kernel: [20559.635193] [<c0146067>] ? sys_clock_gettime+0x57/0xb0
Nov 4 12:13:33 topol015 kernel: [20559.635205] [<c0105003>] common_interrupt+0x23/0x30
Nov 4 12:13:33 topol015 kernel: [20559.635214] =======================
Nov 4 12:13:33 topol015 kernel: [20559.635219] ---[ end trace 44f093d96ce74abe ]---

It happend 57.5 minutes after reassociation to a rebooted DIR-655 802.11n WPA/WPA2 router.