Bug 13922
| Summary: | Kernel Panic ieee80211_agg_splice_packets with Atheros AR9160 in Wireless N AP mode | ||
|---|---|---|---|
| Product: | Networking | Reporter: | Jack Lau (jackelectronics) |
| Component: | Wireless | Assignee: | networking_wireless (networking_wireless) |
| Status: | CLOSED CODE_FIX | ||
| Severity: | high | CC: | mcgrof |
| Priority: | P1 | ||
| Hardware: | All | ||
| OS: | Linux | ||
| URL: | http://marc.info/?t=124863015500005&r=1&w=2 | ||
| Kernel Version: | 2.6.28 onwards with compat-wireless installed | Subsystem: | |
| Regression: | No | Bisected commit-id: | |
| Attachments: | Do not splice TID queue unless its set | ||
|
Description
Jack Lau
2009-08-05 18:44:46 UTC
Log files can be found at http://www.jackelec.myzen.co.uk/logs.zip Can you just add the panic in question here? I saw you e-mail thread and saw no panic at all. This is a kernel panic dump from Ubuntu 2.6.28-14-server via netconsole with compat-wireless 2.6.30 installed which are both "stable" releases (not). [ 106.950941] BUG: unable to handle kernel NULL pointer dereference at 00000030 [ 106.951085] IP: [<f84c810d>] ieee80211_agg_splice_packets+0x3d/0xc0 [mac80211] [ 106.951232] *pdpt = 0000000034c9b001 *pde = 0000000000000000 [ 106.951344] Oops: 0000 [#1] SMP [ 106.951409] last sysfs file: /sys/module/aes_generic/initstate [ 106.951512] Dumping ftrace buffer: [ 106.951563] (ftrace buffer empty) [ 106.951626] Modules linked in: aes_i586 aes_generic input_polldev video output bridge stp netconsole configfs lp parport arc4 ecb snd_hda_intel ath9k snd_pcm mac80211 iTCO_wdt snd_timer joydev iTCO_vendor_support cfg80211 snd intel_agp soundcore dcdbas psmouse led_class agpgart usbhid snd_page_alloc pcspkr serio_raw e100 mii floppy vesafb fbcon tileblit font bitblit softcursor [ 106.952454] [ 106.952485] Pid: 0, comm: swapper Not tainted (2.6.28-14-server #47-Ubuntu) Dell DV051 [ 106.952626] EIP: 0060:[<f84c810d>] EFLAGS: 00010282 CPU: 0 [ 106.952724] EIP is at ieee80211_agg_splice_packets+0x3d/0xc0 [mac80211] [ 106.952837] EAX: 00000030 EBX: 00000002 ECX: 00000003 EDX: 00000000 [ 106.952946] ESI: 0000004c EDI: f4d14000 EBP: c0743e58 ESP: c0743e3c [ 106.953030] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 106.953109] Process swapper (pid: 0, ti=c0742000 task=c0695340 task.ti=c0742000) [ 106.953233] Stack: [ 106.953269] f540c1e0 f5083f20 f4d14000 f6048858 0000004c 00000000 f4d14000 c0743e84 [ 106.953438] f84c86c8 00000292 f5083f00 f540c770 f5083f20 f540c1e0 f4d14020 f5083f00 [ 106.953628] f540c290 00000000 c0743edc f84c306f 00000f40 c0743ea8 f86194dc 00000000 [ 106.953821] Call Trace: [ 106.953866] [<f84c86c8>] ? ieee80211_stop_tx_ba_cb+0x78/0xf0 [mac80211] [ 106.954001] [<f84c306f>] ? ieee80211_tasklet_handler+0xcf/0x120 [mac80211] [ 106.954121] [<f86194dc>] ? ath9k_iowrite32+0x2c/0x80 [ath9k] [ 106.954217] [<f861dfb7>] ? ath9k_hw_set_interrupts+0x297/0x470 [ath9k] [ 106.954329] [<f863876f>] ? ath9k_tasklet+0x3f/0xb0 [ath9k] [ 106.954436] [<c0146378>] ? tasklet_action+0x78/0x100 [ 106.954518] [<c01467f7>] ? __do_softirq+0x97/0x170 [ 106.954610] [<c012206f>] ? ack_apic_level+0x6f/0x290 [ 106.954692] [<c014692d>] ? do_softirq+0x5d/0x60 [ 106.954778] [<c0146aa5>] ? irq_exit+0x55/0x90 [ 106.954862] [<c010c1c3>] ? do_IRQ+0x83/0xa0 [ 106.954944] [<c015abaa>] ? hrtimer_start+0x1a/0x20 [ 106.955034] [<c010ab13>] ? common_interrupt+0x23/0x28 [ 106.955127] [<c01282b5>] ? native_safe_halt+0x5/0x10 [ 106.955224] [<c01109cd>] ? default_idle+0x5d/0x60 [ 106.955318] [<c010884d>] ? cpu_idle+0x6d/0xd0 [ 106.955531] [<c04fb1de>] ? rest_init+0x4e/0x60 [ 106.955617] Code: 45 e4 89 f0 83 c6 4c 83 e0 07 89 5d f4 0f b7 1c 85 80 5d 4e f8 8b 45 e4 89 7d fc 89 d7 89 da e8 7a 29 01 00 8b 54 b7 0c 8d 42 30 <39> 42 30 74 6e 8b 45 e4 83 c0 60 89 45 e8 e8 60 53 04 c8 8b 55 [ 106.956381] EIP: [<f84c810d>] ieee80211_agg_splice_packets+0x3d/0xc0 [mac80211] SS:ESP 0068:c0743e3c [ 106.956564] Kernel panic - not syncing: Fatal exception in interrupt Thanks, can you please try 2.6.30 vanilla off of kernel.org? http://kernel.org/pub/linux/kernel/v2.6/linux-2.6.30.4.tar.bz2 This probably is a valid oops on 2.6.30 but just want to make sure the issue has nothing to do with the backport effort. Also please run gdb net/mac80211/mac80211.ko off of the mac80211.ko for your compat-wireless modules. That should be in /lib/modules/$(uname -r)/updates/net/mac80211/mac80211.ko Then use: l *(ieee80211_agg_splice_packets+0x3d) And paste the output here. (In reply to comment #5) > Also please run gdb net/mac80211/mac80211.ko off of the mac80211.ko for your > compat-wireless modules. That should be in /lib/modules/$(uname > -r)/updates/net/mac80211/mac80211.ko > Then use: > l *(ieee80211_agg_splice_packets+0x3d) > And paste the output here. How do I compile compat-wireless with debugging symbols? I can't see anything obvious in config.mk. All I get is no debugging symbols found. I am really am an idiot with programming. (In reply to comment #4) > Thanks, can you please try 2.6.30 vanilla off of kernel.org? > http://kernel.org/pub/linux/kernel/v2.6/linux-2.6.30.4.tar.bz2 > This probably is a valid oops on 2.6.30 but just want to make sure the issue > has nothing to do with the backport effort. I have also tried http://packages.debian.org/sid/linux-image-2.6.30-1-686 from Debian, http://packages.ubuntu.com/karmic/linux-image-2.6.31-5-generic from Ubuntu both without backports and even the bleeding edge wireless-testing from yesterday, all crashing with the same error. I will also try 2.6.30.4 tommorow. Compile your kernel with debugging symbols. The debugging stuff should be followed on compat-wireless from your current kernel. (In reply to comment #5) > Also please run gdb net/mac80211/mac80211.ko off of the mac80211.ko for your > compat-wireless modules. That should be in /lib/modules/$(uname > -r)/updates/net/mac80211/mac80211.ko > Then use: > l *(ieee80211_agg_splice_packets+0x3d) > And paste the output here. The output is from the 2.6.30.4 kernel with no backports installed. root@DV051:~# gdb /lib/modules/2.6.30.4/kernel/net/mac80211/mac80211.ko GNU gdb 6.8-debian Copyright (C) 2008 Free Software Foundation, Inc. License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html> This is free software: you are free to change and redistribute it. There is NO WARRANTY, to the extent permitted by law. Type "show copying" and "show warranty" for details. This GDB was configured as "i486-linux-gnu"... (gdb) l * (ieee80211_agg_splice_packets+0x3d) 0x619d is in ieee80211_agg_splice_packets (net/mac80211/agg-tx.c:379). 374 375 ieee80211_stop_queue_by_reason( 376 &local->hw, queue, 377 IEEE80211_QUEUE_STOP_REASON_AGGREGATION); 378 379 if (!skb_queue_empty(&sta->ampdu_mlme.tid_tx[tid]->pending)) { 380 spin_lock_irqsave(&local->queue_stop_reason_lock, flags); 381 /* mark queue as pending, it is stopped already */ 382 __set_bit(IEEE80211_QUEUE_STOP_REASON_PENDING, 383 &local->queue_stop_reasons[queue]); (gdb) q (In reply to comment #4) > Thanks, can you please try 2.6.30 vanilla off of kernel.org? > http://kernel.org/pub/linux/kernel/v2.6/linux-2.6.30.4.tar.bz2 > This probably is a valid oops on 2.6.30 but just want to make sure the issue > has nothing to do with the backport effort. Unfortunately: [ 77.067762] BUG: unable to handle kernel NULL pointer dereference at 00000030 [ 77.067783] IP: [<f85b816d>] ieee80211_agg_splice_packets+0x3d/0xc0 [mac80211] [ 77.067811] *pdpt = 0000000002097001 *pde = 0000000000000000 [ 77.067825] Thread overran stack, or stack corrupted [ 77.067831] Oops: 0000 [#1] SMP [ 77.067846] last sysfs file: /sys/module/aes_generic/initstate [ 77.067854] Modules linked in: aes_i586 aes_generic video output bridge stp netconsole configfs lp parport arc4 ecb ath9k snd_hda_codec_idt mac80211 snd_hda_intel snd_hda_codec iTCO_wdt iTCO_vendor_support snd_pcm cfg80211 psmouse dcdbas snd_timer snd soundcore snd_page_alloc led_class intel_agp agpgart serio_raw pcspkr joydev usbhid e100 mii floppy [ 77.068015] [ 77.068024] Pid: 0, comm: swapper Not tainted (2.6.30.4 #1) Dell DV051 [ 77.068032] EIP: 0060:[<f85b816d>] EFLAGS: 00010282 CPU: 0 [ 77.068050] EIP is at ieee80211_agg_splice_packets+0x3d/0xc0 [mac80211] [ 77.068058] EAX: 00000030 EBX: 00000002 ECX: 00000282 EDX: 00000000 [ 77.068065] ESI: 0000004c EDI: c2038000 EBP: c0719e30 ESP: c0719e14 [ 77.068072] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 77.068079] Process swapper (pid: 0, ti=c0718000 task=c06bd320 task.ti=c0718000) [ 77.068087] Stack: [ 77.068093] c2d72180 f779fd20 c2038000 f779ea00 0000004c 00000000 c2038000 c0719e5c [ 77.068132] f85b872f c07100d0 00000082 c2d72710 f779fd20 c2d72180 c2038020 f779fd00 [ 77.068172] 00000000 c07a2304 c0719eb4 f85b34af f74ddc58 c0719e80 f94e74dc 00000000 [ 77.068221] Call Trace: [ 77.068229] [<f85b872f>] ? ieee80211_stop_tx_ba_cb+0x7f/0x100 [mac80211] [ 77.068253] [<f85b34af>] ? ieee80211_tasklet_handler+0xcf/0x120 [mac80211] [ 77.068279] [<f94e74dc>] ? ath9k_iowrite32+0x2c/0x80 [ath9k] [ 77.068299] [<f94ebfb7>] ? ath9k_hw_set_interrupts+0x297/0x470 [ath9k] [ 77.068320] [<f95066bf>] ? ath9k_tasklet+0x3f/0xb0 [ath9k] [ 77.068339] [<c01450a8>] ? tasklet_action+0x58/0xc0 [ 77.068356] [<c01456ad>] ? __do_softirq+0x9d/0x170 [ 77.068369] [<c01201ce>] ? ack_apic_level+0x7e/0x270 [ 77.068382] [<c01457bd>] ? do_softirq+0x3d/0x40 [ 77.068393] [<c0145905>] ? irq_exit+0x65/0x90 [ 77.068404] [<c010a63f>] ? do_IRQ+0x4f/0xb0 [ 77.068416] [<c01094c9>] ? common_interrupt+0x29/0x30 [ 77.068427] [<c010fcde>] ? mwait_idle+0xbe/0x100 [ 77.068443] [<c0107e92>] ? cpu_idle+0x52/0x90 [ 77.068456] [<c05172c5>] ? rest_init+0x55/0x60 [ 77.068470] [<c0722905>] ? start_kernel+0x31d/0x385 [ 77.068482] [<c072239e>] ? unknown_bootoption+0x0/0x1f9 [ 77.068494] [<c0722099>] ? i386_start_kernel+0x79/0x81 [ 77.068510] Code: 45 e4 89 f0 83 c6 4c 83 e0 07 89 5d f4 0f b7 1c 85 e0 57 5d f8 8b 45 e4 89 7d fc 89 d7 89 da e8 ca 2b 01 00 8b 54 b7 0c 8d 42 30 <39> 42 30 74 6e 8b 45 e4 83 c0 60 89 45 e8 e8 60 4d f7 c7 8b 55 [ 77.068936] EIP: [<f85b816d>] ieee80211_agg_splice_packets+0x3d/0xc0 [mac80211] SS:ESP 0068:c0719e14 [ 77.068967] CR2: 0000000000000030 [ 77.069000] ---[ end trace 40a065ccf1c08603 ]--- [ 77.069007] Kernel panic - not syncing: Fatal exception in interrupt [ 77.069016] Pid: 0, comm: swapper Tainted: G D 2.6.30.4 #1 [ 77.069023] Call Trace: [ 77.069032] [<c052a510>] ? printk+0x18/0x20 [ 77.069042] [<c052a440>] panic+0x43/0xfb [ 77.069052] [<c052de61>] oops_end+0xc1/0xd0 [ 77.069063] [<c01277e6>] no_context+0xb6/0x1a0 [ 77.069074] [<c04721e9>] ? nf_iterate+0x69/0x80 [ 77.069084] [<c012792b>] __bad_area_nosemaphore+0x5b/0x170 [ 77.069095] [<c047237f>] ? nf_hook_slow+0x9f/0xe0 [ 77.069113] [<f995b380>] ? br_nf_pre_routing_finish+0x0/0x2d0 [bridge] [ 77.069135] [<f85c32fa>] ? __ieee80211_rx_handle_packet+0x34a/0x5d0 [mac80211] [ 77.069149] [<c0127a52>] bad_area_nosemaphore+0x12/0x20 [ 77.069159] [<c052f3dc>] do_page_fault+0x23c/0x2e0 [ 77.069168] [<c052f1a0>] ? do_page_fault+0x0/0x2e0 [ 77.069177] [<c052d335>] error_code+0x6d/0x74 [ 77.069198] [<f85c007b>] ? tkip_mixing_phase1+0x3b/0x130 [mac80211] [ 77.069209] [<c052f1a0>] ? do_page_fault+0x0/0x2e0 [ 77.069301] [<f85b816d>] ? ieee80211_agg_splice_packets+0x3d/0xc0 [mac80211] [ 77.069325] [<f85b872f>] ieee80211_stop_tx_ba_cb+0x7f/0x100 [mac80211] [ 77.069344] [<f85b34af>] ieee80211_tasklet_handler+0xcf/0x120 [mac80211] [ 77.069360] [<f94e74dc>] ? ath9k_iowrite32+0x2c/0x80 [ath9k] [ 77.069376] [<f94ebfb7>] ? ath9k_hw_set_interrupts+0x297/0x470 [ath9k] [ 77.069395] [<f95066bf>] ? ath9k_tasklet+0x3f/0xb0 [ath9k] [ 77.069407] [<c01450a8>] tasklet_action+0x58/0xc0 [ 77.069416] [<c01456ad>] __do_softirq+0x9d/0x170 [ 77.069425] [<c01201ce>] ? ack_apic_level+0x7e/0x270 [ 77.069437] [<c01457bd>] do_softirq+0x3d/0x40 [ 77.069446] [<c0145905>] irq_exit+0x65/0x90 [ 77.069455] [<c010a63f>] do_IRQ+0x4f/0xb0 [ 77.069463] [<c01094c9>] common_interrupt+0x29/0x30 [ 77.069472] [<c010fcde>] ? mwait_idle+0xbe/0x100 [ 77.069483] [<c0107e92>] cpu_idle+0x52/0x90 [ 77.069492] [<c05172c5>] rest_init+0x55/0x60 [ 77.069502] [<c0722905>] start_kernel+0x31d/0x385 [ 77.069510] [<c072239e>] ? unknown_bootoption+0x0/0x1f9 [ 77.069521] [<c0722099>] i386_start_kernel+0x79/0x81 This is good. Now can you please try the same with wireless-testing directly? http://wireless.kernel.org/en/developers/Documentation/git-guide I'd like to see if you can reproduce this panic with the wireless-testing kernel so we can fix it there and then propagate the changes down to older kernels. If you do see an oops please use gdb as well for the EIP as you did for 2.6.30.4. Unfortunately, even with the very latest git master 2009-08-07: [ 119.857646] BUG: unable to handle kernel NULL pointer dereference at 00000030 [ 119.857775] IP: [<f8806c70>] ieee80211_agg_splice_packets+0x40/0xc0 [mac80211] [ 119.857900] *pdpt = 0000000002d1e001 *pde = 0000000000000000 [ 119.858011] Thread overran stack, or stack corrupted [ 119.858089] Oops: 0000 [#1] SMP [ 119.858162] last sysfs file: /sys/module/aes_generic/initstate [ 119.858245] Modules linked in: aes_i586 aes_generic video output bridge stp netconsole configfs lp parport arc4 ecb ath9k snd_hda_codec_idt mac80211 led_class iTCO_wdt iTCO_vendor_support snd_hda_intel ath psmouse snd_hda_codec cfg80211 intel_agp pcspkr serio_raw snd_pcm snd_timer snd soundcore snd_page_alloc agpgart dcdbas e100 mii floppy [ 119.858982] [ 119.859011] Pid: 0, comm: swapper Not tainted (2.6.31-rc5-wl #2) Dell DV051 [ 119.859156] EIP: 0060:[<f8806c70>] EFLAGS: 00010292 CPU: 0 [ 119.859245] EIP is at ieee80211_agg_splice_packets+0x40/0xc0 [mac80211] [ 119.859349] EAX: 00000030 EBX: 0000004c ECX: 00000003 EDX: 00000000 [ 119.859433] ESI: c1c98000 EDI: f745a1c0 EBP: c076be58 ESP: c076be38 [ 119.859541] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 119.859616] Process swapper (pid: 0, ti=c076a000 task=c0709160 task.ti=c076a000) [ 119.859713] Stack: [ 119.859750] 00000002 f745a1c0 c2d56d20 c1c98000 c076be58 c2d56d20 c1c98000 f745a1c0 [ 119.859921] <0> c076be84 f8806edb f882b668 c2d56d20 00000000 f745a74c c1c98020 00000000 [ 119.860105] <0> c2d56d00 f745a1c0 f745a294 c076beac f8802f1e c47926e0 00000040 c076bec0 [ 119.860296] Call Trace: [ 119.860355] [<f8806edb>] ? ieee80211_stop_tx_ba_cb+0xab/0x150 [mac80211] [ 119.860460] [<f8802f1e>] ? ieee80211_tasklet_handler+0xce/0x110 [mac80211] [ 119.860584] [<c04862ff>] ? net_rx_action+0xef/0x1d0 [ 119.860670] [<c0149378>] ? tasklet_action+0x58/0xc0 [ 119.860758] [<c014a0f2>] ? __do_softirq+0xc2/0x190 [ 119.860831] [<c018eb48>] ? handle_IRQ_event+0x58/0x140 [ 119.860924] [<c01205fe>] ? ack_apic_level+0x7e/0x270 [ 119.861014] [<c014a1fd>] ? do_softirq+0x3d/0x40 [ 119.865724] [<c014a345>] ? irq_exit+0x65/0x90 [ 119.867299] [<c010a6af>] ? do_IRQ+0x4f/0xc0 [ 119.867299] [<c014a35d>] ? irq_exit+0x7d/0x90 [ 119.867299] [<c011d547>] ? smp_apic_timer_interrupt+0x57/0x90 [ 119.867299] [<c01094a9>] ? common_interrupt+0x29/0x30 [ 119.867299] [<c010fd9e>] ? mwait_idle+0xbe/0x100 [ 119.867299] [<c0107e42>] ? cpu_idle+0x52/0x90 [ 119.867299] [<c054b1a5>] ? rest_init+0x55/0x60 [ 119.867299] [<c077492d>] ? start_kernel+0x315/0x37d [ 119.867299] [<c07743ce>] ? unknown_bootoption+0x0/0x1f9 [ 119.867299] [<c0774099>] ? i386_start_kernel+0x79/0x81 [ 119.867299] Code: d8 83 c3 4c 83 e0 07 0f b7 04 85 20 7b 82 f8 89 75 f8 89 d6 89 7d fc 89 c2 89 45 e0 8b 45 e4 e8 c7 28 01 00 8b 54 9e 0c 8d 42 30 <39> 42 30 74 67 8b 45 e4 83 c0 64 89 45 e8 e8 dd ba d5 c7 89 45 [ 119.867299] EIP: [<f8806c70>] ieee80211_agg_splice_packets+0x40/0xc0 [mac80211] SS:ESP 0068:c076be38 [ 119.867299] CR2: 0000000000000030 [ 119.934842] ---[ end trace d4e4ee5c282a2c7f ]--- [ 119.939588] Kernel panic - not syncing: Fatal exception in interrupt [ 119.944409] Pid: 0, comm: swapper Tainted: G D 2.6.31-rc5-wl #2 [ 119.949161] Call Trace: [ 119.953794] [<c055fff0>] ? printk+0x18/0x20 [ 119.958441] [<c055ff20>] panic+0x43/0xfb [ 119.963081] [<c05636d1>] oops_end+0xc1/0xd0 [ 119.967744] [<c0127f36>] no_context+0xb6/0x1a0 [ 119.972402] [<c012807b>] __bad_area_nosemaphore+0x5b/0x170 [ 119.977064] [<c049588c>] ? netpoll_send_udp+0x1dc/0x1f0 [ 119.981620] [<f871c2c5>] ? write_msg+0xd5/0xe0 [netconsole] [ 119.986254] [<f871c1f0>] ? write_msg+0x0/0xe0 [netconsole] [ 119.990944] [<c0144812>] ? __call_console_drivers+0x62/0x80 [ 119.995541] [<c015fc9b>] ? up+0x2b/0x40 [ 120.000102] [<c01281a2>] bad_area_nosemaphore+0x12/0x20 [ 120.004595] [<c0564c5c>] do_page_fault+0x24c/0x2f0 [ 120.009189] [<c0564a10>] ? do_page_fault+0x0/0x2f0 [ 120.013601] [<c0562bae>] error_code+0x66/0x6c [ 120.018084] [<f881007b>] ? ieee80211_tkip_decrypt_data+0x1b/0x3e0 [mac80211] [ 120.022609] [<c0564a10>] ? do_page_fault+0x0/0x2f0 [ 120.027114] [<f8806c70>] ? ieee80211_agg_splice_packets+0x40/0xc0 [mac80211] [ 120.031616] [<f8806edb>] ieee80211_stop_tx_ba_cb+0xab/0x150 [mac80211] [ 120.036055] [<f8802f1e>] ieee80211_tasklet_handler+0xce/0x110 [mac80211] [ 120.040587] [<c04862ff>] ? net_rx_action+0xef/0x1d0 [ 120.045012] [<c0149378>] tasklet_action+0x58/0xc0 [ 120.049329] [<c014a0f2>] __do_softirq+0xc2/0x190 [ 120.053531] [<c018eb48>] ? handle_IRQ_event+0x58/0x140 [ 120.057552] [<c01205fe>] ? ack_apic_level+0x7e/0x270 [ 120.061640] [<c014a1fd>] do_softirq+0x3d/0x40 [ 120.065710] [<c014a345>] irq_exit+0x65/0x90 [ 120.069662] [<c010a6af>] do_IRQ+0x4f/0xc0 [ 120.073648] [<c014a35d>] ? irq_exit+0x7d/0x90 [ 120.077611] [<c011d547>] ? smp_apic_timer_interrupt+0x57/0x90 [ 120.081583] [<c01094a9>] common_interrupt+0x29/0x30 [ 120.085530] [<c010fd9e>] ? mwait_idle+0xbe/0x100 [ 120.089388] [<c0107e42>] cpu_idle+0x52/0x90 [ 120.093237] [<c054b1a5>] rest_init+0x55/0x60 [ 120.097001] [<c077492d>] start_kernel+0x315/0x37d [ 120.100715] [<c07743ce>] ? unknown_bootoption+0x0/0x1f9 [ 120.104377] [<c0774099>] i386_start_kernel+0x79/0x81 And the same culprit lines of code in GDB: root@DV051:~# gdb /lib/modules/2.6.31-rc5-wl/kernel/net/mac80211/mac80211.ko GNU gdb 6.8-debian Copyright (C) 2008 Free Software Foundation, Inc. License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html> This is free software: you are free to change and redistribute it. There is NO WARRANTY, to the extent permitted by law. Type "show copying" and "show warranty" for details. This GDB was configured as "i486-linux-gnu"... (gdb) l * (ieee80211_agg_splice_packets+0x40) 0x4ca0 is in ieee80211_agg_splice_packets (net/mac80211/agg-tx.c:384). 379 380 ieee80211_stop_queue_by_reason( 381 &local->hw, queue, 382 IEEE80211_QUEUE_STOP_REASON_AGGREGATION); 383 384 if (!skb_queue_empty(&sta->ampdu_mlme.tid_tx[tid]->pending)) { 385 spin_lock_irqsave(&local->queue_stop_reason_lock, flags); 386 /* copy over remaining packets */ 387 skb_queue_splice_tail_init( 388 &sta->ampdu_mlme.tid_tx[tid]->pending, (gdb) q Created attachment 22671 [details]
Do not splice TID queue unless its set
Please try this patch, also please be sure to enable:
CONFIG_MAC80211_HT_DEBUG=y
and provide the logs.
I have updated my git to the latest master-2009-08-10, applied the patch, enabled HT debug, compiled and installed. I am now pleased that the crash has now been resolved. However, I am not seeing the message "TID %d gone but expected when splicing aggregates from the pending queue" when the crash would be happening. My guess is because of the return statement just above the code to print the message. Here is the output of the whole boot session (I have changed the MAC addresses for privacy reasons). [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 2.6.31-rc5-wl (root@DV051) (gcc version 4.3.3 (Ubuntu 4.3.3-5ubuntu4) ) #3 SMP Tue Aug 11 18:35:51 BST 2009 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] NSC Geode by NSC [ 0.000000] Cyrix CyrixInstead [ 0.000000] Centaur CentaurHauls [ 0.000000] Transmeta GenuineTMx86 [ 0.000000] Transmeta TransmetaCPU [ 0.000000] UMC UMC UMC UMC [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: 0000000000000000 - 00000000000a0000 (usable) [ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved) [ 0.000000] BIOS-e820: 0000000000100000 - 000000007f688c00 (usable) [ 0.000000] BIOS-e820: 000000007f688c00 - 000000007f68ac00 (ACPI NVS) [ 0.000000] BIOS-e820: 000000007f68ac00 - 000000007f68cc00 (ACPI data) [ 0.000000] BIOS-e820: 000000007f68cc00 - 0000000080000000 (reserved) [ 0.000000] BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved) [ 0.000000] BIOS-e820: 00000000fec00000 - 00000000fed00400 (reserved) [ 0.000000] BIOS-e820: 00000000fed20000 - 00000000feda0000 (reserved) [ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fef00000 (reserved) [ 0.000000] BIOS-e820: 00000000ffb00000 - 0000000100000000 (reserved) [ 0.000000] DMI 2.3 present. [ 0.000000] last_pfn = 0x7f688 max_arch_pfn = 0x1000000 [ 0.000000] Scanning 1 areas for low memory corruption [ 0.000000] modified physical RAM map: [ 0.000000] modified: 0000000000000000 - 0000000000002000 (usable) [ 0.000000] modified: 0000000000002000 - 0000000000006000 (reserved) [ 0.000000] modified: 0000000000006000 - 00000000000a0000 (usable) [ 0.000000] modified: 00000000000f0000 - 0000000000100000 (reserved) [ 0.000000] modified: 0000000000100000 - 000000007f688c00 (usable) [ 0.000000] modified: 000000007f688c00 - 000000007f68ac00 (ACPI NVS) [ 0.000000] modified: 000000007f68ac00 - 000000007f68cc00 (ACPI data) [ 0.000000] modified: 000000007f68cc00 - 0000000080000000 (reserved) [ 0.000000] modified: 00000000e0000000 - 00000000f0000000 (reserved) [ 0.000000] modified: 00000000fec00000 - 00000000fed00400 (reserved) [ 0.000000] modified: 00000000fed20000 - 00000000feda0000 (reserved) [ 0.000000] modified: 00000000fee00000 - 00000000fef00000 (reserved) [ 0.000000] modified: 00000000ffb00000 - 0000000100000000 (reserved) [ 0.000000] init_memory_mapping: 0000000000000000-00000000379fe000 [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] RAMDISK: 35106000 - 37fefc94 [ 0.000000] Allocated new RAMDISK: 008a9000 - 03792c94 [ 0.000000] Move RAMDISK from 0000000035106000 - 0000000037fefc93 to 008a9000 - 03792c93 [ 0.000000] ACPI: RSDP 000fec00 00014 (v00 DELL ) [ 0.000000] ACPI: RSDT 000fcc50 0003C (v01 DELL DV051 00000007 ASL 00000061) [ 0.000000] ACPI: FACP 000fcc8c 00074 (v01 DELL DV051 00000007 ASL 00000061) [ 0.000000] ACPI: DSDT fffc56f3 02D5F (v01 DELL dt_ex 00001000 MSFT 0100000D) [ 0.000000] ACPI: FACS 7f688c00 00040 [ 0.000000] ACPI: SSDT fffc858f 000BA (v01 DELL st_ex 00001000 MSFT 0100000D) [ 0.000000] ACPI: APIC 000fcd00 00092 (v01 DELL DV051 00000007 ASL 00000061) [ 0.000000] ACPI: BOOT 000fcd92 00028 (v01 DELL DV051 00000007 ASL 00000061) [ 0.000000] ACPI: MCFG 000fcdba 0003E (v01 DELL DV051 00000007 ASL 00000061) [ 0.000000] ACPI: HPET 000fcdf8 00038 (v01 DELL DV051 00000007 ASL 00000061) [ 0.000000] 1148MB HIGHMEM available. [ 0.000000] 889MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 379fe000 [ 0.000000] low ram: 0 - 379fe000 [ 0.000000] node 0 low ram: 00000000 - 379fe000 [ 0.000000] node 0 bootmap 00009000 - 0000ff40 [ 0.000000] (9 early reservations) ==> bootmem [0000000000 - 00379fe000] [ 0.000000] #0 [0000000000 - 0000001000] BIOS data page ==> [0000000000 - 0000001000] [ 0.000000] #1 [0000001000 - 0000002000] EX TRAMPOLINE ==> [0000001000 - 0000002000] [ 0.000000] #2 [0000006000 - 0000007000] TRAMPOLINE ==> [0000006000 - 0000007000] [ 0.000000] #3 [0000100000 - 00008a1a38] TEXT DATA BSS ==> [0000100000 - 00008a1a38] [ 0.000000] #4 [000009fc00 - 0000100000] BIOS reserved ==> [000009fc00 - 0000100000] [ 0.000000] #5 [00008a2000 - 00008a81d0] BRK ==> [00008a2000 - 00008a81d0] [ 0.000000] #6 [0000007000 - 0000009000] PGTABLE ==> [0000007000 - 0000009000] [ 0.000000] #7 [00008a9000 - 0003792c94] NEW RAMDISK ==> [00008a9000 - 0003792c94] [ 0.000000] #8 [0000009000 - 0000010000] BOOTMAP ==> [0000009000 - 0000010000] [ 0.000000] found SMP MP-table at [c00fe710] fe710 [ 0.000000] Zone PFN ranges: [ 0.000000] DMA 0x00000000 -> 0x00001000 [ 0.000000] Normal 0x00001000 -> 0x000379fe [ 0.000000] HighMem 0x000379fe -> 0x0007f688 [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[3] active PFN ranges [ 0.000000] 0: 0x00000000 -> 0x00000002 [ 0.000000] 0: 0x00000006 -> 0x000000a0 [ 0.000000] 0: 0x00000100 -> 0x0007f688 [ 0.000000] Using APIC driver default [ 0.000000] ACPI: PM-Timer IO Port: 0x808 [ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x06] disabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x04] lapic_id[0x02] disabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x05] lapic_id[0x04] disabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x06] lapic_id[0x07] disabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x07] lapic_id[0x03] disabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x08] lapic_id[0x05] disabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] high level lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x08] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 8, version 32, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] SMP: Allowing 8 CPUs, 6 hotplug CPUs [ 0.000000] PM: Registered nosave memory: 0000000000002000 - 0000000000006000 [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000 [ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000 [ 0.000000] Allocating PCI resources starting at 80000000 (gap: 80000000:60000000) [ 0.000000] NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:8 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 14 pages at c478d000, static data 33500 bytes [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 517686 [ 0.000000] Kernel command line: root=UUID=a8de6ccd-1498-4938-9f76-b696cf4edbf6 ro vga=775 [ 0.000000] PID hash table entries: 4096 (order: 12, 16384 bytes) [ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) [ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) [ 0.000000] Enabling fast FPU save and restore... done. [ 0.000000] Enabling unmasked SIMD FPU exception support... done. [ 0.000000] Initializing CPU#0 [ 0.000000] allocated 10437280 bytes of page_cgroup [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.000000] Initializing HighMem for node 0 (000379fe:0007f688) [ 0.000000] Memory: 2002344k/2087456k available (4508k kernel code, 83716k reserved, 2051k data, 548k init, 1176104k highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xfff1e000 - 0xfffff000 ( 900 kB) [ 0.000000] pkmap : 0xffa00000 - 0xffc00000 (2048 kB) [ 0.000000] vmalloc : 0xf81fe000 - 0xff9fe000 ( 120 MB) [ 0.000000] lowmem : 0xc0000000 - 0xf79fe000 ( 889 MB) [ 0.000000] .init : 0xc0774000 - 0xc07fd000 ( 548 kB) [ 0.000000] .data : 0xc056732f - 0xc07680a8 (2051 kB) [ 0.000000] .text : 0xc0100000 - 0xc056732f (4508 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] SLUB: Genslabs=13, HWalign=128, Order=0-3, MinObjects=0, CPUs=8, Nodes=1 [ 0.000000] NR_IRQS:512 [ 0.000000] Fast TSC calibration using PIT [ 0.000000] Detected 2992.590 MHz processor. [ 0.000028] Console: colour dummy device 80x25 [ 0.000033] console [tty0] enabled [ 0.000440] HPET: 3 timers in total, 0 timers will be used for per-cpu timer [ 0.000448] Calibrating delay loop (skipped), value calculated using timer frequency.. 5985.18 BogoMIPS (lpj=29925900) [ 0.000472] Security Framework initialized [ 0.000481] SELinux: Disabled at boot. [ 0.000491] Mount-cache hash table entries: 512 [ 0.000653] Initializing cgroup subsys ns [ 0.000660] Initializing cgroup subsys cpuacct [ 0.000667] Initializing cgroup subsys memory [ 0.000677] Initializing cgroup subsys freezer [ 0.000700] CPU: Trace cache: 12K uops, L1 D cache: 16K [ 0.000706] CPU: L2 cache: 1024K [ 0.000710] CPU: Physical Processor ID: 0 [ 0.000714] CPU: Processor Core ID: 0 [ 0.000719] using mwait in idle threads. [ 0.000733] Checking 'hlt' instruction... OK. [ 0.041966] ACPI: Core revision 20090521 [ 0.089050] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.189078] CPU0: Intel(R) Pentium(R) 4 CPU 3.00GHz stepping 09 [ 0.190000] Booting processor 1 APIC 0x1 ip 0x6000 [ 0.010000] Initializing CPU#1 [ 0.010000] Calibrating delay using timer specific routine.. 5985.04 BogoMIPS (lpj=29925200) [ 0.010000] CPU: Trace cache: 12K uops, L1 D cache: 16K [ 0.010000] CPU: L2 cache: 1024K [ 0.010000] CPU: Physical Processor ID: 0 [ 0.010000] CPU: Processor Core ID: 0 [ 0.340409] CPU1: Intel(R) Pentium(R) 4 CPU 3.00GHz stepping 09 [ 0.340448] checking TSC synchronization [CPU#0 -> CPU#1]: passed. [ 0.350044] Brought up 2 CPUs [ 0.350052] Total of 2 processors activated (11970.22 BogoMIPS). [ 0.350211] Booting paravirtualized kernel on bare hardware [ 0.350391] regulator: core version 0.5 [ 0.350391] Time: 18:39:04 Date: 08/11/09 [ 0.350391] NET: Registered protocol family 16 [ 0.350391] EISA bus registered [ 0.350391] ACPI: bus type pci registered [ 0.350391] PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255 [ 0.350391] PCI: MCFG area at e0000000 reserved in E820 [ 0.350391] PCI: Using MMCONFIG for extended config space [ 0.350391] PCI: Using configuration type 1 for base access [ 0.351631] bio: create slab <bio-0> at 0 [ 0.374662] ACPI: BIOS _OSI(Linux) query ignored [ 0.385419] ACPI: Interpreter enabled [ 0.385431] ACPI: (supports S0 S1 S3 S4 S5) [ 0.385467] ACPI: Using IOAPIC for interrupt routing [ 0.428036] ACPI: No dock devices found. [ 0.431918] ACPI: PCI Root Bridge [PCI0] (0000:00) [ 0.432185] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold [ 0.432192] pci 0000:00:1b.0: PME# disabled [ 0.432262] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold [ 0.432270] pci 0000:00:1c.0: PME# disabled [ 0.432341] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold [ 0.432348] pci 0000:00:1c.1: PME# disabled [ 0.432693] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold [ 0.432701] pci 0000:00:1d.7: PME# disabled [ 0.432825] pci 0000:00:1f.0: quirk: region 0800-087f claimed by ICH6 ACPI/GPIO/TCO [ 0.432834] pci 0000:00:1f.0: quirk: region 0880-08bf claimed by ICH6 GPIO [ 0.432841] pci 0000:00:1f.0: LPC Generic IO decode 1 PIO at 0c00-0c7f [ 0.432848] pci 0000:00:1f.0: LPC Generic IO decode 2 PIO at 00e0-00ef [ 0.433017] pci 0000:00:1f.2: PME# supported from D3hot [ 0.433024] pci 0000:00:1f.2: PME# disabled [ 0.433313] pci 0000:03:02.0: PME# supported from D0 D3hot [ 0.433321] pci 0000:03:02.0: PME# disabled [ 0.433428] pci 0000:03:08.0: PME# supported from D0 D1 D2 D3hot D3cold [ 0.433435] pci 0000:03:08.0: PME# disabled [ 0.433478] pci 0000:00:1e.0: transparent bridge [ 0.822692] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 9 10 *11 12 15) [ 0.823042] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 9 *10 11 12 15) [ 0.823388] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 *4 5 6 7 9 10 11 12 15) [ 0.823730] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 10 11 12 15) *0, disabled. [ 0.824079] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 9 *10 11 12 15) [ 0.824425] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 *9 10 11 12 15) [ 0.824769] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 *5 6 7 9 10 11 12 15) [ 0.825115] ACPI: PCI Interrupt Link [LNKH] (IRQs *3 4 5 6 7 9 10 11 12 15) [ 0.825390] SCSI subsystem initialized [ 0.825427] usbcore: registered new interface driver usbfs [ 0.825427] usbcore: registered new interface driver hub [ 0.825427] usbcore: registered new device driver usb [ 0.825427] ACPI: WMI: Mapper loaded [ 0.825427] PCI: Using ACPI for IRQ routing [ 0.825427] Bluetooth: Core ver 2.15 [ 0.825427] NET: Registered protocol family 31 [ 0.825427] Bluetooth: HCI device and connection manager initialized [ 0.825427] Bluetooth: HCI socket layer initialized [ 0.825427] NET: Registered protocol family 8 [ 0.825427] NET: Registered protocol family 20 [ 0.825427] NetLabel: Initializing [ 0.825427] NetLabel: domain hash size = 128 [ 0.825427] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.825427] NetLabel: unlabeled traffic allowed by default [ 0.825427] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.825427] hpet0: 3 comparators, 64-bit 14.318180 MHz counter [ 0.831969] pnp: PnP ACPI init [ 0.831997] ACPI: bus type pnp registered [ 0.837818] pnp 00:01: io resource (0x800-0x85f) overlaps 0000:00:1f.0 BAR 7 (0x800-0x87f), disabling [ 0.837828] pnp 00:01: io resource (0x860-0x8ff) overlaps 0000:00:1f.0 BAR 7 (0x800-0x87f), disabling [ 0.859371] pnp: PnP ACPI: found 9 devices [ 0.859377] ACPI: ACPI bus type pnp unregistered [ 0.859385] PnPBIOS: Disabled by ACPI PNP [ 0.859402] system 00:01: ioport range 0xc00-0xc7f has been reserved [ 0.859417] system 00:07: iomem range 0x0-0x9ffff could not be reserved [ 0.859424] system 00:07: iomem range 0x100000-0xffffff could not be reserved [ 0.859431] system 00:07: iomem range 0x1000000-0x7f688bff could not be reserved [ 0.859439] system 00:07: iomem range 0xc0000-0xfffff could not be reserved [ 0.859445] system 00:07: iomem range 0xfec00000-0xfecfffff could not be reserved [ 0.859452] system 00:07: iomem range 0xfee00000-0xfeefffff has been reserved [ 0.859458] system 00:07: iomem range 0xfed20000-0xfed9ffff has been reserved [ 0.859464] system 00:07: iomem range 0xffb00000-0xffbfffff has been reserved [ 0.859470] system 00:07: iomem range 0xffc00000-0xffffffff has been reserved [ 0.859482] system 00:08: ioport range 0x100-0x1fe could not be reserved [ 0.859488] system 00:08: ioport range 0x200-0x277 has been reserved [ 0.859495] system 00:08: ioport range 0x280-0x2e7 has been reserved [ 0.859503] system 00:08: ioport range 0x2e8-0x2ef has been reserved [ 0.859510] system 00:08: ioport range 0x2f0-0x2f7 has been reserved [ 0.859518] system 00:08: ioport range 0x2f8-0x2ff has been reserved [ 0.859525] system 00:08: ioport range 0x300-0x377 could not be reserved [ 0.859533] system 00:08: ioport range 0x380-0x3bb has been reserved [ 0.859540] system 00:08: ioport range 0x3c0-0x3e7 has been reserved [ 0.859548] system 00:08: ioport range 0x3f6-0x3f7 could not be reserved [ 0.859556] system 00:08: ioport range 0x400-0x4cf has been reserved [ 0.859563] system 00:08: ioport range 0x4d2-0x57f has been reserved [ 0.859571] system 00:08: ioport range 0x580-0x677 has been reserved [ 0.859578] system 00:08: ioport range 0x680-0x777 has been reserved [ 0.859586] system 00:08: ioport range 0x780-0x7bb has been reserved [ 0.859593] system 00:08: ioport range 0x7c0-0x7ff has been reserved [ 0.859601] system 00:08: ioport range 0x8e0-0x8ff has been reserved [ 0.859608] system 00:08: ioport range 0x900-0x9fe has been reserved [ 0.859616] system 00:08: ioport range 0xa00-0xafe has been reserved [ 0.859624] system 00:08: ioport range 0xb00-0xbfe has been reserved [ 0.859631] system 00:08: ioport range 0xc80-0xcaf has been reserved [ 0.859639] system 00:08: ioport range 0xcb0-0xcbf has been reserved [ 0.859646] system 00:08: ioport range 0xcc0-0xcf7 has been reserved [ 0.859654] system 00:08: ioport range 0xd00-0xdfe has been reserved [ 0.859661] system 00:08: ioport range 0xe00-0xefe has been reserved [ 0.859669] system 00:08: ioport range 0xf00-0xffe has been reserved [ 0.859677] system 00:08: ioport range 0x2000-0x20fe has been reserved [ 0.859684] system 00:08: ioport range 0x2100-0x21fe has been reserved [ 0.859692] system 00:08: ioport range 0x2200-0x22fe has been reserved [ 0.859700] system 00:08: ioport range 0x2300-0x23fe has been reserved [ 0.859707] system 00:08: ioport range 0x2400-0x24fe has been reserved [ 0.859715] system 00:08: ioport range 0x2500-0x25fe has been reserved [ 0.859723] system 00:08: ioport range 0x2600-0x26fe has been reserved [ 0.859731] system 00:08: ioport range 0x2700-0x27fe has been reserved [ 0.859738] system 00:08: ioport range 0x2800-0x28fe has been reserved [ 0.859746] system 00:08: ioport range 0x2900-0x29fe has been reserved [ 0.859754] system 00:08: ioport range 0x2a00-0x2afe has been reserved [ 0.859762] system 00:08: ioport range 0x2b00-0x2bfe has been reserved [ 0.859770] system 00:08: ioport range 0x2c00-0x2cfe has been reserved [ 0.859778] system 00:08: ioport range 0x2d00-0x2dfe has been reserved [ 0.859786] system 00:08: ioport range 0x2e00-0x2efe has been reserved [ 0.859794] system 00:08: ioport range 0x2f00-0x2ffe has been reserved [ 0.859802] system 00:08: ioport range 0x5000-0x50fe has been reserved [ 0.859809] system 00:08: ioport range 0x5100-0x51fe has been reserved [ 0.859817] system 00:08: ioport range 0x5200-0x52fe has been reserved [ 0.859825] system 00:08: ioport range 0x5300-0x53fe has been reserved [ 0.859836] system 00:08: ioport range 0x5400-0x54fe has been reserved [ 0.859844] system 00:08: ioport range 0x5500-0x55fe has been reserved [ 0.859853] system 00:08: ioport range 0x5600-0x56fe has been reserved [ 0.859861] system 00:08: ioport range 0x5700-0x57fe has been reserved [ 0.859869] system 00:08: ioport range 0x5800-0x58fe has been reserved [ 0.859877] system 00:08: ioport range 0x5900-0x59fe has been reserved [ 0.859885] system 00:08: ioport range 0x5a00-0x5afe has been reserved [ 0.859893] system 00:08: ioport range 0x5b00-0x5bfe has been reserved [ 0.859902] system 00:08: ioport range 0x5c00-0x5cfe has been reserved [ 0.859910] system 00:08: ioport range 0x5d00-0x5dfe has been reserved [ 0.859918] system 00:08: ioport range 0x5e00-0x5efe has been reserved [ 0.859927] system 00:08: ioport range 0x5f00-0x5ffe has been reserved [ 0.859935] system 00:08: ioport range 0x6000-0x60fe has been reserved [ 0.859943] system 00:08: ioport range 0x6100-0x61fe has been reserved [ 0.859952] system 00:08: ioport range 0x6200-0x62fe has been reserved [ 0.859960] system 00:08: ioport range 0x6300-0x63fe has been reserved [ 0.859968] system 00:08: ioport range 0x6400-0x64fe has been reserved [ 0.859977] system 00:08: ioport range 0x6500-0x65fe has been reserved [ 0.859985] system 00:08: ioport range 0x6600-0x66fe has been reserved [ 0.859994] system 00:08: ioport range 0x6700-0x67fe has been reserved [ 0.860014] system 00:08: ioport range 0x6800-0x68fe has been reserved [ 0.860023] system 00:08: ioport range 0x6900-0x69fe has been reserved [ 0.860031] system 00:08: ioport range 0x6a00-0x6afe has been reserved [ 0.860040] system 00:08: ioport range 0x6b00-0x6bfe has been reserved [ 0.860049] system 00:08: ioport range 0x6c00-0x6cfe has been reserved [ 0.860057] system 00:08: ioport range 0x6d00-0x6dfe has been reserved [ 0.860066] system 00:08: ioport range 0x6e00-0x6efe has been reserved [ 0.860075] system 00:08: ioport range 0x6f00-0x6ffe has been reserved [ 0.860083] system 00:08: ioport range 0xa000-0xa0fe has been reserved [ 0.860092] system 00:08: ioport range 0xa100-0xa1fe has been reserved [ 0.860101] system 00:08: ioport range 0xa200-0xa2fe has been reserved [ 0.860110] system 00:08: ioport range 0xa300-0xa3fe has been reserved [ 0.860118] system 00:08: ioport range 0xa400-0xa4fe has been reserved [ 0.860127] system 00:08: ioport range 0xa500-0xa5fe has been reserved [ 0.860136] system 00:08: ioport range 0xa600-0xa6fe has been reserved [ 0.860145] system 00:08: ioport range 0xa700-0xa7fe has been reserved [ 0.860154] system 00:08: ioport range 0xa800-0xa8fe has been reserved [ 0.860163] system 00:08: ioport range 0xa900-0xa9fe has been reserved [ 0.860172] system 00:08: ioport range 0xaa00-0xaafe has been reserved [ 0.860182] system 00:08: ioport range 0xab00-0xabfe has been reserved [ 0.860191] system 00:08: ioport range 0xac00-0xacfe has been reserved [ 0.860200] system 00:08: ioport range 0xad00-0xadfe has been reserved [ 0.860209] system 00:08: ioport range 0xae00-0xaefe has been reserved [ 0.860219] system 00:08: ioport range 0xaf00-0xaffe has been reserved [ 0.860228] system 00:08: iomem range 0xe0000000-0xefffffff has been reserved [ 0.860235] system 00:08: iomem range 0xfeda0000-0xfedacfff has been reserved [ 0.894994] pci 0000:00:1c.0: PCI bridge, secondary bus 0000:01 [ 0.895000] pci 0000:00:1c.0: IO window: disabled [ 0.895009] pci 0000:00:1c.0: MEM window: 0xdfe00000-0xdfefffff [ 0.895016] pci 0000:00:1c.0: PREFETCH window: disabled [ 0.895023] pci 0000:00:1c.1: PCI bridge, secondary bus 0000:02 [ 0.895028] pci 0000:00:1c.1: IO window: disabled [ 0.895036] pci 0000:00:1c.1: MEM window: 0xdfd00000-0xdfdfffff [ 0.895042] pci 0000:00:1c.1: PREFETCH window: disabled [ 0.895050] pci 0000:00:1e.0: PCI bridge, secondary bus 0000:03 [ 0.895056] pci 0000:00:1e.0: IO window: 0xd000-0xdfff [ 0.895064] pci 0000:00:1e.0: MEM window: 0xdfc00000-0xdfcfffff [ 0.895070] pci 0000:00:1e.0: PREFETCH window: disabled [ 0.895090] pci 0000:00:1c.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 0.895111] pci 0000:00:1c.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 0.895206] NET: Registered protocol family 2 [ 0.895344] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.895758] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.896124] TCP bind hash table entries: 65536 (order: 7, 524288 bytes) [ 0.896407] TCP: Hash tables configured (established 131072 bind 65536) [ 0.896412] TCP reno registered [ 0.896564] NET: Registered protocol family 1 [ 0.896651] Trying to unpack rootfs image as initramfs... [ 2.437621] Freeing initrd memory: 48039k freed [ 2.464201] Simple Boot Flag at 0x7a set to 0x1 [ 2.464335] cpufreq-nforce2: No nForce2 chipset. [ 2.464377] Scanning for low memory corruption every 60 seconds [ 2.464508] audit: initializing netlink socket (disabled) [ 2.464527] type=2000 audit(1250015945.460:1): initialized [ 2.473214] highmem bounce pool size: 64 pages [ 2.473226] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 2.474969] VFS: Disk quotas dquot_6.5.2 [ 2.475056] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 2.475769] fuse init (API version 7.12) [ 2.475876] msgmni has been set to 1709 [ 2.476157] alg: No test for stdrng (krng) [ 2.476180] io scheduler noop registered [ 2.476186] io scheduler anticipatory registered [ 2.476191] io scheduler deadline registered (default) [ 2.476250] io scheduler cfq registered [ 2.476369] pci 0000:03:08.0: Firmware left e100 interrupts enabled; disabling [ 2.476783] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 2.476859] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 2.477043] uvesafb: failed to execute /sbin/v86d [ 2.477052] uvesafb: make sure that the v86d helper is installed and executable [ 2.477060] uvesafb: Getting VBE info block failed (eax=0x4f00, err=-2) [ 2.477065] uvesafb: vbe_init() failed with -22 [ 2.477073] uvesafb: probe of uvesafb.0 failed with error -22 [ 2.477168] vesafb: framebuffer at 0xc0000000, mapped to 0xf8280000, using 2560k, total 7872k [ 2.477176] vesafb: mode is 1280x1024x8, linelength=1280, pages=5 [ 2.477181] vesafb: scrolling: redraw [ 2.477186] vesafb: Pseudocolor: size=8:8:8:8, shift=0:0:0:0 [ 2.490830] Console: switching to colour frame buffer device 160x64 [ 2.504514] fb0: VESA VGA frame buffer device [ 2.504696] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.504822] ACPI: Power Button [PWRF] [ 2.504945] input: Power Button as /devices/LNXSYSTM:00/device:00/PNP0C0C:00/input/input1 [ 2.505055] ACPI: Power Button [VBTN] [ 2.505566] processor LNXCPU:00: registered as cooling_device0 [ 2.505692] processor LNXCPU:01: registered as cooling_device1 [ 2.541408] isapnp: Scanning for PnP cards... [ 2.853684] isapnp: No Plug & Play device found [ 2.853764] XENFS: not registering filesystem on non-xen platform [ 2.855244] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.855511] Platform driver 'serial8250' needs updating - please use dev_pm_ops [ 2.857031] brd: module loaded [ 2.857640] loop: module loaded [ 2.857781] input: Macintosh mouse button emulation as /devices/virtual/input/input2 [ 2.858022] ahci 0000:00:1f.2: PCI INT C -> GSI 20 (level, low) -> IRQ 20 [ 2.858202] ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 4 ports 1.5 Gbps 0xf impl IDE mode [ 2.858310] ahci 0000:00:1f.2: flags: 64bit ncq pm led slum part [ 2.858769] scsi0 : ahci [ 2.858926] scsi1 : ahci [ 2.859032] scsi2 : ahci [ 2.859139] scsi3 : ahci [ 2.859225] ata1: SATA max UDMA/133 irq_stat 0x00400040, connection status changed irq 20 [ 2.859362] ata2: SATA max UDMA/133 abar m1024@0xdff3bc00 port 0xdff3bd80 irq 20 [ 2.859459] ata3: SATA max UDMA/133 abar m1024@0xdff3bc00 port 0xdff3be00 irq 20 [ 2.859582] ata4: SATA max UDMA/133 abar m1024@0xdff3bc00 port 0xdff3be80 irq 20 [ 2.859817] ata_piix 0000:00:1f.1: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 2.860059] scsi4 : ata_piix [ 2.860175] scsi5 : ata_piix [ 2.860258] ata5: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0xffa0 irq 14 [ 2.860351] ata6: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xffa8 irq 15 [ 2.861369] Fixed MDIO Bus: probed [ 2.861434] PPP generic driver version 2.4.2 [ 2.861620] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 2.861731] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [ 2.861867] ehci_hcd 0000:00:1d.7: EHCI Host Controller [ 2.861996] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 1 [ 2.866012] ehci_hcd 0000:00:1d.7: debug port 1 [ 2.866111] ehci_hcd 0000:00:1d.7: irq 21, io mem 0xffa80800 [ 2.890652] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00 [ 2.894806] usb usb1: configuration #1 chosen from 1 choice [ 2.898868] hub 1-0:1.0: USB hub found [ 2.902898] hub 1-0:1.0: 8 ports detected [ 2.906944] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 2.911056] uhci_hcd: USB Universal Host Controller Interface driver [ 2.915213] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [ 2.919436] uhci_hcd 0000:00:1d.0: UHCI Host Controller [ 2.923678] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 [ 2.927900] uhci_hcd 0000:00:1d.0: irq 21, io base 0x0000ff80 [ 2.932103] usb usb2: configuration #1 chosen from 1 choice [ 2.936235] hub 2-0:1.0: USB hub found [ 2.940329] hub 2-0:1.0: 2 ports detected [ 2.944349] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22 [ 2.948479] uhci_hcd 0000:00:1d.1: UHCI Host Controller [ 2.952561] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 [ 2.956616] uhci_hcd 0000:00:1d.1: irq 22, io base 0x0000ff60 [ 2.960776] usb usb3: configuration #1 chosen from 1 choice [ 2.964817] hub 3-0:1.0: USB hub found [ 2.968767] hub 3-0:1.0: 2 ports detected [ 2.972688] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 2.976632] uhci_hcd 0000:00:1d.2: UHCI Host Controller [ 2.980509] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 [ 2.984494] uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000ff40 [ 2.988518] usb usb4: configuration #1 chosen from 1 choice [ 2.992471] hub 4-0:1.0: USB hub found [ 2.996302] hub 4-0:1.0: 2 ports detected [ 3.000096] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 23 (level, low) -> IRQ 23 [ 3.003950] uhci_hcd 0000:00:1d.3: UHCI Host Controller [ 3.007725] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5 [ 3.011529] uhci_hcd 0000:00:1d.3: irq 23, io base 0x0000ff20 [ 3.015439] usb usb5: configuration #1 chosen from 1 choice [ 3.019304] hub 5-0:1.0: USB hub found [ 3.023122] hub 5-0:1.0: 2 ports detected [ 3.026971] PNP: No PS/2 controller found. Probing ports directly. [ 3.030798] Platform driver 'i8042' needs updating - please use dev_pm_ops [ 3.037117] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.040903] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.044749] mice: PS/2 mouse device common for all mice [ 3.049013] ata5.00: ATAPI: HL-DT-STDVD+-RW GSA-H21N, B109, max UDMA/33 [ 3.050786] rtc_cmos 00:05: RTC can wake from S4 [ 3.050907] rtc_cmos 00:05: rtc core: registered rtc_cmos as rtc0 [ 3.050951] rtc0: alarms up to one day, 242 bytes nvram, hpet irqs [ 3.051259] device-mapper: uevent: version 1.0.3 [ 3.051511] device-mapper: ioctl: 4.15.0-ioctl (2009-04-01) initialised: dm-devel@redhat.com [ 3.051711] device-mapper: multipath: version 1.1.0 loaded [ 3.051716] device-mapper: multipath round-robin: version 1.0.0 loaded [ 3.052092] EISA: Probing bus 0 at eisa.0 [ 3.052097] EISA: Cannot allocate resource for mainboard [ 3.052109] Cannot allocate resource for EISA slot 2 [ 3.052135] Cannot allocate resource for EISA slot 5 [ 3.052142] Cannot allocate resource for EISA slot 6 [ 3.052162] EISA: Detected 0 cards. [ 3.052404] cpuidle: using governor ladder [ 3.052409] cpuidle: using governor menu [ 3.053740] TCP cubic registered [ 3.054224] NET: Registered protocol family 10 [ 3.055528] lo: Disabled Privacy Extensions [ 3.056503] NET: Registered protocol family 17 [ 3.056563] Bluetooth: L2CAP ver 2.13 [ 3.056566] Bluetooth: L2CAP socket layer initialized [ 3.056572] Bluetooth: SCO (Voice Link) ver 0.6 [ 3.056576] Bluetooth: SCO socket layer initialized [ 3.056682] Bluetooth: RFCOMM socket layer initialized [ 3.056694] Bluetooth: RFCOMM TTY layer initialized [ 3.056699] Bluetooth: RFCOMM ver 1.11 [ 3.152383] Using IPI No-Shortcut mode [ 3.156061] registered taskstats version 1 [ 3.159669] Magic number: 5:879:695 [ 3.163216] pci 0000:00:00.0: hash matches [ 3.166752] rtc_cmos 00:05: setting system clock to 2009-08-11 18:39:06 UTC (1250015946) [ 3.170343] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 3.173944] EDD information not available. [ 3.200350] ata5.00: configured for UDMA/33 [ 3.260037] ata4: SATA link down (SStatus 0 SControl 300) [ 3.263573] ata3: SATA link down (SStatus 0 SControl 300) [ 3.290678] ata2: SATA link down (SStatus 0 SControl 300) [ 3.294112] usb 1-1: new high speed USB device using ehci_hcd and address 2 [ 3.440472] usb 1-1: configuration #1 chosen from 1 choice [ 3.444059] hub 1-1:1.0: USB hub found [ 3.447650] hub 1-1:1.0: 4 ports detected [ 3.670039] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 3.716942] ata1.00: ATA-7: ST3160812AS, 3.ADH, max UDMA/133 [ 3.720478] ata1.00: 312500000 sectors, multi 8: LBA48 NCQ (depth 31/32) [ 3.730153] usb 1-1.1: new low speed USB device using ehci_hcd and address 3 [ 3.775272] ata1.00: configured for UDMA/133 [ 3.790143] scsi 0:0:0:0: Direct-Access ATA ST3160812AS 3.AD PQ: 0 ANSI: 5 [ 3.793882] sd 0:0:0:0: Attached scsi generic sg0 type 0 [ 3.797548] sd 0:0:0:0: [sda] 312500000 512-byte logical blocks: (160 GB/149 GiB) [ 3.801268] sd 0:0:0:0: [sda] Write Protect is off [ 3.804965] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 3.808710] scsi 4:0:0:0: CD-ROM HL-DT-ST DVD+-RW GSA-H21N B109 PQ: 0 ANSI: 5 [ 3.809154] sda:sr0: scsi3-mmc drive: 48x/48x writer cd/rw xa/form2 cdda tray [ 3.821411] Uniform CD-ROM driver Revision: 3.20 [ 3.825238] sr 4:0:0:0: Attached scsi generic sg1 type 5 [ 3.828924] sda1 sda2 sda3 [ 3.833027] sd 0:0:0:0: [sda] Attached SCSI disk [ 3.836726] Freeing unused kernel memory: 548k freed [ 3.840836] Write protecting the kernel text: 4512k [ 3.844624] Write protecting the kernel read-only data: 1668k [ 3.862617] usb 1-1.1: configuration #1 chosen from 1 choice [ 3.960161] usb 1-1.2: new full speed USB device using ehci_hcd and address 4 [ 4.081169] usb 1-1.2: configuration #1 chosen from 1 choice [ 4.081802] hub 1-1.2:1.0: USB hub found [ 4.082023] hub 1-1.2:1.0: 3 ports detected [ 4.117179] Platform driver 'floppy' needs updating - please use dev_pm_ops [ 4.121607] Floppy drive(s): fd0 is 1.44M [ 4.142229] FDC 0 is a post-1991 82077 [ 4.162622] e100: Intel(R) PRO/100 Network Driver, 3.5.24-k2-NAPI [ 4.166976] e100: Copyright(c) 1999-2006 Intel Corporation [ 4.171527] e100 0000:03:08.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 4.201497] e100 0000:03:08.0: PME# disabled [ 4.207186] e100: eth0: e100_probe: addr 0xdfcef000, irq 20, MAC addr 00:16:76:af:c1:00 [ 4.390266] usb 1-1.2.1: new full speed USB device using ehci_hcd and address 5 [ 4.501108] usb 1-1.2.1: configuration #1 chosen from 1 choice [ 4.821786] EXT4-fs (sda3): barriers enabled [ 4.837919] kjournald2 starting: pid 682, dev sda3:8, commit interval 5 seconds [ 4.842161] EXT4-fs (sda3): delayed allocation enabled [ 4.846481] EXT4-fs: file extents enabled [ 4.851771] EXT4-fs: mballoc enabled [ 4.855990] EXT4-fs (sda3): mounted filesystem with ordered data mode [ 6.133071] udev: starting version 141 [ 6.618762] Linux agpgart interface v0.103 [ 6.688647] agpgart-intel 0000:00:00.0: Intel 915G Chipset [ 6.693953] agpgart-intel 0000:00:00.0: detected 7932K stolen memory [ 6.700934] agpgart-intel 0000:00:00.0: AGP aperture is 256M @ 0xc0000000 [ 6.745079] input: PC Speaker as /devices/platform/pcspkr/input/input3 [ 6.801753] intel_rng: Firmware space is locked read-only. If you can't or [ 6.801756] intel_rng: don't want to disable this in firmware setup, and if [ 6.801759] intel_rng: you are certain that your system has a functional [ 6.801761] intel_rng: RNG, try using the 'no_fwh_detect' option. [ 7.480614] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2) [ 7.560934] cfg80211: Calling CRDA to update world regulatory domain [ 7.694171] iTCO_vendor_support: vendor-support=0 [ 7.802017] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 7.836128] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.05 [ 7.840801] iTCO_wdt: failed to reset NO_REBOOT flag, reboot disabled by hardware [ 7.845012] iTCO_wdt: No card detected [ 7.944171] cfg80211: World regulatory domain updated: [ 7.948240] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 7.952400] (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 7.956522] (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 7.960656] (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 7.964672] (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 7.968661] (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8.157479] ath9k 0000:03:02.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18 [ 9.800275] Registered led device: ath9k-phy0::radio [ 9.804333] Registered led device: ath9k-phy0::assoc [ 9.808345] Registered led device: ath9k-phy0::tx [ 9.812333] Registered led device: ath9k-phy0::rx [ 9.816218] phy0: Atheros AR9160 MAC/BB Rev:0 AR5133 RF Rev:b0: mem=0xf9960000, irq=18 [ 9.820270] cfg80211: Calling CRDA for country: AT [ 9.830625] cfg80211: Regulatory domain changed to country: AT [ 9.835034] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 9.839553] (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 9.844092] (5170000 KHz - 5250000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 9.848108] (5250000 KHz - 5330000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 9.851985] (5490000 KHz - 5710000 KHz @ 40000 KHz), (N/A, 2700 mBm) [ 10.053575] lp: driver loaded but no devices found [ 10.121729] netconsole: local port 6969 [ 10.125521] netconsole: local IP 192.168.1.2 [ 10.129218] netconsole: interface eth0 [ 10.132913] netconsole: remote port 514 [ 10.136580] netconsole: remote IP 192.168.1.1 [ 10.140104] netconsole: remote ethernet address ba:98:76:54:32:10 [ 10.143737] netconsole: device eth0 not up yet, forcing it [ 10.161808] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 12.040144] e100: eth0 NIC Link is Up 100 Mbps Full Duplex [ 12.043871] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 12.070056] console [netcon0] enabled [ 13.913199] netconsole: network logging started [ 14.292559] EXT4-fs (sda3): internal journal on sda3:8 [ 15.191507] Bridge firewalling registered [ 15.204537] device eth0 entered promiscuous mode [ 15.212257] device wlan0 entered promiscuous mode [ 15.237417] phy0: device now idle [ 15.264899] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 15.302238] br0: port 1(eth0) entering learning state [ 23.910013] eth0: no IPv6 routers present [ 25.550023] br0: no IPv6 routers present [ 30.300044] br0: port 1(eth0) entering forwarding state [ 34.581697] ath9k: DMA failed to stop in 10 ms AR_CR=0x00000024 AR_DIAG_SW=0x40000020 [ 34.590722] br0: port 2(wlan0) entering disabled state [ 34.599846] phy0: device no longer idle - in use [ 34.710221] br0: port 2(wlan0) entering learning state [ 45.660021] wlan0: no IPv6 routers present [ 46.298369] phy0: Allocated STA 01:23:45:67:89:ab [ 46.298459] phy0: Inserted STA 01:23:45:67:89:ab [ 49.402282] phy0: Removed STA 01:23:45:67:89:ab [ 49.430035] phy0: Destroyed STA 01:23:45:67:89:ab [ 49.432909] phy0: Allocated STA 01:23:45:67:89:ab [ 49.432993] phy0: Inserted STA 01:23:45:67:89:ab [ 49.710022] br0: port 2(wlan0) entering forwarding state [ 50.608053] padlock: VIA PadLock not detected. [ 51.433969] Open BA session requested for 01:23:45:67:89:ab tid 0 [ 51.434087] activated addBA response timer on tid 0 [ 51.434987] switched off addBA timer for tid 0 [ 51.435067] Aggregation is on for tid 0 [ 58.474977] Rx A-MPDU request on tid 0 result 0 [ 58.816116] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 39 [ 58.816214] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 58.816338] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 61.165424] Open BA session requested for 01:23:45:67:89:ab tid 0 [ 61.165522] activated addBA response timer on tid 0 [ 61.166504] switched off addBA timer for tid 0 [ 61.166585] Aggregation is on for tid 0 [ 67.820029] rx session timer expired on tid 0 [ 67.820115] Rx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 75.012386] phy0: Allocated STA 01:23:45:67:89:ab [ 75.012492] phy0: Destroyed STA 01:23:45:67:89:ab [ 78.674950] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.675074] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.675184] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.675277] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.675405] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.675488] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.675611] unexpected callback to A-MPDU stop [ 78.676822] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.676914] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.677029] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.679321] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.679415] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.679538] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.680343] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.680437] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.680554] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.680665] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.680780] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.680882] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.680961] unexpected callback to A-MPDU stop [ 78.681702] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.681819] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.681939] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.683732] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.683850] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.683969] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.684061] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.684168] delba from 01:23:45:67:89:ab (recipient) tid 0 reason code 38 [ 78.684260] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.684382] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.684465] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.684557] unexpected callback to A-MPDU stop [ 78.684640] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.684719] unexpected callback to A-MPDU stop [ 78.685581] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.685684] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.687961] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.688081] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.688197] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.692342] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.696440] Tx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 78.700564] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.704637] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.708644] unexpected callback to A-MPDU stop [ 78.712655] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.716766] unexpected callback to A-MPDU stop [ 78.720787] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.724911] unexpected callback to A-MPDU stop [ 78.728995] Stopping Tx BA session for 01:23:45:67:89:ab tid 0 [ 78.733020] unexpected callback to A-MPDU stop [ 78.749900] Rx A-MPDU request on tid 0 result 0 [ 97.149810] __ratelimit: 6 callbacks suppressed [ 97.153848] delba from 01:23:45:67:89:ab (initiator) tid 0 reason code 39 [ 97.157968] Rx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 116.501760] phy0: Allocated STA 01:23:45:67:89:ab [ 116.505848] phy0: Destroyed STA 01:23:45:67:89:ab [ 119.663280] Rx A-MPDU request on tid 0 result 0 [ 136.549916] delba from 01:23:45:67:89:ab (initiator) tid 0 reason code 39 [ 136.554030] Rx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 150.353916] Rx A-MPDU request on tid 0 result 0 [ 156.400022] rx session timer expired on tid 0 [ 156.404103] Rx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 163.589085] phy0: Allocated STA 01:23:45:67:89:ab [ 163.593225] phy0: Destroyed STA 01:23:45:67:89:ab [ 171.413666] Rx A-MPDU request on tid 0 result 0 [ 190.158400] delba from 01:23:45:67:89:ab (initiator) tid 0 reason code 39 [ 190.162546] Rx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 197.313068] Rx A-MPDU request on tid 0 result 0 [ 209.869560] delba from 01:23:45:67:89:ab (initiator) tid 0 reason code 39 [ 209.873831] Rx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 221.303467] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 221.341683] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 221.345790] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 221.444228] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 221.557885] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 221.561996] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 221.660438] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 221.774096] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 221.778226] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 221.876645] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 221.990301] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 221.994333] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 222.092854] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 222.206508] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 222.210661] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 222.420880] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 222.534534] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 222.538529] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 222.637086] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 222.750742] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 222.754740] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 222.853295] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 222.966951] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 222.970919] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 223.069502] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 223.183157] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 223.187187] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 223.285711] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 223.399367] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 223.403369] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 223.501919] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 223.615575] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 223.619718] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 223.718126] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 223.831782] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 223.835993] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 223.934334] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 224.047991] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 224.052244] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 224.264044] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 224.377699] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 224.381923] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 224.480252] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 224.593909] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 224.598220] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 224.696458] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 224.810095] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 224.814260] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 224.818629] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 224.846433] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 224.850662] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 224.948982] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 225.048982] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 225.053273] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 225.151537] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 225.251289] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 225.255491] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 225.353687] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 225.381531] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 225.385787] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 225.492819] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 225.616681] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 225.620931] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 279.956628] Rx A-MPDU request on tid 0 result 0 [ 285.730038] rx session timer expired on tid 0 [ 285.734299] Rx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 292.826134] phy0: Allocated STA 01:23:45:67:89:ab [ 292.830418] phy0: Destroyed STA 01:23:45:67:89:ab [ 298.586903] Rx A-MPDU request on tid 0 result 0 [ 314.153829] delba from 01:23:45:67:89:ab (initiator) tid 0 reason code 39 [ 314.158137] Rx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 330.723105] Rx A-MPDU request on tid 0 result 0 [ 337.906020] delba from 01:23:45:67:89:ab (initiator) tid 0 reason code 39 [ 337.910325] Rx BA session stop requested for 01:23:45:67:89:ab tid 0 [ 350.631373] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 350.782603] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 350.786888] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 350.884956] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 350.892162] phy0: dropped TX filtered frame, queue_len=0 PS=1 @5089 [ 350.998566] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 351.002978] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 351.101354] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 351.215008] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 351.219367] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 351.293978] Rx A-MPDU request on tid 0 result 0 [ 351.317559] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 351.430963] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 351.435285] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 351.647167] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 351.718663] STA 01:23:45:67:89:ab aid 1: PS buffer (entries before 0) [ 351.760996] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 351.765398] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/1 PS frames since STA not sleeping anymore [ 351.863370] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 351.878631] STA 01:23:45:67:89:ab aid 1: PS buffer (entries before 0) [ 351.977026] wlan0: STA 00:21:5c:07:99:f9 aid 1 exits power save mode [ 351.981504] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/1 PS frames since STA not sleeping anymore [ 352.079577] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 352.193401] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 352.197973] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 352.295786] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 352.409670] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 352.414185] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 352.511994] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 352.625650] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 352.630237] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 352.728202] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 352.841859] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 352.846311] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 352.944408] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 353.058067] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 353.062657] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 353.160618] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 353.274274] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 353.278746] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 353.490326] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 353.603982] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 353.608564] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 353.706535] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 353.820190] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 353.824678] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 353.922741] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 354.036378] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 354.040810] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 354.045364] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 354.072666] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 354.077248] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 354.175218] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 354.275188] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 354.279665] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 354.377739] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 354.477572] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 354.482046] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 354.579969] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 354.647088] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 354.651525] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore [ 354.749640] wlan0: STA 01:23:45:67:89:ab aid 1 enters power save mode [ 354.873510] wlan0: STA 01:23:45:67:89:ab aid 1 exits power save mode [ 354.877863] wlan0: STA 01:23:45:67:89:ab aid 1 sending 0 filtered/0 PS frames since STA not sleeping anymore The fact that you do not see it is a good thing. It means that my suspicion that a splice was trying to be generated even when HT_ADDBA_REQUESTED_MSK was not set was true. How that happens is a mystery to me still, I reviewed this and was unable to see how it happens. I'll send this in for now to cure your pains. Thanks for testing and reporting this. Thank you very much. Can someone please close this bug report? I've submitted this upstream now. Thanks Jack, but it is still not closed. |