linux-kernel - Re: [Bug #13306] hibernate slow on _second

lists.openwall.net		lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC
Open Source and information security mailing list archives

Hash Suite: Windows password security audit tool. GUI, reports in PDF.

[<prev] [next>] [<thread-prev] [thread-next>] [day] [month] [year] [list]

Message-Id: <1244125570.22576.78.camel@johannes.local>
Date:	Thu, 04 Jun 2009 16:26:10 +0200
From:	Johannes Berg <johannes@...solutions.net>
To:	"Rafael J. Wysocki" <rjw@...k.pl>
Cc:	Linux Kernel Mailing List <linux-kernel@...r.kernel.org>,
	Kernel Testers List <kernel-testers@...r.kernel.org>,
	Steven Rostedt <srostedt@...hat.com>
Subject: Re: [Bug #13306] hibernate slow on _second_ run

Alright, I have managed to trace this.

http://johannes.sipsolutions.net/files/hibernate-delay-dmesg.txt

has the dmesg, you can clearly see the delay:
[50265.143330] ACPI: Waking up from system sleep state S4
[50265.679141] HDA Intel 0000:00:08.0: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002)
[50265.689525] forcedeth 0000:00:0a.0: restoring config space at offset 0x1 (was 0xb00003, writing 0xb00007)
[50265.699775] ahci 0000:00:0b.0: restoring config space at offset 0x1 (was 0xb00403, writing 0xb00407)
[50286.294910] pci 0000:00:03.2: PME# disabled

I managed to get an entire function trace between

[50265.143330] ACPI: Waking up from system sleep state S4

and

[50290.439040] Restarting tasks ... done.

which I've uploaded to

http://johannes.sipsolutions.net/files/hibernate-delay-trace.bz2

(WARNING: uncompresses to 574MiB!)

I'm not sure why the timing in there doesn't show the delay, Steven was
taking a look at that.

johannes

Download attachment "signature.asc" of type "application/pgp-signature" (802 bytes)