FC3 kernel 2.6.9-1.667 GPF on events/0

brmiller · #1 4th January 2005, 07:33 PM

Fedora Core 3
kernel 2.6.9-1.667
Biostar iDEQ 210P w/3200+

This happens on stock 2.6.9-1.667 and self-compiled -1.667. I have commented out ATA_FLAG_SATA_RESET in sata_nv.c as per Bug 3352 sata_nv module fails to find drives. Otherwise I get SATA timeouts. This temporary fix has been accepted in 2.6.10, but I do not see a 2.6.10 from FC3 updates yet. I have not tried kernel-2.6.9-1.724_FC3 yet.

Kernel messages:

Jan 3 17:29:32 ideq kernel: general protection fault: 0000 [1]
Jan 3 17:29:32 ideq kernel: CPU 0
Jan 3 17:29:32 ideq kernel: Modules linked in: nls_utf8(U) parport_pc(U) lp(U) parport(U) autofs4(U) i2c_dev(U) i2c_core(U) sunrpc(U) ds(U) yenta_socket(U) pcmcia_core(U) ipt_REJECT(U) ipt_state(U) ip_conntrack(U) iptable_filter(U) ip_tables(U) dm_mod(U) button(U) battery(U) ac(U) md5(U) ipv6(U) usb_storage(U) joydev(U) ohci1394(U) ieee1394(U) ohci_hcd(U) ehci_hcd(U) snd_intel8x0(U) snd_ac97_codec(U) snd_pcm_oss(U) snd_mixer_oss(U) snd_pcm(U) snd_timer(U) snd_page_alloc(U) gameport(U) snd_mpu401_uart(U) snd_rawmidi(U) snd_seq_device(U) snd(U) soundcore(U) forcedeth(U) ext3(U) jbd(U) sata_nv(U) libata(U) sd_mod(U) scsi_mod(U)
Jan 3 17:29:32 ideq kernel: Pid: 3, comm: events/0 Not tainted 2.6.9-prep
Jan 3 17:29:32 ideq kernel: RIP: 0010:[<ffffffff8016cadd>] <ffffffff8016cadd>{free_block+86}
Jan 3 17:29:32 ideq kernel: RSP: 0018:0000010037e3fe08 EFLAGS: 00010016
Jan 3 17:29:32 ideq kernel: RAX: 038000fc82a78000 RBX: 000001003ffcb180 RCX: 0000000079000222
Jan 3 17:29:32 ideq kernel: RDX: 0000010001000000 RSI: 000001003ffeee10 RDI: 000001003ffcb180
Jan 3 17:29:32 ideq kernel: RBP: 000000000033667a R08: 0000010037e3e000 R09: 0000000000000246
Jan 3 17:29:32 ideq kernel: R10: 0000000000000246 R11: ffffffff8025b31d R12: 000001003ffeee10
Jan 3 17:29:32 ideq kernel: R13: 0000000000000002 R14: ffffffff804cc560 R15: 0000000000000000
Jan 3 17:29:32 ideq kernel: FS: 0000002a956b0a40(0000) GS:ffffffff80503480(0000) knlGS:0000000000000000
Jan 3 17:29:32 ideq kernel: CS: 0010 DS: 0018 ES: 0018 CR0: 000000008005003b
Jan 3 17:29:32 ideq kernel: CR2: 0000002a95557000 CR3: 0000000000101000 CR4: 00000000000006e0
Jan 3 17:29:32 ideq kernel: Process events/0 (pid: 3, threadinfo 0000010037e3e000, task 0000010002150030)
Jan 3 17:29:32 ideq kernel: Stack: 000001003ffeee10 000000000033667a 000001003ffeee00 ffffffff8016cbee
Jan 3 17:29:32 ideq kernel: 000001003ffcb180 000001003ffcb0b0 000001003ffcb260 ffffffff8016e08e
Jan 3 17:29:32 ideq kernel: 0000000000000246 0000000000000246
Jan 3 17:29:32 ideq kernel: Call Trace:<ffffffff8016cbee>{drain_array_locked+99} <ffffffff8016e08e>{cache_reap+309}
Jan 3 17:29:32 ideq kernel: <ffffffff8016df59>{cache_reap+0} <ffffffff8014f109>{worker_thread+631}
Jan 3 17:29:32 ideq kernel: <ffffffff8013374c>{default_wake_function+0} <ffffffff8013374c>{default_wake_function+0}
Jan 3 17:29:32 ideq kernel: <ffffffff8014ee92>{worker_thread+0} <ffffffff801551af>{kthread+188}
Jan 3 17:29:32 ideq kernel: <ffffffff8011124f>{child_rip+8} <ffffffff801550f3>{kthread+0}
Jan 3 17:29:32 ideq kernel: <ffffffff80111247>{child_rip+0}
Jan 3 17:29:32 ideq kernel:
Jan 3 17:29:32 ideq kernel: Code: 48 8b 70 30 48 8b 56 08 48 8b 06 48 89 50 08 48 89 02 48 2b
Jan 3 17:29:32 ideq kernel: RIP <ffffffff8016cadd>{free_block+86} RSP <0000010037e3fe08>

brmiller · #2 5th January 2005, 08:07 PM

2.6.10-1.727_FC3 from the FC3 testing directory - same thing. But this time, I'm getting a problem with a kernel paging request... Wonder if that's progress? Are their kernel gurus here?

Jan 5 11:42:24 ideq kernel: Unable to handle kernel paging request at 0000010441b0c4bf RIP:
Jan 5 11:42:24 ideq kernel: <ffffffff8020b66e>{memmove+58}
Jan 5 11:42:24 ideq kernel: PML4 8063 PGD 0
Jan 5 11:42:24 ideq kernel: Oops: 0000 [1]
Jan 5 11:42:24 ideq kernel: CPU 0
Jan 5 11:42:24 ideq kernel: Modules linked in: parport_pc lp parport autofs4 i2c_dev i2c_core sunrpc pcmcia yenta_socket pcmcia_core ipt_REJECT ipt_state ip_conntrack iptable_filter ip_tables dm_mod video button battery ac md5 ipv6 usb_storage joydev ohci1394 ieee1394 ohci_hcd ehci_hcd snd_intel8x0 snd_ac97_codec snd_pcm_oss snd_mixer_oss snd_pcm snd_timer snd soundcore snd_page_alloc forcedeth ext3 jbd sata_nv libata sd_mod scsi_mod
Jan 5 11:42:24 ideq kernel: Pid: 3, comm: events/0 Not tainted 2.6.10-1.727_FC3
Jan 5 11:42:24 ideq kernel: RIP: 0010:[<ffffffff8020b66e>] <ffffffff8020b66e>{memmove+58}
Jan 5 11:42:24 ideq kernel: RSP: 0018:0000010037e2be70 EFLAGS: 00010013
Jan 5 11:42:24 ideq kernel: RAX: 0000000000000000 RBX: 000001003ffed800 RCX: 0000010441b0c4bf
Jan 5 11:42:24 ideq kernel: RDX: 0000000401b1d0df RSI: 000001003ffef3e0 RDI: 0000010441b0c4bf
Jan 5 11:42:24 ideq kernel: RBP: 000001003ffed8e0 R08: 000001003ffef3e0 R09: ffffffff80494468
Jan 5 11:42:24 ideq kernel: R10: 0000000000000246 R11: ffffffff8034240c R12: 0000000000000002
Jan 5 11:42:24 ideq kernel: R13: ffffffff804c3a80 R14: 0000000000000000 R15: 0000000000000000
Jan 5 11:42:24 ideq kernel: FS: 0000002a9557e3e0(0000) GS:ffffffff804fd200(0000) knlGS:0000000000000000
Jan 5 11:42:24 ideq kernel: CS: 0010 DS: 0018 ES: 0018 CR0: 000000008005003b
Jan 5 11:42:24 ideq kernel: CR2: 0000010441b0c4bf CR3: 0000000000101000 CR4: 00000000000006e0
Jan 5 11:42:24 ideq kernel: Process events/0 (pid: 3, threadinfo 0000010037e2a000, task 000001003fefd7e0)
Jan 5 11:42:24 ideq kernel: Stack: ffffffff801692e8 0000000000000001 000001003ffe2318 ffffffff80149457
Jan 5 11:42:24 ideq kernel: 000001003ffb7d28 00000000fffffffc ffffffff80149682 0000000000000282
Jan 5 11:42:24 ideq kernel: ffffffffffffffff 0000000000000001
Jan 5 11:42:24 ideq kernel: Call Trace:<ffffffff801692e8>{cache_reap+259} <ffffffff80149457>{worker_thread+0}
Jan 5 11:42:24 ideq kernel: <ffffffff80149682>{worker_thread+555} <ffffffff8012fbed>{default_wake_function+0}
Jan 5 11:42:24 ideq kernel: <ffffffff8012fbed>{default_wake_function+0} <ffffffff8014ee1f>{kthread+188}
Jan 5 11:42:24 ideq kernel: <ffffffff8010f263>{child_rip+8} <ffffffff8014a021>{__create_workqueue+66}
Jan 5 11:42:24 ideq kernel: <ffffffff8014ed63>{kthread+0} <ffffffff8010f25b>{child_rip+0}
Jan 5 11:42:24 ideq kernel:
Jan 5 11:42:24 ideq kernel:
Jan 5 11:42:24 ideq kernel: Code: 0f b6 01 88 07 eb ea 4c 89 c0 c3 90 90 90 90 90 90 90 49 89
Jan 5 11:42:24 ideq kernel: RIP <ffffffff8020b66e>{memmove+58} RSP <0000010037e2be70>
Jan 5 11:42:24 ideq kernel: CR2: 0000010441b0c4bf

