Mar 20 22:21:49 vino kernel: [ 7125.803140] PM: Syncing filesystems ... done. Mar 20 22:21:49 vino kernel: [ 7125.810246] Freezing user space processes ... (elapsed 0.00 seconds) done. Mar 20 22:21:49 vino kernel: [ 7125.810898] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. Mar 20 22:21:49 vino kernel: [ 7125.810932] Suspending console(s) (use no_console_suspend to debug) Mar 20 22:21:49 vino kernel: [ 7126.260060] sd 0:0:0:0: [sda] Synchronizing SCSI cache Mar 20 22:21:49 vino kernel: [ 7126.279401] sd 0:0:0:0: [sda] Stopping disk Mar 20 22:21:49 vino kernel: [ 7126.588422] wl 0000:03:00.0: PCI INT A disabled Mar 20 22:21:49 vino kernel: [ 7126.600231] wl 0000:03:00.0: power state changed by ACPI to D3 Mar 20 22:21:49 vino kernel: [ 7126.600463] NVRM: RmPowerManagement: 4 Mar 20 22:21:49 vino kernel: [ 7126.660056] HDA Intel 0000:00:08.0: PCI INT A disabled Mar 20 22:21:49 vino kernel: [ 7126.680157] ehci_hcd 0000:00:06.1: PCI INT B disabled Mar 20 22:21:49 vino kernel: [ 7126.700161] ohci_hcd 0000:00:06.0: PCI INT A disabled Mar 20 22:21:49 vino kernel: [ 7126.720120] ohci_hcd 0000:00:06.0: PME# enabled Mar 20 22:21:49 vino kernel: [ 7126.720232] ohci_hcd 0000:00:06.0: wake-up capability enabled by ACPI Mar 20 22:21:49 vino kernel: [ 7126.720235] ohci_hcd 0000:00:06.0: PME# enabled Mar 20 22:21:49 vino kernel: [ 7126.720237] ohci_hcd 0000:00:06.0: wake-up capability enabled by ACPI Mar 20 22:21:49 vino kernel: [ 7126.720270] ehci_hcd 0000:00:04.1: PCI INT B disabled Mar 20 22:21:49 vino kernel: [ 7126.740143] ohci_hcd 0000:00:04.0: PCI INT A disabled Mar 20 22:21:49 vino kernel: [ 7126.760119] ohci_hcd 0000:00:04.0: PME# enabled Mar 20 22:21:49 vino kernel: [ 7126.760205] ohci_hcd 0000:00:04.0: wake-up capability enabled by ACPI Mar 20 22:21:49 vino kernel: [ 7126.760209] ohci_hcd 0000:00:04.0: PME# enabled Mar 20 22:21:49 vino kernel: [ 7126.760211] ohci_hcd 0000:00:04.0: wake-up capability enabled by ACPI Mar 20 22:21:49 vino kernel: [ 7126.760558] PM: suspend devices took 0.950 seconds Mar 20 22:21:49 vino kernel: [ 7126.763540] ACPI: Preparing to enter system sleep state S3 Mar 20 22:21:49 vino kernel: [ 7126.764727] Disabling non-boot CPUs ... Mar 20 22:21:49 vino kernel: [ 7126.870022] CPU 1 is now offline Mar 20 22:21:49 vino kernel: [ 7126.870025] SMP alternatives: switching to UP code Mar 20 22:21:49 vino kernel: [ 7126.900177] CPU1 is down Mar 20 22:21:49 vino kernel: [ 7126.900328] Extended CMOS year: 2000 Mar 20 22:21:49 vino kernel: [ 7126.900328] Extended CMOS year: 2000 Mar 20 22:21:49 vino kernel: [ 7126.900328] Enabling non-boot CPUs ... Mar 20 22:21:49 vino kernel: [ 7126.900328] SMP alternatives: switching to SMP code Mar 20 22:21:49 vino kernel: [ 7126.930669] Booting processor 1/1 ip 6000 Mar 20 22:21:49 vino kernel: [ 7126.774882] Initializing CPU#1 Mar 20 22:21:49 vino kernel: [ 7126.774882] Calibrating delay using timer specific routine.. 3715.18 BogoMIPS (lpj=18575933) Mar 20 22:21:49 vino kernel: [ 7126.774882] CPU: L1 I cache: 32K, L1 D cache: 32K Mar 20 22:21:49 vino kernel: [ 7126.774882] CPU: L2 cache: 6144K Mar 20 22:21:49 vino kernel: [ 7126.774882] CPU 1/1 -> Node 0 Mar 20 22:21:49 vino kernel: [ 7126.774882] CPU: Physical Processor ID: 0 Mar 20 22:21:49 vino kernel: [ 7126.774882] CPU: Processor Core ID: 1 Mar 20 22:21:49 vino kernel: [ 7127.092500] CPU1: Intel(R) Core(TM)2 Duo CPU L9400 @ 1.86GHz stepping 06 Mar 20 22:21:49 vino kernel: [ 7127.130579] CPU1 is up Mar 20 22:21:49 vino kernel: [ 7127.130581] ACPI: Waking up from system sleep state S3 Mar 20 22:21:49 vino kernel: [ 7127.330839] ACPI: EC: non-query interrupt received, switching to interrupt mode Mar 20 22:21:49 vino kernel: [ 7127.499436] ohci_hcd 0000:00:04.0: wake-up capability disabled by ACPI Mar 20 22:21:49 vino kernel: [ 7127.499439] ohci_hcd 0000:00:04.0: PME# disabled Mar 20 22:21:49 vino kernel: [ 7127.499441] ohci_hcd 0000:00:04.0: wake-up capability disabled by ACPI Mar 20 22:21:49 vino kernel: [ 7127.499444] ohci_hcd 0000:00:04.0: PME# disabled Mar 20 22:21:49 vino kernel: [ 7127.510026] ohci_hcd 0000:00:04.0: PCI INT A -> Link[LUS0] -> GSI 22 (level, low) -> IRQ 22 Mar 20 22:21:49 vino kernel: [ 7127.560045] ehci_hcd 0000:00:04.1: enabling device (0000 -> 0002) Mar 20 22:21:49 vino kernel: [ 7127.560049] ehci_hcd 0000:00:04.1: PCI INT B -> Link[LUS2] -> GSI 20 (level, low) -> IRQ 20 Mar 20 22:21:49 vino kernel: [ 7127.560088] ohci_hcd 0000:00:06.0: wake-up capability disabled by ACPI Mar 20 22:21:49 vino kernel: [ 7127.560091] ohci_hcd 0000:00:06.0: PME# disabled Mar 20 22:21:49 vino kernel: [ 7127.560093] ohci_hcd 0000:00:06.0: wake-up capability disabled by ACPI Mar 20 22:21:49 vino kernel: [ 7127.560096] ohci_hcd 0000:00:06.0: PME# disabled Mar 20 22:21:49 vino kernel: [ 7127.580047] ohci_hcd 0000:00:06.0: PCI INT A -> Link[Z000] -> GSI 21 (level, low) -> IRQ 21 Mar 20 22:21:49 vino kernel: [ 7127.630044] ehci_hcd 0000:00:06.1: enabling device (0000 -> 0002) Mar 20 22:21:49 vino kernel: [ 7127.630048] ehci_hcd 0000:00:06.1: PCI INT B -> Link[Z001] -> GSI 19 (level, low) -> IRQ 19 Mar 20 22:21:49 vino kernel: [ 7127.650075] HDA Intel 0000:00:08.0: PCI INT A -> Link[LAZA] -> GSI 17 (level, low) -> IRQ 17 Mar 20 22:21:49 vino kernel: [ 7127.830398] NVRM: RmPowerManagement: 5 Mar 20 22:21:49 vino kernel: [ 7128.819191] wl 0000:03:00.0: power state changed by ACPI to D0 Mar 20 22:21:49 vino kernel: [ 7128.819589] wl 0000:03:00.0: power state changed by ACPI to D0 Mar 20 22:21:49 vino kernel: [ 7128.819791] wl 0000:03:00.0: PCI INT A -> Link[Z00F] -> GSI 23 (level, low) -> IRQ 23 Mar 20 22:21:49 vino kernel: [ 7129.190082] sd 0:0:0:0: [sda] Starting disk Mar 20 22:21:49 vino kernel: [ 7134.432631] ata1: link is slow to respond, please be patient (ready=0) Mar 20 22:21:49 vino kernel: [ 7137.852553] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Mar 20 22:21:49 vino kernel: [ 7142.852552] ata1.00: qc timeout (cmd 0xec) Mar 20 22:21:49 vino kernel: [ 7142.852556] ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4) Mar 20 22:21:49 vino kernel: [ 7143.382551] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Mar 20 22:21:49 vino kernel: [ 7143.383574] ata1.00: configured for UDMA/100 Mar 20 22:21:49 vino kernel: [ 7143.400534] ata1.00: configured for UDMA/100 Mar 20 22:21:49 vino kernel: [ 7143.400537] ata1: EH complete Mar 20 22:21:49 vino kernel: [ 7143.400637] sd 0:0:0:0: [sda] 236978176 512-byte hardware sectors (121333 MB) Mar 20 22:21:49 vino kernel: [ 7143.400657] sd 0:0:0:0: [sda] Write Protect is off Mar 20 22:21:49 vino kernel: [ 7143.400689] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Mar 20 22:21:49 vino kernel: [ 7143.400718] sd 0:0:0:0: [sda] 236978176 512-byte hardware sectors (121333 MB) Mar 20 22:21:49 vino kernel: [ 7143.400734] sd 0:0:0:0: [sda] Write Protect is off Mar 20 22:21:49 vino kernel: [ 7143.400765] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Mar 20 22:21:49 vino kernel: [ 7143.759136] input: Apple Mac mini infrared remote control driver as /devices/pci0000:00/0000:00:04.0/usb1/1-5/1-5:1.0/input/input14 Mar 20 22:21:49 vino kernel: [ 7143.810426] PM: resume devices took 16.480 seconds Mar 20 22:21:49 vino kernel: [ 7143.810432] ------------[ cut here ]------------ Mar 20 22:21:49 vino kernel: [ 7143.810434] WARNING: at /build/buildd/linux-2.6.27/kernel/power/main.c:176 suspend_test_finish+0x75/0x80() Mar 20 22:21:49 vino kernel: [ 7143.810436] Modules linked in: ipv6 af_packet binfmt_misc sco rfcomm bridge stp bnep l2cap ppdev acpi_cpufreq cpufreq_userspace cpufreq_stats cpufreq_conservative cpufreq_ondemand freq_table cpufreq_powersave sbs sbshc wmi container pci_slot video output iptable_filter ip_tables x_tables mbp_nvidia_bl applesmc led_class input_polldev parport_pc lp parport joydev btusb bluetooth bcm5974 usbhid pcspkr hid evdev nvidia(P) i2c_core ieee80211_crypt_tkip wl(P) ieee80211_crypt snd_pcm_oss snd_mixer_oss shpchp pci_hotplug uvcvideo compat_ioctl32 videodev v4l1_compat snd_hda_intel snd_pcm snd_seq_dummy appleir snd_seq_oss snd_seq_midi_event snd_seq snd_timer snd_seq_device snd soundcore snd_page_alloc battery button ac ext3 jbd mbcache sd_mod crc_t10dif sg ata_generic ahci pata_acpi libata scsi_mod dock ehci_hcd ohci_hcd usbcore thermal processor fan fbcon tileblit font bitblit softcursor fuse Mar 20 22:21:49 vino kernel: [ 7143.810476] Pid: 12621, comm: pm-suspend Tainted: P 2.6.27-11-server #1 Mar 20 22:21:49 vino kernel: [ 7143.810478] Mar 20 22:21:49 vino kernel: [ 7143.810479] Call Trace: Mar 20 22:21:49 vino kernel: [ 7143.810483] [] warn_on_slowpath+0x64/0x90 Mar 20 22:21:49 vino kernel: [ 7143.810487] [] ? printk+0x6c/0x6e Mar 20 22:21:49 vino kernel: [ 7143.810492] [] ? kobject_put+0x27/0x60 Mar 20 22:21:49 vino kernel: [ 7143.810494] [] ? mutex_unlock+0x9/0x20 Mar 20 22:21:49 vino kernel: [ 7143.810497] [] ? dpm_complete+0x18a/0x1a0 Mar 20 22:21:49 vino kernel: [ 7143.810500] [] suspend_test_finish+0x75/0x80 Mar 20 22:21:49 vino kernel: [ 7143.810502] [] suspend_devices_and_enter+0x104/0x1b0 Mar 20 22:21:49 vino kernel: [ 7143.810505] [] enter_state+0xe1/0x110 Mar 20 22:21:49 vino kernel: [ 7143.810507] [] state_store+0xba/0x100 Mar 20 22:21:49 vino kernel: [ 7143.810509] [] kobj_attr_store+0x17/0x20 Mar 20 22:21:49 vino kernel: [ 7143.810512] [] sysfs_write_file+0xca/0x140 Mar 20 22:21:49 vino kernel: [ 7143.810515] [] vfs_write+0xcb/0x130 Mar 20 22:21:49 vino kernel: [ 7143.810518] [] sys_write+0x55/0x90 Mar 20 22:21:49 vino kernel: [ 7143.810521] [] system_call_fastpath+0x16/0x1b Mar 20 22:21:49 vino kernel: [ 7143.810523] Mar 20 22:21:49 vino kernel: [ 7143.810524] ---[ end trace 3285f7103a056dc8 ]--- Mar 20 22:21:49 vino kernel: [ 7143.811341] Restarting tasks ... done. Mar 20 22:21:49 vino kernel: [ 7143.834064] usb 2-1.2: USB disconnect, address 4 Mar 20 22:21:49 vino kernel: [ 7143.972815] usb 2-1.3: USB disconnect, address 5 Mar 20 22:21:51 vino kernel: [ 7146.470089] CE: hpet increasing min_delta_ns to 22500 nsec