Re: Question about USB keyboard remote wakeup from hibernation

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



On Thu, 2011-04-07 at 10:47 -0400, Alan Stern wrote:
> Please set up your email client to wrap lines after 72 columns or so.
> 
> On Thu, 7 Apr 2011, Xu, Andiry wrote:
> 
> > Hi,
> > 
> > Currently I'm facing a problem on USB remote wakeup from hibernation.
> > When plug a USB1.1 keyboard to EHCI/OHCI port, press button during suspend and hibernation can wakeup the system; However, when I plug the keyboard to xHCI port, press button can only wakeup the system from suspend, but not from hibernation.
> > 
> > I think the driver should treat the USB keyboard remote wakeup the same way for both suspend and hibernation(set remote wakeup request to the device, suspend it and the host, etc). I don't know why remote wakeup for suspend and hibernation behaves differently on xHCI port. Any suggestions? 
> 
> Can you post the dmesg log (with CONFIG_USB_DEBUG enabled) and a usbmon 
> trace?
> 
> > Another question is I can see usb_port_suspend() and xhci_pci_suspend() getting called during suspend, but I cannot see them called during hibernation, either by adding print message and using ftrace. Are they not called at all during hibernation, or just print message and ftrace fails to catch it? Thanks. 
> 
> They should be called, if everything is working right.  The dmesg log 
> will help answer these questions.
> 

Please see the attached usbmon trace and dmesg:
1.mon.out/dmesg1: S3 with USB keyboard plugged to xHCI controller as usb
7-3
2.mon.out/dmesg2: S4 with USB keyboard plugged to xHCI controller as usb
7-3 (use power button to wakeup)
3.mon.txt/dmesg3: S3 with USB keyboard plugged to OHCI controller as usb
3-5
4.mon.txt/dmesg3: S4 with USB keyboard plugged to OHCI controller as usb
3-5

Thanks,
Andiry