brmiller · #3 8th January 2005, 08:10 AM

It only gets weirder:

Jan 7 10:53:36 ideq kernel: slab: double free detected in cache 'journal_head', objp 00000100351cfc40.
Jan 7 10:53:36 ideq kernel: ----------- [cut here ] --------- [please bite here ] ---------
Jan 7 10:53:36 ideq kernel: Kernel BUG at slab:2158
Jan 7 10:53:36 ideq kernel: invalid operand: 0000 [1]
Jan 7 10:53:36 ideq kernel: CPU 0
Jan 7 10:53:36 ideq kernel: Modules linked in: nfs lockd nls_utf8 parport_pc lp parport autofs4 i2c_dev i2c_core sunrpc pcmcia yenta_socket pcmcia_core ipt_REJECT ipt_state ip_conntrack iptable_filter ip_tables dm_mod video button battery ac usb_storage md5 ipv6 joydev ohci1394 ieee1394 ohci_hcd ehci_hcd snd_intel8x0 snd_ac97_codec snd_pcm_oss snd_mixer_oss snd_pcm snd_timer snd soundcore snd_page_alloc forcedeth ext3 jbd sata_nv libata sd_mod scsi_mod
Jan 7 10:53:36 ideq kernel: Pid: 3, comm: events/0 Not tainted 2.6.10-1.727_FC3
Jan 7 10:53:36 ideq kernel: RIP: 0010:[<ffffffff80167d13>] <ffffffff80167d13>{free_block+208}
Jan 7 10:53:36 ideq kernel: RSP: 0018:0000010037e2be08 EFLAGS: 00010016
Jan 7 10:53:36 ideq kernel: RAX: 000000000000004e RBX: 00000100351cf000 RCX: ffffffff8041f7d0
Jan 7 10:53:36 ideq kernel: RDX: 0000000100000000 RSI: 0000000000000001 RDI: 000001003af9a030
Jan 7 10:53:36 ideq kernel: RBP: 0000010037da6980 R08: ffffffff8041f7d0 R09: 000000000000000a
Jan 7 10:53:36 ideq kernel: R10: 0000000000000000 R11: 0000ffff8043e580 R12: 00000100351cfc40
Jan 7 10:53:36 ideq kernel: R13: 000000000000001b R14: 00000100351cf028 R15: 000000000000001b
Jan 7 10:53:36 ideq kernel: FS: 0000002a95581fe0(0000) GS:ffffffff804fd200(0000) knlGS:0000000000000000
Jan 7 10:53:36 ideq kernel: CS: 0010 DS: 0018 ES: 0018 CR0: 000000008005003b
Jan 7 10:53:36 ideq kernel: CR2: 0000002a95557000 CR3: 0000000000101000 CR4: 00000000000006e0
Jan 7 10:53:36 ideq kernel: Process events/0 (pid: 3, threadinfo 0000010037e2a000, task 000001003fefd7e0)
Jan 7 10:53:36 ideq kernel: Stack: 00000100351b6ba0 0000010037da2998 0000000237e2be98 0000010037da2970
Jan 7 10:53:36 ideq kernel: 0000000000000007 0000010037da2960 ffffffff804c3a80 0000000000000000
Jan 7 10:53:36 ideq kernel: 0000000000000000 ffffffff80167e1c
Jan 7 10:53:36 ideq kernel: Call Trace:<ffffffff80167e1c>{drain_array_locked+99} <ffffffff801692b3>{cache_reap+206}
Jan 7 10:53:36 ideq kernel: <ffffffff80149457>{worker_thread+0} <ffffffff80149682>{worker_thread+555}
Jan 7 10:53:36 ideq kernel: <ffffffff8012fbed>{default_wake_function+0} <ffffffff8012fbed>{default_wake_function+0}
Jan 7 10:53:36 ideq kernel: <ffffffff8014ee1f>{kthread+188} <ffffffff8010f263>{child_rip+8}
Jan 7 10:53:36 ideq kernel: <ffffffff8014a021>{__create_workqueue+66} <ffffffff8014ed63>{kthread+0}
Jan 7 10:53:36 ideq kernel: <ffffffff8010f25b>{child_rip+0}
Jan 7 10:53:36 ideq kernel:
Jan 7 10:53:36 ideq kernel: Code: 0f 0b 89 34 36 80 ff ff ff ff 6e 08 0f b7 43 24 48 89 de 48
Jan 7 10:53:36 ideq kernel: RIP <ffffffff80167d13>{free_block+208} RSP <0000010037e2be08>