[ 35.492463] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [ 35.496093] wlan0: authenticated [ 35.558624] wlan0: associate with 50:67:f0:95:df:9f (try 1) [ 35.562616] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=0 aid=3) [ 35.562621] wlan0: associated [ 35.567300] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 40.615053] init: plymouth-stop pre-start process (1808) terminated with status 1 [ 42.896509] init: autofs main process (1947) terminated with status 127 [ 42.896531] init: autofs main process ended, respawning [ 50.436274] wlan0: no IPv6 routers present [ 117.309487] gnome-shell[2262] trap int3 ip:7f4b31a1613b sp:7fff37889b00 error:0 [ 745.860571] process `skype' is using obsolete setsockopt SO_BSDCOMPAT [ 883.479083] notification-da[4920] trap int3 ip:7f9364a7f13b sp:7fff3a3e1130 error:0 [ 898.645084] notification-da[5093] trap int3 ip:7ff34971313b sp:7ffff0baa920 error:0 [ 5176.054967] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [ 5176.079781] cfg80211: All devices are disconnected, going to restore regulatory settings [ 5176.079788] cfg80211: Restoring regulatory settings [ 5176.079801] cfg80211: Calling CRDA to update world regulatory domain [ 5176.094445] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain [ 5176.094452] cfg80211: World regulatory domain updated: [ 5176.094455] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 5176.094460] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 5176.094464] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 5176.094469] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 5176.094473] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 5176.094477] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 5178.590145] PM: Syncing filesystems ... done. [ 5178.596855] PM: Preparing system for mem sleep [ 5179.029748] Freezing user space processes ... (elapsed 0.01 seconds) done. [ 5179.045889] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [ 5179.061853] PM: Entering mem sleep [ 5179.061994] Suspending console(s) (use no_console_suspend to debug) [ 5179.062271] hdaps: setting ec_rate=0, filter_order=1 [ 5179.062562] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 5179.062755] sd 0:0:0:0: [sda] Stopping disk [ 5179.257541] PM: suspend of drv:tpm_tis dev:00:0b complete after 178.290 msecs [ 5179.257771] ehci_hcd 0000:00:1d.0: PCI INT D disabled [ 5179.257779] ehci_hcd 0000:00:1a.0: PCI INT D disabled [ 5179.289461] i915 0000:00:02.0: power state changed by ACPI to D3 [ 5179.323327] e1000e 0000:00:19.0: PCI INT A disabled [ 5179.323336] e1000e 0000:00:19.0: PME# enabled [ 5179.323342] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [ 5179.461064] PM: suspend of drv:sd dev:0:0:0:0 complete after 399.209 msecs [ 5179.461080] PM: suspend of drv:scsi dev:target0:0:0 complete after 399.190 msecs [ 5179.461086] PM: suspend of drv:scsi dev:host0 complete after 382.258 msecs [ 5179.477115] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 219.739 msecs [ 5180.467668] snd_hda_intel 0000:00:1b.0: PCI INT B disabled [ 5180.483419] PM: suspend of drv:snd_hda_intel dev:0000:00:1b.0 complete after 1227.760 msecs [ 5180.483491] PM: suspend of drv: dev:pci0000:00 complete after 1227.011 msecs [ 5180.483556] PM: suspend of devices complete after 1423.879 msecs [ 5180.483559] PM: suspend devices took 1.424 seconds [ 5180.499576] ehci_hcd 0000:00:1d.0: PME# enabled [ 5180.499583] ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI [ 5180.515332] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [ 5180.515392] ehci_hcd 0000:00:1a.0: PME# enabled [ 5180.515399] ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI [ 5180.531305] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D3 [ 5180.547358] PM: late suspend of devices complete after 63.903 msecs [ 5180.547514] ACPI: Preparing to enter system sleep state S3 [ 5180.719026] PM: Saving platform NVS memory [ 5180.723011] Disabling non-boot CPUs ... [ 5180.723793] Broke affinity for irq 1 [ 5180.826832] CPU 1 is now offline [ 5180.827316] Extended CMOS year: 2000 [ 5180.827542] ACPI: Low-level resume complete [ 5180.827597] PM: Restoring platform NVS memory [ 5180.828257] Extended CMOS year: 2000 [ 5180.828282] Enabling non-boot CPUs ... [ 5180.828431] Booting Node 0 Processor 1 APIC 0x4 [ 5180.828433] smpboot cpu 1: start_ip = 99000 [ 5180.839447] Calibrating delay loop (skipped) already calibrated this CPU [ 5180.859892] NMI watchdog enabled, takes one hw-pmu counter. [ 5180.875840] CPU1 is up [ 5180.877326] ACPI: Waking up from system sleep state S3 [ 5181.119385] thinkpad_acpi: EC reports that Thermal Table has changed [ 5181.283090] agpgart-intel 0000:00:00.0: restoring config space at offset 0x1 (was 0x900006, writing 0x20900006) [ 5181.283107] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [ 5181.283192] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100107) [ 5181.283223] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [ 5181.283242] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728000) [ 5181.283250] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [ 5181.283274] ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI [ 5181.283279] ehci_hcd 0000:00:1a.0: PME# disabled [ 5181.283283] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [ 5181.283287] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [ 5181.283361] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x200000f0) [ 5181.283463] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x4010b) [ 5181.283475] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) [ 5181.283480] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xf240f240) [ 5181.283485] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x0, writing 0x200000f0) [ 5181.283493] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [ 5181.283500] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [ 5181.283535] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [ 5181.283553] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728400) [ 5181.283561] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [ 5181.283580] ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI [ 5181.283584] ehci_hcd 0000:00:1d.0: PME# disabled [ 5181.283587] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 5181.283591] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 5181.283694] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [ 5181.283760] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x400, writing 0x40b) [ 5181.283782] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [ 5181.284050] PM: early resume of devices complete after 1.070 msecs [ 5181.284187] i915 0000:00:02.0: power state changed by ACPI to D0 [ 5181.284192] i915 0000:00:02.0: power state changed by ACPI to D0 [ 5181.284203] i915 0000:00:02.0: setting latency timer to 64 [ 5181.284234] mei 0000:00:16.0: irq 41 for MSI/MSI-X [ 5181.284377] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [ 5181.284383] e1000e 0000:00:19.0: PME# disabled [ 5181.284464] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [ 5181.287444] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [ 5181.287448] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [ 5181.287458] ehci_hcd 0000:00:1a.0: PCI INT D -> GSI 23 (level, low) -> IRQ 23 [ 5181.287467] ehci_hcd 0000:00:1a.0: setting latency timer to 64 [ 5181.287511] snd_hda_intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 5181.287521] snd_hda_intel 0000:00:1b.0: setting latency timer to 64 [ 5181.287620] snd_hda_intel 0000:00:1b.0: irq 45 for MSI/MSI-X [ 5181.287657] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 5181.287661] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 5181.287666] ehci_hcd 0000:00:1d.0: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [ 5181.287672] ehci_hcd 0000:00:1d.0: setting latency timer to 64 [ 5181.287693] pci 0000:00:1e.0: setting latency timer to 64 [ 5181.287713] ahci 0000:00:1f.2: setting latency timer to 64 [ 5181.288403] sd 0:0:0:0: [sda] Starting disk [ 5181.375735] Extended CMOS year: 2000 [ 5181.466661] PM: resume of drv: dev:ep_00 complete after 178.430 msecs [ 5181.466698] PM: resume of drv:hub dev:1-1:1.0 complete after 178.501 msecs [ 5181.466759] PM: resume of drv: dev:ep_81 complete after 178.547 msecs [ 5181.538746] usb 1-1.4: reset full-speed USB device number 3 using ehci_hcd [ 5181.606412] ata5: SATA link down (SStatus 0 SControl 300) [ 5181.614394] ata6: SATA link down (SStatus 0 SControl 300) [ 5181.622364] ata2: SATA link down (SStatus 0 SControl 300) [ 5181.632442] btusb 1-1.4:1.0: no reset_resume for driver btusb? [ 5181.632446] btusb 1-1.4:1.1: no reset_resume for driver btusb? [ 5181.656023] PM: resume of drv:i915 dev:0000:00:02.0 complete after 372.493 msecs [ 5181.702452] usb 1-1.6: reset high-speed USB device number 4 using ehci_hcd [ 5181.803454] PM: resume of drv: dev:ep_00 complete after 515.489 msecs [ 5181.803464] PM: resume of drv:uvcvideo dev:1-1.6:1.1 complete after 515.517 msecs [ 5181.803471] PM: resume of drv:uvcvideo dev:1-1.6:1.0 complete after 515.553 msecs [ 5181.803529] PM: resume of drv: dev:ep_81 complete after 515.596 msecs [ 5181.882056] watchdog: only one watchdog can use /dev/watchdog. [ 5181.882063] watchdog: error registering /dev/watchdog (err=-16). [ 5181.882064] mei: unable to register watchdog device. [ 5181.882221] PM: resume of drv:usb dev:1-1.4:1.0 complete after 594.623 msecs [ 5181.882229] PM: resume of drv:usb dev:1-1.4:1.1 complete after 594.575 msecs [ 5181.882234] PM: resume of drv: dev:ep_00 complete after 594.479 msecs [ 5181.882237] PM: resume of drv:usb dev:1-1.4:1.2 complete after 594.540 msecs [ 5181.882241] PM: resume of drv:usb dev:1-1.4:1.3 complete after 594.501 msecs [ 5181.882245] PM: resume of drv: dev:ep_83 complete after 594.576 msecs [ 5181.882248] PM: resume of drv: dev:ep_02 complete after 594.607 msecs [ 5181.882250] PM: resume of drv: dev:ep_03 complete after 594.567 msecs [ 5181.882252] PM: resume of drv: dev:ep_82 complete after 594.626 msecs [ 5181.882255] PM: resume of drv: dev:ep_84 complete after 594.543 msecs [ 5181.882257] PM: resume of drv: dev:ep_81 complete after 594.646 msecs [ 5181.882267] PM: resume of drv: dev:ep_04 complete after 594.541 msecs [ 5183.307472] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 5183.317572] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [ 5183.317578] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [ 5183.317841] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [ 5183.317847] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [ 5183.320621] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [ 5183.320626] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [ 5183.320896] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [ 5183.320901] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [ 5183.322193] ata1.00: configured for UDMA/100 [ 5183.350364] PM: resume of drv:sd dev:0:0:0:0 complete after 2065.516 msecs [ 5183.350426] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 1978.081 msecs [ 5183.350544] hdaps: initial mode latch is 0x05 [ 5183.350729] hdaps: setting ec_rate=250, filter_order=2 [ 5183.351658] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 2066.763 msecs [ 5183.352274] PM: resume of devices complete after 2071.710 msecs [ 5183.352737] PM: resume devices took 2.072 seconds [ 5183.352769] PM: Finishing wakeup. [ 5183.352770] Restarting tasks ... done. [ 5183.394785] video LNXVIDEO:00: Restoring backlight state [ 5184.087174] init: anacron main process (6234) killed by TERM signal [ 5184.120021] e1000e 0000:00:19.0: PME# enabled [ 5184.221860] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [ 5184.221867] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [ 5184.221873] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [ 5184.221892] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [ 5184.221913] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [ 5184.221961] e1000e 0000:00:19.0: PME# disabled [ 5184.341861] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [ 5184.397596] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [ 5184.398348] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 5184.399136] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [ 5184.399323] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [ 5184.507842] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 5185.578603] e1000e 0000:00:19.0: PME# enabled [ 5192.199818] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [ 5192.202254] wlan0: authenticated [ 5192.202550] wlan0: associate with 50:67:f0:95:df:9f (try 1) [ 5192.204525] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=0 aid=1) [ 5192.204529] wlan0: associated [ 5192.207947] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 5206.539382] wlan0: no IPv6 routers present [ 7856.326796] thinkpad_acpi: EC reports that Thermal Table has changed [ 7856.338752] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [ 7856.338764] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [ 7856.338774] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [ 7856.338800] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [ 7856.338829] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [ 7856.338876] e1000e 0000:00:19.0: PME# disabled [ 7856.338981] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [ 8127.727068] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio. [ 8127.727174] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.727180] iwlwifi 0000:02:00.0: Error sending REPLY_QOS_PARAM: enqueue_hcmd failed: -5 [ 8127.727186] iwlwifi 0000:02:00.0: Failed to update QoS [ 8127.727192] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.727196] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8127.727201] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8127.727207] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.727211] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8127.727214] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8127.727220] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [ 8127.742829] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.742837] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 8127.742846] ieee80211 phy0: failed to remove key (1, ff:ff:ff:ff:ff:ff) from hardware (-5) [ 8127.758795] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.758802] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 8127.758809] ieee80211 phy0: failed to remove key (0, 50:67:f0:95:df:9f) from hardware (-5) [ 8127.758849] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.758853] iwlwifi 0000:02:00.0: Error sending REPLY_REMOVE_STA: enqueue_hcmd failed: -5 [ 8127.758858] iwlwifi 0000:02:00.0: Error removing station 50:67:f0:95:df:9f [ 8127.774290] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.774298] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8127.774304] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8127.774336] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.774340] iwlwifi 0000:02:00.0: Error sending REPLY_LEDS_CMD: enqueue_hcmd failed: -5 [ 8127.774348] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.774352] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8127.774355] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8127.774398] cfg80211: All devices are disconnected, going to restore regulatory settings [ 8127.774404] cfg80211: Restoring regulatory settings [ 8127.774431] cfg80211: Calling CRDA to update world regulatory domain [ 8127.782812] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8127.782819] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8127.782825] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8127.788880] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain [ 8127.788887] cfg80211: World regulatory domain updated: [ 8127.788890] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 8127.788895] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8127.788900] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 8127.788904] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 8127.788908] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8127.788913] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8127.793720] usb 1-1.4: USB disconnect, device number 3 [ 8127.846710] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. [ 8127.928872] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8128.047892] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [ 8128.048087] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [ 8128.172744] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8128.342128] usb 1-1.4: new full-speed USB device number 5 using ehci_hcd [ 8135.792963] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [ 8135.819365] wlan0: authenticated [ 8135.819833] wlan0: associate with 50:67:f0:95:df:9f (try 1) [ 8135.821972] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=0 aid=1) [ 8135.821977] wlan0: associated [ 8135.826868] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 8150.008329] wlan0: no IPv6 routers present [ 8156.572245] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx [ 8156.572255] e1000e 0000:00:19.0: eth0: 10/100 speed: disabling TSO [ 8156.573567] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 8167.058403] eth0: no IPv6 routers present [ 8210.798680] e1000e: eth0 NIC Link is Down [ 8215.201057] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 8223.946550] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio. [ 8223.946650] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8223.946655] iwlwifi 0000:02:00.0: Error sending REPLY_QOS_PARAM: enqueue_hcmd failed: -5 [ 8223.946659] iwlwifi 0000:02:00.0: Failed to update QoS [ 8223.946665] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8223.946668] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8223.946671] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8223.946677] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8223.946680] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8223.946683] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8223.946687] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [ 8223.963465] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8223.963470] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 8223.963475] ieee80211 phy0: failed to remove key (1, ff:ff:ff:ff:ff:ff) from hardware (-5) [ 8223.975418] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8223.975420] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 8223.975422] ieee80211 phy0: failed to remove key (0, 50:67:f0:95:df:9f) from hardware (-5) [ 8223.975446] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8223.975448] iwlwifi 0000:02:00.0: Error sending REPLY_REMOVE_STA: enqueue_hcmd failed: -5 [ 8223.975450] iwlwifi 0000:02:00.0: Error removing station 50:67:f0:95:df:9f [ 8224.039351] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8224.039354] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8224.039357] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8224.039385] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8224.039387] iwlwifi 0000:02:00.0: Error sending REPLY_LEDS_CMD: enqueue_hcmd failed: -5 [ 8224.039391] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8224.039393] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8224.039394] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8224.039409] cfg80211: All devices are disconnected, going to restore regulatory settings [ 8224.039412] cfg80211: Restoring regulatory settings [ 8224.039433] cfg80211: Calling CRDA to update world regulatory domain [ 8224.046145] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. [ 8224.058178] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain [ 8224.058183] cfg80211: World regulatory domain updated: [ 8224.058184] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 8224.058187] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8224.058189] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 8224.058191] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 8224.058193] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8224.058195] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8224.058744] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8224.139971] usb 1-1.4: USB disconnect, device number 5 [ 8224.142510] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [ 8224.142700] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [ 8224.266946] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8225.341399] usb 1-1.4: new full-speed USB device number 6 using ehci_hcd [ 8231.937231] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [ 8231.963061] wlan0: authenticated [ 8231.963423] wlan0: associate with 50:67:f0:95:df:9f (try 1) [ 8231.965507] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=0 aid=1) [ 8231.965512] wlan0: associated [ 8231.969789] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 8235.482019] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx [ 8235.482029] e1000e 0000:00:19.0: eth0: 10/100 speed: disabling TSO [ 8235.483330] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 8245.490371] wlan0: no IPv6 routers present [ 8247.128295] eth0: no IPv6 routers present [ 8793.191578] e1000e: eth0 NIC Link is Down [ 8797.213235] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 8815.355158] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx [ 8815.355167] e1000e 0000:00:19.0: eth0: 10/100 speed: disabling TSO [ 8815.356467] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 8824.774707] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio. [ 8824.774802] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.774807] iwlwifi 0000:02:00.0: Error sending REPLY_QOS_PARAM: enqueue_hcmd failed: -5 [ 8824.774812] iwlwifi 0000:02:00.0: Failed to update QoS [ 8824.774817] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.774820] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8824.774824] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8824.774830] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.774833] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8824.774836] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8824.774840] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [ 8824.776532] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.776574] iwlwifi 0000:02:00.0: Error sending REPLY_LEDS_CMD: enqueue_hcmd failed: -5 [ 8824.788522] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.788526] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 8824.788530] ieee80211 phy0: failed to remove key (1, ff:ff:ff:ff:ff:ff) from hardware (-5) [ 8824.794293] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.794300] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 8824.794325] ieee80211 phy0: failed to remove key (0, 50:67:f0:95:df:9f) from hardware (-5) [ 8824.794361] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.794363] iwlwifi 0000:02:00.0: Error sending REPLY_REMOVE_STA: enqueue_hcmd failed: -5 [ 8824.794369] iwlwifi 0000:02:00.0: Error removing station 50:67:f0:95:df:9f [ 8824.797021] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.797024] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8824.797026] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8824.797078] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.797081] iwlwifi 0000:02:00.0: Error sending REPLY_LEDS_CMD: enqueue_hcmd failed: -5 [ 8824.797089] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.797096] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8824.797098] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8824.797114] cfg80211: All devices are disconnected, going to restore regulatory settings [ 8824.797117] cfg80211: Restoring regulatory settings [ 8824.797124] cfg80211: Calling CRDA to update world regulatory domain [ 8824.816596] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8824.816604] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8824.816610] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8824.821568] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain [ 8824.821574] cfg80211: World regulatory domain updated: [ 8824.821577] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 8824.821582] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8824.821587] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 8824.821591] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 8824.821595] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8824.821599] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8824.960062] usb 1-1.4: USB disconnect, device number 6 [ 8824.976074] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8825.003849] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. [ 8825.015489] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [ 8825.015678] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [ 8825.142729] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8825.319877] usb 1-1.4: new full-speed USB device number 7 using ehci_hcd [ 8825.647039] eth0: no IPv6 routers present [ 8825.907151] e1000e: eth0 NIC Link is Down [ 8827.145745] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio. [ 8827.164417] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8827.164423] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8827.164426] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8827.260085] usb 1-1.4: USB disconnect, device number 7 [ 8827.564199] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. [ 8827.567634] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [ 8827.567855] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [ 8827.695221] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8827.971299] usb 1-1.4: new full-speed USB device number 8 using ehci_hcd [ 8830.154428] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 8832.176734] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio. [ 8832.177632] iwlwifi 0000:02:00.0: Request scan called when driver not ready. [ 8832.191743] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8832.191748] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8832.191751] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8832.371521] usb 1-1.4: USB disconnect, device number 8 [ 8834.946426] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. [ 8834.950195] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [ 8834.950390] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [ 8835.078193] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8835.382531] usb 1-1.4: new full-speed USB device number 9 using ehci_hcd [ 8839.737218] e1000e: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: Rx [ 8839.738524] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 8842.744226] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [ 8842.746549] wlan0: authenticated [ 8842.746919] wlan0: associate with 50:67:f0:95:df:9f (try 1) [ 8842.748986] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=0 aid=1) [ 8842.748991] wlan0: associated [ 8842.756374] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 8849.973123] eth0: no IPv6 routers present [ 8857.296496] wlan0: no IPv6 routers present [ 8876.898102] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio. [ 8876.898202] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.898208] iwlwifi 0000:02:00.0: Error sending REPLY_QOS_PARAM: enqueue_hcmd failed: -5 [ 8876.898212] iwlwifi 0000:02:00.0: Failed to update QoS [ 8876.898218] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.898221] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8876.898224] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8876.898230] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.898233] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8876.898236] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8876.898240] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [ 8876.914005] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.914010] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 8876.914014] ieee80211 phy0: failed to remove key (1, ff:ff:ff:ff:ff:ff) from hardware (-5) [ 8876.929965] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.929973] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 8876.929980] ieee80211 phy0: failed to remove key (0, 50:67:f0:95:df:9f) from hardware (-5) [ 8876.930023] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.930025] iwlwifi 0000:02:00.0: Error sending REPLY_REMOVE_STA: enqueue_hcmd failed: -5 [ 8876.930027] iwlwifi 0000:02:00.0: Error removing station 50:67:f0:95:df:9f [ 8876.945975] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.945980] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8876.945985] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8876.946016] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.946020] iwlwifi 0000:02:00.0: Error sending REPLY_LEDS_CMD: enqueue_hcmd failed: -5 [ 8876.946027] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.946031] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8876.946035] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8876.946070] cfg80211: All devices are disconnected, going to restore regulatory settings [ 8876.946076] cfg80211: Restoring regulatory settings [ 8876.946104] cfg80211: Calling CRDA to update world regulatory domain [ 8876.957893] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 8876.957920] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 8876.957925] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 8876.962355] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain [ 8876.962362] cfg80211: World regulatory domain updated: [ 8876.962365] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 8876.962370] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8876.962375] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 8876.962379] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 8876.962384] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8876.962388] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 8877.094194] usb 1-1.4: USB disconnect, device number 9 [ 8877.099200] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8879.568082] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. [ 8879.571858] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [ 8879.572283] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [ 8879.693604] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 8879.879704] usb 1-1.4: new full-speed USB device number 10 using ehci_hcd [ 8887.391945] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [ 8887.417116] wlan0: authenticated [ 8887.417453] wlan0: associate with 50:67:f0:95:df:9f (try 1) [ 8887.419524] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=0 aid=1) [ 8887.419529] wlan0: associated [ 8887.424458] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 8902.121017] wlan0: no IPv6 routers present [ 9045.893594] e1000e: eth0 NIC Link is Down [ 9048.894345] e1000e: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: Rx [ 9703.641752] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio. [ 9703.641851] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9703.641856] iwlwifi 0000:02:00.0: Error sending REPLY_QOS_PARAM: enqueue_hcmd failed: -5 [ 9703.641861] iwlwifi 0000:02:00.0: Failed to update QoS [ 9703.641866] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9703.641869] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 9703.641872] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 9703.641882] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9703.641883] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 9703.641885] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 9703.641887] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [ 9703.655061] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9703.655083] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 9703.655091] ieee80211 phy0: failed to remove key (1, ff:ff:ff:ff:ff:ff) from hardware (-5) [ 9703.666995] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9703.666997] iwlwifi 0000:02:00.0: Error sending REPLY_ADD_STA: enqueue_hcmd failed: -5 [ 9703.667000] ieee80211 phy0: failed to remove key (0, 50:67:f0:95:df:9f) from hardware (-5) [ 9703.667025] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9703.667027] iwlwifi 0000:02:00.0: Error sending REPLY_REMOVE_STA: enqueue_hcmd failed: -5 [ 9703.667029] iwlwifi 0000:02:00.0: Error removing station 50:67:f0:95:df:9f [ 9703.730987] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9703.730993] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 9703.730998] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 9703.731028] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9703.731029] iwlwifi 0000:02:00.0: Error sending REPLY_LEDS_CMD: enqueue_hcmd failed: -5 [ 9703.731034] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9703.731036] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 9703.731037] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 9703.731052] cfg80211: All devices are disconnected, going to restore regulatory settings [ 9703.731056] cfg80211: Restoring regulatory settings [ 9703.731238] cfg80211: Calling CRDA to update world regulatory domain [ 9703.731347] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. [ 9703.750134] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain [ 9703.750138] cfg80211: World regulatory domain updated: [ 9703.750139] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 9703.750142] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 9703.750144] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 9703.750146] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 9703.750148] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 9703.750154] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 9703.753388] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 9703.829194] usb 1-1.4: USB disconnect, device number 10 [ 9703.832475] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [ 9703.832671] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [ 9703.958355] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 9704.030333] iwlwifi 0000:02:00.0: RF_KILL bit toggled to disable radio. [ 9704.030446] iwlwifi 0000:02:00.0: Request scan called when driver not ready. [ 9704.062367] iwlwifi 0000:02:00.0: Not sending command - RF KILL [ 9704.062372] iwlwifi 0000:02:00.0: Error sending REPLY_RXON: enqueue_hcmd failed: -5 [ 9704.062375] iwlwifi 0000:02:00.0: Error clearing ASSOC_MSK on BSS (-5) [ 9704.359124] iwlwifi 0000:02:00.0: RF_KILL bit toggled to enable radio. [ 9704.363861] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [ 9704.364055] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [ 9704.490637] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 9704.586002] e1000e: eth0 NIC Link is Down [ 9704.793312] usb 1-1.4: new full-speed USB device number 11 using ehci_hcd [ 9709.625730] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 9712.077677] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [ 9712.104008] wlan0: authenticated [ 9712.104389] wlan0: associate with 50:67:f0:95:df:9f (try 1) [ 9712.109149] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=0 aid=1) [ 9712.109152] wlan0: associated [ 9712.112711] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 9726.627137] wlan0: no IPv6 routers present [20478.236088] wlan0: disassociated from 50:67:f0:95:df:9f (Reason: 16) [20478.268430] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20478.269037] cfg80211: All devices are disconnected, going to restore regulatory settings [20478.269041] cfg80211: Restoring regulatory settings [20478.269045] cfg80211: Calling CRDA to update world regulatory domain [20478.272246] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain [20478.272250] cfg80211: World regulatory domain updated: [20478.272251] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [20478.272254] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [20478.272256] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [20478.272257] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [20478.272259] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [20478.272261] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [20481.647980] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20481.650135] wlan0: authenticated [20481.650436] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20481.652403] wlan0: RX ReassocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20481.652406] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20481.666251] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20484.994505] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20484.996713] wlan0: authenticated [20484.997107] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20484.999038] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20484.999045] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20485.010293] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20488.311792] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20488.314540] wlan0: authenticated [20488.314895] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20488.317148] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20488.317155] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20488.328602] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20491.653915] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20491.656382] wlan0: authenticated [20491.656840] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20491.658771] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20491.658777] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20491.670927] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20494.025901] ADDRCONF(NETDEV_UP): wlan0: link is not ready [20495.049636] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20495.051871] wlan0: authenticated [20495.052373] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20495.054329] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20495.054332] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20495.083434] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20498.386069] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20498.388243] wlan0: authenticated [20498.389388] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20498.392673] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20498.392677] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20498.407235] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20501.660209] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20501.662458] wlan0: authenticated [20501.663643] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20501.666041] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20501.666047] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20501.681656] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20505.030769] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20505.033150] wlan0: authenticated [20505.033630] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20505.035656] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20505.035662] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20505.051860] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20508.352756] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20508.354370] wlan0: authenticated [20508.354602] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20508.356506] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20508.356510] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20508.374056] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20511.623939] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20511.626349] wlan0: authenticated [20511.626859] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20511.628818] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20511.628825] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20511.648496] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20514.946797] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20514.949883] wlan0: authenticated [20514.950255] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20514.952185] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20514.952191] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20514.966762] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20518.269571] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20518.271933] wlan0: authenticated [20518.272187] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20518.274095] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20518.274101] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20518.289489] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20521.541290] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20521.543623] wlan0: authenticated [20521.543970] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20521.546071] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20521.546078] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20521.555304] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20524.760535] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20524.762892] wlan0: authenticated [20524.763301] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20524.765830] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20524.765837] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20524.781814] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20528.156011] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20528.158310] wlan0: authenticated [20528.158623] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20528.160554] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20528.160559] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20528.161508] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20531.514797] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20531.517058] wlan0: authenticated [20531.517397] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20531.519305] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20531.519311] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20531.530383] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20534.831183] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20534.832827] wlan0: authenticated [20534.833284] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20534.835172] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=1 aid=0) [20534.835177] wlan0: 50:67:f0:95:df:9f denied association (code=1) [20534.844407] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [20538.102401] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [20538.104748] wlan0: authenticated [20538.105044] wlan0: associate with 50:67:f0:95:df:9f (try 1) [20538.107118] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=0 aid=1) [20538.107124] wlan0: associated [20538.113488] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [20552.817037] wlan0: no IPv6 routers present [35696.860949] e1000e 0000:00:19.0: PME# enabled [35696.869651] wlan0: deauthenticating from 50:67:f0:95:df:9f by local choice (reason=3) [35696.880086] thinkpad_acpi: EC reports that Thermal Table has changed [35696.922274] cfg80211: All devices are disconnected, going to restore regulatory settings [35696.922278] cfg80211: Restoring regulatory settings [35696.922283] cfg80211: Calling CRDA to update world regulatory domain [35696.935546] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain [35696.935550] cfg80211: World regulatory domain updated: [35696.935552] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [35696.935554] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [35696.935556] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [35696.935559] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [35696.935561] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [35696.935563] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [35697.680754] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [35697.680764] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [35697.680772] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [35697.680794] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [35697.680821] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [35697.680882] e1000e 0000:00:19.0: PME# disabled [35699.418225] PM: Syncing filesystems ... done. [35699.575237] PM: Preparing system for mem sleep [35700.040839] Freezing user space processes ... (elapsed 0.01 seconds) done. [35700.056696] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [35700.072655] PM: Entering mem sleep [35700.072790] Suspending console(s) (use no_console_suspend to debug) [35700.073145] hdaps: setting ec_rate=0, filter_order=1 [35700.073589] sd 0:0:0:0: [sda] Synchronizing SCSI cache [35700.073712] sd 0:0:0:0: [sda] Stopping disk [35700.264322] PM: suspend of drv:tpm_tis dev:00:0b complete after 178.656 msecs [35700.264556] ehci_hcd 0000:00:1d.0: PCI INT D disabled [35700.264572] ehci_hcd 0000:00:1a.0: PCI INT D disabled [35700.264612] snd_hda_intel 0000:00:1b.0: PCI INT B disabled [35700.288244] intel ips 0000:00:1f.6: MCP limit exceeded: Avg power 55290, limit 35000 [35700.300225] i915 0000:00:02.0: power state changed by ACPI to D3 [35700.326665] e1000e 0000:00:19.0: PME# enabled [35700.326679] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [35700.555088] PM: suspend of drv:sd dev:0:0:0:0 complete after 482.340 msecs [35700.555148] PM: suspend of drv:scsi dev:target0:0:0 complete after 482.326 msecs [35700.555195] PM: suspend of drv:scsi dev:host0 complete after 470.053 msecs [35700.571755] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 307.846 msecs [35700.571814] PM: suspend of drv: dev:pci0000:00 complete after 307.235 msecs [35700.571823] PM: suspend of devices complete after 499.754 msecs [35700.571827] PM: suspend devices took 0.500 seconds [35700.587914] ehci_hcd 0000:00:1d.0: PME# enabled [35700.587920] ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI [35700.603703] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [35700.603900] ehci_hcd 0000:00:1a.0: PME# enabled [35700.603905] ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI [35700.619675] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D3 [35700.635728] PM: late suspend of devices complete after 64.006 msecs [35700.635883] ACPI: Preparing to enter system sleep state S3 [35700.807394] PM: Saving platform NVS memory [35700.811709] Disabling non-boot CPUs ... [35700.812692] Broke affinity for irq 23 [35700.915191] CPU 1 is now offline [35700.915708] Extended CMOS year: 2000 [35700.915929] ACPI: Low-level resume complete [35700.915984] PM: Restoring platform NVS memory [35700.916637] Extended CMOS year: 2000 [35700.916683] Enabling non-boot CPUs ... [35700.916818] Booting Node 0 Processor 1 APIC 0x4 [35700.916820] smpboot cpu 1: start_ip = 99000 [35700.927834] Calibrating delay loop (skipped) already calibrated this CPU [35700.948356] NMI watchdog enabled, takes one hw-pmu counter. [35700.964207] CPU1 is up [35700.965779] ACPI: Waking up from system sleep state S3 [35701.287602] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [35701.287687] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100107) [35701.287718] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [35701.287736] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728000) [35701.287743] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [35701.287766] ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI [35701.287772] ehci_hcd 0000:00:1a.0: PME# disabled [35701.287776] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [35701.287779] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [35701.287954] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x4010b) [35701.287966] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) [35701.287971] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xf240f240) [35701.287976] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x0, writing 0xf0) [35701.287985] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [35701.287991] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [35701.288026] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [35701.288043] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728400) [35701.288051] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [35701.288070] ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI [35701.288074] ehci_hcd 0000:00:1d.0: PME# disabled [35701.288077] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [35701.288080] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [35701.288184] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [35701.288251] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x400, writing 0x40b) [35701.288273] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [35701.288355] iwlwifi 0000:02:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [35701.288545] PM: early resume of devices complete after 1.067 msecs [35701.288681] i915 0000:00:02.0: power state changed by ACPI to D0 [35701.288687] i915 0000:00:02.0: power state changed by ACPI to D0 [35701.288698] i915 0000:00:02.0: setting latency timer to 64 [35701.288729] mei 0000:00:16.0: irq 41 for MSI/MSI-X [35701.288871] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [35701.288877] e1000e 0000:00:19.0: PME# disabled [35701.288960] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [35701.291931] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [35701.291935] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [35701.291944] ehci_hcd 0000:00:1a.0: PCI INT D -> GSI 23 (level, low) -> IRQ 23 [35701.291955] ehci_hcd 0000:00:1a.0: setting latency timer to 64 [35701.291979] snd_hda_intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [35701.291985] snd_hda_intel 0000:00:1b.0: setting latency timer to 64 [35701.292048] snd_hda_intel 0000:00:1b.0: irq 45 for MSI/MSI-X [35701.292082] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [35701.292085] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [35701.292091] ehci_hcd 0000:00:1d.0: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [35701.292097] ehci_hcd 0000:00:1d.0: setting latency timer to 64 [35701.292115] pci 0000:00:1e.0: setting latency timer to 64 [35701.292129] ahci 0000:00:1f.2: setting latency timer to 64 [35701.292272] sd 0:0:0:0: [sda] Starting disk [35701.391296] PM: resume of drv:button dev:PNP0C0D:00 complete after 102.702 msecs [35701.432347] Extended CMOS year: 2000 [35701.471162] PM: resume of drv: dev:ep_00 complete after 179.117 msecs [35701.471202] PM: resume of drv:hub dev:1-1:1.0 complete after 179.179 msecs [35701.471264] PM: resume of drv: dev:ep_81 complete after 179.232 msecs [35701.543132] usb 1-1.6: reset high-speed USB device number 4 using ehci_hcd [35701.610933] ata5: SATA link down (SStatus 0 SControl 300) [35701.618847] ata6: SATA link down (SStatus 0 SControl 300) [35701.634895] ata2: SATA link down (SStatus 0 SControl 300) [35701.644394] PM: resume of drv: dev:ep_00 complete after 352.555 msecs [35701.644406] PM: resume of drv:uvcvideo dev:1-1.6:1.1 complete after 352.579 msecs [35701.644414] PM: resume of drv:uvcvideo dev:1-1.6:1.0 complete after 352.609 msecs [35701.644489] PM: resume of drv: dev:ep_81 complete after 352.672 msecs [35701.684423] PM: resume of drv:i915 dev:0000:00:02.0 complete after 396.439 msecs [35701.710855] usb 1-1.4: reset full-speed USB device number 11 using ehci_hcd [35701.804443] btusb 1-1.4:1.0: no reset_resume for driver btusb? [35701.804448] btusb 1-1.4:1.1: no reset_resume for driver btusb? [35701.984694] watchdog: only one watchdog can use /dev/watchdog. [35701.984698] watchdog: error registering /dev/watchdog (err=-16). [35701.984700] mei: unable to register watchdog device. [35702.054403] PM: resume of drv:usb dev:1-1.4:1.1 complete after 763.205 msecs [35702.054415] PM: resume of drv:usb dev:1-1.4:1.2 complete after 763.189 msecs [35702.054425] PM: resume of drv:usb dev:1-1.4:1.3 complete after 763.167 msecs [35702.054432] PM: resume of drv: dev:ep_00 complete after 763.164 msecs [35702.054438] PM: resume of drv: dev:ep_83 complete after 763.233 msecs [35702.054446] PM: resume of drv:usb dev:1-1.4:1.0 complete after 763.290 msecs [35702.054452] PM: resume of drv: dev:ep_03 complete after 763.231 msecs [35702.054459] PM: resume of drv: dev:ep_84 complete after 763.222 msecs [35702.054466] PM: resume of drv: dev:ep_81 complete after 763.304 msecs [35702.054472] PM: resume of drv: dev:ep_04 complete after 763.220 msecs [35702.054475] PM: resume of drv: dev:ep_82 complete after 763.304 msecs [35702.054481] PM: resume of drv: dev:ep_02 complete after 763.293 msecs [35703.415801] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [35703.426409] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [35703.426415] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [35703.426689] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [35703.426695] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [35703.429438] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [35703.429444] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [35703.429730] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [35703.429735] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [35703.431039] ata1.00: configured for UDMA/100 [35703.467545] PM: resume of drv:sd dev:0:0:0:0 complete after 2179.022 msecs [35703.467618] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 2038.761 msecs [35703.467746] hdaps: initial mode latch is 0x05 [35703.467888] hdaps: setting ec_rate=250, filter_order=2 [35703.468809] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 2180.254 msecs [35703.469436] PM: resume of devices complete after 2184.575 msecs [35703.469846] PM: resume devices took 2.184 seconds [35703.469878] PM: Finishing wakeup. [35703.469879] Restarting tasks ... done. [35703.500850] video LNXVIDEO:00: Restoring backlight state [35704.112442] e1000e 0000:00:19.0: PME# enabled [35704.206403] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [35704.206411] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [35704.206417] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [35704.206436] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [35704.206456] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [35704.206502] e1000e 0000:00:19.0: PME# disabled [35704.317520] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [35704.370180] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [35704.370996] ADDRCONF(NETDEV_UP): eth0: link is not ready [35704.371751] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [35704.371938] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [35704.487992] ADDRCONF(NETDEV_UP): wlan0: link is not ready [35705.562373] e1000e 0000:00:19.0: PME# enabled [35706.510614] cfg80211: Found new beacon on frequency: 5240 MHz (Ch 48) on phy0 [35804.813354] usb 1-1.4: USB disconnect, device number 11 [35807.836090] usb 1-1.4: new full-speed USB device number 12 using ehci_hcd [35873.586344] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [35873.586352] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [35873.586357] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [35873.586377] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [35873.586396] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [35873.586431] e1000e 0000:00:19.0: PME# disabled [35873.586507] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [35873.673583] e1000e 0000:00:19.0: PME# enabled [35874.700487] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [35874.700498] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [35874.700508] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [35874.700531] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [35874.700555] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [35874.700614] e1000e 0000:00:19.0: PME# disabled [35875.780527] PM: Syncing filesystems ... done. [35875.854989] PM: Preparing system for mem sleep [35876.329762] Freezing user space processes ... (elapsed 0.01 seconds) done. [35876.345662] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [35876.361620] PM: Entering mem sleep [35876.361744] Suspending console(s) (use no_console_suspend to debug) [35876.362048] hdaps: setting ec_rate=0, filter_order=1 [35876.362179] sd 0:0:0:0: [sda] Synchronizing SCSI cache [35876.362239] sd 0:0:0:0: [sda] Stopping disk [35876.553309] PM: suspend of drv:tpm_tis dev:00:0b complete after 179.412 msecs [35876.553533] ehci_hcd 0000:00:1d.0: PCI INT D disabled [35876.553542] ehci_hcd 0000:00:1a.0: PCI INT D disabled [35876.585230] i915 0000:00:02.0: power state changed by ACPI to D3 [35876.619066] e1000e 0000:00:19.0: PME# enabled [35876.619074] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [35876.657627] snd_hda_intel 0000:00:1b.0: PCI INT B disabled [35876.673069] PM: suspend of drv:snd_hda_intel dev:0000:00:1b.0 complete after 119.743 msecs [35876.760523] PM: suspend of drv:sd dev:0:0:0:0 complete after 399.034 msecs [35876.760580] PM: suspend of drv:scsi dev:target0:0:0 complete after 399.091 msecs [35876.760639] PM: suspend of drv:scsi dev:host0 complete after 387.160 msecs [35876.776835] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 223.702 msecs [35876.776939] PM: suspend of drv: dev:pci0000:00 complete after 222.948 msecs [35876.776956] PM: suspend of devices complete after 415.787 msecs [35876.776958] PM: suspend devices took 0.416 seconds [35876.793078] ehci_hcd 0000:00:1d.0: PME# enabled [35876.793084] ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI [35876.808855] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [35876.809052] ehci_hcd 0000:00:1a.0: PME# enabled [35876.809057] ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI [35876.824810] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D3 [35876.840871] PM: late suspend of devices complete after 64.018 msecs [35876.841026] ACPI: Preparing to enter system sleep state S3 [35877.012529] PM: Saving platform NVS memory [35877.017194] Disabling non-boot CPUs ... [35877.120312] CPU 1 is now offline [35877.120791] Extended CMOS year: 2000 [35877.121010] ACPI: Low-level resume complete [35877.121064] PM: Restoring platform NVS memory [35877.121696] Extended CMOS year: 2000 [35877.121725] Enabling non-boot CPUs ... [35877.121879] Booting Node 0 Processor 1 APIC 0x4 [35877.121880] smpboot cpu 1: start_ip = 99000 [35877.132895] Calibrating delay loop (skipped) already calibrated this CPU [35877.153438] NMI watchdog enabled, takes one hw-pmu counter. [35877.169261] CPU1 is up [35877.170860] ACPI: Waking up from system sleep state S3 [35877.492713] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [35877.492801] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100107) [35877.492831] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [35877.492849] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728000) [35877.492857] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [35877.492880] ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI [35877.492886] ehci_hcd 0000:00:1a.0: PME# disabled [35877.492890] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [35877.492894] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [35877.493070] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x4010b) [35877.493081] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) [35877.493086] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xf240f240) [35877.493091] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x0, writing 0xf0) [35877.493100] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [35877.493106] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [35877.493141] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [35877.493159] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728400) [35877.493167] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [35877.493185] ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI [35877.493190] ehci_hcd 0000:00:1d.0: PME# disabled [35877.493192] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [35877.493196] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [35877.493301] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [35877.493370] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x400, writing 0x40b) [35877.493392] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [35877.493475] iwlwifi 0000:02:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [35877.493665] PM: early resume of devices complete after 1.073 msecs [35877.493801] i915 0000:00:02.0: power state changed by ACPI to D0 [35877.493806] i915 0000:00:02.0: power state changed by ACPI to D0 [35877.493817] i915 0000:00:02.0: setting latency timer to 64 [35877.493848] mei 0000:00:16.0: irq 41 for MSI/MSI-X [35877.493978] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [35877.493985] e1000e 0000:00:19.0: PME# disabled [35877.494079] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [35877.497064] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [35877.497068] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [35877.497078] ehci_hcd 0000:00:1a.0: PCI INT D -> GSI 23 (level, low) -> IRQ 23 [35877.497084] ehci_hcd 0000:00:1a.0: setting latency timer to 64 [35877.497108] snd_hda_intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [35877.497117] snd_hda_intel 0000:00:1b.0: setting latency timer to 64 [35877.497166] snd_hda_intel 0000:00:1b.0: irq 45 for MSI/MSI-X [35877.497197] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [35877.497201] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [35877.497209] ehci_hcd 0000:00:1d.0: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [35877.497216] ehci_hcd 0000:00:1d.0: setting latency timer to 64 [35877.497232] pci 0000:00:1e.0: setting latency timer to 64 [35877.497246] ahci 0000:00:1f.2: setting latency timer to 64 [35877.500541] sd 0:0:0:0: [sda] Starting disk [35877.624359] PM: resume of drv:button dev:PNP0C0D:00 complete after 130.668 msecs [35877.665411] Extended CMOS year: 2000 [35877.676303] PM: resume of drv: dev:ep_00 complete after 176.019 msecs [35877.676357] PM: resume of drv:hub dev:1-1:1.0 complete after 176.083 msecs [35877.676413] PM: resume of drv: dev:ep_81 complete after 176.137 msecs [35877.748419] usb 1-1.6: reset high-speed USB device number 4 using ehci_hcd [35877.824005] ata5: SATA link down (SStatus 0 SControl 300) [35877.831999] ata6: SATA link down (SStatus 0 SControl 300) [35877.839953] ata2: SATA link down (SStatus 0 SControl 300) [35877.849149] PM: resume of drv: dev:ep_00 complete after 345.167 msecs [35877.849159] PM: resume of drv:uvcvideo dev:1-1.6:1.1 complete after 345.180 msecs [35877.849166] PM: resume of drv:uvcvideo dev:1-1.6:1.0 complete after 345.198 msecs [35877.849224] PM: resume of drv: dev:ep_81 complete after 345.248 msecs [35877.889580] PM: resume of drv:i915 dev:0000:00:02.0 complete after 396.476 msecs [35877.916024] usb 1-1.4: reset full-speed USB device number 12 using ehci_hcd [35878.009561] btusb 1-1.4:1.0: no reset_resume for driver btusb? [35878.009566] btusb 1-1.4:1.1: no reset_resume for driver btusb? [35878.187604] watchdog: only one watchdog can use /dev/watchdog. [35878.187609] watchdog: error registering /dev/watchdog (err=-16). [35878.187611] mei: unable to register watchdog device. [35878.259550] PM: resume of drv: dev:ep_00 complete after 756.241 msecs [35878.259560] PM: resume of drv:usb dev:1-1.4:1.3 complete after 756.254 msecs [35878.259567] PM: resume of drv:usb dev:1-1.4:1.2 complete after 756.269 msecs [35878.259579] PM: resume of drv:usb dev:1-1.4:1.1 complete after 756.289 msecs [35878.259588] PM: resume of drv:usb dev:1-1.4:1.0 complete after 756.310 msecs [35878.259600] PM: resume of drv: dev:ep_04 complete after 756.297 msecs [35878.259606] PM: resume of drv: dev:ep_83 complete after 756.314 msecs [35878.259616] PM: resume of drv: dev:ep_03 complete after 756.318 msecs [35878.259620] PM: resume of drv: dev:ep_81 complete after 756.340 msecs [35878.259624] PM: resume of drv: dev:ep_84 complete after 756.322 msecs [35878.259627] PM: resume of drv: dev:ep_82 complete after 756.342 msecs [35878.259632] PM: resume of drv: dev:ep_02 complete after 756.346 msecs [35879.660835] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [35879.667890] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [35879.667896] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [35879.668182] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [35879.668187] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [35879.670865] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [35879.670871] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [35879.671139] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [35879.671145] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [35879.672431] ata1.00: configured for UDMA/100 [35879.700692] PM: resume of drv:sd dev:0:0:0:0 complete after 2203.943 msecs [35879.700753] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 2038.832 msecs [35879.700868] hdaps: initial mode latch is 0x05 [35879.701017] hdaps: setting ec_rate=250, filter_order=2 [35879.701938] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 2205.165 msecs [35879.702558] PM: resume of devices complete after 2212.624 msecs [35879.702953] PM: resume devices took 2.212 seconds [35879.702984] PM: Finishing wakeup. [35879.702986] Restarting tasks ... done. [35879.734278] video LNXVIDEO:00: Restoring backlight state [35881.496257] e1000e 0000:00:19.0: PME# enabled [35881.573480] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [35881.573488] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [35881.573494] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [35881.573513] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [35881.573534] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [35881.573582] e1000e 0000:00:19.0: PME# disabled [35881.677928] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [35881.733316] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [35881.734087] ADDRCONF(NETDEV_UP): eth0: link is not ready [35882.906933] e1000e 0000:00:19.0: PME# enabled [36146.380913] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [36146.380921] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [36146.380927] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [36146.380947] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [36146.380970] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [36146.381006] e1000e 0000:00:19.0: PME# disabled [36146.381090] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [36146.469761] e1000e 0000:00:19.0: PME# enabled [36147.514989] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [36147.515002] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [36147.515012] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [36147.515039] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [36147.515068] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [36147.515138] e1000e 0000:00:19.0: PME# disabled [36148.855503] PM: Syncing filesystems ... done. [36148.945837] PM: Preparing system for mem sleep [36149.391809] Freezing user space processes ... (elapsed 0.01 seconds) done. [36149.407792] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [36149.423757] PM: Entering mem sleep [36149.423889] Suspending console(s) (use no_console_suspend to debug) [36149.424197] hdaps: setting ec_rate=0, filter_order=1 [36149.424321] sd 0:0:0:0: [sda] Synchronizing SCSI cache [36149.424524] sd 0:0:0:0: [sda] Stopping disk [36149.619417] PM: suspend of drv:tpm_tis dev:00:0b complete after 176.590 msecs [36149.619560] ehci_hcd 0000:00:1d.0: PCI INT D disabled [36149.619569] ehci_hcd 0000:00:1a.0: PCI INT D disabled [36149.651340] i915 0000:00:02.0: power state changed by ACPI to D3 [36149.684936] e1000e 0000:00:19.0: PME# enabled [36149.684943] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [36149.723760] snd_hda_intel 0000:00:1b.0: PCI INT B disabled [36149.739177] PM: suspend of drv:snd_hda_intel dev:0000:00:1b.0 complete after 119.826 msecs [36149.822779] PM: suspend of drv:sd dev:0:0:0:0 complete after 399.149 msecs [36149.822837] PM: suspend of drv:scsi dev:target0:0:0 complete after 399.199 msecs [36149.822900] PM: suspend of drv:scsi dev:host0 complete after 380.465 msecs [36149.839007] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 219.842 msecs [36149.839064] PM: suspend of drv: dev:pci0000:00 complete after 219.047 msecs [36149.839126] PM: suspend of devices complete after 415.812 msecs [36149.839129] PM: suspend devices took 0.416 seconds [36149.855161] ehci_hcd 0000:00:1d.0: PME# enabled [36149.855168] ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI [36149.870952] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [36149.871151] ehci_hcd 0000:00:1a.0: PME# enabled [36149.871156] ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI [36149.886925] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D3 [36149.902977] PM: late suspend of devices complete after 63.951 msecs [36149.903131] ACPI: Preparing to enter system sleep state S3 [36150.074644] PM: Saving platform NVS memory [36150.079027] Disabling non-boot CPUs ... [36150.182452] CPU 1 is now offline [36150.182941] Extended CMOS year: 2000 [36150.183161] ACPI: Low-level resume complete [36150.183216] PM: Restoring platform NVS memory [36150.183850] Extended CMOS year: 2000 [36150.183876] Enabling non-boot CPUs ... [36150.184029] Booting Node 0 Processor 1 APIC 0x4 [36150.184031] smpboot cpu 1: start_ip = 99000 [36150.195045] Calibrating delay loop (skipped) already calibrated this CPU [36150.215639] NMI watchdog enabled, takes one hw-pmu counter. [36150.235357] CPU1 is up [36150.236915] ACPI: Waking up from system sleep state S3 [36150.558825] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [36150.558910] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100107) [36150.558941] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [36150.558959] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728000) [36150.558966] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [36150.558989] ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI [36150.558995] ehci_hcd 0000:00:1a.0: PME# disabled [36150.558999] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [36150.559003] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [36150.559178] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x4010b) [36150.559189] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) [36150.559194] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xf240f240) [36150.559199] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x0, writing 0xf0) [36150.559208] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [36150.559214] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [36150.559249] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [36150.559267] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728400) [36150.559274] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [36150.559293] ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI [36150.559297] ehci_hcd 0000:00:1d.0: PME# disabled [36150.559300] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [36150.559304] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [36150.559408] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [36150.559476] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x400, writing 0x40b) [36150.559498] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [36150.559580] iwlwifi 0000:02:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [36150.559769] PM: early resume of devices complete after 1.065 msecs [36150.559905] i915 0000:00:02.0: power state changed by ACPI to D0 [36150.559910] i915 0000:00:02.0: power state changed by ACPI to D0 [36150.559916] i915 0000:00:02.0: setting latency timer to 64 [36150.560030] mei 0000:00:16.0: irq 41 for MSI/MSI-X [36150.560145] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [36150.560153] e1000e 0000:00:19.0: PME# disabled [36150.560248] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [36150.563226] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [36150.563231] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [36150.563241] ehci_hcd 0000:00:1a.0: PCI INT D -> GSI 23 (level, low) -> IRQ 23 [36150.563250] ehci_hcd 0000:00:1a.0: setting latency timer to 64 [36150.563275] snd_hda_intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [36150.563281] snd_hda_intel 0000:00:1b.0: setting latency timer to 64 [36150.563343] snd_hda_intel 0000:00:1b.0: irq 45 for MSI/MSI-X [36150.563376] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [36150.563380] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [36150.563385] ehci_hcd 0000:00:1d.0: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [36150.563391] ehci_hcd 0000:00:1d.0: setting latency timer to 64 [36150.563410] pci 0000:00:1e.0: setting latency timer to 64 [36150.563424] ahci 0000:00:1f.2: setting latency timer to 64 [36150.563665] sd 0:0:0:0: [sda] Starting disk [36150.818291] PM: resume of drv:hub dev:1-1:1.0 complete after 255.029 msecs [36150.818301] PM: resume of drv: dev:ep_00 complete after 255.037 msecs [36150.818308] PM: resume of drv: dev:ep_81 complete after 255.040 msecs [36150.890199] usb 1-1.4: reset full-speed USB device number 12 using ehci_hcd [36150.890207] ata2: SATA link down (SStatus 0 SControl 300) [36150.898076] ata5: SATA link down (SStatus 0 SControl 300) [36150.906085] ata6: SATA link down (SStatus 0 SControl 300) [36150.947713] PM: resume of drv:i915 dev:0000:00:02.0 complete after 388.489 msecs [36150.983772] btusb 1-1.4:1.0: no reset_resume for driver btusb? [36150.983776] btusb 1-1.4:1.1: no reset_resume for driver btusb? [36151.054057] usb 1-1.6: reset high-speed USB device number 4 using ehci_hcd [36151.155039] PM: resume of drv: dev:ep_00 complete after 592.293 msecs [36151.155049] PM: resume of drv:uvcvideo dev:1-1.6:1.1 complete after 592.307 msecs [36151.155056] PM: resume of drv:uvcvideo dev:1-1.6:1.0 complete after 592.356 msecs [36151.155117] PM: resume of drv: dev:ep_81 complete after 592.412 msecs [36151.233814] PM: resume of drv: dev:ep_00 complete after 671.154 msecs [36151.233824] PM: resume of drv:usb dev:1-1.4:1.3 complete after 671.181 msecs [36151.233831] PM: resume of drv:usb dev:1-1.4:1.2 complete after 671.197 msecs [36151.233842] PM: resume of drv:usb dev:1-1.4:1.1 complete after 671.217 msecs [36151.233851] PM: resume of drv:usb dev:1-1.4:1.0 complete after 671.238 msecs [36151.233862] PM: resume of drv: dev:ep_04 complete after 671.222 msecs [36151.233868] PM: resume of drv: dev:ep_83 complete after 671.240 msecs [36151.233874] PM: resume of drv: dev:ep_03 complete after 671.243 msecs [36151.233883] PM: resume of drv: dev:ep_81 complete after 671.264 msecs [36151.233887] PM: resume of drv: dev:ep_82 complete after 671.269 msecs [36151.233891] PM: resume of drv: dev:ep_84 complete after 671.251 msecs [36151.233894] PM: resume of drv: dev:ep_02 complete after 671.271 msecs [36151.247042] watchdog: only one watchdog can use /dev/watchdog. [36151.247046] watchdog: error registering /dev/watchdog (err=-16). [36151.247049] mei: unable to register watchdog device. [36152.726947] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [36152.730847] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [36152.730853] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [36152.731161] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [36152.731166] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [36152.733853] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [36152.733859] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [36152.734127] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [36152.734133] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [36152.735402] ata1.00: configured for UDMA/100 [36152.780275] PM: resume of drv:sd dev:0:0:0:0 complete after 2220.431 msecs [36152.780335] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 2180.488 msecs [36152.780453] hdaps: initial mode latch is 0x05 [36152.780598] hdaps: setting ec_rate=250, filter_order=2 [36152.781536] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 2221.669 msecs [36152.782087] PM: resume of devices complete after 2226.070 msecs [36152.782516] PM: resume devices took 2.224 seconds [36152.782547] PM: Finishing wakeup. [36152.782549] Restarting tasks ... done. [36152.826382] video LNXVIDEO:00: Restoring backlight state [36152.836654] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id [36153.887087] e1000e 0000:00:19.0: PME# enabled [36153.988734] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [36153.988741] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [36153.988747] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [36153.988765] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [36153.988786] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [36153.988834] e1000e 0000:00:19.0: PME# disabled [36154.104795] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [36154.160668] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [36154.161435] ADDRCONF(NETDEV_UP): eth0: link is not ready [36155.350352] e1000e 0000:00:19.0: PME# enabled [37101.167677] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [37101.167686] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [37101.167692] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [37101.167712] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [37101.167734] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [37101.167771] e1000e 0000:00:19.0: PME# disabled [37101.167853] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [37101.254217] e1000e 0000:00:19.0: PME# enabled [37102.505359] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [37102.505369] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [37102.505382] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [37102.505408] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [37102.505436] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [37102.505504] e1000e 0000:00:19.0: PME# disabled [37104.980659] PM: Syncing filesystems ... done. [37105.055784] PM: Preparing system for mem sleep [37105.516243] Freezing user space processes ... (elapsed 0.01 seconds) done. [37105.532212] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [37105.548173] PM: Entering mem sleep [37105.548320] Suspending console(s) (use no_console_suspend to debug) [37105.548624] hdaps: setting ec_rate=0, filter_order=1 [37105.548946] sd 0:0:0:0: [sda] Synchronizing SCSI cache [37105.549142] sd 0:0:0:0: [sda] Stopping disk [37105.739853] PM: suspend of drv:tpm_tis dev:00:0b complete after 177.788 msecs [37105.740000] ehci_hcd 0000:00:1d.0: PCI INT D disabled [37105.740009] ehci_hcd 0000:00:1a.0: PCI INT D disabled [37105.771795] i915 0000:00:02.0: power state changed by ACPI to D3 [37105.805519] e1000e 0000:00:19.0: PME# enabled [37105.805527] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [37105.844211] snd_hda_intel 0000:00:1b.0: PCI INT B disabled [37105.859611] PM: suspend of drv:snd_hda_intel dev:0000:00:1b.0 complete after 119.819 msecs [37105.969943] PM: suspend of drv:sd dev:0:0:0:0 complete after 421.729 msecs [37105.970001] PM: suspend of drv:scsi dev:target0:0:0 complete after 421.569 msecs [37105.970059] PM: suspend of drv:scsi dev:host0 complete after 408.362 msecs [37105.983446] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 243.886 msecs [37105.983462] PM: suspend of drv: dev:pci0000:00 complete after 243.064 msecs [37105.983474] PM: suspend of devices complete after 435.763 msecs [37105.983477] PM: suspend devices took 0.436 seconds [37105.999586] ehci_hcd 0000:00:1d.0: PME# enabled [37105.999592] ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI [37106.015345] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [37106.015544] ehci_hcd 0000:00:1a.0: PME# enabled [37106.015549] ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI [37106.031317] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D3 [37106.047371] PM: late suspend of devices complete after 63.998 msecs [37106.047528] ACPI: Preparing to enter system sleep state S3 [37106.219036] PM: Saving platform NVS memory [37106.223683] Disabling non-boot CPUs ... [37106.326833] CPU 1 is now offline [37106.327334] Extended CMOS year: 2000 [37106.327556] ACPI: Low-level resume complete [37106.327612] PM: Restoring platform NVS memory [37106.328271] Extended CMOS year: 2000 [37106.328297] Enabling non-boot CPUs ... [37106.328451] Booting Node 0 Processor 1 APIC 0x4 [37106.328453] smpboot cpu 1: start_ip = 99000 [37106.339466] Calibrating delay loop (skipped) already calibrated this CPU [37106.359977] NMI watchdog enabled, takes one hw-pmu counter. [37106.375860] CPU1 is up [37106.377440] ACPI: Waking up from system sleep state S3 [37106.699252] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [37106.699337] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100107) [37106.699368] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [37106.699386] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728000) [37106.699393] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [37106.699416] ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI [37106.699422] ehci_hcd 0000:00:1a.0: PME# disabled [37106.699426] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [37106.699429] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [37106.699605] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x4010b) [37106.699616] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) [37106.699621] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xf240f240) [37106.699626] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x0, writing 0xf0) [37106.699635] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [37106.699641] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [37106.699676] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [37106.699694] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728400) [37106.699702] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [37106.699720] ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI [37106.699725] ehci_hcd 0000:00:1d.0: PME# disabled [37106.699727] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37106.699731] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37106.699834] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [37106.699902] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x400, writing 0x40b) [37106.699925] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [37106.700008] iwlwifi 0000:02:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [37106.700197] PM: early resume of devices complete after 1.067 msecs [37106.700328] i915 0000:00:02.0: power state changed by ACPI to D0 [37106.700332] i915 0000:00:02.0: power state changed by ACPI to D0 [37106.700341] i915 0000:00:02.0: setting latency timer to 64 [37106.700372] mei 0000:00:16.0: irq 41 for MSI/MSI-X [37106.700393] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [37106.700398] e1000e 0000:00:19.0: PME# disabled [37106.700469] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [37106.703453] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [37106.703457] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [37106.703466] ehci_hcd 0000:00:1a.0: PCI INT D -> GSI 23 (level, low) -> IRQ 23 [37106.703472] ehci_hcd 0000:00:1a.0: setting latency timer to 64 [37106.703495] snd_hda_intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [37106.703501] snd_hda_intel 0000:00:1b.0: setting latency timer to 64 [37106.703540] snd_hda_intel 0000:00:1b.0: irq 45 for MSI/MSI-X [37106.703573] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37106.703577] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37106.703583] ehci_hcd 0000:00:1d.0: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [37106.703589] ehci_hcd 0000:00:1d.0: setting latency timer to 64 [37106.703607] pci 0000:00:1e.0: setting latency timer to 64 [37106.703621] ahci 0000:00:1f.2: setting latency timer to 64 [37106.704627] sd 0:0:0:0: [sda] Starting disk [37106.882820] PM: resume of drv: dev:ep_00 complete after 178.232 msecs [37106.882859] PM: resume of drv:hub dev:1-1:1.0 complete after 178.398 msecs [37106.882918] PM: resume of drv: dev:ep_81 complete after 178.370 msecs [37106.954879] usb 1-1.6: reset high-speed USB device number 4 using ehci_hcd [37107.030580] ata2: SATA link down (SStatus 0 SControl 300) [37107.042499] ata6: SATA link down (SStatus 0 SControl 300) [37107.046548] ata5: SATA link down (SStatus 0 SControl 300) [37107.055987] PM: resume of drv:uvcvideo dev:1-1.6:1.1 complete after 351.418 msecs [37107.055996] PM: resume of drv: dev:ep_00 complete after 351.391 msecs [37107.056023] PM: resume of drv:uvcvideo dev:1-1.6:1.0 complete after 351.563 msecs [37107.056050] PM: resume of drv: dev:ep_81 complete after 351.520 msecs [37107.096129] PM: resume of drv:i915 dev:0000:00:02.0 complete after 396.493 msecs [37107.122612] usb 1-1.4: reset full-speed USB device number 12 using ehci_hcd [37107.216058] btusb 1-1.4:1.0: no reset_resume for driver btusb? [37107.216062] btusb 1-1.4:1.1: no reset_resume for driver btusb? [37107.396021] watchdog: only one watchdog can use /dev/watchdog. [37107.396025] watchdog: error registering /dev/watchdog (err=-16). [37107.396027] mei: unable to register watchdog device. [37107.466034] PM: resume of drv:usb dev:1-1.4:1.1 complete after 762.003 msecs [37107.466046] PM: resume of drv:usb dev:1-1.4:1.2 complete after 761.973 msecs [37107.466052] PM: resume of drv:usb dev:1-1.4:1.0 complete after 762.081 msecs [37107.466056] PM: resume of drv:usb dev:1-1.4:1.3 complete after 761.882 msecs [37107.466063] PM: resume of drv: dev:ep_00 complete after 761.874 msecs [37107.466069] PM: resume of drv: dev:ep_81 complete after 762.084 msecs [37107.466075] PM: resume of drv: dev:ep_83 complete after 762.026 msecs [37107.466078] PM: resume of drv: dev:ep_82 complete after 762.079 msecs [37107.466082] PM: resume of drv: dev:ep_03 complete after 762.024 msecs [37107.466086] PM: resume of drv: dev:ep_02 complete after 762.071 msecs [37107.466089] PM: resume of drv: dev:ep_84 complete after 761.966 msecs [37107.466105] PM: resume of drv: dev:ep_04 complete after 761.967 msecs [37108.811471] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [37108.820001] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [37108.820007] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [37108.820312] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [37108.820317] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [37108.823016] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [37108.823024] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [37108.823319] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [37108.823325] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [37108.824619] ata1.00: configured for UDMA/100 [37108.861132] PM: resume of drv:sd dev:0:0:0:0 complete after 2160.222 msecs [37108.861191] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 2124.767 msecs [37108.861203] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 2160.207 msecs [37108.861307] hdaps: initial mode latch is 0x05 [37108.861513] hdaps: setting ec_rate=250, filter_order=2 [37108.863026] PM: resume of devices complete after 2166.491 msecs [37108.863379] PM: resume devices took 2.168 seconds [37108.863411] PM: Finishing wakeup. [37108.863412] Restarting tasks ... done. [37108.911829] video LNXVIDEO:00: Restoring backlight state [37108.959554] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id [37109.628049] e1000e 0000:00:19.0: PME# enabled [37109.705902] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [37109.705909] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [37109.705915] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [37109.705933] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [37109.705954] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [37109.706000] e1000e 0000:00:19.0: PME# disabled [37109.817946] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [37109.873641] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [37109.874420] ADDRCONF(NETDEV_UP): eth0: link is not ready [37111.070351] e1000e 0000:00:19.0: PME# enabled [38179.054206] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [38179.054214] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [38179.054221] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [38179.054241] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [38179.054263] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [38179.054301] e1000e 0000:00:19.0: PME# disabled [38179.054384] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [38179.140852] e1000e 0000:00:19.0: PME# enabled [38180.204253] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [38180.204266] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [38180.204276] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [38180.204305] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [38180.204330] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [38180.204391] e1000e 0000:00:19.0: PME# disabled [38181.602079] PM: Syncing filesystems ... done. [38181.726010] PM: Preparing system for mem sleep [38182.192848] Freezing user space processes ... (elapsed 0.01 seconds) done. [38182.208825] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [38182.224749] PM: Entering mem sleep [38182.224898] Suspending console(s) (use no_console_suspend to debug) [38182.225203] hdaps: setting ec_rate=0, filter_order=1 [38182.225510] sd 0:0:0:0: [sda] Synchronizing SCSI cache [38182.225718] sd 0:0:0:0: [sda] Stopping disk [38182.420451] PM: suspend of drv:tpm_tis dev:00:0b complete after 176.465 msecs [38182.420591] ehci_hcd 0000:00:1d.0: PCI INT D disabled [38182.420622] ehci_hcd 0000:00:1a.0: PCI INT D disabled [38182.452391] i915 0000:00:02.0: power state changed by ACPI to D3 [38182.486239] e1000e 0000:00:19.0: PME# enabled [38182.486247] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [38182.524724] snd_hda_intel 0000:00:1b.0: PCI INT B disabled [38182.540210] PM: suspend of drv:snd_hda_intel dev:0000:00:1b.0 complete after 119.813 msecs [38182.629984] PM: suspend of drv:sd dev:0:0:0:0 complete after 405.179 msecs [38182.630044] PM: suspend of drv:scsi dev:target0:0:0 complete after 404.929 msecs [38182.630107] PM: suspend of drv:scsi dev:host0 complete after 386.472 msecs [38182.644070] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 223.882 msecs [38182.644132] PM: suspend of drv: dev:pci0000:00 complete after 223.105 msecs [38182.644141] PM: suspend of devices complete after 419.825 msecs [38182.644145] PM: suspend devices took 0.420 seconds [38182.660263] ehci_hcd 0000:00:1d.0: PME# enabled [38182.660269] ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI [38182.675979] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [38182.676177] ehci_hcd 0000:00:1a.0: PME# enabled [38182.676181] ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI [38182.691951] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D3 [38182.708003] PM: late suspend of devices complete after 63.962 msecs [38182.708160] ACPI: Preparing to enter system sleep state S3 [38182.879669] PM: Saving platform NVS memory [38182.884113] Disabling non-boot CPUs ... [38182.987413] CPU 1 is now offline [38182.987893] Extended CMOS year: 2000 [38182.988113] ACPI: Low-level resume complete [38182.988169] PM: Restoring platform NVS memory [38182.988830] Extended CMOS year: 2000 [38182.988856] Enabling non-boot CPUs ... [38182.989009] Booting Node 0 Processor 1 APIC 0x4 [38182.989011] smpboot cpu 1: start_ip = 99000 [38183.000025] Calibrating delay loop (skipped) already calibrated this CPU [38183.020560] NMI watchdog enabled, takes one hw-pmu counter. [38183.036433] CPU1 is up [38183.037995] ACPI: Waking up from system sleep state S3 [38183.359887] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [38183.359973] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100107) [38183.360004] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [38183.360021] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728000) [38183.360029] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [38183.360052] ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI [38183.360057] ehci_hcd 0000:00:1a.0: PME# disabled [38183.360062] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [38183.360065] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [38183.360244] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x4010b) [38183.360255] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) [38183.360260] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xf240f240) [38183.360265] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x0, writing 0xf0) [38183.360274] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [38183.360281] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [38183.360316] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x400, writing 0x40b) [38183.360334] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728400) [38183.360342] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [38183.360360] ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI [38183.360364] ehci_hcd 0000:00:1d.0: PME# disabled [38183.360367] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [38183.360371] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [38183.360474] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [38183.360543] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x400, writing 0x40b) [38183.360565] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [38183.360647] iwlwifi 0000:02:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [38183.360835] PM: early resume of devices complete after 1.071 msecs [38183.360972] i915 0000:00:02.0: power state changed by ACPI to D0 [38183.360978] i915 0000:00:02.0: power state changed by ACPI to D0 [38183.360988] i915 0000:00:02.0: setting latency timer to 64 [38183.361019] mei 0000:00:16.0: irq 41 for MSI/MSI-X [38183.361148] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [38183.361154] e1000e 0000:00:19.0: PME# disabled [38183.361250] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [38183.364256] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [38183.364261] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0 [38183.364269] ehci_hcd 0000:00:1a.0: PCI INT D -> GSI 23 (level, low) -> IRQ 23 [38183.364275] ehci_hcd 0000:00:1a.0: setting latency timer to 64 [38183.364305] snd_hda_intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [38183.364313] snd_hda_intel 0000:00:1b.0: setting latency timer to 64 [38183.364352] snd_hda_intel 0000:00:1b.0: irq 45 for MSI/MSI-X [38183.364387] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [38183.364390] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [38183.364396] ehci_hcd 0000:00:1d.0: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [38183.364402] ehci_hcd 0000:00:1d.0: setting latency timer to 64 [38183.364420] pci 0000:00:1e.0: setting latency timer to 64 [38183.364434] ahci 0000:00:1f.2: setting latency timer to 64 [38183.364593] sd 0:0:0:0: [sda] Starting disk [38183.526629] PM: resume of drv:button dev:PNP0C0D:00 complete after 165.828 msecs [38183.543405] PM: resume of drv:hub dev:1-1:1.0 complete after 179.063 msecs [38183.543412] PM: resume of drv: dev:ep_00 complete after 179.050 msecs [38183.543431] PM: resume of drv: dev:ep_81 complete after 179.081 msecs [38183.572505] Extended CMOS year: 2000 [38183.619433] usb 1-1.6: reset high-speed USB device number 4 using ehci_hcd [38183.683198] ata5: SATA link down (SStatus 0 SControl 300) [38183.691181] ata6: SATA link down (SStatus 0 SControl 300) [38183.699225] ata2: SATA link down (SStatus 0 SControl 300) [38183.720547] PM: resume of drv: dev:ep_00 complete after 356.397 msecs [38183.720557] PM: resume of drv:uvcvideo dev:1-1.6:1.1 complete after 356.418 msecs [38183.720564] PM: resume of drv:uvcvideo dev:1-1.6:1.0 complete after 356.446 msecs [38183.720619] PM: resume of drv: dev:ep_81 complete after 356.489 msecs [38183.760743] PM: resume of drv:i915 dev:0000:00:02.0 complete after 400.475 msecs [38183.787154] usb 1-1.4: reset full-speed USB device number 12 using ehci_hcd [38183.880741] btusb 1-1.4:1.0: no reset_resume for driver btusb? [38183.880746] btusb 1-1.4:1.1: no reset_resume for driver btusb? [38184.062992] watchdog: only one watchdog can use /dev/watchdog. [38184.062996] watchdog: error registering /dev/watchdog (err=-16). [38184.062999] mei: unable to register watchdog device. [38184.130713] PM: resume of drv: dev:ep_00 complete after 767.136 msecs [38184.130724] PM: resume of drv:usb dev:1-1.4:1.3 complete after 767.158 msecs [38184.130730] PM: resume of drv:usb dev:1-1.4:1.2 complete after 767.197 msecs [38184.130742] PM: resume of drv:usb dev:1-1.4:1.1 complete after 767.240 msecs [38184.130752] PM: resume of drv:usb dev:1-1.4:1.0 complete after 767.291 msecs [38184.130764] PM: resume of drv: dev:ep_04 complete after 767.208 msecs [38184.130770] PM: resume of drv: dev:ep_83 complete after 767.257 msecs [38184.130776] PM: resume of drv: dev:ep_03 complete after 767.253 msecs [38184.130785] PM: resume of drv: dev:ep_81 complete after 767.315 msecs [38184.130789] PM: resume of drv: dev:ep_84 complete after 767.242 msecs [38184.130792] PM: resume of drv: dev:ep_82 complete after 767.309 msecs [38184.130797] PM: resume of drv: dev:ep_02 complete after 767.306 msecs [38185.496064] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [38185.506895] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [38185.506901] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [38185.507180] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [38185.507185] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [38185.509908] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [38185.509914] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [38185.510189] ata1.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [38185.510195] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [38185.511468] ata1.00: configured for UDMA/100 [38185.548007] PM: resume of drv:sd dev:0:0:0:0 complete after 2187.177 msecs [38185.548054] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 1978.881 msecs [38185.548068] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 2187.202 msecs [38185.548166] hdaps: initial mode latch is 0x05 [38185.548315] hdaps: setting ec_rate=250, filter_order=2 [38185.549817] PM: resume of devices complete after 2192.678 msecs [38185.550237] PM: resume devices took 2.192 seconds [38185.550268] PM: Finishing wakeup. [38185.550270] Restarting tasks ... done. [38185.593674] video LNXVIDEO:00: Restoring backlight state [38185.622562] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id [38186.674691] e1000e 0000:00:19.0: PME# enabled [38186.777805] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [38186.777814] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [38186.777820] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [38186.777838] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [38186.777859] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [38186.777907] e1000e 0000:00:19.0: PME# disabled [38186.889811] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [38186.945564] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [38186.946329] ADDRCONF(NETDEV_UP): eth0: link is not ready [38188.135195] e1000e 0000:00:19.0: PME# enabled [38230.637305] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S [38230.637495] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1 [38230.754926] ADDRCONF(NETDEV_UP): wlan0: link is not ready [38238.414328] wlan0: authenticate with 50:67:f0:95:df:9f (try 1) [38238.417574] wlan0: authenticated [38238.420851] wlan0: associate with 50:67:f0:95:df:9f (try 1) [38238.422870] wlan0: RX AssocResp from 50:67:f0:95:df:9f (capab=0x411 status=0 aid=5) [38238.422874] wlan0: associated [38238.426588] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [38252.372759] wlan0: no IPv6 routers present [38575.835076] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff]) [38575.835088] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff]) [38575.835099] e1000e 0000:00:19.0: BAR 2: set to [io 0x1820-0x183f] (PCI address [0x1820-0x183f]) [38575.835125] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [38575.835154] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) [38575.835201] e1000e 0000:00:19.0: PME# disabled [38575.835307] e1000e 0000:00:19.0: irq 43 for MSI/MSI-X [38575.859356] thinkpad_acpi: EC reports that Thermal Table has changed [39539.703031] usb 1-1.4: USB disconnect, device number 12 [39541.689944] usb 1-1.4: new full-speed USB device number 13 using ehci_hcd