ffff8800375b3600 2183539485 C Ii:7:002:1 -2:8 0
ffff880067049d80 2183539517 S Co:7:002:0 s 00 03 0001 0000 0000 0
ffff880067049d80 2183541479 C Co:7:002:0 0 0
ffff880067049d80 2183541530 S Co:7:001:0 s 23 03 0002 0003 0000 0
ffff880067049d80 2183557942 C Co:7:001:0 0 0
ffff880066da3480 2183578039 C Ii:7:001:1 -2:2048 0
ffff8800664fe240 2191068023 S Ci:7:001:0 s a3 00 0000 0001 0004 4 <
ffff8800664fe240 2191068026 C Ci:7:001:0 0 4 = 00010000
ffff8800664fe240 2191068027 S Ci:7:001:0 s a3 00 0000 0002 0004 4 <
ffff8800664fe240 2191068029 C Ci:7:001:0 0 4 = 00010000
ffff8800664fe240 2191068030 S Ci:7:001:0 s a3 00 0000 0003 0004 4 <
ffff8800664fe240 2191068033 C Ci:7:001:0 0 4 = 03030400
ffff8800664fe240 2191068036 S Ci:7:001:0 s a3 00 0000 0004 0004 4 <
ffff8800664fe240 2191068038 C Ci:7:001:0 0 4 = 00010000
ffff880066da3480 2191068039 S Ii:7:001:1 -115:2048 4 <
ffff8800664fe240 2191068103 S Ci:7:001:0 s a3 00 0000 0003 0004 4 <
ffff8800664fe240 2191068105 C Ci:7:001:0 0 4 = 03030400
ffff8800664fe240 2191068106 S Co:7:001:0 s 23 01 0012 0003 0000 0
ffff8800664fe240 2191068109 C Co:7:001:0 0 0
ffff8800664fe240 2191068112 S Ci:7:002:0 s 80 00 0000 0000 0002 2 <
ffff8800664fe240 2191071024 C Ci:7:002:0 0 2 = 0200
ffff8800664fe240 2191071045 S Co:7:002:0 s 00 01 0001 0000 0000 0
ffff8800664fe240 2191073015 C Co:7:002:0 0 0
ffff8800375b3600 2191073042 S Ii:7:002:1 -115:8 8 <
ffff8800375b3600 2191081054 C Ii:7:002:1 0:8 8 = 00002800 00000000
ffff8800375b3600 2191081085 S Ii:7:002:1 -115:8 8 <
ffff8800375b3600 2190530813 C Ii:7:002:1 0:8 8 = 00000000 00000000
ffff8800375b3600 2190530841 S Ii:7:002:1 -115:8 8 <
ffff8800375b3e40 2194463578 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800664e1180 2194463856 S Ci:7:001:0 s a3 00 0000 0003 0004 4 <
ffff8800664e1180 2194463871 C Ci:7:001:0 0 4 = 03030000
ffff8800375b3e40 2194465788 C Co:7:002:0 0 1 >
ffff8800375b3e40 2194465802 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800375b3e40 2194468744 C Co:7:002:0 0 1 >
ffff8800375b3e40 2194468755 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800375b3e40 2194471736 C Co:7:002:0 0 1 >
ffff8800375b3e40 2194471742 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800375b3e40 2194474806 C Co:7:002:0 0 1 >
ffff8800375b3e40 2194474811 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800375b3e40 2194477743 C Co:7:002:0 0 1 >
ffff8800375b3600 2226154801 C Ii:7:002:1 -2:8 0
ffff880066da3480 2226154852 C Ii:7:001:1 -2:2048 0
ffff8800679b03c0 2298489801 S Co:7:001:0 s 23 03 0008 0001 0000 0
ffff8800679b03c0 2298489821 C Co:7:001:0 0 0
ffff8800679b03c0 2298489823 S Co:7:001:0 s 23 03 0008 0002 0000 0
ffff8800679b03c0 2298489829 C Co:7:001:0 0 0
ffff8800679b03c0 2298489829 S Co:7:001:0 s 23 03 0008 0003 0000 0
ffff8800679b03c0 2298489835 C Co:7:001:0 0 0
ffff8800679b03c0 2298489835 S Co:7:001:0 s 23 03 0008 0004 0000 0
ffff8800679b03c0 2298489841 C Co:7:001:0 0 0
ffff8800679b03c0 2299201617 S Ci:7:001:0 s a3 00 0000 0001 0004 4 <
ffff8800679b03c0 2299201622 C Ci:7:001:0 0 4 = 00010000
ffff8800679b03c0 2299201625 S Ci:7:001:0 s a3 00 0000 0002 0004 4 <
ffff8800679b03c0 2299201630 C Ci:7:001:0 0 4 = 00010000
ffff8800679b03c0 2299201631 S Ci:7:001:0 s a3 00 0000 0003 0004 4 <
ffff8800679b03c0 2299201633 C Ci:7:001:0 0 4 = 01010100
ffff8800679b03c0 2299201643 S Co:7:001:0 s 23 01 0010 0003 0000 0
ffff8800679b03c0 2299201646 C Co:7:001:0 0 0
ffff8800679b03c0 2299201647 S Ci:7:001:0 s a3 00 0000 0004 0004 4 <
ffff8800679b03c0 2299201649 C Ci:7:001:0 0 4 = 00010000
ffff880066da3480 2299311607 S Ii:7:001:1 -115:2048 4 <
ffff8800679b03c0 2299311647 S Ci:7:001:0 s a3 00 0000 0003 0004 4 <
ffff8800679b03c0 2299311652 C Ci:7:001:0 0 4 = 01010000
ffff8800679b03c0 2299311664 S Co:7:001:0 s 23 03 0004 0003 0000 0
ffff8800679b03c0 2299311668 C Co:7:001:0 0 0
ffff8800679b03c0 2299521609 S Ci:7:001:0 s a3 00 0000 0003 0004 4 <
ffff8800679b03c0 2299521614 C Ci:7:001:0 0 4 = 03030000
ffff8800679b03c0 2299581681 S Co:7:001:0 s 23 01 0014 0003 0000 0
ffff8800679b03c0 2299581687 C Co:7:001:0 0 0
ffff8800679b03c0 2299601608 S Ci:7:002:0 s 80 06 0100 0000 0008 8 <
ffff8800679b03c0 2299603767 C Ci:7:002:0 0 8 = 12011001 00000008
ffff8800679b03c0 2299603789 S Ci:7:002:0 s 80 06 0100 0000 0012 18 <
ffff8800679b03c0 2299608767 C Ci:7:002:0 0 18 = 12011001 00000008 6d0415c3 00280102 0001
ffff8800679b03c0 2299608797 S Ci:7:002:0 s 80 06 0200 0000 0022 34 <
ffff8800679b03c0 2299615767 C Ci:7:002:0 0 34 = 09022200 010100a0 32090400 00010301 01000921 10010001 22400007 05810308
ffff8800679b03c0 2299616065 S Co:7:002:0 s 00 09 0001 0000 0000 0
ffff8800679b03c0 2299617756 C Co:7:002:0 0 0
ffff8800679b03c0 2299617779 S Ci:7:002:0 s 80 00 0000 0000 0002 2 <
ffff8800679b03c0 2299620768 C Ci:7:002:0 0 2 = 0000
ffff8800679b03c0 2299620791 S Co:7:002:0 s 21 0a 0000 0000 0000 0
ffff8800679b03c0 2299622757 C Co:7:002:0 0 0
ffff8800375b3600 2299622776 S Ii:7:002:1 -115:8 8 <
ffff8800375b3e40 2300241714 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800679b0d80 2300242171 S Ci:7:001:0 s a3 00 0000 0003 0004 4 <
ffff8800679b0d80 2300242242 C Ci:7:001:0 0 4 = 03030000
ffff8800375b3e40 2300244740 C Co:7:002:0 0 1 >
ffff8800375b3e40 2300244746 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800375b3e40 2300247739 C Co:7:002:0 0 1 >
ffff8800375b3e40 2300247745 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800375b3e40 2300250741 C Co:7:002:0 0 1 >
ffff8800375b3e40 2300250747 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800375b3e40 2300253751 C Co:7:002:0 0 1 >
ffff8800375b3e40 2300253761 S Co:7:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800375b3e40 2300256776 C Co:7:002:0 0 1 >
ffff8800571d8b40 2894515096 C Ii:3:002:1 -2:8 0
ffff88006661c840 2894515136 S Co:3:002:0 s 00 03 0001 0000 0000 0
ffff88006661c840 2894516134 C Co:3:002:0 0 0
ffff88006661c840 2894516167 S Co:3:001:0 s 23 03 0002 0005 0000 0
ffff88006661c840 2894516169 C Co:3:001:0 0 0
ffff88005713bcc0 2894535605 C Ii:3:001:1 -2:128 0
ffff880059c68e40 2900617008 S Ci:3:001:0 s a3 00 0000 0001 0004 4 <
ffff880059c68e40 2900617013 C Ci:3:001:0 0 4 = 00010000
ffff880059c68e40 2900617015 S Ci:3:001:0 s a3 00 0000 0002 0004 4 <
ffff880059c68e40 2900617017 C Ci:3:001:0 0 4 = 00010000
ffff880059c68e40 2900617018 S Ci:3:001:0 s a3 00 0000 0003 0004 4 <
ffff880059c68e40 2900617019 C Ci:3:001:0 0 4 = 00010000
ffff880059c68e40 2900617020 S Ci:3:001:0 s a3 00 0000 0004 0004 4 <
ffff880059c68e40 2900617022 C Ci:3:001:0 0 4 = 00010000
ffff880059c68e40 2900617023 S Ci:3:001:0 s a3 00 0000 0005 0004 4 <
ffff880059c68e40 2900617029 C Ci:3:001:0 0 4 = 03030400
ffff88005713bcc0 2900617032 S Ii:3:001:1 -115:128 2 <
ffff880059c68e40 2900617063 S Ci:3:001:0 s a3 00 0000 0005 0004 4 <
ffff880059c68e40 2900617068 C Ci:3:001:0 0 4 = 03030400
ffff880059c68e40 2900617069 S Co:3:001:0 s 23 01 0012 0005 0000 0
ffff880059c68e40 2900617070 C Co:3:001:0 0 0
ffff880059c68e40 2900617073 S Ci:3:002:0 s 80 00 0000 0000 0002 2 <
ffff880059c68e40 2900618049 C Ci:3:002:0 0 2 = 0200
ffff880068ecc780 2900618082 S Co:3:002:0 s 00 01 0001 0000 0000 0
ffff880068ecc780 2900620048 C Co:3:002:0 0 0
ffff8800571d8b40 2900620075 S Ii:3:002:1 -115:8 8 <
ffff8800571d8b40 2900621048 C Ii:3:002:1 0:8 8 = 00002800 00000000
ffff8800571d8b40 2900621074 S Ii:3:002:1 -115:8 8 <
ffff8800571d8b40 2900629068 C Ii:3:002:1 0:8 8 = 00000000 00000000
ffff8800571d8b40 2900629103 S Ii:3:002:1 -115:8 8 <
ffff8800571d8d80 2909909806 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff880068ecca80 2909910216 S Ci:3:001:0 s a3 00 0000 0005 0004 4 <
ffff880068ecca80 2909910219 C Ci:3:001:0 0 4 = 03030000
ffff8800571d8d80 2909911025 C Co:3:002:0 0 1 >
ffff8800571d8d80 2909911028 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800571d8d80 2909912064 C Co:3:002:0 0 1 >
ffff8800571d8d80 2909912069 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800571d8d80 2909913053 C Co:3:002:0 0 1 >
ffff8800571d8d80 2909913057 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800571d8d80 2909914022 C Co:3:002:0 0 1 >
ffff8800571d8d80 2909914024 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800571d8d80 2909915031 C Co:3:002:0 0 1 >
ffff8800571d8b40 3014432954 C Ii:3:002:1 -2:8 0
ffff88005713bcc0 3014432983 C Ii:3:001:1 -2:128 0
ffff880066616b40 3086552325 S Co:3:001:0 s 23 03 0008 0001 0000 0
ffff880066616b40 3086552330 C Co:3:001:0 0 0
ffff880066616b40 3086552332 S Co:3:001:0 s 23 03 0008 0002 0000 0
ffff880066616b40 3086552333 C Co:3:001:0 0 0
ffff880066616b40 3086552333 S Co:3:001:0 s 23 03 0008 0003 0000 0
ffff880066616b40 3086552334 C Co:3:001:0 0 0
ffff880066616b40 3086552334 S Co:3:001:0 s 23 03 0008 0004 0000 0
ffff880066616b40 3086552335 C Co:3:001:0 0 0
ffff880066616b40 3086552335 S Co:3:001:0 s 23 03 0008 0005 0000 0
ffff880066616b40 3086552336 C Co:3:001:0 0 0
ffff880066616b40 3086662321 S Ci:3:001:0 s a3 00 0000 0001 0004 4 <
ffff880066616b40 3086662325 C Ci:3:001:0 0 4 = 00010000
ffff880066616b40 3086662328 S Ci:3:001:0 s a3 00 0000 0002 0004 4 <
ffff880066616b40 3086662329 C Ci:3:001:0 0 4 = 00010000
ffff880066616b40 3086662330 S Ci:3:001:0 s a3 00 0000 0003 0004 4 <
ffff880066616b40 3086662331 C Ci:3:001:0 0 4 = 00010000
ffff880066616b40 3086662332 S Ci:3:001:0 s a3 00 0000 0004 0004 4 <
ffff880066616b40 3086662334 C Ci:3:001:0 0 4 = 00010000
ffff880066616b40 3086662334 S Ci:3:001:0 s a3 00 0000 0005 0004 4 <
ffff880066616b40 3086662345 C Ci:3:001:0 0 4 = 01030100
ffff880066616b40 3086662348 S Co:3:001:0 s 23 01 0010 0005 0000 0
ffff880066616b40 3086662359 C Co:3:001:0 0 0
ffff88005713bcc0 3086772324 S Ii:3:001:1 -115:128 2 <
ffff8800666163c0 3086772357 S Ci:3:001:0 s a3 00 0000 0005 0004 4 <
ffff8800666163c0 3086772360 C Ci:3:001:0 0 4 = 01030000
ffff8800666163c0 3087413520 S Co:3:001:0 s 23 03 0004 0005 0000 0
ffff88005713bcc0 3087443209 C Ii:3:001:1 0:128 1 = 20
ffff88005713bcc0 3087443218 S Ii:3:001:1 -115:128 2 <
ffff8800666163c0 3087443347 C Co:3:001:0 0 0
ffff88005713bcc0 3087652317 C Ii:3:001:1 0:128 1 = 20
ffff88005713bcc0 3087652321 S Ii:3:001:1 -115:128 2 <
ffff88006646ab40 3087652340 S Ci:3:001:0 s a3 00 0000 0005 0004 4 <
ffff88006646ab40 3087652349 C Ci:3:001:0 0 4 = 03031000
ffff88006646ab40 3087712303 S Co:3:001:0 s 23 01 0014 0005 0000 0
ffff88006646ab40 3087712306 C Co:3:001:0 0 0
ffff88006646ab40 3087712318 S Ci:3:000:0 s 80 06 0100 0000 0040 64 <
ffff88006646ab40 3087713462 C Ci:3:000:0 0 18 = 12011001 00000008 6d0415c3 00280102 0001
ffff88006646ab40 3087713493 S Co:3:001:0 s 23 03 0004 0005 0000 0
ffff88006646ab40 3087743341 C Co:3:001:0 0 0
ffff88005713bcc0 3087902304 C Ii:3:001:1 0:128 1 = 20
ffff88005713bcc0 3087902308 S Ii:3:001:1 -115:128 2 <
ffff88006646ab40 3087952298 S Ci:3:001:0 s a3 00 0000 0005 0004 4 <
ffff88006646ab40 3087952312 C Ci:3:001:0 0 4 = 03031000
ffff88006646ab40 3088012234 S Co:3:001:0 s 23 01 0014 0005 0000 0
ffff88006646ab40 3088012237 C Co:3:001:0 0 0
ffff88006646ab40 3088012240 S Co:3:000:0 s 00 05 0002 0000 0000 0
ffff88006646ab40 3088013493 C Co:3:000:0 0 0
ffff88006646ab40 3088042303 S Ci:3:002:0 s 80 06 0100 0000 0012 18 <
ffff88006646ab40 3088044493 C Ci:3:002:0 0 18 = 12011001 00000008 6d0415c3 00280102 0001
ffff88006646ab40 3088044528 S Ci:3:002:0 s 80 06 0200 0000 0022 34 <
ffff88006646ab40 3088047493 C Ci:3:002:0 0 34 = 09022200 010100a0 32090400 00010301 01000921 10010001 22400007 05810308
ffff88006646ab40 3088047528 S Co:3:002:0 s 00 09 0001 0000 0000 0
ffff88006646ab40 3088049493 C Co:3:002:0 0 0
ffff88006646ab40 3088049529 S Ci:3:002:0 s 80 00 0000 0000 0002 2 <
ffff88006646ab40 3088051493 C Ci:3:002:0 0 2 = 0000
ffff88006646ab40 3088051528 S Co:3:002:0 s 21 0a 0000 0000 0000 0
ffff88006646ab40 3088053493 C Co:3:002:0 0 0
ffff8800571d8b40 3088053527 S Ii:3:002:1 -115:8 8 <
ffff8800571d8d80 3088053586 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800666163c0 3088053950 S Ci:3:001:0 s a3 00 0000 0005 0004 4 <
ffff8800666163c0 3088053954 C Ci:3:001:0 0 4 = 03030000
ffff8800571d8d80 3088055478 C Co:3:002:0 0 1 >
ffff8800571d8d80 3088055484 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800571d8d80 3088056474 C Co:3:002:0 0 1 >
ffff8800571d8d80 3088056478 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800571d8d80 3088057474 C Co:3:002:0 0 1 >
ffff8800571d8d80 3088057477 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800571d8d80 3088058407 C Co:3:002:0 0 1 >
ffff8800571d8d80 3088058408 S Co:3:002:0 s 21 09 0200 0000 0001 1 = 00
ffff8800571d8d80 3088059475 C Co:3:002:0 0 1 >
[  681.280695] EXT4-fs (sda7): re-mounted. Opts: errors=remount-ro,commit=0
[  682.032111] PM: Syncing filesystems ... done.
[  682.033142] PM: Preparing system for mem sleep
[  682.200487] Freezing user space processes ... (elapsed 0.01 seconds) done.
[  682.220146] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[  682.240151] PM: Entering mem sleep
[  682.240408] Suspending console(s) (use no_console_suspend to debug)
[  682.240775] sd 3:0:0:0: [sda] Synchronizing SCSI cache
[  682.240814] usb 4-3: usb suspend
[  682.241195] sd 3:0:0:0: [sda] Stopping disk
[  682.243765] i8042 kbd 00:07: wake-up capability enabled by ACPI
[  682.259902] pciehp 0000:00:15.2:pcie04: pciehp_suspend ENTRY
[  682.259964] sdhci-pci 0000:00:14.7: PCI INT A disabled
[  682.259989] HDA Intel 0000:00:14.2: PCI INT A disabled
[  682.262204] usb 7-3: usb suspend
[  682.262306] hub 4-0:1.0: hub_suspend
[  682.262311] usb usb4: bus suspend
[  682.262314] ohci_hcd 0000:00:13.0: suspend root hub
[  682.262336] HDA Intel 0000:01:05.1: PCI INT B disabled
[  682.262351] ACPI handle has no context!
[  682.280175] hub 7-0:1.0: hub_suspend
[  682.280186] usb usb7: bus suspend
[  682.281234] [drm] Disabling audio support
[  682.340140] PM: suspend of devices complete after 99.535 msecs
[  682.340143] PM: suspend devices took 0.100 seconds
[  682.340384] xhci_hcd 0000:02:00.0: wakeup: 0
[  682.360172] xhci_hcd 0000:02:00.0: --> PCI D3hot
[  682.360354] ohci_hcd 0000:00:14.5: wakeup: 1
[  682.360366] ohci_hcd 0000:00:14.5: wake-up capability enabled by ACPI
[  682.360369] ohci_hcd 0000:00:14.5: --> PCI D0
[  682.360447] ehci_hcd 0000:00:13.2: wakeup: 1
[  682.360451] ehci_hcd 0000:00:13.2: PME# enabled
[  682.360455] ehci_hcd 0000:00:13.2: wake-up capability enabled by ACPI
[  682.380123] ehci_hcd 0000:00:13.2: --> PCI D3hot
[  682.380147] ohci_hcd 0000:00:13.0: wakeup: 1
[  682.380159] ohci_hcd 0000:00:13.0: wake-up capability enabled by ACPI
[  682.380161] ohci_hcd 0000:00:13.0: --> PCI D0
[  682.380186] ehci_hcd 0000:00:12.2: wakeup: 1
[  682.380191] ehci_hcd 0000:00:12.2: PME# enabled
[  682.380195] ehci_hcd 0000:00:12.2: wake-up capability enabled by ACPI
[  682.400123] ehci_hcd 0000:00:12.2: --> PCI D3hot
[  682.400148] ohci_hcd 0000:00:12.0: wakeup: 1
[  682.400159] ohci_hcd 0000:00:12.0: wake-up capability enabled by ACPI
[  682.400162] ohci_hcd 0000:00:12.0: --> PCI D0
[  682.400210] xhci_hcd 0000:00:10.1: wakeup: 1
[  682.400215] xhci_hcd 0000:00:10.1: PME# enabled
[  682.400219] xhci_hcd 0000:00:10.1: wake-up capability enabled by ACPI
[  682.420123] xhci_hcd 0000:00:10.1: --> PCI D3hot
[  682.420175] xhci_hcd 0000:00:10.0: wakeup: 1
[  682.420181] xhci_hcd 0000:00:10.0: PME# enabled
[  682.420192] xhci_hcd 0000:00:10.0: wake-up capability enabled by ACPI
[  682.440123] xhci_hcd 0000:00:10.0: --> PCI D3hot
[  682.440189] PM: late suspend of devices complete after 100.042 msecs
[  682.440264] ACPI: Preparing to enter system sleep state S3
[  682.442566] PM: Saving platform NVS memory
[  682.461259] Disabling non-boot CPUs ...
[  682.462747] CPU 1 is now offline
[  682.462965] Back to C!
[  682.462965] PM: Restoring platform NVS memory
[  682.462965] Enabling non-boot CPUs ...
[  682.462965] Booting Node 0 Processor 1 APIC 0x1
[  682.462675] Switch to broadcast mode on CPU1
[  682.650122] Switched to NOHz mode on CPU #1
[  682.650199] CPU1 is up
[  682.651269] ACPI: Waking up from system sleep state S3
[  682.653252] pcieport 0000:00:04.0: restoring config space at offset 0xc (was 0xffff, writing 0x0)
[  682.653256] pcieport 0000:00:04.0: restoring config space at offset 0xa (was 0xffffffff, writing 0x0)
[  682.653260] pcieport 0000:00:04.0: restoring config space at offset 0x7 (was 0x1f1, writing 0x200001f1)
[  682.653265] pcieport 0000:00:04.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407)
[  682.653326] xhci_hcd 0000:00:10.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100406)
[  682.653360] xhci_hcd 0000:00:10.0: wake-up capability disabled by ACPI
[  682.653364] xhci_hcd 0000:00:10.0: PME# disabled
[  682.653410] xhci_hcd 0000:00:10.1: restoring config space at offset 0x1 (was 0x100006, writing 0x100406)
[  682.653441] xhci_hcd 0000:00:10.1: wake-up capability disabled by ACPI
[  682.653445] xhci_hcd 0000:00:10.1: PME# disabled
[  682.653472] ahci 0000:00:11.0: restoring config space at offset 0x1 (was 0x2300003, writing 0x2300407)
[  682.653517] ohci_hcd 0000:00:12.0: wake-up capability disabled by ACPI
[  682.670098] ehci_hcd 0000:00:12.2: BAR 0: set to [mem 0x9240c000-0x9240c0ff] (PCI address [0x9240c000-0x9240c0ff])
[  682.670127] ehci_hcd 0000:00:12.2: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00017)
[  682.670150] ehci_hcd 0000:00:12.2: wake-up capability disabled by ACPI
[  682.670154] ehci_hcd 0000:00:12.2: PME# disabled
[  682.670180] ohci_hcd 0000:00:13.0: wake-up capability disabled by ACPI
[  682.690094] ehci_hcd 0000:00:13.2: BAR 0: set to [mem 0x9240a000-0x9240a0ff] (PCI address [0x9240a000-0x9240a0ff])
[  682.690123] ehci_hcd 0000:00:13.2: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00017)
[  682.690145] ehci_hcd 0000:00:13.2: wake-up capability disabled by ACPI
[  682.690149] ehci_hcd 0000:00:13.2: PME# disabled
[  682.690260] ohci_hcd 0000:00:14.5: wake-up capability disabled by ACPI
[  682.690280] sdhci-pci 0000:00:14.7: restoring config space at offset 0x3 (was 0x800710, writing 0x804710)
[  682.690310] pcieport 0000:00:15.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
[  682.690314] pcieport 0000:00:15.0: restoring config space at offset 0x8 (was 0x0, writing 0xfff0)
[  682.690318] pcieport 0000:00:15.0: restoring config space at offset 0x7 (was 0x101, writing 0x1f1)
[  682.690322] pcieport 0000:00:15.0: restoring config space at offset 0x6 (was 0x0, writing 0x50500)
[  682.690328] pcieport 0000:00:15.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[  682.690333] pcieport 0000:00:15.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[  682.690378] pcieport 0000:00:15.2: restoring config space at offset 0x9 (was 0x10001, writing 0x90f19001)
[  682.690383] pcieport 0000:00:15.2: restoring config space at offset 0x8 (was 0x0, writing 0x92009110)
[  682.690387] pcieport 0000:00:15.2: restoring config space at offset 0x7 (was 0x101, writing 0x2121)
[  682.690391] pcieport 0000:00:15.2: restoring config space at offset 0x6 (was 0x0, writing 0xb0600)
[  682.690397] pcieport 0000:00:15.2: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[  682.690402] pcieport 0000:00:15.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[  682.690445] pcieport 0000:00:15.3: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
[  682.690449] pcieport 0000:00:15.3: restoring config space at offset 0x8 (was 0x0, writing 0x91009100)
[  682.690453] pcieport 0000:00:15.3: restoring config space at offset 0x7 (was 0x101, writing 0x1f1)
[  682.690457] pcieport 0000:00:15.3: restoring config space at offset 0x6 (was 0x0, writing 0xc0c00)
[  682.690463] pcieport 0000:00:15.3: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[  682.690468] pcieport 0000:00:15.3: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[  682.690545] HDA Intel 0000:01:05.1: restoring config space at offset 0x1 (was 0x100007, writing 0x100003)
[  682.690597] xhci_hcd 0000:02:00.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100406)
[  682.690681] tg3 0000:0c:00.0: restoring config space at offset 0x6 (was 0x4, writing 0x91010004)
[  682.690688] tg3 0000:0c:00.0: restoring config space at offset 0x4 (was 0x4, writing 0x91000004)
[  682.690694] tg3 0000:0c:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[  682.690701] tg3 0000:0c:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100006)
[  682.690786] PM: early resume of devices complete after 37.591 msecs
[  682.690891] xhci_hcd 0000:00:10.0: setting latency timer to 64
[  682.690946] xhci_hcd 0000:00:10.1: setting latency timer to 64
[  682.691034] ohci_hcd 0000:00:12.0: powerup ports
[  682.691073] ohci_hcd 0000:00:13.0: powerup ports
[  682.691126] ohci_hcd 0000:00:14.5: powerup ports
[  682.691129] HDA Intel 0000:00:14.2: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  682.691141] sdhci-pci 0000:00:14.7: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  682.691170] pciehp 0000:00:15.2:pcie04: pciehp_resume ENTRY
[  682.691181] HDA Intel 0000:01:05.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[  682.691190] xhci_hcd 0000:02:00.0: setting latency timer to 64
[  682.691192] HDA Intel 0000:01:05.1: setting latency timer to 64
[  682.691217] usb usb8: root hub lost power or was reset
[  682.691286] sd 3:0:0:0: [sda] Starting disk
[  682.691307] usb usb6: usb resume
[  682.691341] usb usb7: usb resume
[  682.691542] xhci_hcd 0000:02:00.0: irq 45 for MSI/MSI-X
[  682.691547] xhci_hcd 0000:02:00.0: irq 52 for MSI/MSI-X
[  682.691551] xhci_hcd 0000:02:00.0: irq 53 for MSI/MSI-X
[  682.694699] usb usb8: usb resume
[  682.694780] radeon 0000:01:05.0: setting latency timer to 64
[  682.695055] i8042 kbd 00:07: wake-up capability disabled by ACPI
[  682.710090] hub 6-0:1.0: hub_resume
[  682.710125] hub 7-0:1.0: hub_resume
[  682.710138] hub 7-0:1.0: port 3: status 0303 change 0004
[  682.710152] hub 8-0:1.0: hub_reset_resume
[  682.710154] hub 8-0:1.0: enabling power on all ports
[  682.710215] usb 7-3: finish resume
[  682.711762] radeon 0000:01:05.0: WB enabled
[  682.720129] usb usb1: usb resume
[  682.720134] ehci_hcd 0000:00:12.2: resume root hub
[  682.720145] usb usb4: usb resume
[  682.720150] ohci_hcd 0000:00:13.0: resume root hub
[  682.720176] usb usb2: usb resume
[  682.720178] ehci_hcd 0000:00:13.2: resume root hub
[  682.743769] [drm] ring test succeeded in 1 usecs
[  682.743783] [drm] ib test succeeded in 0 usecs
[  682.743784] [drm] Enabling audio support
[  682.760110] hub 1-0:1.0: hub_resume
[  682.790107] hub 2-0:1.0: hub_resume
[  682.830106] hub 4-0:1.0: hub_resume
[  682.830122] hub 4-0:1.0: port 3: status 0307 change 0000
[  682.830149] usb 4-3: usb resume
[  682.870116] ohci_hcd 0000:00:13.0: GetStatus roothub.portstatus [2] = 0x00040303 PSSC LSDA PPS PES CCS
[  682.890114] usb 4-3: finish resume
[  686.540103] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[  686.667892] ata4.00: configured for UDMA/133
[  686.713433] PM: resume of devices complete after 4022.605 msecs
[  686.713586] PM: resume devices took 4.020 seconds
[  686.713614] PM: Finishing wakeup.
[  686.713616] Restarting tasks ... 
[  686.713661] hub 6-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  686.713671] hub 7-0:1.0: state 7 ports 4 chg 0008 evt 0000
[  686.713687] hub 7-0:1.0: port 3, status 0303, change 0000, 1.5 Mb/s
[  686.713690] hub 1-0:1.0: state 7 ports 5 chg 0000 evt 0000
[  686.713694] hub 2-0:1.0: state 7 ports 5 chg 0000 evt 0000
[  686.713698] hub 8-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  686.713701] hub 4-0:1.0: state 7 ports 5 chg 0000 evt 0008
[  686.717402] done.
[  686.717415] video LNXVIDEO:00: Restoring backlight state
[  686.724190] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id
[  686.763227] tg3 0000:0c:00.0: irq 54 for MSI/MSI-X
[  686.880701] ADDRCONF(NETDEV_UP): eth0: link is not ready
[  687.215352] EXT4-fs (sda7): re-mounted. Opts: errors=remount-ro,commit=0
[  689.010102] hub 6-0:1.0: hub_suspend
[  689.010112] usb usb6: bus auto-suspend
[  689.010124] hub 1-0:1.0: hub_suspend
[  689.010127] usb usb1: bus auto-suspend
[  689.010129] ehci_hcd 0000:00:12.2: suspend root hub
[  689.010309] hub 2-0:1.0: hub_suspend
[  689.010312] usb usb2: bus auto-suspend
[  689.010313] ehci_hcd 0000:00:13.2: suspend root hub
[  689.010353] hub 8-0:1.0: hub_suspend
[  689.010356] usb usb8: bus auto-suspend
[  689.859545] tg3 0000:0c:00.0: eth0: Link is up at 1000 Mbps, full duplex
[  689.859549] tg3 0000:0c:00.0: eth0: Flow control is on for TX and on for RX
[  689.859813] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[  708.529648] EXT4-fs (sda7): re-mounted. Opts: errors=remount-ro,commit=0
[  709.482496] PM: Marking nosave pages: 000000000009b000 - 0000000000100000
[  709.482502] PM: Marking nosave pages: 000000006e3e1000 - 000000006e5e1000
[  709.482513] PM: Marking nosave pages: 000000006fd3f000 - 000000006fef6000
[  709.482522] PM: Basic memory bitmaps created
[  709.482524] PM: Syncing filesystems ... done.
[  709.597304] Freezing user space processes ... (elapsed 0.01 seconds) done.
[  709.610118] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[  709.630375] PM: Preallocating image memory... done (allocated 150921 pages)
[  709.713230] PM: Allocated 603684 kbytes in 0.08 seconds (7546.05 MB/s)
[  709.713233] Suspending console(s) (use no_console_suspend to debug)
[  709.713612] sd 3:0:0:0: [sda] Synchronizing SCSI cache
[  709.713664] hub 4-0:1.0: hub_suspend
[  709.713671] usb usb4: bus suspend
[  709.713675] ohci_hcd 0000:00:13.0: suspend root hub
[  709.713777] i8042 kbd 00:07: wake-up capability enabled by ACPI
[  709.713851] HDA Intel 0000:01:05.1: PCI INT B disabled
[  709.713867] ACPI handle has no context!
[  709.713943] pciehp 0000:00:15.2:pcie04: pciehp_suspend ENTRY
[  709.714004] sdhci-pci 0000:00:14.7: PCI INT A disabled
[  709.714026] HDA Intel 0000:00:14.2: PCI INT A disabled
[  709.722473] hub 7-0:1.0: hub_suspend
[  709.722482] usb usb7: bus suspend
[  709.754167] [drm] Disabling audio support
[  709.793449] PM: freeze of devices complete after 79.990 msecs
[  709.794118] PM: late freeze of devices complete after 0.666 msecs
[  709.794206] ACPI: Preparing to enter system sleep state S4
[  709.796505] PM: Saving platform NVS memory
[  709.814736] Disabling non-boot CPUs ...
[  709.816128] CPU 1 is now offline
[  709.816448] PM: Creating hibernation image:
[  709.824917] PM: Need to copy 150814 pages
[  709.824917] PM: Normal pages needed: 150814 + 1024, available pages: 306583
[  709.824917] PM: Restoring platform NVS memory
[  709.824917] Enabling non-boot CPUs ...
[  709.824917] Booting Node 0 Processor 1 APIC 0x1
[  709.824964] Switch to broadcast mode on CPU1
[  710.000124] Switched to NOHz mode on CPU #1
[  710.000203] CPU1 is up
[  710.001292] ACPI: Waking up from system sleep state S4
[  710.003411] pcieport 0000:00:04.0: restoring config space at offset 0x7 (was 0x200001f1, writing 0x1f1)
[  710.003470] xhci_hcd 0000:00:10.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100406)
[  710.003543] xhci_hcd 0000:00:10.1: restoring config space at offset 0x1 (was 0x100006, writing 0x100406)
[  710.003598] ahci 0000:00:11.0: restoring config space at offset 0x1 (was 0x2300403, writing 0x2300407)
[  710.003748] HDA Intel 0000:00:14.2: restoring config space at offset 0xf (was 0x107, writing 0x7)
[  710.003764] HDA Intel 0000:00:14.2: restoring config space at offset 0x3 (was 0x10, writing 0x4010)
[  710.003769] HDA Intel 0000:00:14.2: restoring config space at offset 0x1 (was 0x4100006, writing 0x4100002)
[  710.003857] sdhci-pci 0000:00:14.7: restoring config space at offset 0x1 (was 0x2300002, writing 0x2300006)
[  710.004050] HDA Intel 0000:01:05.1: restoring config space at offset 0x1 (was 0x100007, writing 0x100003)
[  710.004101] xhci_hcd 0000:02:00.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100406)
[  710.004308] PM: early restore of devices complete after 0.958 msecs
[  710.037540] xhci_hcd 0000:00:10.0: setting latency timer to 64
[  710.037545] usb usb6: root hub lost power or was reset
[  710.037889] xhci_hcd 0000:00:10.0: irq 46 for MSI/MSI-X
[  710.037893] xhci_hcd 0000:00:10.0: irq 47 for MSI/MSI-X
[  710.037897] xhci_hcd 0000:00:10.0: irq 48 for MSI/MSI-X
[  710.037912] xhci_hcd 0000:00:10.1: setting latency timer to 64
[  710.037918] usb usb7: root hub lost power or was reset
[  710.038342] xhci_hcd 0000:00:10.1: irq 49 for MSI/MSI-X
[  710.038347] xhci_hcd 0000:00:10.1: irq 50 for MSI/MSI-X
[  710.038351] xhci_hcd 0000:00:10.1: irq 51 for MSI/MSI-X
[  710.041189] ohci_hcd 0000:00:12.0: lost power
[  710.041235] ohci_hcd 0000:00:13.0: lost power
[  710.041268] HDA Intel 0000:00:14.2: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  710.041306] ohci_hcd 0000:00:14.5: lost power
[  710.041320] sdhci-pci 0000:00:14.7: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  710.041348] pciehp 0000:00:15.2:pcie04: pciehp_resume ENTRY
[  710.041366] radeon 0000:01:05.0: setting latency timer to 64
[  710.041515] HDA Intel 0000:01:05.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[  710.041519] HDA Intel 0000:01:05.1: setting latency timer to 64
[  710.041538] xhci_hcd 0000:02:00.0: setting latency timer to 64
[  710.041541] usb usb8: root hub lost power or was reset
[  710.041748] xhci_hcd 0000:02:00.0: irq 45 for MSI/MSI-X
[  710.041752] xhci_hcd 0000:02:00.0: irq 52 for MSI/MSI-X
[  710.041756] xhci_hcd 0000:02:00.0: irq 53 for MSI/MSI-X
[  710.045017] i8042 kbd 00:07: wake-up capability disabled by ACPI
[  710.045190] sd 3:0:0:0: [sda] Starting disk
[  710.045214] usb usb6: usb resume
[  710.045292] usb usb7: usb resume
[  710.045333] usb usb8: usb resume
[  710.060125] hub 7-0:1.0: hub_reset_resume
[  710.060129] hub 7-0:1.0: trying to enable port power on non-switchable hub
[  710.060158] hub 8-0:1.0: hub_reset_resume
[  710.060160] hub 8-0:1.0: enabling power on all ports
[  710.060204] hub 6-0:1.0: hub_reset_resume
[  710.060205] hub 6-0:1.0: trying to enable port power on non-switchable hub
[  710.063172] radeon 0000:01:05.0: WB enabled
[  710.095161] [drm] ring test succeeded in 1 usecs
[  710.095176] [drm] ib test succeeded in 0 usecs
[  710.095177] [drm] Enabling audio support
[  710.114153] ohci_hcd 0000:00:12.0: OHCI controller state
[  710.114166] ohci_hcd 0000:00:14.5: OHCI controller state
[  710.114194] ohci_hcd 0000:00:12.0: OHCI 1.0, NO legacy support registers
[  710.114197] ohci_hcd 0000:00:14.5: OHCI 1.0, NO legacy support registers
[  710.114200] ohci_hcd 0000:00:12.0: control 0x283 RWC HCFS=operational CBSR=3
[  710.114203] ohci_hcd 0000:00:14.5: control 0x283 RWC HCFS=operational CBSR=3
[  710.114206] ohci_hcd 0000:00:12.0: cmdstatus 0x00000 SOC=0
[  710.114209] ohci_hcd 0000:00:14.5: cmdstatus 0x00000 SOC=0
[  710.114212] ohci_hcd 0000:00:12.0: intrstatus 0x00000004 SF
[  710.114214] ohci_hcd 0000:00:14.5: intrstatus 0x00000004 SF
[  710.114217] ohci_hcd 0000:00:12.0: intrenable 0x8000005a MIE RHSC UE RD WDH
[  710.114220] ohci_hcd 0000:00:14.5: intrenable 0x8000005a MIE RHSC UE RD WDH
[  710.114230] ohci_hcd 0000:00:12.0: hcca frame #0005
[  710.114233] ohci_hcd 0000:00:14.5: hcca frame #0004
[  710.114237] ohci_hcd 0000:00:12.0: roothub.a 02001205 POTPGT=2 NOCP NPS NDP=5(5)
[  710.114240] ohci_hcd 0000:00:14.5: roothub.a 02001202 POTPGT=2 NOCP NPS NDP=2(2)
[  710.114242] ohci_hcd 0000:00:12.0: roothub.b 00000000 PPCM=0000 DR=0000
[  710.114245] ohci_hcd 0000:00:14.5: roothub.b 00000000 PPCM=0000 DR=0000
[  710.114247] ohci_hcd 0000:00:12.0: roothub.status 00008000 DRWE
[  710.114250] ohci_hcd 0000:00:14.5: roothub.status 00008000 DRWE
[  710.114252] ohci_hcd 0000:00:12.0: roothub.portstatus [0] 0x00000100 PPS
[  710.114255] ohci_hcd 0000:00:14.5: roothub.portstatus [0] 0x00000100 PPS
[  710.114258] ohci_hcd 0000:00:12.0: roothub.portstatus [1] 0x00000100 PPS
[  710.114261] ohci_hcd 0000:00:14.5: roothub.portstatus [1] 0x00000100 PPS
[  710.114264] ohci_hcd 0000:00:12.0: roothub.portstatus [2] 0x00000100 PPS
[  710.114266] ohci_hcd 0000:00:14.5: restart complete
[  710.114268] ohci_hcd 0000:00:12.0: roothub.portstatus [3] 0x00000100 PPS
[  710.114270] usb usb5: root hub lost power or was reset
[  710.114273] ohci_hcd 0000:00:12.0: roothub.portstatus [4] 0x00000100 PPS
[  710.114275] ohci_hcd 0000:00:14.5: suspend root hub
[  710.114277] ohci_hcd 0000:00:12.0: restart complete
[  710.114279] usb usb3: root hub lost power or was reset
[  710.114282] ohci_hcd 0000:00:12.0: suspend root hub
[  710.114333] usb usb1: root hub lost power or was reset
[  710.114339] ehci_hcd 0000:00:12.2: reset command 0010006 (park)=0 ithresh=1 period=512 Reset HALT
[  710.114346] ehci_hcd 0000:00:12.2: MWI active
[  710.114355] usb usb1: usb resume
[  710.114358] ehci_hcd 0000:00:12.2: resume root hub after power loss
[  710.118312] ohci_hcd 0000:00:13.0: OHCI controller state
[  710.118350] ohci_hcd 0000:00:13.0: OHCI 1.0, NO legacy support registers
[  710.118354] ohci_hcd 0000:00:13.0: control 0x283 RWC HCFS=operational CBSR=3
[  710.118357] ohci_hcd 0000:00:13.0: cmdstatus 0x00000 SOC=0
[  710.118361] ohci_hcd 0000:00:13.0: intrstatus 0x00000004 SF
[  710.118364] ohci_hcd 0000:00:13.0: intrenable 0x8000005a MIE RHSC UE RD WDH
[  710.118373] ohci_hcd 0000:00:13.0: hcca frame #0005
[  710.118376] ohci_hcd 0000:00:13.0: roothub.a 02001205 POTPGT=2 NOCP NPS NDP=5(5)
[  710.118379] ohci_hcd 0000:00:13.0: roothub.b 00000000 PPCM=0000 DR=0000
[  710.118382] ohci_hcd 0000:00:13.0: roothub.status 00008000 DRWE
[  710.118386] ohci_hcd 0000:00:13.0: roothub.portstatus [0] 0x00000100 PPS
[  710.118389] ohci_hcd 0000:00:13.0: roothub.portstatus [1] 0x00000100 PPS
[  710.118393] ohci_hcd 0000:00:13.0: roothub.portstatus [2] 0x00010100 CSC PPS
[  710.118396] ohci_hcd 0000:00:13.0: roothub.portstatus [3] 0x00000100 PPS
[  710.118400] ohci_hcd 0000:00:13.0: roothub.portstatus [4] 0x00000100 PPS
[  710.118402] ohci_hcd 0000:00:13.0: restart complete
[  710.118403] usb usb4: root hub lost power or was reset
[  710.118406] ohci_hcd 0000:00:13.0: suspend root hub
[  710.118427] usb usb4: usb resume
[  710.118456] usb usb2: root hub lost power or was reset
[  710.118465] ehci_hcd 0000:00:13.2: reset command 0010006 (park)=0 ithresh=1 period=512 Reset HALT
[  710.118472] ehci_hcd 0000:00:13.2: MWI active
[  710.118504] usb usb2: usb resume
[  710.118509] ehci_hcd 0000:00:13.2: resume root hub after power loss
[  710.140145] ohci_hcd 0000:00:13.0: resume root hub
[  710.150134] hub 1-0:1.0: hub_reset_resume
[  710.150139] hub 1-0:1.0: trying to enable port power on non-switchable hub
[  710.170140] ehci_hcd 0000:00:13.2: port 3 low speed --> companion
[  710.170170] hub 7-0:1.0: port 3: status 0101 change 0001
[  710.250139] hub 4-0:1.0: hub_reset_resume
[  710.250143] hub 4-0:1.0: trying to enable port power on non-switchable hub
[  710.270144] ehci_hcd 0000:00:13.2: GetStatus port:3 status 003002 0  ACK POWER OWNER sig=se0 CSC
[  710.280176] usb 7-3: finish reset-resume
[  710.290136] hub 2-0:1.0: hub_reset_resume
[  710.290141] hub 2-0:1.0: trying to enable port power on non-switchable hub
[  710.360156] ohci_hcd 0000:00:13.0: GetStatus roothub.portstatus [2] = 0x00010301 CSC LSDA PPS CCS
[  710.360160] hub 4-0:1.0: port 3: status 0301 change 0001
[  710.470166] usb 4-3: finish reset-resume
[  710.550212] usb 7-3: reset low speed USB device using xhci_hcd and address 2
[  710.584657] xhci_hcd 0000:00:10.1: xHCI xhci_drop_endpoint called with disabled ep ffff88006900a4c0
[  710.584670] usb 7-3: ep 0x81 - rounding interval to 64 microframes, ep desc says 80 microframes
[  710.584922] usb 7-3: Successful Endpoint Configure command
[  710.600053] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[  710.600863] ohci_hcd 0000:00:13.0: port[2] reset timeout, stat 00000311
[  710.603812] ata4.00: configured for UDMA/133
[  710.810127] ohci_hcd 0000:00:13.0: GetStatus roothub.portstatus [2] = 0x00100303 PRSC LSDA PPS PES CCS
[  710.870128] usb 4-3: reset low speed USB device using ohci_hcd and address 2
[  711.160127] ohci_hcd 0000:00:13.0: GetStatus roothub.portstatus [2] = 0x00100303 PRSC LSDA PPS PES CCS
[  711.260301] PM: restore of devices complete after 1222.875 msecs
[  711.260485] PM: Image restored successfully.
[  711.260486] Restarting tasks ... 
[  711.260533] hub 6-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  711.260548] hub 8-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  711.260552] hub 1-0:1.0: state 7 ports 5 chg 0000 evt 0000
[  711.260556] hub 7-0:1.0: state 7 ports 4 chg 0008 evt 0000
[  711.260566] hub 7-0:1.0: port 3, status 0303, change 0000, 1.5 Mb/s
[  711.260570] hub 2-0:1.0: state 7 ports 5 chg 0000 evt 0000
[  711.260574] hub 4-0:1.0: state 7 ports 5 chg 0008 evt 0008
[  711.260580] hub 4-0:1.0: port 3, status 0303, change 0000, 1.5 Mb/s
[  711.264025] done.
[  711.264040] PM: Basic memory bitmaps freed
[  711.264050] video LNXVIDEO:00: Restoring backlight state
[  711.265253] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id
[  711.311993] tg3 0000:0c:00.0: irq 54 for MSI/MSI-X
[  711.410255] ADDRCONF(NETDEV_UP): eth0: link is not ready
[  711.709921] EXT4-fs (sda7): re-mounted. Opts: errors=remount-ro,commit=0
[  714.020141] hub 6-0:1.0: hub_suspend
[  714.020151] usb usb6: bus auto-suspend
[  714.020169] hub 8-0:1.0: hub_suspend
[  714.020172] usb usb8: bus auto-suspend
[  714.020192] hub 1-0:1.0: hub_suspend
[  714.020195] usb usb1: bus auto-suspend
[  714.020197] ehci_hcd 0000:00:12.2: suspend root hub
[  714.020840] hub 2-0:1.0: hub_suspend
[  714.020843] usb usb2: bus auto-suspend
[  714.020844] ehci_hcd 0000:00:13.2: suspend root hub
[  714.450280] tg3 0000:0c:00.0: eth0: Link is up at 1000 Mbps, full duplex
[  714.450284] tg3 0000:0c:00.0: eth0: Flow control is on for TX and on for RX
[  714.450548] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[  193.779071] EXT4-fs (sda7): re-mounted. Opts: errors=remount-ro,commit=0
[  194.655131] PM: Syncing filesystems ... done.
[  194.656132] PM: Preparing system for mem sleep
[  194.780646] Freezing user space processes ... (elapsed 0.01 seconds) done.
[  194.800158] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[  194.820157] PM: Entering mem sleep
[  194.820412] Suspending console(s) (use no_console_suspend to debug)
[  194.820768] usb 4-3: usb suspend
[  194.820784] sd 3:0:0:0: [sda] Synchronizing SCSI cache
[  194.821180] sd 3:0:0:0: [sda] Stopping disk
[  194.822324] usb 3-5: usb suspend
[  194.823479] i8042 kbd 00:07: wake-up capability enabled by ACPI
[  194.840127] hub 4-0:1.0: hub_suspend
[  194.840135] usb usb4: bus suspend
[  194.840139] ohci_hcd 0000:00:13.0: suspend root hub
[  194.841726] hub 3-0:1.0: hub_suspend
[  194.841736] usb usb3: bus suspend
[  194.841740] ohci_hcd 0000:00:12.0: suspend root hub
[  194.841804] sdhci-pci 0000:00:14.7: PCI INT A disabled
[  194.841817] ohci_hcd 0000:00:14.5: PCI INT C disabled
[  194.842431] pciehp 0000:00:15.2:pcie04: pciehp_suspend ENTRY
[  194.842441] ehci_hcd 0000:00:13.2: PCI INT B disabled
[  194.842453] ohci_hcd 0000:00:13.0: PCI INT A disabled
[  194.842460] ehci_hcd 0000:00:12.2: PCI INT B disabled
[  194.842472] ohci_hcd 0000:00:12.0: PCI INT A disabled
[  194.916961] [drm] Disabling audio support
[  194.950112] HDA Intel 0000:00:14.2: PCI INT A disabled
[  194.950190] HDA Intel 0000:01:05.1: PCI INT B disabled
[  194.950204] ACPI handle has no context!
[  194.957401] radeon 0000:01:05.0: PCI INT A disabled
[  194.970142] PM: suspend of devices complete after 149.536 msecs
[  194.970146] PM: suspend devices took 0.150 seconds
[  194.970386] xhci_hcd 0000:02:00.0: wakeup: 0
[  194.990180] xhci_hcd 0000:02:00.0: --> PCI D3hot
[  194.990263] ohci_hcd 0000:00:14.5: wakeup: 1
[  194.990275] ohci_hcd 0000:00:14.5: wake-up capability enabled by ACPI
[  194.990277] ohci_hcd 0000:00:14.5: --> PCI D0
[  194.990355] ehci_hcd 0000:00:13.2: wakeup: 1
[  194.990359] ehci_hcd 0000:00:13.2: PME# enabled
[  194.990363] ehci_hcd 0000:00:13.2: wake-up capability enabled by ACPI
[  195.010136] ehci_hcd 0000:00:13.2: --> PCI D3hot
[  195.010161] ohci_hcd 0000:00:13.0: wakeup: 1
[  195.010173] ohci_hcd 0000:00:13.0: wake-up capability enabled by ACPI
[  195.010175] ohci_hcd 0000:00:13.0: --> PCI D0
[  195.010200] ehci_hcd 0000:00:12.2: wakeup: 1
[  195.010205] ehci_hcd 0000:00:12.2: PME# enabled
[  195.010208] ehci_hcd 0000:00:12.2: wake-up capability enabled by ACPI
[  195.030127] ehci_hcd 0000:00:12.2: --> PCI D3hot
[  195.030152] ohci_hcd 0000:00:12.0: wakeup: 1
[  195.030164] ohci_hcd 0000:00:12.0: wake-up capability enabled by ACPI
[  195.030166] ohci_hcd 0000:00:12.0: --> PCI D0
[  195.030214] xhci_hcd 0000:00:10.1: wakeup: 1
[  195.030219] xhci_hcd 0000:00:10.1: PME# enabled
[  195.030223] xhci_hcd 0000:00:10.1: wake-up capability enabled by ACPI
[  195.050139] xhci_hcd 0000:00:10.1: --> PCI D3hot
[  195.050190] xhci_hcd 0000:00:10.0: wakeup: 1
[  195.050196] xhci_hcd 0000:00:10.0: PME# enabled
[  195.050207] xhci_hcd 0000:00:10.0: wake-up capability enabled by ACPI
[  195.070129] xhci_hcd 0000:00:10.0: --> PCI D3hot
[  195.070177] PM: late suspend of devices complete after 100.028 msecs
[  195.070259] ACPI: Preparing to enter system sleep state S3
[  195.072581] PM: Saving platform NVS memory
[  195.090515] Disabling non-boot CPUs ...
[  195.090776] Broke affinity for irq 1
[  195.090799] Broke affinity for irq 44
[  195.091965] CPU 1 is now offline
[  195.092211] Back to C!
[  195.092211] PM: Restoring platform NVS memory
[  195.092211] Enabling non-boot CPUs ...
[  195.092211] Booting Node 0 Processor 1 APIC 0x1
[  195.091893] Switch to broadcast mode on CPU1
[  195.280122] Switched to NOHz mode on CPU #1
[  195.280200] CPU1 is up
[  195.281269] ACPI: Waking up from system sleep state S3
[  195.283253] pcieport 0000:00:04.0: restoring config space at offset 0xc (was 0xffff, writing 0x0)
[  195.283257] pcieport 0000:00:04.0: restoring config space at offset 0xa (was 0xffffffff, writing 0x0)
[  195.283261] pcieport 0000:00:04.0: restoring config space at offset 0x7 (was 0x1f1, writing 0x200001f1)
[  195.283266] pcieport 0000:00:04.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407)
[  195.283327] xhci_hcd 0000:00:10.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100402)
[  195.283361] xhci_hcd 0000:00:10.0: wake-up capability disabled by ACPI
[  195.283365] xhci_hcd 0000:00:10.0: PME# disabled
[  195.283410] xhci_hcd 0000:00:10.1: restoring config space at offset 0x1 (was 0x100006, writing 0x100402)
[  195.283442] xhci_hcd 0000:00:10.1: wake-up capability disabled by ACPI
[  195.283446] xhci_hcd 0000:00:10.1: PME# disabled
[  195.283473] ahci 0000:00:11.0: restoring config space at offset 0x1 (was 0x2300003, writing 0x2300407)
[  195.283518] ohci_hcd 0000:00:12.0: wake-up capability disabled by ACPI
[  195.300094] ehci_hcd 0000:00:12.2: BAR 0: set to [mem 0x9240c000-0x9240c0ff] (PCI address [0x9240c000-0x9240c0ff])
[  195.300123] ehci_hcd 0000:00:12.2: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00013)
[  195.300145] ehci_hcd 0000:00:12.2: wake-up capability disabled by ACPI
[  195.300150] ehci_hcd 0000:00:12.2: PME# disabled
[  195.300175] ohci_hcd 0000:00:13.0: wake-up capability disabled by ACPI
[  195.320094] ehci_hcd 0000:00:13.2: BAR 0: set to [mem 0x9240a000-0x9240a0ff] (PCI address [0x9240a000-0x9240a0ff])
[  195.320122] ehci_hcd 0000:00:13.2: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00013)
[  195.320144] ehci_hcd 0000:00:13.2: wake-up capability disabled by ACPI
[  195.320149] ehci_hcd 0000:00:13.2: PME# disabled
[  195.320260] ohci_hcd 0000:00:14.5: wake-up capability disabled by ACPI
[  195.320280] sdhci-pci 0000:00:14.7: restoring config space at offset 0x3 (was 0x800710, writing 0x804710)
[  195.320310] pcieport 0000:00:15.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
[  195.320314] pcieport 0000:00:15.0: restoring config space at offset 0x8 (was 0x0, writing 0xfff0)
[  195.320318] pcieport 0000:00:15.0: restoring config space at offset 0x7 (was 0x101, writing 0x1f1)
[  195.320322] pcieport 0000:00:15.0: restoring config space at offset 0x6 (was 0x0, writing 0x50500)
[  195.320328] pcieport 0000:00:15.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[  195.320333] pcieport 0000:00:15.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[  195.320378] pcieport 0000:00:15.2: restoring config space at offset 0x9 (was 0x10001, writing 0x90f19001)
[  195.320382] pcieport 0000:00:15.2: restoring config space at offset 0x8 (was 0x0, writing 0x92009110)
[  195.320387] pcieport 0000:00:15.2: restoring config space at offset 0x7 (was 0x101, writing 0x2121)
[  195.320391] pcieport 0000:00:15.2: restoring config space at offset 0x6 (was 0x0, writing 0xb0600)
[  195.320396] pcieport 0000:00:15.2: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[  195.320401] pcieport 0000:00:15.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[  195.320445] pcieport 0000:00:15.3: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
[  195.320449] pcieport 0000:00:15.3: restoring config space at offset 0x8 (was 0x0, writing 0x91009100)
[  195.320453] pcieport 0000:00:15.3: restoring config space at offset 0x7 (was 0x101, writing 0x1f1)
[  195.320457] pcieport 0000:00:15.3: restoring config space at offset 0x6 (was 0x0, writing 0xc0c00)
[  195.320463] pcieport 0000:00:15.3: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[  195.320468] pcieport 0000:00:15.3: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[  195.320528] radeon 0000:01:05.0: restoring config space at offset 0x1 (was 0x100003, writing 0x100007)
[  195.320547] HDA Intel 0000:01:05.1: restoring config space at offset 0x1 (was 0x100007, writing 0x100003)
[  195.320600] xhci_hcd 0000:02:00.0: restoring config space at offset 0x1 (was 0x100002, writing 0x100402)
[  195.320683] tg3 0000:0c:00.0: restoring config space at offset 0x6 (was 0x4, writing 0x91010004)
[  195.320690] tg3 0000:0c:00.0: restoring config space at offset 0x4 (was 0x4, writing 0x91000004)
[  195.320696] tg3 0000:0c:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[  195.320703] tg3 0000:0c:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100006)
[  195.320789] PM: early resume of devices complete after 37.593 msecs
[  195.320896] xhci_hcd 0000:00:10.0: setting latency timer to 64
[  195.320954] xhci_hcd 0000:00:10.1: setting latency timer to 64
[  195.321049] ohci_hcd 0000:00:12.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[  195.321056] ohci_hcd 0000:00:12.0: powerup ports
[  195.321073] ehci_hcd 0000:00:12.2: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[  195.321105] ohci_hcd 0000:00:13.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[  195.321108] ehci_hcd 0000:00:13.2: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[  195.321114] ohci_hcd 0000:00:13.0: powerup ports
[  195.321132] HDA Intel 0000:00:14.2: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  195.321142] ohci_hcd 0000:00:14.5: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[  195.321149] ohci_hcd 0000:00:14.5: powerup ports
[  195.321160] sdhci-pci 0000:00:14.7: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  195.321172] pciehp 0000:00:15.2:pcie04: pciehp_resume ENTRY
[  195.321190] HDA Intel 0000:01:05.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[  195.321194] radeon 0000:01:05.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[  195.321196] HDA Intel 0000:01:05.1: setting latency timer to 64
[  195.321198] radeon 0000:01:05.0: setting latency timer to 64
[  195.321220] xhci_hcd 0000:02:00.0: setting latency timer to 64
[  195.321251] usb usb8: root hub lost power or was reset
[  195.321550] xhci_hcd 0000:02:00.0: irq 51 for MSI/MSI-X
[  195.321554] xhci_hcd 0000:02:00.0: irq 52 for MSI/MSI-X
[  195.321557] xhci_hcd 0000:02:00.0: irq 53 for MSI/MSI-X
[  195.325010] i8042 kbd 00:07: wake-up capability disabled by ACPI
[  195.325358] sd 3:0:0:0: [sda] Starting disk
[  195.325446] usb usb6: usb resume
[  195.325544] usb usb7: usb resume
[  195.325609] usb usb8: usb resume
[  195.338722] radeon 0000:01:05.0: WB enabled
[  195.340095] hub 6-0:1.0: hub_resume
[  195.340123] hub 7-0:1.0: hub_resume
[  195.340139] hub 8-0:1.0: hub_reset_resume
[  195.340141] hub 8-0:1.0: enabling power on all ports
[  195.350099] usb usb4: usb resume
[  195.350106] ohci_hcd 0000:00:13.0: resume root hub
[  195.350110] usb usb5: usb resume
[  195.350115] ohci_hcd 0000:00:14.5: resume root hub
[  195.350155] usb usb2: usb resume
[  195.350158] ehci_hcd 0000:00:13.2: resume root hub
[  195.360061] usb usb3: usb resume
[  195.360066] ohci_hcd 0000:00:12.0: wakeup root hub
[  195.360110] usb usb1: usb resume
[  195.360113] ehci_hcd 0000:00:12.2: resume root hub
[  195.370728] [drm] ring test succeeded in 1 usecs
[  195.370743] [drm] ib test succeeded in 0 usecs
[  195.370744] [drm] Enabling audio support
[  195.420096] hub 2-0:1.0: hub_resume
[  195.430099] hub 1-0:1.0: hub_resume
[  195.460094] hub 5-0:1.0: hub_resume
[  195.460120] hub 4-0:1.0: hub_resume
[  195.460128] hub 4-0:1.0: port 3: status 0307 change 0000
[  195.460163] usb 4-3: usb resume
[  195.470094] hub 3-0:1.0: hub_resume
[  195.470120] ohci_hcd 0000:00:12.0: GetStatus roothub.portstatus [4] = 0x00040303 PSSC LSDA PPS PES CCS
[  195.470124] hub 3-0:1.0: port 5: status 0303 change 0004
[  195.470160] ohci_hcd 0000:00:12.0: GetStatus roothub.portstatus [4] = 0x00040303 PSSC LSDA PPS PES CCS
[  195.470165] usb 3-5: finish resume
[  195.500116] ohci_hcd 0000:00:13.0: GetStatus roothub.portstatus [2] = 0x00040303 PSSC LSDA PPS PES CCS
[  195.520113] usb 4-3: finish resume
[  196.540078] ohci_hcd 0000:00:14.5: auto-stop root hub
[  199.170107] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[  199.171818] ata4.00: n_sectors mismatch 625142448 != 625140335
[  199.171821] ata4.00: old n_sectors matches native, probably late HPA lock, will try to unlock HPA
[  199.171823] ata4.00: revalidation failed (errno=-5)
[  204.720102] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[  204.725572] ata4.00: configured for UDMA/133
[  204.762950] PM: resume of devices complete after 9442.120 msecs
[  204.763116] PM: resume devices took 9.440 seconds
[  204.763224] PM: Finishing wakeup.
[  204.763225] Restarting tasks ... 
[  204.763266] hub 6-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  204.763276] hub 7-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  204.763280] hub 2-0:1.0: state 7 ports 5 chg 0000 evt 0000
[  204.763284] hub 1-0:1.0: state 7 ports 5 chg 0000 evt 0000
[  204.763288] hub 8-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  204.763291] hub 5-0:1.0: state 7 ports 2 chg 0000 evt 0000
[  204.763295] hub 4-0:1.0: state 7 ports 5 chg 0000 evt 0008
[  204.763306] hub 3-0:1.0: state 7 ports 5 chg 0020 evt 0000
[  204.763315] hub 3-0:1.0: port 5, status 0303, change 0000, 1.5 Mb/s
[  204.777332] done.
[  204.777355] video LNXVIDEO:00: Restoring backlight state
[  204.968262] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id
[  205.003713] tg3 0000:0c:00.0: irq 54 for MSI/MSI-X
[  205.120412] ADDRCONF(NETDEV_UP): eth0: link is not ready
[  206.537247] EXT4-fs (sda7): re-mounted. Opts: errors=remount-ro,commit=0
[  207.010111] hub 6-0:1.0: hub_suspend
[  207.010121] usb usb6: bus auto-suspend
[  207.010133] hub 7-0:1.0: hub_suspend
[  207.010136] usb usb7: bus auto-suspend
[  207.010146] hub 2-0:1.0: hub_suspend
[  207.010149] usb usb2: bus auto-suspend
[  207.010151] ehci_hcd 0000:00:13.2: suspend root hub
[  207.010616] hub 1-0:1.0: hub_suspend
[  207.010619] usb usb1: bus auto-suspend
[  207.010621] ehci_hcd 0000:00:12.2: suspend root hub
[  207.011573] hub 8-0:1.0: hub_suspend
[  207.011575] usb usb8: bus auto-suspend
[  207.011595] hub 5-0:1.0: hub_suspend
[  207.011598] usb usb5: bus auto-suspend
[  207.011601] ohci_hcd 0000:00:14.5: suspend root hub
[  208.120992] tg3 0000:0c:00.0: eth0: Link is up at 1000 Mbps, full duplex
[  208.120997] tg3 0000:0c:00.0: eth0: Flow control is on for TX and on for RX
[  208.121267] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[  307.129856] EXT4-fs (sda7): re-mounted. Opts: errors=remount-ro,commit=0
[  308.112541] PM: Marking nosave pages: 000000000009b000 - 0000000000100000
[  308.112546] PM: Marking nosave pages: 000000006e3e1000 - 000000006e5e1000
[  308.112557] PM: Marking nosave pages: 000000006fd3f000 - 000000006fef6000
[  308.112567] PM: Basic memory bitmaps created
[  308.112568] PM: Syncing filesystems ... done.
[  308.276542] Freezing user space processes ... (elapsed 0.01 seconds) done.
[  308.290117] Freezing remaining freezable tasks ... (elapsed 0.02 seconds) done.
[  308.310383] PM: Preallocating image memory... done (allocated 151213 pages)
[  308.393616] PM: Allocated 604852 kbytes in 0.08 seconds (7560.65 MB/s)
[  308.393619] Suspending console(s) (use no_console_suspend to debug)
[  308.393969] sd 3:0:0:0: [sda] Synchronizing SCSI cache
[  308.394085] hub 4-0:1.0: hub_suspend
[  308.394091] usb usb4: bus suspend
[  308.394095] ohci_hcd 0000:00:13.0: suspend root hub
[  308.394195] hub 3-0:1.0: hub_suspend
[  308.394194] i8042 kbd 00:07: wake-up capability enabled by ACPI
[  308.394201] usb usb3: bus suspend
[  308.394203] ohci_hcd 0000:00:12.0: suspend root hub
[  308.394237] HDA Intel 0000:01:05.1: PCI INT B disabled
[  308.394251] ACPI handle has no context!
[  308.394285] pciehp 0000:00:15.2:pcie04: pciehp_suspend ENTRY
[  308.394363] sdhci-pci 0000:00:14.7: PCI INT A disabled
[  308.394385] HDA Intel 0000:00:14.2: PCI INT A disabled
[  308.437629] [drm] Disabling audio support
[  308.478211] PM: freeze of devices complete after 84.360 msecs
[  308.478900] PM: late freeze of devices complete after 0.685 msecs
[  308.478988] ACPI: Preparing to enter system sleep state S4
[  308.481259] PM: Saving platform NVS memory
[  308.498334] Disabling non-boot CPUs ...
[  308.510185] Broke affinity for irq 18
[  308.511298] CPU 1 is now offline
[  308.511628] PM: Creating hibernation image:
[  308.520102] PM: Need to copy 151561 pages
[  308.520102] PM: Normal pages needed: 151561 + 1024, available pages: 305836
[  308.520102] PM: Restoring platform NVS memory
[  308.520102] Enabling non-boot CPUs ...
[  308.520102] Booting Node 0 Processor 1 APIC 0x1
[  308.511258] Switch to broadcast mode on CPU1
[  308.700122] Switched to NOHz mode on CPU #1
[  308.700201] CPU1 is up
[  308.701261] ACPI: Waking up from system sleep state S4
[  308.703383] pcieport 0000:00:04.0: restoring config space at offset 0x7 (was 0x200001f1, writing 0x1f1)
[  308.703442] xhci_hcd 0000:00:10.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100406)
[  308.703515] xhci_hcd 0000:00:10.1: restoring config space at offset 0x1 (was 0x100006, writing 0x100406)
[  308.703570] ahci 0000:00:11.0: restoring config space at offset 0x1 (was 0x2300403, writing 0x2300407)
[  308.703721] HDA Intel 0000:00:14.2: restoring config space at offset 0xf (was 0x107, writing 0x7)
[  308.703737] HDA Intel 0000:00:14.2: restoring config space at offset 0x3 (was 0x10, writing 0x4010)
[  308.703742] HDA Intel 0000:00:14.2: restoring config space at offset 0x1 (was 0x4100006, writing 0x4100002)
[  308.703831] sdhci-pci 0000:00:14.7: restoring config space at offset 0x1 (was 0x2300002, writing 0x2300006)
[  308.704025] HDA Intel 0000:01:05.1: restoring config space at offset 0x1 (was 0x100007, writing 0x100003)
[  308.704076] xhci_hcd 0000:02:00.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100406)
[  308.704284] PM: early restore of devices complete after 0.962 msecs
[  308.737900] xhci_hcd 0000:00:10.0: setting latency timer to 64
[  308.737906] usb usb6: root hub lost power or was reset
[  308.737920] xhci_hcd 0000:00:10.1: setting latency timer to 64
[  308.737925] usb usb7: root hub lost power or was reset
[  308.738321] xhci_hcd 0000:00:10.0: irq 45 for MSI/MSI-X
[  308.738325] xhci_hcd 0000:00:10.0: irq 46 for MSI/MSI-X
[  308.738329] xhci_hcd 0000:00:10.0: irq 47 for MSI/MSI-X
[  308.738378] xhci_hcd 0000:00:10.1: irq 48 for MSI/MSI-X
[  308.738382] xhci_hcd 0000:00:10.1: irq 49 for MSI/MSI-X
[  308.738387] xhci_hcd 0000:00:10.1: irq 50 for MSI/MSI-X
[  308.741541] ohci_hcd 0000:00:13.0: lost power
[  308.741575] HDA Intel 0000:00:14.2: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  308.741578] ohci_hcd 0000:00:12.0: lost power
[  308.741609] ohci_hcd 0000:00:14.5: lost power
[  308.741612] sdhci-pci 0000:00:14.7: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  308.741637] pciehp 0000:00:15.2:pcie04: pciehp_resume ENTRY
[  308.741649] radeon 0000:01:05.0: setting latency timer to 64
[  308.741653] HDA Intel 0000:01:05.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[  308.741657] HDA Intel 0000:01:05.1: setting latency timer to 64
[  308.741677] xhci_hcd 0000:02:00.0: setting latency timer to 64
[  308.741681] usb usb8: root hub lost power or was reset
[  308.741890] xhci_hcd 0000:02:00.0: irq 51 for MSI/MSI-X
[  308.741894] xhci_hcd 0000:02:00.0: irq 52 for MSI/MSI-X
[  308.741898] xhci_hcd 0000:02:00.0: irq 53 for MSI/MSI-X
[  308.745220] sd 3:0:0:0: [sda] Starting disk
[  308.745253] usb usb6: usb resume
[  308.745289] usb usb7: usb resume
[  308.745326] usb usb8: usb resume
[  308.750528] i8042 kbd 00:07: wake-up capability disabled by ACPI
[  308.760155] hub 7-0:1.0: hub_reset_resume
[  308.760159] hub 7-0:1.0: trying to enable port power on non-switchable hub
[  308.760206] hub 6-0:1.0: hub_reset_resume
[  308.760208] hub 6-0:1.0: trying to enable port power on non-switchable hub
[  308.760247] hub 8-0:1.0: hub_reset_resume
[  308.760249] hub 8-0:1.0: enabling power on all ports
[  308.766563] radeon 0000:01:05.0: WB enabled
[  308.798573] [drm] ring test succeeded in 1 usecs
[  308.798587] [drm] ib test succeeded in 0 usecs
[  308.798589] [drm] Enabling audio support
[  308.804084] ohci_hcd 0000:00:13.0: OHCI controller state
[  308.804125] ohci_hcd 0000:00:13.0: OHCI 1.0, NO legacy support registers
[  308.804129] ohci_hcd 0000:00:13.0: control 0x283 RWC HCFS=operational CBSR=3
[  308.804134] ohci_hcd 0000:00:13.0: cmdstatus 0x00000 SOC=0
[  308.804138] ohci_hcd 0000:00:13.0: intrstatus 0x00000004 SF
[  308.804142] ohci_hcd 0000:00:13.0: intrenable 0x8000005a MIE RHSC UE RD WDH
[  308.804154] ohci_hcd 0000:00:13.0: hcca frame #0005
[  308.804159] ohci_hcd 0000:00:13.0: roothub.a 02001205 POTPGT=2 NOCP NPS NDP=5(5)
[  308.804163] ohci_hcd 0000:00:13.0: roothub.b 00000000 PPCM=0000 DR=0000
[  308.804166] ohci_hcd 0000:00:13.0: roothub.status 00008000 DRWE
[  308.804171] ohci_hcd 0000:00:13.0: roothub.portstatus [0] 0x00000100 PPS
[  308.804175] ohci_hcd 0000:00:13.0: roothub.portstatus [1] 0x00000100 PPS
[  308.804179] ohci_hcd 0000:00:13.0: roothub.portstatus [2] 0x00010100 CSC PPS
[  308.804183] ohci_hcd 0000:00:13.0: roothub.portstatus [3] 0x00000100 PPS
[  308.804187] ohci_hcd 0000:00:13.0: roothub.portstatus [4] 0x00000100 PPS
[  308.804188] ohci_hcd 0000:00:13.0: restart complete
[  308.804191] usb usb4: root hub lost power or was reset
[  308.804194] ohci_hcd 0000:00:13.0: suspend root hub
[  308.808223] ohci_hcd 0000:00:14.5: OHCI controller state
[  308.808261] ohci_hcd 0000:00:14.5: OHCI 1.0, NO legacy support registers
[  308.808265] ohci_hcd 0000:00:14.5: control 0x283 RWC HCFS=operational CBSR=3
[  308.808269] ohci_hcd 0000:00:14.5: cmdstatus 0x00000 SOC=0
[  308.808273] ohci_hcd 0000:00:14.5: intrstatus 0x00000004 SF
[  308.808277] ohci_hcd 0000:00:14.5: intrenable 0x8000005a MIE RHSC UE RD WDH
[  308.808289] ohci_hcd 0000:00:14.5: hcca frame #0005
[  308.808293] ohci_hcd 0000:00:14.5: roothub.a 02001202 POTPGT=2 NOCP NPS NDP=2(2)
[  308.808297] ohci_hcd 0000:00:14.5: roothub.b 00000000 PPCM=0000 DR=0000
[  308.808301] ohci_hcd 0000:00:14.5: roothub.status 00008000 DRWE
[  308.808305] ohci_hcd 0000:00:14.5: roothub.portstatus [0] 0x00000100 PPS
[  308.808309] ohci_hcd 0000:00:14.5: roothub.portstatus [1] 0x00000100 PPS
[  308.808310] ohci_hcd 0000:00:14.5: restart complete
[  308.808312] usb usb5: root hub lost power or was reset
[  308.808315] ohci_hcd 0000:00:14.5: suspend root hub
[  308.808341] usb usb2: root hub lost power or was reset
[  308.808349] ehci_hcd 0000:00:13.2: reset command 0010006 (park)=0 ithresh=1 period=512 Reset HALT
[  308.808357] ehci_hcd 0000:00:13.2: MWI active
[  308.808367] usb usb4: usb resume
[  308.808371] usb usb5: usb resume
[  308.808374] usb usb2: usb resume
[  308.808377] ehci_hcd 0000:00:13.2: resume root hub after power loss
[  308.812401] ohci_hcd 0000:00:12.0: OHCI controller state
[  308.812439] ohci_hcd 0000:00:12.0: OHCI 1.0, NO legacy support registers
[  308.812443] ohci_hcd 0000:00:12.0: control 0x283 RWC HCFS=operational CBSR=3
[  308.812446] ohci_hcd 0000:00:12.0: cmdstatus 0x00000 SOC=0
[  308.812449] ohci_hcd 0000:00:12.0: intrstatus 0x00000004 SF
[  308.812453] ohci_hcd 0000:00:12.0: intrenable 0x8000005a MIE RHSC UE RD WDH
[  308.812461] ohci_hcd 0000:00:12.0: hcca frame #0005
[  308.812465] ohci_hcd 0000:00:12.0: roothub.a 02001205 POTPGT=2 NOCP NPS NDP=5(5)
[  308.812468] ohci_hcd 0000:00:12.0: roothub.b 00000000 PPCM=0000 DR=0000
[  308.812471] ohci_hcd 0000:00:12.0: roothub.status 00008000 DRWE
[  308.812474] ohci_hcd 0000:00:12.0: roothub.portstatus [0] 0x00000100 PPS
[  308.812478] ohci_hcd 0000:00:12.0: roothub.portstatus [1] 0x00000100 PPS
[  308.812481] ohci_hcd 0000:00:12.0: roothub.portstatus [2] 0x00000100 PPS
[  308.812485] ohci_hcd 0000:00:12.0: roothub.portstatus [3] 0x00000100 PPS
[  308.812488] ohci_hcd 0000:00:12.0: roothub.portstatus [4] 0x00010100 CSC PPS
[  308.812490] ohci_hcd 0000:00:12.0: restart complete
[  308.812492] usb usb3: root hub lost power or was reset
[  308.812495] ohci_hcd 0000:00:12.0: suspend root hub
[  308.812522] usb usb3: usb resume
[  308.812544] usb usb1: root hub lost power or was reset
[  308.812553] ehci_hcd 0000:00:12.2: reset command 0010006 (park)=0 ithresh=1 period=512 Reset HALT
[  308.812560] ehci_hcd 0000:00:12.2: MWI active
[  308.812590] usb usb1: usb resume
[  308.812593] ehci_hcd 0000:00:12.2: resume root hub after power loss
[  308.820182] ohci_hcd 0000:00:13.0: resume root hub
[  308.820193] ohci_hcd 0000:00:14.5: resume root hub
[  308.830142] ohci_hcd 0000:00:12.0: resume root hub
[  308.850121] ehci_hcd 0000:00:13.2: port 3 low speed --> companion
[  308.860122] ehci_hcd 0000:00:12.2: port 5 low speed --> companion
[  308.930126] hub 5-0:1.0: hub_reset_resume
[  308.930131] hub 5-0:1.0: trying to enable port power on non-switchable hub
[  308.930141] hub 4-0:1.0: hub_reset_resume
[  308.930145] hub 4-0:1.0: trying to enable port power on non-switchable hub
[  308.940132] hub 3-0:1.0: hub_reset_resume
[  308.940137] hub 3-0:1.0: trying to enable port power on non-switchable hub
[  308.950131] ehci_hcd 0000:00:13.2: GetStatus port:3 status 003002 0  ACK POWER OWNER sig=se0 CSC
[  308.963945] ehci_hcd 0000:00:12.2: GetStatus port:5 status 003002 0  ACK POWER OWNER sig=se0 CSC
[  308.980122] hub 2-0:1.0: hub_reset_resume
[  308.980127] hub 2-0:1.0: trying to enable port power on non-switchable hub
[  308.980140] hub 1-0:1.0: hub_reset_resume
[  308.980144] hub 1-0:1.0: trying to enable port power on non-switchable hub
[  309.040153] ohci_hcd 0000:00:13.0: GetStatus roothub.portstatus [2] = 0x00010301 CSC LSDA PPS CCS
[  309.040157] hub 4-0:1.0: port 3: status 0301 change 0001
[  309.050159] ohci_hcd 0000:00:12.0: GetStatus roothub.portstatus [4] = 0x00010301 CSC LSDA PPS CCS
[  309.050163] hub 3-0:1.0: port 5: status 0301 change 0001
[  309.150175] usb 4-3: finish reset-resume
[  309.160183] usb 3-5: finish reset-resume
[  309.290164] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[  309.293919] ata4.00: configured for UDMA/133
[  309.410135] ohci_hcd 0000:00:13.0: GetStatus roothub.portstatus [2] = 0x00100303 PRSC LSDA PPS PES CCS
[  309.470139] usb 4-3: reset low speed USB device using ohci_hcd and address 2
[  309.501156] ohci_hcd 0000:00:13.0: port[2] reset timeout, stat 00000313
[  309.710137] ohci_hcd 0000:00:13.0: GetStatus roothub.portstatus [2] = 0x00100303 PRSC LSDA PPS PES CCS
[  309.831158] ohci_hcd 0000:00:12.0: port[4] reset timeout, stat 00000311
[  310.040120] ohci_hcd 0000:00:14.5: auto-stop root hub
[  310.040163] ohci_hcd 0000:00:12.0: GetStatus roothub.portstatus [4] = 0x00100303 PRSC LSDA PPS PES CCS
[  310.100132] usb 3-5: reset low speed USB device using ohci_hcd and address 2
[  310.131153] ohci_hcd 0000:00:12.0: port[4] reset timeout, stat 00000313
[  310.340125] ohci_hcd 0000:00:12.0: GetStatus roothub.portstatus [4] = 0x00100303 PRSC LSDA PPS PES CCS
[  310.441453] PM: restore of devices complete after 1703.666 msecs
[  310.441637] PM: Image restored successfully.
[  310.441639] Restarting tasks ... 
[  310.441683] hub 7-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  310.441694] hub 6-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  310.441699] hub 8-0:1.0: state 7 ports 4 chg 0000 evt 0000
[  310.441702] hub 5-0:1.0: state 7 ports 2 chg 0000 evt 0000
[  310.441706] hub 2-0:1.0: state 7 ports 5 chg 0000 evt 0000
[  310.441710] hub 1-0:1.0: state 7 ports 5 chg 0000 evt 0000
[  310.441713] hub 4-0:1.0: state 7 ports 5 chg 0008 evt 0008
[  310.441760] hub 4-0:1.0: port 3, status 0303, change 0000, 1.5 Mb/s
[  310.441763] hub 3-0:1.0: state 7 ports 5 chg 0020 evt 0020
[  310.441772] hub 3-0:1.0: port 5, status 0303, change 0000, 1.5 Mb/s
[  310.445203] done.
[  310.445216] PM: Basic memory bitmaps freed
[  310.445225] video LNXVIDEO:00: Restoring backlight state
[  310.448663] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id
[  310.491667] tg3 0000:0c:00.0: irq 54 for MSI/MSI-X
[  310.604230] ADDRCONF(NETDEV_UP): eth0: link is not ready
[  311.330696] EXT4-fs (sda7): re-mounted. Opts: errors=remount-ro,commit=0
[  313.020176] hub 7-0:1.0: hub_suspend
[  313.020186] usb usb7: bus auto-suspend
[  313.020205] hub 6-0:1.0: hub_suspend
[  313.020208] usb usb6: bus auto-suspend
[  313.020225] hub 8-0:1.0: hub_suspend
[  313.020227] usb usb8: bus auto-suspend
[  313.020247] hub 5-0:1.0: hub_suspend
[  313.020250] usb usb5: bus auto-suspend
[  313.020254] ohci_hcd 0000:00:14.5: suspend root hub
[  313.020259] hub 2-0:1.0: hub_suspend
[  313.020262] usb usb2: bus auto-suspend
[  313.020264] ehci_hcd 0000:00:13.2: suspend root hub
[  313.020812] hub 1-0:1.0: hub_suspend
[  313.020815] usb usb1: bus auto-suspend
[  313.020816] ehci_hcd 0000:00:12.2: suspend root hub
[  313.671959] tg3 0000:0c:00.0: eth0: Link is up at 1000 Mbps, full duplex
[  313.671963] tg3 0000:0c:00.0: eth0: Flow control is on for TX and on for RX
[  313.672235] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready

[Index of Archives]     [Linux Media]     [Linux Input]     [Linux Audio Users]     [Yosemite News]     [Linux Kernel]     [Linux SCSI]     [Old Linux USB Devel Archive]

  Powered by Linux