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

Bug#863843: bugs.debian.org: Encrypted partition not accessible after resume



On Thu 01-Jun-2017 at 23:58:43 +0200, Ben Hutchings <ben@decadent.org.uk> wrote: 
> On Thu, 2017-06-01 at 23:36 +0200, garjola@garjola.net wrote:
>> On Thu 01-Jun-2017 at 00:15:29 +0200, Ben Hutchings <ben@decadent.org
>> .uk> wrote: 
>> > Control: tag -1 moreinfo
>> > 
>> > On Wed, 31 May 2017 21:34:59 +0200 Garjola Dindi <garjola@garjola.net>
>> > wrote:
>> > [...]
>> > > For several weeks now I have been having issues after resume (both
>> > 
>> > from RAM or from disk): my /home seems not to be accessible (at least
>> > for writing). This does not happen every time, but more something like
>> > once every 10 or 20 resume cycles.
>> > [...]
>> > 
>> > Please send the messages that appear in the kernel log when you resume.
>> > (Run 'dmesg' as root to show the kernel log.)
>> > 
>> > Ben.
>> 
>> Hi,
>> 
>> The problem appeared again. I ran dmesg and piped the output to a file
>> (in one of the non encrypted partitions) just after the problematic
>> resume, but after reboot (to be able to send this message), the file was
>> gone.
>> 
>> Below is the output of dmesg after a fresh reboot and one successful
>> suspend/resume cycle. I dont't know if is is useful, since the problem
>> has not happened since the reboot.
> [...]
>
> I really need to see what happens in the failing case.
>
> Ben.

Hi,

Here goes the output of dmesg after a failing resume. I have used a usb
stick to save the output of dmesg so that I could send it to you. This
is the sdc device which appears at the end of the log.

Thanks.

