From mboxrd@z Thu Jan 1 00:00:00 1970 From: Julian Wollrath Subject: Re: Hung task with trace after resume on kernel v3.7-rc6 Date: Mon, 19 Nov 2012 12:11:34 +0100 Message-ID: <20121119121134.423d026b@ilfaris> References: <20121118161803.58ca707c@ilfaris> <20121119115632.0c41386f@ilfaris> Mime-Version: 1.0 Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: 7bit Return-path: Received: from mout.web.de (mout.web.de [212.227.15.4]) by alsa0.perex.cz (Postfix) with ESMTP id 64A4926163D for ; Mon, 19 Nov 2012 12:11:40 +0100 (CET) In-Reply-To: <20121119115632.0c41386f@ilfaris> List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , Errors-To: alsa-devel-bounces@alsa-project.org Sender: alsa-devel-bounces@alsa-project.org To: Julian Wollrath Cc: Takashi Iwai , Dylan Reid , alsa-devel@alsa-project.org List-Id: alsa-devel@alsa-project.org Am Mon, 19 Nov 2012 11:56:32 +0100 schrieb Julian Wollrath : > > > > I have an Thinkpad X121e with the following soundcard: > > > > 00:01.1 Audio device [0403]: Advanced Micro Devices [AMD] nee > > > > ATI Wrestler HDMI Audio [Radeon HD 6250/6310] [1002:1314] > Of course I did not mean the hdmi device but this one, sorry: > 00:14.2 Audio device [0403]: Advanced Micro Devices [AMD] nee ATI > SBx00 Azalia (Intel HDA) [1002:4383] (rev 40) > > > So, for this particular issue (at least the recursive suspend > > call), I think the easiest way is a patch like below. This is no > > ideal solution but would be good enough as a bandaid at this late > > stage for 3.7. Julian, could you check whether this works? > Sadly the patch does not work, I still get the spurious responses and > a trace, which looked minimaly different this time: > [ 240.434881] INFO: task kworker/u:14:3617 blocked for more than 120 > seconds. [ 240.434894] "echo 0 > > /proc/sys/kernel/hung_task_timeout_secs" disables this message. > > [ 240.434901] kworker/u:14 D ffff88011ed128c0 0 3617 > > 2 0x00000000 > [ 240.434918] ffff880106272cd0 0000000000000046 0000000000000086 > ffff88011a6e7950 [ 240.434931] ffff8801178f7fd8 ffff8801178f7fd8 > ffff8801178f7fd8 ffff880106272cd0 [ 240.434944] 0000000000000003 > ffff8801178f7c20 ffff8801178f7c18 ffff880106272cd0 [ 240.434957] > Call Trace: [ 240.434978] [] ? > schedule_timeout+0x1e2/0x2a0 [ 240.434992] [] ? > select_task_rq_fair+0x53d/0x5d0 [ 240.435004] > [] ? wait_for_common+0xd2/0x180 [ 240.435017] > [] ? try_to_wake_up+0x270/0x270 [ 240.435030] > [] ? flush_work+0xe1/0x160 [ 240.435041] > [] ? gcwq_release_assoc_and_unlock+0x40/0x40 > [ 240.435052] [] ? __cancel_work_timer+0x5d/0xa0 > [ 240.435093] [] ? > hda_call_codec_suspend+0x14c/0x160 [snd_hda_codec] [ 240.435114] > [] ? snd_hda_suspend+0x40/0x60 [snd_hda_codec] > [ 240.435131] [] ? azx_bus_reset+0xab/0xc0 > [snd_hda_intel] [ 240.435152] [] ? > codec_exec_verb+0x185/0x1c0 [snd_hda_codec] [ 240.435173] > [] ? snd_hda_codec_read+0x58/0x90 [snd_hda_codec] > [ 240.435193] [] ? snd_hda_shutup_pins+0x58/0x70 > [snd_hda_codec] [ 240.435210] [] ? > conexant_suspend+0x9/0x10 [snd_hda_codec_conexant] [ 240.435229] > [] ? hda_call_codec_suspend+0x1e/0x160 > [snd_hda_codec] [ 240.435249] [] ? > hda_power_work+0x78/0xc0 [snd_hda_codec] [ 240.435260] > [] ? process_one_work+0x126/0x490 [ 240.435280] > [] ? snd_hda_suspend+0x60/0x60 [snd_hda_codec] > [ 240.435291] [] ? worker_thread+0x15d/0x450 > [ 240.435302] [] ? flush_delayed_work+0x40/0x40 > [ 240.435313] [] ? kthread+0xb3/0xc0 > [ 240.435323] [] ? > kthread_create_on_node+0x110/0x110 [ 240.435335] > [] ? ret_from_fork+0x7c/0xb0 [ 240.435345] > [] ? kthread_create_on_node+0x110/0x110 > > By the way, it seems like I get the traces every 120 seconds and not > only once, forgot to mention that earlier. > Just one more little piece of information: After the 10th of the above mentioned traces I found the following in my dmesg output: [ 1378.403822] azx_single_send_cmd: 219 callbacks suppressed With best regards, Julian