2.6.7 "Unable to handle kernel paging request" plus kobject_get badness

["Dwayne Rightler" <drightler@technicalogic.com>]

[-- Attachment #1: Type: text/plain, Size: 415 bytes --]

Hello,

I've never reported a kernel error before so please let me know if there is
more info I can provide.  Running 2.6.7 with the kexec patch.  Was not
having these problems with 2.6.5 with the kexec patch.  After the "Unable to
handle kernel paging request" error the machine becomes fairly unresponsive
and a normal reboot is not enough to bring the machine down.  Dmesg and
config attached.

-Dwayne Rightler

[-- Attachment #2: config.gz --]
[-- Type: application/octet-stream, Size: 5512 bytes --]

[-- Attachment #3: 2.5.7-kexec.dmesg --]
[-- Type: application/octet-stream, Size: 15233 bytes --]

Linux version 2.6.7-kexec (root@demigod) (gcc version 2.95.4 20011002 (Debian prerelease)) #1 Mon Jul 5 11:30:36 CDT 2004
BIOS-provided physical RAM map:
 BIOS-e820: 0000000000000000 - 000000000009fc00 (usable)
 BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved)
 BIOS-e820: 00000000000ec000 - 0000000000100000 (reserved)
 BIOS-e820: 0000000000100000 - 0000000027ff0000 (usable)
 BIOS-e820: 0000000027ff0000 - 0000000027ff8000 (ACPI data)
 BIOS-e820: 0000000027ff8000 - 0000000028000000 (ACPI NVS)
 BIOS-e820: 00000000fec00000 - 00000000fec01000 (reserved)
 BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
 BIOS-e820: 00000000ffff0000 - 0000000100000000 (reserved)
639MB LOWMEM available.
found SMP MP-table at 000fb210
On node 0 totalpages: 163824
  DMA zone: 4096 pages, LIFO batch:1
  Normal zone: 159728 pages, LIFO batch:16
  HighMem zone: 0 pages, LIFO batch:1
DMI 2.3 present.
ACPI: RSDP (v000 AMI                                       ) @ 0x000fa970
ACPI: RSDT (v001 AMIINT VIA_K7   0x00000010 MSFT 0x00000097) @ 0x27ff0000
ACPI: FADT (v001 AMIINT VIA_K7   0x00000011 MSFT 0x00000097) @ 0x27ff0030
ACPI: MADT (v001 AMIINT          0x00000009 MSFT 0x00000097) @ 0x27ff00b0
ACPI: DSDT (v001    VIA   VT8371 0x00001000 MSFT 0x0100000b) @ 0x00000000
ACPI: Local APIC address 0xfee00000
ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
Processor #0 6:3 APIC version 16
Using ACPI for processor (LAPIC) configuration information
Intel MultiProcessor Specification v1.1
    Virtual Wire compatibility mode.
OEM ID: VIA      Product ID: KT133        APIC at: 0xFEE00000
I/O APIC #2 Version 17 at 0xFEC00000.
Enabling APIC mode:  Flat.  Using 1 I/O APICs
Processors: 1
Built 1 zonelists
Kernel command line: root=/dev/hdb1
Initializing CPU#0
PID hash table entries: 4096 (order 12: 32768 bytes)
Detected 850.483 MHz processor.
Using tsc for high-res timesource
Console: colour VGA+ 80x25
Memory: 645260k/655296k available (2455k kernel code, 9284k reserved, 1141k data, 152k init, 0k highmem)
Checking if this processor honours the WP bit even in supervisor mode... Ok.
Calibrating delay loop... 1671.16 BogoMIPS
Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Mount-cache hash table entries: 512 (order: 0, 4096 bytes)
CPU:     After generic identify, caps: 0183fbff c1c7fbff 00000000 00000000
CPU:     After vendor identify, caps: 0183fbff c1c7fbff 00000000 00000000
CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line)
CPU: L2 Cache: 64K (64 bytes/line)
CPU:     After all inits, caps: 0183fbff c1c7fbff 00000000 00000020
CPU: AMD Duron(tm) stepping 01
Enabling fast FPU save and restore... done.
Checking 'hlt' instruction... OK.
enabled ExtINT on CPU#0
ESR value before enabling vector: 00000080
ESR value after enabling vector: 00000000
ENABLING IO-APIC IRQs
Setting 2 in the phys_id_present_map
...changing IO-APIC physical APIC ID to 2 ... ok.
init IO_APIC IRQs
 IO-APIC (apicid-pin) 2-0, 2-16, 2-17, 2-18, 2-19, 2-20, 2-21, 2-22, 2-23 not connected.
..TIMER: vector=0x31 pin1=2 pin2=0
number of MP IRQ sources: 16.
number of IO-APIC #2 registers: 24.
testing the IO APIC.......................
IO APIC #2......
.... register #00: 02000000
.......    : physical APIC id: 02
.......    : Delivery Type: 0
.......    : LTS          : 0
.... register #01: 00178011
.......     : max redirection entries: 0017
.......     : PRQ implemented: 1
.......     : IO APIC version: 0011
.... register #02: 00000000
.......     : arbitration: 00
.... IRQ redirection table:
 NR Log Phy Mask Trig IRR Pol Stat Dest Deli Vect:   
 00 000 00  1    0    0   0   0    0    0    00
 01 001 01  0    0    0   0   0    1    1    39
 02 001 01  0    0    0   0   0    1    1    31
 03 001 01  0    0    0   0   0    1    1    41
 04 001 01  0    0    0   0   0    1    1    49
 05 001 01  1    1    0   1   0    1    1    51
 06 001 01  0    0    0   0   0    1    1    59
 07 001 01  0    0    0   0   0    1    1    61
 08 001 01  0    0    0   0   0    1    1    69
 09 001 01  1    1    0   1   0    1    1    71
 0a 001 01  1    1    0   1   0    1    1    79
 0b 001 01  1    1    0   1   0    1    1    81
 0c 001 01  0    0    0   0   0    1    1    89
 0d 001 01  0    0    0   0   0    1    1    91
 0e 001 01  0    0    0   0   0    1    1    99
 0f 001 01  0    0    0   0   0    1    1    A1
 10 000 00  1    0    0   0   0    0    0    00
 11 000 00  1    0    0   0   0    0    0    00
 12 000 00  1    0    0   0   0    0    0    00
 13 000 00  1    0    0   0   0    0    0    00
 14 000 00  1    0    0   0   0    0    0    00
 15 000 00  1    0    0   0   0    0    0    00
 16 000 00  1    0    0   0   0    0    0    00
 17 050 00  1    0    0   0   0    0    2    00
IRQ to pin mappings:
IRQ0 -> 0:2
IRQ1 -> 0:1
IRQ3 -> 0:3
IRQ4 -> 0:4
IRQ5 -> 0:5
IRQ6 -> 0:6
IRQ7 -> 0:7
IRQ8 -> 0:8
IRQ9 -> 0:9
IRQ10 -> 0:10
IRQ11 -> 0:11
IRQ12 -> 0:12
IRQ13 -> 0:13
IRQ14 -> 0:14
IRQ15 -> 0:15
.................................... done.
Using local APIC timer interrupts.
calibrating APIC timer ...
..... CPU clock speed is 849.0887 MHz.
..... host bus clock speed is 199.0973 MHz.
NET: Registered protocol family 16
PCI: PCI BIOS revision 2.10 entry at 0xfdb31, last bus=1
PCI: Using configuration type 1
mtrr: v2.0 (20020519)
Linux Plug and Play Support v0.97 (c) Adam Belay
PnPBIOS: Scanning system for PnP BIOS support...
PnPBIOS: Found PnP BIOS installation structure at 0xc00f71d0
PnPBIOS: PnP BIOS version 1.0, entry 0xf0000:0x5f74, dseg 0xf0000
PnPBIOS: 14 nodes reported by PnP BIOS; 14 recorded by driver
PCI: Probing PCI hardware
PCI: Probing PCI hardware (bus 00)
PCI: Using IRQ router VIA [1106/0686] at 0000:00:07.0
Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
Initializing Cryptographic API
Applying VIA southbridge workaround.
PCI: Enabling Via external APIC routing
isapnp: Scanning for PnP cards...
isapnp: No Plug & Play device found
lp: driver loaded but no devices found
Real Time Clock Driver v1.12
Non-volatile memory driver v1.2
Linux agpgart interface v0.100 (c) Dave Jones
agpgart: Detected VIA KLE133 chipset
agpgart: Maximum main memory to use for agp memory: 564M
agpgart: AGP aperture is 64M @ 0xe0000000
Serial: 8250/16550 driver $Revision: 1.90 $ 8 ports, IRQ sharing enabled
ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
parport0: PC-style at 0x378 (0x778) [PCSPP,TRISTATE]
lp0: using parport0 (polling).
parport_pc: Via 686A parallel port: io=0x378
Using anticipatory io scheduler
Floppy drive(s): fd0 is 1.44M
FDC 0 is a post-1991 82077
RAMDISK driver initialized: 16 RAM disks of 4096K size 1024 blocksize
loop: loaded (max 8 devices)
nbd: registered device at major 43
via-rhine.c:v1.10-LK1.1.20-2.6 May-23-2004 Written by Donald Becker
eth0: VIA VT86C100A Rhine at 0xdffffe80, 00:50:ba:c4:1f:93, IRQ 9.
eth0: MII PHY found at address 8, status 0x782d advertising 05e1 Link 40a1.
PPP generic driver version 2.4.2
PPP Deflate Compression module registered
PPP BSD Compression module registered
NET: Registered protocol family 24
Universal TUN/TAP device driver 1.5 (C)1999-2002 Maxim Krasnyansky
Loaded prism54 driver, version 1.1
eth1: prism54 driver detected card model: XG-900/GW-DS54G
Linux Tulip driver version 1.1.13 (May 11, 2002)
tulip0:  MII transceiver #1 config 3100 status 7829 advertising 01e1.
eth2: Lite-On 82c168 PNIC rev 32 at 0xe8828f00, 00:A0:CC:29:35:97, IRQ 5.
Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
VP_IDE: IDE controller at PCI slot 0000:00:07.1
VP_IDE: chipset revision 6
VP_IDE: not 100% native mode: will probe irqs later
VP_IDE: VIA vt82c686b (rev 40) IDE UDMA100 controller on pci0000:00:07.1
    ide0: BM-DMA at 0xffa0-0xffa7, BIOS settings: hda:DMA, hdb:DMA
    ide1: BM-DMA at 0xffa8-0xffaf, BIOS settings: hdc:DMA, hdd:pio
hda: SAMSUNG SV2044D, ATA DISK drive
hdb: Maxtor 90845D4, ATA DISK drive
ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
hdc: Hewlett-Packard CD-Writer Plus 9300, ATAPI CD/DVD-ROM drive
ide1 at 0x170-0x177,0x376 on irq 15
PDC20267: IDE controller at PCI slot 0000:00:0f.0
PDC20267: chipset revision 2
PDC20267: ROM enabled at 0xdff60000
PDC20267: 100% native mode on irq 10
PDC20267: (U)DMA Burst Bit ENABLED Primary PCI Mode Secondary PCI Mode.
    ide2: BM-DMA at 0xcc00-0xcc07, BIOS settings: hde:pio, hdf:pio
    ide3: BM-DMA at 0xcc08-0xcc0f, BIOS settings: hdg:pio, hdh:pio
hde: Maxtor 53073H4, ATA DISK drive
hdf: Maxtor 92720U8, ATA DISK drive
ide2 at 0xdc00-0xdc07,0xd802 on irq 10
hda: max request size: 128KiB
hda: 39862368 sectors (20409 MB) w/472KiB Cache, CHS=39546/16/63
 hda: hda1 hda2 hda3
hdb: max request size: 128KiB
hdb: 16514064 sectors (8455 MB) w/512KiB Cache, CHS=16383/16/63
 hdb: hdb1
hde: max request size: 128KiB
hde: 60030432 sectors (30735 MB) w/2048KiB Cache, CHS=59554/16/63
 hde: unknown partition table
hdf: max request size: 128KiB
hdf: 53177040 sectors (27226 MB) w/2048KiB Cache, CHS=52755/16/63
 hdf: hdf1
hdc: ATAPI 32X CD-ROM CD-R/RW drive, 4096kB Cache
Uniform CD-ROM driver Revision: 3.20
mice: PS/2 mouse device common for all mice
input: PC Speaker
serio: i8042 AUX port at 0x60,0x64 irq 12
input: ImPS/2 Logitech Wheel Mouse on isa0060/serio1
serio: i8042 KBD port at 0x60,0x64 irq 1
input: AT Translated Set 2 keyboard on isa0060/serio0
device-mapper: 4.1.0-ioctl (2003-12-10) initialised: dm@uk.sistina.com
NET: Registered protocol family 2
IP: routing cache hash table of 8192 buckets, 64Kbytes
TCP: Hash tables configured (established 262144 bind 65536)
ip_conntrack version 2.1 (5119 buckets, 40952 max) - 300 bytes per conntrack
ip_tables: (C) 2000-2002 Netfilter core team
ipt_recent v0.3.1: Stephen Frost <sfrost@snowman.net>.  http://snowman.net/projects/ipt_recent/
arp_tables: (C) 2002 David S. Miller
NET: Registered protocol family 1
NET: Registered protocol family 17
Bridge firewalling registered
Ebtables v2.0 registered
EXT3-fs: INFO: recovery required on readonly filesystem.
EXT3-fs: write access will be enabled during recovery.
kjournald starting.  Commit interval 5 seconds
EXT3-fs: hdb1: orphan cleanup on readonly fs
ext3_orphan_cleanup: deleting unreferenced inode 98307
ext3_orphan_cleanup: deleting unreferenced inode 98306
EXT3-fs: hdb1: 2 orphan inodes deleted
EXT3-fs: recovery complete.
EXT3-fs: mounted filesystem with ordered data mode.
VFS: Mounted root (ext3 filesystem) readonly.
Freeing unused kernel memory: 152k freed
Adding 626524k swap on /dev/hda2.  Priority:-1 extents:1
EXT3 FS on hdb1, internal journal
kjournald starting.  Commit interval 5 seconds
EXT3 FS on hda1, internal journal
EXT3-fs: mounted filesystem with ordered data mode.
kjournald starting.  Commit interval 5 seconds
EXT3 FS on dm-0, internal journal
EXT3-fs: mounted filesystem with ordered data mode.
device eth2 entered promiscuous mode
device tap0 entered promiscuous mode
eth2: Promiscuous mode enabled.
eth2: Promiscuous mode enabled.
eth2: Promiscuous mode enabled.
eth2: Promiscuous mode enabled.
eth2: Promiscuous mode enabled.
br0: port 2(tap0) entering learning state
br0: port 1(eth2) entering learning state
process `syslogd' is using obsolete setsockopt SO_BSDCOMPAT
eth2: Setting full-duplex based on MII#1 link partner capability of 05e1.
process `named' is using obsolete setsockopt SO_BSDCOMPAT
br0: topology change detected, propgating
br0: port 2(tap0) entering forwarding state
br0: topology change detected, propgating
br0: port 1(eth2) entering forwarding state
br0: port 2(tap0) entering disabled state
br0: port 1(eth2) entering disabled state
eth2: Promiscuous mode enabled.
br0: port 2(tap0) entering disabled state
br0: port 1(eth2) entering disabled state
eth1: islpci_open()
eth1: resetting device...
eth1: uploading firmware...
eth1: firmware uploaded done, now triggering reset...
eth1 (WE) : Buffer for request SIOCGIWPRIV too small (16<100)
eth1 (WE) : Buffer for request SIOCGIWPRIV too small (32<100)
eth1 (WE) : Buffer for request SIOCGIWPRIV too small (64<100)
eth1 (WE) : Buffer for request SIOCGIWPRIV too small (16<100)
eth1 (WE) : Buffer for request SIOCGIWPRIV too small (32<100)
eth1 (WE) : Buffer for request SIOCGIWPRIV too small (64<100)
Badness in kobject_get at lib/kobject.c:433
 [<c024ee2e>] kobject_get+0x2e/0x40
 [<c024eb05>] kobject_init+0x25/0x40
 [<c024ec80>] kobject_register+0x10/0x50
 [<c0349d86>] br_sysfs_addbr+0xa6/0x100
 [<c03462a3>] br_add_bridge+0x73/0xb0
 [<c0347317>] old_deviceless+0x127/0x150
 [<c0347367>] br_ioctl_deviceless_stub+0x27/0xc0
 [<c02ea6a2>] sock_ioctl+0x1b2/0x2b0
 [<c0152e29>] sys_ioctl+0x1e9/0x240
 [<c01060f9>] error_code+0x2d/0x38
 [<c01056ef>] syscall_call+0x7/0xb

eth2: Promiscuous mode enabled.
eth2: Promiscuous mode enabled.
eth2: Promiscuous mode enabled.
eth2: Promiscuous mode enabled.
eth2: Promiscuous mode enabled.
br0: port 2(tap0) entering learning state
br0: port 1(eth2) entering learning state
eth2: Setting full-duplex based on MII#1 link partner capability of 05e1.
br0: topology change detected, propgating
br0: port 2(tap0) entering forwarding state
br0: topology change detected, propgating
br0: port 1(eth2) entering forwarding state
hda: DMA disabled
hdb: dma_timer_expiry: dma status == 0x41
hdb: DMA timeout error
hdb: dma timeout error: status=0xd0 { Busy }

hdb: DMA disabled
ide0: reset: success
hdc: CHECK for good STATUS
Unable to handle kernel paging request at virtual address 00001004
 printing eip:
c01b5379
*pde = 00000000
Oops: 0000 [#1]
PREEMPT 
CPU:    0
EIP:    0060:[<c01b5379>]    Not tainted
EFLAGS: 00010202   (2.6.7-kexec) 
EIP is at __journal_remove_journal_head+0x9/0x130
eax: d0819a3c   ebx: 00001000   ecx: e7dada00   edx: d759bc8c
esi: d0819a3c   edi: d759bcbc   ebp: e0adc358   esp: e6b79df4
ds: 007b   es: 007b   ss: 0068
Process kjournald (pid: 524, threadinfo=e6b78000 task=e67b52a0)
Stack: e6b78000 d0819a3c c01b54b5 d0819a3c e6b78000 c01b0e69 d0819a3c e6b78000 
       00000001 e7dada6c e7dada00 e7dada78 e0adc3b0 e7dada54 e7dada3c c02c5c0c 
       e6b79e68 00000000 00000000 00000000 00000000 00000000 d91c1b6c 00000c1b 
Call Trace:
 [<c01b54b5>] journal_remove_journal_head+0x15/0x30
 [<c01b0e69>] journal_commit_transaction+0x409/0xee0
 [<c02c5c0c>] __ide_set_handler+0x4c/0x60
 [<c0114930>] autoremove_wake_function+0x0/0x40
 [<c0114930>] autoremove_wake_function+0x0/0x40
 [<c0113090>] try_to_wake_up+0x20/0xb0
 [<c0113061>] deactivate_task+0x21/0x30
 [<c0364388>] schedule+0x3d8/0x430
 [<c01b3756>] kjournald+0xc6/0x250
 [<c01b3690>] kjournald+0x0/0x250
 [<c0114930>] autoremove_wake_function+0x0/0x40
 [<c0114930>] autoremove_wake_function+0x0/0x40
 [<c01b3670>] commit_timeout+0x0/0x10
 [<c0103ca5>] kernel_thread_helper+0x5/0x10

Code: 83 7b 04 00 7d 29 68 c0 bd 38 c0 68 c0 06 00 00 68 ec b5 38 
 <6>note: kjournald[524] exited with preempt_count 2