[alsa-devel] 2.6.34-rc: sound hungs (ice1724)
Hi Takashi
Could you please help me how to debug an issue. Sometimes soung hungs, it happens few days (up to a week) after boot. I have no idea how to reproduce it or how to debug it. That's why it is very hard to bisect, I have not tried, the better way should exist. The problem appeared somewhere after 2.6.33.
Card is M-Audio Revo 5.1 (1412:1724).
After it hungs ALSA continues to play last sound frame forever. When I try to play something else playing frame changes. Only reboot heals it.
rmmod hungs at INFO: task rmmod:30356 blocked for more than 120 seconds. "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. rmmod D db281e7c 0 30356 2345 0x00000004 db281e8c 00000086 00000002 db281e7c cc2d7b90 00000000 c14e8b80 09c3638a c10252a0 00000001 c14e2000 c14e2000 c14e8b80 c14e8b80 cc2d7a00 db281e8c 00000246 db281e8c c1043d23 00000001 f6923000 f69231b4 db281e9c db281ebc Call Trace: [<c10252a0>] ? __wake_up+0x40/0x50 [<c1043d23>] ? prepare_to_wait+0x43/0x70 [<f8ce328d>] snd_card_free+0x5d/0x90 [snd] [<c1043af0>] ? autoremove_wake_function+0x0/0x40 [<f9ebcaa6>] snd_vt1724_remove+0x13/0x25 [snd_ice1724] [<c11cddb9>] pci_device_remove+0x19/0x40 [<c1239f3e>] __device_release_driver+0x3e/0x90 [<c123a017>] driver_detach+0x87/0x90 [<c1239323>] bus_remove_driver+0x63/0xa0 [<c123a526>] driver_unregister+0x46/0x80 [<c10d616d>] ? sysfs_remove_file+0xd/0x10 [<c11cdfed>] pci_unregister_driver+0x2d/0x80 [<f9ebca91>] alsa_card_ice1724_exit+0xd/0xf [snd_ice1724] [<c1057bee>] sys_delete_module+0x15e/0x210 [<c107f91f>] ? remove_vma+0x3f/0x60 [<c1080902>] ? do_munmap+0x202/0x2d0 [<c1002b50>] sysenter_do_call+0x12/0x26
CONFIG_SOUND=y CONFIG_SND=m CONFIG_SND_TIMER=m CONFIG_SND_PCM=m CONFIG_SND_RAWMIDI=m CONFIG_SND_VMASTER=y CONFIG_SND_DMA_SGBUF=y CONFIG_SND_AC97_CODEC=m CONFIG_SND_PCI=y CONFIG_SND_ICE1724=m
At Wed, 14 Apr 2010 00:23:37 +0400, Alexander Beregalov wrote:
Hi Takashi
Could you please help me how to debug an issue. Sometimes soung hungs, it happens few days (up to a week) after boot. I have no idea how to reproduce it or how to debug it. That's why it is very hard to bisect, I have not tried, the better way should exist. The problem appeared somewhere after 2.6.33.
Card is M-Audio Revo 5.1 (1412:1724).
After it hungs ALSA continues to play last sound frame forever. When I try to play something else playing frame changes. Only reboot heals it.
rmmod hungs at INFO: task rmmod:30356 blocked for more than 120 seconds. "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. rmmod D db281e7c 0 30356 2345 0x00000004 db281e8c 00000086 00000002 db281e7c cc2d7b90 00000000 c14e8b80 09c3638a c10252a0 00000001 c14e2000 c14e2000 c14e8b80 c14e8b80 cc2d7a00 db281e8c 00000246 db281e8c c1043d23 00000001 f6923000 f69231b4 db281e9c db281ebc Call Trace: [<c10252a0>] ? __wake_up+0x40/0x50 [<c1043d23>] ? prepare_to_wait+0x43/0x70 [<f8ce328d>] snd_card_free+0x5d/0x90 [snd] [<c1043af0>] ? autoremove_wake_function+0x0/0x40 [<f9ebcaa6>] snd_vt1724_remove+0x13/0x25 [snd_ice1724] [<c11cddb9>] pci_device_remove+0x19/0x40 [<c1239f3e>] __device_release_driver+0x3e/0x90 [<c123a017>] driver_detach+0x87/0x90 [<c1239323>] bus_remove_driver+0x63/0xa0 [<c123a526>] driver_unregister+0x46/0x80 [<c10d616d>] ? sysfs_remove_file+0xd/0x10 [<c11cdfed>] pci_unregister_driver+0x2d/0x80 [<f9ebca91>] alsa_card_ice1724_exit+0xd/0xf [snd_ice1724] [<c1057bee>] sys_delete_module+0x15e/0x210 [<c107f91f>] ? remove_vma+0x3f/0x60 [<c1080902>] ? do_munmap+0x202/0x2d0 [<c1002b50>] sysenter_do_call+0x12/0x26
This is odd. Don't you see any other messages before that?
There are almost no change in ice172x. Thus, if any, the regression must be in ALSA core. There have been many changes of PCM hw-updater, at least.
thanks,
Takashi
On 14 April 2010 10:26, Takashi Iwai tiwai@suse.de wrote:
At Wed, 14 Apr 2010 00:23:37 +0400, Alexander Beregalov wrote:
Hi Takashi
Could you please help me how to debug an issue. Sometimes soung hungs, it happens few days (up to a week) after boot. I have no idea how to reproduce it or how to debug it. That's why it is very hard to bisect, I have not tried, the better way should exist. The problem appeared somewhere after 2.6.33.
Card is M-Audio Revo 5.1 (1412:1724).
After it hungs ALSA continues to play last sound frame forever. When I try to play something else playing frame changes. Only reboot heals it.
rmmod hungs at INFO: task rmmod:30356 blocked for more than 120 seconds. "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. rmmod D db281e7c 0 30356 2345 0x00000004 db281e8c 00000086 00000002 db281e7c cc2d7b90 00000000 c14e8b80 09c3638a c10252a0 00000001 c14e2000 c14e2000 c14e8b80 c14e8b80 cc2d7a00 db281e8c 00000246 db281e8c c1043d23 00000001 f6923000 f69231b4 db281e9c db281ebc Call Trace: [<c10252a0>] ? __wake_up+0x40/0x50 [<c1043d23>] ? prepare_to_wait+0x43/0x70 [<f8ce328d>] snd_card_free+0x5d/0x90 [snd] [<c1043af0>] ? autoremove_wake_function+0x0/0x40 [<f9ebcaa6>] snd_vt1724_remove+0x13/0x25 [snd_ice1724] [<c11cddb9>] pci_device_remove+0x19/0x40 [<c1239f3e>] __device_release_driver+0x3e/0x90 [<c123a017>] driver_detach+0x87/0x90 [<c1239323>] bus_remove_driver+0x63/0xa0 [<c123a526>] driver_unregister+0x46/0x80 [<c10d616d>] ? sysfs_remove_file+0xd/0x10 [<c11cdfed>] pci_unregister_driver+0x2d/0x80 [<f9ebca91>] alsa_card_ice1724_exit+0xd/0xf [snd_ice1724] [<c1057bee>] sys_delete_module+0x15e/0x210 [<c107f91f>] ? remove_vma+0x3f/0x60 [<c1080902>] ? do_munmap+0x202/0x2d0 [<c1002b50>] sysenter_do_call+0x12/0x26
This is odd. Don't you see any other messages before that?
No messages. I can try to boot with ignore_loglevel parameter.
There are almost no change in ice172x. Thus, if any, the regression must be in ALSA core. There have been many changes of PCM hw-updater, at least.
It seems the bug is in the core, but in this case I should not be the only reporter.
On 14 April 2010 12:46, Alexander Beregalov a.beregalov@gmail.com wrote:
This is odd. Don't you see any other messages before that?
No messages. I can try to boot with ignore_loglevel parameter.
There are almost no change in ice172x. Thus, if any, the regression must be in ALSA core. There have been many changes of PCM hw-updater, at least.
It seems the bug is in the core, but in this case I should not be the only reporter.
Hi Takashi
I did some bisection. The oldest bad kernel is 6123637fa, with kernels from v2.6.33 to 6123637fa I was not able to reproduce the bug, it's understandable - the bug is very hard to reproduce, I cannot be sure if the kernel is really good after running even for a week. Perhaps could you look at "git log v2.6.33..6123637fa sound/core/" to see something suspicious?
participants (2)
-
Alexander Beregalov -
Takashi Iwai