Re: [BUG] Sound related problem with Linux-2.6.31-rc8-git1-rt9

[Takashi Iwai]

At Mon, 7 Sep 2009 10:01:15 +0300,
Tarkan Erimer wrote:
> 
> On Saturday 05 September 2009 11:44:32 am Takashi Iwai wrote:
> > At Fri, 4 Sep 2009 14:45:28 +0300,
> > 
> > Tarkan Erimer wrote:
> > > When I ran a movie, I got these errors in dmesg. Also, sound began to
> > > skip too fastly. My audio device is:
> > >
> > > tarkane@tarkane:~$ lspci | grep -i audio
> > > 00:1b.0 Audio device: Intel Corporation 82801G (ICH7 Family) High
> > > Definition Audio Controller (rev 01)
> > >
> > >
> > > Tarkan Erimer
> > >
> > >
> > > [81001.954666] BUG: unable to handle kernel NULL pointer dereference at
> > > 00000000000000a8
> > > [81001.954677] IP: [<ffffffffa010f4b5>] snd_pcm_period_elapsed+0x11/0x1ec
> > > [snd_pcm]
> > > [81001.954701] PGD 1a028067 PUD 1a022067 PMD 0
> > > [81001.954708] Oops: 0000 [#1] PREEMPT SMP
> > > [81001.954713] last sysfs file:
> > > /sys/devices/pci0000:00/0000:00:1d.7/usb5/5-8/5-8:1.0/host5/target5:0:0/5
> > >:0:0:0/block/sdb/size [81001.954718] CPU 1
> > > [81001.954721] Modules linked in: nls_iso8859_1 nls_cp437 vfat fat
> > > usb_storage nfs lockd fscache nfs_acl auth_rpcgss sunrpc xt_multiport
> > > iptable_filter ip_tables x_tables binfmt_misc bridge stp llc bnep
> > > xfrm_user xfrm4_tunnel tunnel4 ipcomp xfrm_ipcomp esp4 ah4 deflate ctr
> > > twofish twofish_common camellia serpent blowfish cast5 des_generic cbc
> > > aes_x86_64 aes_generic xcbc rmd160 sha256_generic sha1_generic
> > > crypto_null af_key xfs exportfs btrfs zlib_deflate crc32c libcrc32c
> > > snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_pcm_oss
> > > snd_mixer_oss snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi snd_rawmidi
> > > snd_seq_midi_event snd_seq snd_timer iTCO_wdt snd_seq_device
> > > iTCO_vendor_support snd soundcore snd_page_alloc psmouse serio_raw pcspkr
> > > usbhid ehci_hcd uhci_hcd tg3 floppy
> > > [81001.954806] Pid: 2180, comm: hd-audio0 Not tainted 2.6.31-rc8-git1 #4
> > > HP Compaq dc7600 Small Form Factor
> > > [81001.954810] RIP: 0010:[<ffffffffa010f4b5>]  [<ffffffffa010f4b5>]
> > > snd_pcm_period_elapsed+0x11/0x1ec [snd_pcm]
> > > [81001.954827] RSP: 0018:ffff88003a0cddd0  EFLAGS: 00010282
> > > [81001.954831] RAX: 0000000000000000 RBX: ffff88003a1cf9e0 RCX:
> > > 0000000000000000
> > > [81001.954834] RDX: 0000000000000001 RSI: 0000000000000003 RDI:
> > > 0000000000000000
> > > [81001.954837] RBP: 0000000000000004 R08: ffff88003a1cf9e0 R09:
> > > 00000000ffffffff
> > > [81001.954841] R10: 0000000000000013 R11: ffffffff81033a48 R12:
> > > ffff88003a49cc48
> > > [81001.954844] R13: 0000000000000000 R14: ffff88003a49cc00 R15:
> > > ffffffffa014c092
> > > [81001.954849] FS:  0000000000000000(0000) GS:ffff8800017f8000(0000)
> > > knlGS:0000000000000000
> > > [81001.954853] CS:  0010 DS: 0018 ES: 0018 CR0: 000000008005003b
> > > [81001.954856] CR2: 00000000000000a8 CR3: 000000001a01b000 CR4:
> > > 00000000000006a0
> > > [81001.954860] DR0: 0000000000000000 DR1: 0000000000000000 DR2:
> > > 0000000000000000
> > > [81001.954863] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7:
> > > 0000000000000400
> > > [81001.954868] Process hd-audio0 (pid: 2180, threadinfo ffff88003a0cc000,
> > > task ffff88003f197750)
> > > [81001.954870] Stack:
> > > [81001.954872]  0000000000000000 ffff88003a1cf9e0 0000000000000004
> > > ffff88003a49cc48
> > > [81001.954878] <0> 0000000000000000 ffff88003a49cc00 ffffffffa014c092
> > > ffffffffa014c11c
> > > [81001.954884] <0> ffff88003a0cdec8 ffffc9000260c100 ffff88003a49cdf0
> > > ffff88003a49cdf8
> > > [81001.954892] Call Trace:
> > > [81001.954905]  [<ffffffffa014c092>] ? azx_irq_pending_work+0x0/0xbc
> > > [snd_hda_intel]
> > > [81001.954914]  [<ffffffffa014c11c>] ? azx_irq_pending_work+0x8a/0xbc
> > > [snd_hda_intel]
> > > [81001.954923]  [<ffffffff81051f35>] ? worker_thread+0x1cb/0x268
> > > [81001.954928]  [<ffffffff81056355>] ? autoremove_wake_function+0x0/0x2e
> > > [81001.954933]  [<ffffffff81051d6a>] ? worker_thread+0x0/0x268
> > > [81001.954938]  [<ffffffff81055f9c>] ? kthread+0x8b/0x93
> > > [81001.954944]  [<ffffffff81011c5a>] ? child_rip+0xa/0x20
> > > [81001.954949]  [<ffffffff81055f11>] ? kthread+0x0/0x93
> > > [81001.954953]  [<ffffffff81011c50>] ? child_rip+0x0/0x20
> > > [81001.954955] Code: 01 00 00 31 c9 ba 01 00 00 00 be 06 00 00 00 e8 5d
> > > 7c f2 e0 31 c9 89 c8 5f c3 41 57 41 56 41 55 41 54 55 53 48 83 ec 08 49
> > > 89 fd <4c> 8b bf a8 00 00 00 49 8b 87 b0 02 00 00 48 85 c0 74 02 ff d0
> > > [81001.955011] RIP  [<ffffffffa010f4b5>]
> > > snd_pcm_period_elapsed+0x11/0x1ec [snd_pcm]
> > > [81001.955026]  RSP <ffff88003a0cddd0>
> > > [81001.955029] CR2: 00000000000000a8
> > > [81001.955033] ---[ end trace 552f354de445b720 ]---
> > 
> > It's the first case of such a report.  Might be some races.
> > Did you set CONFIG_SND_DEBUG=y?
> > 
> > 
> > thanks,
> > 
> > Takashi
> >
> 
> Thanks for your respond. 
> 
> No, I didn't. But; today, I will try with CONFIG_SND_DEBUG=y and then will try 
> to reproduce the problem.

Thanks, that'll be helpful.
Also, there should be some relevant messages from the driver before
entering this point.  Could you check it?

Another questions:
- how often does it happen, how reproducible is it?
- is whether it's a regression in 2.6.31 -- have you ever gotten this
  in the earlier version? 

There are a few changes in the codec communication code since 2.6.30,
but I don't see any obvious problem in them...


thanks,

Takashi
--
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/