[ 2759.347508] PM: Syncing filesystems ... done. [ 2759.349469] PM: Preparing system for mem sleep [ 2759.428890] Freezing user space processes ... (elapsed 0.01 seconds) done. [ 2759.444236] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [ 2759.460108] PM: Entering mem sleep [ 2759.460128] Suspending console(s) (use no_console_suspend to debug) [ 2759.460574] sd 5:0:0:0: [sdc] Synchronizing SCSI cache [ 2759.460600] sd 1:0:0:0: [sdb] Synchronizing SCSI cache [ 2759.460674] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 2759.460699] sd 1:0:0:0: [sdb] Stopping disk [ 2759.460745] sd 0:0:0:0: [sda] Stopping disk [ 2759.460863] serial 00:07: disabled [ 2759.460867] serial 00:07: wake-up capability disabled by ACPI [ 2759.461307] ACPI handle has no context! [ 2759.541074] sd 5:0:0:0: [sdc] Stopping disk [ 2759.563796] ACPI handle has no context! [ 2759.579730] PM: suspend of drv:snd_hda_intel dev:0000:01:05.1 complete after 118.789 msecs [ 2759.611741] PM: suspend of drv:radeon dev:0000:01:05.0 complete after 150.860 msecs [ 2759.611769] PM: suspend of drv:pci dev:0000:00:01.0 complete after 147.735 msecs [ 2759.787318] PM: suspend of drv:snd_hda_intel dev:0000:00:14.2 complete after 323.927 msecs [ 2759.795969] PM: suspend of drv:sd dev:0:0:0:0 complete after 336.102 msecs [ 2759.796006] PM: suspend of drv:scsi dev:target0:0:0 complete after 336.103 msecs [ 2759.796041] PM: suspend of drv:scsi dev:host0 complete after 335.796 msecs [ 2759.796097] PM: suspend of drv: dev:ata1 complete after 335.739 msecs [ 2760.275637] PM: suspend of drv:sd dev:5:0:0:0 complete after 817.023 msecs [ 2760.275675] PM: suspend of drv:scsi dev:target5:0:0 complete after 817.041 msecs [ 2760.275690] PM: suspend of drv:scsi dev:host5 complete after 816.623 msecs [ 2760.275756] PM: suspend of drv: dev:ata6 complete after 816.637 msecs [ 2760.641139] PM: suspend of drv:sd dev:1:0:0:0 complete after 1183.404 msecs [ 2760.641175] PM: suspend of drv:scsi dev:target1:0:0 complete after 1183.383 msecs [ 2760.641189] PM: suspend of drv:scsi dev:host1 complete after 1183.019 msecs [ 2760.641251] PM: suspend of drv: dev:ata2 complete after 1182.956 msecs [ 2760.641293] PM: suspend of drv:ahci dev:0000:00:11.0 complete after 1179.836 msecs [ 2760.641315] PM: suspend of drv: dev:pci0000:00 complete after 1179.741 msecs [ 2760.641323] PM: suspend of devices complete after 1183.914 msecs [ 2760.641325] PM: suspend devices took 1.184 seconds [ 2760.641488] PM: late suspend of devices complete after 0.161 msecs [ 2760.641667] r8169 0000:06:00.0: wake-up capability enabled by ACPI [ 2760.657275] pcieport 0000:00:0a.0: wake-up capability enabled by ACPI [ 2760.673283] ehci_hcd 0000:00:16.2: wake-up capability enabled by ACPI [ 2760.689162] ohci_hcd 0000:00:16.0: wake-up capability enabled by ACPI [ 2760.689184] ohci_hcd 0000:00:14.5: wake-up capability enabled by ACPI [ 2760.689262] ehci_hcd 0000:00:13.2: wake-up capability enabled by ACPI [ 2760.705077] ohci_hcd 0000:00:13.0: wake-up capability enabled by ACPI [ 2760.705104] ehci_hcd 0000:00:12.2: wake-up capability enabled by ACPI [ 2760.721089] ohci_hcd 0000:00:12.0: wake-up capability enabled by ACPI [ 2760.721147] PM: noirq suspend of devices complete after 79.836 msecs [ 2760.721182] ACPI: Preparing to enter system sleep state S3 [ 2760.724314] PM: Saving platform NVS memory [ 2760.724475] Disabling non-boot CPUs ... [ 2760.725873] CPU 1 is now offline [ 2760.726519] Broke affinity for irq 18 [ 2760.828743] CPU 2 is now offline [ 2760.829267] Broke affinity for irq 17 [ 2760.829274] Broke affinity for irq 42 [ 2760.932487] CPU 3 is now offline [ 2760.932842] Extended CMOS year: 2000 [ 2760.933043] ACPI: Low-level resume complete [ 2760.933076] PM: Restoring platform NVS memory [ 2760.933135] PCI-DMA: Resuming GART IOMMU [ 2760.933135] PCI-DMA: Restoring GART aperture settings [ 2760.933354] Extended CMOS year: 2000 [ 2760.933375] Enabling non-boot CPUs ... [ 2760.933461] Booting Node 0 Processor 1 APIC 0x1 [ 2762.996026] [Firmware Bug]: cpu 1, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu [ 2762.996027] perf: IBS APIC setup failed on cpu #1 [ 2760.946455] TSC synchronization [CPU#0 -> CPU#1]: [ 2760.946456] Measured 6197309976 cycles TSC warp between CPUs, turning off TSC clock. [ 0.008000] Marking TSC unstable due to check_tsc_sync_source failed [ 0.008000] Switch to broadcast mode on CPU1 [ 2769.866214] Switching to clocksource hpet [ 2769.866566] CPU1 is up [ 2769.866598] Booting Node 0 Processor 2 APIC 0x2 [ 0.008000] [Firmware Bug]: cpu 2, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu [ 0.008000] perf: IBS APIC setup failed on cpu #2 [ 0.008000] Switch to broadcast mode on CPU2 [ 2769.876186] CPU2 is up [ 2769.876302] Booting Node 0 Processor 3 APIC 0x3 [ 0.008000] [Firmware Bug]: cpu 3, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu [ 0.008000] perf: IBS APIC setup failed on cpu #3 [ 0.008000] Switch to broadcast mode on CPU3 [ 2769.887992] CPU3 is up [ 2769.888524] ACPI: Waking up from system sleep state S3 [ 2769.976584] ohci_hcd 0000:00:12.0: wake-up capability disabled by ACPI [ 2769.992176] ehci_hcd 0000:00:12.2: wake-up capability disabled by ACPI [ 2769.992203] ohci_hcd 0000:00:13.0: wake-up capability disabled by ACPI [ 2770.008128] ehci_hcd 0000:00:13.2: wake-up capability disabled by ACPI [ 2770.008238] ohci_hcd 0000:00:14.5: wake-up capability disabled by ACPI [ 2770.008334] ohci_hcd 0000:00:16.0: wake-up capability disabled by ACPI [ 2770.024177] ehci_hcd 0000:00:16.2: wake-up capability disabled by ACPI [ 2770.024424] pcieport 0000:00:0a.0: wake-up capability disabled by ACPI [ 2770.025063] PM: noirq resume of devices complete after 48.744 msecs [ 2770.025180] PM: early resume of devices complete after 0.074 msecs [ 2770.025452] snd_hda_intel 0000:01:05.1: setting latency timer to 64 [ 2770.025515] usb usb8: root hub lost power or was reset [ 2770.025516] usb usb9: root hub lost power or was reset [ 2770.025863] xhci_hcd 0000:03:00.0: irq 43 for MSI/MSI-X [ 2770.025867] xhci_hcd 0000:03:00.0: irq 44 for MSI/MSI-X [ 2770.025872] xhci_hcd 0000:03:00.0: irq 45 for MSI/MSI-X [ 2770.025876] xhci_hcd 0000:03:00.0: irq 46 for MSI/MSI-X [ 2770.025880] xhci_hcd 0000:03:00.0: irq 47 for MSI/MSI-X [ 2770.028110] r8169 0000:06:00.0: wake-up capability disabled by ACPI [ 2770.028903] serial 00:07: activated [ 2770.043899] [drm] PCIE GART of 512M enabled (table at 0x00000000C0040000). [ 2770.044054] radeon 0000:01:05.0: WB enabled [ 2770.044056] radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000a0000c00 and cpu addr 0xffff880114f0dc00 [ 2770.044373] radeon 0000:01:05.0: setting latency timer to 64 [ 2770.076063] [drm] ring test on 0 succeeded in 1 usecs [ 2770.076089] [drm] ib test on ring 0 succeeded in 0 usecs [ 2770.148097] PM: resume of drv:hub dev:8-0:1.0 complete after 118.075 msecs [ 2770.148103] PM: resume of drv: dev:ep_00 complete after 118.021 msecs [ 2770.148108] PM: resume of drv: dev:ep_81 complete after 118.058 msecs [ 2770.148118] PM: resume of drv:hub dev:9-0:1.0 complete after 117.964 msecs [ 2770.148127] PM: resume of drv: dev:ep_00 complete after 117.904 msecs [ 2770.148128] PM: resume of drv: dev:ep_81 complete after 117.937 msecs [ 2770.148708] PM: resume of drv: dev:ep_00 complete after 118.322 msecs [ 2770.148713] PM: resume of drv: dev:ep_00 complete after 117.300 msecs [ 2770.148723] PM: resume of drv:usb-storage dev:1-2:1.0 complete after 117.475 msecs [ 2770.148729] PM: resume of drv:usb-storage dev:1-1:1.0 complete after 118.439 msecs [ 2770.148734] PM: resume of drv: dev:ep_02 complete after 117.353 msecs [ 2770.148736] PM: resume of drv:scsi dev:host9 complete after 117.458 msecs [ 2770.148744] PM: resume of drv: dev:ep_81 complete after 118.427 msecs [ 2770.148750] PM: resume of drv:scsi dev:host6 complete after 118.334 msecs [ 2770.148755] PM: resume of drv:scsi dev:target9:0:0 complete after 116.836 msecs [ 2770.148758] PM: resume of drv: dev:ep_81 complete after 117.403 msecs [ 2770.148759] PM: resume of drv:scsi_host dev:host6 complete after 118.309 msecs [ 2770.148762] PM: resume of drv:sd dev:9:0:0:0 complete after 116.809 msecs [ 2770.148764] PM: resume of drv: dev:ep_02 complete after 118.413 msecs [ 2770.148765] PM: resume of drv:scsi dev:target6:0:0 complete after 117.084 msecs [ 2770.148769] PM: resume of drv:scsi_host dev:host9 complete after 117.457 msecs [ 2770.148774] PM: resume of drv:sd dev:6:0:0:0 complete after 117.061 msecs [ 2770.148776] PM: resume of drv:scsi_device dev:9:0:0:0 complete after 116.788 msecs [ 2770.148788] PM: resume of drv:scsi_device dev:6:0:0:0 complete after 117.040 msecs [ 2770.177190] PM: resume of drv: dev:ep_00 complete after 144.637 msecs [ 2770.177195] PM: resume of drv:usbhid dev:4-5:1.0 complete after 145.107 msecs [ 2770.177218] PM: resume of drv: dev:ep_81 complete after 144.702 msecs [ 2770.179156] PM: resume of drv:usbhid dev:5-1:1.0 complete after 147.334 msecs [ 2770.179160] PM: resume of drv: dev:ep_00 complete after 147.268 msecs [ 2770.179177] PM: resume of drv: dev:ep_81 complete after 147.322 msecs [ 2770.184167] PM: resume of drv:scsi dev:host8 complete after 153.018 msecs [ 2770.184193] PM: resume of drv:scsi_host dev:host8 complete after 153.013 msecs [ 2770.203958] PM: resume of drv:scsi dev:host7 complete after 172.877 msecs [ 2770.203978] PM: resume of drv:scsi_host dev:host7 complete after 172.862 msecs [ 2770.348119] ata5: SATA link down (SStatus 0 SControl 300) [ 2770.348148] ata4: SATA link down (SStatus 0 SControl 300) [ 2770.364151] PM: resume of drv:scsi dev:host4 complete after 336.042 msecs [ 2770.364161] PM: resume of drv:scsi dev:host3 complete after 338.412 msecs [ 2770.364167] PM: resume of drv:scsi_host dev:host4 complete after 336.053 msecs [ 2770.364174] PM: resume of drv:scsi_host dev:host3 complete after 336.084 msecs [ 2770.520102] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 2770.520129] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 2770.520676] ata1.00: configured for UDMA/133 [ 2770.526975] ata3.00: configured for UDMA/100 [ 2770.536151] PM: resume of drv:scsi dev:host0 complete after 510.467 msecs [ 2770.536156] PM: resume of drv:ata_port dev:ata1 complete after 506.727 msecs [ 2770.536170] PM: resume of drv:scsi dev:target0:0:0 complete after 505.689 msecs [ 2770.536176] PM: resume of drv:scsi_host dev:host0 complete after 510.489 msecs [ 2770.536178] PM: resume of drv:sd dev:0:0:0:0 complete after 505.662 msecs [ 2770.536183] sd 0:0:0:0: [sda] Starting disk [ 2770.536329] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 505.776 msecs [ 2770.548125] PM: resume of drv:scsi dev:host2 complete after 522.402 msecs [ 2770.548147] PM: resume of drv:scsi_host dev:host2 complete after 522.403 msecs [ 2770.548162] PM: resume of drv:scsi dev:target2:0:0 complete after 517.479 msecs [ 2770.548178] PM: resume of drv:sr dev:2:0:0:0 complete after 517.466 msecs [ 2770.548193] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 517.449 msecs [ 2770.580087] firewire_core 0000:02:00.0: rediscovered device fw0 [ 2777.852102] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 2777.856101] ata6: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 2777.885803] ata2.00: configured for UDMA/133 [ 2777.900154] PM: resume of drv:scsi dev:host1 complete after 7874.459 msecs [ 2777.900159] PM: resume of drv:ata_port dev:ata2 complete after 7363.980 msecs [ 2777.900174] PM: resume of drv:scsi dev:target1:0:0 complete after 7869.590 msecs [ 2777.900179] PM: resume of drv:scsi_host dev:host1 complete after 7874.460 msecs [ 2777.900206] PM: resume of drv:sd dev:1:0:0:0 complete after 7869.592 msecs [ 2777.900211] sd 1:0:0:0: [sdb] Starting disk [ 2777.901024] ata6.00: configured for UDMA/133 [ 2777.905258] PM: resume of drv:scsi_device dev:1:0:0:0 complete after 7874.608 msecs [ 2777.916148] PM: resume of drv:scsi dev:host5 complete after 7887.166 msecs [ 2777.916168] PM: resume of drv:scsi dev:target5:0:0 complete after 7885.391 msecs [ 2777.916173] PM: resume of drv:scsi_host dev:host5 complete after 7887.180 msecs [ 2777.916201] PM: resume of drv:sd dev:5:0:0:0 complete after 7885.391 msecs [ 2777.916205] sd 5:0:0:0: [sdc] Starting disk [ 2777.920920] PM: resume of drv:scsi_device dev:5:0:0:0 complete after 7890.074 msecs [ 2777.921259] PM: resume of devices complete after 7896.073 msecs [ 2777.952954] PM: resume devices took 7.928 seconds [ 2777.953538] PM: Finishing wakeup. [ 2777.953539] Restarting tasks ... done. [ 2778.599810] r8169 0000:06:00.0: eth0: link down [ 2778.599880] r8169 0000:06:00.0: eth0: link down [ 2778.601257] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ 2780.214342] r8169 0000:06:00.0: eth0: link up [ 2780.215600] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [13772.096362] PM: Syncing filesystems ... done. [13772.100057] PM: Preparing system for mem sleep [13772.200882] Freezing user space processes ... (elapsed 0.01 seconds) done. [13772.216161] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [13772.232156] PM: Entering mem sleep [13772.232176] Suspending console(s) (use no_console_suspend to debug) [13772.232943] sd 5:0:0:0: [sdc] Synchronizing SCSI cache [13772.233673] serial 00:07: disabled [13772.233677] serial 00:07: wake-up capability disabled by ACPI [13772.234043] sd 1:0:0:0: [sdb] Synchronizing SCSI cache [13772.234180] sd 1:0:0:0: [sdb] Stopping disk [13772.234224] sd 0:0:0:0: [sda] Synchronizing SCSI cache [13772.234320] sd 0:0:0:0: [sda] Stopping disk [13772.235865] ACPI handle has no context! [13772.311595] sd 5:0:0:0: [sdc] Stopping disk [13772.336106] ACPI handle has no context! [13772.352066] PM: suspend of drv:snd_hda_intel dev:0000:01:05.1 complete after 116.290 msecs [13772.384152] PM: suspend of drv:radeon dev:0000:01:05.0 complete after 148.301 msecs [13772.384189] PM: suspend of drv:pci dev:0000:00:01.0 complete after 147.611 msecs [13772.560152] PM: suspend of drv:snd_hda_intel dev:0000:00:14.2 complete after 324.010 msecs [13773.203627] PM: suspend of drv:sd dev:5:0:0:0 complete after 970.699 msecs [13773.203669] PM: suspend of drv:scsi dev:target5:0:0 complete after 970.721 msecs [13773.203690] PM: suspend of drv:scsi dev:host5 complete after 968.458 msecs [13773.203756] PM: suspend of drv: dev:ata6 complete after 968.367 msecs [13773.423177] PM: suspend of drv:sd dev:1:0:0:0 complete after 1189.139 msecs [13773.423218] PM: suspend of drv:scsi dev:target1:0:0 complete after 1189.065 msecs [13773.423237] PM: suspend of drv:scsi dev:host1 complete after 1187.924 msecs [13773.423297] PM: suspend of drv: dev:ata2 complete after 1187.713 msecs [13773.423346] PM: suspend of drv:ahci dev:0000:00:11.0 complete after 1186.935 msecs [13773.423371] PM: suspend of drv: dev:pci0000:00 complete after 1186.735 msecs [13773.423380] PM: suspend of devices complete after 1191.058 msecs [13773.423382] PM: suspend devices took 1.188 seconds [13773.423546] PM: late suspend of devices complete after 0.161 msecs [13773.424228] r8169 0000:06:00.0: wake-up capability enabled by ACPI [13773.440209] pcieport 0000:00:0a.0: wake-up capability enabled by ACPI [13773.456264] ehci_hcd 0000:00:16.2: wake-up capability enabled by ACPI [13773.472175] ohci_hcd 0000:00:16.0: wake-up capability enabled by ACPI [13773.472260] ohci_hcd 0000:00:14.5: wake-up capability enabled by ACPI [13773.472347] ehci_hcd 0000:00:13.2: wake-up capability enabled by ACPI [13773.488175] ohci_hcd 0000:00:13.0: wake-up capability enabled by ACPI [13773.488204] ehci_hcd 0000:00:12.2: wake-up capability enabled by ACPI [13773.504175] ohci_hcd 0000:00:12.0: wake-up capability enabled by ACPI [13773.504361] PM: noirq suspend of devices complete after 80.812 msecs [13773.504399] ACPI: Preparing to enter system sleep state S3 [13773.507732] PM: Saving platform NVS memory [13773.507901] Disabling non-boot CPUs ... [13773.612094] CPU 1 is now offline [13773.716091] CPU 2 is now offline [13773.716704] Broke affinity for irq 18 [13773.716706] Broke affinity for irq 42 [13773.820073] CPU 3 is now offline [13773.820424] Extended CMOS year: 2000 [13773.820424] ACPI: Low-level resume complete [13773.820424] PM: Restoring platform NVS memory [13773.820424] PCI-DMA: Resuming GART IOMMU [13773.820424] PCI-DMA: Restoring GART aperture settings [13773.820424] LVT offset 0 assigned for vector 0xf9 [13773.820424] Extended CMOS year: 2000 [13773.820424] Enabling non-boot CPUs ... [13773.820424] Booting Node 0 Processor 1 APIC 0x1 [13773.509347] [Firmware Bug]: cpu 1, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu [13773.509347] perf: IBS APIC setup failed on cpu #1 [13773.509347] Switch to broadcast mode on CPU1 [13773.831988] CPU1 is up [13773.832136] Booting Node 0 Processor 2 APIC 0x2 [13773.613863] [Firmware Bug]: cpu 2, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu [13773.613863] perf: IBS APIC setup failed on cpu #2 [13773.613863] Switch to broadcast mode on CPU2 [13773.843717] CPU2 is up [13773.843883] Booting Node 0 Processor 3 APIC 0x3 [13773.717767] [Firmware Bug]: cpu 3, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu [13773.717767] perf: IBS APIC setup failed on cpu #3 [13773.717767] Switch to broadcast mode on CPU3 [13773.855543] CPU3 is up [13773.856048] ACPI: Waking up from system sleep state S3 [13773.948583] ohci_hcd 0000:00:12.0: wake-up capability disabled by ACPI [13773.964178] ehci_hcd 0000:00:12.2: wake-up capability disabled by ACPI [13773.964204] ohci_hcd 0000:00:13.0: wake-up capability disabled by ACPI [13773.980178] ehci_hcd 0000:00:13.2: wake-up capability disabled by ACPI [13773.980288] ohci_hcd 0000:00:14.5: wake-up capability disabled by ACPI [13773.980384] ohci_hcd 0000:00:16.0: wake-up capability disabled by ACPI [13773.996175] ehci_hcd 0000:00:16.2: wake-up capability disabled by ACPI [13773.996422] pcieport 0000:00:0a.0: wake-up capability disabled by ACPI [13773.997062] PM: noirq resume of devices complete after 48.741 msecs [13773.997179] PM: early resume of devices complete after 0.074 msecs [13773.997467] snd_hda_intel 0000:01:05.1: setting latency timer to 64 [13773.997535] usb usb8: root hub lost power or was reset [13773.997537] usb usb9: root hub lost power or was reset [13773.997870] xhci_hcd 0000:03:00.0: irq 43 for MSI/MSI-X [13773.997875] xhci_hcd 0000:03:00.0: irq 44 for MSI/MSI-X [13773.997878] xhci_hcd 0000:03:00.0: irq 45 for MSI/MSI-X [13773.997883] xhci_hcd 0000:03:00.0: irq 46 for MSI/MSI-X [13773.997887] xhci_hcd 0000:03:00.0: irq 47 for MSI/MSI-X [13774.000178] r8169 0000:06:00.0: wake-up capability disabled by ACPI [13774.001097] serial 00:07: activated [13774.017550] [drm] PCIE GART of 512M enabled (table at 0x00000000C0040000). [13774.017671] radeon 0000:01:05.0: WB enabled [13774.017673] radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000a0000c00 and cpu addr 0xffff880114f0dc00 [13774.017898] radeon 0000:01:05.0: setting latency timer to 64 [13774.049502] [drm] ring test on 0 succeeded in 0 usecs [13774.049536] [drm] ib test on ring 0 succeeded in 0 usecs [13774.100102] PM: resume of drv:hub dev:4-0:1.0 complete after 101.998 msecs [13774.100108] PM: resume of drv:hub dev:6-0:1.0 complete after 101.573 msecs [13774.100111] PM: resume of drv: dev:ep_00 complete after 101.883 msecs [13774.100115] PM: resume of drv: dev:ep_00 complete after 101.484 msecs [13774.100117] PM: resume of drv:hub dev:7-0:1.0 complete after 101.370 msecs [13774.100120] PM: resume of drv: dev:ep_81 complete after 101.539 msecs [13774.100122] PM: resume of drv: dev:ep_00 complete after 101.275 msecs [13774.100127] PM: resume of drv: dev:ep_81 complete after 101.950 msecs [13774.100135] PM: resume of drv: dev:ep_00 complete after 101.701 msecs [13774.100144] PM: resume of drv:hub dev:5-0:1.0 complete after 101.816 msecs [13774.100160] PM: resume of drv: dev:ep_81 complete after 101.364 msecs [13774.100164] PM: resume of drv: dev:ep_81 complete after 101.786 msecs [13774.120098] PM: resume of drv:hub dev:8-0:1.0 complete after 121.146 msecs [13774.120103] PM: resume of drv: dev:ep_00 complete after 121.040 msecs [13774.120107] PM: resume of drv: dev:ep_81 complete after 121.109 msecs [13774.120116] PM: resume of drv:hub dev:9-0:1.0 complete after 120.925 msecs [13774.120124] PM: resume of drv: dev:ep_00 complete after 120.816 msecs [13774.120139] PM: resume of drv: dev:ep_81 complete after 120.866 msecs [13774.120174] PM: resume of drv:usb-storage dev:1-1:1.0 complete after 120.769 msecs [13774.120182] PM: resume of drv: dev:ep_00 complete after 120.625 msecs [13774.120183] PM: resume of drv: dev:ep_81 complete after 120.728 msecs [13774.120191] PM: resume of drv:scsi dev:host6 complete after 120.570 msecs [13774.120191] PM: resume of drv: dev:ep_02 complete after 120.687 msecs [13774.120205] PM: resume of drv:scsi_host dev:host6 complete after 120.501 msecs [13774.120211] PM: resume of drv:scsi dev:target6:0:0 complete after 114.745 msecs [13774.120224] PM: resume of drv:sd dev:6:0:0:0 complete after 114.720 msecs [13774.120243] PM: resume of drv:scsi_device dev:6:0:0:0 complete after 114.700 msecs [13774.120274] PM: resume of drv:usb-storage dev:1-2:1.0 complete after 115.321 msecs [13774.120280] PM: resume of drv: dev:ep_00 complete after 115.128 msecs [13774.120283] PM: resume of drv: dev:ep_81 complete after 115.210 msecs [13774.120287] PM: resume of drv:scsi dev:host9 complete after 115.293 msecs [13774.120289] PM: resume of drv: dev:ep_02 complete after 115.176 msecs [13774.120298] PM: resume of drv:scsi dev:target9:0:0 complete after 114.556 msecs [13774.120299] PM: resume of drv:scsi_host dev:host9 complete after 115.264 msecs [13774.120311] PM: resume of drv:sd dev:9:0:0:0 complete after 114.529 msecs [13774.120323] PM: resume of drv:scsi_device dev:9:0:0:0 complete after 114.502 msecs [13774.149181] PM: resume of drv: dev:ep_00 complete after 142.841 msecs [13774.149188] PM: resume of drv:usbhid dev:4-5:1.0 complete after 143.287 msecs [13774.149203] PM: resume of drv: dev:ep_81 complete after 142.905 msecs [13774.151193] PM: resume of drv:usbhid dev:5-1:1.0 complete after 145.565 msecs [13774.151198] PM: resume of drv: dev:ep_00 complete after 145.489 msecs [13774.151214] PM: resume of drv: dev:ep_81 complete after 145.547 msecs [13774.160194] PM: resume of drv:scsi dev:host8 complete after 155.356 msecs [13774.160220] PM: resume of drv:scsi_host dev:host8 complete after 155.345 msecs [13774.172052] PM: resume of drv:scsi dev:host7 complete after 167.324 msecs [13774.172077] PM: resume of drv:scsi_host dev:host7 complete after 167.278 msecs [13774.320139] ata5: SATA link down (SStatus 0 SControl 300) [13774.320176] ata4: SATA link down (SStatus 0 SControl 300) [13774.336144] PM: resume of drv:scsi dev:host3 complete after 338.488 msecs [13774.336149] PM: resume of drv:scsi dev:host4 complete after 338.481 msecs [13774.336165] PM: resume of drv:scsi_host dev:host3 complete after 338.504 msecs [13774.336171] PM: resume of drv:scsi_host dev:host4 complete after 338.502 msecs [13774.488104] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [13774.492096] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [13774.492623] ata1.00: configured for UDMA/133 [13774.495221] ata3.00: configured for UDMA/100 [13774.508150] PM: resume of drv:scsi dev:host0 complete after 510.516 msecs [13774.508158] PM: resume of drv:ata_port dev:ata1 complete after 506.575 msecs [13774.508171] PM: resume of drv:scsi dev:target0:0:0 complete after 508.420 msecs [13774.508177] PM: resume of drv:scsi_host dev:host0 complete after 510.538 msecs [13774.508202] PM: resume of drv:sd dev:0:0:0:0 complete after 508.401 msecs [13774.508206] sd 0:0:0:0: [sda] Starting disk [13774.508316] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 508.461 msecs [13774.552092] firewire_core 0000:02:00.0: rediscovered device fw0 [13774.624142] PM: resume of drv:scsi dev:host2 complete after 626.492 msecs [13774.624186] PM: resume of drv:scsi_host dev:host2 complete after 626.533 msecs [13774.624191] PM: resume of drv:scsi dev:target2:0:0 complete after 624.073 msecs [13774.624226] PM: resume of drv:sr dev:2:0:0:0 complete after 624.047 msecs [13774.624247] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 623.244 msecs [13781.548104] ata6: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [13781.591765] ata6.00: configured for UDMA/133 [13781.604136] PM: resume of drv:scsi dev:host5 complete after 7606.461 msecs [13781.604170] PM: resume of drv:scsi dev:target5:0:0 complete after 7600.066 msecs [13781.604175] PM: resume of drv:scsi_host dev:host5 complete after 7606.492 msecs [13781.604185] PM: resume of drv:sd dev:5:0:0:0 complete after 7599.987 msecs [13781.604190] sd 5:0:0:0: [sdc] Starting disk [13781.611653] PM: resume of drv:scsi_device dev:5:0:0:0 complete after 7607.413 msecs [13782.052104] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [13782.081648] ata2.00: configured for UDMA/133 [13782.096150] PM: resume of drv:scsi dev:host1 complete after 8098.507 msecs [13782.096155] PM: resume of drv:ata_port dev:ata2 complete after 7587.975 msecs [13782.096169] PM: resume of drv:scsi dev:target1:0:0 complete after 8096.265 msecs [13782.096175] PM: resume of drv:scsi_host dev:host1 complete after 8098.528 msecs [13782.096180] PM: resume of drv:sd dev:1:0:0:0 complete after 8096.224 msecs [13782.096184] sd 1:0:0:0: [sdb] Starting disk [13782.101111] PM: resume of drv:scsi_device dev:1:0:0:0 complete after 8101.077 msecs [13782.101451] PM: resume of devices complete after 8104.266 msecs [13782.134171] PM: resume devices took 8.136 seconds [13782.134758] PM: Finishing wakeup. [13782.134758] Restarting tasks ... done. [13782.779783] r8169 0000:06:00.0: eth0: link down [13782.781145] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [13782.783271] r8169 0000:06:00.0: eth0: link down [13784.375445] r8169 0000:06:00.0: eth0: link up [13784.376729] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [17332.786742] PM: Syncing filesystems ... done. [17332.792202] PM: Preparing system for mem sleep [17332.884893] Freezing user space processes ... (elapsed 0.01 seconds) done. [17332.900162] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [17332.916158] PM: Entering mem sleep [17332.916180] Suspending console(s) (use no_console_suspend to debug) [17332.916894] sd 5:0:0:0: [sdc] Synchronizing SCSI cache [17332.916963] sd 1:0:0:0: [sdb] Synchronizing SCSI cache [17332.917067] sd 1:0:0:0: [sdb] Stopping disk [17332.917087] sd 0:0:0:0: [sda] Synchronizing SCSI cache [17332.917177] sd 0:0:0:0: [sda] Stopping disk [17332.917887] serial 00:07: disabled [17332.917891] serial 00:07: wake-up capability disabled by ACPI [17332.924141] ACPI handle has no context! [17332.961400] sd 5:0:0:0: [sdc] Stopping disk [17333.020139] ACPI handle has no context! [17333.036149] PM: suspend of drv:snd_hda_intel dev:0000:01:05.1 complete after 116.762 msecs [17333.036192] PM: suspend of drv:pci dev:0000:00:01.0 complete after 116.088 msecs [17333.240153] PM: suspend of drv:snd_hda_intel dev:0000:00:14.2 complete after 320.455 msecs [17333.697967] PM: suspend of drv:sd dev:5:0:0:0 complete after 781.076 msecs [17333.698009] PM: suspend of drv:scsi dev:target5:0:0 complete after 781.088 msecs [17333.698050] PM: suspend of drv:scsi dev:host5 complete after 779.185 msecs [17333.698116] PM: suspend of drv: dev:ata6 complete after 779.098 msecs [17334.099632] PM: suspend of drv:sd dev:1:0:0:0 complete after 1182.671 msecs [17334.099675] PM: suspend of drv:scsi dev:target1:0:0 complete after 1182.652 msecs [17334.099716] PM: suspend of drv:scsi dev:host1 complete after 1180.769 msecs [17334.099789] PM: suspend of drv: dev:ata2 complete after 1180.614 msecs [17334.099855] PM: suspend of drv:ahci dev:0000:00:11.0 complete after 1179.924 msecs [17334.099888] PM: suspend of drv: dev:pci0000:00 complete after 1179.731 msecs [17334.099907] PM: suspend of devices complete after 1183.581 msecs [17334.099909] PM: suspend devices took 1.180 seconds [17334.100101] PM: late suspend of devices complete after 0.189 msecs [17334.100747] r8169 0000:06:00.0: wake-up capability enabled by ACPI [17334.116208] pcieport 0000:00:0a.0: wake-up capability enabled by ACPI [17334.132264] ehci_hcd 0000:00:16.2: wake-up capability enabled by ACPI [17334.148177] ohci_hcd 0000:00:16.0: wake-up capability enabled by ACPI [17334.148262] ohci_hcd 0000:00:14.5: wake-up capability enabled by ACPI [17334.148348] ehci_hcd 0000:00:13.2: wake-up capability enabled by ACPI [17334.164176] ohci_hcd 0000:00:13.0: wake-up capability enabled by ACPI [17334.164206] ehci_hcd 0000:00:12.2: wake-up capability enabled by ACPI [17334.180175] ohci_hcd 0000:00:12.0: wake-up capability enabled by ACPI [17334.180361] PM: noirq suspend of devices complete after 80.257 msecs [17334.180397] ACPI: Preparing to enter system sleep state S3 [17334.183766] PM: Saving platform NVS memory [17334.183942] Disabling non-boot CPUs ... [17334.288145] CPU 1 is now offline [17334.392085] CPU 2 is now offline [17334.496079] CPU 3 is now offline [17334.496459] Extended CMOS year: 2000 [17334.496459] ACPI: Low-level resume complete [17334.496459] PM: Restoring platform NVS memory [17334.496459] PCI-DMA: Resuming GART IOMMU [17334.496459] PCI-DMA: Restoring GART aperture settings [17334.496459] LVT offset 0 assigned for vector 0xf9 [17334.496459] Extended CMOS year: 2000 [17334.496459] Enabling non-boot CPUs ... [17334.496459] Booting Node 0 Processor 1 APIC 0x1 [17334.185525] [Firmware Bug]: cpu 1, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu [17334.185525] perf: IBS APIC setup failed on cpu #1 [17334.185525] Switch to broadcast mode on CPU1 [17334.508000] CPU1 is up [17334.508148] Booting Node 0 Processor 2 APIC 0x2 [17334.289928] [Firmware Bug]: cpu 2, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu [17334.289928] perf: IBS APIC setup failed on cpu #2 [17334.289928] Switch to broadcast mode on CPU2 [17334.519735] CPU2 is up [17334.519960] Booting Node 0 Processor 3 APIC 0x3 [17334.393726] [Firmware Bug]: cpu 3, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu [17334.393726] perf: IBS APIC setup failed on cpu #3 [17334.393726] Switch to broadcast mode on CPU3 [17334.531625] CPU3 is up [17334.532137] ACPI: Waking up from system sleep state S3 [17334.620596] ohci_hcd 0000:00:12.0: wake-up capability disabled by ACPI [17334.636187] ehci_hcd 0000:00:12.2: wake-up capability disabled by ACPI [17334.636214] ohci_hcd 0000:00:13.0: wake-up capability disabled by ACPI [17334.652189] ehci_hcd 0000:00:13.2: wake-up capability disabled by ACPI [17334.652299] ohci_hcd 0000:00:14.5: wake-up capability disabled by ACPI [17334.652396] ohci_hcd 0000:00:16.0: wake-up capability disabled by ACPI [17334.668189] ehci_hcd 0000:00:16.2: wake-up capability disabled by ACPI [17334.668436] pcieport 0000:00:0a.0: wake-up capability disabled by ACPI [17334.669075] PM: noirq resume of devices complete after 48.744 msecs [17334.669183] PM: early resume of devices complete after 0.074 msecs [17334.669488] snd_hda_intel 0000:01:05.1: setting latency timer to 64 [17334.669542] r8169 0000:06:00.0: wake-up capability disabled by ACPI [17334.669549] usb usb8: root hub lost power or was reset [17334.669550] usb usb9: root hub lost power or was reset [17334.669851] xhci_hcd 0000:03:00.0: irq 43 for MSI/MSI-X [17334.669855] xhci_hcd 0000:03:00.0: irq 44 for MSI/MSI-X [17334.669859] xhci_hcd 0000:03:00.0: irq 45 for MSI/MSI-X [17334.669864] xhci_hcd 0000:03:00.0: irq 46 for MSI/MSI-X [17334.669868] xhci_hcd 0000:03:00.0: irq 47 for MSI/MSI-X [17334.670713] serial 00:07: activated [17334.686668] [drm] PCIE GART of 512M enabled (table at 0x00000000C0040000). [17334.686786] radeon 0000:01:05.0: WB enabled [17334.686788] radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000a0000c00 and cpu addr 0xffff880114f0dc00 [17334.687013] radeon 0000:01:05.0: setting latency timer to 64 [17334.719003] [drm] ring test on 0 succeeded in 1 usecs [17334.719021] [drm] ib test on ring 0 succeeded in 0 usecs [17334.792111] PM: resume of drv: dev:ep_00 complete after 120.166 msecs [17334.792127] PM: resume of drv:hub dev:8-0:1.0 complete after 120.264 msecs [17334.792129] PM: resume of drv: dev:ep_00 complete after 120.239 msecs [17334.792133] PM: resume of drv:hub dev:9-0:1.0 complete after 120.215 msecs [17334.792138] PM: resume of drv: dev:ep_81 complete after 120.265 msecs [17334.792142] PM: resume of drv: dev:ep_81 complete after 120.213 msecs [17334.792193] PM: resume of drv:usb-storage dev:1-1:1.0 complete after 120.223 msecs [17334.792197] PM: resume of drv: dev:ep_00 complete after 120.157 msecs [17334.792199] PM: resume of drv: dev:ep_00 complete after 119.520 msecs [17334.792202] PM: resume of drv:usb-storage dev:1-2:1.0 complete after 119.597 msecs [17334.792208] PM: resume of drv:scsi dev:host6 complete after 120.154 msecs [17334.792211] PM: resume of drv: dev:ep_81 complete after 120.226 msecs [17334.792215] PM: resume of drv:scsi dev:host9 complete after 119.595 msecs [17334.792219] PM: resume of drv: dev:ep_02 complete after 120.220 msecs [17334.792222] PM: resume of drv:scsi dev:target6:0:0 complete after 119.422 msecs [17334.792223] PM: resume of drv:scsi_host dev:host6 complete after 120.154 msecs [17334.792225] PM: resume of drv: dev:ep_81 complete after 119.575 msecs [17334.792228] PM: resume of drv:sd dev:6:0:0:0 complete after 119.414 msecs [17334.792234] PM: resume of drv:scsi dev:target9:0:0 complete after 119.330 msecs [17334.792235] PM: resume of drv: dev:ep_02 complete after 119.570 msecs [17334.792241] PM: resume of drv:scsi_device dev:6:0:0:0 complete after 119.413 msecs [17334.792243] PM: resume of drv:scsi_host dev:host9 complete after 119.607 msecs [17334.792245] PM: resume of drv:sd dev:9:0:0:0 complete after 119.327 msecs [17334.792267] PM: resume of drv:scsi_device dev:9:0:0:0 complete after 119.333 msecs [17334.821174] PM: resume of drv:usbhid dev:4-5:1.0 complete after 148.208 msecs [17334.821189] PM: resume of drv: dev:ep_00 complete after 148.025 msecs [17334.821191] PM: resume of drv: dev:ep_81 complete after 148.040 msecs [17334.823156] PM: resume of drv:usbhid dev:5-1:1.0 complete after 150.291 msecs [17334.823162] PM: resume of drv: dev:ep_00 complete after 150.267 msecs [17334.823177] PM: resume of drv: dev:ep_81 complete after 150.298 msecs [17334.828192] PM: resume of drv:scsi dev:host8 complete after 155.630 msecs [17334.828214] PM: resume of drv:scsi_host dev:host8 complete after 155.636 msecs [17334.840052] PM: resume of drv:scsi dev:host7 complete after 167.518 msecs [17334.840086] PM: resume of drv:scsi_host dev:host7 complete after 167.538 msecs [17334.988142] ata5: SATA link down (SStatus 0 SControl 300) [17334.992091] ata4: SATA link down (SStatus 0 SControl 300) [17335.004162] PM: resume of drv:scsi dev:host4 complete after 332.621 msecs [17335.004185] PM: resume of drv:scsi_host dev:host4 complete after 332.640 msecs [17335.008136] PM: resume of drv:scsi dev:host3 complete after 336.604 msecs [17335.008157] PM: resume of drv:scsi_host dev:host3 complete after 336.619 msecs [17335.160097] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [17335.160126] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [17335.160698] ata1.00: configured for UDMA/133 [17335.166944] ata3.00: configured for UDMA/100 [17335.176151] PM: resume of drv:ata_port dev:ata1 complete after 504.878 msecs [17335.176156] PM: resume of drv:scsi dev:host0 complete after 504.645 msecs [17335.176178] PM: resume of drv:scsi_host dev:host0 complete after 504.662 msecs [17335.176192] PM: resume of drv:scsi dev:target0:0:0 complete after 504.108 msecs [17335.176218] PM: resume of drv:sd dev:0:0:0:0 complete after 504.118 msecs [17335.176223] sd 0:0:0:0: [sda] Starting disk [17335.176369] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 504.251 msecs [17335.188128] PM: resume of drv:scsi dev:host2 complete after 516.605 msecs [17335.188150] PM: resume of drv:scsi_host dev:host2 complete after 516.621 msecs [17335.188164] PM: resume of drv:scsi dev:target2:0:0 complete after 515.988 msecs [17335.188181] PM: resume of drv:sr dev:2:0:0:0 complete after 515.992 msecs [17335.188197] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 515.994 msecs [17335.348091] firewire_core 0000:02:00.0: rediscovered device fw0 [17341.880121] ata6: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [17341.918597] ata6.00: configured for UDMA/133 [17341.932143] PM: resume of drv:scsi dev:host5 complete after 7260.596 msecs [17341.932167] PM: resume of drv:scsi_host dev:host5 complete after 7260.616 msecs [17341.932184] PM: resume of drv:scsi dev:target5:0:0 complete after 7259.964 msecs [17341.932199] PM: resume of drv:sd dev:5:0:0:0 complete after 7259.966 msecs [17341.932204] sd 5:0:0:0: [sdc] Starting disk [17341.938524] PM: resume of drv:scsi_device dev:5:0:0:0 complete after 7266.273 msecs [17342.272110] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [17342.299891] ata2.00: configured for UDMA/133 [17342.312149] PM: resume of drv:scsi dev:host1 complete after 7640.631 msecs [17342.312154] PM: resume of drv:ata_port dev:ata2 complete after 7135.985 msecs [17342.312173] PM: resume of drv:scsi_host dev:host1 complete after 7640.651 msecs [17342.312187] PM: resume of drv:scsi dev:target1:0:0 complete after 7640.058 msecs [17342.312205] PM: resume of drv:sd dev:1:0:0:0 complete after 7640.061 msecs [17342.312209] sd 1:0:0:0: [sdb] Starting disk [17342.312361] Extended CMOS year: 2000 [17342.319348] PM: resume of drv:scsi_device dev:1:0:0:0 complete after 7647.186 msecs [17342.319693] PM: resume of devices complete after 7650.503 msecs [17342.350154] PM: resume devices took 7.680 seconds [17342.350736] PM: Finishing wakeup. [17342.350737] Restarting tasks ... done. [17342.967754] r8169 0000:06:00.0: eth0: link down [17342.967820] r8169 0000:06:00.0: eth0: link down [17342.969126] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [17344.583242] r8169 0000:06:00.0: eth0: link up [17344.584550] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready