[Bug 652036] Re: MacBook4,1 resume broken in Meverick

j^ j at mailb.org
Thu Oct 7 21:07:09 UTC 2010


tested again with current kernel, this time computer woke up, after one
minute, here the syslog for that time:

Oct  7 22:58:00 Ubuntu NetworkManager[1150]: <info> sleep requested (sleeping: no  enabled: yes)
Oct  7 22:58:00 Ubuntu NetworkManager[1150]: <info> sleeping or disabling...
Oct  7 22:58:00 Ubuntu NetworkManager[1150]: <info> (wlan0): now unmanaged
Oct  7 22:58:00 Ubuntu NetworkManager[1150]: <info> (wlan0): device state change: 8 -> 1 (reason 37)
Oct  7 22:58:00 Ubuntu NetworkManager[1150]: <info> (wlan0): deactivating device (reason: 37).
Oct  7 22:58:01 Ubuntu NetworkManager[1150]: <info> (wlan0): canceled DHCP transaction, DHCP client pid 1459
Oct  7 22:58:01 Ubuntu avahi-daemon[1127]: Withdrawing address record for 192.168.0.21 on wlan0.
Oct  7 22:58:01 Ubuntu avahi-daemon[1127]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.21.
Oct  7 22:58:01 Ubuntu avahi-daemon[1127]: Interface wlan0.IPv4 no longer relevant for mDNS.
Oct  7 22:58:01 Ubuntu NetworkManager[1150]: <info> (wlan0): cleaning up...
Oct  7 22:58:01 Ubuntu NetworkManager[1150]: <info> (wlan0): taking down device.
Oct  7 22:58:01 Ubuntu avahi-daemon[1127]: Interface wlan0.IPv6 no longer relevant for mDNS.
Oct  7 22:58:01 Ubuntu avahi-daemon[1127]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::hidden.
Oct  7 22:58:01 Ubuntu avahi-daemon[1127]: Withdrawing address record for fe80::hidden on wlan0.
Oct  7 22:58:01 Ubuntu NetworkManager[1150]: <info> (eth0): now unmanaged
Oct  7 22:58:01 Ubuntu NetworkManager[1150]: <info> (eth0): device state change: 2 -> 1 (reason 37)
Oct  7 22:58:01 Ubuntu NetworkManager[1150]: <info> (eth0): cleaning up...
Oct  7 22:58:01 Ubuntu NetworkManager[1150]: <info> (eth0): taking down device.
Oct  7 22:58:01 Ubuntu kernel: [  176.591745] sky2 0000:03:00.0: eth0: disabling interface
Oct  7 22:58:01 Ubuntu postfix/master[1823]: reload -- version 2.7.1, configuration /etc/postfix
Oct  7 22:58:01 Ubuntu kernel: [  177.145977] PM: Syncing filesystems ... done.
Oct  7 22:58:01 Ubuntu kernel: [  177.150336] PM: Preparing system for mem sleep
Oct  7 22:59:50 Ubuntu rtkit-daemon[3187]: The canary thread is apparently starving. Taking action.
Oct  7 22:59:50 Ubuntu kernel: [  177.376320] Freezing user space processes ... (elapsed 0.01 seconds) done.
Oct  7 22:59:50 Ubuntu rtkit-daemon[3187]: Demoting known real-time threads.
Oct  7 22:59:50 Ubuntu rtkit-daemon[3187]: Successfully demoted thread 3232 of process 3185 (n/a).
Oct  7 22:59:50 Ubuntu rtkit-daemon[3187]: Successfully demoted thread 3228 of process 3185 (n/a).
Oct  7 22:59:50 Ubuntu rtkit-daemon[3187]: Successfully demoted thread 3185 of process 3185 (n/a).
Oct  7 22:59:50 Ubuntu rtkit-daemon[3187]: Demoted 3 threads.
Oct  7 22:59:50 Ubuntu kernel: [  177.392071] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Oct  7 22:59:50 Ubuntu kernel: [  177.408103] PM: Entering mem sleep
Oct  7 22:59:50 Ubuntu kernel: [  177.408221] Suspending console(s) (use no_console_suspend to debug)
Oct  7 22:59:50 Ubuntu kernel: [  177.409128] sd 2:0:0:0: [sda] Synchronizing SCSI cache
Oct  7 22:59:50 Ubuntu kernel: [  177.409553] ACPI handle has no context!
Oct  7 22:59:50 Ubuntu kernel: [  177.410684] btusb_intr_complete: hci0 urb efd93800 failed to resubmit (1)
Oct  7 22:59:50 Ubuntu kernel: [  177.411689] btusb_bulk_complete: hci0 urb efd93700 failed to resubmit (1)
Oct  7 22:59:50 Ubuntu kernel: [  177.412688] btusb_bulk_complete: hci0 urb efd93300 failed to resubmit (1)
Oct  7 22:59:50 Ubuntu kernel: [  177.413210] ndiswrapper (mp_set_power_state:366): couldn't set wake-on-lan options: 0x0, C0010015
Oct  7 22:59:50 Ubuntu kernel: [  177.413212] sky2 0000:03:00.0: PME# enabled
Oct  7 22:59:50 Ubuntu kernel: [  177.413220] sky2 0000:03:00.0: wake-up capability enabled by ACPI
Oct  7 22:59:50 Ubuntu kernel: [  177.415586] ata_piix 0000:00:1f.1: PCI INT A disabled
Oct  7 22:59:50 Ubuntu kernel: [  177.415734] ata_piix 0000:00:1f.1: power state changed by ACPI to D3
Oct  7 22:59:50 Ubuntu kernel: [  177.415747] uhci_hcd 0000:00:1d.1: PCI INT B disabled
Oct  7 22:59:50 Ubuntu kernel: [  177.415759] uhci_hcd 0000:00:1d.0: PCI INT A disabled
Oct  7 22:59:50 Ubuntu kernel: [  177.415815] pciehp 0000:00:1c.0:pcie04: pciehp_suspend ENTRY
Oct  7 22:59:50 Ubuntu kernel: [  177.415845] ehci_hcd 0000:00:1a.7: PCI INT C disabled
Oct  7 22:59:50 Ubuntu kernel: [  177.415857] uhci_hcd 0000:00:1a.1: PCI INT B disabled
Oct  7 22:59:50 Ubuntu kernel: [  177.429072] pciehp 0000:00:1c.4:pcie04: pciehp_suspend ENTRY
Oct  7 22:59:50 Ubuntu kernel: [  177.429100] uhci_hcd 0000:00:1a.0: PCI INT A disabled
Oct  7 22:59:50 Ubuntu kernel: [  177.429113] uhci_hcd 0000:00:1d.2: PCI INT C disabled
Oct  7 22:59:50 Ubuntu kernel: [  177.440039] ehci_hcd 0000:00:1d.7: PCI INT D disabled
Oct  7 22:59:50 Ubuntu kernel: [  177.520092] HDA Intel 0000:00:1b.0: PCI INT A disabled
Oct  7 22:59:50 Ubuntu kernel: [  177.536028] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 120.207 msecs
Oct  7 22:59:50 Ubuntu kernel: [  177.547122] sd 2:0:0:0: [sda] Stopping disk
Oct  7 22:59:50 Ubuntu kernel: [  177.568046] PM: suspend of drv:sky2 dev:0000:03:00.0 complete after 157.991 msecs
Oct  7 22:59:50 Ubuntu kernel: [  177.568057] pciehp 0000:00:1c.5:pcie04: pciehp_suspend ENTRY
Oct  7 22:59:50 Ubuntu kernel: [  177.568063] PM: suspend of drv:pcieport dev:0000:00:1c.5 complete after 152.298 msecs
Oct  7 22:59:50 Ubuntu kernel: [  178.507920] PM: suspend of drv:sd dev:2:0:0:0 complete after 1098.798 msecs
Oct  7 22:59:50 Ubuntu kernel: [  178.507937] PM: suspend of drv:scsi dev:target2:0:0 complete after 1098.300 msecs
Oct  7 22:59:50 Ubuntu kernel: [  178.507945] PM: suspend of drv:scsi dev:host2 complete after 1097.938 msecs
Oct  7 22:59:50 Ubuntu kernel: [  178.508067] ata_piix 0000:00:1f.2: PCI INT B disabled
Oct  7 22:59:50 Ubuntu kernel: [  178.524025] PM: suspend of drv:ata_piix dev:0000:00:1f.2 complete after 1108.546 msecs
Oct  7 22:59:50 Ubuntu kernel: [  178.524042] PM: suspend of drv: dev:pci0000:00 complete after 1107.675 msecs
Oct  7 22:59:50 Ubuntu kernel: [  178.524053] PM: suspend of devices complete after 1115.566 msecs
Oct  7 22:59:50 Ubuntu kernel: [  178.524055] PM: suspend devices took 1.116 seconds
Oct  7 22:59:50 Ubuntu kernel: [  178.556236] PM: late suspend of devices complete after 32.176 msecs
Oct  7 22:59:50 Ubuntu kernel: [  178.576045] ACPI: Preparing to enter system sleep state S3
Oct  7 22:59:50 Ubuntu kernel: [  178.588092] PM: Saving platform NVS memory
Oct  7 22:59:50 Ubuntu kernel: [  178.645787] Disabling non-boot CPUs ...
Oct  7 22:59:50 Ubuntu kernel: [  178.748041] CPU 1 is now offline
Oct  7 22:59:50 Ubuntu kernel: [  178.748045] SMP alternatives: switching to UP code
Oct  7 22:59:50 Ubuntu kernel: [  178.754196] Extended CMOS year: 2000
Oct  7 22:59:50 Ubuntu kernel: [  178.754196] Back to C!
Oct  7 22:59:50 Ubuntu kernel: [  178.754196] PM: Restoring platform NVS memory
Oct  7 22:59:50 Ubuntu kernel: [  178.754196] Extended CMOS year: 2000
Oct  7 22:59:50 Ubuntu kernel: [  178.754196] Enabling non-boot CPUs ...
Oct  7 22:59:50 Ubuntu kernel: [  178.754196] SMP alternatives: switching to SMP code
Oct  7 22:59:50 Ubuntu kernel: [  178.760058] Booting Node 0 Processor 1 APIC 0x1
Oct  7 22:59:50 Ubuntu kernel: [  178.753850] Initializing CPU#1
Oct  7 22:59:50 Ubuntu kernel: [  178.872417] CPU1 is up
Oct  7 22:59:50 Ubuntu kernel: [  178.873832] ACPI: Waking up from system sleep state S3
Oct  7 22:59:50 Ubuntu kernel: [  179.132197] i915 0000:00:02.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
Oct  7 22:59:50 Ubuntu kernel: [  179.132204] i915 0000:00:02.0: restoring config space at offset 0x8 (was 0x1, writing 0x6111)
Oct  7 22:59:50 Ubuntu kernel: [  179.132208] i915 0000:00:02.0: restoring config space at offset 0x6 (was 0xc, writing 0x8000000c)
Oct  7 22:59:50 Ubuntu kernel: [  179.132213] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407)
Oct  7 22:59:50 Ubuntu kernel: [  179.132238] pci 0000:00:02.1: restoring config space at offset 0x4 (was 0x4, writing 0x90200004)
Oct  7 22:59:50 Ubuntu kernel: [  179.132242] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007)
Oct  7 22:59:50 Ubuntu kernel: [  179.132254] uhci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x100, writing 0x10a)
Oct  7 22:59:50 Ubuntu kernel: [  179.132268] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x8 (was 0x1, writing 0x60c1)
Oct  7 22:59:50 Ubuntu kernel: [  179.132281] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001)
Oct  7 22:59:50 Ubuntu kernel: [  179.132295] uhci_hcd 0000:00:1a.1: restoring config space at offset 0xf (was 0x200, writing 0x20b)
Oct  7 22:59:50 Ubuntu kernel: [  179.132309] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x8 (was 0x1, writing 0x60a1)
Oct  7 22:59:50 Ubuntu kernel: [  179.132323] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001)
Oct  7 22:59:50 Ubuntu kernel: [  179.132344] ehci_hcd 0000:00:1a.7: restoring config space at offset 0xf (was 0x300, writing 0x309)
Oct  7 22:59:50 Ubuntu kernel: [  179.132363] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x4 (was 0x0, writing 0x90704c00)
Oct  7 22:59:50 Ubuntu kernel: [  179.132371] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002)
Oct  7 22:59:50 Ubuntu kernel: [  179.132405] HDA Intel 0000:00:1b.0: restoring config space at offset 0xf (was 0x100, writing 0x10a)
Oct  7 22:59:50 Ubuntu kernel: [  179.132425] HDA Intel 0000:00:1b.0: restoring config space at offset 0x4 (was 0x4, writing 0x90700004)
Oct  7 22:59:50 Ubuntu kernel: [  179.132429] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x40)
Oct  7 22:59:50 Ubuntu kernel: [  179.132436] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100004, writing 0x100002)
Oct  7 22:59:50 Ubuntu kernel: [  179.132470] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x100, writing 0x1ff)
Oct  7 22:59:50 Ubuntu kernel: [  179.132482] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0x90919081)
Oct  7 22:59:50 Ubuntu kernel: [  179.132487] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0x90609060)
Oct  7 22:59:50 Ubuntu kernel: [  179.132492] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x0, writing 0x2020)
Oct  7 22:59:50 Ubuntu kernel: [  179.132497] pcieport 0000:00:1c.0: restoring config space at offset 0x6 (was 0x0, writing 0x10100)
Oct  7 22:59:50 Ubuntu kernel: [  179.132504] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810040)
Oct  7 22:59:50 Ubuntu kernel: [  179.132511] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
Oct  7 22:59:50 Ubuntu kernel: [  179.132561] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x1ff)
Oct  7 22:59:50 Ubuntu kernel: [  179.132573] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0x90019001)
Oct  7 22:59:50 Ubuntu kernel: [  179.132578] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0x90509050)
Oct  7 22:59:50 Ubuntu kernel: [  179.132583] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x20000000, writing 0x3030)
Oct  7 22:59:50 Ubuntu kernel: [  179.132588] pcieport 0000:00:1c.4: restoring config space at offset 0x6 (was 0x0, writing 0x20200)
Oct  7 22:59:50 Ubuntu kernel: [  179.132596] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810040)
Oct  7 22:59:50 Ubuntu kernel: [  179.132602] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
Oct  7 22:59:50 Ubuntu kernel: [  179.132652] pcieport 0000:00:1c.5: restoring config space at offset 0xf (was 0x200, writing 0x2ff)
Oct  7 22:59:50 Ubuntu kernel: [  179.132664] pcieport 0000:00:1c.5: restoring config space at offset 0x9 (was 0x10001, writing 0x90b190a1)
Oct  7 22:59:50 Ubuntu kernel: [  179.132669] pcieport 0000:00:1c.5: restoring config space at offset 0x8 (was 0x0, writing 0x90409040)
Oct  7 22:59:50 Ubuntu kernel: [  179.132674] pcieport 0000:00:1c.5: restoring config space at offset 0x7 (was 0x20000000, writing 0x5050)
Oct  7 22:59:50 Ubuntu kernel: [  179.132679] pcieport 0000:00:1c.5: restoring config space at offset 0x6 (was 0x0, writing 0x30300)
Oct  7 22:59:50 Ubuntu kernel: [  179.132687] pcieport 0000:00:1c.5: restoring config space at offset 0x3 (was 0x810000, writing 0x810040)
Oct  7 22:59:50 Ubuntu kernel: [  179.132693] pcieport 0000:00:1c.5: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
Oct  7 22:59:50 Ubuntu kernel: [  179.132732] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
Oct  7 22:59:50 Ubuntu kernel: [  179.132746] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x6081)
Oct  7 22:59:50 Ubuntu kernel: [  179.132759] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001)
Oct  7 22:59:50 Ubuntu kernel: [  179.132772] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x205)
Oct  7 22:59:50 Ubuntu kernel: [  179.132786] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x6061)
Oct  7 22:59:50 Ubuntu kernel: [  179.132799] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001)
Oct  7 22:59:50 Ubuntu kernel: [  179.132812] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x309)
Oct  7 22:59:50 Ubuntu kernel: [  179.132826] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x6041)
Oct  7 22:59:50 Ubuntu kernel: [  179.132840] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001)
Oct  7 22:59:50 Ubuntu kernel: [  179.132861] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40a)
Oct  7 22:59:50 Ubuntu kernel: [  179.132880] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0x90704800)
Oct  7 22:59:50 Ubuntu kernel: [  179.132888] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002)
Oct  7 22:59:50 Ubuntu kernel: [  179.132962] pci 0000:00:1e.0: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.133017] pci 0000:00:1e.0: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.133027] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x0, writing 0xff)
Oct  7 22:59:50 Ubuntu kernel: [  179.133040] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
Oct  7 22:59:50 Ubuntu kernel: [  179.133045] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0x90309030)
Oct  7 22:59:50 Ubuntu kernel: [  179.133050] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x228000f0)
Oct  7 22:59:50 Ubuntu kernel: [  179.133055] pci 0000:00:1e.0: restoring config space at offset 0x6 (was 0x0, writing 0x20040400)
Oct  7 22:59:50 Ubuntu kernel: [  179.133065] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007)
Oct  7 22:59:50 Ubuntu kernel: [  179.133158] ata_piix 0000:00:1f.1: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.133187] ata_piix 0000:00:1f.1: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.133212] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800001, writing 0x2800005)
Oct  7 22:59:50 Ubuntu kernel: [  179.133251] ata_piix 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00007)
Oct  7 22:59:50 Ubuntu kernel: [  179.133268] pci 0000:00:1f.3: restoring config space at offset 0xf (was 0x300, writing 0x30a)
Oct  7 22:59:50 Ubuntu kernel: [  179.133288] pci 0000:00:1f.3: restoring config space at offset 0x4 (was 0x0, writing 0x90705000)
Oct  7 22:59:50 Ubuntu kernel: [  179.133296] pci 0000:00:1f.3: restoring config space at offset 0x1 (was 0x2800001, writing 0x2800003)
Oct  7 22:59:50 Ubuntu kernel: [  179.133336] ndiswrapper 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x107)
Oct  7 22:59:50 Ubuntu kernel: [  179.133359] ndiswrapper 0000:02:00.0: restoring config space at offset 0x6 (was 0xc, writing 0x9000000c)
Oct  7 22:59:50 Ubuntu kernel: [  179.133367] ndiswrapper 0000:02:00.0: restoring config space at offset 0x4 (was 0x4, writing 0x90500004)
Oct  7 22:59:50 Ubuntu kernel: [  179.133373] ndiswrapper 0000:02:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x40)
Oct  7 22:59:50 Ubuntu kernel: [  179.133382] ndiswrapper 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100006)
Oct  7 22:59:50 Ubuntu kernel: [  179.133577] sky2 0000:03:00.0: restoring config space at offset 0xf (was 0x100, writing 0x107)
Oct  7 22:59:50 Ubuntu kernel: [  179.133625] sky2 0000:03:00.0: restoring config space at offset 0xc (was 0x0, writing 0xfffe0000)
Oct  7 22:59:50 Ubuntu kernel: [  179.133720] sky2 0000:03:00.0: restoring config space at offset 0x6 (was 0x1, writing 0x5001)
Oct  7 22:59:50 Ubuntu kernel: [  179.133748] sky2 0000:03:00.0: restoring config space at offset 0x4 (was 0x4, writing 0x90400004)
Oct  7 22:59:50 Ubuntu kernel: [  179.133773] sky2 0000:03:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x40)
Oct  7 22:59:50 Ubuntu kernel: [  179.133817] sky2 0000:03:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
Oct  7 22:59:50 Ubuntu kernel: [  179.134102] firewire_ohci 0000:04:03.0: restoring config space at offset 0x4 (was 0x0, writing 0x90300000)
Oct  7 22:59:50 Ubuntu kernel: [  179.134108] firewire_ohci 0000:04:03.0: restoring config space at offset 0x3 (was 0x0, writing 0xf810)
Oct  7 22:59:50 Ubuntu kernel: [  179.134114] firewire_ohci 0000:04:03.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900216)
Oct  7 22:59:50 Ubuntu kernel: [  179.134563] PM: early resume of devices complete after 2.499 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.135058] i915 0000:00:02.0: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.139490] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20
Oct  7 22:59:50 Ubuntu kernel: [  179.139497] uhci_hcd 0000:00:1a.0: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.139522] usb usb3: root hub lost power or was reset
Oct  7 22:59:50 Ubuntu kernel: [  179.139545] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 16 (level, low) -> IRQ 16
Oct  7 22:59:50 Ubuntu kernel: [  179.139551] uhci_hcd 0000:00:1a.1: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.139574] usb usb4: root hub lost power or was reset
Oct  7 22:59:50 Ubuntu kernel: [  179.139596] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 21 (level, low) -> IRQ 21
Oct  7 22:59:50 Ubuntu kernel: [  179.139603] ehci_hcd 0000:00:1a.7: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.139641] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20
Oct  7 22:59:50 Ubuntu kernel: [  179.139647] HDA Intel 0000:00:1b.0: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.139694] HDA Intel 0000:00:1b.0: irq 45 for MSI/MSI-X
Oct  7 22:59:50 Ubuntu kernel: [  179.139734] pciehp 0000:00:1c.0:pcie04: pciehp_resume ENTRY
Oct  7 22:59:50 Ubuntu kernel: [  179.139740] pciehp 0000:00:1c.4:pcie04: pciehp_resume ENTRY
Oct  7 22:59:50 Ubuntu kernel: [  179.139746] pciehp 0000:00:1c.5:pcie04: pciehp_resume ENTRY
Oct  7 22:59:50 Ubuntu kernel: [  179.139757] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
Oct  7 22:59:50 Ubuntu kernel: [  179.139764] uhci_hcd 0000:00:1d.0: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.139793] usb usb5: root hub lost power or was reset
Oct  7 22:59:50 Ubuntu kernel: [  179.139817] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 18 (level, low) -> IRQ 18
Oct  7 22:59:50 Ubuntu kernel: [  179.139831] uhci_hcd 0000:00:1d.1: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.139882] usb usb6: root hub lost power or was reset
Oct  7 22:59:50 Ubuntu kernel: [  179.139907] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 21 (level, low) -> IRQ 21
Oct  7 22:59:50 Ubuntu kernel: [  179.139913] uhci_hcd 0000:00:1d.2: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.139939] usb usb7: root hub lost power or was reset
Oct  7 22:59:50 Ubuntu kernel: [  179.139964] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 20 (level, low) -> IRQ 20
Oct  7 22:59:50 Ubuntu kernel: [  179.140000] ehci_hcd 0000:00:1d.7: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.140406] ata_piix 0000:00:1f.1: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.140437] ata_piix 0000:00:1f.1: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.140468] ata_piix 0000:00:1f.1: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.140497] ata_piix 0000:00:1f.1: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.140504] ata_piix 0000:00:1f.1: PCI INT A -> GSI 21 (level, low) -> IRQ 21
Oct  7 22:59:50 Ubuntu kernel: [  179.140510] ata_piix 0000:00:1f.1: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.140532] ata_piix 0000:00:1f.2: PCI INT B -> GSI 18 (level, low) -> IRQ 18
Oct  7 22:59:50 Ubuntu kernel: [  179.140537] ata_piix 0000:00:1f.2: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.150309] pci 0000:00:1e.0: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.150367] sky2 0000:03:00.0: wake-up capability disabled by ACPI
Oct  7 22:59:50 Ubuntu kernel: [  179.150415] sky2 0000:03:00.0: PME# disabled
Oct  7 22:59:50 Ubuntu kernel: [  179.150821] pci 0000:00:1e.0: power state changed by ACPI to D0
Oct  7 22:59:50 Ubuntu kernel: [  179.150832] pci 0000:00:1e.0: setting latency timer to 64
Oct  7 22:59:50 Ubuntu kernel: [  179.155059] sd 2:0:0:0: [sda] Starting disk
Oct  7 22:59:50 Ubuntu kernel: [  179.237212] firewire_core: skipped bus generations, destroying all nodes
Oct  7 22:59:50 Ubuntu kernel: [  179.245610] PM: resume of drv:battery dev:PNP0C0A:00 complete after 110.654 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.261217] PM: resume of drv:i915 dev:0000:00:02.0 complete after 126.165 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.297100] PM: resume of drv:usb dev:usb5 complete after 142.186 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.297112] PM: resume of drv:hub dev:5-0:1.0 complete after 142.180 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.297142] PM: resume of drv:usb dev:usb4 complete after 142.265 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.297147] PM: resume of drv:hub dev:4-0:1.0 complete after 142.250 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.297167] PM: resume of drv:usb dev:usb6 complete after 142.193 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.297227] PM: resume of drv:hub dev:6-0:1.0 complete after 142.232 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.308873] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Oct  7 22:59:50 Ubuntu kernel: [  179.308876] ata1.00: ACPI cmd ef/03:44:00:00:00:a0 (SET FEATURES) filtered out
Oct  7 22:59:50 Ubuntu kernel: [  179.325532] ata1.00: configured for UDMA/66
Oct  7 22:59:50 Ubuntu kernel: [  179.401138] PM: resume of drv:usb dev:usb3 complete after 246.294 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.401144] PM: resume of drv:usb dev:usb7 complete after 246.130 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.401160] PM: resume of drv:hub dev:3-0:1.0 complete after 246.297 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.401170] PM: resume of drv:hub dev:7-0:1.0 complete after 246.140 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.401175] PM: resume of drv: dev:ep_81 complete after 155.058 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.513124] usb 3-1: reset full speed USB device using uhci_hcd and address 3
Oct  7 22:59:50 Ubuntu kernel: [  179.577192] PM: resume of drv:usb dev:3-1 complete after 421.935 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.577200] PM: resume of drv:btusb dev:3-1:1.0 complete after 421.933 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.577202] PM: resume of drv:usb dev:3-1:1.2 complete after 421.904 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.577206] PM: resume of drv:btusb dev:3-1:1.1 complete after 421.925 msecs
Oct  7 22:59:50 Ubuntu kernel: [  179.737160] firewire_core: rediscovered device fw0
Oct  7 22:59:50 Ubuntu kernel: [  179.837125] usb 7-1: reset low speed USB device using uhci_hcd and address 2
Oct  7 22:59:50 Ubuntu kernel: [  180.144185] PM: resume of drv:usb dev:7-1 complete after 989.044 msecs
Oct  7 22:59:50 Ubuntu kernel: [  180.144212] PM: resume of drv:usbhid dev:7-1:1.0 complete after 989.057 msecs
Oct  7 22:59:50 Ubuntu kernel: [  180.237126] usb 7-2: reset full speed USB device using uhci_hcd and address 3
Oct  7 22:59:50 Ubuntu kernel: [  180.396187] appletouch: Geyser mode initialized.
Oct  7 22:59:50 Ubuntu kernel: [  180.397194] PM: resume of drv:usb dev:7-2 complete after 1242.022 msecs
Oct  7 22:59:50 Ubuntu kernel: [  180.397213] PM: resume of drv:usbhid dev:7-2:1.2 complete after 1241.975 msecs
Oct  7 22:59:50 Ubuntu kernel: [  180.397222] PM: resume of drv:appletouch dev:7-2:1.1 complete after 1242.000 msecs
Oct  7 22:59:50 Ubuntu kernel: [  180.397228] PM: resume of drv:usbhid dev:7-2:1.0 complete after 1242.037 msecs
Oct  7 22:59:50 Ubuntu kernel: [  181.001291] ata3.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Oct  7 22:59:50 Ubuntu kernel: [  181.001294] ata3.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out
Oct  7 22:59:50 Ubuntu kernel: [  181.017310] ata3.00: configured for UDMA/100
Oct  7 22:59:50 Ubuntu kernel: [  181.118634] PM: resume of drv:sd dev:2:0:0:0 complete after 1963.571 msecs
Oct  7 22:59:50 Ubuntu kernel: [  181.118647] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 1963.548 msecs
Oct  7 22:59:50 Ubuntu kernel: [  181.118661] PM: resume of drv:scsi_disk dev:2:0:0:0 complete after 1717.340 msecs
Oct  7 22:59:50 Ubuntu kernel: [  181.119185] PM: resume of devices complete after 1984.598 msecs
Oct  7 22:59:50 Ubuntu kernel: [  241.120137] Unable to load isight firmware
Oct  7 22:59:50 Ubuntu kernel: [  241.120307] PM: resume devices took 61.988 seconds
Oct  7 22:59:50 Ubuntu kernel: [  241.120308] ------------[ cut here ]------------
Oct  7 22:59:50 Ubuntu kernel: [  241.120314] WARNING: at /build/buildd/linux-2.6.35/kernel/power/suspend_test.c:53 suspend_test_finish+0x89/0x90()
Oct  7 22:59:50 Ubuntu kernel: [  241.120316] Hardware name: MacBook4,1
Oct  7 22:59:50 Ubuntu kernel: [  241.120318] Component: resume devices, time: 61988
Oct  7 22:59:50 Ubuntu kernel: [  241.120319] Modules linked in: binfmt_misc rfcomm sco bnep l2cap ip6table_filter ip6_tables ipt_MASQUERADE iptable_nat nf_nat nf_conntrack_ipv4 nf_defrag_ipv4 xt_state nf_conntrack ipt_REJECT xt_tcpudp iptable_filter ip_tables x_tables bridge stp kvm_intel kvm parport_pc ppdev nls_utf8 hfsplus snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd_pcm snd_seq_midi snd_rawmidi i915 snd_seq_midi_event drm_kms_helper wl(P) snd_seq drm snd_timer snd_seq_device snd intel_agp agpgart soundcore snd_page_alloc i2c_algo_bit ndiswrapper lib80211 isight_firmware joydev applesmc led_class hid_apple input_polldev mbp_nvidia_bl appletouch video output btusb bluetooth lp parport usbhid hid btrfs zlib_deflate firewire_ohci firewire_core crc_itu_t sky2 crc32c libcrc32c
Oct  7 22:59:50 Ubuntu kernel: [  241.120363] Pid: 3434, comm: pm-suspend Tainted: P            2.6.35-22-generic #33-Ubuntu
Oct  7 22:59:50 Ubuntu kernel: [  241.120365] Call Trace:
Oct  7 22:59:50 Ubuntu kernel: [  241.120370]  [<c014ac52>] warn_slowpath_common+0x72/0xa0
Oct  7 22:59:50 Ubuntu kernel: [  241.120372]  [<c0182529>] ? suspend_test_finish+0x89/0x90
Oct  7 22:59:50 Ubuntu kernel: [  241.120375]  [<c0182529>] ? suspend_test_finish+0x89/0x90
Oct  7 22:59:50 Ubuntu kernel: [  241.120378]  [<c014ad23>] warn_slowpath_fmt+0x33/0x40
Oct  7 22:59:50 Ubuntu kernel: [  241.120380]  [<c0182529>] suspend_test_finish+0x89/0x90
Oct  7 22:59:50 Ubuntu kernel: [  241.120383]  [<c01822ff>] suspend_devices_and_enter+0xbf/0xf0
Oct  7 22:59:50 Ubuntu kernel: [  241.120385]  [<c01823ed>] enter_state+0xbd/0xf0
Oct  7 22:59:50 Ubuntu kernel: [  241.120387]  [<c0181a5d>] state_store+0x6d/0xb0
Oct  7 22:59:50 Ubuntu kernel: [  241.120389]  [<c01819f0>] ? state_store+0x0/0xb0
Oct  7 22:59:50 Ubuntu kernel: [  241.120393]  [<c03519c0>] kobj_attr_store+0x20/0x30
Oct  7 22:59:50 Ubuntu kernel: [  241.120396]  [<c026fd39>] sysfs_write_file+0x99/0xf0
Oct  7 22:59:50 Ubuntu kernel: [  241.120400]  [<c02186e2>] vfs_write+0xa2/0x190
Oct  7 22:59:50 Ubuntu kernel: [  241.120403]  [<c026fca0>] ? sysfs_write_file+0x0/0xf0
Oct  7 22:59:50 Ubuntu kernel: [  241.120405]  [<c0218fa2>] sys_write+0x42/0x70
Oct  7 22:59:50 Ubuntu kernel: [  241.120409]  [<c05c90a4>] syscall_call+0x7/0xb
Oct  7 22:59:50 Ubuntu kernel: [  241.120411] ---[ end trace aef30b7b90747d97 ]---
Oct  7 22:59:50 Ubuntu kernel: [  241.120459] PM: Finishing wakeup.
Oct  7 22:59:50 Ubuntu kernel: [  241.120461] Restarting tasks ... done.
Oct  7 22:59:50 Ubuntu kernel: [  241.120924] video LNXVIDEO:00: Restoring backlight state
Oct  7 22:59:50 Ubuntu kernel: [  241.155722] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id
Oct  7 22:59:50 Ubuntu acpid: client 1347[0:0] has disconnected
Oct  7 22:59:50 Ubuntu acpid: client connected from 1347[0:0]
Oct  7 22:59:50 Ubuntu acpid: 1 client rule loaded
Oct  7 22:59:50 Ubuntu anacron[3948]: Anacron 2.3 started on 2010-10-07
Oct  7 22:59:50 Ubuntu anacron[3948]: Normal exit (0 jobs run)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> wake requested (sleeping: yes  enabled: yes)
Oct  7 22:59:50 Ubuntu kernel: [  241.193069] Skipping EDID probe due to cached edid
Oct  7 22:59:50 Ubuntu kernel: [  241.195038] ADDRCONF(NETDEV_UP): wlan0: link is not ready
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> waking up and re-enabling...
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): now managed
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): device state change: 1 -> 2 (reason 2)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): bringing up device.
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): preparing device.
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): deactivating device (reason: 2).
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (eth0): now managed
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (eth0): device state change: 1 -> 2 (reason 2)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (eth0): bringing up device.
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (eth0): preparing device.
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (eth0): deactivating device (reason: 2).
Oct  7 22:59:50 Ubuntu kernel: [  241.217599] sky2 0000:03:00.0: eth0: enabling interface
Oct  7 22:59:50 Ubuntu kernel: [  241.217814] ADDRCONF(NETDEV_UP): eth0: link is not ready
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): supplicant interface state:  starting -> ready
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): device state change: 2 -> 3 (reason 42)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) starting connection 'Auto !!!'
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): device state change: 3 -> 4 (reason 0)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): device state change: 4 -> 5 (reason 0)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0/wireless): access point 'Auto !!!' has security, but secrets are required.
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): device state change: 5 -> 6 (reason 0)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): device state change: 6 -> 4 (reason 0)
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Oct  7 22:59:50 Ubuntu NetworkManager[1150]: <info> (wlan0): device state change: 4 -> 5 (reason 0)
Oct  7 22:59:50 Ubuntu bluetoothd[2764]: HCI dev 0 down

-- 
MacBook4,1 resume broken in Meverick
https://bugs.launchpad.net/bugs/652036
You received this bug notification because you are a member of Kernel
Bugs, which is subscribed to linux in ubuntu.




More information about the kernel-bugs mailing list