Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1753556AbcCZTAZ (ORCPT ); Sat, 26 Mar 2016 15:00:25 -0400 Received: from mail-wm0-f52.google.com ([74.125.82.52]:35453 "EHLO mail-wm0-f52.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751178AbcCZTAW (ORCPT ); Sat, 26 Mar 2016 15:00:22 -0400 MIME-Version: 1.0 From: Greg Stark Date: Sat, 26 Mar 2016 18:59:39 +0000 X-Google-Sender-Auth: 0vVG-94Fy2hmUQsU7Dptn0jtjQg Message-ID: Subject: Continue to get freezes on Chromebook PIxel To: linux-kernel@vger.kernel.org Content-Type: text/plain; charset=UTF-8 Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org Content-Length: 39407 Lines: 776 I continue to see freezes at random intervals on my Chromebook PIxel (2013). The X UI freezes completely for anywhere from a fraction of a second to several minutes but always eventually resumes. When it resumes there's normally nothing in dmesg or any other logs and no indication of exactly what exactly was happening when X was frozen. I had always chalked this up to the known problems with the intel graphics driver but apparently reports are that those problems are fixed and nobody else continues to see these freezes. I'm now suspecting that there's something else going on. Possibly the Sandisk iSSD apparently other Sandisk SSDs are buggy as hell so maybe the iSSD is as well? When the system returns there is usually a bunch of processes in disk wait including dm_crypt and usually several Chrome processes trying to page in stuff from swap. So blaming the SSD doesn't seem entirely out of line. On the other hand *anything* that locked up the PCI bus for a while would also cause lots of queued up I/O. I'm at a loss how to debug this. I'm looking for anything I can enable that would indicate what is blocking X and/or the kernel. Presumably there's some device driver waiting for some event for longer than is reasonable and either holding some kernel lock or hardware resource. Surely there are debug flags I can enable that will log whenever this happens so I can see after a freeze what was waiting on what for so long? I do have logs from a particularly long freeze where the kernel logged hung tasks. I suspect these just indicate what processes happened to be have wanted to do during the freeze that caused them to get stuck, not the culprit that actually caused them to get stuck. And I do have the intel driver debug flags enable but I think all this shows is that that the screensaver kicked in when the kernel finally unstuck and scheduled X: So please, if anyone has any suggestions of what tools to use or flags to enable to get visibility into what the kernel is doing when everything is frozen I would be more than happy to do further investigation on this end. Mar 26 17:06:52 pixel kernel: [174364.984072] INFO: task kworker/0:2:15108 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [174364.984077] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [174364.984078] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [174364.984080] kworker/0:2 D 0000000000000000 0 15108 2 0x00000000 Mar 26 17:06:52 pixel kernel: [174364.984088] Workqueue: events_freezable thermal_zone_device_check Mar 26 17:06:52 pixel kernel: [174364.984090] ffff8801000e0240 ffff880060ab6f80 ffff88012b494000 ffff88012b493c50 Mar 26 17:06:52 pixel kernel: [174364.984092] ffff88014a8035c0 ffff8801000e0240 ffff88014a89bb80 ffffffffa000e06d Mar 26 17:06:52 pixel kernel: [174364.984094] ffffffff815a81a1 7fffffffffffffff ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [174364.984096] Call Trace: Mar 26 17:06:52 pixel kernel: [174364.984102] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [174364.984104] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [174364.984108] [] ? acpi_ns_lookup+0x281/0x3a1 Mar 26 17:06:52 pixel kernel: [174364.984111] [] ? down_timeout+0x31/0x50 Mar 26 17:06:52 pixel kernel: [174364.984114] [] ? __down_timeout+0x75/0xc0 Mar 26 17:06:52 pixel kernel: [174364.984115] [] ? schedule_timeout+0x1a0/0x270 Mar 26 17:06:52 pixel kernel: [174364.984118] [] ? down_timeout+0x43/0x50 Mar 26 17:06:52 pixel kernel: [174364.984121] [] ? acpi_os_wait_semaphore+0x48/0x62 Mar 26 17:06:52 pixel kernel: [174364.984124] [] ? acpi_ut_acquire_mutex+0x44/0x7f Mar 26 17:06:52 pixel kernel: [174364.984126] [] ? acpi_ex_enter_interpreter+0xc/0x29 Mar 26 17:06:52 pixel kernel: [174364.984128] [] ? acpi_ns_evaluate+0x1b1/0x237 Mar 26 17:06:52 pixel kernel: [174364.984130] [] ? acpi_evaluate_object+0x13e/0x247 Mar 26 17:06:52 pixel kernel: [174364.984132] [] ? acpi_evaluate_integer+0x52/0x87 Mar 26 17:06:52 pixel kernel: [174364.984135] [] ? acpi_thermal_get_temperature+0x47/0x77 [thermal] Mar 26 17:06:52 pixel kernel: [174364.984137] [] ? thermal_get_temp+0x23/0x3a [thermal] Mar 26 17:06:52 pixel kernel: [174364.984139] [] ? thermal_zone_get_temp+0x4f/0x60 Mar 26 17:06:52 pixel kernel: [174364.984141] [] ? thermal_zone_device_update.part.22+0x28/0x160 Mar 26 17:06:52 pixel kernel: [174364.984144] [] ? process_one_work+0x15a/0x410 Mar 26 17:06:52 pixel kernel: [174364.984146] [] ? worker_thread+0x4d/0x480 Mar 26 17:06:52 pixel kernel: [174364.984148] [] ? process_one_work+0x410/0x410 Mar 26 17:06:52 pixel kernel: [174364.984151] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [174364.984153] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174364.984156] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [174364.984158] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174484.987671] INFO: task kworker/0:2:15108 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [174484.987676] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [174484.987677] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [174484.987679] kworker/0:2 D 0000000000000000 0 15108 2 0x00000000 Mar 26 17:06:52 pixel kernel: [174484.987688] Workqueue: events_freezable thermal_zone_device_check Mar 26 17:06:52 pixel kernel: [174484.987690] ffff8801000e0240 ffff880060ab6f80 ffff88012b494000 ffff88012b493c50 Mar 26 17:06:52 pixel kernel: [174484.987692] ffff88014a8035c0 ffff8801000e0240 ffff88014a89bb80 ffffffffa000e06d Mar 26 17:06:52 pixel kernel: [174484.987694] ffffffff815a81a1 7fffffffffffffff ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [174484.987696] Call Trace: Mar 26 17:06:52 pixel kernel: [174484.987702] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [174484.987705] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [174484.987709] [] ? acpi_ns_lookup+0x281/0x3a1 Mar 26 17:06:52 pixel kernel: [174484.987712] [] ? down_timeout+0x31/0x50 Mar 26 17:06:52 pixel kernel: [174484.987714] [] ? __down_timeout+0x75/0xc0 Mar 26 17:06:52 pixel kernel: [174484.987716] [] ? schedule_timeout+0x1a0/0x270 Mar 26 17:06:52 pixel kernel: [174484.987718] [] ? down_timeout+0x43/0x50 Mar 26 17:06:52 pixel kernel: [174484.987722] [] ? acpi_os_wait_semaphore+0x48/0x62 Mar 26 17:06:52 pixel kernel: [174484.987724] [] ? acpi_ut_acquire_mutex+0x44/0x7f Mar 26 17:06:52 pixel kernel: [174484.987726] [] ? acpi_ex_enter_interpreter+0xc/0x29 Mar 26 17:06:52 pixel kernel: [174484.987728] [] ? acpi_ns_evaluate+0x1b1/0x237 Mar 26 17:06:52 pixel kernel: [174484.987731] [] ? acpi_evaluate_object+0x13e/0x247 Mar 26 17:06:52 pixel kernel: [174484.987733] [] ? acpi_evaluate_integer+0x52/0x87 Mar 26 17:06:52 pixel kernel: [174484.987736] [] ? acpi_thermal_get_temperature+0x47/0x77 [thermal] Mar 26 17:06:52 pixel kernel: [174484.987738] [] ? thermal_get_temp+0x23/0x3a [thermal] Mar 26 17:06:52 pixel kernel: [174484.987740] [] ? thermal_zone_get_temp+0x4f/0x60 Mar 26 17:06:52 pixel kernel: [174484.987742] [] ? thermal_zone_device_update.part.22+0x28/0x160 Mar 26 17:06:52 pixel kernel: [174484.987746] [] ? process_one_work+0x15a/0x410 Mar 26 17:06:52 pixel kernel: [174484.987747] [] ? worker_thread+0x4d/0x480 Mar 26 17:06:52 pixel kernel: [174484.987749] [] ? process_one_work+0x410/0x410 Mar 26 17:06:52 pixel kernel: [174484.987752] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [174484.987754] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174484.987757] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [174484.987759] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174604.991268] INFO: task kworker/0:2:15108 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [174604.991273] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [174604.991274] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [174604.991276] kworker/0:2 D 0000000000000000 0 15108 2 0x00000000 Mar 26 17:06:52 pixel kernel: [174604.991284] Workqueue: events_freezable thermal_zone_device_check Mar 26 17:06:52 pixel kernel: [174604.991286] ffff8801000e0240 ffff880060ab6f80 ffff88012b494000 ffff88012b493c50 Mar 26 17:06:52 pixel kernel: [174604.991289] ffff88014a8035c0 ffff8801000e0240 ffff88014a89bb80 ffffffffa000e06d Mar 26 17:06:52 pixel kernel: [174604.991290] ffffffff815a81a1 7fffffffffffffff ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [174604.991292] Call Trace: Mar 26 17:06:52 pixel kernel: [174604.991298] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [174604.991300] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [174604.991304] [] ? acpi_ns_lookup+0x281/0x3a1 Mar 26 17:06:52 pixel kernel: [174604.991308] [] ? down_timeout+0x31/0x50 Mar 26 17:06:52 pixel kernel: [174604.991310] [] ? __down_timeout+0x75/0xc0 Mar 26 17:06:52 pixel kernel: [174604.991312] [] ? schedule_timeout+0x1a0/0x270 Mar 26 17:06:52 pixel kernel: [174604.991314] [] ? down_timeout+0x43/0x50 Mar 26 17:06:52 pixel kernel: [174604.991317] [] ? acpi_os_wait_semaphore+0x48/0x62 Mar 26 17:06:52 pixel kernel: [174604.991320] [] ? acpi_ut_acquire_mutex+0x44/0x7f Mar 26 17:06:52 pixel kernel: [174604.991322] [] ? acpi_ex_enter_interpreter+0xc/0x29 Mar 26 17:06:52 pixel kernel: [174604.991323] [] ? acpi_ns_evaluate+0x1b1/0x237 Mar 26 17:06:52 pixel kernel: [174604.991326] [] ? acpi_evaluate_object+0x13e/0x247 Mar 26 17:06:52 pixel kernel: [174604.991328] [] ? acpi_evaluate_integer+0x52/0x87 Mar 26 17:06:52 pixel kernel: [174604.991332] [] ? acpi_thermal_get_temperature+0x47/0x77 [thermal] Mar 26 17:06:52 pixel kernel: [174604.991334] [] ? thermal_get_temp+0x23/0x3a [thermal] Mar 26 17:06:52 pixel kernel: [174604.991336] [] ? thermal_zone_get_temp+0x4f/0x60 Mar 26 17:06:52 pixel kernel: [174604.991338] [] ? thermal_zone_device_update.part.22+0x28/0x160 Mar 26 17:06:52 pixel kernel: [174604.991341] [] ? process_one_work+0x15a/0x410 Mar 26 17:06:52 pixel kernel: [174604.991343] [] ? worker_thread+0x4d/0x480 Mar 26 17:06:52 pixel kernel: [174604.991345] [] ? process_one_work+0x410/0x410 Mar 26 17:06:52 pixel kernel: [174604.991347] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [174604.991350] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174604.991352] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [174604.991355] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174724.994863] INFO: task kworker/0:2:15108 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [174724.994868] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [174724.994869] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [174724.994870] kworker/0:2 D 0000000000000000 0 15108 2 0x00000000 Mar 26 17:06:52 pixel kernel: [174724.994880] Workqueue: events_freezable thermal_zone_device_check Mar 26 17:06:52 pixel kernel: [174724.994882] ffff8801000e0240 ffff880060ab6f80 ffff88012b494000 ffff88012b493c50 Mar 26 17:06:52 pixel kernel: [174724.994884] ffff88014a8035c0 ffff8801000e0240 ffff88014a89bb80 ffffffffa000e06d Mar 26 17:06:52 pixel kernel: [174724.994885] ffffffff815a81a1 7fffffffffffffff ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [174724.994887] Call Trace: Mar 26 17:06:52 pixel kernel: [174724.994893] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [174724.994895] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [174724.994899] [] ? acpi_ns_lookup+0x281/0x3a1 Mar 26 17:06:52 pixel kernel: [174724.994902] [] ? down_timeout+0x31/0x50 Mar 26 17:06:52 pixel kernel: [174724.994904] [] ? __down_timeout+0x75/0xc0 Mar 26 17:06:52 pixel kernel: [174724.994906] [] ? schedule_timeout+0x1a0/0x270 Mar 26 17:06:52 pixel kernel: [174724.994909] [] ? down_timeout+0x43/0x50 Mar 26 17:06:52 pixel kernel: [174724.994912] [] ? acpi_os_wait_semaphore+0x48/0x62 Mar 26 17:06:52 pixel kernel: [174724.994915] [] ? acpi_ut_acquire_mutex+0x44/0x7f Mar 26 17:06:52 pixel kernel: [174724.994917] [] ? acpi_ex_enter_interpreter+0xc/0x29 Mar 26 17:06:52 pixel kernel: [174724.994919] [] ? acpi_ns_evaluate+0x1b1/0x237 Mar 26 17:06:52 pixel kernel: [174724.994921] [] ? acpi_evaluate_object+0x13e/0x247 Mar 26 17:06:52 pixel kernel: [174724.994923] [] ? acpi_evaluate_integer+0x52/0x87 Mar 26 17:06:52 pixel kernel: [174724.994926] [] ? acpi_thermal_get_temperature+0x47/0x77 [thermal] Mar 26 17:06:52 pixel kernel: [174724.994928] [] ? thermal_get_temp+0x23/0x3a [thermal] Mar 26 17:06:52 pixel kernel: [174724.994930] [] ? thermal_zone_get_temp+0x4f/0x60 Mar 26 17:06:52 pixel kernel: [174724.994932] [] ? thermal_zone_device_update.part.22+0x28/0x160 Mar 26 17:06:52 pixel kernel: [174724.994936] [] ? process_one_work+0x15a/0x410 Mar 26 17:06:52 pixel kernel: [174724.994938] [] ? worker_thread+0x4d/0x480 Mar 26 17:06:52 pixel kernel: [174724.994940] [] ? process_one_work+0x410/0x410 Mar 26 17:06:52 pixel kernel: [174724.994942] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [174724.994945] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174724.994948] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [174724.994950] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174844.998452] INFO: task kworker/0:2:15108 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [174844.998456] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [174844.998457] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [174844.998459] kworker/0:2 D 0000000000000000 0 15108 2 0x00000000 Mar 26 17:06:52 pixel kernel: [174844.998467] Workqueue: events_freezable thermal_zone_device_check Mar 26 17:06:52 pixel kernel: [174844.998469] ffff8801000e0240 ffff880060ab6f80 ffff88012b494000 ffff88012b493c50 Mar 26 17:06:52 pixel kernel: [174844.998471] ffff88014a8035c0 ffff8801000e0240 ffff88014a89bb80 ffffffffa000e06d Mar 26 17:06:52 pixel kernel: [174844.998473] ffffffff815a81a1 7fffffffffffffff ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [174844.998475] Call Trace: Mar 26 17:06:52 pixel kernel: [174844.998481] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [174844.998483] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [174844.998486] [] ? acpi_ns_lookup+0x281/0x3a1 Mar 26 17:06:52 pixel kernel: [174844.998490] [] ? down_timeout+0x31/0x50 Mar 26 17:06:52 pixel kernel: [174844.998492] [] ? __down_timeout+0x75/0xc0 Mar 26 17:06:52 pixel kernel: [174844.998494] [] ? schedule_timeout+0x1a0/0x270 Mar 26 17:06:52 pixel kernel: [174844.998496] [] ? down_timeout+0x43/0x50 Mar 26 17:06:52 pixel kernel: [174844.998499] [] ? acpi_os_wait_semaphore+0x48/0x62 Mar 26 17:06:52 pixel kernel: [174844.998501] [] ? acpi_ut_acquire_mutex+0x44/0x7f Mar 26 17:06:52 pixel kernel: [174844.998503] [] ? acpi_ex_enter_interpreter+0xc/0x29 Mar 26 17:06:52 pixel kernel: [174844.998505] [] ? acpi_ns_evaluate+0x1b1/0x237 Mar 26 17:06:52 pixel kernel: [174844.998507] [] ? acpi_evaluate_object+0x13e/0x247 Mar 26 17:06:52 pixel kernel: [174844.998510] [] ? acpi_evaluate_integer+0x52/0x87 Mar 26 17:06:52 pixel kernel: [174844.998513] [] ? acpi_thermal_get_temperature+0x47/0x77 [thermal] Mar 26 17:06:52 pixel kernel: [174844.998515] [] ? thermal_get_temp+0x23/0x3a [thermal] Mar 26 17:06:52 pixel kernel: [174844.998517] [] ? thermal_zone_get_temp+0x4f/0x60 Mar 26 17:06:52 pixel kernel: [174844.998519] [] ? thermal_zone_device_update.part.22+0x28/0x160 Mar 26 17:06:52 pixel kernel: [174844.998522] [] ? process_one_work+0x15a/0x410 Mar 26 17:06:52 pixel kernel: [174844.998524] [] ? worker_thread+0x4d/0x480 Mar 26 17:06:52 pixel kernel: [174844.998526] [] ? process_one_work+0x410/0x410 Mar 26 17:06:52 pixel kernel: [174844.998528] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [174844.998530] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174844.998533] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [174844.998535] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174965.002049] INFO: task kworker/0:2:15108 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [174965.002054] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [174965.002055] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [174965.002056] kworker/0:2 D 0000000000000000 0 15108 2 0x00000000 Mar 26 17:06:52 pixel kernel: [174965.002065] Workqueue: events_freezable thermal_zone_device_check Mar 26 17:06:52 pixel kernel: [174965.002067] ffff8801000e0240 ffff880060ab6f80 ffff88012b494000 ffff88012b493c50 Mar 26 17:06:52 pixel kernel: [174965.002069] ffff88014a8035c0 ffff8801000e0240 ffff88014a89bb80 ffffffffa000e06d Mar 26 17:06:52 pixel kernel: [174965.002071] ffffffff815a81a1 7fffffffffffffff ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [174965.002072] Call Trace: Mar 26 17:06:52 pixel kernel: [174965.002078] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [174965.002081] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [174965.002084] [] ? acpi_ns_lookup+0x281/0x3a1 Mar 26 17:06:52 pixel kernel: [174965.002088] [] ? down_timeout+0x31/0x50 Mar 26 17:06:52 pixel kernel: [174965.002090] [] ? __down_timeout+0x75/0xc0 Mar 26 17:06:52 pixel kernel: [174965.002092] [] ? schedule_timeout+0x1a0/0x270 Mar 26 17:06:52 pixel kernel: [174965.002094] [] ? down_timeout+0x43/0x50 Mar 26 17:06:52 pixel kernel: [174965.002097] [] ? acpi_os_wait_semaphore+0x48/0x62 Mar 26 17:06:52 pixel kernel: [174965.002100] [] ? acpi_ut_acquire_mutex+0x44/0x7f Mar 26 17:06:52 pixel kernel: [174965.002102] [] ? acpi_ex_enter_interpreter+0xc/0x29 Mar 26 17:06:52 pixel kernel: [174965.002104] [] ? acpi_ns_evaluate+0x1b1/0x237 Mar 26 17:06:52 pixel kernel: [174965.002106] [] ? acpi_evaluate_object+0x13e/0x247 Mar 26 17:06:52 pixel kernel: [174965.002108] [] ? acpi_evaluate_integer+0x52/0x87 Mar 26 17:06:52 pixel kernel: [174965.002111] [] ? acpi_thermal_get_temperature+0x47/0x77 [thermal] Mar 26 17:06:52 pixel kernel: [174965.002113] [] ? thermal_get_temp+0x23/0x3a [thermal] Mar 26 17:06:52 pixel kernel: [174965.002115] [] ? thermal_zone_get_temp+0x4f/0x60 Mar 26 17:06:52 pixel kernel: [174965.002117] [] ? thermal_zone_device_update.part.22+0x28/0x160 Mar 26 17:06:52 pixel kernel: [174965.002121] [] ? process_one_work+0x15a/0x410 Mar 26 17:06:52 pixel kernel: [174965.002123] [] ? worker_thread+0x4d/0x480 Mar 26 17:06:52 pixel kernel: [174965.002124] [] ? process_one_work+0x410/0x410 Mar 26 17:06:52 pixel kernel: [174965.002127] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [174965.002129] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [174965.002132] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [174965.002134] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [175085.005595] INFO: task jbd2/dm-3-8:1693 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [175085.005601] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [175085.005602] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [175085.005605] jbd2/dm-3-8 D 0000000000000002 0 1693 2 0x00000000 Mar 26 17:06:52 pixel kernel: [175085.005609] ffff880148916fc0 ffff8800930fa100 ffff8800a84a4000 ffff8800a84a3be0 Mar 26 17:06:52 pixel kernel: [175085.005611] 7fffffffffffffff ffffffff815a8940 ffff8800a84a3c60 ffff8801281a9700 Mar 26 17:06:52 pixel kernel: [175085.005613] ffffffff815a81a1 0000000000000000 ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [175085.005615] Call Trace: Mar 26 17:06:52 pixel kernel: [175085.005622] [] ? bit_wait+0x60/0x60 Mar 26 17:06:52 pixel kernel: [175085.005624] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [175085.005626] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [175085.005633] [] ? __split_and_process_bio+0x302/0x400 [dm_mod] Mar 26 17:06:52 pixel kernel: [175085.005636] [] ? bit_wait+0x60/0x60 Mar 26 17:06:52 pixel kernel: [175085.005637] [] ? io_schedule_timeout+0x9d/0x100 Mar 26 17:06:52 pixel kernel: [175085.005641] [] ? prepare_to_wait+0x55/0x80 Mar 26 17:06:52 pixel kernel: [175085.005642] [] ? bit_wait_io+0x17/0x60 Mar 26 17:06:52 pixel kernel: [175085.005644] [] ? __wait_on_bit+0x58/0x90 Mar 26 17:06:52 pixel kernel: [175085.005646] [] ? bit_wait+0x60/0x60 Mar 26 17:06:52 pixel kernel: [175085.005647] [] ? out_of_line_wait_on_bit+0x7e/0xa0 Mar 26 17:06:52 pixel kernel: [175085.005649] [] ? autoremove_wake_function+0x40/0x40 Mar 26 17:06:52 pixel kernel: [175085.005656] [] ? jbd2_journal_commit_transaction+0xf22/0x18a0 [jbd2] Mar 26 17:06:52 pixel kernel: [175085.005659] [] ? try_to_del_timer_sync+0x59/0x80 Mar 26 17:06:52 pixel kernel: [175085.005663] [] ? kjournald2+0xc2/0x250 [jbd2] Mar 26 17:06:52 pixel kernel: [175085.005666] [] ? wake_atomic_t_function+0x60/0x60 Mar 26 17:06:52 pixel kernel: [175085.005669] [] ? commit_timeout+0x10/0x10 [jbd2] Mar 26 17:06:52 pixel kernel: [175085.005672] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [175085.005675] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [175085.005677] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [175085.005679] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [175085.005730] INFO: task kworker/0:2:15108 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [175085.005731] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [175085.005732] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [175085.005733] kworker/0:2 D 0000000000000000 0 15108 2 0x00000000 Mar 26 17:06:52 pixel kernel: [175085.005738] Workqueue: events_freezable thermal_zone_device_check Mar 26 17:06:52 pixel kernel: [175085.005740] ffff8801000e0240 ffff880060ab6f80 ffff88012b494000 ffff88012b493c50 Mar 26 17:06:52 pixel kernel: [175085.005741] ffff88014a8035c0 ffff8801000e0240 ffff88014a89bb80 ffffffffa000e06d Mar 26 17:06:52 pixel kernel: [175085.005743] ffffffff815a81a1 7fffffffffffffff ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [175085.005745] Call Trace: Mar 26 17:06:52 pixel kernel: [175085.005747] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [175085.005749] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [175085.005752] [] ? acpi_ns_lookup+0x281/0x3a1 Mar 26 17:06:52 pixel kernel: [175085.005755] [] ? down_timeout+0x31/0x50 Mar 26 17:06:52 pixel kernel: [175085.005758] [] ? __down_timeout+0x75/0xc0 Mar 26 17:06:52 pixel kernel: [175085.005759] [] ? schedule_timeout+0x1a0/0x270 Mar 26 17:06:52 pixel kernel: [175085.005761] [] ? down_timeout+0x43/0x50 Mar 26 17:06:52 pixel kernel: [175085.005764] [] ? acpi_os_wait_semaphore+0x48/0x62 Mar 26 17:06:52 pixel kernel: [175085.005767] [] ? acpi_ut_acquire_mutex+0x44/0x7f Mar 26 17:06:52 pixel kernel: [175085.005769] [] ? acpi_ex_enter_interpreter+0xc/0x29 Mar 26 17:06:52 pixel kernel: [175085.005771] [] ? acpi_ns_evaluate+0x1b1/0x237 Mar 26 17:06:52 pixel kernel: [175085.005773] [] ? acpi_evaluate_object+0x13e/0x247 Mar 26 17:06:52 pixel kernel: [175085.005775] [] ? acpi_evaluate_integer+0x52/0x87 Mar 26 17:06:52 pixel kernel: [175085.005778] [] ? acpi_thermal_get_temperature+0x47/0x77 [thermal] Mar 26 17:06:52 pixel kernel: [175085.005780] [] ? thermal_get_temp+0x23/0x3a [thermal] Mar 26 17:06:52 pixel kernel: [175085.005782] [] ? thermal_zone_get_temp+0x4f/0x60 Mar 26 17:06:52 pixel kernel: [175085.005784] [] ? thermal_zone_device_update.part.22+0x28/0x160 Mar 26 17:06:52 pixel kernel: [175085.005786] [] ? process_one_work+0x15a/0x410 Mar 26 17:06:52 pixel kernel: [175085.005788] [] ? worker_thread+0x4d/0x480 Mar 26 17:06:52 pixel kernel: [175085.005790] [] ? process_one_work+0x410/0x410 Mar 26 17:06:52 pixel kernel: [175085.005792] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [175085.005795] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [175085.005797] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [175085.005799] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [175205.009185] INFO: task jbd2/dm-3-8:1693 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [175205.009190] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [175205.009191] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [175205.009192] jbd2/dm-3-8 D 0000000000000002 0 1693 2 0x00000000 Mar 26 17:06:52 pixel kernel: [175205.009196] ffff880148916fc0 ffff8800930fa100 ffff8800a84a4000 ffff8800a84a3be0 Mar 26 17:06:52 pixel kernel: [175205.009198] 7fffffffffffffff ffffffff815a8940 ffff8800a84a3c60 ffff8801281a9700 Mar 26 17:06:52 pixel kernel: [175205.009200] ffffffff815a81a1 0000000000000000 ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [175205.009202] Call Trace: Mar 26 17:06:52 pixel kernel: [175205.009207] [] ? bit_wait+0x60/0x60 Mar 26 17:06:52 pixel kernel: [175205.009209] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [175205.009212] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [175205.009219] [] ? __split_and_process_bio+0x302/0x400 [dm_mod] Mar 26 17:06:52 pixel kernel: [175205.009221] [] ? bit_wait+0x60/0x60 Mar 26 17:06:52 pixel kernel: [175205.009223] [] ? io_schedule_timeout+0x9d/0x100 Mar 26 17:06:52 pixel kernel: [175205.009226] [] ? prepare_to_wait+0x55/0x80 Mar 26 17:06:52 pixel kernel: [175205.009228] [] ? bit_wait_io+0x17/0x60 Mar 26 17:06:52 pixel kernel: [175205.009229] [] ? __wait_on_bit+0x58/0x90 Mar 26 17:06:52 pixel kernel: [175205.009231] [] ? bit_wait+0x60/0x60 Mar 26 17:06:52 pixel kernel: [175205.009233] [] ? out_of_line_wait_on_bit+0x7e/0xa0 Mar 26 17:06:52 pixel kernel: [175205.009235] [] ? autoremove_wake_function+0x40/0x40 Mar 26 17:06:52 pixel kernel: [175205.009240] [] ? jbd2_journal_commit_transaction+0xf22/0x18a0 [jbd2] Mar 26 17:06:52 pixel kernel: [175205.009244] [] ? try_to_del_timer_sync+0x59/0x80 Mar 26 17:06:52 pixel kernel: [175205.009248] [] ? kjournald2+0xc2/0x250 [jbd2] Mar 26 17:06:52 pixel kernel: [175205.009251] [] ? wake_atomic_t_function+0x60/0x60 Mar 26 17:06:52 pixel kernel: [175205.009254] [] ? commit_timeout+0x10/0x10 [jbd2] Mar 26 17:06:52 pixel kernel: [175205.009257] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [175205.009260] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [175205.009262] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [175205.009265] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [175205.009314] INFO: task kworker/0:2:15108 blocked for more than 120 seconds. Mar 26 17:06:52 pixel kernel: [175205.009316] Tainted: G C 4.5.0-rc7-amd64 #1 Mar 26 17:06:52 pixel kernel: [175205.009317] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Mar 26 17:06:52 pixel kernel: [175205.009318] kworker/0:2 D 0000000000000000 0 15108 2 0x00000000 Mar 26 17:06:52 pixel kernel: [175205.009323] Workqueue: events_freezable thermal_zone_device_check Mar 26 17:06:52 pixel kernel: [175205.009324] ffff8801000e0240 ffff880060ab6f80 ffff88012b494000 ffff88012b493c50 Mar 26 17:06:52 pixel kernel: [175205.009326] ffff88014a8035c0 ffff8801000e0240 ffff88014a89bb80 ffffffffa000e06d Mar 26 17:06:52 pixel kernel: [175205.009328] ffffffff815a81a1 7fffffffffffffff ffffffff815ab012 7fffffffffffffff Mar 26 17:06:52 pixel kernel: [175205.009329] Call Trace: Mar 26 17:06:52 pixel kernel: [175205.009332] [] ? schedule+0x31/0x80 Mar 26 17:06:52 pixel kernel: [175205.009334] [] ? schedule_timeout+0x1b2/0x270 Mar 26 17:06:52 pixel kernel: [175205.009337] [] ? acpi_ns_lookup+0x281/0x3a1 Mar 26 17:06:52 pixel kernel: [175205.009340] [] ? down_timeout+0x31/0x50 Mar 26 17:06:52 pixel kernel: [175205.009342] [] ? __down_timeout+0x75/0xc0 Mar 26 17:06:52 pixel kernel: [175205.009344] [] ? schedule_timeout+0x1a0/0x270 Mar 26 17:06:52 pixel kernel: [175205.009346] [] ? down_timeout+0x43/0x50 Mar 26 17:06:52 pixel kernel: [175205.009349] [] ? acpi_os_wait_semaphore+0x48/0x62 Mar 26 17:06:52 pixel kernel: [175205.009351] [] ? acpi_ut_acquire_mutex+0x44/0x7f Mar 26 17:06:52 pixel kernel: [175205.009353] [] ? acpi_ex_enter_interpreter+0xc/0x29 Mar 26 17:06:52 pixel kernel: [175205.009355] [] ? acpi_ns_evaluate+0x1b1/0x237 Mar 26 17:06:52 pixel kernel: [175205.009357] [] ? acpi_evaluate_object+0x13e/0x247 Mar 26 17:06:52 pixel kernel: [175205.009360] [] ? acpi_evaluate_integer+0x52/0x87 Mar 26 17:06:52 pixel kernel: [175205.009362] [] ? acpi_thermal_get_temperature+0x47/0x77 [thermal] Mar 26 17:06:52 pixel kernel: [175205.009364] [] ? thermal_get_temp+0x23/0x3a [thermal] Mar 26 17:06:52 pixel kernel: [175205.009366] [] ? thermal_zone_get_temp+0x4f/0x60 Mar 26 17:06:52 pixel kernel: [175205.009368] [] ? thermal_zone_device_update.part.22+0x28/0x160 Mar 26 17:06:52 pixel kernel: [175205.009370] [] ? process_one_work+0x15a/0x410 Mar 26 17:06:52 pixel kernel: [175205.009372] [] ? worker_thread+0x4d/0x480 Mar 26 17:06:52 pixel kernel: [175205.009374] [] ? process_one_work+0x410/0x410 Mar 26 17:06:52 pixel kernel: [175205.009376] [] ? kthread+0xcd/0xf0 Mar 26 17:06:52 pixel kernel: [175205.009378] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:06:52 pixel kernel: [175205.009380] [] ? ret_from_fork+0x3f/0x70 Mar 26 17:06:52 pixel kernel: [175205.009383] [] ? kthread_create_on_node+0x190/0x190 Mar 26 17:07:04 pixel kernel: [175679.231157] [drm:connected_sink_compute_bpp] [CONNECTOR:34:eDP-1] checking for sink bpp constrains Mar 26 17:07:04 pixel kernel: [175679.231160] [drm:connected_sink_compute_bpp] clamping display bpp (was 36) to EDID reported max of 24 Mar 26 17:07:04 pixel kernel: [175679.231164] [drm:intel_dp_compute_config] DP link computation with max lane count 4 max bw 270000 pixel clock 285250KHz Mar 26 17:07:04 pixel kernel: [175679.231169] [drm:intel_dp_compute_config] DP link bw 0a rate select 00 lane count 4 clock 270000 bpp 24 Mar 26 17:07:04 pixel kernel: [175679.231170] [drm:intel_dp_compute_config] DP link bw required 684600 available 864000 Mar 26 17:07:04 pixel kernel: [175679.231172] [drm:intel_modeset_pipe_config] hw max bpp: 36, pipe bpp: 24, dithering: 0 Mar 26 17:07:04 pixel kernel: [175679.231175] [drm:intel_dump_pipe_config] [CRTC:21][modeset] config ffff880149f2e400 for pipe A Mar 26 17:07:04 pixel kernel: [175679.231176] [drm:intel_dump_pipe_config] cpu_transcoder: A Mar 26 17:07:04 pixel kernel: [175679.231178] [drm:intel_dump_pipe_config] pipe bpp: 24, dithering: 0 Mar 26 17:07:04 pixel kernel: [175679.231179] [drm:intel_dump_pipe_config] fdi/pch: 0, lanes: 0, gmch_m: 0, gmch_n: 0, link_m: 0, link_n: 0, tu: 0 Mar 26 17:07:04 pixel kernel: [175679.231181] [drm:intel_dump_pipe_config] dp: 1, lanes: 4, gmch_m: 6646806, gmch_n: 8388608, link_m: 553900, link_n: 524288, tu: 64 Mar 26 17:07:04 pixel kernel: [175679.231182] [drm:intel_dump_pipe_config] dp: 1, lanes: 4, gmch_m2: 0, gmch_n2: 0, link_m2: 0, link_n2: 0, tu2: 0 Mar 26 17:07:04 pixel kernel: [175679.231183] [drm:intel_dump_pipe_config] audio: 0, infoframes: 0 Mar 26 17:07:04 pixel kernel: [175679.231184] [drm:intel_dump_pipe_config] requested mode: Mar 26 17:07:04 pixel kernel: [175679.231186] [drm:drm_mode_debug_printmodeline] Modeline 0:"2560x1700" 60 285250 2560 2608 2640 2720 1700 1703 1713 1749 0x0 0xa Mar 26 17:07:04 pixel kernel: [175679.231187] [drm:intel_dump_pipe_config] adjusted mode: Mar 26 17:07:04 pixel kernel: [175679.231189] [drm:drm_mode_debug_printmodeline] Modeline 0:"2560x1700" 60 285250 2560 2608 2640 2720 1700 1703 1713 1749 0x48 0xa Mar 26 17:07:04 pixel kernel: [175679.231191] [drm:intel_dump_crtc_timings] crtc timings: 285250 2560 2608 2640 2720 1700 1703 1713 1749, type: 0x48 flags: 0xa Mar 26 17:07:04 pixel kernel: [175679.231192] [drm:intel_dump_pipe_config] port clock: 270000 Mar 26 17:07:04 pixel kernel: [175679.231193] [drm:intel_dump_pipe_config] pipe src size: 2560x1700 Mar 26 17:07:04 pixel kernel: [175679.231194] [drm:intel_dump_pipe_config] num_scalers: 0, scaler_users: 0x0, scaler_id: 0 Mar 26 17:07:04 pixel kernel: [175679.231195] [drm:intel_dump_pipe_config] gmch pfit: control: 0x00000000, ratios: 0x00000000, lvds border: 0x00000000 Mar 26 17:07:04 pixel kernel: [175679.231196] [drm:intel_dump_pipe_config] pch pfit: pos: 0x00000000, size: 0x00000000, disabled Mar 26 17:07:04 pixel kernel: [175679.231197] [drm:intel_dump_pipe_config] ips: 0 Mar 26 17:07:04 pixel kernel: [175679.231198] [drm:intel_dump_pipe_config] double wide: 0 Mar 26 17:07:04 pixel kernel: [175679.231200] [drm:intel_dump_pipe_config] dpll_hw_state: dpll: 0x0, dpll_md: 0x0, fp0: 0x0, fp1: 0x0 Mar 26 17:07:04 pixel kernel: [175679.231200] [drm:intel_dump_pipe_config] planes on this crtc Mar 26 17:07:04 pixel kernel: [175679.231202] [drm:intel_dump_pipe_config] STANDARD PLANE:18 plane: 0.0 idx: 0 enabled Mar 26 17:07:04 pixel kernel: [175679.231203] [drm:intel_dump_pipe_config] FB:47, fb = 2560x1700 format = 0x34325258<7>[175679.231205] [drm:intel_dump_pipe_config] scaler:0 src (0, 0) 2560x1700 dst (0, 0) 2560x1700 Mar 26 17:07:04 pixel kernel: [175679.231206] [drm:intel_dump_pipe_config] CURSOR PLANE:20 plane: 0.1 idx: 1 enabled Mar 26 17:07:04 pixel kernel: [175679.231208] [drm:intel_dump_pipe_config] FB:82, fb = 64x64 format = 0x34325241<7>[175679.231209] [drm:intel_dump_pipe_config] scaler:0 src (0, 0) 64x64 dst (830, 818) 64x64 Mar 26 17:07:04 pixel kernel: [175679.231211] [drm:intel_dump_pipe_config] STANDARD PLANE:22 plane: 0.1 idx: 2 disabled, scaler_id = 0 Mar 26 17:07:04 pixel kernel: [175679.231252] [drm:edp_panel_vdd_on] Turning eDP port A VDD on Mar 26 17:07:04 pixel kernel: [175679.231258] [drm:edp_panel_vdd_on] PP_STATUS: 0x80000008 PP_CONTROL: 0xabcd000f Mar 26 17:07:04 pixel kernel: [175679.231260] [drm:intel_edp_backlight_off] Mar 26 17:07:04 pixel kernel: [175679.431353] [drm:intel_panel_actually_set_backlight] set backlight PWM = 0 Mar 26 17:07:04 pixel kernel: [175679.431515] [drm:edp_panel_off] Turn eDP port A panel power off Mar 26 17:07:04 pixel kernel: [175679.431518] [drm:wait_panel_off] Wait for panel power off time -- greg