Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1752340AbdG1O4V (ORCPT ); Fri, 28 Jul 2017 10:56:21 -0400 Received: from mga09.intel.com ([134.134.136.24]:9424 "EHLO mga09.intel.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751937AbdG1O4U (ORCPT ); Fri, 28 Jul 2017 10:56:20 -0400 X-ExtLoop1: 1 X-IronPort-AV: E=Sophos;i="5.40,425,1496127600"; d="scan'208";a="998273762" Subject: Re: Suspend-resume failure on Intel Eagle Lake Core2Duo To: Thomas Gleixner Cc: Martin Peres , jeffy.chen@rock-chips.com, linux-kernel@vger.kernel.org References: <4d6b511a-61d5-3c5e-a406-9f71d83670b6@linux.intel.com> <864ff133-815c-0c7f-5e36-fdcc32d0261d@linux.intel.com> <2ecc8ffd-e041-2d53-6f33-e91b3ec701eb@linux.intel.com> <67de95b4-a869-d897-e76c-17c974fb21a6@linux.intel.com> <862ba91e-9185-89a8-da81-63bb42ea565d@intel.com> <7287f845-1012-51af-e696-99d26bcb9b7f@intel.com> From: Tomi Sarvela Organization: Intel Finland Oy - BIC 0357606-4 - Westendinkatu 7, 02160 Espoo Message-ID: <1d2c51f3-a655-2223-68a9-e6d700e7d8e1@intel.com> Date: Fri, 28 Jul 2017 17:55:08 +0300 User-Agent: Mozilla/5.0 (X11; Linux x86_64; rv:52.0) Gecko/20100101 Thunderbird/52.2.1 MIME-Version: 1.0 In-Reply-To: Content-Type: text/plain; charset=utf-8; format=flowed Content-Language: en-US Content-Transfer-Encoding: 7bit Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org Content-Length: 18929 Lines: 404 On 28/07/17 17:50, Thomas Gleixner wrote: > On Fri, 28 Jul 2017, Tomi Sarvela wrote: >> On 28/07/17 17:13, Thomas Gleixner wrote: >>> On Fri, 28 Jul 2017, Tomi Sarvela wrote: >>>> On 28/07/17 16:15, Thomas Gleixner wrote: >>>>> Another question. Is the machine completely dead or not? >>>> >>>> Completely dead. Powerled is on, so host isn't shut down. >>> >>> So that means it does not even power the machine down. That's what I >>> expected least. >>> >>>> Serial or network if don't give any signs of life. >>> >>>> Patch applies cleanly but still getting the same error: >>> >>> Sorry for the noise. I'm an idiot trying to do 10 things at once. This time >>> it actually compiles and links. >>> >>> If the machine does still not powerdown with this applied, then please redo >>> the 'platform' test and grab the trace for that one. >> >> This patch fixes the issue. Below is the dmesg from the testrun (sorry for the >> spam, we're primarily testing i915 issues). > > Can you please retrieve the trace data from: > > /sys/kernel/debug/tracing/trace > > and provide that. The dmesg does not help much. Right, here you go. $ sudo cat /sys/kernel/debug/tracing/trace # tracer: nop # # _-----=> irqs-off # / _----=> need-resched # | / _---=> hardirq/softirq # || / _--=> preempt-depth # ||| / delay # TASK-PID CPU# |||| TIMESTAMP FUNCTION # | | | |||| | | rtcwake-1332 [000] d..1 64.411098: suspend_device_irqs: presuspend 0 state 00400600 rtcwake-1332 [000] d..1 64.411101: suspend_device_irqs: postsuspend 0 state 00400600 rtcwake-1332 [000] d..1 64.411102: suspend_device_irqs: presuspend 1 state 00030000 rtcwake-1332 [000] d..1 64.411103: suspend_device_irqs: postsuspend 1 state 00030000 rtcwake-1332 [000] d..1 64.411104: suspend_device_irqs: presuspend 2 state 00030000 rtcwake-1332 [000] d..1 64.411104: suspend_device_irqs: postsuspend 2 state 00030000 rtcwake-1332 [000] d..1 64.411105: suspend_device_irqs: presuspend 3 state 00030000 rtcwake-1332 [000] d..1 64.411106: suspend_device_irqs: postsuspend 3 state 00030000 rtcwake-1332 [000] d..1 64.411107: suspend_device_irqs: presuspend 4 state 00031000 rtcwake-1332 [000] d..1 64.411107: suspend_device_irqs: postsuspend 4 state 00031000 rtcwake-1332 [000] d..1 64.411108: suspend_device_irqs: presuspend 5 state 00030000 rtcwake-1332 [000] d..1 64.411108: suspend_device_irqs: postsuspend 5 state 00030000 rtcwake-1332 [000] d..1 64.411109: suspend_device_irqs: presuspend 6 state 00030000 rtcwake-1332 [000] d..1 64.411110: suspend_device_irqs: postsuspend 6 state 00030000 rtcwake-1332 [000] d..1 64.411110: suspend_device_irqs: presuspend 7 state 00030000 rtcwake-1332 [000] d..1 64.411111: suspend_device_irqs: postsuspend 7 state 00030000 rtcwake-1332 [000] d..1 64.411112: suspend_device_irqs: presuspend 8 state 00401200 rtcwake-1332 [000] d..1 64.411112: __irq_disable: predisable 8 state 00401200 rtcwake-1332 [000] d..1 64.411113: __irq_disable: postdisable 8 state 00411200 rtcwake-1332 [000] d..1 64.411114: suspend_device_irqs: postsuspend 8 state 00411200 rtcwake-1332 [000] d..1 64.411115: suspend_device_irqs: presuspend 9 state 00403300 rtcwake-1332 [000] d..1 64.411115: __irq_disable: predisable 9 state 00403300 rtcwake-1332 [000] d..1 64.411116: __irq_disable: postdisable 9 state 00413300 rtcwake-1332 [000] d..1 64.411116: suspend_device_irqs: postsuspend 9 state 00413300 rtcwake-1332 [000] d..1 64.411117: suspend_device_irqs: presuspend 10 state 00030000 rtcwake-1332 [000] d..1 64.411118: suspend_device_irqs: postsuspend 10 state 00030000 rtcwake-1332 [000] d..1 64.411119: suspend_device_irqs: presuspend 11 state 00030000 rtcwake-1332 [000] d..1 64.411119: suspend_device_irqs: postsuspend 11 state 00030000 rtcwake-1332 [000] d..1 64.411120: suspend_device_irqs: presuspend 12 state 00030000 rtcwake-1332 [000] d..1 64.411120: suspend_device_irqs: postsuspend 12 state 00030000 rtcwake-1332 [000] d..1 64.411121: suspend_device_irqs: presuspend 13 state 00030000 rtcwake-1332 [000] d..1 64.411122: suspend_device_irqs: postsuspend 13 state 00030000 rtcwake-1332 [000] d..1 64.411122: suspend_device_irqs: presuspend 14 state 00030000 rtcwake-1332 [000] d..1 64.411123: suspend_device_irqs: postsuspend 14 state 00030000 rtcwake-1332 [000] d..1 64.411124: suspend_device_irqs: presuspend 15 state 00030000 rtcwake-1332 [000] d..1 64.411124: suspend_device_irqs: postsuspend 15 state 00030000 rtcwake-1332 [000] d..1 64.411125: suspend_device_irqs: presuspend 16 state 00403200 rtcwake-1332 [000] d..1 64.411126: __irq_disable: predisable 16 state 00403200 rtcwake-1332 [000] d..1 64.411126: __irq_disable: postdisable 16 state 00413200 rtcwake-1332 [000] d..1 64.411127: suspend_device_irqs: postsuspend 16 state 00413200 rtcwake-1332 [000] d..1 64.411128: suspend_device_irqs: presuspend 17 state 00033000 rtcwake-1332 [000] d..1 64.411128: suspend_device_irqs: postsuspend 17 state 00033000 rtcwake-1332 [000] d..1 64.411129: suspend_device_irqs: presuspend 18 state 00032000 rtcwake-1332 [000] d..1 64.411130: suspend_device_irqs: postsuspend 18 state 00032000 rtcwake-1332 [000] d..1 64.411130: suspend_device_irqs: presuspend 19 state 00032000 rtcwake-1332 [000] d..1 64.411131: suspend_device_irqs: postsuspend 19 state 00032000 rtcwake-1332 [000] d..1 64.411132: suspend_device_irqs: presuspend 20 state 00403300 rtcwake-1332 [000] d..1 64.411132: __irq_disable: predisable 20 state 00403300 rtcwake-1332 [000] d..1 64.411133: __irq_disable: postdisable 20 state 00413300 rtcwake-1332 [000] d..1 64.411133: suspend_device_irqs: postsuspend 20 state 00413300 rtcwake-1332 [000] d..1 64.411134: suspend_device_irqs: presuspend 21 state 00403300 rtcwake-1332 [000] d..1 64.411134: __irq_disable: predisable 21 state 00403300 rtcwake-1332 [000] d..1 64.411135: __irq_disable: postdisable 21 state 00413300 rtcwake-1332 [000] d..1 64.411136: suspend_device_irqs: postsuspend 21 state 00413300 rtcwake-1332 [000] d..1 64.411136: suspend_device_irqs: presuspend 22 state 00403300 rtcwake-1332 [000] d..1 64.411137: __irq_disable: predisable 22 state 00403300 rtcwake-1332 [000] d..1 64.411137: __irq_disable: postdisable 22 state 00413300 rtcwake-1332 [000] d..1 64.411138: suspend_device_irqs: postsuspend 22 state 00413300 rtcwake-1332 [000] d..1 64.411139: suspend_device_irqs: presuspend 24 state 00409600 rtcwake-1332 [000] d..1 64.411139: suspend_device_irqs: postsuspend 24 state 00409600 rtcwake-1332 [000] d..1 64.411140: suspend_device_irqs: presuspend 25 state 00409600 rtcwake-1332 [000] d..1 64.411141: suspend_device_irqs: postsuspend 25 state 00409600 rtcwake-1332 [000] d..1 64.411142: suspend_device_irqs: presuspend 26 state 00038000 rtcwake-1332 [000] d..1 64.411142: suspend_device_irqs: postsuspend 26 state 00038000 rtcwake-1332 [000] d..1 64.411143: suspend_device_irqs: presuspend 27 state 00038000 rtcwake-1332 [000] d..1 64.411143: suspend_device_irqs: postsuspend 27 state 00038000 rtcwake-1332 [000] d..1 64.411144: suspend_device_irqs: presuspend 28 state 00401200 rtcwake-1332 [000] d..1 64.411145: __irq_disable: predisable 28 state 00401200 rtcwake-1332 [000] d..1 64.411145: __irq_disable: postdisable 28 state 00411200 rtcwake-1332 [000] d..1 64.411146: suspend_device_irqs: postsuspend 28 state 00411200 rtcwake-1332 [001] d.H1 64.425561: mask_irq: premask 8 state 00411200 rtcwake-1332 [001] d.H1 64.425565: mask_irq: postmask 8 state 00431200 rtcwake-1332 [000] dN.1 64.436605: __irq_disable: predisable 25 state 00409600 rtcwake-1332 [000] dN.1 64.436607: mask_irq: premask 25 state 00419600 rtcwake-1332 [000] dN.1 64.436608: mask_irq: postmask 25 state 00439600 rtcwake-1332 [000] dN.1 64.436609: __irq_disable: postdisable 25 state 00439600 rtcwake-1332 [000] d..1 576460734.868390: __irq_disable: predisable 24 state 00409600 rtcwake-1332 [000] d..1 576460734.868508: __irq_disable: postdisable 24 state 00419600 rtcwake-1332 [000] d..1 576460734.868511: irq_enable: preenable 24 state 00419600 rtcwake-1332 [000] d..1 576460734.868511: unmask_irq: preunmask 24 state 00409600 rtcwake-1332 [000] d..1 576460734.868512: unmask_irq: postunmask 24 state 00409600 rtcwake-1332 [000] d..1 576460734.868512: irq_enable: postenable 24 state 00409600 rtcwake-1332 [000] dNh1 576460734.868533: mask_irq: premask 9 state 00413200 rtcwake-1332 [000] dNh1 576460734.868535: mask_irq: postmask 9 state 00433200 kworker/1:1-1039 [001] d..1 576460734.869322: irq_enable: preenable 25 state 00039600 kworker/1:1-1039 [001] d..1 576460734.869324: unmask_irq: preunmask 25 state 00029600 kworker/1:1-1039 [001] d..1 576460734.869325: unmask_irq: postunmask 25 state 00009600 kworker/1:1-1039 [001] d..1 576460734.869326: irq_enable: postenable 25 state 00009600 kworker/1:1-1039 [001] d..1 576460734.869329: __irq_disable: predisable 25 state 00409600 kworker/1:1-1039 [001] d..1 576460734.869329: __irq_disable: postdisable 25 state 00419600 kworker/1:1-1039 [001] d..1 576460734.869332: irq_enable: preenable 25 state 00419600 kworker/1:1-1039 [001] d..1 576460734.869332: unmask_irq: preunmask 25 state 00409600 kworker/1:1-1039 [001] d..1 576460734.869333: unmask_irq: postunmask 25 state 00409600 kworker/1:1-1039 [001] d..1 576460734.869333: irq_enable: postenable 25 state 00409600 rtcwake-1332 [000] d..1 576460734.882983: resume_irqs: preresume 0 state 00400600 rtcwake-1332 [000] d..1 18446744056.289114: resume_irqs: postresume 0 state 00400600 rtcwake-1332 [000] d..1 18446744056.289116: resume_irqs: preresume 1 state 00030000 rtcwake-1332 [000] d..1 18446744056.289116: resume_irqs: postresume 1 state 00030000 rtcwake-1332 [000] d..1 18446744056.289117: resume_irqs: preresume 2 state 00030000 rtcwake-1332 [000] d..1 18446744056.289118: resume_irqs: postresume 2 state 00030000 rtcwake-1332 [000] d..1 18446744056.289118: resume_irqs: preresume 3 state 00030000 rtcwake-1332 [000] d..1 18446744056.289119: resume_irqs: postresume 3 state 00030000 rtcwake-1332 [000] d..1 18446744056.289120: resume_irqs: preresume 4 state 00031000 rtcwake-1332 [000] d..1 18446744056.289120: resume_irqs: postresume 4 state 00031000 rtcwake-1332 [000] d..1 18446744056.289121: resume_irqs: preresume 5 state 00030000 rtcwake-1332 [000] d..1 18446744056.289122: resume_irqs: postresume 5 state 00030000 rtcwake-1332 [000] d..1 18446744056.289122: resume_irqs: preresume 6 state 00030000 rtcwake-1332 [000] d..1 18446744056.289123: resume_irqs: postresume 6 state 00030000 rtcwake-1332 [000] d..1 18446744056.289124: resume_irqs: preresume 7 state 00030000 rtcwake-1332 [000] d..1 18446744056.289124: resume_irqs: postresume 7 state 00030000 rtcwake-1332 [000] d..1 18446744056.289125: resume_irqs: preresume 8 state 00431200 rtcwake-1332 [000] d..1 18446744056.289126: irq_enable: preenable 8 state 00431200 rtcwake-1332 [000] d..1 18446744056.289126: unmask_irq: preunmask 8 state 00421200 rtcwake-1332 [000] d..1 18446744056.289128: unmask_irq: postunmask 8 state 00401200 rtcwake-1332 [000] d..1 18446744056.289128: irq_enable: postenable 8 state 00401200 rtcwake-1332 [000] d..1 18446744056.289129: resume_irqs: postresume 8 state 00401200 rtcwake-1332 [000] d..1 18446744056.289570: resume_irqs: preresume 9 state 00433200 rtcwake-1332 [000] d..1 18446744056.289571: irq_enable: preenable 9 state 00433200 rtcwake-1332 [000] d..1 18446744056.289571: unmask_irq: preunmask 9 state 00423200 rtcwake-1332 [000] d..1 18446744056.289572: unmask_irq: postunmask 9 state 00403200 rtcwake-1332 [000] d..1 18446744056.289572: irq_enable: postenable 9 state 00403200 rtcwake-1332 [000] d..1 18446744056.289572: resume_irqs: postresume 9 state 00403200 rtcwake-1332 [000] d..1 18446744056.289573: resume_irqs: preresume 10 state 00030000 rtcwake-1332 [000] d..1 18446744056.289573: resume_irqs: postresume 10 state 00030000 rtcwake-1332 [000] d..1 18446744056.289588: resume_irqs: preresume 11 state 00030000 rtcwake-1332 [000] d..1 18446744056.289588: resume_irqs: postresume 11 state 00030000 rtcwake-1332 [000] d..1 18446744056.289589: resume_irqs: preresume 12 state 00030000 rtcwake-1332 [000] d..1 18446744056.289589: resume_irqs: postresume 12 state 00030000 rtcwake-1332 [000] d..1 18446744056.289589: resume_irqs: preresume 13 state 00030000 rtcwake-1332 [000] d..1 18446744056.289590: resume_irqs: postresume 13 state 00030000 rtcwake-1332 [000] d..1 18446744056.289590: resume_irqs: preresume 14 state 00030000 rtcwake-1332 [000] d..1 18446744056.289591: resume_irqs: postresume 14 state 00030000 rtcwake-1332 [000] d..1 18446744056.289591: resume_irqs: preresume 15 state 00030000 rtcwake-1332 [000] d..1 18446744056.289591: resume_irqs: postresume 15 state 00030000 rtcwake-1332 [000] d..1 18446744056.289592: resume_irqs: preresume 16 state 00413200 rtcwake-1332 [000] d..1 18446744056.289592: irq_enable: preenable 16 state 00413200 rtcwake-1332 [000] d..1 18446744056.289593: unmask_irq: preunmask 16 state 00403200 rtcwake-1332 [000] d..1 18446744056.289593: unmask_irq: postunmask 16 state 00403200 rtcwake-1332 [000] d..1 18446744056.289594: irq_enable: postenable 16 state 00403200 rtcwake-1332 [000] d..1 18446744056.289594: resume_irqs: postresume 16 state 00403200 rtcwake-1332 [000] d..1 18446744056.289594: resume_irqs: preresume 17 state 00033000 rtcwake-1332 [000] d..1 18446744056.289595: resume_irqs: postresume 17 state 00033000 rtcwake-1332 [000] d..1 18446744056.289595: resume_irqs: preresume 18 state 00032000 rtcwake-1332 [000] d..1 18446744056.289596: resume_irqs: postresume 18 state 00032000 rtcwake-1332 [000] d..1 18446744056.289596: resume_irqs: preresume 19 state 00032000 rtcwake-1332 [000] d..1 18446744056.289596: resume_irqs: postresume 19 state 00032000 rtcwake-1332 [000] d..1 18446744056.289597: resume_irqs: preresume 20 state 00413200 rtcwake-1332 [000] d..1 18446744056.289597: irq_enable: preenable 20 state 00413200 rtcwake-1332 [000] d..1 18446744056.289598: unmask_irq: preunmask 20 state 00403200 rtcwake-1332 [000] d..1 18446744056.289598: unmask_irq: postunmask 20 state 00403200 rtcwake-1332 [000] d..1 18446744056.289598: irq_enable: postenable 20 state 00403200 rtcwake-1332 [000] d..1 18446744056.289599: resume_irqs: postresume 20 state 00403200 rtcwake-1332 [000] d..1 18446744056.289599: resume_irqs: preresume 21 state 00413200 rtcwake-1332 [000] d..1 18446744056.289600: irq_enable: preenable 21 state 00413200 rtcwake-1332 [000] d..1 18446744056.289600: unmask_irq: preunmask 21 state 00403200 rtcwake-1332 [000] d..1 18446744056.289600: unmask_irq: postunmask 21 state 00403200 rtcwake-1332 [000] d..1 18446744056.289601: irq_enable: postenable 21 state 00403200 rtcwake-1332 [000] d..1 18446744056.289601: resume_irqs: postresume 21 state 00403200 rtcwake-1332 [000] d..1 18446744056.289602: resume_irqs: preresume 22 state 00413200 rtcwake-1332 [000] d..1 18446744056.289602: irq_enable: preenable 22 state 00413200 rtcwake-1332 [000] d..1 18446744056.289602: unmask_irq: preunmask 22 state 00403200 rtcwake-1332 [000] d..1 18446744056.289603: unmask_irq: postunmask 22 state 00403200 rtcwake-1332 [000] d..1 18446744056.289603: irq_enable: postenable 22 state 00403200 rtcwake-1332 [000] d..1 18446744056.289603: resume_irqs: postresume 22 state 00403200 rtcwake-1332 [000] d..1 18446744056.289604: resume_irqs: preresume 24 state 00409600 rtcwake-1332 [000] d..1 18446744056.289604: resume_irqs: postresume 24 state 00409600 rtcwake-1332 [000] d..1 18446744056.289604: resume_irqs: preresume 25 state 00409600 rtcwake-1332 [000] d..1 18446744056.289605: resume_irqs: postresume 25 state 00409600 rtcwake-1332 [000] d..1 18446744056.289605: resume_irqs: preresume 26 state 00038000 rtcwake-1332 [000] d..1 18446744056.289606: resume_irqs: postresume 26 state 00038000 rtcwake-1332 [000] d..1 18446744056.289606: resume_irqs: preresume 27 state 00038000 rtcwake-1332 [000] d..1 18446744056.289606: resume_irqs: postresume 27 state 00038000 rtcwake-1332 [000] d..1 18446744056.289607: resume_irqs: preresume 28 state 00411200 rtcwake-1332 [000] d..1 18446744056.289607: irq_enable: preenable 28 state 00411200 rtcwake-1332 [000] d..1 18446744056.289608: unmask_irq: preunmask 28 state 00401200 rtcwake-1332 [000] d..1 18446744056.289608: unmask_irq: postunmask 28 state 00401200 rtcwake-1332 [000] d..1 18446744056.289608: irq_enable: postenable 28 state 00401200 rtcwake-1332 [000] d..1 18446744056.289609: resume_irqs: postresume 28 state 00401200 Tomi -- Intel Finland Oy - BIC 0357606-4 - Westendinkatu 7, 02160 Espoo