Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1756815Ab0D0T4Q (ORCPT ); Tue, 27 Apr 2010 15:56:16 -0400 Received: from einhorn.in-berlin.de ([192.109.42.8]:36569 "EHLO einhorn.in-berlin.de" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1756799Ab0D0T4M (ORCPT ); Tue, 27 Apr 2010 15:56:12 -0400 X-Envelope-From: stefanr@s5r6.in-berlin.de Date: Tue, 27 Apr 2010 21:56:04 +0200 (CEST) From: Stefan Richter Subject: sound/core/timer.c: inconsistent lock state reported for tu->qlock To: alsa-devel@alsa-project.org cc: Jaroslav Kysela , Takashi Iwai , linux-kernel@vger.kernel.org Message-ID: MIME-Version: 1.0 Content-Type: TEXT/PLAIN; CHARSET=us-ascii Content-Disposition: INLINE Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org Content-Length: 3389 Lines: 79 Hi, I got the following log from a rarely used PC that I just updated from 2.6.34-rc4 to 2.6.34-rc5. I don't know though under which kernel I last used the soundcard of it; could have been 2.6.33, could have been a .34-rc. It is an x86 Mac mini with 00:1b.0 Audio device: Intel Corporation 82801G (ICH7 Family) High Definition Audio Controller (rev 02) Kernel is vanilla except for various firewire patches, which should not matter to this issue. ================================= [ INFO: inconsistent lock state ] 2.6.34-rc5 #5 --------------------------------- inconsistent {HARDIRQ-ON-W} -> {IN-HARDIRQ-W} usage. dolphin/4003 [HC1[1]:SC0[0]:HE0:SE1] takes: (&(&tu->qlock)->rlock){?.+...}, at: [] snd_timer_user_tinterrupt+0x28/0x132 [snd_timer] {HARDIRQ-ON-W} state was registered at: [] __lock_acquire+0x654/0x1482 [] lock_acquire+0x5c/0x73 [] _raw_spin_lock+0x25/0x34 [] snd_timer_user_ccallback+0x55/0x95 [snd_timer] [] snd_timer_notify1+0x53/0xca [snd_timer] [] _snd_timer_stop+0xfc/0x106 [snd_timer] [] snd_timer_stop+0x13/0x42 [snd_timer] [] snd_timer_user_ioctl+0xa27/0xaf5 [snd_timer] [] vfs_ioctl+0x22/0x87 [] do_vfs_ioctl+0x472/0x4ac [] sys_ioctl+0x2c/0x45 [] sysenter_do_call+0x12/0x36 irq event stamp: 2042234 hardirqs last enabled at (2042233): [] sysenter_exit+0xf/0x18 hardirqs last disabled at (2042234): [] common_interrupt+0x27/0x34 softirqs last enabled at (2042226): [] __do_softirq+0x102/0x10a softirqs last disabled at (2042221): [] do_softirq+0x2b/0x43 other info that might help us debug this: 2 locks held by dolphin/4003: #0: (snd_pcm_link_rwlock){.-....}, at: [] snd_pcm_period_elapsed+0x2a/0xaf [snd_pcm] #1: (&(&substream->self_group.lock)->rlock){-.....}, at: [] snd_pcm_period_elapsed+0x34/0xaf [snd_pcm] stack backtrace: Pid: 4003, comm: dolphin Tainted: G W 2.6.34-rc5 #5 Call Trace: [] ? printk+0xf/0x12 [] print_usage_bug+0x14e/0x15a [] mark_lock+0x2a1/0x4a7 [] ? check_usage_forwards+0x0/0xb0 [] __lock_acquire+0x5d4/0x1482 [] ? __lock_acquire+0x1473/0x1482 [] lock_acquire+0x5c/0x73 [] ? snd_timer_user_tinterrupt+0x28/0x132 [snd_timer] [] _raw_spin_lock+0x25/0x34 [] ? snd_timer_user_tinterrupt+0x28/0x132 [snd_timer] [] snd_timer_user_tinterrupt+0x28/0x132 [snd_timer] [] ? snd_timer_user_tinterrupt+0x0/0x132 [snd_timer] [] snd_timer_interrupt+0x213/0x264 [snd_timer] [] ? _raw_spin_lock+0x2c/0x34 [] snd_pcm_period_elapsed+0x72/0xaf [snd_pcm] [] azx_interrupt+0x8d/0x109 [snd_hda_intel] [] handle_IRQ_event+0x1d/0xa2 [] handle_fasteoi_irq+0x79/0xb2 [] handle_irq+0x3b/0x48 [] do_IRQ+0x45/0x9f [] common_interrupt+0x2e/0x34 [] ? piix_init_one+0x1d2/0x628 -- Stefan Richter -=====-==-=- -=-- ==-== http://arcgraph.de/sr/ -- To unsubscribe from this list: send the line "unsubscribe linux-kernel" in the body of a message to majordomo@vger.kernel.org More majordomo info at http://vger.kernel.org/majordomo-info.html Please read the FAQ at http://www.tux.org/lkml/