From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1758033AbYGPBzk (ORCPT ); Tue, 15 Jul 2008 21:55:40 -0400 Received: (majordomo@vger.kernel.org) by vger.kernel.org id S1752095AbYGPBzb (ORCPT ); Tue, 15 Jul 2008 21:55:31 -0400 Received: from yx-out-2324.google.com ([74.125.44.29]:21204 "EHLO yx-out-2324.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751935AbYGPBza (ORCPT ); Tue, 15 Jul 2008 21:55:30 -0400 DomainKey-Signature: a=rsa-sha1; c=nofws; d=gmail.com; s=gamma; h=message-id:date:from:to:subject:mime-version:content-type :content-transfer-encoding:content-disposition; b=Yi+C9bWAC8ipuD58IWyLBvKbzL8BsoMnhaZ8jp6J4n5Enw8hFdKiW3HdAM8S6z5sKk JlzafX61rDEl+Q83ClNqTld08/yw4wmwLZEFDWMscgmjIhVj/K1kJZsI4hB/nE+ADgf4 xbIujTCAHLTeliT9ZI7rogYSh8H/T8MdAwgwE= Message-ID: <19f34abd0807151855k22dc80d5tf3629da2e52ee6de@mail.gmail.com> Date: Wed, 16 Jul 2008 03:55:28 +0200 From: "Vegard Nossum" To: "Linux Kernel Mailing List" , "Steven Rostedt" Subject: 4d3702b6 (post-v2.6.26): WARNING: at kernel/lockdep.c:2731 check_flags (ftrace) MIME-Version: 1.0 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: 7bit Content-Disposition: inline Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org Hi, When booting 4d3702b6, I got this huge thing: Testing tracer wakeup: <4>------------[ cut here ]------------ WARNING: at kernel/lockdep.c:2731 check_flags+0x123/0x160() Modules linked in: Pid: 1, comm: swapper Not tainted 2.6.26-crashing-02127-g4d3702b6 #30 [] warn_on_slowpath+0x59/0xb0 [] ? ftrace_call+0x5/0x8 [] ? native_read_tsc+0x0/0x20 [] ? sub_preempt_count+0x12/0xf0 [] ? trace_hardirqs_off+0xb/0x10 [] ? __lock_acquire+0x2cc/0x1120 [] ? trace_hardirqs_off+0xb/0x10 [] ? mcount_call+0x5/0xa [] check_flags+0x123/0x160 [] lock_acquire+0x51/0xd0 [] ? ftrace_call+0x5/0x8 [] _spin_lock_irqsave+0x5f/0xa0 [] ? ftrace_record_ip+0xf5/0x220 [] ? debug_locks_off+0x3/0x50 [] ftrace_record_ip+0xf5/0x220 [] mcount_call+0x5/0xa [] ? debug_locks_off+0x8/0x50 [] check_flags+0xf7/0x160 [] lock_acquire+0x51/0xd0 [] ? ftrace_call+0x5/0x8 [] _spin_lock_irqsave+0x5f/0xa0 [] ? wakeup_tracer_call+0x6d/0xf0 [] ? _local_bh_enable+0x62/0xb0 [] ? sub_preempt_count+0xd/0xf0 [] wakeup_tracer_call+0x6d/0xf0 [] ? __do_softirq+0xf4/0x110 [] ? wakeup_tracer_call+0x91/0xf0 [] ftrace_call+0x5/0x8 [] ? __do_softirq+0xf4/0x110 [] ? sub_preempt_count+0x12/0xf0 [] _local_bh_enable+0x62/0xb0 [] __do_softirq+0xf4/0x110 [] do_softirq+0xad/0xb0 [] irq_exit+0xa5/0xb0 [] smp_apic_timer_interrupt+0x66/0xa0 [] ? trace_hardirqs_off_thunk+0xc/0x10 [] apic_timer_interrupt+0x2d/0x34 [] ? find_usage_backwards+0xb/0xf0 [] ? _spin_unlock_irqrestore+0x69/0x80 [] tg_shares_up+0x132/0x1d0 [] walk_tg_tree+0x62/0xa0 [] ? tg_shares_up+0x0/0x1d0 [] ? tg_nop+0x0/0x10 [] update_shares+0x5d/0x80 [] try_to_wake_up+0x6f/0x280 [] ? __ftrace_modify_code+0x0/0xc0 [] ? __ftrace_modify_code+0x0/0xc0 [] wake_up_process+0x14/0x20 [] kthread_create+0x66/0xb0 [] ? do_stop+0x0/0x200 [] ? __stop_machine_run+0x30/0xb0 [] __stop_machine_run+0x50/0xb0 [] ? do_stop+0x0/0x200 [] ? __ftrace_modify_code+0x0/0xc0 [] ? mutex_unlock+0xd/0x10 [] stop_machine_run+0x2c/0x60 [] unregister_ftrace_function+0x103/0x180 [] stop_wakeup_tracer+0x17/0x60 [] wakeup_tracer_ctrl_update+0xf/0x30 [] trace_selftest_startup_wakeup+0xb5/0x130 [] ? trace_wakeup_test_thread+0x0/0x70 [] register_tracer+0x135/0x1b0 [] init_wakeup_tracer+0xd/0xf [] kernel_init+0x1a9/0x2ce [] ? _spin_unlock_irq+0x3b/0x60 [] ? trace_hardirqs_on_thunk+0xc/0x10 [] ? init_wakeup_tracer+0x0/0xf [] ? trace_hardirqs_on_caller+0x126/0x180 [] ? trace_hardirqs_on_thunk+0xc/0x10 [] ? restore_nocheck_notrace+0x0/0xe [] ? kernel_init+0x0/0x2ce [] ? kernel_init+0x0/0x2ce [] kernel_thread_helper+0x7/0x10 ======================= ---[ end trace a7919e7f17c0a725 ]--- irq event stamp: 579530 hardirqs last enabled at (579528): [] trace_hardirqs_on+0xb/0x10 hardirqs last disabled at (579529): [] trace_hardirqs_off+0xb/0x10 softirqs last enabled at (579530): [] __do_softirq+0xf4/0x110 softirqs last disabled at (579517): [] do_softirq+0xad/0xb0 irq event stamp: 579530 hardirqs last enabled at (579528): [] trace_hardirqs_on+0xb/0x10 hardirqs last disabled at (579529): [] trace_hardirqs_off+0xb/0x10 softirqs last enabled at (579530): [] __do_softirq+0xf4/0x110 softirqs last disabled at (579517): [] do_softirq+0xad/0xb0 PASSED Incidentally, the kernel also hung while I was typing in this report. (I thought I'd already reported this in -next before the merge window opened... weird.) Vegard -- "The animistic metaphor of the bug that maliciously sneaked in while the programmer was not looking is intellectually dishonest as it disguises that the error is the programmer's own creation." -- E. W. Dijkstra, EWD1036