Testing tracer wakeup warning

From: Zdenek Kabelac
Date: Thu Jul 17 2008 - 09:32:47 EST


I've updated git tree to commit 33af79d12e0fa25545d49e86afc67ea8ad5f2f40
(and using two extra patches - for led_trigger & poweroff issue)

I wanted to test the new sysprof feature

- It looks like the machine is rebooting after memory suspend/resume
(if I'll get a trace I'll make a new post)

- selinux=off doesn't work anymore - had to use selinux=0

- I've got this Warning from the boot (attached configuration file)

Linux version 2.6.26 (kabi@xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx) (gcc
version 4.3.1 20080708 (Red Hat 4.3.1-4) (GCC) ) #45 SMP PREEMPT Thu
Jul 17 14:29:08 CEST 2008
Command line: ro root=/dev/sda2 selinux=0 no_console_suspend
Testing tracer sched_switch: PASSED
Testing tracer sysprof: PASSED
Testing tracer ftrace: PASSED
Testing dynamic ftrace: PASSED
Testing tracer irqsoff: PASSED
Testing tracer preemptoff: PASSED
Testing tracer preemptirqsoff: PASSED
Testing tracer wakeup: <4>------------[ cut here ]------------
WARNING: at kernel/lockdep.c:2731 check_flags+0x15d/0x1a0()
Modules linked in:
Pid: 3, comm: migration/0 Not tainted 2.6.26 #45

Call Trace:
<IRQ> [<ffffffff81040c74>] warn_on_slowpath+0x64/0xb0
[<ffffffff81068771>] ? trace_hardirqs_off_caller+0x21/0xc0
[<ffffffff8109aae6>] ? ftrace_record_ip+0x196/0x300
[<ffffffff8100c5a4>] ? mcount_call+0x5/0x31
[<ffffffff8109aae6>] ? ftrace_record_ip+0x196/0x300
[<ffffffff810670dd>] check_flags+0x15d/0x1a0
[<ffffffff8106b66b>] lock_acquire+0x5b/0xe0
[<ffffffff8132420c>] _spin_lock_irqsave+0x4c/0x90
[<ffffffff811a03a4>] ? debug_locks_off+0x4/0x50
[<ffffffff8109aae6>] ftrace_record_ip+0x196/0x300
[<ffffffff810a2f33>] ? wakeup_tracer_call+0x93/0x130
[<ffffffff8100c5a4>] mcount_call+0x5/0x31
[<ffffffff810a2f33>] ? wakeup_tracer_call+0x93/0x130
[<ffffffff811a03a9>] ? debug_locks_off+0x9/0x50
[<ffffffff810670b1>] check_flags+0x131/0x1a0
[<ffffffff8106b66b>] lock_acquire+0x5b/0xe0
[<ffffffff8132420c>] _spin_lock_irqsave+0x4c/0x90
[<ffffffff8106881d>] ? trace_hardirqs_off+0xd/0x10
[<ffffffff81047e43>] ? _local_bh_enable+0x63/0xc0
[<ffffffff81327c01>] ? sub_preempt_count+0x11/0x120
[<ffffffff810a2f33>] wakeup_tracer_call+0x93/0x130
[<ffffffff81047f7a>] ? __do_softirq+0xda/0xf0
[<ffffffff8100c608>] ftrace_call+0x5/0x2b
[<ffffffff81047f7a>] ? __do_softirq+0xda/0xf0
[<ffffffff81047f25>] ? __do_softirq+0x85/0xf0
[<ffffffff8106881d>] ? trace_hardirqs_off+0xd/0x10
[<ffffffff81327c06>] ? sub_preempt_count+0x16/0x120
[<ffffffff81047e43>] _local_bh_enable+0x63/0xc0
[<ffffffff81047f7a>] __do_softirq+0xda/0xf0
[<ffffffff8100dafc>] call_softirq+0x1c/0x30
[<ffffffff8100f1c5>] do_softirq+0x75/0xb0
[<ffffffff81047995>] irq_exit+0xa5/0xb0
[<ffffffff810201da>] smp_apic_timer_interrupt+0x9a/0xf0
[<ffffffff8100d54b>] apic_timer_interrupt+0x6b/0x70
<EOI> [<ffffffff81323e9f>] ? _spin_unlock_irqrestore+0x6f/0xa0
[<ffffffff8103360f>] ? complete+0x4f/0x60
[<ffffffff8103cf50>] ? migration_thread+0x0/0x2b0
[<ffffffff8103d004>] ? migration_thread+0xb4/0x2b0
[<ffffffff8103cf50>] ? migration_thread+0x0/0x2b0
[<ffffffff8105941e>] ? kthread+0x4e/0x90
[<ffffffff8100d799>] ? child_rip+0xa/0x11
[<ffffffff81323df2>] ? _spin_unlock_irq+0x42/0x80
[<ffffffff8100cda3>] ? restore_args+0x0/0x30
[<ffffffff81323f05>] ? _spin_unlock+0x35/0x60
[<ffffffff810593d0>] ? kthread+0x0/0x90
[<ffffffff8100d78f>] ? child_rip+0x0/0x11

---[ end trace a7919e7f17c0a725 ]---
irq event stamp: 214
hardirqs last enabled at (212): [<ffffffff81069bad>] trace_hardirqs_on+0xd/0x10
hardirqs last disabled at (213): [<ffffffff8106881d>]
trace_hardirqs_off+0xd/0x10
softirqs last enabled at (214): [<ffffffff81047f7a>] __do_softirq+0xda/0xf0
softirqs last disabled at (201): [<ffffffff8100dafc>] call_softirq+0x1c/0x30
irq event stamp: 214
hardirqs last enabled at (212): [<ffffffff81069bad>] trace_hardirqs_on+0xd/0x10
hardirqs last disabled at (213): [<ffffffff8106881d>]
trace_hardirqs_off+0xd/0x10
softirqs last enabled at (214): [<ffffffff81047f7a>] __do_softirq+0xda/0xf0
softirqs last disabled at (201): [<ffffffff8100dafc>] call_softirq+0x1c/0x30
PASSED
msgmni has been set to 3917
io scheduler noop registered
io scheduler anticipatory registered
io scheduler deadline registered
io scheduler cfq registered (default)

Regards

Zdenek

Attachment: config-2.6.27pre
Description: Binary data