m0n0wall Forum - Interrupt Storm & Negative Runtimes?!

Hello there!

I am using m0n0wall with an Atheros and two Fast Ethernet cards as my wireless gateway, it is lastest beta 1.3 relase 15, i have not many problems with configuration, but:

1. There is a lot of messages "interrupt storm detected on IRQ X" where X is an always same number, i.e 9. This may be related to WiFi adapter, because it is located on IRQ 9 i guess?

2. There is a lot of messages "calcru: negative runtime", can be one message for each process, but sometimes messages appears again and again to the ethernity...

3. No matter of this messages, m0n0wall works just fine for weeks, when I do not touch webinterface. But, if I try to change i.e. WAN config or advanced setup, system freeze, no ping response... Then one hard reboot (via AC plug) helps, configuration is saved, all works fine just as I wanted.

Here is my last dmesg:

Quote from: m0n0wall

Copyright (c) 1992-2008 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 6.3-RELEASE-p5 #0: Fri Oct 3 13:35:36 CEST 2008
root@mb63.neon1.net:/usr/src/sys/i386/compile/M0N0WALL_GENERIC
Timecounter "i8254" frequency 1193182 Hz quality 0
CPU: Intel Celeron (566.90-MHz 686-class CPU)
Origin = "GenuineIntel" Id = 0x683 Stepping = 3
Features=0x383f9ff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE>
real memory = 132055040 (125 MB)
avail memory = 102883328 (98 MB)
wlan: mac acl policy registered
kbd1 at kbdmux0
ath_hal: 0.9.20.3 (AR5210, AR5211, AR5212, RF5111, RF5112, RF2413, RF5413)
acpi0: <HP HPCCD HX> on motherboard
acpi0: Power Button (fixed)
Timecounter "ACPI-safe" frequency 3579545 Hz quality 850
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0
cpu0: <ACPI CPU> on acpi0
acpi_throttle0: <ACPI CPU Throttling> on cpu0
acpi_button0: <Power Button> on acpi0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
atapci0: <SiS 620 UDMA66 controller> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xdcf0-0xdcff at device 0.1 on pci0
ata0: <ATA channel 0> on atapci0
ata1: <ATA channel 1> on atapci0
isab0: <PCI-ISA bridge> at device 1.0 on pci0
isa0: <ISA bus> on isab0
pci0: <unknown> at device 1.1 (no driver attached)
ohci0: <SiS 5571 USB controller> mem 0xfedef000-0xfedeffff irq 11 at device 1.2 on pci0
ohci0: [GIANT-LOCKED]
usb0: OHCI version 1.0, legacy support
usb0: <SiS 5571 USB controller> on ohci0
usb0: USB revision 1.0
uhub0: SiS OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub0: 2 ports with 2 removable, self powered
pcib1: <PCI-PCI bridge> at device 2.0 on pci0
pci1: <PCI bus> on pcib1
pci1: <display, VGA> at device 0.0 (no driver attached)
pci0: <multimedia, audio> at device 6.0 (no driver attached)
vr0: <VIA VT6105 Rhine III 10/100BaseTX> port 0xd800-0xd8ff mem 0xfededc00-0xfededcff irq 3 at device 10.0 on pci0
vr0: Quirks: 0x0
miibus0: <MII bus> on vr0
ukphy0: <Generic IEEE 802.3u media interface> on miibus0
ukphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
vr0: Ethernet address: XX:XX:XX:XX:XX:XX
xl0: <3Com 3c905B-TX Fast Etherlink XL> port 0xdc00-0xdc7f mem 0xfeded800-0xfeded87f irq 9 at device 11.0 on pci0
miibus1: <MII bus> on xl0
xlphy0: <3Com internal media interface> on miibus1
xlphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
xl0: Ethernet address: XX:XX:XX:XX:XX:XX
ath0: <Atheros 5212> mem 0xfedf0000-0xfedfffff irq 9 at device 12.0 on pci0
ath0: Ethernet address: XX:XX:XX:XX:XX:XX
ath0: mac 7.8 phy 4.5 radio 5.6
fdc0: <floppy drive controller> port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on acpi0
fdc0: [FAST]
fd0: <1440-KB 3.5" drive> on fdc0 drive 0
sio0: <16550A-compatible COM port> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
sio0: type 16550A
atkbdc0: <Keyboard controller (i8042)> port 0x60,0x64 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
pmtimer0 on isa0
orm0: <ISA Option ROMs> at iomem 0xc0000-0xc7fff,0xe8000-0xeffff on isa0
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=0x300>
sio1: configured irq 3 not in bitmap of probed irqs 0
sio1: port may not be enabled
Timecounter "TSC" frequency 566896327 Hz quality 800
Timecounters tick every 1.000 msec
Fast IPsec: Initialized Security Association Processing.
IP Filter: v4.1.28 initialized. Default = block all, Logging = enabled
md0: Preloaded image </mfsroot> 15728640 bytes at 0xc0a9c360
ad0: 4125MB <FUJITSU MPC3043AT 6018> at ata0-master PIO4
acd0: CDROM <LTN485S/JKF1> at ata1-master PIO4
Trying to mount root from ufs:/dev/md0
calcru: negative runtime of -1344149 usec for pid 149 (sh)
calcru: negative runtime of -1296559 usec for pid 105 (mpd4)
calcru: negative runtime of -285436 usec for pid 56 (php)
calcru: negative runtime of -1770696 usec for pid 42 (sh)
calcru: negative runtime of -1370405 usec for pid 41 (schedcpu)
calcru: negative runtime of -306 usec for pid 38 (vnlru)
calcru: negative runtime of -686237 usec for pid 37 (bufdaemon)
calcru: negative runtime of -8572975 usec for pid 35 (pagezero)
calcru: negative runtime of -684207 usec for pid 30 (fdc0)
calcru: negative runtime of -1357063 usec for pid 29 (ath0 taskq)
calcru: negative runtime of -400 usec for pid 26 (usb0)
calcru: negative runtime of -4772841 usec for pid 4 (g_down)
calcru: negative runtime of -2736504 usec for pid 2 (g_event)
calcru: negative runtime of -635073 usec for pid 1 (init)
calcru: negative runtime of -1344149 usec for pid 149 (sh)
calcru: negative runtime of -1296559 usec for pid 105 (mpd4)
calcru: negative runtime of -285436 usec for pid 56 (php)
calcru: negative runtime of -1770696 usec for pid 42 (sh)
calcru: negative runtime of -1370405 usec for pid 41 (schedcpu)
calcru: negative runtime of -306 usec for pid 38 (vnlru)
calcru: negative runtime of -686237 usec for pid 37 (bufdaemon)
calcru: negative runtime of -8572975 usec for pid 35 (pagezero)
calcru: negative runtime of -684207 usec for pid 30 (fdc0)
calcru: negative runtime of -1357063 usec for pid 29 (ath0 taskq)
calcru: negative runtime of -400 usec for pid 26 (usb0)
calcru: negative runtime of -4772841 usec for pid 4 (g_down)
calcru: negative runtime of -2736504 usec for pid 2 (g_event)
calcru: negative runtime of -635073 usec for pid 1 (init)
calcru: negative runtime of -669627 usec for pid 154 (killall)
calcru: negative runtime of -660582 usec for pid 153 (sh)
calcru: negative runtime of -593443 usec for pid 105 (mpd4)
calcru: negative runtime of -275691 usec for pid 56 (php)
calcru: runtime went backwards from 5239166 usec to 3273459 usec for pid 56 (php)
calcru: negative runtime of -1770696 usec for pid 42 (sh)
calcru: negative runtime of -1370405 usec for pid 41 (schedcpu)
calcru: negative runtime of -306 usec for pid 38 (vnlru)
calcru: negative runtime of -686237 usec for pid 37 (bufdaemon)
calcru: negative runtime of -8572975 usec for pid 35 (pagezero)
calcru: negative runtime of -684207 usec for pid 30 (fdc0)
calcru: negative runtime of -1355909 usec for pid 29 (ath0 taskq)
calcru: negative runtime of -400 usec for pid 26 (usb0)
calcru: runtime went backwards from 2064165 usec to 2063995 usec for pid 14 (yarrow)
calcru: negative runtime of -4772751 usec for pid 4 (g_down)
calcru: negative runtime of -2736397 usec for pid 2 (g_event)
calcru: negative runtime of -635073 usec for pid 1 (init)
calcru: negative runtime of -660582 usec for pid 153 (sh)
calcru: negative runtime of -593443 usec for pid 105 (mpd4)
calcru: negative runtime of -275691 usec for pid 56 (php)
calcru: runtime went backwards from 5239166 usec to 3273459 usec for pid 56 (php)
calcru: negative runtime of -1770696 usec for pid 42 (sh)
calcru: negative runtime of -1370405 usec for pid 41 (schedcpu)
calcru: negative runtime of -306 usec for pid 38 (vnlru)
calcru: negative runtime of -686237 usec for pid 37 (bufdaemon)
calcru: negative runtime of -8572975 usec for pid 35 (pagezero)
calcru: negative runtime of -684207 usec for pid 30 (fdc0)
calcru: negative runtime of -1355909 usec for pid 29 (ath0 taskq)
calcru: negative runtime of -400 usec for pid 26 (usb0)
calcru: runtime went backwards from 2064165 usec to 2063995 usec for pid 14 (yarrow)
calcru: negative runtime of -4772751 usec for pid 4 (g_down)
calcru: negative runtime of -2736397 usec for pid 2 (g_event)
calcru: negative runtime of -635073 usec for pid 1 (init)
ath0: link state changed to UP
calcru: negative runtime of -2010864 usec for pid 181 (msntp)
calcru: negative runtime of -1995613 usec for pid 156 (sh)
calcru: negative runtime of -1277849 usec for pid 156 (sh)
calcru: negative runtime of -1364645 usec for pid 132 (ipmon)
calcru: negative runtime of -1907483 usec for pid 105 (mpd4)
calcru: negative runtime of -560766 usec for pid 105 (mpd4)
calcru: negative runtime of -2055192 usec for pid 41 (schedcpu)
calcru: negative runtime of -686631 usec for pid 40 (softdepflush)
calcru: negative runtime of -685469 usec for pid 39 (syncer)
calcru: negative runtime of -686115 usec for pid 37 (bufdaemon)
calcru: negative runtime of -5073874 usec for pid 35 (pagezero)
calcru: negative runtime of -1370155 usec for pid 30 (fdc0)
calcru: negative runtime of -6799849 usec for pid 29 (ath0 taskq)
calcru: negative runtime of -400 usec for pid 26 (usb0)
calcru: runtime went backwards from 689351 usec to 689118 usec for pid 19 (swi6: task queue)
calcru: negative runtime of -1365605 usec for pid 14 (yarrow)
calcru: negative runtime of -5457178 usec for pid 4 (g_down)
calcru: negative runtime of -4792325 usec for pid 2 (g_event)
calcru: negative runtime of -1366454 usec for pid 13 (swi1: net)
calcru: runtime went backwards from 9086212 usec to 1637027 usec for pid 11 (swi4: clock sio)
calcru: runtime went backwards from 6069386 usec to 4456925 usec for pid 1 (init)
calcru: negative runtime of -2010864 usec for pid 181 (msntp)
calcru: negative runtime of -1995613 usec for pid 156 (sh)
calcru: negative runtime of -1277849 usec for pid 156 (sh)
calcru: negative runtime of -1364645 usec for pid 132 (ipmon)
calcru: negative runtime of -1907483 usec for pid 105 (mpd4)
calcru: negative runtime of -560766 usec for pid 105 (mpd4)
calcru: negative runtime of -2055192 usec for pid 41 (schedcpu)
calcru: negative runtime of -686631 usec for pid 40 (softdepflush)
calcru: negative runtime of -685469 usec for pid 39 (syncer)
calcru: negative runtime of -686115 usec for pid 37 (bufdaemon)
calcru: negative runtime of -5073874 usec for pid 35 (pagezero)
calcru: negative runtime of -1370155 usec for pid 30 (fdc0)
calcru: negative runtime of -6799371 usec for pid 29 (ath0 taskq)
calcru: negative runtime of -400 usec for pid 26 (usb0)
calcru: runtime went backwards from 3479196 usec to 3479017 usec for pid 22 (irq9: xl0 ath0+)
calcru: runtime went backwards from 689351 usec to 689118 usec for pid 19 (swi6: task queue)
calcru: negative runtime of -1365605 usec for pid 14 (yarrow)
calcru: negative runtime of -5457178 usec for pid 4 (g_down)
calcru: negative runtime of -4792325 usec for pid 2 (g_event)
calcru: negative runtime of -1366454 usec for pid 13 (swi1: net)
calcru: runtime went backwards from 9086212 usec to 1636769 usec for pid 11 (swi4: clock sio)
calcru: runtime went backwards from 6069386 usec to 4456925 usec for pid 1 (init)
calcru: negative runtime of -2010864 usec for pid 181 (msntp)
calcru: negative runtime of -1995613 usec for pid 156 (sh)
calcru: negative runtime of -1277849 usec for pid 156 (sh)
calcru: runtime went backwards from 1436456 usec to 757277 usec for pid 142 (syslogd)
calcru: negative runtime of -1359949 usec for pid 132 (ipmon)
calcru: negative runtime of -1907483 usec for pid 105 (mpd4)
calcru: negative runtime of -560766 usec for pid 105 (mpd4)
calcru: negative runtime of -3427488 usec for pid 41 (schedcpu)
calcru: runtime went backwards from 284 usec to 133 usec for pid 40 (softdepflush)
calcru: negative runtime of -2059017 usec for pid 39 (syncer)
calcru: negative runtime of -21 usec for pid 38 (vnlru)
calcru: negative runtime of -3047817 usec for pid 35 (pagezero)
calcru: negative runtime of -1369776 usec for pid 30 (fdc0)
calcru: negative runtime of -6097173 usec for pid 29 (ath0 taskq)
calcru: negative runtime of -400 usec for pid 26 (usb0)
calcru: runtime went backwards from 3479196 usec to 1428798 usec for pid 22 (irq9: xl0 ath0+)
calcru: runtime went backwards from 689351 usec to 689118 usec for pid 19 (swi6: task queue)
calcru: negative runtime of -2052136 usec for pid 14 (yarrow)
calcru: negative runtime of -6140999 usec for pid 4 (g_down)
calcru: negative runtime of -6851146 usec for pid 2 (g_event)
calcru: negative runtime of -2050398 usec for pid 13 (swi1: net)
calcru: runtime went backwards from 9086212 usec to 3036411 usec for pid 11 (swi4: clock sio)
calcru: runtime went backwards from 6069386 usec to 4456925 usec for pid 1 (init)
calcru: negative runtime of -2010864 usec for pid 181 (msntp)
calcru: negative runtime of -1995613 usec for pid 156 (sh)
calcru: negative runtime of -1277849 usec for pid 156 (sh)
calcru: runtime went backwards from 1436456 usec to 757277 usec for pid 142 (syslogd)
calcru: negative runtime of -1359949 usec for pid 132 (ipmon)
calcru: negative runtime of -1907483 usec for pid 105 (mpd4)
calcru: negative runtime of -560766 usec for pid 105 (mpd4)
calcru: negative runtime of -3427488 usec for pid 41 (schedcpu)
calcru: runtime went backwards from 284 usec to 133 usec for pid 40 (softdepflush)
calcru: negative runtime of -2059017 usec for pid 39 (syncer)
calcru: negative runtime of -21 usec for pid 38 (vnlru)
calcru: negative runtime of -3047817 usec for pid 35 (pagezero)
calcru: negative runtime of -1369776 usec for pid 30 (fdc0)
calcru: negative runtime of -6097173 usec for pid 29 (ath0 taskq)
calcru: negative runtime of -400 usec for pid 26 (usb0)
calcru: runtime went backwards from 3479196 usec to 1428798 usec for pid 22 (irq9: xl0 ath0+)
calcru: runtime went backwards from 689351 usec to 689118 usec for pid 19 (swi6: task queue)
calcru: negative runtime of -2052136 usec for pid 14 (yarrow)
calcru: negative runtime of -6140999 usec for pid 4 (g_down)
calcru: negative runtime of -6851146 usec for pid 2 (g_event)
calcru: negative runtime of -2050398 usec for pid 13 (swi1: net)
calcru: runtime went backwards from 9086212 usec to 3037139 usec for pid 11 (swi4: clock sio)
calcru: runtime went backwards from 6069386 usec to 4456925 usec for pid 1 (init)
vr0: link state changed to DOWN
vr0: link state changed to UP
vr0: link state changed to DOWN
vr0: link state changed to UP
vr0: link state changed to DOWN
vr0: link state changed to UP
vr0: link state changed to DOWN
vr0: link state changed to UP