On 1/27/2011 7:53 AM, Alan Stern wrote:
On Wed, 26 Jan 2011, Paul Bender wrote:
If you are not the correct person to report this problem to, could you
point me to the correct person.
Problems like this should also be posted to the linux-usb mailing list.
Thank you for ccing the linux-usb mailing list. I will continue the
thread on the linux-usb mailing list.
I am having a problem in the 2.6.36 and 2.6.37 kernels that I have
traced to kernel commit ff2f078
<http://git.kernel.org/?p=linux/kernel/git/torvalds/linux-2.6.git;a=commit;h=ff2f078>.
You should always provide the commit title in parentheses so that
readers will have some idea what the commit does.
Done.
I don't like to accept patches without understanding the real cause of
> the problem.
I agree completely. Masking a problem is not the right thing to do.
Below is a diagnostic patch you can try out. Please
apply it to a vanilla kernel (i.e., without your own patch) and enable
CONFIG_USB_DEBUG. Then post the dmesg output showing what happens
during a pair of suspend attempts.
Thank you for the patch. I have attached files for good (suspend to RAM
succeeds) and bad behavior (suspend to RAM aborts)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 b7 10 8a 07 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8b 07 8a 11 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8a 11 9b 11 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 08 8a 08 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8a 08 89 08 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8a 08 8a 08 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 08 8a 08 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 09 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 08 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 12 89 08 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 12 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 09 89 12 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 7f (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 69 b5 11 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 12 88 12 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 9a 12 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 91 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 12 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 91 13 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 91 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 13 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 7f 7f 7f (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 6a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 b5 12 88 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 12 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 12 9a 12 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 0a 88 09 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 12 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 87 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 13 87 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 88 0a (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 0a 87 13 (length=5)
Jan 27 09:05:02 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 87 7f (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 6a b5 12 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 12 88 12 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 9a 12 89 09 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 91 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 13 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0b 90 13 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 87 0b (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 91 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 13 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 7f 7f 7f (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 6a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 b4 13 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 13 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 12 9a 12 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 0a 87 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 87 0b (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 87 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 13 87 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 87 0b (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 90 13 87 0b (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 88 0a (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 87 0a 88 0b (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 90 0a 87 13 (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 87 7f (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:03 (none) user.info kernel: lirc_mceusb[2]: rx data: 83 7f 7f 5f 9f 01 01 9f 15 00 00 80 (length=12)
Jan 27 09:05:03 (none) user.debug kernel: lirc_mceusb[2] mceusb_process_ir_data: found control header
Jan 27 09:05:03 (none) local0.info mythfrontend: 2011-01-27 09:05:03.546 NetworkControl: New connection established.
Jan 27 09:05:03 (none) local0.info mythfrontend: 2011-01-27 09:05:03.552 NetworkControl: Client Socket disconnected
Jan 27 09:05:03 (none) user.info kernel: PM: Syncing filesystems ... done.
Jan 27 09:05:35 (none) daemon.notice acpid: client 2170[0:1005] has disconnected
Jan 27 09:05:35 (none) user.warn kernel: Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 27 09:05:35 (none) user.warn kernel: Freezing remaining freezable tasks ... (elapsed 3.45 seconds) done.
Jan 27 09:05:35 (none) user.warn kernel: Suspending console(s) (use no_console_suspend to debug)
Jan 27 09:05:35 (none) user.warn kernel: lirc_mceusb[2]: suspend
Jan 27 09:05:35 (none) user.info kernel: ehci_hcd 0000:00:04.1: PCI INT B disabled
Jan 27 09:05:35 (none) user.info kernel: ehci_hcd 0000:00:02.1: PCI INT B disabled
Jan 27 09:05:35 (none) user.info kernel: ohci_hcd 0000:00:02.0: PCI INT A disabled
Jan 27 09:05:35 (none) user.info kernel: forcedeth 0000:00:0a.0: PCI INT A disabled
Jan 27 09:05:35 (none) user.debug kernel: usb 4-1: usb suspend
Jan 27 09:05:35 (none) user.debug kernel: hub 4-0:1.0: hub_suspend
Jan 27 09:05:35 (none) user.debug kernel: usb usb4: bus suspend
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: suspend root hub
Jan 27 09:05:35 (none) user.info kernel: ohci_hcd 0000:00:04.0: PCI INT A disabled
Jan 27 09:05:35 (none) user.info kernel: HDA Intel 0000:00:07.0: PCI INT A disabled
Jan 27 09:05:35 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D3
Jan 27 09:05:35 (none) user.info kernel: PM: suspend of devices complete after 259.870 msecs
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:04.1: wakeup: 0
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:04.1: --> PCI D3hot
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: wakeup: 1
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: PME# enabled
Jan 27 09:05:35 (none) user.info kernel: ohci_hcd 0000:00:04.0: wake-up capability enabled by ACPI
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: --> PCI D3hot
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:02.1: wakeup: 0
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:02.1: --> PCI D3hot
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:02.0: wakeup: 0
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:02.0: --> PCI D3hot
Jan 27 09:05:35 (none) user.info kernel: PM: late suspend of devices complete after 53.317 msecs
Jan 27 09:05:35 (none) user.info kernel: ACPI: Preparing to enter system sleep state S3
Jan 27 09:05:35 (none) user.info kernel: PM: Saving platform NVS memory
Jan 27 09:05:35 (none) user.warn kernel: Disabling non-boot CPUs ...
Jan 27 09:05:35 (none) user.info kernel: CPU 1 is now offline
Jan 27 09:05:35 (none) user.info kernel: SMP alternatives: switching to UP code
Jan 27 09:05:35 (none) user.info kernel: Extended CMOS year: 2000
Jan 27 09:05:35 (none) user.debug kernel: Back to C!
Jan 27 09:05:35 (none) user.info kernel: PM: Restoring platform NVS memory
Jan 27 09:05:35 (none) user.info kernel: Extended CMOS year: 2000
Jan 27 09:05:35 (none) user.warn kernel: Enabling non-boot CPUs ...
Jan 27 09:05:35 (none) user.info kernel: SMP alternatives: switching to SMP code
Jan 27 09:05:35 (none) user.info kernel: Booting Node 0 Processor 1 APIC 0x1
Jan 27 09:05:35 (none) user.info kernel: Initializing CPU#1
Jan 27 09:05:35 (none) user.warn kernel: CPU1 is up
Jan 27 09:05:35 (none) user.info kernel: ACPI: Waking up from system sleep state S3
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:02.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003)
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:02.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002)
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003)
Jan 27 09:05:35 (none) user.info kernel: ohci_hcd 0000:00:04.0: wake-up capability disabled by ACPI
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: PME# disabled
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:04.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002)
Jan 27 09:05:35 (none) user.debug kernel: HDA Intel 0000:00:07.0: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002)
Jan 27 09:05:35 (none) user.debug kernel: forcedeth 0000:00:0a.0: restoring config space at offset 0x7 (was 0x0, writing 0xfcf7f000)
Jan 27 09:05:35 (none) user.debug kernel: forcedeth 0000:00:0a.0: restoring config space at offset 0x6 (was 0x0, writing 0xfcf7f400)
Jan 27 09:05:35 (none) user.debug kernel: pci 0000:00:0b.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010)
Jan 27 09:05:35 (none) user.debug kernel: nvidia 0000:02:00.0: restoring config space at offset 0xc (was 0xfebe0000, writing 0x0)
Jan 27 09:05:35 (none) user.debug kernel: nvidia 0000:02:00.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100007)
Jan 27 09:05:35 (none) user.info kernel: PM: early resume of devices complete after 1.037 msecs
Jan 27 09:05:35 (none) user.info kernel: ohci_hcd 0000:00:02.0: PCI INT A -> Link[LUB0] -> GSI 20 (level, low) -> IRQ 20
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:02.0: setting latency timer to 64
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:02.0: powerup ports
Jan 27 09:05:35 (none) user.info kernel: ehci_hcd 0000:00:02.1: PCI INT B -> Link[LUB2] -> GSI 22 (level, low) -> IRQ 22
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:02.1: setting latency timer to 64
Jan 27 09:05:35 (none) user.info kernel: ohci_hcd 0000:00:04.0: PCI INT A -> Link[UB11] -> GSI 23 (level, low) -> IRQ 23
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: setting latency timer to 64
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: powerup ports
Jan 27 09:05:35 (none) user.info kernel: ehci_hcd 0000:00:04.1: PCI INT B -> Link[UB12] -> GSI 21 (level, low) -> IRQ 21
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:04.1: setting latency timer to 64
Jan 27 09:05:35 (none) user.debug kernel: pci 0000:00:08.0: setting latency timer to 64
Jan 27 09:05:35 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:05:35 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:05:35 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:05:35 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:05:35 (none) user.info kernel: HDA Intel 0000:00:07.0: PCI INT A -> Link[LAZA] -> GSI 22 (level, low) -> IRQ 22
Jan 27 09:05:35 (none) user.debug kernel: HDA Intel 0000:00:07.0: setting latency timer to 64
Jan 27 09:05:35 (none) user.debug kernel: pci 0000:00:0b.0: setting latency timer to 64
Jan 27 09:05:35 (none) user.info kernel: pci 0000:00:10.0: PCI INT A -> Link[LN0A] -> GSI 19 (level, low) -> IRQ 19
Jan 27 09:05:35 (none) user.debug kernel: pci 0000:00:10.0: setting latency timer to 64
Jan 27 09:05:35 (none) user.info kernel: pci 0000:00:12.0: PCI INT A -> Link[LN2A] -> GSI 18 (level, low) -> IRQ 18
Jan 27 09:05:35 (none) user.debug kernel: pci 0000:00:12.0: setting latency timer to 64
Jan 27 09:05:35 (none) user.debug kernel: usb usb3: usb resume
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:02.0: wakeup root hub
Jan 27 09:05:35 (none) user.debug kernel: usb usb4: usb resume
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: wakeup root hub
Jan 27 09:05:35 (none) user.debug kernel: usb usb1: usb resume
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:02.1: resume root hub
Jan 27 09:05:35 (none) user.debug kernel: usb usb2: usb resume
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:04.1: resume root hub
Jan 27 09:05:35 (none) user.debug kernel: usb usb1: bus resume complete
Jan 27 09:05:35 (none) user.debug kernel: hub 1-0:1.0: hub_resume
Jan 27 09:05:35 (none) user.info kernel: eth0: no link during initialization.
Jan 27 09:05:35 (none) user.debug kernel: usb usb4: bus resume requested
Jan 27 09:05:35 (none) user.debug kernel: usb usb2: bus resume complete
Jan 27 09:05:35 (none) user.debug kernel: hub 2-0:1.0: hub_resume
Jan 27 09:05:35 (none) user.debug kernel: usb usb4: bus resume complete
Jan 27 09:05:35 (none) user.debug kernel: hub 4-0:1.0: hub_resume
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: GetStatus roothub.portstatus [0] = 0x00040103 PSSC PPS PES CCS
Jan 27 09:05:35 (none) user.debug kernel: hub 4-0:1.0: port 1: status 0103 change 0004
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:04.0: GetStatus roothub.portstatus [0] = 0x00040103 PSSC PPS PES CCS
Jan 27 09:05:35 (none) user.debug kernel: usb 4-1: finish resume
Jan 27 09:05:35 (none) user.debug kernel: usb usb3: bus resume complete
Jan 27 09:05:35 (none) user.debug kernel: hub 3-0:1.0: hub_resume
Jan 27 09:05:35 (none) user.warn kernel: lirc_mceusb[2]: resume
Jan 27 09:05:35 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 b5 11 89 09 (length=5)
Jan 27 09:05:35 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 12 84 89 12 9a 12 84 88 0a 88 0a 84 (length=16)
Jan 27 09:05:35 (none) user.info kernel: lirc_mceusb[2]: rx data: 88 09 88 0a 84 88 0a 88 09 84 88 0a 88 0a 84 88 (length=16)
Jan 27 09:05:35 (none) user.info kernel: lirc_mceusb[2]: rx data: 09 88 0a 84 91 09 89 09 84 88 0a 88 12 84 88 0a (length=16)
Jan 27 09:05:35 (none) user.info kernel: lirc_mceusb[2]: rx data: 88 0a 84 88 09 88 0a 84 91 12 88 0a 83 7f 7f 5f (length=16)
Jan 27 09:05:35 (none) user.info kernel: PM: resume of devices complete after 507.883 msecs
Jan 27 09:05:35 (none) user.warn kernel: Restarting tasks ...
Jan 27 09:05:35 (none) user.debug kernel: hub 1-0:1.0: state 7 ports 6 chg 0000 evt 0000
Jan 27 09:05:35 (none) user.debug kernel: hub 2-0:1.0: state 7 ports 6 chg 0000 evt 0000
Jan 27 09:05:35 (none) user.debug kernel: hub 4-0:1.0: state 7 ports 6 chg 0002 evt 0000
Jan 27 09:05:35 (none) user.debug kernel: hub 4-0:1.0: port 1, status 0103, change 0000, 12 Mb/s
Jan 27 09:05:35 (none) user.debug kernel: hub 3-0:1.0: state 7 ports 6 chg 0000 evt 0000
Jan 27 09:05:35 (none) user.debug kernel: hub 1-0:1.0: hub_suspend
Jan 27 09:05:35 (none) user.debug kernel: usb usb1: bus auto-suspend
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:02.1: suspend root hub
Jan 27 09:05:35 (none) user.debug kernel: hub 2-0:1.0: hub_suspend
Jan 27 09:05:35 (none) user.debug kernel: usb usb2: bus auto-suspend
Jan 27 09:05:35 (none) user.debug kernel: ehci_hcd 0000:00:04.1: suspend root hub
Jan 27 09:05:35 (none) user.debug kernel: hub 3-0:1.0: hub_suspend
Jan 27 09:05:35 (none) user.debug kernel: usb usb3: bus auto-suspend
Jan 27 09:05:35 (none) user.debug kernel: ohci_hcd 0000:00:02.0: suspend root hub
Jan 27 09:05:35 (none) user.warn kernel: done.
Jan 27 09:05:35 (none) user.info kernel: video LNXVIDEO:00: Restoring backlight state
Jan 27 09:05:35 (none) daemon.notice acpid: client connected from 2170[0:1005]
Jan 27 09:05:35 (none) daemon.info acpid: 1 client rule loaded
Jan 27 09:05:38 (none) user.info kernel: eth0: link up.
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 b7 10 8b 06 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8b 07 8a 10 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8b 10 9c 10 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8a 08 8a 08 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 08 8a 08 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8a 08 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 08 8a 08 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 08 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 92 09 89 08 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8a 08 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 11 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 08 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 92 12 89 08 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 08 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 92 08 89 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 68 b6 11 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 08 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 8a 11 89 11 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 9b 12 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 08 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 08 92 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 91 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 91 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 12 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 6a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 b5 11 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 12 9a 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 13 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 12 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 0a 88 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 6a b4 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 12 89 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 9a 12 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 91 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 13 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 91 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 91 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 12 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 6a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 b4 13 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 12 9a 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 13 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 12 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 0a 88 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 6a b4 13 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 12 89 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 9a 12 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 91 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 13 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 0a (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 91 12 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:57 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 91 0a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 12 88 0a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 7f 7f 7f (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 6a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 b4 13 88 09 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 12 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 12 9a 12 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 89 09 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 0a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 09 88 0a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 13 88 09 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 89 09 88 0a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 12 88 0a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 09 88 0a (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 09 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 91 0a 88 12 (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 88 0a 88 7f (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 84 7f 7f 7f 7f (length=5)
Jan 27 09:05:58 (none) user.info kernel: lirc_mceusb[2]: rx data: 83 7f 7f 5f 9f 01 01 9f 15 00 00 80 (length=12)
Jan 27 09:05:58 (none) user.debug kernel: lirc_mceusb[2] mceusb_process_ir_data: found control header
Jan 27 09:05:58 (none) local0.info mythfrontend: 2011-01-27 09:05:58.411 NetworkControl: New connection established.
Jan 27 09:05:58 (none) local0.info mythfrontend: 2011-01-27 09:05:58.414 NetworkControl: Client Socket disconnected
Jan 27 09:05:58 (none) user.info kernel: PM: Syncing filesystems ... done.
Jan 27 09:06:04 (none) user.warn kernel: Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 27 09:06:04 (none) user.warn kernel: Freezing remaining freezable tasks ... (elapsed 4.81 seconds) done.
Jan 27 09:06:04 (none) user.warn kernel: Suspending console(s) (use no_console_suspend to debug)
Jan 27 09:06:04 (none) user.warn kernel: lirc_mceusb[2]: suspend
Jan 27 09:06:04 (none) user.info kernel: ehci_hcd 0000:00:04.1: PCI INT B disabled
Jan 27 09:06:04 (none) user.info kernel: ohci_hcd 0000:00:02.0: PCI INT A disabled
Jan 27 09:06:04 (none) user.info kernel: ehci_hcd 0000:00:02.1: PCI INT B disabled
Jan 27 09:06:04 (none) user.debug kernel: usb 4-1: usb suspend
Jan 27 09:06:04 (none) user.debug kernel: hub 4-0:1.0: hub_suspend
Jan 27 09:06:04 (none) user.debug kernel: usb usb4: bus suspend
Jan 27 09:06:04 (none) user.debug kernel: ohci_hcd 0000:00:04.0: suspend root hub
Jan 27 09:06:04 (none) user.err kernel: pci_pm_suspend(): hcd_pci_suspend+0x0/0x19 returns -16
Jan 27 09:06:04 (none) daemon.notice acpid: client 2170[0:1005] has disconnected
Jan 27 09:06:04 (none) user.err kernel: pm_op(): pci_pm_suspend+0x0/0x164 returns -16
Jan 27 09:06:04 (none) user.err kernel: PM: Device 0000:00:04.0 failed to suspend async: error -16
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: PCI INT A disabled
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D3
Jan 27 09:06:04 (none) user.err kernel: PM: Some devices failed to suspend
Jan 27 09:06:04 (none) user.info kernel: ohci_hcd 0000:00:02.0: PCI INT A -> Link[LUB0] -> GSI 20 (level, low) -> IRQ 20
Jan 27 09:06:04 (none) user.debug kernel: ohci_hcd 0000:00:02.0: setting latency timer to 64
Jan 27 09:06:04 (none) user.debug kernel: ohci_hcd 0000:00:02.0: powerup ports
Jan 27 09:06:04 (none) user.info kernel: ehci_hcd 0000:00:04.1: PCI INT B -> Link[UB12] -> GSI 21 (level, low) -> IRQ 21
Jan 27 09:06:04 (none) user.info kernel: ehci_hcd 0000:00:02.1: PCI INT B -> Link[LUB2] -> GSI 22 (level, low) -> IRQ 22
Jan 27 09:06:04 (none) user.debug kernel: ehci_hcd 0000:00:04.1: setting latency timer to 64
Jan 27 09:06:04 (none) user.debug kernel: ehci_hcd 0000:00:02.1: setting latency timer to 64
Jan 27 09:06:04 (none) user.debug kernel: pci 0000:00:08.0: setting latency timer to 64
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:06:04 (none) user.debug kernel: pci 0000:00:0b.0: setting latency timer to 64
Jan 27 09:06:04 (none) user.info kernel: pci 0000:00:10.0: PCI INT A -> Link[LN0A] -> GSI 19 (level, low) -> IRQ 19
Jan 27 09:06:04 (none) user.info kernel: pci 0000:00:12.0: PCI INT A -> Link[LN2A] -> GSI 18 (level, low) -> IRQ 18
Jan 27 09:06:04 (none) user.debug kernel: pci 0000:00:10.0: setting latency timer to 64
Jan 27 09:06:04 (none) user.debug kernel: pci 0000:00:12.0: setting latency timer to 64
Jan 27 09:06:04 (none) user.debug kernel: usb usb2: usb resume
Jan 27 09:06:04 (none) user.debug kernel: ehci_hcd 0000:00:04.1: resume root hub
Jan 27 09:06:04 (none) user.debug kernel: usb usb4: usb resume
Jan 27 09:06:04 (none) user.debug kernel: ohci_hcd 0000:00:04.0: resume root hub
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: BAR 0: set to [mem 0xfcf78000-0xfcf7bfff] (PCI address [0xfcf78000-0xfcf7bfff])
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:06:04 (none) user.debug kernel: HDA Intel 0000:00:07.0: restoring config space at offset 0xf (was 0x5020100, writing 0x502010a)
Jan 27 09:06:04 (none) user.debug kernel: HDA Intel 0000:00:07.0: restoring config space at offset 0x1 (was 0xb00000, writing 0xb00002)
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: power state changed by ACPI to D0
Jan 27 09:06:04 (none) user.info kernel: HDA Intel 0000:00:07.0: PCI INT A -> Link[LAZA] -> GSI 22 (level, low) -> IRQ 22
Jan 27 09:06:04 (none) user.debug kernel: HDA Intel 0000:00:07.0: setting latency timer to 64
Jan 27 09:06:04 (none) user.info kernel: forcedeth 0000:00:0a.0: BAR 0: set to [mem 0xfcf7c000-0xfcf7cfff] (PCI address [0xfcf7c000-0xfcf7cfff])
Jan 27 09:06:04 (none) user.info kernel: forcedeth 0000:00:0a.0: BAR 1: set to [io 0xd480-0xd487] (PCI address [0xd480-0xd487])
Jan 27 09:06:04 (none) user.info kernel: forcedeth 0000:00:0a.0: BAR 2: set to [mem 0xfcf7f400-0xfcf7f4ff] (PCI address [0xfcf7f400-0xfcf7f4ff])
Jan 27 09:06:04 (none) user.info kernel: forcedeth 0000:00:0a.0: BAR 3: set to [mem 0xfcf7f000-0xfcf7f00f] (PCI address [0xfcf7f000-0xfcf7f00f])
Jan 27 09:06:04 (none) user.debug kernel: forcedeth 0000:00:0a.0: restoring config space at offset 0xf (was 0x14010100, writing 0x1401010b)
Jan 27 09:06:04 (none) user.debug kernel: forcedeth 0000:00:0a.0: restoring config space at offset 0x1 (was 0xb00000, writing 0xb00007)
Jan 27 09:06:04 (none) user.debug kernel: usb usb3: usb resume
Jan 27 09:06:04 (none) user.debug kernel: ohci_hcd 0000:00:02.0: resume root hub
Jan 27 09:06:04 (none) user.debug kernel: usb usb1: usb resume
Jan 27 09:06:04 (none) user.debug kernel: ehci_hcd 0000:00:02.1: resume root hub
Jan 27 09:06:04 (none) user.debug kernel: usb usb2: bus resume complete
Jan 27 09:06:04 (none) user.debug kernel: hub 2-0:1.0: hub_resume
Jan 27 09:06:04 (none) user.debug kernel: usb usb1: bus resume complete
Jan 27 09:06:04 (none) user.debug kernel: hub 1-0:1.0: hub_resume
Jan 27 09:06:04 (none) user.debug kernel: usb usb4: bus resume complete
Jan 27 09:06:04 (none) user.debug kernel: hub 4-0:1.0: hub_resume
Jan 27 09:06:04 (none) user.debug kernel: hub 4-0:1.0: port 1: status 0107 change 0000
Jan 27 09:06:04 (none) user.debug kernel: usb 4-1: usb resume
Jan 27 09:06:04 (none) user.info kernel: eth0: no link during initialization.
Jan 27 09:06:04 (none) user.debug kernel: usb usb3: bus resume complete
Jan 27 09:06:04 (none) user.debug kernel: hub 3-0:1.0: hub_resume
Jan 27 09:06:04 (none) user.debug kernel: ohci_hcd 0000:00:04.0: GetStatus roothub.portstatus [0] = 0x00040103 PSSC PPS PES CCS
Jan 27 09:06:04 (none) user.debug kernel: usb 4-1: finish resume
Jan 27 09:06:04 (none) user.warn kernel: lirc_mceusb[2]: resume
Jan 27 09:06:04 (none) user.info kernel: PM: resume of devices complete after 506.370 msecs
Jan 27 09:06:04 (none) user.warn kernel: Restarting tasks ...
Jan 27 09:06:04 (none) user.debug kernel: hub 2-0:1.0: state 7 ports 6 chg 0000 evt 0000
Jan 27 09:06:04 (none) user.debug kernel: hub 1-0:1.0: state 7 ports 6 chg 0000 evt 0000
Jan 27 09:06:04 (none) user.debug kernel: hub 4-0:1.0: state 7 ports 6 chg 0000 evt 0002
Jan 27 09:06:04 (none) user.debug kernel: hub 3-0:1.0: state 7 ports 6 chg 0000 evt 0000
Jan 27 09:06:04 (none) user.debug kernel: hub 2-0:1.0: hub_suspend
Jan 27 09:06:04 (none) user.debug kernel: usb usb2: bus auto-suspend
Jan 27 09:06:04 (none) user.debug kernel: ehci_hcd 0000:00:04.1: suspend root hub
Jan 27 09:06:04 (none) user.debug kernel: hub 1-0:1.0: hub_suspend
Jan 27 09:06:04 (none) user.debug kernel: usb usb1: bus auto-suspend
Jan 27 09:06:04 (none) user.debug kernel: ehci_hcd 0000:00:02.1: suspend root hub
Jan 27 09:06:04 (none) user.debug kernel: hub 3-0:1.0: hub_suspend
Jan 27 09:06:04 (none) user.debug kernel: usb usb3: bus auto-suspend
Jan 27 09:06:04 (none) user.debug kernel: ohci_hcd 0000:00:02.0: suspend root hub
Jan 27 09:06:04 (none) user.warn kernel: done.
Jan 27 09:06:04 (none) user.info kernel: video LNXVIDEO:00: Restoring backlight state
Jan 27 09:06:04 (none) daemon.notice acpid: client connected from 2170[0:1005]
Jan 27 09:06:04 (none) daemon.info acpid: 1 client rule loaded
Jan 27 09:06:06 (none) user.info kernel: eth0: link up.
