Re: Linux 2.6.21-rc5

From: Michal Piotrowski
Date: Tue Mar 27 2007 - 14:54:15 EST


Linus Torvalds napisaÅ(a):
> There's various fixes here, ranging from some architecture updates (ia64,
> ARM, MIPS, SH, Sparc64) to KVM, networking and network drivers.
>
> And random one-liners.
>

I found this in mm snapshot
http://www.ussg.iu.edu/hypermail/linux/kernel/0703.2/1367.html
it's in mainline too.

Andi, any progress with this bug?

BUG: using smp_processor_id() in preemptible [00000001] code: mount/7245
caller is avail_to_resrv_perfctr_nmi_bit+0x1a/0x32
[<c0105039>] show_trace_log_lvl+0x1a/0x2f
[<c0105720>] show_trace+0x12/0x14
[<c01057d2>] dump_stack+0x16/0x18
[<c01f911e>] debug_smp_processor_id+0xa2/0xb4
[<c0115832>] avail_to_resrv_perfctr_nmi_bit+0x1a/0x32
[<fdca69b5>] nmi_create_files+0x2a/0x10e [oprofile]
[<fdca5f4e>] oprofile_create_files+0xe6/0xec [oprofile]
[<fdca6153>] oprofilefs_fill_super+0x78/0x7e [oprofile]
[<c0173516>] get_sb_single+0x46/0x8c
[<fdca608b>] oprofilefs_get_sb+0x1c/0x1e [oprofile]
[<c0173406>] vfs_kern_mount+0x81/0xf1
[<c01734be>] do_kern_mount+0x30/0x42
[<c0185be9>] do_mount+0x601/0x678
[<c0185ccf>] sys_mount+0x6f/0xa4
[<c0104060>] syscall_call+0x7/0xb
=======================
BUG: using smp_processor_id() in preemptible [00000001] code: mount/7245
caller is avail_to_resrv_perfctr_nmi_bit+0x1a/0x32
[<c0105039>] show_trace_log_lvl+0x1a/0x2f
[<c0105720>] show_trace+0x12/0x14
[<c01057d2>] dump_stack+0x16/0x18
[<c01f911e>] debug_smp_processor_id+0xa2/0xb4
[<c0115832>] avail_to_resrv_perfctr_nmi_bit+0x1a/0x32
[<fdca69b5>] nmi_create_files+0x2a/0x10e [oprofile]
[<fdca5f4e>] oprofile_create_files+0xe6/0xec [oprofile]
[<fdca6153>] oprofilefs_fill_super+0x78/0x7e [oprofile]
[<c0173516>] get_sb_single+0x46/0x8c
[<fdca608b>] oprofilefs_get_sb+0x1c/0x1e [oprofile]
[<c0173406>] vfs_kern_mount+0x81/0xf1
[<c01734be>] do_kern_mount+0x30/0x42
[<c0185be9>] do_mount+0x601/0x678
[<c0185ccf>] sys_mount+0x6f/0xa4
[<c0104060>] syscall_call+0x7/0xb
=======================
BUG: using smp_processor_id() in preemptible [00000001] code: mount/7245
caller is avail_to_resrv_perfctr_nmi_bit+0x1a/0x32
[<c0105039>] show_trace_log_lvl+0x1a/0x2f
[<c0105720>] show_trace+0x12/0x14
[<c01057d2>] dump_stack+0x16/0x18
[<c01f911e>] debug_smp_processor_id+0xa2/0xb4
[<c0115832>] avail_to_resrv_perfctr_nmi_bit+0x1a/0x32
[<fdca69b5>] nmi_create_files+0x2a/0x10e [oprofile]
[<fdca5f4e>] oprofile_create_files+0xe6/0xec [oprofile]
[<fdca6153>] oprofilefs_fill_super+0x78/0x7e [oprofile]
[<c0173516>] get_sb_single+0x46/0x8c
[<fdca608b>] oprofilefs_get_sb+0x1c/0x1e [oprofile]
[<c0173406>] vfs_kern_mount+0x81/0xf1
[<c01734be>] do_kern_mount+0x30/0x42
[<c0185be9>] do_mount+0x601/0x678
[<c0185ccf>] sys_mount+0x6f/0xa4
[<c0104060>] syscall_call+0x7/0xb
=======================
BUG: using smp_processor_id() in preemptible [00000001] code: mount/7245
caller is avail_to_resrv_perfctr_nmi_bit+0x1a/0x32
[<c0105039>] show_trace_log_lvl+0x1a/0x2f
[<c0105720>] show_trace+0x12/0x14
[<c01057d2>] dump_stack+0x16/0x18
[<c01f911e>] debug_smp_processor_id+0xa2/0xb4
[<c0115832>] avail_to_resrv_perfctr_nmi_bit+0x1a/0x32
[<fdca69b5>] nmi_create_files+0x2a/0x10e [oprofile]
[<fdca5f4e>] oprofile_create_files+0xe6/0xec [oprofile]
[<fdca6153>] oprofilefs_fill_super+0x78/0x7e [oprofile]
[<c0173516>] get_sb_single+0x46/0x8c
[<fdca608b>] oprofilefs_get_sb+0x1c/0x1e [oprofile]
[<c0173406>] vfs_kern_mount+0x81/0xf1
[<c01734be>] do_kern_mount+0x30/0x42
[<c0185be9>] do_mount+0x601/0x678
[<c0185ccf>] sys_mount+0x6f/0xa4
[<c0104060>] syscall_call+0x7/0xb
=======================
SELinux: initialized (dev oprofilefs, type oprofilefs), uses genfs_contexts

