[alsa-devel] [REGRESSION] no sound on T60 laptop (HDA Intel)

Tue Oct 5 11:49:50 CEST 2010

At Tue, 05 Oct 2010 11:25:53 +0200,
Miklos Szeredi wrote:
> 
> Hi,
> 
> In 2.6.36-rc* sound stopped working on my T60 (HDA Intel).  Everything
> appears normal except there's no sound.
> 
> Dmesg attached.
> 
> ...
> 
> Hmm, it appears sound is back after a suspend/resume.   Strange.

I see no obvious errors related the sound there.
Did the sound come from the headphone before suspend?  Thinkpad has
also thinkpad_acpi stuff, and this can control the speaker volume as
well.

And,

> [24556.438378] =======================================================
> [24556.438384] [ INFO: possible circular locking dependency detected ]
> [24556.438387] 2.6.36-rc6-00084-gc6ea21e-dirty #99
> [24556.438390] -------------------------------------------------------
> [24556.438393] sh/19063 is trying to acquire lock:
> [24556.438395]  (s_active#121){++++.+}, at: [<ffffffff8111f29a>] sysfs_addrm_finish+0x31/0x5a
> [24556.438407] 
> [24556.438408] but task is already holding lock:
> [24556.438410]  (dbs_mutex){+.+.+.}, at: [<ffffffff8138642d>] cpufreq_governor_dbs+0x37c/0x427
> [24556.438420] 
> [24556.438421] which lock already depends on the new lock.
> [24556.438422] 
> [24556.438424] 
> [24556.438425] the existing dependency chain (in reverse order) is:
> [24556.438427] 
> [24556.438428] -> #2 (dbs_mutex){+.+.+.}:
> [24556.438433]        [<ffffffff81068d6b>] __lock_acquire+0x889/0x8fa
> [24556.438440]        [<ffffffff81068ecb>] lock_acquire+0xef/0x115
> [24556.438445]        [<ffffffff8144a677>] mutex_lock_nested+0x4b/0x2e6
> [24556.438451]        [<ffffffff81386127>] cpufreq_governor_dbs+0x76/0x427
> [24556.438456]        [<ffffffff81382e16>] __cpufreq_governor+0x10b/0x14c
> [24556.438461]        [<ffffffff81382f5b>] __cpufreq_set_policy+0x104/0x142
> [24556.438465]        [<ffffffff81384a51>] store_scaling_governor+0x190/0x1ca
> [24556.438470]        [<ffffffff81383f4f>] store+0x56/0x79
> [24556.438474]        [<ffffffff8111dc22>] sysfs_write_file+0x103/0x13f
> [24556.438480]        [<ffffffff810ccfe6>] vfs_write+0xae/0x136
> [24556.438487]        [<ffffffff810cd127>] sys_write+0x45/0x6c
> [24556.438491]        [<ffffffff8100202b>] system_call_fastpath+0x16/0x1b
> [24556.438497] 
> [24556.438498] -> #1 (&per_cpu(cpu_policy_rwsem, cpu)){+++++.}:
> [24556.438503]        [<ffffffff81068d6b>] __lock_acquire+0x889/0x8fa
> [24556.438508]        [<ffffffff81068ecb>] lock_acquire+0xef/0x115
> [24556.438512]        [<ffffffff8144ab7f>] down_write+0x2c/0x4f
> [24556.438517]        [<ffffffff81382c80>] lock_policy_rwsem_write+0x4a/0x7a
> [24556.438522]        [<ffffffff81383f32>] store+0x39/0x79
> [24556.438526]        [<ffffffff8111dc22>] sysfs_write_file+0x103/0x13f
> [24556.438531]        [<ffffffff810ccfe6>] vfs_write+0xae/0x136
> [24556.438536]        [<ffffffff810cd127>] sys_write+0x45/0x6c
> [24556.438540]        [<ffffffff8100202b>] system_call_fastpath+0x16/0x1b
> [24556.438545] 
> [24556.438546] -> #0 (s_active#121){++++.+}:
> [24556.438552]        [<ffffffff81067ee6>] validate_chain+0x727/0xd23
> [24556.438557]        [<ffffffff81068d6b>] __lock_acquire+0x889/0x8fa
> [24556.438561]        [<ffffffff81068ecb>] lock_acquire+0xef/0x115
> [24556.438566]        [<ffffffff8111e87e>] sysfs_deactivate+0x8e/0xcb
> [24556.438571]        [<ffffffff8111f29a>] sysfs_addrm_finish+0x31/0x5a
> [24556.438575]        [<ffffffff8111d236>] sysfs_hash_and_remove+0x54/0x78
> [24556.438580]        [<ffffffff8112074c>] sysfs_remove_group+0x90/0xc9
> [24556.438584]        [<ffffffff81386441>] cpufreq_governor_dbs+0x390/0x427
> [24556.438589]        [<ffffffff81382e16>] __cpufreq_governor+0x10b/0x14c
> [24556.438594]        [<ffffffff81382f45>] __cpufreq_set_policy+0xee/0x142
> [24556.438599]        [<ffffffff81384a51>] store_scaling_governor+0x190/0x1ca
> [24556.438604]        [<ffffffff81383f4f>] store+0x56/0x79
> [24556.438608]        [<ffffffff8111dc22>] sysfs_write_file+0x103/0x13f
> [24556.438613]        [<ffffffff810ccfe6>] vfs_write+0xae/0x136
> [24556.438617]        [<ffffffff810cd127>] sys_write+0x45/0x6c
> [24556.438622]        [<ffffffff8100202b>] system_call_fastpath+0x16/0x1b
> [24556.438627] 
> [24556.438628] other info that might help us debug this:
> [24556.438629] 
> [24556.438632] 4 locks held by sh/19063:
> [24556.438634]  #0:  (&buffer->mutex){+.+.+.}, at: [<ffffffff8111db56>] sysfs_write_file+0x37/0x13f
> [24556.438642]  #1:  (s_active#120){.+.+.+}, at: [<ffffffff8111dc01>] sysfs_write_file+0xe2/0x13f
> [24556.438651]  #2:  (&per_cpu(cpu_policy_rwsem, cpu)){+++++.}, at: [<ffffffff81382c80>] lock_policy_rwsem_write+0x4a/0x7a
> [24556.438659]  #3:  (dbs_mutex){+.+.+.}, at: [<ffffffff8138642d>] cpufreq_governor_dbs+0x37c/0x427
> [24556.438667] 
> [24556.438667] stack backtrace:
> [24556.438671] Pid: 19063, comm: sh Not tainted 2.6.36-rc6-00084-gc6ea21e-dirty #99
> [24556.438674] Call Trace:
> [24556.438679]  [<ffffffff810670c3>] print_circular_bug+0xae/0xbd
> [24556.438684]  [<ffffffff81067ee6>] validate_chain+0x727/0xd23
> [24556.438689]  [<ffffffff81068d6b>] __lock_acquire+0x889/0x8fa
> [24556.438694]  [<ffffffff81066798>] ? mark_held_locks+0x52/0x70
> [24556.438699]  [<ffffffff81065450>] ? lockdep_init_map+0x9b/0x4fb
> [24556.438703]  [<ffffffff8111f29a>] ? sysfs_addrm_finish+0x31/0x5a
> [24556.438707]  [<ffffffff81068ecb>] lock_acquire+0xef/0x115
> [24556.438711]  [<ffffffff8111f29a>] ? sysfs_addrm_finish+0x31/0x5a
> [24556.438716]  [<ffffffff8111e87e>] sysfs_deactivate+0x8e/0xcb
> [24556.438720]  [<ffffffff8111f29a>] ? sysfs_addrm_finish+0x31/0x5a
> [24556.438725]  [<ffffffff8111f29a>] sysfs_addrm_finish+0x31/0x5a
> [24556.438730]  [<ffffffff8111d236>] sysfs_hash_and_remove+0x54/0x78
> [24556.438734]  [<ffffffff8112074c>] sysfs_remove_group+0x90/0xc9
> [24556.438739]  [<ffffffff81386441>] cpufreq_governor_dbs+0x390/0x427
> [24556.438744]  [<ffffffff81382e16>] __cpufreq_governor+0x10b/0x14c
> [24556.438749]  [<ffffffff81382f45>] __cpufreq_set_policy+0xee/0x142
> [24556.438754]  [<ffffffff81384a51>] store_scaling_governor+0x190/0x1ca
> [24556.438758]  [<ffffffff81384874>] ? handle_update+0x0/0xe
> [24556.438763]  [<ffffffff81383f4f>] store+0x56/0x79
> [24556.438768]  [<ffffffff8111dc22>] sysfs_write_file+0x103/0x13f
> [24556.438773]  [<ffffffff810ccfe6>] vfs_write+0xae/0x136
> [24556.438777]  [<ffffffff810cd127>] sys_write+0x45/0x6c
> [24556.438782]  [<ffffffff8100202b>] system_call_fastpath+0x16/0x1b

These look a bit scary...

In anyway, if this is reproducible, get alsa-info.sh output before and
after suspend.  It'll give more information of HD-audio and sound
driver status.

Takashi