#1656: Computer freezes after an unpredictable time under load
-------------------------------+--------------------------------------------
Reporter: [EMAIL PROTECTED] | Type: defect
Status: new | Priority: minor
Component: madwifi: driver | Version: trunk
Keywords: | Patch_attached: 0
-------------------------------+--------------------------------------------
The two routers with this defect do freeze at least every few hours. A
half day is only possible without load (at night). Under load the freeze
occours to half an hour.
I've been trying for a couple of weeks wich madwifi driver version X
kernel won't be doing this anymore. I am not sure whether this all is a
madwifi bug, dostro problem, or hardware issue. I however am completely
without further ideas what to do so I'm begging for adwise.
The first computer is a WRAP with two Atheros wireless cards (presently
there are two CM11, but CM9 behave the same).
Debugging enabled:
{{{
dev.wifi0.debug:
0x800d01e0<reset,mode,beacon,watchdog,calibrate,state,node,fat>
dev.wifi1.debug:
0x800d01e0<reset,mode,beacon,watchdog,calibrate,state,node,fat>
net.ath0.debug: 0x00ec18c0<assoc,auth,scan,state,power,wpa,acl,inact,roam>
net.ath1.debug: 0x00ec18c0<assoc,auth,scan,state,power,wpa,acl,inact,roam>
}}}
Kernel version:
{{{
Linux ant 2.6.22.12-LARA-WRAP-router-debug #1
Tue Nov 13 20:38:46 CET 2007 i586 Unknown Geode by NSC GNU/Linux
}}}
I'm using MAC acl on both cards. No encription enabled.
On both cards:
{{{
bgscan = 0
bintval = 350
mode = 11b
frag thr = 700
rts thr = 400
}}}
The streangest thing seems to me, that the problems started approx two
weeks ago. There was no change in anything effecting the computers except
the temperature lowered. The environment of our network is very noisy for
many other stations are running there. Diversity is disabled in the
following way (sysctl.conf lines):
{{{
dev.wifi0.diversity = 0
dev.wifi0.rxantenna = 1
dev.wifi0.txantenna = 1
dev.wifi1.diversity = 0
dev.wifi1.rxantenna = 1
dev.wifi1.txantenna = 1
}}}
this very unlikely to effected the wireless because of the problems were
there before I set this up.
On every wireless card there is one AP VAP.
I have a notebook connected to the WRAP using a serial line. This way I'm
able to log everything what the kernel outputs (right?). The output is
datified but a bit ugly.
{{{
2007-11-19T14:29:53,021537310+0100: 319.305631] ath1:
[00:19:e0:83:03:b3] UAPSD bit settings from STA: 00
2007-11-19T14:29:53,049195542+0100: 319.325370] ath1:
[00:19:e0:83:03:b3] station reassociated at aid 1: long preamble, long
slot time, QoS
2007-11-19T14:29:53,369318268+0100: 319.367880] ath0:
[00:12:0e:34:71:34] probe station due to inactivity
2007-11-19T14:29:58,110120908+0100: 319.589790] ath_calibrate: channel
2442/a0
2007-11-19T14:30:09,899722218+0100: 324.165582] ath_rate_node_init:
2007-11-19T14:30:09,907372605+0100: 324.175157] ath_node_alloc: an
c6a4a000
2007-11-19T14:30:10,855736191+0100: 324.219050] ath_calibrate: channel
2417/a0
2007-11-19T14:30:28,141993802+0100: 324.893553] ath_calibrate: channel
2442/a0
2007-11-19T14:30:40,875566492+0100: 325.360961] ath_calibrate: channel
2417/a0
2007-11-19T14:30:58,161792254+0100: 326.147186] ath_calibrate: channel
2442/a0
2007-11-19T14:31:09,883326548+0100: 326.573069] ath_rate_node_init:
2007-11-19T14:31:09,890977774+0100: 326.582652] ath_node_alloc: an
c6477000
2007-11-19T14:31:10,907351380+0100: 326.623663] ath_calibrate: channel
2417/a0
2007-11-19T14:31:28,193630225+0100: 327.489202] ath_calibrate: channel
2442/a0
2007-11-19T14:31:40,927221076+0100: 327.930651] ath_calibrate: channel
2417/a0
2007-11-19T14:31:58,209427612+0100: 328.621374] ath_calibrate: channel
2442/a0
2007-11-19T14:32:10,947028469+0100: 329.362369] ath_calibrate: channel
2417/a0
2007-11-19T14:32:16,583753654+0100: 329.673277] ath_rate_node_init:
2007-11-19T14:32:16,591421643+0100: 329.682852] ath_node_alloc: an
c6b4a000
2007-11-19T14:32:17,063800567+0100: 329.711476] ath_rate_node_init:
2007-11-19T14:32:17,075476605+0100: 329.721052] ath_node_alloc: an
c65b4000
2007-11-19T14:32:17,935683190+0100: 329.759738] ath_rate_node_init:
2007-11-19T14:32:17,943579994+0100: 329.769303] ath_node_alloc: an
c658f000
2007-11-19T14:32:18,539984983+0100: 329.801071] ath1:
[00:19:e0:83:03:b3] recv auth frame with algorithm 0 seq 1
2007-11-19T14:32:18,555687233+0100: 329.822499] ath1:
[00:19:e0:83:03:b3] station authenticated (open)
2007-11-19T14:32:18,580966226+0100: 329.841286] ath1:
[00:19:e0:83:03:b3] UAPSD bit settings from STA: 00
2007-11-19T14:32:18,603814294+0100: 329.860926] ath1:
[00:19:e0:83:03:b3] station reassociated at aid 1: long preamble, long
slot time, QoS
2007-11-19T14:32:23,592605923+0100: 330.143899] ath0:
[00:12:0e:34:71:34] probe station due to inactivity
2007-11-19T14:32:28,349180938+0100: 330.360755] ath_calibrate: channel
2442/a0
2007-11-19T14:32:41,086858346+0100: 330.891331] ath_calibrate: channel
2417/a0
2007-11-19T14:32:58,369036105+0100: 331.810120] ath_calibrate: channel
2442/a0
2007-11-19T14:33:09,902498779+0100: 332.617203] ath_rate_node_init:
2007-11-19T14:33:09,910182972+0100: 332.626802] ath_node_alloc: an
c6492000
2007-11-19T14:33:11,118594062+0100: 332.895805] ath_calibrate: channel
2417/a0
2007-11-19T14:33:28,400832168+0100: 335.731554] ath_calibrate: channel
2442/a0
2007-11-19T14:33:35,649778298+0100: 336.092020] ath1:
[00:19:e0:83:03:b3] UAPSD bit settings from STA: 00
2007-11-19T14:33:35,677435971+0100: 336.111728] ath1:
[00:19:e0:83:03:b3] station reassociated at aid 1: long preamble, long
slot time, QoS
2007-11-19T14:33:41,178412954+0100: 336.585516] ath_calibrate: channel
2417/a0
2007-11-19T14:33:58,460643238+0100: 337.967540] ath_calibrate: channel
2442/a0
2007-11-19T14:33:59,668819087+0100: 338.121221] ath1:
[00:19:e0:83:03:b3] UAPSD bit settings from STA: 00
2007-11-19T14:33:59,696495757+0100: 338.140936] ath1:
[00:19:e0:83:03:b3] station reassociated at aid 1: long preamble, long
slot time, QoS
2007-11-19T14:34:11,238550345+0100: 339.086016] ath_calibrate: channel
2417/a0
2007-11-19T14:34:37,645653747+0100: C Engines WRAP.1C/1D/1E v1.11
2007-11-19T14:34:37,653408904+0100: 40 KB Base Memory
2007-11-19T14:34:40,789982115+0100: 15360
31744
48128
64512
80896
97280
113664
130048 KB Extended Memory
2007-11-19T14:34:40,793117089+0100:
2007-11-19T14:34:40,809723986+0100: 1F0 Master 0000 KCF256M-KT3
2007-11-19T14:34:40,821713774+0100: hys C/H/S 503/16/63 Log C/H/S
503/16/63
2007-11-19T14:34:40,877706069+0100:
2007-11-19T14:34:42,878327691+0100: ILO 22.7.3 boot:
2007-11-19T14:34:43,150218028+0100: oading linux-2.6.22.12
2007-11-19T14:34:43,157987433+0100: IOS data check successful
2007-11-19T14:34:47,810918044+0100: 0.000000] Linux version 2.6.22.12
-LARA-WRAP-router-debug ([EMAIL PROTECTED]) (gcc version 4.2.2 (Gentoo 4.2.2
p1.0)) #1 Tue Nov 13 20:38:46 CET 2007
2007-11-19T14:34:47,822641858+0100: 0.000000] BIOS-provided physical
RAM map:
2007-11-19T14:34:47,842612825+0100: 0.000000] BIOS-e820:
0000000000000000 - 00000000000a0000 (usable)
2007-11-19T14:34:47,862594128+0100: 0.000000] BIOS-e820:
00000000000f0000 - 0000000000100000 (reserved)
2007-11-19T14:34:47,882635499+0100: 0.000000] BIOS-e820:
0000000000100000 - 0000000008000000 (usable)
2007-11-19T14:34:47,902619317+0100: 0.000000] BIOS-e820:
00000000fff00000 - 0000000100000000 (reserved)
2007-11-19T14:34:47,910639609+0100: 0.000000] 128MB LOWMEM available.
2007-11-19T14:34:47,934651035+0100: 0.000000] Entering
add_active_range(0, 0, 32768) 0 entries of 256 used
2007-11-19T14:34:47,942615171+0100: 0.000000] Zone PFN ranges:
2007-11-19T14:34:47,954636250+0100: 0.000000] DMA 0 ->
4096
2007-11-19T14:34:47,966643919+0100: 0.000000] Normal 4096 ->
32768
2007-11-19T14:34:47,978627001+0100: 0.000000] early_node_map[1] active
PFN ranges
2007-11-19T14:34:47,990638022+0100: 0.000000] 0: 0 ->
32768
2007-11-19T14:34:48,002647087+0100: 0.000000] On node 0 totalpages:
32768
2007-11-19T14:34:48,014833841+0100: 0.000000] DMA zone: 32 pages
used for memmap
2007-11-19T14:34:48,030648125+0100: 0.000000] DMA zone: 0 pages
reserved
2007-11-19T14:34:48,042642662+0100: 0.000000] DMA zone: 4064 pages,
LIFO batch:0
2007-11-19T14:34:48,054633847+0100: 0.000000] Normal zone: 224 pages
used for memmap
2007-11-19T14:34:48,070646773+0100: 0.000000] Normal zone: 28448
pages, LIFO batch:7
2007-11-19T14:34:48,082653881+0100: 0.000000] DMI not present or
invalid.
2007-11-19T14:34:48,106642118+0100: 0.000000] Allocating PCI resources
starting at 10000000 (gap: 08000000:f7f00000)
2007-11-19T14:34:48,122639678+0100: 0.000000] Built 1 zonelists.
Total pages: 32512
2007-11-19T14:34:48,158652626+0100: 0.000000] Kernel command line:
auto BOOT_IMAGE=linux-2.6.22.12 ro root=302 console=ttyS0,38400 panic=7
reboot=bios debug acpi=off noapic
2007-11-19T14:34:48,174658845+0100: 0.000000] No local APIC present or
hardware disabled
2007-11-19T14:34:48,186686629+0100: 0.000000] mapped APIC to ffffd000
(01101000)
2007-11-19T14:34:48,194675910+0100: 0.000000] Initializing CPU#0
2007-11-19T14:34:48,210751697+0100: 0.000000] PID hash table entries:
512 (order: 9, 2048 bytes)
2007-11-19T14:34:48,226660971+0100: 0.000000] Detected 233.319 MHz
processor.
2007-11-19T14:34:48,238690990+0100: 12.200547] Console: colour dummy
device 80x25
2007-11-19T14:34:48,258677602+0100: 12.666522] Dentry cache hash table
entries: 16384 (order: 4, 65536 bytes)
2007-11-19T14:34:48,282641252+0100: 12.688366] Inode-cache hash table
entries: 8192 (order: 3, 32768 bytes)
2007-11-19T14:34:48,350712739+0100: 12.749019] Memory: 126964k/131072k
available (1463k kernel code, 3708k reserved, 681k data, 140k init, 0k
highmem)
2007-11-19T14:34:48,366697447+0100: 12.780473] virtual kernel memory
layout:
2007-11-19T14:34:48,382711489+0100: 12.780502] fixmap : 0xfffbc000
- 0xfffff000 ( 268 kB)
2007-11-19T14:34:48,398684463+0100: 12.780539] vmalloc : 0xc8800000
- 0xfffba000 ( 887 MB)
2007-11-19T14:34:48,418715497+0100: 12.780577] lowmem : 0xc0000000
- 0xc8000000 ( 128 MB)
2007-11-19T14:34:48,434698808+0100: 12.780615] .init : 0xc031c000
- 0xc033f000 ( 140 kB)
2007-11-19T14:34:48,451117679+0100: 12.780653] .data : 0xc026dc1d
- 0xc0318044 ( 681 kB)
2007-11-19T14:34:48,470713153+0100: 12.780690] .text : 0xc0100000
- 0xc026dc1d (1463 kB)
2007-11-19T14:34:48,494667024+0100: 12.896006] Checking if this
processor honours the WP bit even in supervisor mode... Ok.
2007-11-19T14:34:48,600015115+0100: 13.001623] Calibrating delay using
timer specific routine.. 467.55 BogoMIPS (lpj=935101)
2007-11-19T14:34:48,614729461+0100: 13.026818] Mount-cache hash table
entries: 512
2007-11-19T14:34:48,646758944+0100: 13.041587] CPU: After generic
identify, caps: 00808131 01818131 00000000 00000000 00000000 00000000
00000000
2007-11-19T14:34:48,674730924+0100: 13.071948] CPU: After all inits,
caps: 00808131 00818131 00000000 00000001 00000000 00000000 00000000
2007-11-19T14:34:48,686745857+0100: 13.100463] Compat vDSO mapped to
ffffe000.
2007-11-19T14:34:48,698737600+0100: 13.113109] CPU: NSC Unknown
stepping 01
2007-11-19T14:34:48,722668563+0100: 13.125110] Checking 'hlt'
instruction... OK.
2007-11-19T14:34:48,738691267+0100: 13.140672] NET: Registered protocol
family 16
2007-11-19T14:34:48,762742645+0100: 13.157181] PCI: PCI BIOS revision
2.10 entry at 0xfc47b, last bus=0
2007-11-19T14:34:48,774739417+0100: 13.176326] PCI: Using configuration
type 1
2007-11-19T14:34:48,786705737+0100: 13.188911] Setting up standard PCI
resources
2007-11-19T14:34:48,822733771+0100: 13.223832] PCI: Probing PCI
hardware
2007-11-19T14:34:48,834707634+0100: 13.234911] PCI: Probing PCI
hardware (bus 00)
2007-11-19T14:34:48,858686652+0100: 13.258809] PCI: Device 0000:00:12.5
not found by BIOS
2007-11-19T14:34:48,878739477+0100: 13.276982] Time: tsc clocksource
has been installed.
2007-11-19T14:34:48,894727537+0100: 13.296071] NET: Registered protocol
family 2
2007-11-19T14:34:48,950756153+0100: 13.310005] IP route cache hash
table entries: 1024 (order: 0, 4096 bytes)
2007-11-19T14:34:48,970763160+0100: 13.331271] TCP established hash
table entries: 4096 (order: 3, 32768 bytes)
2007-11-19T14:34:48,994760895+0100: 13.352831] TCP bind hash table
entries: 4096 (order: 2, 16384 bytes)
2007-11-19T14:34:49,010979448+0100: 13.372398] TCP: Hash tables
configured (established 4096 bind 4096)
2007-11-19T14:34:49,022731759+0100: 13.391505] TCP reno registered
2007-11-19T14:34:49,042764469+0100: 13.402877] scx200: NatSemi SCx200
Driver
2007-11-19T14:34:49,054805105+0100: 13.415570] scx200: GPIO base 0xf400
2007-11-19T14:34:49,070789534+0100: 13.426452] scx200: Configuration
Block base 0x9000
2007-11-19T14:34:49,086769491+0100: 13.442672] audit: initializing
netlink socket (disabled)
2007-11-19T14:34:49,102807002+0100: 13.459029] audit(946744412.416:1):
initialized
2007-11-19T14:34:49,114792879+0100: 13.474579] io scheduler noop
registered
2007-11-19T14:34:49,130739311+0100: 13.486469] io scheduler
anticipatory registered (default)
2007-11-19T14:34:49,814959333+0100: 14.172367] Real Time Clock Driver
v1.12ac
2007-11-19T14:34:49,823005049+0100: 14.184947] nsc_gpio initializing
2007-11-19T14:34:49,834912419+0100: 14.195052] cs5535_gpio: DIVIL not
found
2007-11-19T14:34:49,858885010+0100: 14.206893] Serial: 8250/16550
driver $Revision: 1.90 $ 4 ports, IRQ sharing disabled
2007-11-19T14:34:49,878854020+0100: 14.230733] serial8250: ttyS0 at I/O
0x3f8 (irq = 4) is a NS16550A
2007-11-19T14:34:49,906894171+0100: 14.256322] Uniform Multi-Platform
E-IDE driver Revision: 7.00alpha2
2007-11-19T14:34:49,930897215+0100: 14.275525] ide: Assuming 33MHz
system bus speed for PIO modes; override with idebus=xx
2007-11-19T14:34:49,946888628+0100: 14.300001] SC1200: IDE controller
at PCI slot 0000:00:12.2
2007-11-19T14:34:49,954894951+0100: 14.316841] SC1200: chipset revision
1
2007-11-19T14:34:49,974885474+0100: 14.328145] SC1200: not 100% native
mode: will probe irqs later
2007-11-19T14:34:49,994893040+0100: 14.345992] ide0: BM-DMA at
0xfc00-0xfc07, BIOS settings: hda:pio, hdb:pio
2007-11-19T14:34:50,019105064+0100: 14.367927] ide1: BM-DMA at
0xfc08-0xfc0f, BIOS settings: hdc:pio, hdd:pio
2007-11-19T14:34:50,030885593+0100: 14.389834] Probing IDE interface
ide0...
2007-11-19T14:34:50,134875036+0100: 14.411358] Clocksource tsc unstable
(delta = 90345007 ns)
2007-11-19T14:34:50,154876176+0100: 14.427918] Time: pit clocksource
has been installed.
2007-11-19T14:34:50,478992704+0100: 14.445576] hda: KCF256M-KT3, ATA
DISK drive
2007-11-19T14:34:51,159319783+0100: 14.463437] hda: selected mode 0x42
2007-11-19T14:34:51,175040192+0100: 14.473969] hda:
sc1200_set_xfer_mode(UDMA 2)
2007-11-19T14:34:51,187057359+0100: 14.487321] ide0 at
0x1f0-0x1f7,0x3f6 on irq 14
2007-11-19T14:34:51,199036531+0100: 14.501847] Probing IDE interface
ide1...
2007-11-19T14:34:51,779141666+0100: 14.528802] Probing IDE interface
ide1...
2007-11-19T14:34:52,359490425+0100: 14.554271] hda: max request size:
128KiB
2007-11-19T14:34:52,383197601+0100: 14.566406] hda: 507024 sectors (259
MB) w/0KiB Cache, CHS=503/16/63, UDMA(33)
2007-11-19T14:34:52,391189116+0100: 14.588768] hda: hda1 hda2
2007-11-19T14:34:52,407212938+0100: 14.601695] i8042.c: No controller
found.
2007-11-19T14:34:52,423192337+0100: 14.614399] mice: PS/2 mouse device
common for all mice
2007-11-19T14:34:52,439213085+0100: 14.630874] enabling scx200 high-res
timer (1 MHz +0 ppm)
2007-11-19T14:34:52,451645419+0100: 14.647374] TCP cubic registered
2007-11-19T14:34:52,467210491+0100: 14.657130] Time: scx200_hrt
clocksource has been installed.
2007-11-19T14:34:52,479256434+0100: 14.674179] Initializing XFRM
netlink socket
2007-11-19T14:34:52,491226665+0100: 14.687174] NET: Registered protocol
family 1
2007-11-19T14:34:52,507225901+0100: 14.700353] NET: Registered protocol
family 17
2007-11-19T14:34:52,519204793+0100: 14.713778] Using IPI Shortcut mode
2007-11-19T14:34:52,539244767+0100: 14.729799] kjournald starting.
Commit interval 5 seconds
2007-11-19T14:34:52,559264905+0100: 14.746453] EXT3-fs: mounted
filesystem with ordered data mode.
2007-11-19T14:34:52,575234246+0100: 14.764378] VFS: Mounted root (ext3
filesystem) readonly.
2007-11-19T14:34:52,591196044+0100: 14.782332] Freeing unused kernel
memory: 140k freed
2007-11-19T14:34:52,695217617+0100: INIT: version 2.86 booting
}}}
The last message is different every time. Sometimes it's an reassociation
request sometimes the channel calibrate.
--
Ticket URL: <http://madwifi.org/ticket/1656>
madwifi.org <http://madwifi.org/>
Multiband Atheros Driver for Wireless Fidelity
-------------------------------------------------------------------------
This SF.net email is sponsored by: Microsoft
Defy all challenges. Microsoft(R) Visual Studio 2005.
http://clk.atdmt.com/MRT/go/vse0120000070mrt/direct/01/
_______________________________________________
Madwifi-tickets mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/madwifi-tickets