=================================
[ INFO: inconsistent lock state ]
2.6.21-rc5-gd4590940-dirty #128
---------------------------------
inconsistent {hardirq-on-W} -> {in-hardirq-W} usage.
firefox-bin/3542 [HC1[1]:SC0[0]:HE0:SE1] takes:
(oprofilefs_lock){+-..}, at: [<fdca6b6a>] nmi_cpu_setup+0x15/0x4f [oprofile]
{hardirq-on-W} state was registered at:
[<c013d338>] __lock_acquire+0x442/0xba1
[<c013daff>] lock_acquire+0x68/0x82
[<c031a947>] _spin_lock+0x35/0x42
[<fdca6343>] oprofilefs_ulong_from_user+0x4e/0x74 [oprofile]
[<fdca6393>] ulong_write_file+0x2a/0x38 [oprofile]
[<c0171d13>] vfs_write+0xaf/0x138
[<c01722dd>] sys_write+0x3d/0x61
[<c0104060>] syscall_call+0x7/0xb
[<ffffffff>] 0xffffffff
irq event stamp: 50464270
hardirqs last enabled at (50464269): [<c0104189>] syscall_exit_work+0x11/0x26
hardirqs last disabled at (50464270): [<c0104ae9>] call_function_interrupt+0x29/0x38
softirqs last enabled at (50462522): [<c012653b>] __do_softirq+0xe4/0xea
softirqs last disabled at (50462515): [<c01069b5>] do_softirq+0x64/0xd1

other info that might help us debug this:
no locks held by firefox-bin/3542.

stack backtrace:
[<c0105039>] show_trace_log_lvl+0x1a/0x2f
[<c0105720>] show_trace+0x12/0x14
[<c01057d2>] dump_stack+0x16/0x18
[<c013bd13>] print_usage_bug+0x140/0x14a
[<c013c51e>] mark_lock+0xa1/0x40b
[<c013d2a9>] __lock_acquire+0x3b3/0xba1
[<c013daff>] lock_acquire+0x68/0x82
[<c031a947>] _spin_lock+0x35/0x42
[<fdca6b6a>] nmi_cpu_setup+0x15/0x4f [oprofile]
[<c0112a61>] smp_call_function_interrupt+0x3a/0x56
[<c0104af3>] call_function_interrupt+0x33/0x38
=======================

http://www.stardust.webpages.pl/files/tbf/bitis-gabonica/2.6.21-rc5/git-config2
http://www.stardust.webpages.pl/files/tbf/bitis-gabonica/2.6.21-rc5/git-dmesg

Regards,
Michal

--
Michal K. K. Piotrowski
LTG - Linux Testers Group (PL)
(http://www.stardust.webpages.pl/ltg/)
LTG - Linux Testers Group (EN)
(http://www.stardust.webpages.pl/linux_testers_group_en/)
-
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
Please read the FAQ at http://www.tux.org/lkml/