Package: linux-2.6 Version: 3.1.8-2 Severity: important Dear Maintainer,
For the last several kernel releases, I have had an intermittent problem suspending my Thinkpad X40. A high fraction of the time, after I suspend (running pm-suspend), the system seems to go to sleep (the screen goes off and the moon light comes on), then comes back by itself a couple minutes later. Of course, the laptop is usually in my bag by this point. Worse, pm-suspend returns a successful 0 exit status, so there's no way I can sound an alert. The logs aren't very helpful, but I hope you can make something of them on at least point me to where I can get more help. In this instance, I ran pm-suspend at 09:13:45, and the system came back on its own at 09:15:22. Here is an excerpt from /var/log/pm-suspend.log: Mon Jan 23 09:13:45 PST 2012: performing suspend KMS graphics driver is in use, skipping quirks. Mon Jan 23 09:15:22 PST 2012: Awake. Here is an excerpt from /var/log/kern.log: Jan 23 09:13:46 apple kernel: [ 4407.572159] PM: Syncing filesystems ... done. Jan 23 09:13:46 apple kernel: [ 4407.574433] PM: Preparing system for mem sleep Jan 23 09:15:22 apple kernel: [ 4407.617900] Freezing user space processes ... (elapsed 0.01 seconds) done. Jan 23 09:15:22 apple kernel: [ 4407.632227] Freezing remaining freezable tasks ... (elapsed 0.11 seconds) done. Jan 23 09:15:22 apple kernel: [ 4407.744205] PM: Entering mem sleep ... Jan 23 09:15:22 apple kernel: [ 4408.352342] ACPI: Preparing to enter system sleep state S3 Jan 23 09:15:22 apple kernel: [ 4408.552054] PM: Saving platform NVS memory Jan 23 09:15:22 apple kernel: [ 4408.552127] Extended CMOS year: 2000 Jan 23 09:15:22 apple kernel: [ 4408.552127] ACPI: Low-level resume complete ... Jan 23 09:15:22 apple kernel: [ 4411.122275] PM: Finishing wakeup. Jan 23 09:15:22 apple kernel: [ 4411.122279] Restarting tasks ... done. (I realize that the syslog timestamp just reflects when the message got to syslogd, and the kernel timestamp isn't updated on resume.) There are no messages indicating that anything went wrong. So I don't understand why it woke up. The pattern of log messages is very similar (just some small ordering differences) whether the resume was at my command or not. Any ideas? I don't have any automated wake-ups, such as wake-on-lan or rtcwake, as far as I know. Complete pm-suspend.log and kern.log from the failed suspend are attached. Andrew -- Package-specific info: ** Version: Linux version 3.1.0-1-486 (Debian 3.1.8-2) (b...@decadent.org.uk) (gcc version 4.6.2 (Debian 4.6.2-11) ) #1 Tue Jan 10 04:55:10 UTC 2012 ** Command line: BOOT_IMAGE=/boot/vmlinuz-3.1.0-1-486 root=UUID=73cf35da-d145-4e4b-b662-3849f9a0ae64 ro ** Not tainted ** Kernel log: [ 4409.648033] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 4409.648042] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [ 4409.648057] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [ 4409.648073] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [ 4409.648085] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 4409.648091] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 4409.648099] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [ 4409.648106] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [ 4409.648114] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [ 4409.648129] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [ 4409.648144] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [ 4409.648155] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [ 4409.648161] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [ 4409.648171] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [ 4409.648186] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [ 4409.648201] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [ 4409.648223] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [ 4409.648244] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xd0100000) [ 4409.648256] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [ 4409.648275] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 4409.648282] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 4409.648342] ata_piix 0000:00:1f.1: restoring config space at offset 0x9 (was 0x0, writing 0x50000000) [ 4409.648358] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800007) [ 4409.648409] snd_intel8x0 0000:00:1f.5: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [ 4409.648442] snd_intel8x0m 0000:00:1f.6: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [ 4409.664026] sdhci-pci 0000:02:00.1: BAR 0: set to [mem 0xd0221000-0xd02210ff] (PCI address [0xd0221000-0xd02210ff]) [ 4409.664051] sdhci-pci 0000:02:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [ 4409.664061] sdhci-pci 0000:02:00.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106) [ 4409.664084] e1000 0000:02:01.0: restoring config space at offset 0xf (was 0xff0100, writing 0xff010b) [ 4409.664101] e1000 0000:02:01.0: restoring config space at offset 0x6 (was 0x1, writing 0x7001) [ 4409.664111] e1000 0000:02:01.0: restoring config space at offset 0x4 (was 0x0, writing 0xd0200000) [ 4409.664119] e1000 0000:02:01.0: restoring config space at offset 0x3 (was 0x0, writing 0x4008) [ 4409.664129] e1000 0000:02:01.0: restoring config space at offset 0x1 (was 0x2300000, writing 0x2300117) [ 4409.664317] PM: early resume of devices complete after 36.261 msecs [ 4409.664514] i915 0000:00:02.0: power state changed by ACPI to D0 [ 4409.664522] i915 0000:00:02.0: power state changed by ACPI to D0 [ 4409.664533] i915 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 4409.664567] i915 0000:00:02.0: setting latency timer to 64 [ 4409.693497] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 4409.693504] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 4409.693516] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 4409.693526] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [ 4409.693550] usb usb2: root hub lost power or was reset [ 4409.693565] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [ 4409.693571] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [ 4409.693580] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [ 4409.693588] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [ 4409.693609] usb usb3: root hub lost power or was reset [ 4409.693624] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 4409.693633] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [ 4409.693654] usb usb4: root hub lost power or was reset [ 4409.693668] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 4409.693676] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 4409.693685] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 23 (level, low) -> IRQ 23 [ 4409.693694] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [ 4409.693750] pci 0000:00:1e.0: setting latency timer to 64 [ 4409.693767] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18 [ 4409.693774] ata_piix 0000:00:1f.1: setting latency timer to 64 [ 4409.693804] snd_intel8x0 0000:00:1f.5: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 4409.693812] snd_intel8x0 0000:00:1f.5: setting latency timer to 64 [ 4409.693846] snd_intel8x0m 0000:00:1f.6: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 4409.693854] snd_intel8x0m 0000:00:1f.6: setting latency timer to 64 [ 4409.696206] sdhci-pci 0000:02:00.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 4409.696213] sdhci-pci 0000:02:00.1: Will use DMA mode even though HW doesn't fully claim to support it. [ 4409.697255] e1000 0000:02:01.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 4409.697272] pci 0000:00:1e.0: wake-up capability disabled by ACPI [ 4409.697280] e1000 0000:02:01.0: PME# disabled [ 4409.697393] ipw2100 0000:02:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [ 4409.735075] sd 0:0:0:0: [sda] Starting disk [ 4409.735958] [drm] capturing error event; look for more information in /debug/dri/0/i915_error_state [ 4409.736009] render error detected, EIR: 0x00000010 [ 4409.736009] [drm:i915_report_and_clear_eir] *ERROR* EIR stuck: 0x00000010, masking [ 4409.737163] render error detected, EIR: 0x00000010 [ 4410.776441] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [ 4410.776451] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [ 4410.776459] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [ 4410.776467] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [ 4410.792266] ata1.00: configured for UDMA/100 [ 4411.034331] PM: resume of devices complete after 1369.943 msecs [ 4411.122275] PM: Finishing wakeup. [ 4411.122279] Restarting tasks ... done. [ 4411.170103] video LNXVIDEO:00: Restoring backlight state [ 4423.304138] eth1: no IPv6 routers present [ 4934.959443] ADDRCONF(NETDEV_UP): eth1: link is not ready [ 4948.588710] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [ 4959.560143] eth1: no IPv6 routers present [ 5005.896989] ADDRCONF(NETDEV_UP): eth1: link is not ready [ 5835.496705] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [ 5845.576031] eth1: no IPv6 routers present [ 5857.484785] ipw2100: Fatal interrupt. Scheduling firmware restart. [ 5858.536956] ADDRCONF(NETDEV_UP): eth1: link is not ready [ 5859.096693] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [ 5869.136035] eth1: no IPv6 routers present [ 5917.759095] ADDRCONF(NETDEV_UP): eth1: link is not ready [ 5922.500720] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [ 5932.688141] eth1: no IPv6 routers present [ 6008.713817] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX [ 6008.714569] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 6010.814559] ADDRCONF(NETDEV_UP): eth1: link is not ready [ 6019.712046] eth0: no IPv6 routers present ** Model information not available ** Loaded modules: acpi_cpufreq mperf cpufreq_userspace cpufreq_stats cpufreq_powersave cpufreq_conservative lib80211_crypt_ccmp nfsd nfs lockd fscache auth_rpcgss nfs_acl sunrpc deflate zlib_deflate ctr twofish_generic twofish_i586 twofish_common camellia serpent blowfish cast5 des_generic xcbc rmd160 sha512_generic sha1_generic hmac crypto_null af_key fuse snd_intel8x0m snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm_oss snd_mixer_oss snd_pcm thinkpad_acpi snd_seq_midi i915 snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_device ipw2100 pcmcia drm_kms_helper drm libipw iTCO_wdt iTCO_vendor_support snd lib80211 snd_page_alloc i2c_i801 cfg80211 rfkill yenta_socket pcmcia_rsrc pcmcia_core i2c_algo_bit rng_core i2c_core shpchp pci_hotplug irda pcspkr soundcore psmouse nvram video button serio_raw battery processor crc_ccitt evdev ac ext3 jbd mbcache sha256_generic cryptd aes_i586 aes_generic cbc dm_crypt dm_mod sd_mod crc_t10dif ata_generic uhci_hcd ata_piix libata scsi_mod ehci_hcd sdhci_pci sdhci usbcore thermal thermal_sys mmc_core e1000 ** PCI devices: 00:00.0 Host bridge [0600]: Intel Corporation 82852/82855 GM/GME/PM/GMV Processor to I/O Controller [8086:3580] (rev 02) Subsystem: IBM ThinkPad R50e [1014:055c] Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort+ >SERR- <PERR- INTx- Latency: 0 Region 0: Memory at <unassigned> (32-bit, prefetchable) Capabilities: <access denied> Kernel driver in use: agpgart-intel 00:00.1 System peripheral [0880]: Intel Corporation 82852/82855 GM/GME/PM/GMV Processor to I/O Controller [8086:3584] (rev 02) Subsystem: IBM ThinkPad R50e [1014:055d] Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 00:00.3 System peripheral [0880]: Intel Corporation 82852/82855 GM/GME/PM/GMV Processor to I/O Controller [8086:3585] (rev 02) Subsystem: IBM ThinkPad R50e [1014:055e] Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 00:02.0 VGA compatible controller [0300]: Intel Corporation 82852/855GM Integrated Graphics Device [8086:3582] (rev 02) (prog-if 00 [VGA controller]) Subsystem: IBM Device [1014:0557] Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx+ Latency: 0 Interrupt: pin A routed to IRQ 16 Region 0: Memory at e0000000 (32-bit, prefetchable) [size=128M] Region 1: Memory at d0000000 (32-bit, non-prefetchable) [size=512K] Region 2: I/O ports at 1800 [size=8] Expansion ROM at <unassigned> [disabled] Capabilities: <access denied> Kernel driver in use: i915 00:02.1 Display controller [0380]: Intel Corporation 82852/855GM Integrated Graphics Device [8086:3582] (rev 02) Subsystem: IBM Device [1014:0557] Control: I/O+ Mem+ BusMaster- SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Region 0: Memory at e8000000 (32-bit, prefetchable) [size=128M] Region 1: Memory at d0080000 (32-bit, non-prefetchable) [size=512K] Capabilities: <access denied> 00:1d.0 USB controller [0c03]: Intel Corporation 82801DB/DBL/DBM (ICH4/ICH4-L/ICH4-M) USB UHCI Controller #1 [8086:24c2] (rev 01) (prog-if 00 [UHCI]) Subsystem: IBM ThinkPad [1014:052d] Control: I/O+ Mem- BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 Interrupt: pin A routed to IRQ 16 Region 4: I/O ports at 1820 [size=32] Kernel driver in use: uhci_hcd 00:1d.1 USB controller [0c03]: Intel Corporation 82801DB/DBL/DBM (ICH4/ICH4-L/ICH4-M) USB UHCI Controller #2 [8086:24c4] (rev 01) (prog-if 00 [UHCI]) Subsystem: IBM ThinkPad [1014:052d] Control: I/O+ Mem- BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 Interrupt: pin B routed to IRQ 19 Region 4: I/O ports at 1840 [size=32] Kernel driver in use: uhci_hcd 00:1d.2 USB controller [0c03]: Intel Corporation 82801DB/DBL/DBM (ICH4/ICH4-L/ICH4-M) USB UHCI Controller #3 [8086:24c7] (rev 01) (prog-if 00 [UHCI]) Subsystem: IBM ThinkPad [1014:052d] Control: I/O+ Mem- BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 Interrupt: pin C routed to IRQ 18 Region 4: I/O ports at 1860 [size=32] Kernel driver in use: uhci_hcd 00:1d.7 USB controller [0c03]: Intel Corporation 82801DB/DBM (ICH4/ICH4-M) USB2 EHCI Controller [8086:24cd] (rev 01) (prog-if 20 [EHCI]) Subsystem: IBM ThinkPad [1014:052e] Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 Interrupt: pin D routed to IRQ 23 Region 0: Memory at d0100000 (32-bit, non-prefetchable) [size=1K] Capabilities: <access denied> Kernel driver in use: ehci_hcd 00:1e.0 PCI bridge [0604]: Intel Corporation 82801 Mobile PCI Bridge [8086:2448] (rev 81) (prog-if 00 [Normal decode]) Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx- Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR+ INTx- Latency: 0 Bus: primary=00, secondary=02, subordinate=05, sec-latency=64 I/O behind bridge: 00003000-00007fff Memory behind bridge: d0200000-dfffffff Prefetchable memory behind bridge: f0000000-f7ffffff Secondary status: 66MHz- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort+ <SERR- <PERR- BridgeCtl: Parity- SERR- NoISA+ VGA- MAbort- >Reset- FastB2B- PriDiscTmr- SecDiscTmr- DiscTmrStat- DiscTmrSERREn- 00:1f.0 ISA bridge [0601]: Intel Corporation 82801DBM (ICH4-M) LPC Interface Bridge [8086:24cc] (rev 01) Control: I/O+ Mem+ BusMaster+ SpecCycle+ MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 00:1f.1 IDE interface [0101]: Intel Corporation 82801DBM (ICH4-M) IDE Controller [8086:24ca] (rev 01) (prog-if 8a [Master SecP PriP]) Subsystem: IBM ThinkPad [1014:052d] Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 Interrupt: pin A routed to IRQ 18 Region 0: I/O ports at 01f0 [size=8] Region 1: I/O ports at 03f4 [size=1] Region 2: I/O ports at 0170 [size=8] Region 3: I/O ports at 0374 [size=1] Region 4: I/O ports at 1810 [size=16] Region 5: Memory at 50000000 (32-bit, non-prefetchable) [size=1K] Kernel driver in use: ata_piix 00:1f.3 SMBus [0c05]: Intel Corporation 82801DB/DBL/DBM (ICH4/ICH4-L/ICH4-M) SMBus Controller [8086:24c3] (rev 01) Subsystem: IBM ThinkPad [1014:052d] Control: I/O+ Mem- BusMaster- SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Interrupt: pin B routed to IRQ 17 Region 4: I/O ports at 1880 [size=32] Kernel driver in use: i801_smbus 00:1f.5 Multimedia audio controller [0401]: Intel Corporation 82801DB/DBL/DBM (ICH4/ICH4-L/ICH4-M) AC'97 Audio Controller [8086:24c5] (rev 01) Subsystem: IBM Device [1014:0558] Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 Interrupt: pin B routed to IRQ 17 Region 0: I/O ports at 1c00 [size=256] Region 1: I/O ports at 18c0 [size=64] Region 2: Memory at d0100c00 (32-bit, non-prefetchable) [size=512] Region 3: Memory at d0100800 (32-bit, non-prefetchable) [size=256] Capabilities: <access denied> Kernel driver in use: snd_intel8x0 00:1f.6 Modem [0703]: Intel Corporation 82801DB/DBL/DBM (ICH4/ICH4-L/ICH4-M) AC'97 Modem Controller [8086:24c6] (rev 01) (prog-if 00 [Generic]) Subsystem: IBM ThinkPad R50e [1014:0559] Control: I/O+ Mem- BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 0 Interrupt: pin B routed to IRQ 17 Region 0: I/O ports at 2400 [size=256] Region 1: I/O ports at 2000 [size=128] Capabilities: <access denied> Kernel driver in use: snd_intel8x0m 02:00.0 CardBus bridge [0607]: Ricoh Co Ltd RL5c476 II [1180:0476] (rev 8d) Subsystem: IBM Device [1014:0555] Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 168 Interrupt: pin A routed to IRQ 16 Region 0: Memory at b0000000 (32-bit, non-prefetchable) [size=4K] Bus: primary=02, secondary=03, subordinate=04, sec-latency=176 Memory window 0: f0000000-f3fff000 (prefetchable) Memory window 1: d4000000-d7fff000 I/O window 0: 00003400-000034ff I/O window 1: 00003000-000030ff BridgeCtl: Parity- SERR- ISA- VGA- MAbort- >Reset- 16bInt+ PostWrite+ 16-bit legacy interface ports at 0001 Kernel driver in use: yenta_cardbus 02:00.1 SD Host controller [0805]: Ricoh Co Ltd R5C822 SD/SDIO/MMC/MS/MSPro Host Adapter [1180:0822] (rev 13) Subsystem: IBM ThinkPad X60s / Z60t [1014:0556] Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 64 Interrupt: pin B routed to IRQ 17 Region 0: Memory at d0221000 (32-bit, non-prefetchable) [size=256] Capabilities: <access denied> Kernel driver in use: sdhci-pci 02:01.0 Ethernet controller [0200]: Intel Corporation 82541GI Gigabit Ethernet Controller [8086:1077] Subsystem: IBM Device [1014:055b] Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV+ VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx- Status: Cap+ 66MHz+ UDF- FastB2B- ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 64 (63750ns min), Cache Line Size: 32 bytes Interrupt: pin A routed to IRQ 20 Region 0: Memory at d0200000 (32-bit, non-prefetchable) [size=128K] Region 2: I/O ports at 7000 [size=64] Capabilities: <access denied> Kernel driver in use: e1000 02:02.0 Network controller [0280]: Intel Corporation PRO/Wireless LAN 2100 3B Mini PCI Adapter [8086:1043] (rev 04) Subsystem: Intel Corporation Device [8086:2551] Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV+ VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx- Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 64 (500ns min, 8500ns max), Cache Line Size: 32 bytes Interrupt: pin A routed to IRQ 21 Region 0: Memory at d0220000 (32-bit, non-prefetchable) [size=4K] Capabilities: <access denied> Kernel driver in use: ipw2100 ** USB devices: Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub Bus 002 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub Bus 003 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub Bus 004 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub -- System Information: Debian Release: wheezy/sid APT prefers unstable APT policy: (500, 'unstable') Architecture: i386 (i686) Kernel: Linux 3.1.0-1-486 Locale: LANG=en_US.UTF-8, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8) Shell: /bin/sh linked to /bin/bash Versions of packages linux-image-3.1.0-1-486 depends on: ii debconf [debconf-2.0] 1.5.41 ii initramfs-tools [linux-initramfs-tool] 0.99 ii linux-base 3.4 ii module-init-tools 3.16-1 Versions of packages linux-image-3.1.0-1-486 recommends: ii firmware-linux-free 3 Versions of packages linux-image-3.1.0-1-486 suggests: pn grub-pc 1.99-14 pn linux-doc-3.1 <none> Versions of packages linux-image-3.1.0-1-486 is related to: pn firmware-bnx2 <none> pn firmware-bnx2x <none> pn firmware-ipw2x00 <none> pn firmware-ivtv <none> pn firmware-iwlwifi <none> pn firmware-linux <none> pn firmware-linux-nonfree <none> pn firmware-qlogic <none> pn firmware-ralink <none> pn xen-hypervisor <none> -- debconf information: linux-image-3.1.0-1-486/postinst/depmod-error-initrd-3.1.0-1-486: false linux-image-3.1.0-1-486/postinst/missing-firmware-3.1.0-1-486: linux-image-3.1.0-1-486/postinst/ignoring-ramdisk: linux-image-3.1.0-1-486/prerm/removing-running-kernel-3.1.0-1-486: true
Mon Jan 23 09:13:45 PST 2012: Running hooks for suspend. Running hook /usr/lib/pm-utils/sleep.d/000kernel-change suspend suspend: /usr/lib/pm-utils/sleep.d/000kernel-change suspend suspend: success. Running hook /usr/lib/pm-utils/sleep.d/00logging suspend suspend: Linux apple 3.1.0-1-486 #1 Tue Jan 10 04:55:10 UTC 2012 i686 GNU/Linux Module Size Used by acpi_cpufreq 12745 1 mperf 12421 1 acpi_cpufreq cpufreq_userspace 12520 0 cpufreq_stats 12645 0 cpufreq_powersave 12422 0 cpufreq_conservative 12987 0 lib80211_crypt_ccmp 12703 2 nfsd 192885 13 nfs 256395 0 lockd 57157 2 nfsd,nfs fscache 27566 1 nfs auth_rpcgss 32012 2 nfsd,nfs nfs_acl 12463 2 nfsd,nfs sunrpc 143085 19 nfsd,nfs,lockd,auth_rpcgss,nfs_acl deflate 12495 0 zlib_deflate 21318 1 deflate ctr 12851 0 twofish_generic 16529 0 twofish_i586 12453 0 twofish_common 20528 2 twofish_generic,twofish_i586 camellia 24892 0 serpent 24847 0 blowfish 16576 0 cast5 24773 0 des_generic 20771 0 xcbc 12629 0 rmd160 16584 0 sha512_generic 16675 0 sha1_generic 12511 0 hmac 12715 0 crypto_null 12636 0 af_key 31004 0 fuse 51958 1 snd_intel8x0m 17503 0 snd_intel8x0 22457 0 snd_ac97_codec 84245 2 snd_intel8x0m,snd_intel8x0 ac97_bus 12462 1 snd_ac97_codec snd_pcm_oss 36194 0 snd_mixer_oss 17668 1 snd_pcm_oss snd_pcm 53270 4 snd_intel8x0m,snd_intel8x0,snd_ac97_codec,snd_pcm_oss thinkpad_acpi 47494 0 snd_seq_midi 12744 0 i915 300010 2 snd_rawmidi 18543 1 snd_seq_midi snd_seq_midi_event 13245 1 snd_seq_midi snd_seq 39764 2 snd_seq_midi,snd_seq_midi_event snd_timer 22478 2 snd_pcm,snd_seq snd_seq_device 13016 3 snd_seq_midi,snd_rawmidi,snd_seq ipw2100 63345 0 pcmcia 32012 0 drm_kms_helper 22699 1 i915 drm 129860 3 i915,drm_kms_helper libipw 26059 1 ipw2100 iTCO_wdt 16945 0 iTCO_vendor_support 12632 1 iTCO_wdt snd 38752 11 snd_intel8x0m,snd_intel8x0,snd_ac97_codec,snd_pcm_oss,snd_mixer_oss,snd_pcm,thinkpad_acpi,snd_rawmidi,snd_seq,snd_timer,snd_seq_device lib80211 12991 2 lib80211_crypt_ccmp,libipw snd_page_alloc 12867 3 snd_intel8x0m,snd_intel8x0,snd_pcm i2c_i801 12670 0 cfg80211 113227 2 ipw2100,libipw rfkill 18715 2 thinkpad_acpi,cfg80211 yenta_socket 22402 0 pcmcia_rsrc 17380 1 yenta_socket pcmcia_core 18063 3 pcmcia,yenta_socket,pcmcia_rsrc i2c_algo_bit 12713 1 i915 rng_core 12580 0 i2c_core 19116 5 i915,drm_kms_helper,drm,i2c_i801,i2c_algo_bit shpchp 26717 0 pci_hotplug 26600 1 shpchp irda 78967 0 pcspkr 12554 0 soundcore 12921 1 snd psmouse 50992 0 nvram 13052 2 thinkpad_acpi video 17412 1 i915 button 12817 1 i915 serio_raw 12777 0 battery 12957 0 processor 23037 2 acpi_cpufreq crc_ccitt 12331 1 irda evdev 13175 12 ac 12552 0 ext3 137919 3 jbd 42496 1 ext3 mbcache 12897 1 ext3 sha256_generic 16709 6 cryptd 14125 0 aes_i586 16608 8 aes_generic 32970 1 aes_i586 cbc 12666 3 dm_crypt 17920 3 dm_mod 53098 7 dm_crypt sd_mod 35425 5 crc_t10dif 12332 1 sd_mod ata_generic 12439 0 uhci_hcd 22506 0 ata_piix 21300 4 libata 121183 2 ata_generic,ata_piix scsi_mod 135633 2 sd_mod,libata ehci_hcd 35684 0 sdhci_pci 13251 0 sdhci 22019 1 sdhci_pci usbcore 100267 3 uhci_hcd,ehci_hcd thermal 13103 0 thermal_sys 17752 3 video,processor,thermal mmc_core 57615 1 sdhci e1000 80664 0 total used free shared buffers cached Mem: 1285508 916204 369304 0 63092 345380 -/+ buffers/cache: 507732 777776 Swap: 974208 0 974208 /usr/lib/pm-utils/sleep.d/00logging suspend suspend: success. Running hook /usr/lib/pm-utils/sleep.d/00powersave suspend suspend: /usr/lib/pm-utils/sleep.d/00powersave suspend suspend: success. Running hook /usr/lib/pm-utils/sleep.d/55NetworkManager suspend suspend: Having NetworkManager put all interaces to sleep...Failed. /usr/lib/pm-utils/sleep.d/55NetworkManager suspend suspend: success. Running hook /usr/lib/pm-utils/sleep.d/60_wpa_supplicant suspend suspend: Selected interface 'eth1' OK /usr/lib/pm-utils/sleep.d/60_wpa_supplicant suspend suspend: success. Running hook /etc/pm/sleep.d/74ifplugd suspend suspend: Network Interface Plugging Daemon...stop eth0...done. /etc/pm/sleep.d/74ifplugd suspend suspend: success. Running hook /usr/lib/pm-utils/sleep.d/75modules suspend suspend: /usr/lib/pm-utils/sleep.d/75modules suspend suspend: success. Running hook /usr/lib/pm-utils/sleep.d/90clock suspend suspend: /usr/lib/pm-utils/sleep.d/90clock suspend suspend: not applicable. Running hook /usr/lib/pm-utils/sleep.d/94cpufreq suspend suspend: /usr/lib/pm-utils/sleep.d/94cpufreq suspend suspend: success. Running hook /usr/lib/pm-utils/sleep.d/95led suspend suspend: /usr/lib/pm-utils/sleep.d/95led suspend suspend: success. Running hook /usr/lib/pm-utils/sleep.d/98video-quirk-db-handler suspend suspend: Kernel modesetting video driver detected, not using quirks. /usr/lib/pm-utils/sleep.d/98video-quirk-db-handler suspend suspend: success. Running hook /usr/lib/pm-utils/sleep.d/99video suspend suspend: /usr/lib/pm-utils/sleep.d/99video suspend suspend: disabled. Mon Jan 23 09:13:45 PST 2012: performing suspend KMS graphics driver is in use, skipping quirks. Mon Jan 23 09:15:22 PST 2012: Awake. Mon Jan 23 09:15:22 PST 2012: Running hooks for resume Running hook /usr/lib/pm-utils/sleep.d/99video resume suspend: /usr/lib/pm-utils/sleep.d/99video resume suspend: disabled. Running hook /usr/lib/pm-utils/sleep.d/98video-quirk-db-handler resume suspend: /usr/lib/pm-utils/sleep.d/98video-quirk-db-handler resume suspend: success. Running hook /usr/lib/pm-utils/sleep.d/95led resume suspend: /usr/lib/pm-utils/sleep.d/95led resume suspend: success. Running hook /usr/lib/pm-utils/sleep.d/94cpufreq resume suspend: /usr/lib/pm-utils/sleep.d/94cpufreq resume suspend: success. Running hook /usr/lib/pm-utils/sleep.d/90clock resume suspend: /usr/lib/pm-utils/sleep.d/90clock resume suspend: not applicable. Running hook /usr/lib/pm-utils/sleep.d/75modules resume suspend: Reloaded unloaded modules. /usr/lib/pm-utils/sleep.d/75modules resume suspend: success. Running hook /etc/pm/sleep.d/74ifplugd resume suspend: Network Interface Plugging Daemon...start eth0...done. /etc/pm/sleep.d/74ifplugd resume suspend: success. Running hook /usr/lib/pm-utils/sleep.d/60_wpa_supplicant resume suspend: Selected interface 'eth1' OK /usr/lib/pm-utils/sleep.d/60_wpa_supplicant resume suspend: success. Running hook /usr/lib/pm-utils/sleep.d/55NetworkManager resume suspend: Having NetworkManager wake interfaces back up...Failed. /usr/lib/pm-utils/sleep.d/55NetworkManager resume suspend: success. Running hook /usr/lib/pm-utils/sleep.d/00powersave resume suspend: /usr/lib/pm-utils/sleep.d/00powersave resume suspend: success. Running hook /usr/lib/pm-utils/sleep.d/00logging resume suspend: /usr/lib/pm-utils/sleep.d/00logging resume suspend: success. Running hook /usr/lib/pm-utils/sleep.d/000kernel-change resume suspend: /usr/lib/pm-utils/sleep.d/000kernel-change resume suspend: success. Mon Jan 23 09:15:24 PST 2012: Finished.
Jan 23 09:13:46 apple kernel: [ 4407.572159] PM: Syncing filesystems ... done. Jan 23 09:13:46 apple kernel: [ 4407.574433] PM: Preparing system for mem sleep Jan 23 09:15:22 apple kernel: [ 4407.617900] Freezing user space processes ... (elapsed 0.01 seconds) done. Jan 23 09:15:22 apple kernel: [ 4407.632227] Freezing remaining freezable tasks ... (elapsed 0.11 seconds) done. Jan 23 09:15:22 apple kernel: [ 4407.744205] PM: Entering mem sleep Jan 23 09:15:22 apple kernel: [ 4407.744233] Suspending console(s) (use no_console_suspend to debug) Jan 23 09:15:22 apple kernel: [ 4407.744934] sd 0:0:0:0: [sda] Stopping disk Jan 23 09:15:22 apple kernel: [ 4407.757938] ACPI handle has no context! Jan 23 09:15:22 apple kernel: [ 4407.757951] sdhci-pci 0000:02:00.1: PCI INT B disabled Jan 23 09:15:22 apple kernel: [ 4407.757957] ACPI handle has no context! Jan 23 09:15:22 apple kernel: [ 4407.758153] snd_intel8x0m 0000:00:1f.6: PCI INT B disabled Jan 23 09:15:22 apple kernel: [ 4407.758423] snd_intel8x0 0000:00:1f.5: PCI INT B disabled Jan 23 09:15:22 apple kernel: [ 4407.758550] ehci_hcd 0000:00:1d.7: PCI INT D disabled Jan 23 09:15:22 apple kernel: [ 4407.758565] uhci_hcd 0000:00:1d.2: PCI INT C disabled Jan 23 09:15:22 apple kernel: [ 4407.758578] uhci_hcd 0000:00:1d.1: PCI INT B disabled Jan 23 09:15:22 apple kernel: [ 4407.758591] uhci_hcd 0000:00:1d.0: PCI INT A disabled Jan 23 09:15:22 apple kernel: [ 4407.758903] i915 0000:00:02.0: PCI INT A disabled Jan 23 09:15:22 apple kernel: [ 4407.772090] i915 0000:00:02.0: power state changed by ACPI to D3 Jan 23 09:15:22 apple kernel: [ 4407.880068] ipw2100 0000:02:02.0: PCI INT A disabled Jan 23 09:15:22 apple kernel: [ 4407.958320] e1000 0000:02:01.0: PCI INT A disabled Jan 23 09:15:22 apple kernel: [ 4407.958330] e1000 0000:02:01.0: PME# enabled Jan 23 09:15:22 apple kernel: [ 4407.958346] pci 0000:00:1e.0: wake-up capability enabled by ACPI Jan 23 09:15:22 apple kernel: [ 4408.316281] ata_piix 0000:00:1f.1: PCI INT A disabled Jan 23 09:15:22 apple kernel: [ 4408.316299] PM: suspend of devices complete after 571.779 msecs Jan 23 09:15:22 apple kernel: [ 4408.332034] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 Jan 23 09:15:22 apple kernel: [ 4408.332090] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 Jan 23 09:15:22 apple kernel: [ 4408.352033] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 Jan 23 09:15:22 apple kernel: [ 4408.352100] PM: late suspend of devices complete after 35.794 msecs Jan 23 09:15:22 apple kernel: [ 4408.352342] ACPI: Preparing to enter system sleep state S3 Jan 23 09:15:22 apple kernel: [ 4408.552054] PM: Saving platform NVS memory Jan 23 09:15:22 apple kernel: [ 4408.552127] Extended CMOS year: 2000 Jan 23 09:15:22 apple kernel: [ 4408.552127] ACPI: Low-level resume complete Jan 23 09:15:22 apple kernel: [ 4408.552127] PM: Restoring platform NVS memory Jan 23 09:15:22 apple kernel: [ 4408.552127] Extended CMOS year: 2000 Jan 23 09:15:22 apple kernel: [ 4408.552206] ACPI: Waking up from system sleep state S3 Jan 23 09:15:22 apple kernel: [ 4409.276324] power_supply BAT0: parent PNP0C0A:00 should not be sleeping Jan 23 09:15:22 apple kernel: [ 4409.628135] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900003, writing 0x980007) Jan 23 09:15:22 apple kernel: [ 4409.628158] pci 0000:00:02.1: restoring config space at offset 0x5 (was 0x0, writing 0xd0080000) Jan 23 09:15:22 apple kernel: [ 4409.628166] pci 0000:00:02.1: restoring config space at offset 0x4 (was 0x8, writing 0xe8000008) Jan 23 09:15:22 apple kernel: [ 4409.628175] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900003) Jan 23 09:15:22 apple kernel: [ 4409.648026] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648033] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648042] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) Jan 23 09:15:22 apple kernel: [ 4409.648057] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1821) Jan 23 09:15:22 apple kernel: [ 4409.648073] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) Jan 23 09:15:22 apple kernel: [ 4409.648085] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648091] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648099] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648106] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648114] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) Jan 23 09:15:22 apple kernel: [ 4409.648129] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1841) Jan 23 09:15:22 apple kernel: [ 4409.648144] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) Jan 23 09:15:22 apple kernel: [ 4409.648155] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648161] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648171] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) Jan 23 09:15:22 apple kernel: [ 4409.648186] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1861) Jan 23 09:15:22 apple kernel: [ 4409.648201] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) Jan 23 09:15:22 apple kernel: [ 4409.648223] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) Jan 23 09:15:22 apple kernel: [ 4409.648244] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xd0100000) Jan 23 09:15:22 apple kernel: [ 4409.648256] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) Jan 23 09:15:22 apple kernel: [ 4409.648275] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648282] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.648342] ata_piix 0000:00:1f.1: restoring config space at offset 0x9 (was 0x0, writing 0x50000000) Jan 23 09:15:22 apple kernel: [ 4409.648358] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800007) Jan 23 09:15:22 apple kernel: [ 4409.648409] snd_intel8x0 0000:00:1f.5: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) Jan 23 09:15:22 apple kernel: [ 4409.648442] snd_intel8x0m 0000:00:1f.6: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Jan 23 09:15:22 apple kernel: [ 4409.664026] sdhci-pci 0000:02:00.1: BAR 0: set to [mem 0xd0221000-0xd02210ff] (PCI address [0xd0221000-0xd02210ff]) Jan 23 09:15:22 apple kernel: [ 4409.664051] sdhci-pci 0000:02:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) Jan 23 09:15:22 apple kernel: [ 4409.664061] sdhci-pci 0000:02:00.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106) Jan 23 09:15:22 apple kernel: [ 4409.664084] e1000 0000:02:01.0: restoring config space at offset 0xf (was 0xff0100, writing 0xff010b) Jan 23 09:15:22 apple kernel: [ 4409.664101] e1000 0000:02:01.0: restoring config space at offset 0x6 (was 0x1, writing 0x7001) Jan 23 09:15:22 apple kernel: [ 4409.664111] e1000 0000:02:01.0: restoring config space at offset 0x4 (was 0x0, writing 0xd0200000) Jan 23 09:15:22 apple kernel: [ 4409.664119] e1000 0000:02:01.0: restoring config space at offset 0x3 (was 0x0, writing 0x4008) Jan 23 09:15:22 apple kernel: [ 4409.664129] e1000 0000:02:01.0: restoring config space at offset 0x1 (was 0x2300000, writing 0x2300117) Jan 23 09:15:22 apple kernel: [ 4409.664317] PM: early resume of devices complete after 36.261 msecs Jan 23 09:15:22 apple kernel: [ 4409.664514] i915 0000:00:02.0: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.664522] i915 0000:00:02.0: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.664533] i915 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 Jan 23 09:15:22 apple kernel: [ 4409.664567] i915 0000:00:02.0: setting latency timer to 64 Jan 23 09:15:22 apple kernel: [ 4409.693497] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.693504] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.693516] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 Jan 23 09:15:22 apple kernel: [ 4409.693526] uhci_hcd 0000:00:1d.0: setting latency timer to 64 Jan 23 09:15:22 apple kernel: [ 4409.693550] usb usb2: root hub lost power or was reset Jan 23 09:15:22 apple kernel: [ 4409.693565] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.693571] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.693580] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 Jan 23 09:15:22 apple kernel: [ 4409.693588] uhci_hcd 0000:00:1d.1: setting latency timer to 64 Jan 23 09:15:22 apple kernel: [ 4409.693609] usb usb3: root hub lost power or was reset Jan 23 09:15:22 apple kernel: [ 4409.693624] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 Jan 23 09:15:22 apple kernel: [ 4409.693633] uhci_hcd 0000:00:1d.2: setting latency timer to 64 Jan 23 09:15:22 apple kernel: [ 4409.693654] usb usb4: root hub lost power or was reset Jan 23 09:15:22 apple kernel: [ 4409.693668] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.693676] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Jan 23 09:15:22 apple kernel: [ 4409.693685] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 23 (level, low) -> IRQ 23 Jan 23 09:15:22 apple kernel: [ 4409.693694] ehci_hcd 0000:00:1d.7: setting latency timer to 64 Jan 23 09:15:22 apple kernel: [ 4409.693750] pci 0000:00:1e.0: setting latency timer to 64 Jan 23 09:15:22 apple kernel: [ 4409.693767] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18 Jan 23 09:15:22 apple kernel: [ 4409.693774] ata_piix 0000:00:1f.1: setting latency timer to 64 Jan 23 09:15:22 apple kernel: [ 4409.693804] snd_intel8x0 0000:00:1f.5: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Jan 23 09:15:22 apple kernel: [ 4409.693812] snd_intel8x0 0000:00:1f.5: setting latency timer to 64 Jan 23 09:15:22 apple kernel: [ 4409.693846] snd_intel8x0m 0000:00:1f.6: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Jan 23 09:15:22 apple kernel: [ 4409.693854] snd_intel8x0m 0000:00:1f.6: setting latency timer to 64 Jan 23 09:15:22 apple kernel: [ 4409.696206] sdhci-pci 0000:02:00.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Jan 23 09:15:22 apple kernel: [ 4409.696213] sdhci-pci 0000:02:00.1: Will use DMA mode even though HW doesn't fully claim to support it. Jan 23 09:15:22 apple kernel: [ 4409.697255] e1000 0000:02:01.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 Jan 23 09:15:22 apple kernel: [ 4409.697272] pci 0000:00:1e.0: wake-up capability disabled by ACPI Jan 23 09:15:22 apple kernel: [ 4409.697280] e1000 0000:02:01.0: PME# disabled Jan 23 09:15:22 apple kernel: [ 4409.697393] ipw2100 0000:02:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 Jan 23 09:15:22 apple kernel: [ 4409.735075] sd 0:0:0:0: [sda] Starting disk Jan 23 09:15:22 apple kernel: [ 4409.735958] [drm] capturing error event; look for more information in /debug/dri/0/i915_error_state Jan 23 09:15:22 apple kernel: [ 4409.736009] render error detected, EIR: 0x00000010 Jan 23 09:15:22 apple kernel: [ 4409.736009] [drm:i915_report_and_clear_eir] *ERROR* EIR stuck: 0x00000010, masking Jan 23 09:15:22 apple kernel: [ 4409.737163] render error detected, EIR: 0x00000010 Jan 23 09:15:22 apple kernel: [ 4410.776441] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Jan 23 09:15:22 apple kernel: [ 4410.776451] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Jan 23 09:15:22 apple kernel: [ 4410.776459] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out Jan 23 09:15:22 apple kernel: [ 4410.776467] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out Jan 23 09:15:22 apple kernel: [ 4410.792266] ata1.00: configured for UDMA/100 Jan 23 09:15:22 apple kernel: [ 4411.034331] PM: resume of devices complete after 1369.943 msecs Jan 23 09:15:22 apple kernel: [ 4411.122275] PM: Finishing wakeup. Jan 23 09:15:22 apple kernel: [ 4411.122279] Restarting tasks ... done. Jan 23 09:15:22 apple kernel: [ 4411.170103] video LNXVIDEO:00: Restoring backlight state