[    4.490217] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    4.511012] 0000:00:16.3: ttyS0 at I/O 0x3080 (irq = 19, base_baud = 115200) is a 16550A
[    4.511185] Linux agpgart interface v0.103
[    4.557309] tpm_tis 00:0b: 1.2 TPM (device-id 0x1B, rev-id 16)
[    4.941311] tpm tpm0: A TPM error (7) occurred attempting to read a pcr value
[    4.941368] tpm tpm0: TPM is disabled/deactivated (0x7)
[    4.941507] AMD IOMMUv2 driver by Joerg Roedel <jroedel@suse.de>
[    4.941508] AMD IOMMUv2 functionality not available on this system
[    4.941793] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[    4.943323] i8042: Detected active multiplexing controller, rev 1.1
[    4.943926] serio: i8042 KBD port at 0x60,0x64 irq 1
[    4.943929] serio: i8042 AUX0 port at 0x60,0x64 irq 12
[    4.943953] serio: i8042 AUX1 port at 0x60,0x64 irq 12
[    4.943973] serio: i8042 AUX2 port at 0x60,0x64 irq 12
[    4.943991] serio: i8042 AUX3 port at 0x60,0x64 irq 12
[    4.944404] mousedev: PS/2 mouse device common for all mice
[    4.944448] rtc_cmos 00:03: RTC can wake from S4
[    4.944999] rtc_cmos 00:03: rtc core: registered rtc_cmos as rtc0
[    4.945080] rtc_cmos 00:03: alarms up to one month, y3k, 242 bytes nvram, hpet irqs
[    4.945086] intel_pstate: Intel P-state driver initializing
[    4.945356] intel_pstate: HWP enabled
[    4.945520] ledtrig-cpu: registered to indicate activity on CPUs
[    4.945776] NET: Registered protocol family 10
[    4.945987] mip6: Mobile IPv6
[    4.945988] NET: Registered protocol family 17
[    4.945990] mpls_gso: MPLS GSO support
[    4.946163] microcode: sig=0x406e3, pf=0x80, revision=0x94
[    4.946222] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[    4.946333] registered taskstats version 1
[    4.946346] zswap: loaded using pool lzo/zbud
[    4.970449] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[    4.993615] tpm tpm0: A TPM error (7) occurred attempting to read a pcr value
[    4.993708] ima: No TPM chip found, activating TPM-bypass!
[    4.996949] rtc_cmos 00:03: setting system clock to 2017-06-01 21:20:08 UTC (1496352008)
[    4.997131] PM: Checking hibernation image partition /dev/mapper/pc--117--162--vg-swap_1
[    4.997139] PM: Hibernation image not present or could not be loaded.
[    4.999349] Freeing unused kernel memory: 1392K (ffffffffb711e000 - ffffffffb727a000)
[    4.999350] Write protecting the kernel read-only data: 12288k
[    4.999759] Freeing unused kernel memory: 1996K (ffff88494720d000 - ffff884947400000)
[    5.001549] Freeing unused kernel memory: 1244K (ffff8849476c9000 - ffff884947800000)
[    5.005189] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[    5.057319] random: systemd-udevd: uninitialized urandom read (16 bytes read)
[    5.057384] random: systemd-udevd: uninitialized urandom read (16 bytes read)
[    5.057391] random: systemd-udevd: uninitialized urandom read (16 bytes read)
[    5.057400] random: systemd-udevd: uninitialized urandom read (16 bytes read)
[    5.058066] random: udevadm: uninitialized urandom read (16 bytes read)
[    5.058090] random: udevadm: uninitialized urandom read (16 bytes read)
[    5.058872] random: udevadm: uninitialized urandom read (16 bytes read)
[    5.058906] random: udevadm: uninitialized urandom read (16 bytes read)
[    5.058936] random: udevadm: uninitialized urandom read (16 bytes read)
[    5.058965] random: udevadm: uninitialized urandom read (16 bytes read)
[    5.092094] hidraw: raw HID events driver (C) Jiri Kosina
[    5.096782] ACPI: bus type USB registered
[    5.096806] usbcore: registered new interface driver usbfs
[    5.096814] usbcore: registered new interface driver hub
[    5.096851] usbcore: registered new device driver usb
[    5.097445] SCSI subsystem initialized
[    5.098214] xhci_hcd 0000:00:14.0: xHCI Host Controller
[    5.098219] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1
[    5.098518] rtsx_pci 0000:01:00.0: rtsx_pci_acquire_irq: pcr->msi_en = 1, pci->irq = 274
[    5.099098] libata version 3.00 loaded.
[    5.099343] xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x00109810
[    5.099355] xhci_hcd 0000:00:14.0: cache line size of 64 is not supported
[    5.099481] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    5.099482] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.099484] usb usb1: Product: xHCI Host Controller
[    5.099485] usb usb1: Manufacturer: Linux 4.9.0-3-amd64 xhci-hcd
[    5.099486] usb usb1: SerialNumber: 0000:00:14.0
[    5.099633] hub 1-0:1.0: USB hub found
[    5.099649] hub 1-0:1.0: 12 ports detected
[    5.100374] pps_core: LinuxPPS API ver. 1 registered
[    5.100375] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    5.100591] PTP clock support registered
[    5.102149] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k
[    5.102150] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[    5.107704] AVX2 version of gcm_enc/dec engaged.
[    5.107705] AES CTR mode by8 optimization enabled
[    5.112314] xhci_hcd 0000:00:14.0: xHCI Host Controller
[    5.112318] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2
[    5.112356] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003
[    5.112357] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.112359] usb usb2: Product: xHCI Host Controller
[    5.112360] usb usb2: Manufacturer: Linux 4.9.0-3-amd64 xhci-hcd
[    5.112361] usb usb2: SerialNumber: 0000:00:14.0
[    5.112493] hub 2-0:1.0: USB hub found
[    5.112506] hub 2-0:1.0: 6 ports detected
[    5.116471] usb: port power management may be unreliable
[    5.117824] thermal LNXTHERM:00: registered as thermal_zone0
[    5.117825] ACPI: Thermal Zone [CPUZ] (32 C)
[    5.117948] ahci 0000:00:17.0: version 3.0
[    5.118163] ahci 0000:00:17.0: SSS flag set, parallel bus scan disabled
[    5.118188] ahci 0000:00:17.0: AHCI 0001.0301 32 slots 2 ports 6 Gbps 0x5 impl SATA mode
[    5.118191] ahci 0000:00:17.0: flags: 64bit ncq stag pm led clo only pio slum part deso sadm sds apst 
[    5.118856] scsi host0: ahci
[    5.118984] scsi host1: ahci
[    5.119119] scsi host2: ahci
[    5.119178] ata1: SATA max UDMA/133 abar m2048@0xe124e000 port 0xe124e100 irq 276
[    5.119179] ata2: DUMMY
[    5.119181] ata3: SATA max UDMA/133 abar m2048@0xe124e000 port 0xe124e200 irq 276
[    5.119379] e1000e 0000:00:1f.6: Interrupt Throttling Rate (ints/sec) set to dynamic conservative mode
[    5.148306] thermal LNXTHERM:01: registered as thermal_zone1
[    5.148307] ACPI: Thermal Zone [GFXZ] (0 C)
[    5.171576] thermal LNXTHERM:02: registered as thermal_zone2
[    5.171578] ACPI: Thermal Zone [EXTZ] (27 C)
[    5.193837] thermal LNXTHERM:03: registered as thermal_zone3
[    5.193838] ACPI: Thermal Zone [LOCZ] (24 C)
[    5.203847] thermal LNXTHERM:04: registered as thermal_zone4
[    5.203848] ACPI: Thermal Zone [BATZ] (24 C)
[    5.204309] thermal LNXTHERM:05: registered as thermal_zone5
[    5.204311] ACPI: Thermal Zone [PCHZ] (127 C)
[    5.331926] e1000e 0000:00:1f.6 0000:00:1f.6 (uninitialized): registered PHC clock
[    5.417065] e1000e 0000:00:1f.6 eth0: (PCI Express:2.5GT/s:Width x1) 30:e1:71:89:f1:a4
[    5.417073] e1000e 0000:00:1f.6 eth0: Intel(R) PRO/1000 Network Connection
[    5.417208] e1000e 0000:00:1f.6 eth0: MAC: 12, PHY: 12, PBA No: FFFFFF-0FF
[    5.418121] i801_smbus 0000:00:1f.4: SMBus using PCI interrupt
[    5.438853] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    5.440982] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[    5.440989] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[    5.441193] ata1.00: ATA-9: HGST HTS541010A7E630, SE0OA4G0, max UDMA/133
[    5.441198] ata1.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
[    5.441337] usb 1-7: new full-speed USB device number 2 using xhci_hcd
[    5.443517] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[    5.443525] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[    5.444070] ata1.00: configured for UDMA/133
[    5.445140] scsi 0:0:0:0: Direct-Access     ATA      HGST HTS541010A7 A4G0 PQ: 0 ANSI: 5
[    5.509671] tsc: Refined TSC clocksource calibration: 2807.989 MHz
[    5.509696] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2879bbf0a17, max_idle_ns: 440795299209 ns
[    5.583992] usb 1-7: New USB device found, idVendor=8087, idProduct=0a2b
[    5.583998] usb 1-7: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    5.705617] usb 1-8: new full-speed USB device number 3 using xhci_hcd
[    5.792542] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    5.793830] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[    5.793942] ata3.00: ATA-9: SanDisk SD8SN8U-512G-1006, X4120006, max UDMA/133
[    5.793947] ata3.00: 1000215216 sectors, multi 1: LBA48 NCQ (depth 31/32), AA
[    5.796444] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[    5.797659] ata3.00: configured for UDMA/133
[    5.798617] scsi 2:0:0:0: Direct-Access     ATA      SanDisk SD8SN8U- 0006 PQ: 0 ANSI: 5
[    5.843143] sd 0:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB)
[    5.843145] sd 0:0:0:0: [sda] 4096-byte physical blocks
[    5.843169] sd 0:0:0:0: [sda] Write Protect is off
[    5.843172] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    5.843182] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    5.843312] sd 2:0:0:0: [sdb] 1000215216 512-byte logical blocks: (512 GB/477 GiB)
[    5.843314] sd 2:0:0:0: [sdb] 4096-byte physical blocks
[    5.843513] sd 2:0:0:0: [sdb] Write Protect is off
[    5.843516] sd 2:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[    5.843562] sd 2:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    5.844305]  sdb: sdb1
[    5.844729] sd 2:0:0:0: [sdb] Attached SCSI disk
[    5.851351] usb 1-8: New USB device found, idVendor=138a, idProduct=003f
[    5.851352] usb 1-8: New USB device strings: Mfr=0, Product=0, SerialNumber=1
[    5.851353] usb 1-8: SerialNumber: 00305e5f579d
[    5.891595]  sda: sda1 sda2 < sda5 >
[    5.892731] sd 0:0:0:0: [sda] Attached SCSI disk
[    5.904051] random: fast init done
[    6.021787] input: PS/2 Generic Mouse as /devices/platform/i8042/serio2/input/input6
[    6.029316] usb 1-9: new high-speed USB device number 4 using xhci_hcd
[    6.203804] usb 1-9: New USB device found, idVendor=04ca, idProduct=7054
[    6.203813] usb 1-9: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[    6.203817] usb 1-9: Product: HP HD Camera
[    6.203821] usb 1-9: Manufacturer: DETNR01BI49DUK
[    6.203824] usb 1-9: SerialNumber: 200901010001
[    6.222325] device-mapper: uevent: version 1.0.3
[    6.222551] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com
[    6.533816] clocksource: Switched to clocksource tsc
[    6.796708] psmouse serio3: synaptics: queried max coordinates: x [..5670], y [..4758]
[    6.830944] psmouse serio3: synaptics: queried min coordinates: x [1360..], y [1198..]
[    6.895635] psmouse serio3: synaptics: Touchpad model: 1, fw: 8.2, id: 0x1e2b1, caps: 0xf00123/0x840300/0x2e800/0x0, board id: 3139, fw id: 2000742
[    6.937470] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio3/input/input7
[   10.354959] random: crng init done
[   14.096750] NET: Registered protocol family 38
[   15.041022] PM: Starting manual resume from disk
[   15.041028] PM: Hibernation image partition 254:2 present
[   15.041029] PM: Looking for hibernation image.
[   15.041192] PM: Image not found (code -22)
[   15.041194] PM: Hibernation image not present or could not be loaded.
[   15.379584] EXT4-fs (sdb1): mounted filesystem with ordered data mode. Opts: (null)
[   15.495936] ip_tables: (C) 2000-2006 Netfilter Core Team
[   15.509923] systemd[1]: systemd 232 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN)
[   15.510225] systemd[1]: Detected architecture x86-64.
[   15.510454] systemd[1]: Set hostname to <pc-117-162>.
[   15.611739] systemd[1]: acpid.socket: Cannot add dependency job, ignoring: Unit acpid.socket is masked.
[   15.611749] systemd[1]: acpid.path: Cannot add dependency job, ignoring: Unit acpid.path is masked.
[   15.611766] systemd[1]: NetworkManager-wait-online.service: Cannot add dependency job, ignoring: Unit NetworkManager-wait-online.service is masked.
[   15.611874] systemd[1]: NetworkManager.service: Cannot add dependency job, ignoring: Unit NetworkManager.service is masked.
[   15.612524] systemd[1]: Listening on Device-mapper event daemon FIFOs.
[   15.612597] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[   15.612625] systemd[1]: Listening on LVM2 poll daemon socket.
[   15.629723] lp: driver loaded but no devices found
[   15.631022] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro
[   15.637403] ppdev: user-space parallel port driver
[   15.654108] RPC: Registered named UNIX socket transport module.
[   15.654109] RPC: Registered udp transport module.
[   15.654110] RPC: Registered tcp transport module.
[   15.654110] RPC: Registered tcp NFSv4.1 backchannel transport module.
[   15.664644] systemd-journald[300]: Received request to flush runtime journal from PID 1
[   15.754945] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input9
[   15.754950] ACPI: Sleep Button [SLPB]
[   15.755056] input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input10
[   15.755058] ACPI: Lid Switch [LID]
[   15.755123] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input11
[   15.755126] ACPI: Power Button [PWRF]
[   15.756181] Initializing HPQ6001 module
[   15.757247] ACPI: AC Adapter [AC] (off-line)
[   15.757319] input: HP Wireless hotkeys as /devices/virtual/input/input12
[   15.771332] ACPI: Battery Slot [BAT0] (battery present)
[   15.781623] hp_accel: hardware type HPB64xx found
[   15.795626] wmi: Mapper loaded
[   15.801076] Bluetooth: Core ver 2.22
[   15.801088] NET: Registered protocol family 31
[   15.801089] Bluetooth: HCI device and connection manager initialized
[   15.801092] Bluetooth: HCI socket layer initialized
[   15.801094] Bluetooth: L2CAP socket layer initialized
[   15.801100] Bluetooth: SCO socket layer initialized
[   15.803790] intel-lpss 0000:00:15.0: enabling device (0000 -> 0002)
[   15.806300] Bluetooth: HCI UART driver ver 2.3
[   15.806301] Bluetooth: HCI UART protocol H4 registered
[   15.806302] Bluetooth: HCI UART protocol BCSP registered
[   15.806306] Bluetooth: HCI UART protocol LL registered
[   15.806308] Bluetooth: HCI UART protocol ATH3K registered
[   15.806310] Bluetooth: HCI UART protocol Three-wire (H5) registered
[   15.806854] sd 0:0:0:0: Attached scsi generic sg0 type 0
[   15.806894] sd 2:0:0:0: Attached scsi generic sg1 type 0
[   15.808142] Bluetooth: HCI UART protocol Intel registered
[   15.808159] Bluetooth: HCI UART protocol Broadcom registered
[   15.808160] Bluetooth: HCI UART protocol QCA registered
[   15.808160] Bluetooth: HCI UART protocol AG6XX registered
[   15.808161] Bluetooth: HCI UART protocol Marvell registered
[   15.813059] iTCO_vendor_support: vendor-support=0
[   15.815330] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11
[   15.815471] iTCO_wdt: Found a Intel PCH TCO device (Version=4, TCOBASE=0x0400)
[   15.816411] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
[   15.816667] idma64 idma64.0: Found Intel integrated DMA 64-bit
[   15.816786] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[   15.817376] mei_me 0000:00:16.0: enabling device (0000 -> 0002)
[   15.817759] [drm] Initialized
[   15.834789] input: PC Speaker as /devices/platform/pcspkr/input/input13
[   15.848655] RAPL PMU: API unit is 2^-32 Joules, 5 fixed counters, 655360 ms ovfl timer
[   15.848657] RAPL PMU: hw unit of domain pp0-core 2^-14 Joules
[   15.848658] RAPL PMU: hw unit of domain package 2^-14 Joules
[   15.848658] RAPL PMU: hw unit of domain dram 2^-14 Joules
[   15.848659] RAPL PMU: hw unit of domain pp1-gpu 2^-14 Joules
[   15.848660] RAPL PMU: hw unit of domain psys 2^-14 Joules
[   15.852049] Intel(R) Wireless WiFi driver for Linux
[   15.852050] Copyright(c) 2003- 2015 Intel Corporation
[   15.857036] iwlwifi 0000:02:00.0: firmware: failed to load iwlwifi-8000C-26.ucode (-2)
[   15.857108] iwlwifi 0000:02:00.0: Direct firmware load for iwlwifi-8000C-26.ucode failed with error -2
[   15.857122] iwlwifi 0000:02:00.0: firmware: failed to load iwlwifi-8000C-25.ucode (-2)
[   15.857190] iwlwifi 0000:02:00.0: Direct firmware load for iwlwifi-8000C-25.ucode failed with error -2
[   15.857200] iwlwifi 0000:02:00.0: firmware: failed to load iwlwifi-8000C-24.ucode (-2)
[   15.857291] iwlwifi 0000:02:00.0: Direct firmware load for iwlwifi-8000C-24.ucode failed with error -2
[   15.857301] iwlwifi 0000:02:00.0: firmware: failed to load iwlwifi-8000C-23.ucode (-2)
[   15.857361] iwlwifi 0000:02:00.0: Direct firmware load for iwlwifi-8000C-23.ucode failed with error -2
[   15.874873] iwlwifi 0000:02:00.0: firmware: direct-loading firmware iwlwifi-8000C-22.ucode
[   15.875487] iwlwifi 0000:02:00.0: loaded firmware version 22.361476.0 op_mode iwlmvm
[   15.877547] [drm] Memory usable by graphics device = 4096M
[   15.877549] [drm] Replacing VGA console driver
[   15.879520] Console: switching to colour dummy device 80x25
[   15.881176] kvm: disabled by bios
[   15.891740] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[   15.891742] [drm] Driver supports precise vblank timestamp query.
[   15.892698] iwlwifi 0000:02:00.0: Detected Intel(R) Dual Band Wireless AC 8260, REV=0x208
[   15.893008] intel_rapl: Found RAPL domain package
[   15.893010] intel_rapl: Found RAPL domain core
[   15.893012] intel_rapl: Found RAPL domain uncore
[   15.893340] i915 0000:00:02.0: firmware: failed to load i915/skl_dmc_ver1_26.bin (-2)
[   15.893348] i915 0000:00:02.0: Direct firmware load for i915/skl_dmc_ver1_26.bin failed with error -2
[   15.893350] i915 0000:00:02.0: Failed to load DMC firmware [https://01.org/linuxgraphics/intel-linux-graphics-firmwares], disabling runtime power management.
[   15.894095] vgaarb: device changed decodes: PCI:0000:00:02.0,olddecodes=io+mem,decodes=io+mem:owns=io+mem
[   15.894838] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   15.895748] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   15.903542] wl: loading out-of-tree module taints kernel.
[   15.903546] wl: module license 'MIXED/Proprietary' taints kernel.
[   15.903546] Disabling lock debugging due to kernel taint
[   15.908042] lis3lv02d: 8 bits 3DC sensor found
[   15.917669] [drm] GuC firmware load skipped
[   15.983336] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a894fc798 (20160831/exresop-594)
[   15.983349] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[   15.983361] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[   15.983375] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[   15.984377] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a894fc9d8 (20160831/exresop-594)
[   15.984388] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[   15.984400] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[   15.984414] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[   15.994103] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a894fc240 (20160831/exresop-594)
[   15.994119] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[   15.994133] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[   15.994212] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[   15.995116] input: HP WMI hotkeys as /devices/virtual/input/input14
[   15.999240] ACPI Error: Attempt to CreateField of length zero (20160831/dsopcode-168)
[   15.999255] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPI] (Node ffff884a908a8190), AE_AML_OPERAND_VALUE (20160831/psparse-543)
[   15.999273] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_VALUE (20160831/psparse-543)
[   16.030485] ieee80211 phy0: Selected rate control algorithm 'iwl-mvm-rs'
[   16.030791] thermal thermal_zone8: failed to read out thermal zone (-5)
[   16.107555] iwlwifi 0000:02:00.0 wlp2s0: renamed from wlan0
[   16.175261] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=600
[   16.764719] Adding 39510012k swap on /dev/mapper/pc--117--162--vg-swap_1.  Priority:-1 extents:1 across:39510012k FS
[   17.193344] input: ST LIS3LV02DL Accelerometer as /devices/platform/lis3lv02d/input/input15
[   17.202876] ACPI: Video Device [GFX0] (multi-head: yes  rom: no  post: no)
[   17.206084] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input16
[   17.207176] snd_hda_intel 0000:00:1f.3: bound 0000:00:02.0 (ops i915_audio_component_bind_ops [i915])
[   17.207184] [drm] Initialized i915 1.6.0 20160919 for 0000:00:02.0 on minor 0
[   17.210452] fbcon: inteldrmfb (fb0) is primary device
[   17.227292] snd_hda_codec_conexant hdaudioC0D0: CX20724: BIOS auto-probing.
[   17.227902] snd_hda_codec_conexant hdaudioC0D0: autoconfig for CX20724: line_outs=1 (0x17/0x0/0x0/0x0/0x0) type:speaker
[   17.227903] snd_hda_codec_conexant hdaudioC0D0:    speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
[   17.227904] snd_hda_codec_conexant hdaudioC0D0:    hp_outs=1 (0x1d/0x0/0x0/0x0/0x0)
[   17.227904] snd_hda_codec_conexant hdaudioC0D0:    mono: mono_out=0x0
[   17.227905] snd_hda_codec_conexant hdaudioC0D0:    inputs:
[   17.227906] snd_hda_codec_conexant hdaudioC0D0:      Internal Mic=0x1a
[   17.227907] snd_hda_codec_conexant hdaudioC0D0:      Mic=0x19
[   17.228971] snd_hda_codec_conexant hdaudioC0D0: Enable sync_write for stable communication
[   17.237140] input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1f.3/sound/card0/input17
[   17.239372] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1f.3/sound/card0/input18
[   17.239429] input: HDA Intel PCH Headphone as /devices/pci0000:00/0000:00:1f.3/sound/card0/input19
[   17.239480] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input20
[   17.239535] input: HDA Intel PCH HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:1f.3/sound/card0/input21
[   17.829810] [drm] RC6 on
[   18.295879] Console: switching to colour frame buffer device 240x67
[   18.316004] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=600
[   18.316859] i915 0000:00:02.0: fb0: inteldrmfb frame buffer device
[   19.668715] media: Linux media interface: v0.10
[   19.672336] Linux video capture interface: v2.00
[   19.738663] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=600
[   19.797607] uvcvideo: Found UVC 1.00 device HP HD Camera (04ca:7054)
[   19.799799] uvcvideo 1-9:1.0: Entity type for entity Extension 4 was not initialized!
[   19.799803] uvcvideo 1-9:1.0: Entity type for entity Processing 2 was not initialized!
[   19.799804] uvcvideo 1-9:1.0: Entity type for entity Camera 1 was not initialized!
[   19.799897] input: HP HD Camera as /devices/pci0000:00/0000:00:14.0/usb1/1-9/1-9:1.0/input/input22
[   19.799959] usbcore: registered new interface driver uvcvideo
[   19.799960] USB Video Class driver (1.1.1)
[   20.444641] EXT4-fs (sda1): mounting ext2 file system using the ext4 subsystem
[   20.515494] EXT4-fs (sda1): mounted filesystem without journal. Opts: (null)
[   20.878339] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=600
[   20.926687] EXT4-fs (sda1): re-mounted. Opts: block_validity,barrier,user_xattr,acl,stripe=4
[   22.097876] usbcore: registered new interface driver btusb
[   22.100333] Bluetooth: hci0: Bootloader revision 0.0 build 2 week 52 2014
[   22.107348] Bluetooth: hci0: Device revision is 5
[   22.107352] Bluetooth: hci0: Secure boot is enabled
[   22.107355] Bluetooth: hci0: OTP lock is enabled
[   22.107357] Bluetooth: hci0: API lock is enabled
[   22.107359] Bluetooth: hci0: Debug lock is disabled
[   22.107363] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[   22.117589] bluetooth hci0: firmware: direct-loading firmware intel/ibt-11-5.sfi
[   22.117597] Bluetooth: hci0: Found device firmware: intel/ibt-11-5.sfi
[   22.212329] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=600
[   22.294670] EXT4-fs (sda1): re-mounted. Opts: block_validity,barrier,user_xattr,acl,stripe=4
[   23.370354] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=600
[   23.461345] EXT4-fs (sda1): re-mounted. Opts: block_validity,barrier,user_xattr,acl,stripe=4
[   23.479186] Bluetooth: hci0: Waiting for firmware download to complete
[   23.479275] Bluetooth: hci0: Firmware loaded in 1349093 usecs
[   23.479306] Bluetooth: hci0: Waiting for device to boot
[   23.490308] Bluetooth: hci0: Device booted in 10754 usecs
[   23.497324] bluetooth hci0: firmware: direct-loading firmware intel/ibt-11-5.ddc
[   23.497328] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-11-5.ddc
[   23.498308] Bluetooth: hci0: Failed to send Intel_Write_DDC (-22)
[   29.657288] EXT4-fs (dm-1): mounted filesystem with ordered data mode. Opts: (null)
[   29.892565] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   29.892566] Bluetooth: BNEP filters: protocol multicast
[   29.892570] Bluetooth: BNEP socket layer initialized
[   30.110849] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=600
[   30.160739] EXT4-fs (sda1): re-mounted. Opts: block_validity,barrier,user_xattr,acl,stripe=4
[   30.171903] EXT4-fs (dm-1): re-mounted. Opts: data=ordered,commit=600
[   30.640021] NET: Registered protocol family 4
[   30.642362] NET: Registered protocol family 3
[   30.654011] NET: Registered protocol family 5
[   30.681307] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   30.681700] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   30.816665] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   30.817060] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   30.900638] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[   31.052388] Netfilter messages via NETLINK v0.30.
[   36.665562] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   39.752981] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   39.753753] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   39.882221] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   39.882621] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   39.982244] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[   40.216050] e1000e: eth0 NIC Link is Down
[   40.441408] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   40.600022] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   40.600734] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   40.731235] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   40.731635] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[   40.823716] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[   46.419303] wlp2s0: authenticate with 40:65:a3:15:37:9e
[   46.432185] wlp2s0: send auth to 40:65:a3:15:37:9e (try 1/3)
[   46.440268] wlp2s0: authenticated
[   46.444705] wlp2s0: associate with 40:65:a3:15:37:9e (try 1/3)
[   46.448494] wlp2s0: RX AssocResp from 40:65:a3:15:37:9e (capab=0x1411 status=0 aid=3)
[   46.456029] wlp2s0: associated
[   46.456135] IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0: link becomes ready
[   69.755860] fuse init (API version 7.26)
[  736.630419] PM: Syncing filesystems ... done.
[  736.859880] PM: Preparing system for sleep (mem)
[  736.860616] (NULL device *): firmware: direct-loading firmware intel/ibt-11-5.ddc
[  736.861067] (NULL device *): firmware: direct-loading firmware intel/ibt-11-5.sfi
[  736.861609] (NULL device *): firmware: direct-loading firmware iwlwifi-8000C-22.ucode
[  736.861645] Freezing user space processes ... (elapsed 0.001 seconds) done.
[  736.863504] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
[  736.864764] PM: Suspending system (mem)
[  736.864833] Suspending console(s) (use no_console_suspend to debug)
[  736.974636] wlp2s0: deauthenticating from 40:65:a3:15:37:9e by local choice (Reason: 3=DEAUTH_LEAVING)
[  736.974900] sd 2:0:0:0: [sdb] Synchronizing SCSI cache
[  736.975194] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  736.982212] sd 2:0:0:0: [sdb] Stopping disk
[  737.102167] ACPI : EC: event blocked
[  737.187537] sd 0:0:0:0: [sda] Stopping disk
[  737.738942] PM: suspend of devices complete after 764.935 msecs
[  737.765913] PM: late suspend of devices complete after 26.964 msecs
[  737.766724] ACPI : EC: interrupt blocked
[  737.769262] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
[  737.850329] PM: noirq suspend of devices complete after 84.412 msecs
[  737.851371] ACPI: Preparing to enter system sleep state S3
[  737.853435] ACPI : EC: EC stopped
[  737.853436] PM: Saving platform NVS memory
[  737.853488] Disabling non-boot CPUs ...
[  737.855038] smpboot: CPU 1 is now offline
[  737.855578] Broke affinity for irq 275
[  737.855580] Broke affinity for irq 280
[  737.856907] smpboot: CPU 2 is now offline
[  737.857274] Broke affinity for irq 1
[  737.857291] Broke affinity for irq 9
[  737.857300] Broke affinity for irq 12
[  737.857340] Broke affinity for irq 275
[  737.857341] Broke affinity for irq 276
[  737.857343] Broke affinity for irq 279
[  737.857344] Broke affinity for irq 280
[  737.858358] smpboot: CPU 3 is now offline
[  737.861033] ACPI: Low-level resume complete
[  737.861150] ACPI : EC: EC started
[  737.861151] PM: Restoring platform NVS memory
[  737.861881] Suspended for 6.361 seconds
[  737.861922] Enabling non-boot CPUs ...
[  737.861974] x86: Booting SMP configuration:
[  737.861975] smpboot: Booting Node 0 Processor 1 APIC 0x2
[  737.864619]  cache: parent cpu1 should not be sleeping
[  737.864821] CPU1 is up
[  737.864856] smpboot: Booting Node 0 Processor 2 APIC 0x1
[  737.867497]  cache: parent cpu2 should not be sleeping
[  737.867681] CPU2 is up
[  737.867716] smpboot: Booting Node 0 Processor 3 APIC 0x3
[  737.870199]  cache: parent cpu3 should not be sleeping
[  737.870396] CPU3 is up
[  737.874187] ACPI: Waking up from system sleep state S3
[  737.884577] acpi LNXPOWER:17: Turning OFF
[  737.884606] acpi LNXPOWER:16: Turning OFF
[  737.884634] acpi LNXPOWER:15: Turning OFF
[  737.884662] acpi LNXPOWER:14: Turning OFF
[  737.884690] acpi LNXPOWER:13: Turning OFF
[  737.884726] acpi LNXPOWER:12: Turning OFF
[  737.884754] acpi LNXPOWER:11: Turning OFF
[  737.884782] acpi LNXPOWER:10: Turning OFF
[  737.884809] acpi LNXPOWER:0f: Turning OFF
[  737.884837] acpi LNXPOWER:0e: Turning OFF
[  737.884864] acpi LNXPOWER:0d: Turning OFF
[  737.884892] acpi LNXPOWER:0c: Turning OFF
[  737.884919] acpi LNXPOWER:0b: Turning OFF
[  737.884947] acpi LNXPOWER:0a: Turning OFF
[  737.884974] acpi LNXPOWER:09: Turning OFF
[  737.885002] acpi LNXPOWER:08: Turning OFF
[  737.885029] acpi LNXPOWER:07: Turning OFF
[  737.885057] acpi LNXPOWER:06: Turning OFF
[  737.885085] acpi LNXPOWER:05: Turning OFF
[  737.885234] acpi LNXPOWER:04: Turning OFF
[  737.948830] acpi LNXPOWER:03: Turning OFF
[  737.949209] ACPI : EC: interrupt unblocked
[  737.990828] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
[  738.105583] PM: noirq resume of devices complete after 156.630 msecs
[  738.105655] pciehp 0000:00:1c.0:pcie004: Slot(1): Card present
[  738.105658] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up
[  738.106086] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up event ignored; already powering on
[  738.123678] PM: early resume of devices complete after 18.014 msecs
[  738.124048] usb usb1: root hub lost power or was reset
[  738.124052] usb usb2: root hub lost power or was reset
[  738.124593] sd 0:0:0:0: [sda] Starting disk
[  738.124613] sd 2:0:0:0: [sdb] Starting disk
[  738.126648] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  738.127457] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  738.185983] [drm] GuC firmware load skipped
[  738.212803] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[  738.212806] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[  738.255579] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  738.255966] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  738.320749] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[  738.320753] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[  738.439823] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[  738.440504] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[  738.443243] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[  738.444497] ata3.00: configured for UDMA/133
[  738.473157] usb 1-8: reset full-speed USB device number 3 using xhci_hcd
[  738.733036] usb 1-9: reset high-speed USB device number 4 using xhci_hcd
[  738.993207] usb 1-7: reset full-speed USB device number 2 using xhci_hcd
[  739.404809] ACPI : EC: event unblocked
[  739.406014] ACPI : button: The lid device is not compliant to SW_LID.
[  739.406084] rtc_cmos 00:03: System wakeup disabled by ACPI
[  739.516981] tpm tpm0: A TPM error (7) occurred attempting to read a pcr value
[  739.516984] tpm tpm0: TPM is disabled/deactivated (0x7)
[  739.521038] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a870a1af8 (20160831/exresop-594)
[  739.521044] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[  739.521056] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[  739.521067] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[  739.522718] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a8622b1b0 (20160831/exresop-594)
[  739.522722] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[  739.522732] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[  739.522742] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[  739.523204] PM: resume of devices complete after 1399.560 msecs
[  739.523423] usb 1-7:1.0: rebind failed: -517
[  739.523429] usb 1-7:1.1: rebind failed: -517
[  739.523978] PM: Finishing wakeup.
[  739.523981] Restarting tasks ... done.
[  739.527374] Bluetooth: hci0: Bootloader revision 0.0 build 2 week 52 2014
[  739.534371] Bluetooth: hci0: Device revision is 5
[  739.534372] Bluetooth: hci0: Secure boot is enabled
[  739.534373] Bluetooth: hci0: OTP lock is enabled
[  739.534373] Bluetooth: hci0: API lock is enabled
[  739.534374] Bluetooth: hci0: Debug lock is disabled
[  739.534375] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[  739.534377] Bluetooth: hci0: Found device firmware: intel/ibt-11-5.sfi
[  739.586818] [drm] RC6 on
[  739.756684] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[  739.758298] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[  739.758303] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[  739.760186] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[  739.760191] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[  739.760386] ata1.00: configured for UDMA/133
[  740.723407] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  740.724236] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  740.807391] psmouse serio3: synaptics: queried max coordinates: x [..5670], y [..4758]
[  740.837249] psmouse serio3: synaptics: queried min coordinates: x [1360..], y [1198..]
[  740.852553] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  740.852914] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  740.943348] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[  741.185540] e1000e: eth0 NIC Link is Down
[  741.256308] Bluetooth: hci0: Waiting for firmware download to complete
[  741.256378] Bluetooth: hci0: Firmware loaded in 1689614 usecs
[  741.256413] Bluetooth: hci0: Waiting for device to boot
[  741.267406] Bluetooth: hci0: Device booted in 10762 usecs
[  741.267418] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-11-5.ddc
[  741.268413] Bluetooth: hci0: Failed to send Intel_Write_DDC (-22)
[  741.405046] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[  745.020624] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  745.021399] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  745.158637] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  745.159037] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  745.258394] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[  748.987711] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  748.988508] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  749.119218] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  749.119718] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  749.221934] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[  749.907404] e1000e: eth0 NIC Link is Down
[  750.129204] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[  750.300500] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  750.301245] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  750.430632] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  750.431032] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[  750.526811] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[  752.851377] wlp2s0: authenticate with 40:65:a3:15:37:9e
[  752.862528] wlp2s0: send auth to 40:65:a3:15:37:9e (try 1/3)
[  752.870660] wlp2s0: authenticated
[  752.872354] wlp2s0: associate with 40:65:a3:15:37:9e (try 1/3)
[  752.876207] wlp2s0: RX AssocResp from 40:65:a3:15:37:9e (capab=0x1411 status=0 aid=3)
[  752.881844] wlp2s0: associated
[  752.881938] IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0: link becomes ready
[ 1282.454844] PM: Syncing filesystems ... done.
[ 1283.649804] PM: Preparing system for sleep (mem)
[ 1283.651183] (NULL device *): firmware: direct-loading firmware iwlwifi-8000C-22.ucode
[ 1283.651203] Freezing user space processes ... (elapsed 0.001 seconds) done.
[ 1283.653153] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
[ 1283.654380] PM: Suspending system (mem)
[ 1283.654450] Suspending console(s) (use no_console_suspend to debug)
[ 1283.761164] wlp2s0: deauthenticating from 40:65:a3:15:37:9e by local choice (Reason: 3=DEAUTH_LEAVING)
[ 1283.761342] sd 2:0:0:0: [sdb] Synchronizing SCSI cache
[ 1283.761384] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[ 1283.768605] sd 2:0:0:0: [sdb] Stopping disk
[ 1283.805931] sd 0:0:0:0: [sda] Stopping disk
[ 1283.888777] ACPI : EC: event blocked
[ 1284.355417] PM: suspend of devices complete after 594.728 msecs
[ 1284.380480] PM: late suspend of devices complete after 25.057 msecs
[ 1284.381205] ACPI : EC: interrupt blocked
[ 1284.383787] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
[ 1284.465228] PM: noirq suspend of devices complete after 84.745 msecs
[ 1284.466270] ACPI: Preparing to enter system sleep state S3
[ 1284.468435] ACPI : EC: EC stopped
[ 1284.468436] PM: Saving platform NVS memory
[ 1284.468471] Disabling non-boot CPUs ...
[ 1284.469005] Broke affinity for irq 276
[ 1284.469011] Broke affinity for irq 279
[ 1284.470055] smpboot: CPU 1 is now offline
[ 1284.471252] Broke affinity for irq 272
[ 1284.471259] Broke affinity for irq 275
[ 1284.471261] Broke affinity for irq 276
[ 1284.471266] Broke affinity for irq 279
[ 1284.473351] smpboot: CPU 2 is now offline
[ 1284.474164] Broke affinity for irq 1
[ 1284.474184] Broke affinity for irq 9
[ 1284.474193] Broke affinity for irq 12
[ 1284.474211] Broke affinity for irq 16
[ 1284.474248] Broke affinity for irq 272
[ 1284.474253] Broke affinity for irq 275
[ 1284.474255] Broke affinity for irq 276
[ 1284.474259] Broke affinity for irq 279
[ 1284.474261] Broke affinity for irq 280
[ 1284.475292] smpboot: CPU 3 is now offline
[ 1284.478901] ACPI: Low-level resume complete
[ 1284.479019] ACPI : EC: EC started
[ 1284.479020] PM: Restoring platform NVS memory
[ 1284.479750] Suspended for 24863.048 seconds
[ 1284.479803] Enabling non-boot CPUs ...
[ 1284.479854] x86: Booting SMP configuration:
[ 1284.479855] smpboot: Booting Node 0 Processor 1 APIC 0x2
[ 1284.482495]  cache: parent cpu1 should not be sleeping
[ 1284.482678] CPU1 is up
[ 1284.482716] smpboot: Booting Node 0 Processor 2 APIC 0x1
[ 1284.485395]  cache: parent cpu2 should not be sleeping
[ 1284.485593] CPU2 is up
[ 1284.485630] smpboot: Booting Node 0 Processor 3 APIC 0x3
[ 1284.488257]  cache: parent cpu3 should not be sleeping
[ 1284.488482] CPU3 is up
[ 1284.492067] ACPI: Waking up from system sleep state S3
[ 1284.513966] acpi LNXPOWER:17: Turning OFF
[ 1284.513996] acpi LNXPOWER:16: Turning OFF
[ 1284.514025] acpi LNXPOWER:15: Turning OFF
[ 1284.514054] acpi LNXPOWER:14: Turning OFF
[ 1284.514083] acpi LNXPOWER:13: Turning OFF
[ 1284.514112] acpi LNXPOWER:12: Turning OFF
[ 1284.514141] acpi LNXPOWER:11: Turning OFF
[ 1284.514170] acpi LNXPOWER:10: Turning OFF
[ 1284.514199] acpi LNXPOWER:0f: Turning OFF
[ 1284.514228] acpi LNXPOWER:0e: Turning OFF
[ 1284.514256] acpi LNXPOWER:0d: Turning OFF
[ 1284.514285] acpi LNXPOWER:0c: Turning OFF
[ 1284.514314] acpi LNXPOWER:0b: Turning OFF
[ 1284.514343] acpi LNXPOWER:0a: Turning OFF
[ 1284.514372] acpi LNXPOWER:09: Turning OFF
[ 1284.514400] acpi LNXPOWER:08: Turning OFF
[ 1284.514429] acpi LNXPOWER:07: Turning OFF
[ 1284.514458] acpi LNXPOWER:06: Turning OFF
[ 1284.514487] acpi LNXPOWER:05: Turning OFF
[ 1284.514643] acpi LNXPOWER:04: Turning OFF
[ 1284.576434] acpi LNXPOWER:03: Turning OFF
[ 1284.576850] ACPI : EC: interrupt unblocked
[ 1284.618374] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
[ 1284.733181] PM: noirq resume of devices complete after 156.625 msecs
[ 1284.733271] pciehp 0000:00:1c.0:pcie004: Slot(1): Card present
[ 1284.733274] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up
[ 1284.736465] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up event ignored; already powering on
[ 1284.746821] PM: early resume of devices complete after 13.520 msecs
[ 1284.747189] usb usb1: root hub lost power or was reset
[ 1284.747193] usb usb2: root hub lost power or was reset
[ 1284.748009] sd 0:0:0:0: [sda] Starting disk
[ 1284.748015] sd 2:0:0:0: [sdb] Starting disk
[ 1284.749263] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1284.749991] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1284.805465] [drm] GuC firmware load skipped
[ 1284.844386] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[ 1284.844389] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[ 1284.877743] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1284.878139] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1284.952349] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[ 1284.952353] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[ 1285.063084] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1285.064184] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[ 1285.065811] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[ 1285.066599] ata3.00: configured for UDMA/133
[ 1285.092433] usb 1-7: reset full-speed USB device number 2 using xhci_hcd
[ 1285.352683] usb 1-9: reset high-speed USB device number 4 using xhci_hcd
[ 1285.612694] usb 1-8: reset full-speed USB device number 3 using xhci_hcd
[ 1286.036382] ACPI : EC: event unblocked
[ 1286.038783] rtc_cmos 00:03: System wakeup disabled by ACPI
[ 1286.148436] tpm tpm0: A TPM error (7) occurred attempting to read a pcr value
[ 1286.148440] tpm tpm0: TPM is disabled/deactivated (0x7)
[ 1286.152800] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a7de845e8 (20160831/exresop-594)
[ 1286.152805] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[ 1286.152818] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1286.152829] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1286.154908] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a8b29d9d8 (20160831/exresop-594)
[ 1286.154913] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[ 1286.154925] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1286.154937] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1286.154995] PM: resume of devices complete after 1408.212 msecs
[ 1286.155230] usb 1-7:1.0: rebind failed: -517
[ 1286.155235] usb 1-7:1.1: rebind failed: -517
[ 1286.155715] PM: Finishing wakeup.
[ 1286.155717] Restarting tasks ... done.
[ 1286.175049] Bluetooth: hci0: Bootloader revision 0.0 build 2 week 52 2014
[ 1286.181117] Bluetooth: hci0: Device revision is 5
[ 1286.181119] Bluetooth: hci0: Secure boot is enabled
[ 1286.181120] Bluetooth: hci0: OTP lock is enabled
[ 1286.181121] Bluetooth: hci0: API lock is enabled
[ 1286.181122] Bluetooth: hci0: Debug lock is disabled
[ 1286.181123] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[ 1286.181293] bluetooth hci0: firmware: direct-loading firmware intel/ibt-11-5.sfi
[ 1286.181295] Bluetooth: hci0: Found device firmware: intel/ibt-11-5.sfi
[ 1286.325635] [drm] RC6 on
[ 1286.380280] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1286.381860] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[ 1286.381862] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[ 1286.383761] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[ 1286.383763] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[ 1286.383943] ata1.00: configured for UDMA/133
[ 1287.402401] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1287.403119] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1287.435211] psmouse serio3: synaptics: queried max coordinates: x [..5670], y [..4758]
[ 1287.466436] psmouse serio3: synaptics: queried min coordinates: x [1360..], y [1198..]
[ 1287.531028] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1287.531428] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1287.619015] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[ 1287.784689] e1000e: eth0 NIC Link is Down
[ 1287.788215] Bluetooth: hci0: Waiting for firmware download to complete
[ 1287.789105] Bluetooth: hci0: Firmware loaded in 1578390 usecs
[ 1287.789380] Bluetooth: hci0: Waiting for device to boot
[ 1287.800142] Bluetooth: hci0: Device booted in 10698 usecs
[ 1287.800188] bluetooth hci0: firmware: direct-loading firmware intel/ibt-11-5.ddc
[ 1287.800193] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-11-5.ddc
[ 1287.801287] Bluetooth: hci0: Failed to send Intel_Write_DDC (-22)
[ 1288.000714] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 1291.007369] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1291.008291] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1291.138510] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1291.138910] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1291.234218] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[ 1294.910753] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1294.911465] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1295.041247] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1295.041646] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1295.138179] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[ 1295.707487] e1000e: eth0 NIC Link is Down
[ 1295.924732] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 1296.063532] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1296.064283] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1296.195052] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1296.195544] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1296.295279] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[ 1298.592959] wlp2s0: authenticate with 40:65:a3:15:37:9e
[ 1298.603769] wlp2s0: send auth to 40:65:a3:15:37:9e (try 1/3)
[ 1298.611459] wlp2s0: authenticated
[ 1298.611950] wlp2s0: associate with 40:65:a3:15:37:9e (try 1/3)
[ 1298.615709] wlp2s0: RX AssocResp from 40:65:a3:15:37:9e (capab=0x1411 status=0 aid=3)
[ 1298.618874] wlp2s0: associated
[ 1298.618974] IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0: link becomes ready
[ 1415.126613] PM: Syncing filesystems ... done.
[ 1415.238888] PM: Preparing system for sleep (mem)
[ 1415.239493] (NULL device *): firmware: direct-loading firmware intel/ibt-11-5.ddc
[ 1415.239733] (NULL device *): firmware: direct-loading firmware intel/ibt-11-5.sfi
[ 1415.240123] (NULL device *): firmware: direct-loading firmware iwlwifi-8000C-22.ucode
[ 1415.240144] Freezing user space processes ... (elapsed 0.002 seconds) done.
[ 1415.242277] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
[ 1415.243620] PM: Suspending system (mem)
[ 1415.243689] Suspending console(s) (use no_console_suspend to debug)
[ 1415.353337] wlp2s0: deauthenticating from 40:65:a3:15:37:9e by local choice (Reason: 3=DEAUTH_LEAVING)
[ 1415.353553] sd 2:0:0:0: [sdb] Synchronizing SCSI cache
[ 1415.353572] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[ 1415.357091] sd 0:0:0:0: [sda] Stopping disk
[ 1415.360751] sd 2:0:0:0: [sdb] Stopping disk
[ 1415.476762] ACPI : EC: event blocked
[ 1415.911948] PM: suspend of devices complete after 559.316 msecs
[ 1415.936437] PM: late suspend of devices complete after 24.483 msecs
[ 1415.937360] ACPI : EC: interrupt blocked
[ 1415.939676] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
[ 1416.020998] PM: noirq suspend of devices complete after 84.559 msecs
[ 1416.021918] ACPI: Preparing to enter system sleep state S3
[ 1416.023847] ACPI : EC: EC stopped
[ 1416.023848] PM: Saving platform NVS memory
[ 1416.023879] Disabling non-boot CPUs ...
[ 1416.024390] Broke affinity for irq 276
[ 1416.025431] smpboot: CPU 1 is now offline
[ 1416.026501] Broke affinity for irq 272
[ 1416.026507] Broke affinity for irq 275
[ 1416.026509] Broke affinity for irq 276
[ 1416.026512] Broke affinity for irq 277
[ 1416.026514] Broke affinity for irq 279
[ 1416.028513] smpboot: CPU 2 is now offline
[ 1416.029291] Broke affinity for irq 1
[ 1416.029308] Broke affinity for irq 9
[ 1416.029318] Broke affinity for irq 12
[ 1416.029335] Broke affinity for irq 16
[ 1416.029367] Broke affinity for irq 272
[ 1416.029371] Broke affinity for irq 275
[ 1416.029373] Broke affinity for irq 276
[ 1416.029375] Broke affinity for irq 277
[ 1416.029377] Broke affinity for irq 279
[ 1416.029379] Broke affinity for irq 280
[ 1416.030404] smpboot: CPU 3 is now offline
[ 1416.034535] ACPI: Low-level resume complete
[ 1416.034671] ACPI : EC: EC started
[ 1416.034672] PM: Restoring platform NVS memory
[ 1416.035414] Suspended for 7463.444 seconds
[ 1416.035484] Enabling non-boot CPUs ...
[ 1416.035561] x86: Booting SMP configuration:
[ 1416.035562] smpboot: Booting Node 0 Processor 1 APIC 0x2
[ 1416.038538]  cache: parent cpu1 should not be sleeping
[ 1416.038831] CPU1 is up
[ 1416.038889] smpboot: Booting Node 0 Processor 2 APIC 0x1
[ 1416.041906]  cache: parent cpu2 should not be sleeping
[ 1416.042197] CPU2 is up
[ 1416.042254] smpboot: Booting Node 0 Processor 3 APIC 0x3
[ 1416.045134]  cache: parent cpu3 should not be sleeping
[ 1416.045428] CPU3 is up
[ 1416.051263] ACPI: Waking up from system sleep state S3
[ 1416.062828] acpi LNXPOWER:17: Turning OFF
[ 1416.062876] acpi LNXPOWER:16: Turning OFF
[ 1416.062923] acpi LNXPOWER:15: Turning OFF
[ 1416.062970] acpi LNXPOWER:14: Turning OFF
[ 1416.063017] acpi LNXPOWER:13: Turning OFF
[ 1416.063064] acpi LNXPOWER:12: Turning OFF
[ 1416.063111] acpi LNXPOWER:11: Turning OFF
[ 1416.063158] acpi LNXPOWER:10: Turning OFF
[ 1416.063204] acpi LNXPOWER:0f: Turning OFF
[ 1416.063250] acpi LNXPOWER:0e: Turning OFF
[ 1416.063296] acpi LNXPOWER:0d: Turning OFF
[ 1416.063342] acpi LNXPOWER:0c: Turning OFF
[ 1416.063388] acpi LNXPOWER:0b: Turning OFF
[ 1416.063435] acpi LNXPOWER:0a: Turning OFF
[ 1416.063481] acpi LNXPOWER:09: Turning OFF
[ 1416.063528] acpi LNXPOWER:08: Turning OFF
[ 1416.063574] acpi LNXPOWER:07: Turning OFF
[ 1416.063620] acpi LNXPOWER:06: Turning OFF
[ 1416.063667] acpi LNXPOWER:05: Turning OFF
[ 1416.063899] acpi LNXPOWER:04: Turning OFF
[ 1416.124812] acpi LNXPOWER:03: Turning OFF
[ 1416.125192] ACPI : EC: interrupt unblocked
[ 1416.166802] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
[ 1416.281544] PM: noirq resume of devices complete after 156.607 msecs
[ 1416.281639] pciehp 0000:00:1c.0:pcie004: Slot(1): Card present
[ 1416.281642] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up
[ 1416.281940] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up event ignored; already powering on
[ 1416.283629] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a88851bd0 (20160831/exresop-594)
[ 1416.283633] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[ 1416.283643] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1416.283652] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1416.284976] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a88851168 (20160831/exresop-594)
[ 1416.284979] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[ 1416.284988] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1416.284997] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1416.298302] PM: early resume of devices complete after 13.507 msecs
[ 1416.298661] usb usb1: root hub lost power or was reset
[ 1416.298665] usb usb2: root hub lost power or was reset
[ 1416.300303] sd 0:0:0:0: [sda] Starting disk
[ 1416.300304] sd 2:0:0:0: [sdb] Starting disk
[ 1416.302134] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1416.302990] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1416.358039] [drm] GuC firmware load skipped
[ 1416.388895] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[ 1416.388898] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[ 1416.431576] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1416.431963] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1416.496797] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[ 1416.496800] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[ 1416.615375] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1416.616009] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[ 1416.617926] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[ 1416.619132] ata3.00: configured for UDMA/133
[ 1416.648898] usb 1-8: reset full-speed USB device number 3 using xhci_hcd
[ 1416.908971] usb 1-7: reset full-speed USB device number 2 using xhci_hcd
[ 1417.168857] usb 1-9: reset high-speed USB device number 4 using xhci_hcd
[ 1417.572987] ACPI : EC: event unblocked
[ 1417.573592] rtc_cmos 00:03: System wakeup disabled by ACPI
[ 1417.684721] tpm tpm0: A TPM error (7) occurred attempting to read a pcr value
[ 1417.684724] tpm tpm0: TPM is disabled/deactivated (0x7)
[ 1417.688454] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a8b29d3f0 (20160831/exresop-594)
[ 1417.688459] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[ 1417.688470] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1417.688480] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1417.689964] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a870a1828 (20160831/exresop-594)
[ 1417.689967] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[ 1417.689978] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1417.689988] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[ 1417.690449] PM: resume of devices complete after 1392.185 msecs
[ 1417.690633] usb 1-7:1.0: rebind failed: -517
[ 1417.690640] usb 1-7:1.1: rebind failed: -517
[ 1417.690959] PM: Finishing wakeup.
[ 1417.690960] Restarting tasks ... done.
[ 1417.707952] Bluetooth: hci0: Bootloader revision 0.0 build 2 week 52 2014
[ 1417.714170] [drm] RC6 on
[ 1417.714201] Bluetooth: hci0: Device revision is 5
[ 1417.714202] Bluetooth: hci0: Secure boot is enabled
[ 1417.714203] Bluetooth: hci0: OTP lock is enabled
[ 1417.714204] Bluetooth: hci0: API lock is enabled
[ 1417.714204] Bluetooth: hci0: Debug lock is disabled
[ 1417.714206] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[ 1417.714209] Bluetooth: hci0: Found device firmware: intel/ibt-11-5.sfi
[ 1417.808709] usb 2-4: new SuperSpeed USB device number 2 using xhci_hcd
[ 1417.829069] usb 2-4: New USB device found, idVendor=0424, idProduct=5534
[ 1417.829071] usb 2-4: New USB device strings: Mfr=2, Product=3, SerialNumber=0
[ 1417.829073] usb 2-4: Product: USB5534B
[ 1417.829074] usb 2-4: Manufacturer: SMSC
[ 1417.829745] hub 2-4:1.0: USB hub found
[ 1417.829926] hub 2-4:1.0: 4 ports detected
[ 1417.858993] NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter.
[ 1417.948646] usb 1-4: new high-speed USB device number 7 using xhci_hcd
[ 1417.949738] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1417.950278] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=0
[ 1417.951244] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[ 1417.951246] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[ 1417.953104] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[ 1417.953107] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[ 1417.953312] ata1.00: configured for UDMA/133
[ 1418.088970] usb 1-4: New USB device found, idVendor=0424, idProduct=2134
[ 1418.088972] usb 1-4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[ 1418.088973] usb 1-4: Product: USB2134B
[ 1418.088975] usb 1-4: Manufacturer: SMSC
[ 1418.089365] hub 1-4:1.0: USB hub found
[ 1418.089436] hub 1-4:1.0: 4 ports detected
[ 1418.512560] EXT4-fs (sda1): re-mounted. Opts: block_validity,barrier,user_xattr,acl,stripe=4
[ 1418.636491] EXT4-fs (dm-1): re-mounted. Opts: data=ordered,commit=0
[ 1418.878782] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1418.879502] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1418.912643] usb 1-4.3: new low-speed USB device number 9 using xhci_hcd
[ 1419.006816] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1419.007221] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1419.014440] psmouse serio3: synaptics: queried max coordinates: x [..5670], y [..4758]
[ 1419.016034] usb 1-4.3: New USB device found, idVendor=0461, idProduct=4d22
[ 1419.016038] usb 1-4.3: New USB device strings: Mfr=0, Product=2, SerialNumber=0
[ 1419.016041] usb 1-4.3: Product: USB Optical Mouse
[ 1419.044570] psmouse serio3: synaptics: queried min coordinates: x [1360..], y [1198..]
[ 1419.090778] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[ 1419.096622] usb 1-4.4: new low-speed USB device number 10 using xhci_hcd
[ 1419.184200] Bluetooth: hci0: Waiting for firmware download to complete
[ 1419.184947] Bluetooth: hci0: Firmware loaded in 1443476 usecs
[ 1419.184974] Bluetooth: hci0: Waiting for device to boot
[ 1419.195941] Bluetooth: hci0: Device booted in 10731 usecs
[ 1419.195946] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-11-5.ddc
[ 1419.196964] Bluetooth: hci0: Failed to send Intel_Write_DDC (-22)
[ 1419.202270] usb 1-4.4: New USB device found, idVendor=413c, idProduct=2107
[ 1419.202273] usb 1-4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[ 1419.202275] usb 1-4.4: Product: Dell USB Entry Keyboard
[ 1419.202276] usb 1-4.4: Manufacturer: DELL
[ 1419.301997] e1000e 0000:00:1f.6: Failed to restore TIMINCA clock rate delta: -22
[ 1419.304585] e1000e: eth0 NIC Link is Down
[ 1419.521228] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 1419.868796] usb 2-4.1: new SuperSpeed USB device number 3 using xhci_hcd
[ 1419.896549] usb 2-4.1: New USB device found, idVendor=174c, idProduct=5106
[ 1419.896556] usb 2-4.1: New USB device strings: Mfr=2, Product=3, SerialNumber=1
[ 1419.896560] usb 2-4.1: Product: StoreJet Transcend
[ 1419.896563] usb 2-4.1: Manufacturer: StoreJet Transcend
[ 1419.896566] usb 2-4.1: SerialNumber: S344J9GFC07086      
[ 1420.018578] usbcore: registered new interface driver usbhid
[ 1420.018581] usbhid: USB HID core driver
[ 1420.047505] input: USB Optical Mouse as /devices/pci0000:00/0000:00:14.0/usb1/1-4/1-4.3/1-4.3:1.0/0003:0461:4D22.0001/input/input35
[ 1420.048135] hid-generic 0003:0461:4D22.0001: input,hidraw0: USB HID v1.11 Mouse [USB Optical Mouse] on usb-0000:00:14.0-4.3/input0
[ 1420.048317] input: DELL Dell USB Entry Keyboard as /devices/pci0000:00/0000:00:14.0/usb1/1-4/1-4.4/1-4.4:1.0/0003:413C:2107.0002/input/input36
[ 1420.104800] hid-generic 0003:413C:2107.0002: input,hidraw1: USB HID v1.11 Keyboard [DELL Dell USB Entry Keyboard] on usb-0000:00:14.0-4.4/input0
[ 1420.253074] usb-storage 2-4.1:1.0: USB Mass Storage device detected
[ 1420.253132] scsi host3: usb-storage 2-4.1:1.0
[ 1420.253204] usbcore: registered new interface driver usb-storage
[ 1420.254217] usbcore: registered new interface driver uas
[ 1421.072901] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: None
[ 1421.072983] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 1421.289345] scsi 3:0:0:0: Direct-Access     StoreJet Transcend        0    PQ: 0 ANSI: 6
[ 1421.290828] sd 3:0:0:0: Attached scsi generic sg2 type 0
[ 1421.291008] sd 3:0:0:0: [sdc] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB)
[ 1421.291281] sd 3:0:0:0: [sdc] Write Protect is off
[ 1421.291293] sd 3:0:0:0: [sdc] Mode Sense: 43 00 00 00
[ 1421.291551] sd 3:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1421.328608]  sdc: sdc1
[ 1421.330412] sd 3:0:0:0: [sdc] Attached SCSI disk
[ 1423.130149] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1423.130943] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1423.260900] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1423.261313] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1423.360917] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[ 1423.396660] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1423.397443] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1423.526406] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1423.526833] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[ 1423.617549] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[ 1423.873609] e1000e: eth0 NIC Link is Down
[ 1424.109368] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 1424.317482] e1000e: eth0 NIC Link is Down
[ 1424.605161] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 1426.129233] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: None
[ 1426.129365] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 1443.070398] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1592 end=1593) time 166 us, min 1073, max 1079, scanline start 1069, end 1080
[ 1969.829087] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=31575 end=31576) time 146 us, min 1043, max 1049, scanline start 1041, end 1051
[ 1989.892857] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=34432 end=34433) time 142 us, min 1073, max 1079, scanline start 1070, end 1080
[ 2171.513669] UDF-fs: warning (device sdc1): udf_load_vrs: No VRS found
[ 2171.513671] UDF-fs: warning (device sdc1): udf_fill_super: No partition found (2)
[ 2171.515041] UDF-fs: warning (device sdc1): udf_load_vrs: No VRS found
[ 2171.515042] UDF-fs: warning (device sdc1): udf_fill_super: No partition found (2)
[ 2171.527923] ISOFS: Unable to identify CD-ROM format.
[ 2171.539638] ISOFS: Unable to identify CD-ROM format.
[ 2171.543723] FAT-fs (sdc1): bogus number of reserved sectors
[ 2171.543727] FAT-fs (sdc1): Can't find a valid FAT filesystem
[ 2171.545388] FAT-fs (sdc1): bogus number of reserved sectors
[ 2171.545392] FAT-fs (sdc1): Can't find a valid FAT filesystem
[ 2171.548867] hfsplus: unable to find HFS+ superblock
[ 2171.550384] hfsplus: unable to find HFS+ superblock
[ 2171.553543] hfs: can't find a HFS filesystem on dev sdc1
[ 2171.555028] hfs: can't find a HFS filesystem on dev sdc1
[ 2171.556293] EXT4-fs (sdc1): couldn't mount as ext3 due to feature incompatibilities
[ 2171.557498] EXT4-fs (sdc1): couldn't mount as ext3 due to feature incompatibilities
[ 2171.558679] EXT4-fs (sdc1): couldn't mount as ext2 due to feature incompatibilities
[ 2171.559882] EXT4-fs (sdc1): couldn't mount as ext2 due to feature incompatibilities
[ 2171.881837] EXT4-fs (sdc1): mounted filesystem with ordered data mode. Opts: errors=remount-ro
[ 2431.007457] usb 1-2: new high-speed USB device number 11 using xhci_hcd
[ 2431.149245] usb 1-2: New USB device found, idVendor=04e8, idProduct=6860
[ 2431.149252] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 2431.149256] usb 1-2: Product: SAMSUNG_Android
[ 2431.149260] usb 1-2: Manufacturer: SAMSUNG
[ 2431.149264] usb 1-2: SerialNumber: 2cbc57d0
[ 2655.104892] usb 1-2: USB disconnect, device number 11
[ 2659.483576] usb 1-2: new high-speed USB device number 12 using xhci_hcd
[ 2659.626802] usb 1-2: New USB device found, idVendor=04e8, idProduct=6860
[ 2659.626809] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 2659.626814] usb 1-2: Product: SAMSUNG_Android
[ 2659.626818] usb 1-2: Manufacturer: SAMSUNG
[ 2659.626821] usb 1-2: SerialNumber: 2cbc57d0
[ 2773.709268] usb 1-2: USB disconnect, device number 12
[ 2776.335687] usb 1-2: new high-speed USB device number 13 using xhci_hcd
[ 2776.477927] usb 1-2: New USB device found, idVendor=04e8, idProduct=6860
[ 2776.477934] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 2776.477939] usb 1-2: Product: SAMSUNG_Android
[ 2776.477943] usb 1-2: Manufacturer: SAMSUNG
[ 2776.477946] usb 1-2: SerialNumber: 2cbc57d0
[ 2897.349704] usb 1-2: USB disconnect, device number 13
[ 3007.035872] usb 1-2: new high-speed USB device number 14 using xhci_hcd
[ 3007.177479] usb 1-2: New USB device found, idVendor=04e8, idProduct=6860
[ 3007.177481] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 3007.177482] usb 1-2: Product: SAMSUNG_Android
[ 3007.177482] usb 1-2: Manufacturer: SAMSUNG
[ 3007.177483] usb 1-2: SerialNumber: 2cbc57d0
[ 3141.326947] usb 1-2: USB disconnect, device number 14
[ 4309.825101] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=170341 end=170342) time 143 us, min 1073, max 1079, scanline start 1070, end 1080
[ 4838.482333] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=200152 end=200153) time 146 us, min 1043, max 1049, scanline start 1041, end 1050
[ 5427.515372] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=235467 end=235468) time 145 us, min 1043, max 1049, scanline start 1040, end 1050
[ 5820.181897] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=259009 end=259010) time 147 us, min 1043, max 1049, scanline start 1042, end 1052
[ 6409.231635] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=294325 end=294326) time 171 us, min 1043, max 1049, scanline start 1041, end 1053
[ 7895.326403] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=379983 end=379984) time 146 us, min 1043, max 1049, scanline start 1040, end 1050
[ 8091.676320] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=391755 end=391756) time 146 us, min 1043, max 1049, scanline start 1040, end 1050
[ 8751.109457] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=433613 end=433614) time 169 us, min 1073, max 1079, scanline start 1070, end 1082
[ 9083.416855] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=451214 end=451215) time 153 us, min 1043, max 1049, scanline start 1041, end 1051
[ 9153.849934] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=457800 end=457801) time 169 us, min 1073, max 1079, scanline start 1072, end 1084
[10331.816166] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=528544 end=528545) time 143 us, min 1073, max 1079, scanline start 1072, end 1082
[10528.199368] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=540338 end=540339) time 143 us, min 1073, max 1079, scanline start 1071, end 1081
[10961.399041] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=562900 end=562901) time 143 us, min 1073, max 1079, scanline start 1070, end 1080
[11354.132174] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=586486 end=586487) time 143 us, min 1073, max 1079, scanline start 1070, end 1080
[11686.506135] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=603840 end=603841) time 171 us, min 1043, max 1049, scanline start 1040, end 1052
[11746.865316] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=610072 end=610073) time 143 us, min 1073, max 1079, scanline start 1072, end 1082
[12079.205991] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=627384 end=627385) time 171 us, min 1043, max 1049, scanline start 1042, end 1053
[12275.572511] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=639157 end=639158) time 146 us, min 1043, max 1049, scanline start 1040, end 1050
[14456.281473] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=769341 end=769342) time 169 us, min 1073, max 1079, scanline start 1071, end 1082
[15377.688403] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=821704 end=821705) time 145 us, min 1043, max 1049, scanline start 1040, end 1050
[15438.047665] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=828302 end=828303) time 143 us, min 1073, max 1079, scanline start 1071, end 1081
[15966.738158] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=857020 end=857021) time 171 us, min 1043, max 1049, scanline start 1039, end 1050
[16742.080104] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=903505 end=903506) time 147 us, min 1043, max 1049, scanline start 1042, end 1052
[17144.854277] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=927653 end=927654) time 146 us, min 1043, max 1049, scanline start 1041, end 1050
[17537.570782] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=951198 end=951199) time 147 us, min 1043, max 1049, scanline start 1041, end 1051
[18186.963160] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=993391 end=993392) time 169 us, min 1073, max 1079, scanline start 1070, end 1082
[18519.320325] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1010058 end=1010059) time 146 us, min 1043, max 1049, scanline start 1040, end 1050
[19108.336757] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1045372 end=1045373) time 172 us, min 1043, max 1049, scanline start 1041, end 1053
[19304.703299] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1057145 end=1057146) time 146 us, min 1043, max 1049, scanline start 1042, end 1051
[20160.502876] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1111914 end=1111915) time 144 us, min 1073, max 1079, scanline start 1070, end 1080
[22850.144938] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1266136 end=1266137) time 172 us, min 1043, max 1049, scanline start 1039, end 1051
[23509.627983] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1309452 end=1309453) time 142 us, min 1073, max 1079, scanline start 1070, end 1080
[24617.327490] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1372086 end=1372087) time 146 us, min 1043, max 1049, scanline start 1042, end 1052
[24884.110771] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1391998 end=1391999) time 170 us, min 1073, max 1079, scanline start 1072, end 1084
[26188.126756] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1466262 end=1466263) time 146 us, min 1043, max 1049, scanline start 1040, end 1050
[26454.876697] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1486332 end=1486333) time 142 us, min 1073, max 1079, scanline start 1070, end 1080
[27191.119079] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1522955 end=1522956) time 171 us, min 1043, max 1049, scanline start 1042, end 1054
[27976.485333] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1570041 end=1570042) time 171 us, min 1043, max 1049, scanline start 1040, end 1052
[28036.844663] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1577891 end=1577892) time 169 us, min 1073, max 1079, scanline start 1071, end 1083
[28565.551724] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1605358 end=1605359) time 145 us, min 1043, max 1049, scanline start 1042, end 1052
[29154.568072] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1640672 end=1640673) time 145 us, min 1043, max 1049, scanline start 1041, end 1051
[29421.367979] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1661040 end=1661041) time 144 us, min 1073, max 1079, scanline start 1071, end 1081
[29607.660623] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1672228 end=1672229) time 169 us, min 1073, max 1079, scanline start 1070, end 1082
[29743.667864] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1675991 end=1675992) time 172 us, min 1043, max 1049, scanline start 1038, end 1050
[30126.276626] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1698930 end=1698931) time 145 us, min 1043, max 1049, scanline start 1041, end 1051
[30196.693725] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1707603 end=1707604) time 170 us, min 1073, max 1079, scanline start 1071, end 1082
[30795.784044] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1743582 end=1743583) time 143 us, min 1073, max 1079, scanline start 1071, end 1081
[30921.717283] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1746620 end=1746621) time 145 us, min 1043, max 1049, scanline start 1042, end 1052
[31188.483861] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1767166 end=1767167) time 143 us, min 1073, max 1079, scanline start 1071, end 1081
[32100.285811] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1813840 end=1813841) time 147 us, min 1043, max 1049, scanline start 1041, end 1051
[32356.994996] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe A (start=1833885 end=1833886) time 169 us, min 1073, max 1079, scanline start 1068, end 1080
[33474.701880] [drm:intel_pipe_update_end [i915]] *ERROR* Atomic update failure on pipe B (start=1896242 end=1896243) time 171 us, min 1043, max 1049, scanline start 1041, end 1053
[34495.658103] usb 1-4.2: new high-speed USB device number 15 using xhci_hcd
[34495.759065] usb 1-4.2: New USB device found, idVendor=1908, idProduct=1320
[34495.759073] usb 1-4.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[34495.759077] usb 1-4.2: Product: Mass storage
[34495.759081] usb 1-4.2: Manufacturer: Generic
[34495.759085] usb 1-4.2: SerialNumber: aaaaaaaaaa7499211377
[34495.760132] usb-storage 1-4.2:1.0: USB Mass Storage device detected
[34495.760379] scsi host4: usb-storage 1-4.2:1.0
[34496.784829] scsi 4:0:0:0: Direct-Access     Generic  Flash Disk       1.68 PQ: 0 ANSI: 2
[34496.786426] sd 4:0:0:0: [sdd] 2009088 512-byte logical blocks: (1.03 GB/981 MiB)
[34496.786432] sd 4:0:0:0: Attached scsi generic sg3 type 0
[34496.787834] sd 4:0:0:0: [sdd] Write Protect is off
[34496.787844] sd 4:0:0:0: [sdd] Mode Sense: 03 00 00 00
[34496.790093] sd 4:0:0:0: [sdd] No Caching mode page found
[34496.790108] sd 4:0:0:0: [sdd] Assuming drive cache: write through
[34496.797882]  sdd: sdd1
[34496.801998] sd 4:0:0:0: [sdd] Attached SCSI removable disk
[34507.053452] UDF-fs: warning (device sdd1): udf_load_vrs: No VRS found
[34507.053458] UDF-fs: warning (device sdd1): udf_fill_super: No partition found (2)
[34507.059141] UDF-fs: warning (device sdd1): udf_load_vrs: No VRS found
[34507.059147] UDF-fs: warning (device sdd1): udf_fill_super: No partition found (2)
[34507.100865] ISOFS: Unable to identify CD-ROM format.
[34507.141504] ISOFS: Unable to identify CD-ROM format.
[34507.154318] FAT-fs (sdd1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[34621.133707] usb 1-4.2: USB disconnect, device number 15
[34966.485959] SGI XFS with ACLs, security attributes, realtime, no debug enabled
[34966.489833] JFS: nTxBlock = 8192, nTxLock = 65536
[34966.496641] ntfs: driver 2.1.32 [Flags: R/O MODULE].
[34966.502788] QNX4 filesystem 0.2.3 registered.
[34966.574192] raid6: sse2x1   gen() 10319 MB/s
[34966.642180] raid6: sse2x1   xor()  8137 MB/s
[34966.710173] raid6: sse2x2   gen() 14539 MB/s
[34966.778199] raid6: sse2x2   xor() 10114 MB/s
[34966.846177] raid6: sse2x4   gen() 15265 MB/s
[34966.914175] raid6: sse2x4   xor() 11001 MB/s
[34966.982167] raid6: avx2x1   gen() 23260 MB/s
[34967.050165] raid6: avx2x2   gen() 26769 MB/s
[34967.118163] raid6: avx2x4   gen() 27517 MB/s
[34967.118165] raid6: using algorithm avx2x4 gen() 27517 MB/s
[34967.118166] raid6: using avx2x2 recovery algorithm
[34967.125992] xor: automatically using best checksumming function   avx       
[34967.135469] Btrfs loaded, crc32c=crc32c-intel
[35292.539517] PM: Syncing filesystems ... done.
[35292.634936] PM: Preparing system for sleep (mem)
[35292.637216] (NULL device *): firmware: direct-loading firmware iwlwifi-8000C-22.ucode
[35292.637333] Freezing user space processes ... (elapsed 0.002 seconds) done.
[35292.639995] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
[35292.641525] PM: Suspending system (mem)
[35292.641625] Suspending console(s) (use no_console_suspend to debug)
[35292.642278] sd 3:0:0:0: [sdc] Synchronizing SCSI cache
[35292.644115] sd 2:0:0:0: [sdb] Synchronizing SCSI cache
[35292.644733] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[35292.645319] sd 2:0:0:0: [sdb] Stopping disk
[35292.661892] sd 0:0:0:0: [sda] Stopping disk
[35292.767742] e1000e: EEE TX LPI TIMER: 00000011
[35292.767974] ACPI : EC: event blocked
[35293.219128] PM: suspend of devices complete after 576.922 msecs
[35293.243440] PM: late suspend of devices complete after 24.299 msecs
[35293.245021] ACPI : EC: interrupt blocked
[35293.247923] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
[35293.332407] PM: noirq suspend of devices complete after 88.961 msecs
[35293.333797] ACPI: Preparing to enter system sleep state S3
[35293.336640] ACPI : EC: EC stopped
[35293.336641] PM: Saving platform NVS memory
[35293.336684] Disabling non-boot CPUs ...
[35293.337410] Broke affinity for irq 276
[35293.338478] smpboot: CPU 1 is now offline
[35293.340041] Broke affinity for irq 272
[35293.340049] Broke affinity for irq 275
[35293.340053] Broke affinity for irq 276
[35293.342522] smpboot: CPU 2 is now offline
[35293.343126] Broke affinity for irq 1
[35293.343144] Broke affinity for irq 9
[35293.343153] Broke affinity for irq 12
[35293.343170] Broke affinity for irq 16
[35293.343190] Broke affinity for irq 272
[35293.343192] Broke affinity for irq 275
[35293.343193] Broke affinity for irq 276
[35293.343194] Broke affinity for irq 279
[35293.343195] Broke affinity for irq 280
[35293.344204] smpboot: CPU 3 is now offline
[35293.347461] ACPI: Low-level resume complete
[35293.347597] ACPI : EC: EC started
[35293.347598] PM: Restoring platform NVS memory
[35293.348340] Suspended for 1912.557 seconds
[35293.348401] Enabling non-boot CPUs ...
[35293.348486] x86: Booting SMP configuration:
[35293.348487] smpboot: Booting Node 0 Processor 1 APIC 0x2
[35293.351449]  cache: parent cpu1 should not be sleeping
[35293.351749] CPU1 is up
[35293.351814] smpboot: Booting Node 0 Processor 2 APIC 0x1
[35293.354808]  cache: parent cpu2 should not be sleeping
[35293.355111] CPU2 is up
[35293.355190] smpboot: Booting Node 0 Processor 3 APIC 0x3
[35293.357980]  cache: parent cpu3 should not be sleeping
[35293.358294] CPU3 is up
[35293.364138] ACPI: Waking up from system sleep state S3
[35293.375365] acpi LNXPOWER:17: Turning OFF
[35293.375412] acpi LNXPOWER:16: Turning OFF
[35293.375459] acpi LNXPOWER:15: Turning OFF
[35293.375506] acpi LNXPOWER:14: Turning OFF
[35293.375553] acpi LNXPOWER:13: Turning OFF
[35293.375600] acpi LNXPOWER:12: Turning OFF
[35293.375647] acpi LNXPOWER:11: Turning OFF
[35293.375693] acpi LNXPOWER:10: Turning OFF
[35293.375739] acpi LNXPOWER:0f: Turning OFF
[35293.375785] acpi LNXPOWER:0e: Turning OFF
[35293.375832] acpi LNXPOWER:0d: Turning OFF
[35293.375878] acpi LNXPOWER:0c: Turning OFF
[35293.375924] acpi LNXPOWER:0b: Turning OFF
[35293.375971] acpi LNXPOWER:0a: Turning OFF
[35293.376017] acpi LNXPOWER:09: Turning OFF
[35293.376064] acpi LNXPOWER:08: Turning OFF
[35293.376110] acpi LNXPOWER:07: Turning OFF
[35293.376157] acpi LNXPOWER:06: Turning OFF
[35293.376204] acpi LNXPOWER:05: Turning OFF
[35293.376435] acpi LNXPOWER:04: Turning OFF
[35293.439240] acpi LNXPOWER:03: Turning OFF
[35293.439661] ACPI : EC: interrupt unblocked
[35293.481212] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
[35293.596019] PM: noirq resume of devices complete after 156.653 msecs
[35293.596076] pciehp 0000:00:1c.0:pcie004: Slot(1): Card present
[35293.596079] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up
[35293.596449] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up event ignored; already powering on
[35293.608668] PM: early resume of devices complete after 12.581 msecs
[35293.608989] usb usb1: root hub lost power or was reset
[35293.608992] usb usb2: root hub lost power or was reset
[35293.609798] sd 0:0:0:0: [sda] Starting disk
[35293.609800] sd 2:0:0:0: [sdb] Starting disk
[35293.611840] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35293.612704] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35293.668774] [drm] GuC firmware load skipped
[35293.703130] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[35293.703132] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[35293.747314] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35293.747697] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35293.811119] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[35293.811120] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[35293.921224] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[35293.921760] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[35293.923251] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[35293.924202] ata3.00: configured for UDMA/133
[35293.955137] usb 1-7: reset full-speed USB device number 2 using xhci_hcd
[35294.215116] usb 1-9: reset high-speed USB device number 4 using xhci_hcd
[35294.475268] usb 1-8: reset full-speed USB device number 3 using xhci_hcd
[35294.923142] ACPI : EC: event unblocked
[35294.923782] rtc_cmos 00:03: System wakeup disabled by ACPI
[35295.035358] tpm tpm0: A TPM error (7) occurred attempting to read a pcr value
[35295.035362] tpm tpm0: TPM is disabled/deactivated (0x7)
[35295.039598] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a88be84c8 (20160831/exresop-594)
[35295.039603] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[35295.039616] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[35295.039628] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[35295.041262] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a8b7f2168 (20160831/exresop-594)
[35295.041266] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[35295.041276] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[35295.041286] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[35295.239313] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[35295.241462] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[35295.241468] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[35295.244283] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[35295.244288] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[35295.244754] ata1.00: configured for UDMA/133
[35296.428470] psmouse serio3: synaptics: queried max coordinates: x [..5670], y [..4758]
[35296.462715] psmouse serio3: synaptics: queried min coordinates: x [1360..], y [1198..]
[35296.516851] xhci_hcd 0000:00:14.0: Cannot set link state.
[35296.516967] usb usb2-port4: cannot disable (err = -32)
[35296.637218] PM: resume of devices complete after 3028.643 msecs
[35296.637569] usb 1-7:1.0: rebind failed: -517
[35296.637576] usb 1-7:1.1: rebind failed: -517
[35296.638266] PM: Finishing wakeup.
[35296.638268] Restarting tasks ... 
[35296.638539] usb 1-4: USB disconnect, device number 7
[35296.638560] usb 1-4.3: USB disconnect, device number 9
[35296.639134] usb 2-4: USB disconnect, device number 2
[35296.639146] usb 2-4.1: USB disconnect, device number 3
[35296.643709] sd 3:0:0:0: [sdc] Synchronizing SCSI cache
[35296.643736] sd 3:0:0:0: [sdc] Synchronize Cache(10) failed: Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK
[35296.644418] usb 1-4.4: USB disconnect, device number 10
[35296.663553] done.
[35296.666942] Bluetooth: hci0: Bootloader revision 0.0 build 2 week 52 2014
[35296.667604] [drm] RC6 on
[35296.674178] Bluetooth: hci0: Device revision is 5
[35296.674180] Bluetooth: hci0: Secure boot is enabled
[35296.674180] Bluetooth: hci0: OTP lock is enabled
[35296.674181] Bluetooth: hci0: API lock is enabled
[35296.674181] Bluetooth: hci0: Debug lock is disabled
[35296.674183] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[35296.674379] bluetooth hci0: firmware: direct-loading firmware intel/ibt-11-5.sfi
[35296.674406] Bluetooth: hci0: Found device firmware: intel/ibt-11-5.sfi
[35296.978699] e1000e: eth0 NIC Link is Down
[35297.148281] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=600
[35297.220231] EXT4-fs (sda1): re-mounted. Opts: block_validity,barrier,user_xattr,acl,stripe=4
[35297.447190] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[35297.734953] EXT4-fs (dm-1): re-mounted. Opts: data=ordered,commit=600
[35297.835256] e1000e: eth0 NIC Link is Down
[35298.051202] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[35298.061747] Bluetooth: hci0: Waiting for firmware download to complete
[35298.062482] Bluetooth: hci0: Firmware loaded in 1370599 usecs
[35298.062521] Bluetooth: hci0: Waiting for device to boot
[35298.073503] Bluetooth: hci0: Device booted in 10737 usecs
[35298.073912] bluetooth hci0: firmware: direct-loading firmware intel/ibt-11-5.ddc
[35298.073915] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-11-5.ddc
[35298.074485] Bluetooth: hci0: Failed to send Intel_Write_DDC (-22)
[35301.766932] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35301.767740] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35301.905726] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35301.906128] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35302.002056] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[35302.253370] e1000e: eth0 NIC Link is Down
[35302.503997] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[35302.658223] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35302.659001] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35302.787670] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35302.788070] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35302.884615] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[35303.660034] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35303.660808] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35303.790251] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35303.790651] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35303.888394] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[35304.096242] e1000e: eth0 NIC Link is Down
[35304.315586] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[35305.207057] wlp2s0: authenticate with 40:65:a3:15:37:9e
[35305.218146] wlp2s0: send auth to 40:65:a3:15:37:9e (try 1/3)
[35305.225934] wlp2s0: authenticated
[35305.226820] wlp2s0: associate with 40:65:a3:15:37:9e (try 1/3)
[35305.230600] wlp2s0: RX AssocResp from 40:65:a3:15:37:9e (capab=0x1411 status=0 aid=2)
[35305.234506] wlp2s0: associated
[35305.234598] IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0: link becomes ready
[35785.842843] PM: Syncing filesystems ... done.
[35786.499609] PM: Preparing system for sleep (mem)
[35786.500248] (NULL device *): firmware: direct-loading firmware intel/ibt-11-5.ddc
[35786.500534] (NULL device *): firmware: direct-loading firmware intel/ibt-11-5.sfi
[35786.501331] (NULL device *): firmware: direct-loading firmware iwlwifi-8000C-22.ucode
[35786.501434] Freezing user space processes ... (elapsed 0.002 seconds) done.
[35786.503528] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
[35786.504876] PM: Suspending system (mem)
[35786.504946] Suspending console(s) (use no_console_suspend to debug)
[35786.614143] wlp2s0: deauthenticating from 40:65:a3:15:37:9e by local choice (Reason: 3=DEAUTH_LEAVING)
[35786.614270] sd 2:0:0:0: [sdb] Synchronizing SCSI cache
[35786.615078] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[35786.621443] sd 2:0:0:0: [sdb] Stopping disk
[35786.648596] sd 0:0:0:0: [sda] Stopping disk
[35786.741182] ACPI : EC: event blocked
[35787.208553] PM: suspend of devices complete after 595.057 msecs
[35787.233358] PM: late suspend of devices complete after 24.796 msecs
[35787.234164] ACPI : EC: interrupt blocked
[35787.236718] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
[35787.317503] PM: noirq suspend of devices complete after 84.138 msecs
[35787.318430] ACPI: Preparing to enter system sleep state S3
[35787.320357] ACPI : EC: EC stopped
[35787.320358] PM: Saving platform NVS memory
[35787.320389] Disabling non-boot CPUs ...
[35787.320890] Broke affinity for irq 276
[35787.321935] smpboot: CPU 1 is now offline
[35787.323010] Broke affinity for irq 272
[35787.323017] Broke affinity for irq 275
[35787.323019] Broke affinity for irq 276
[35787.323022] Broke affinity for irq 279
[35787.323025] Broke affinity for irq 281
[35787.324049] smpboot: CPU 2 is now offline
[35787.324812] Broke affinity for irq 1
[35787.324829] Broke affinity for irq 9
[35787.324837] Broke affinity for irq 12
[35787.324855] Broke affinity for irq 16
[35787.324889] Broke affinity for irq 272
[35787.324891] Broke affinity for irq 275
[35787.324892] Broke affinity for irq 276
[35787.324893] Broke affinity for irq 279
[35787.324894] Broke affinity for irq 280
[35787.324895] Broke affinity for irq 281
[35787.325901] smpboot: CPU 3 is now offline
[35787.329158] ACPI: Low-level resume complete
[35787.329293] ACPI : EC: EC started
[35787.329294] PM: Restoring platform NVS memory
[35787.330036] Suspended for 9.666 seconds
[35787.330097] Enabling non-boot CPUs ...
[35787.330183] x86: Booting SMP configuration:
[35787.330184] smpboot: Booting Node 0 Processor 1 APIC 0x2
[35787.333150]  cache: parent cpu1 should not be sleeping
[35787.333447] CPU1 is up
[35787.333511] smpboot: Booting Node 0 Processor 2 APIC 0x1
[35787.336520]  cache: parent cpu2 should not be sleeping
[35787.336825] CPU2 is up
[35787.336891] smpboot: Booting Node 0 Processor 3 APIC 0x3
[35787.339666]  cache: parent cpu3 should not be sleeping
[35787.339973] CPU3 is up
[35787.345820] ACPI: Waking up from system sleep state S3
[35787.357373] acpi LNXPOWER:17: Turning OFF
[35787.357425] acpi LNXPOWER:16: Turning OFF
[35787.357475] acpi LNXPOWER:15: Turning OFF
[35787.357525] acpi LNXPOWER:14: Turning OFF
[35787.357576] acpi LNXPOWER:13: Turning OFF
[35787.357626] acpi LNXPOWER:12: Turning OFF
[35787.357676] acpi LNXPOWER:11: Turning OFF
[35787.357725] acpi LNXPOWER:10: Turning OFF
[35787.357774] acpi LNXPOWER:0f: Turning OFF
[35787.357824] acpi LNXPOWER:0e: Turning OFF
[35787.357873] acpi LNXPOWER:0d: Turning OFF
[35787.357922] acpi LNXPOWER:0c: Turning OFF
[35787.357972] acpi LNXPOWER:0b: Turning OFF
[35787.358021] acpi LNXPOWER:0a: Turning OFF
[35787.358071] acpi LNXPOWER:09: Turning OFF
[35787.358120] acpi LNXPOWER:08: Turning OFF
[35787.358170] acpi LNXPOWER:07: Turning OFF
[35787.358219] acpi LNXPOWER:06: Turning OFF
[35787.358269] acpi LNXPOWER:05: Turning OFF
[35787.358524] acpi LNXPOWER:04: Turning OFF
[35787.420669] acpi LNXPOWER:03: Turning OFF
[35787.421097] ACPI : EC: interrupt unblocked
[35787.462456] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
[35787.577419] PM: noirq resume of devices complete after 156.618 msecs
[35787.577510] pciehp 0000:00:1c.0:pcie004: Slot(1): Card present
[35787.577513] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up
[35787.580846] pciehp 0000:00:1c.0:pcie004: Slot(1): Link Up event ignored; already powering on
[35787.590155] PM: early resume of devices complete after 12.613 msecs
[35787.590466] usb usb1: root hub lost power or was reset
[35787.590469] usb usb2: root hub lost power or was reset
[35787.591376] sd 0:0:0:0: [sda] Starting disk
[35787.591378] sd 2:0:0:0: [sdb] Starting disk
[35787.593503] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35787.594229] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35787.649674] [drm] GuC firmware load skipped
[35787.688588] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[35787.688593] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[35787.721960] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35787.722346] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35787.796627] pciehp 0000:00:1c.0:pcie004: Device 0000:01:00.0 already exists at 0000:01:00, cannot hot-add
[35787.796630] pciehp 0000:00:1c.0:pcie004: Cannot add device at 0000:01:00
[35787.902922] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[35787.903663] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[35787.905349] ata3.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[35787.906263] ata3.00: configured for UDMA/133
[35787.937064] usb 1-7: reset full-speed USB device number 2 using xhci_hcd
[35788.197113] usb 1-8: reset full-speed USB device number 3 using xhci_hcd
[35788.456819] usb 1-9: reset high-speed USB device number 4 using xhci_hcd
[35788.872954] ACPI : EC: event unblocked
[35788.873506] rtc_cmos 00:03: System wakeup disabled by ACPI
[35788.984914] tpm tpm0: A TPM error (7) occurred attempting to read a pcr value
[35788.984917] tpm tpm0: TPM is disabled/deactivated (0x7)
[35788.988352] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a88851bd0 (20160831/exresop-594)
[35788.988358] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[35788.988370] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[35788.988382] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[35788.990081] ACPI Error: Needed [Buffer/String/Package], found [Integer] ffff884a8b7f2240 (20160831/exresop-594)
[35788.990082] ACPI Exception: AE_AML_OPERAND_TYPE, While resolving operands for [OpcodeName unavailable] (20160831/dswexec-461)
[35788.990086] ACPI Error: Method parse/execution failed [\_SB.WMIV.WVPO] (Node ffff884a908a8988), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[35788.990089] ACPI Error: Method parse/execution failed [\_SB.WMIV.WMPV] (Node ffff884a908a87a8), AE_AML_OPERAND_TYPE (20160831/psparse-543)
[35788.990269] PM: resume of devices complete after 1400.098 msecs
[35788.990437] usb 1-7:1.0: rebind failed: -517
[35788.990439] usb 1-7:1.1: rebind failed: -517
[35788.990688] PM: Finishing wakeup.
[35788.990689] Restarting tasks ... done.
[35789.007957] Bluetooth: hci0: Bootloader revision 0.0 build 2 week 52 2014
[35789.014226] Bluetooth: hci0: Device revision is 5
[35789.014227] Bluetooth: hci0: Secure boot is enabled
[35789.014228] Bluetooth: hci0: OTP lock is enabled
[35789.014229] Bluetooth: hci0: API lock is enabled
[35789.014230] Bluetooth: hci0: Debug lock is disabled
[35789.014231] Bluetooth: hci0: Minimum firmware build 1 week 10 2014
[35789.014234] Bluetooth: hci0: Found device firmware: intel/ibt-11-5.sfi
[35789.018500] [drm] RC6 on
[35789.114500] NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter.
[35789.130549] EXT4-fs (sdb1): re-mounted. Opts: errors=remount-ro,data=ordered,commit=0
[35789.228582] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[35789.230077] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[35789.230079] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[35789.231871] ata1.00: ACPI cmd f5/00:00:00:00:00:e0 (SECURITY FREEZE LOCK) filtered out
[35789.231872] ata1.00: ACPI cmd b1/c1:00:00:00:00:e0 (DEVICE CONFIGURATION OVERLAY) filtered out
[35789.232072] ata1.00: configured for UDMA/133
[35790.285558] psmouse serio3: synaptics: queried max coordinates: x [..5670], y [..4758]
[35790.315687] psmouse serio3: synaptics: queried min coordinates: x [1360..], y [1198..]
[35790.429835] Bluetooth: hci0: Waiting for firmware download to complete
[35790.430253] Bluetooth: hci0: Firmware loaded in 1390769 usecs
[35790.430291] Bluetooth: hci0: Waiting for device to boot
[35790.441260] Bluetooth: hci0: Device booted in 10741 usecs
[35790.441266] Bluetooth: hci0: Found Intel DDC parameters: intel/ibt-11-5.ddc
[35790.442286] Bluetooth: hci0: Failed to send Intel_Write_DDC (-22)
[35791.012752] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35791.013477] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35791.141596] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35791.141996] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35791.225891] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[35791.431531] e1000e: eth0 NIC Link is Down
[35791.653317] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[35794.900788] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35794.901520] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35795.030232] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35795.030641] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35795.119078] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[35798.816868] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35798.817595] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35798.945872] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35798.946276] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35799.036479] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[35799.381162] e1000e: eth0 NIC Link is Down
[35799.601416] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[35799.751296] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35799.752021] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35799.880398] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35799.880811] iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
[35799.969593] IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
[35802.311548] wlp2s0: authenticate with 40:65:a3:15:37:9e
[35802.320175] wlp2s0: send auth to 40:65:a3:15:37:9e (try 1/3)
[35802.327852] wlp2s0: authenticated
[35802.328773] wlp2s0: associate with 40:65:a3:15:37:9e (try 1/3)
[35802.334388] wlp2s0: RX AssocResp from 40:65:a3:15:37:9e (capab=0x1411 status=0 aid=2)
[35802.336253] wlp2s0: associated
[35802.336351] IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0: link becomes ready
[35803.071297] PM: Hibernation mode set to 'platform'
[35803.073307] (NULL device *): firmware: direct-loading firmware iwlwifi-8000C-22.ucode
[35803.073322] PM: Syncing filesystems ... 
[35995.976169] usb 1-1: new high-speed USB device number 18 using xhci_hcd
[35996.117136] usb 1-1: New USB device found, idVendor=8644, idProduct=800f
[35996.117143] usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[35996.117148] usb 1-1: Product: USB Flash Disk
[35996.117151] usb 1-1: Manufacturer: General
[35996.117155] usb 1-1: SerialNumber: 0340100000043239
[35996.118141] usb-storage 1-1:1.0: USB Mass Storage device detected
[35996.118434] scsi host3: usb-storage 1-1:1.0
[35997.148869] scsi 3:0:0:0: Direct-Access     General  USB Flash Disk   1.0  PQ: 0 ANSI: 2
[35997.150323] sd 3:0:0:0: Attached scsi generic sg2 type 0
[35997.150668] sd 3:0:0:0: [sdc] 7831552 512-byte logical blocks: (4.01 GB/3.73 GiB)
[35997.150945] sd 3:0:0:0: [sdc] Write Protect is off
[35997.150951] sd 3:0:0:0: [sdc] Mode Sense: 03 00 00 00
[35997.151195] sd 3:0:0:0: [sdc] No Caching mode page found
[35997.151206] sd 3:0:0:0: [sdc] Assuming drive cache: write through
[35997.157652]  sdc: sdc1
[35997.159049] sd 3:0:0:0: [sdc] Attached SCSI removable disk
[36001.958742] UDF-fs: warning (device sdc1): udf_load_vrs: No VRS found
[36001.958743] UDF-fs: warning (device sdc1): udf_fill_super: No partition found (2)
[36001.960183] UDF-fs: warning (device sdc1): udf_load_vrs: No VRS found
[36001.960184] UDF-fs: warning (device sdc1): udf_fill_super: No partition found (2)
[36001.983762] ISOFS: Unable to identify CD-ROM format.
[36002.012370] ISOFS: Unable to identify CD-ROM format.
[36002.019980] FAT-fs (sdc1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[36007.772226] INFO: task mount:9623 blocked for more than 120 seconds.
[36007.772242]       Tainted: P           O    4.9.0-3-amd64 #1
[36007.772246] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[36007.772252] mount           D    0  9623   9447 0x00000000
[36007.772265]  ffff884910117000 ffff884a8c748000 ffff884a7c28d000 ffff884ab1598240
[36007.772275]  ffff884a7fb29000 ffffa24f8c93bbc0 ffffffffb69ff483 00000000ffffff87
[36007.772284]  00000000fffffffb ffff884ab1598240 ffff884a87d02000 ffff884a7c28d000
[36007.772292] Call Trace:
[36007.772309]  [<ffffffffb69ff483>] ? __schedule+0x233/0x6d0
[36007.772317]  [<ffffffffb6a000f0>] ? bit_wait+0x50/0x50
[36007.772322]  [<ffffffffb69ff952>] ? schedule+0x32/0x80
[36007.772329]  [<ffffffffb6a02d23>] ? schedule_timeout+0x243/0x310
[36007.772336]  [<ffffffffb66f7b7f>] ? __blk_run_queue+0x2f/0x40
[36007.772344]  [<ffffffffb64ec0dc>] ? ktime_get+0x3c/0xb0
[36007.772349]  [<ffffffffb6a000f0>] ? bit_wait+0x50/0x50
[36007.772356]  [<ffffffffb69ff1ed>] ? io_schedule_timeout+0x9d/0x100
[36007.772362]  [<ffffffffb64b8977>] ? prepare_to_wait+0x57/0x80
[36007.772368]  [<ffffffffb6a00107>] ? bit_wait_io+0x17/0x60
[36007.772373]  [<ffffffffb69ffcd3>] ? __wait_on_bit+0x53/0x80
[36007.772379]  [<ffffffffb6a000f0>] ? bit_wait+0x50/0x50
[36007.772385]  [<ffffffffb69ffe2e>] ? out_of_line_wait_on_bit+0x7e/0xa0
[36007.772391]  [<ffffffffb64b8de0>] ? wake_atomic_t_function+0x60/0x60
[36007.772399]  [<ffffffffb663c896>] ? __sync_dirty_buffer+0xa6/0xf0
[36007.772451]  [<ffffffffc077cb6d>] ? ext4_commit_super+0x20d/0x2b0 [ext4]
[36007.772496]  [<ffffffffc07800cf>] ? ext4_remount+0x59f/0x710 [ext4]
[36007.772504]  [<ffffffffb661ac9d>] ? shrink_dcache_sb+0xcd/0x110
[36007.772514]  [<ffffffffb6605c97>] ? do_remount_sb+0x67/0x1f0
[36007.772522]  [<ffffffffb6625cef>] ? do_mount+0x6ff/0xc80
[36007.772529]  [<ffffffffb662659e>] ? SyS_mount+0x7e/0xd0
[36007.772538]  [<ffffffffb6a0413b>] ? system_call_fast_compare_end+0xc/0x9b
-- 
Dr. Dindi
Dad, Philosopher, Hacker


Reply to: