Sep 13 10:53:23 localhost wpa_supplicant[1082]: Trying to authenticate with 00:12:17:07:d0:8e (SSID='XXVLG' freq=2422 MHz) Sep 13 10:53:23 localhost NetworkManager[740]: (wlan0): supplicant interface state: completed -> authenticating Sep 13 10:53:23 localhost kernel: [19560.409824] wlan0: direct probe to 00:12:17:07:d0:8e (try 1/3) Sep 13 10:53:23 localhost kernel: [19560.411933] wlan0: direct probe responded Sep 13 10:53:23 localhost wpa_supplicant[1082]: Trying to associate with 00:12:17:07:d0:8e (SSID='XXVLG' freq=2422 MHz) Sep 13 10:53:23 localhost kernel: [19560.432038] wlan0: authenticate with 00:12:17:07:d0:8e (try 1) Sep 13 10:53:23 localhost kernel: [19560.433830] wlan0: authenticated Sep 13 10:53:23 localhost NetworkManager[740]: (wlan0): supplicant interface state: authenticating -> associating Sep 13 10:53:23 localhost kernel: [19560.490790] wlan0: associate with 00:12:17:07:d0:8e (try 1) Sep 13 10:53:23 localhost kernel: [19560.492947] wlan0: RX ReassocResp from 00:12:17:07:d0:8e (capab=0x411 status=0 aid=3) Sep 13 10:53:23 localhost kernel: [19560.492952] wlan0: associated Sep 13 10:53:23 localhost wpa_supplicant[1082]: Associated with 00:12:17:07:d0:8e Sep 13 10:53:23 localhost wpa_supplicant[1082]: CTRL-EVENT-CONNECTED - Connection to 00:12:17:07:d0:8e completed (reauth) [id=0 id_str=] Sep 13 10:53:23 localhost NetworkManager[740]: (wlan0): supplicant interface state: associating -> completed Sep 13 10:53:28 localhost NetworkManager[740]: (wlan0): roamed from BSSID 00:12:17:BD:36:B6 (XXVLG) to 00:12:17:07:D0:8E (XXVLG) Sep 13 10:55:00 localhost kernel: [19657.549419] telepathy-idle[6164]: segfault at 24 ip 08061406 sp bfa6e4f0 error 4 in telepathy-idle[8048000+25000] Sep 13 11:25:05 localhost kernel: [21461.771993] telepathy-idle[7200]: segfault at 24 ip 08061406 sp bfe960f0 error 4 in telepathy-idle[8048000+25000] Sep 13 11:55:06 localhost kernel: [23263.261265] telepathy-idle[7363]: segfault at 24 ip 08061406 sp bf9d6910 error 4 in telepathy-idle[8048000+25000] Sep 13 12:17:23 localhost kernel: [24600.408218] wlan0: deauthenticated from 00:12:17:07:d0:8e (Reason: 7) Sep 13 12:17:23 localhost wpa_supplicant[1082]: CTRL-EVENT-DISCONNECTED bssid=00:12:17:07:d0:8e reason=7 Sep 13 12:17:23 localhost NetworkManager[740]: (wlan0): supplicant interface state: completed -> disconnected Sep 13 12:17:23 localhost kernel: [24600.464934] cfg80211: All devices are disconnected, going to restore regulatory settings Sep 13 12:17:23 localhost kernel: [24600.464942] cfg80211: Restoring regulatory settings Sep 13 12:17:23 localhost kernel: [24600.464949] cfg80211: Calling CRDA to update world regulatory domain Sep 13 12:17:23 localhost kernel: [24600.482097] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain Sep 13 12:17:23 localhost kernel: [24600.482104] cfg80211: World regulatory domain updated: Sep 13 12:17:23 localhost kernel: [24600.482108] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) Sep 13 12:17:23 localhost kernel: [24600.482113] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 13 12:17:23 localhost kernel: [24600.482119] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 13 12:17:23 localhost kernel: [24600.482124] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 13 12:17:23 localhost kernel: [24600.482128] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 13 12:17:23 localhost kernel: [24600.482133] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 13 12:17:23 localhost NetworkManager[740]: (wlan0): supplicant interface state: disconnected -> scanning Sep 13 12:17:26 localhost wpa_supplicant[1082]: Trying to authenticate with 00:12:17:07:d0:8e (SSID='XXVLG' freq=2422 MHz) Sep 13 12:17:26 localhost NetworkManager[740]: (wlan0): supplicant interface state: scanning -> authenticating Sep 13 12:17:26 localhost wpa_supplicant[1082]: Trying to associate with 00:12:17:07:d0:8e (SSID='XXVLG' freq=2422 MHz) Sep 13 12:17:26 localhost kernel: [24602.796345] wlan0: authenticate with 00:12:17:07:d0:8e (try 1) Sep 13 12:17:26 localhost kernel: [24602.798109] wlan0: authenticated Sep 13 12:17:26 localhost kernel: [24602.798258] wlan0: associate with 00:12:17:07:d0:8e (try 1) Sep 13 12:17:26 localhost kernel: [24602.800418] wlan0: RX ReassocResp from 00:12:17:07:d0:8e (capab=0x411 status=0 aid=2) Sep 13 12:17:26 localhost kernel: [24602.800423] wlan0: associated Sep 13 12:17:26 localhost NetworkManager[740]: (wlan0): supplicant interface state: authenticating -> associating Sep 13 12:17:26 localhost wpa_supplicant[1082]: Associated with 00:12:17:07:d0:8e Sep 13 12:17:26 localhost wpa_supplicant[1082]: CTRL-EVENT-CONNECTED - Connection to 00:12:17:07:d0:8e completed (reauth) [id=0 id_str=] Sep 13 12:17:26 localhost NetworkManager[740]: (wlan0): supplicant interface state: associating -> completed Sep 13 12:25:07 localhost kernel: [25064.210476] telepathy-idle[7643]: segfault at 24 ip 08061406 sp bfb27530 error 4 in telepathy-idle[8048000+25000] Sep 13 12:37:37 localhost kernel: [25814.567097] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=600 Sep 13 12:37:38 localhost kernel: [25814.648304] EXT4-fs (sda5): re-mounted. Opts: commit=600 Sep 13 12:37:42 localhost kernel: [25819.106893] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 13 12:37:42 localhost kernel: [25819.142313] EXT4-fs (sda5): re-mounted. Opts: commit=0 Sep 13 12:55:08 localhost kernel: [26865.361532] telepathy-idle[8201]: segfault at 24 ip 08061406 sp bf92d910 error 4 in telepathy-idle[8048000+25000] Sep 13 12:58:06 localhost kernel: [27042.721242] iwl4965 0000:03:00.0: Microcode SW error detected. Restarting 0x82000000. Sep 13 12:58:06 localhost kernel: [27042.721254] iwl4965 0000:03:00.0: Loaded firmware version: 228.61.2.24 Sep 13 12:58:06 localhost kernel: [27042.721276] iwl4965 0000:03:00.0: Start IWL Error Log Dump: Sep 13 12:58:06 localhost kernel: [27042.721283] iwl4965 0000:03:00.0: Status: 0x000213E4, count: 5 Sep 13 12:58:06 localhost kernel: [27042.721442] iwl4965 0000:03:00.0: Desc Time data1 data2 line Sep 13 12:58:06 localhost kernel: [27042.721453] iwl4965 0000:03:00.0: FH_ERROR (0x000C) 1782329340 0x00000008 0x03530000 208 Sep 13 12:58:06 localhost kernel: [27042.721460] iwl4965 0000:03:00.0: pc blink1 blink2 ilink1 ilink2 hcmd Sep 13 12:58:06 localhost kernel: [27042.721469] iwl4965 0000:03:00.0: 0x0046C 0x0A332 0x004C2 0x006DE 0x0A3EE 0x43200A8 Sep 13 12:58:06 localhost kernel: [27042.721476] iwl4965 0000:03:00.0: FH register values: Sep 13 12:58:06 localhost kernel: [27042.721496] iwl4965 0000:03:00.0: FH_RSCSR_CHNL0_STTS_WPTR_REG: 0X02fd2800 Sep 13 12:58:06 localhost kernel: [27042.721516] iwl4965 0000:03:00.0: FH_RSCSR_CHNL0_RBDCB_BASE_REG: 0X002fd270 Sep 13 12:58:06 localhost kernel: [27042.721537] iwl4965 0000:03:00.0: FH_RSCSR_CHNL0_WPTR: 0X00000050 Sep 13 12:58:06 localhost kernel: [27042.721557] iwl4965 0000:03:00.0: FH_MEM_RCSR_CHNL0_CONFIG_REG: 0X00819000 Sep 13 12:58:06 localhost kernel: [27042.721577] iwl4965 0000:03:00.0: FH_MEM_RSSR_SHARED_CTRL_REG: 0X0000003c Sep 13 12:58:06 localhost kernel: [27042.721597] iwl4965 0000:03:00.0: FH_MEM_RSSR_RX_STATUS_REG: 0X03530000 Sep 13 12:58:06 localhost kernel: [27042.721617] iwl4965 0000:03:00.0: FH_MEM_RSSR_RX_ENABLE_ERR_IRQ2DRV: 0X00000000 Sep 13 12:58:06 localhost kernel: [27042.721637] iwl4965 0000:03:00.0: FH_TSSR_TX_STATUS_REG: 0X07ff0002 Sep 13 12:58:06 localhost kernel: [27042.721657] iwl4965 0000:03:00.0: FH_TSSR_TX_ERROR_REG: 0X00000000 Sep 13 12:58:06 localhost kernel: [27042.721720] iwl4965 0000:03:00.0: Start IWL Event Log Dump: display last 20 entries Sep 13 12:58:06 localhost kernel: [27042.721746] iwl4965 0000:03:00.0: EVT_LOGT:1782329022:0x0000007a:1055 Sep 13 12:58:06 localhost kernel: [27042.721764] iwl4965 0000:03:00.0: EVT_LOGT:1782329027:0x000000d4:0321 Sep 13 12:58:06 localhost kernel: [27042.721781] iwl4965 0000:03:00.0: EVT_LOGT:1782329029:0x00000000:1350 Sep 13 12:58:06 localhost kernel: [27042.721798] iwl4965 0000:03:00.0: EVT_LOGT:1782329029:0x00000000:1351 Sep 13 12:58:06 localhost kernel: [27042.721815] iwl4965 0000:03:00.0: EVT_LOGT:1782329030:0x00000000:1352 Sep 13 12:58:06 localhost kernel: [27042.721832] iwl4965 0000:03:00.0: EVT_LOGT:1782329030:0x00000001:1353 Sep 13 12:58:06 localhost kernel: [27042.721849] iwl4965 0000:03:00.0: EVT_LOGT:1782329037:0x00000005:0357 Sep 13 12:58:06 localhost kernel: [27042.721866] iwl4965 0000:03:00.0: EVT_LOGT:1782329055:0x000000f1:1055 Sep 13 12:58:06 localhost kernel: [27042.721883] iwl4965 0000:03:00.0: EVT_LOGT:1782329056:0x45009120:1076 Sep 13 12:58:06 localhost kernel: [27042.721900] iwl4965 0000:03:00.0: EVT_LOGT:1782329059:0x00000012:1076 Sep 13 12:58:06 localhost kernel: [27042.721917] iwl4965 0000:03:00.0: EVT_LOGT:1782329060:0x4500911c:1065 Sep 13 12:58:06 localhost kernel: [27042.721934] iwl4965 0000:03:00.0: EVT_LOGT:1782329287:0x00000107:0106 Sep 13 12:58:06 localhost kernel: [27042.721951] iwl4965 0000:03:00.0: EVT_LOGT:1782329288:0x00000000:0302 Sep 13 12:58:06 localhost kernel: [27042.721967] iwl4965 0000:03:00.0: EVT_LOGT:1782329321:0x000000d4:0321 Sep 13 12:58:06 localhost kernel: [27042.721983] iwl4965 0000:03:00.0: EVT_LOGT:1782329322:0x00000000:1350 Sep 13 12:58:06 localhost kernel: [27042.722000] iwl4965 0000:03:00.0: EVT_LOGT:1782329322:0x00000000:1351 Sep 13 12:58:06 localhost kernel: [27042.722017] iwl4965 0000:03:00.0: EVT_LOGT:1782329323:0x00000000:1352 Sep 13 12:58:06 localhost kernel: [27042.722033] iwl4965 0000:03:00.0: EVT_LOGT:1782329323:0x00000001:1353 Sep 13 12:58:06 localhost kernel: [27042.722050] iwl4965 0000:03:00.0: EVT_LOGT:1782329332:0x00000006:0357 Sep 13 12:58:06 localhost kernel: [27042.722067] iwl4965 0000:03:00.0: EVT_LOGT:1782329343:0x00000000:0125 Sep 13 12:58:06 localhost kernel: [27042.722372] ieee80211 phy0: Hardware restart was requested Sep 13 13:25:08 localhost kernel: [28665.498610] telepathy-idle[8356]: segfault at 24 ip 08061406 sp bf9187f0 error 4 in telepathy-idle[8048000+25000] Sep 13 13:55:09 localhost kernel: [30466.467441] telepathy-idle[8359]: segfault at 24 ip 08061406 sp bfb1f360 error 4 in telepathy-idle[8048000+25000] Sep 13 14:25:09 localhost kernel: [32266.503097] telepathy-idle[8513]: segfault at 24 ip 08061406 sp bf8fd170 error 4 in telepathy-idle[8048000+25000] Sep 13 14:55:10 localhost kernel: [34067.443509] telepathy-idle[8516]: segfault at 24 ip 08061406 sp bfc50980 error 4 in telepathy-idle[8048000+25000] Sep 13 15:25:11 localhost kernel: [35867.611915] telepathy-idle[10646]: segfault at 24 ip 08061406 sp bfc199a0 error 4 in telepathy-idle[8048000+25000] Sep 13 15:55:11 localhost kernel: [37668.423087] telepathy-idle[10649]: segfault at 24 ip 08061406 sp bfe118b0 error 4 in telepathy-idle[8048000+25000] Sep 13 16:25:11 localhost kernel: [39468.539235] telepathy-idle[10907]: segfault at 24 ip 08061406 sp bf8b17d0 error 4 in telepathy-idle[8048000+25000] Sep 13 16:48:06 localhost kernel: [40842.908466] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=600 Sep 13 16:48:06 localhost kernel: [40842.998373] EXT4-fs (sda5): re-mounted. Opts: commit=600 Sep 13 16:49:23 localhost wpa_supplicant[1082]: Trying to authenticate with 00:12:17:bd:36:b6 (SSID='XXVLG' freq=2447 MHz) Sep 13 16:49:23 localhost NetworkManager[740]: (wlan0): supplicant interface state: completed -> authenticating Sep 13 16:49:23 localhost kernel: [40920.439436] wlan0: direct probe to 00:12:17:bd:36:b6 (try 1/3) Sep 13 16:49:23 localhost kernel: [40920.441558] wlan0: direct probe responded Sep 13 16:49:23 localhost kernel: [40920.441599] wlan0: authenticate with 00:12:17:bd:36:b6 (try 1) Sep 13 16:49:23 localhost wpa_supplicant[1082]: Trying to associate with 00:12:17:bd:36:b6 (SSID='XXVLG' freq=2447 MHz) Sep 13 16:49:23 localhost kernel: [40920.456745] wlan0: authenticated Sep 13 16:49:23 localhost NetworkManager[740]: (wlan0): supplicant interface state: authenticating -> associating Sep 13 16:49:23 localhost kernel: [40920.507184] wlan0: associate with 00:12:17:bd:36:b6 (try 1) Sep 13 16:49:23 localhost kernel: [40920.509432] wlan0: RX ReassocResp from 00:12:17:bd:36:b6 (capab=0x411 status=0 aid=1) Sep 13 16:49:23 localhost kernel: [40920.509441] wlan0: associated Sep 13 16:49:23 localhost wpa_supplicant[1082]: Associated with 00:12:17:bd:36:b6 Sep 13 16:49:23 localhost wpa_supplicant[1082]: CTRL-EVENT-CONNECTED - Connection to 00:12:17:bd:36:b6 completed (reauth) [id=0 id_str=] Sep 13 16:49:23 localhost NetworkManager[740]: (wlan0): supplicant interface state: associating -> completed Sep 13 16:49:28 localhost NetworkManager[740]: (wlan0): roamed from BSSID 00:12:17:07:D0:8E (XXVLG) to 00:12:17:BD:36:B6 (XXVLG) Sep 13 16:55:12 localhost kernel: [41269.542630] telepathy-idle[10910]: segfault at 24 ip 08061406 sp bfc4a0c0 error 4 in telepathy-idle[8048000+25000] Sep 13 17:25:14 localhost kernel: [43071.131812] telepathy-idle[11219]: segfault at 24 ip 08061406 sp bfd7ed90 error 4 in telepathy-idle[8048000+25000] Sep 13 17:55:15 localhost kernel: [44872.278461] telepathy-idle[11303]: segfault at 24 ip 08061406 sp bfb04c10 error 4 in telepathy-idle[8048000+25000] Sep 13 18:22:53 localhost NetworkManager[740]: sleep requested (sleeping: no enabled: yes) Sep 13 18:22:53 localhost NetworkManager[740]: sleeping or disabling... Sep 13 18:22:53 localhost NetworkManager[740]: (eth0): now unmanaged Sep 13 18:22:53 localhost NetworkManager[740]: (eth0): device state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37] Sep 13 18:22:53 localhost NetworkManager[740]: (eth0): cleaning up... Sep 13 18:22:53 localhost NetworkManager[740]: (eth0): taking down device. Sep 13 18:22:53 localhost NetworkManager[740]: (wlan0): now unmanaged Sep 13 18:22:53 localhost NetworkManager[740]: (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37] Sep 13 18:22:53 localhost NetworkManager[740]: (wlan0): deactivating device (reason: 37). Sep 13 18:22:53 localhost NetworkManager[740]: (wlan0): canceled DHCP transaction, DHCP client pid 5981 Sep 13 18:22:53 localhost NetworkManager[740]: (wlan0): cleaning up... Sep 13 18:22:53 localhost kernel: [46530.513560] wlan0: deauthenticating from 00:12:17:bd:36:b6 by local choice (reason=3) Sep 13 18:22:53 localhost kernel: [46530.543415] cfg80211: All devices are disconnected, going to restore regulatory settings Sep 13 18:22:53 localhost kernel: [46530.543427] cfg80211: Restoring regulatory settings Sep 13 18:22:53 localhost kernel: [46530.543438] cfg80211: Calling CRDA to update world regulatory domain Sep 13 18:22:53 localhost wpa_supplicant[1082]: CTRL-EVENT-DISCONNECTED bssid=00:00:00:00:00:00 reason=3 Sep 13 18:22:53 localhost NetworkManager[740]: (wlan0): taking down device. Sep 13 18:22:54 localhost kernel: [46530.580185] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain Sep 13 18:22:54 localhost kernel: [46530.580190] cfg80211: World regulatory domain updated: Sep 13 18:22:54 localhost kernel: [46530.580193] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) Sep 13 18:22:54 localhost kernel: [46530.580197] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 13 18:22:54 localhost kernel: [46530.580202] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 13 18:22:54 localhost kernel: [46530.580205] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 13 18:22:54 localhost kernel: [46530.580209] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 13 18:22:54 localhost kernel: [46530.580213] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 13 18:22:54 localhost kernel: [46531.268456] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 13 18:22:54 localhost kernel: [46531.324369] EXT4-fs (sda5): re-mounted. Opts: commit=0 Sep 13 18:22:56 localhost kernel: [46532.908071] usb 3-2: USB disconnect, device number 6 Sep 13 18:22:56 localhost kernel: [46532.908808] btusb_intr_complete: hci0 urb ed14bb00 failed to resubmit (19) Sep 13 18:22:56 localhost kernel: [46532.908819] btusb_bulk_complete: hci0 urb f2854f80 failed to resubmit (19) Sep 13 18:22:56 localhost kernel: [46532.909805] btusb_bulk_complete: hci0 urb ed14b480 failed to resubmit (19) Sep 13 18:22:56 localhost kernel: [46532.910038] btusb_send_frame: hci0 urb ed3cc380 submission failed Sep 13 18:22:57 localhost kernel: [46533.559912] PM: Syncing filesystems ... done. Sep 13 18:22:57 localhost kernel: [46533.631889] PM: Preparing system for mem sleep Sep 13 18:39:32 localhost kernel: [46533.956198] Freezing user space processes ... (elapsed 0.01 seconds) done. Sep 13 18:39:32 localhost kernel: [46533.972080] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. Sep 13 18:39:32 localhost kernel: [46533.988070] PM: Entering mem sleep Sep 13 18:39:32 localhost kernel: [46533.988102] Suspending console(s) (use no_console_suspend to debug) Sep 13 18:39:32 localhost kernel: [46533.988733] sd 2:0:0:0: [sda] Synchronizing SCSI cache Sep 13 18:39:32 localhost kernel: [46533.992470] sd 2:0:0:0: [sda] Stopping disk Sep 13 18:39:32 localhost kernel: [46534.005900] serial 00:0a: disabled Sep 13 18:39:32 localhost kernel: [46534.006169] ata_piix 0000:00:1f.1: PCI INT C disabled Sep 13 18:39:32 localhost kernel: [46534.007217] ACPI handle has no context! Sep 13 18:39:32 localhost kernel: [46534.007226] sdhci-pci 0000:05:00.2: PCI INT C disabled Sep 13 18:39:32 localhost kernel: [46534.007235] ACPI handle has no context! Sep 13 18:39:32 localhost kernel: [46534.007262] ehci_hcd 0000:00:1d.7: PCI INT D disabled Sep 13 18:39:32 localhost kernel: [46534.007280] uhci_hcd 0000:00:1d.1: PCI INT B disabled Sep 13 18:39:32 localhost kernel: [46534.007298] uhci_hcd 0000:00:1d.0: PCI INT A disabled Sep 13 18:39:32 localhost kernel: [46534.007306] pciehp 0000:00:1c.1:pcie04: pciehp_suspend ENTRY Sep 13 18:39:32 localhost kernel: [46534.007314] pciehp 0000:00:1c.0:pcie04: pciehp_suspend ENTRY Sep 13 18:39:32 localhost kernel: [46534.007333] ehci_hcd 0000:00:1a.7: PCI INT C disabled Sep 13 18:39:32 localhost kernel: [46534.007353] uhci_hcd 0000:00:1a.1: PCI INT B disabled Sep 13 18:39:32 localhost kernel: [46534.007366] uhci_hcd 0000:00:1a.0: PCI INT A disabled Sep 13 18:39:32 localhost kernel: [46534.008899] e1000e 0000:00:19.0: PME# enabled Sep 13 18:39:32 localhost kernel: [46534.008909] e1000e 0000:00:19.0: wake-up capability enabled by ACPI Sep 13 18:39:32 localhost kernel: [46534.012072] ACPI handle has no context! Sep 13 18:39:32 localhost kernel: [46534.024038] i915 0000:00:02.0: power state changed by ACPI to D3 Sep 13 18:39:32 localhost kernel: [46534.108324] HDA Intel 0000:00:1b.0: PCI INT B disabled Sep 13 18:39:32 localhost kernel: [46534.124022] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 116.706 msecs Sep 13 18:39:32 localhost kernel: [46534.124045] PM: suspend of drv: dev:pci0000:00 complete after 115.292 msecs Sep 13 18:39:32 localhost kernel: [46534.124061] PM: suspend of devices complete after 135.537 msecs Sep 13 18:39:32 localhost kernel: [46534.124064] PM: suspend devices took 0.136 seconds Sep 13 18:39:32 localhost kernel: [46534.156034] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 Sep 13 18:39:32 localhost kernel: [46534.156185] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 Sep 13 18:39:32 localhost kernel: [46534.172030] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D3 Sep 13 18:39:32 localhost kernel: [46534.172112] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D3 Sep 13 18:39:32 localhost kernel: [46534.172345] PM: late suspend of devices complete after 48.276 msecs Sep 13 18:39:32 localhost kernel: [46534.172879] ACPI: Preparing to enter system sleep state S3 Sep 13 18:39:32 localhost kernel: [46534.364061] PM: Saving platform NVS memory Sep 13 18:39:32 localhost kernel: [46534.364399] Disabling non-boot CPUs ... Sep 13 18:39:32 localhost kernel: [46534.468041] CPU 1 is now offline Sep 13 18:39:32 localhost kernel: [46534.468469] Extended CMOS year: 2000 Sep 13 18:39:32 localhost kernel: [46534.468469] ACPI: Low-level resume complete Sep 13 18:39:32 localhost kernel: [46534.468469] PM: Restoring platform NVS memory Sep 13 18:39:32 localhost kernel: [46534.468469] Extended CMOS year: 2000 Sep 13 18:39:32 localhost kernel: [46534.468469] Enabling non-boot CPUs ... Sep 13 18:39:32 localhost kernel: [46534.468469] Booting Node 0 Processor 1 APIC 0x1 Sep 13 18:39:32 localhost kernel: [46534.468469] smpboot cpu 1: start_ip = 99000 Sep 13 18:39:32 localhost kernel: [46534.365873] Initializing CPU#1 Sep 13 18:39:32 localhost kernel: [46534.560024] Switched to NOHz mode on CPU #1 Sep 13 18:39:32 localhost kernel: [46534.576078] CPU1 is up Sep 13 18:39:32 localhost kernel: [46534.577761] ACPI: Waking up from system sleep state S3 Sep 13 18:39:32 localhost kernel: [46535.128267] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) Sep 13 18:39:32 localhost kernel: [46535.128306] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) Sep 13 18:39:32 localhost kernel: [46535.128494] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Sep 13 18:39:32 localhost kernel: [46535.128518] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.128523] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.128588] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Sep 13 18:39:32 localhost kernel: [46535.128604] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.128608] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.128692] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) Sep 13 18:39:32 localhost kernel: [46535.128719] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.128727] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.128830] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) Sep 13 18:39:32 localhost kernel: [46535.128963] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) Sep 13 18:39:32 localhost kernel: [46535.129147] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) Sep 13 18:39:32 localhost kernel: [46535.129240] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.129244] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.129306] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Sep 13 18:39:32 localhost kernel: [46535.129322] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.129325] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.129392] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Sep 13 18:39:32 localhost kernel: [46535.129494] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) Sep 13 18:39:32 localhost kernel: [46535.129530] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.129538] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.129623] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007) Sep 13 18:39:32 localhost kernel: [46535.129912] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) Sep 13 18:39:32 localhost kernel: [46535.130166] iwl4965 0000:03:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) Sep 13 18:39:32 localhost kernel: [46535.144027] firewire_ohci 0000:05:00.1: BAR 0: set to [mem 0xd7efe800-0xd7efefff] (PCI address [0xd7efe800-0xd7efefff]) Sep 13 18:39:32 localhost kernel: [46535.144069] firewire_ohci 0000:05:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) Sep 13 18:39:32 localhost kernel: [46535.144079] firewire_ohci 0000:05:00.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) Sep 13 18:39:32 localhost kernel: [46535.160024] sdhci-pci 0000:05:00.2: BAR 0: set to [mem 0xd7efe400-0xd7efe4ff] (PCI address [0xd7efe400-0xd7efe4ff]) Sep 13 18:39:32 localhost kernel: [46535.160065] sdhci-pci 0000:05:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) Sep 13 18:39:32 localhost kernel: [46535.160075] sdhci-pci 0000:05:00.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) Sep 13 18:39:32 localhost kernel: [46535.160796] PM: early resume of devices complete after 32.741 msecs Sep 13 18:39:32 localhost kernel: [46535.160898] i915 0000:00:02.0: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.160905] i915 0000:00:02.0: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.160912] i915 0000:00:02.0: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.161033] e1000e 0000:00:19.0: wake-up capability disabled by ACPI Sep 13 18:39:32 localhost kernel: [46535.161044] e1000e 0000:00:19.0: PME# disabled Sep 13 18:39:32 localhost kernel: [46535.162754] e1000e 0000:00:19.0: irq 42 for MSI/MSI-X Sep 13 18:39:32 localhost kernel: [46535.173354] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 Sep 13 18:39:32 localhost kernel: [46535.173363] uhci_hcd 0000:00:1a.0: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.173393] usb usb3: root hub lost power or was reset Sep 13 18:39:32 localhost kernel: [46535.173410] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.173414] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.173420] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 Sep 13 18:39:32 localhost kernel: [46535.173429] uhci_hcd 0000:00:1a.1: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.173456] usb usb4: root hub lost power or was reset Sep 13 18:39:32 localhost kernel: [46535.173473] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.173479] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.173487] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 22 (level, low) -> IRQ 22 Sep 13 18:39:32 localhost kernel: [46535.173495] ehci_hcd 0000:00:1a.7: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.173547] HDA Intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Sep 13 18:39:32 localhost kernel: [46535.173555] HDA Intel 0000:00:1b.0: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.173608] HDA Intel 0000:00:1b.0: irq 46 for MSI/MSI-X Sep 13 18:39:32 localhost kernel: [46535.173666] pciehp 0000:00:1c.0:pcie04: pciehp_resume ENTRY Sep 13 18:39:32 localhost kernel: [46535.173681] pciehp 0000:00:1c.1:pcie04: pciehp_resume ENTRY Sep 13 18:39:32 localhost kernel: [46535.173690] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.173694] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.173700] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 Sep 13 18:39:32 localhost kernel: [46535.173709] uhci_hcd 0000:00:1d.0: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.173737] usb usb5: root hub lost power or was reset Sep 13 18:39:32 localhost kernel: [46535.173754] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Sep 13 18:39:32 localhost kernel: [46535.173762] uhci_hcd 0000:00:1d.1: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.173790] usb usb6: root hub lost power or was reset Sep 13 18:39:32 localhost kernel: [46535.173806] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.173813] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Sep 13 18:39:32 localhost kernel: [46535.173821] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 Sep 13 18:39:32 localhost kernel: [46535.173829] ehci_hcd 0000:00:1d.7: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.173877] pci 0000:00:1e.0: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.173895] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16 Sep 13 18:39:32 localhost kernel: [46535.173902] ata_piix 0000:00:1f.1: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.173930] ahci 0000:00:1f.2: setting latency timer to 64 Sep 13 18:39:32 localhost kernel: [46535.174382] sdhci-pci 0000:05:00.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 Sep 13 18:39:32 localhost kernel: [46535.174387] sdhci-pci 0000:05:00.2: Will use DMA mode even though HW doesn't fully claim to support it. Sep 13 18:39:32 localhost kernel: [46535.175997] ata2: port disabled. ignoring. Sep 13 18:39:32 localhost kernel: [46535.176942] sd 2:0:0:0: [sda] Starting disk Sep 13 18:39:32 localhost kernel: [46535.210771] serial 00:0a: activated Sep 13 18:39:32 localhost kernel: [46535.214402] Extended CMOS year: 2000 Sep 13 18:39:32 localhost kernel: [46535.236127] firewire_core: skipped bus generations, destroying all nodes Sep 13 18:39:32 localhost kernel: [46535.300125] PM: resume of drv: dev:ep_00 complete after 123.680 msecs Sep 13 18:39:32 localhost kernel: [46535.300134] PM: resume of drv:hub dev:4-0:1.0 complete after 123.735 msecs Sep 13 18:39:32 localhost kernel: [46535.300145] PM: resume of drv: dev:ep_81 complete after 123.723 msecs Sep 13 18:39:32 localhost kernel: [46535.300180] PM: resume of drv: dev:ep_00 complete after 123.541 msecs Sep 13 18:39:32 localhost kernel: [46535.300188] PM: resume of drv:hub dev:6-0:1.0 complete after 123.591 msecs Sep 13 18:39:32 localhost kernel: [46535.300197] PM: resume of drv: dev:ep_00 complete after 123.647 msecs Sep 13 18:39:32 localhost kernel: [46535.300204] PM: resume of drv: dev:ep_81 complete after 123.586 msecs Sep 13 18:39:32 localhost kernel: [46535.300215] PM: resume of drv:hub dev:5-0:1.0 complete after 123.710 msecs Sep 13 18:39:32 localhost kernel: [46535.300224] PM: resume of drv: dev:ep_81 complete after 123.696 msecs Sep 13 18:39:32 localhost kernel: [46535.320093] PM: resume of drv: dev:ep_00 complete after 144.065 msecs Sep 13 18:39:32 localhost kernel: [46535.320101] PM: resume of drv:hub dev:1-0:1.0 complete after 144.644 msecs Sep 13 18:39:32 localhost kernel: [46535.320127] PM: resume of drv: dev:ep_81 complete after 144.150 msecs Sep 13 18:39:32 localhost kernel: [46535.364556] PM: resume of drv:i915 dev:0000:00:02.0 complete after 203.672 msecs Sep 13 18:39:32 localhost kernel: [46535.404217] PM: resume of drv: dev:ep_00 complete after 227.919 msecs Sep 13 18:39:32 localhost kernel: [46535.404225] PM: resume of drv:hub dev:3-0:1.0 complete after 228.053 msecs Sep 13 18:39:32 localhost kernel: [46535.404247] PM: resume of drv: dev:ep_81 complete after 227.964 msecs Sep 13 18:39:32 localhost kernel: [46535.513908] PM: resume of drv:e1000e dev:0000:00:19.0 complete after 352.881 msecs Sep 13 18:39:32 localhost kernel: [46535.513929] PM: resume of drv:net dev:eth0 complete after 299.482 msecs Sep 13 18:39:32 localhost kernel: [46535.516070] usb 3-1: reset full speed USB device number 2 using uhci_hcd Sep 13 18:39:32 localhost kernel: [46535.665201] PM: resume of drv: dev:ep_00 complete after 488.330 msecs Sep 13 18:39:32 localhost kernel: [46535.665209] PM: resume of drv:usb dev:3-1:1.0 complete after 488.481 msecs Sep 13 18:39:32 localhost kernel: [46535.665230] PM: resume of drv: dev:ep_83 complete after 488.381 msecs Sep 13 18:39:32 localhost kernel: [46535.665237] PM: resume of drv: dev:ep_02 complete after 488.414 msecs Sep 13 18:39:32 localhost kernel: [46535.665244] PM: resume of drv: dev:ep_81 complete after 488.495 msecs Sep 13 18:39:32 localhost kernel: [46535.736071] firewire_core: rediscovered device fw0 Sep 13 18:39:32 localhost kernel: [46536.836074] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 13 18:39:32 localhost kernel: [46536.838727] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 13 18:39:32 localhost kernel: [46536.838734] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 13 18:39:32 localhost kernel: [46536.839443] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 13 18:39:32 localhost kernel: [46536.839449] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 13 18:39:32 localhost kernel: [46536.839753] ata3.00: configured for UDMA/100 Sep 13 18:39:32 localhost kernel: [46536.852105] PM: resume of drv:sd dev:2:0:0:0 complete after 1675.163 msecs Sep 13 18:39:32 localhost kernel: [46536.852117] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 1675.128 msecs Sep 13 18:39:32 localhost kernel: [46536.852124] PM: resume of drv:scsi_disk dev:2:0:0:0 complete after 1338.052 msecs Sep 13 18:39:32 localhost kernel: [46536.992121] PM: resume of devices complete after 1831.275 msecs Sep 13 18:39:32 localhost kernel: [46536.992327] PM: resume devices took 1.832 seconds Sep 13 18:39:32 localhost kernel: [46536.992363] PM: Finishing wakeup. Sep 13 18:39:32 localhost kernel: [46536.992365] Restarting tasks ... done. Sep 13 18:39:32 localhost kernel: [46537.057748] video LNXVIDEO:00: Restoring backlight state Sep 13 18:39:32 localhost kernel: [46537.124650] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id Sep 13 18:39:33 localhost kernel: [46537.888199] usb 3-2: new full speed USB device number 7 using uhci_hcd Sep 13 18:39:34 localhost kernel: [46539.127297] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=600 Sep 13 18:39:34 localhost kernel: [46539.158308] EXT4-fs (sda5): re-mounted. Opts: commit=600 Sep 13 18:39:34 localhost NetworkManager[740]: wake requested (sleeping: yes enabled: yes) Sep 13 18:39:34 localhost NetworkManager[740]: waking up and re-enabling... Sep 13 18:39:34 localhost NetworkManager[740]: (eth0): now managed Sep 13 18:39:34 localhost NetworkManager[740]: (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 13 18:39:34 localhost NetworkManager[740]: (eth0): bringing up device. Sep 13 18:39:35 localhost kernel: [46539.612291] e1000e 0000:00:19.0: irq 42 for MSI/MSI-X Sep 13 18:39:35 localhost NetworkManager[740]: (eth0): preparing device. Sep 13 18:39:35 localhost NetworkManager[740]: (eth0): deactivating device (reason: 2). Sep 13 18:39:35 localhost NetworkManager[740]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Sep 13 18:39:35 localhost NetworkManager[740]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Sep 13 18:39:35 localhost NetworkManager[740]: (wlan0): now managed Sep 13 18:39:35 localhost NetworkManager[740]: (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 13 18:39:35 localhost NetworkManager[740]: (wlan0): bringing up device. Sep 13 18:39:35 localhost kernel: [46539.668142] e1000e 0000:00:19.0: irq 42 for MSI/MSI-X Sep 13 18:39:35 localhost kernel: [46539.668452] ADDRCONF(NETDEV_UP): eth0: link is not ready Sep 13 18:39:35 localhost NetworkManager[740]: (wlan0): preparing device. Sep 13 18:39:35 localhost NetworkManager[740]: (wlan0): deactivating device (reason: 2). Sep 13 18:39:35 localhost kernel: [46539.910208] ADDRCONF(NETDEV_UP): wlan0: link is not ready Sep 13 18:39:35 localhost NetworkManager[740]: (wlan0): supplicant interface state: starting -> ready Sep 13 18:39:35 localhost NetworkManager[740]: (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] Sep 13 18:39:35 localhost NetworkManager[740]: (wlan0): supplicant interface state: ready -> inactive Sep 13 18:39:39 localhost NetworkManager[740]: Auto-activating connection 'Auto XXVLG'. Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) starting connection 'Auto XXVLG' Sep 13 18:39:39 localhost NetworkManager[740]: (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 13 18:39:39 localhost NetworkManager[740]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0/wireless): access point 'Auto XXVLG' has security, but secrets are required. Sep 13 18:39:39 localhost NetworkManager[740]: (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0] Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 13 18:39:39 localhost NetworkManager[740]: (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0] Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 13 18:39:39 localhost NetworkManager[740]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0/wireless): connection 'Auto XXVLG' has security, and secrets exist. No new secrets needed. Sep 13 18:39:39 localhost NetworkManager[740]: Config: added 'ssid' value 'XXVLG' Sep 13 18:39:39 localhost NetworkManager[740]: Config: added 'scan_ssid' value '1' Sep 13 18:39:39 localhost NetworkManager[740]: Config: added 'key_mgmt' value 'NONE' Sep 13 18:39:39 localhost NetworkManager[740]: Config: added 'auth_alg' value 'OPEN' Sep 13 18:39:39 localhost NetworkManager[740]: Config: added 'wep_key0' value '' Sep 13 18:39:39 localhost NetworkManager[740]: Config: added 'wep_tx_keyidx' value '0' Sep 13 18:39:39 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 13 18:39:39 localhost NetworkManager[740]: Config: set interface ap_scan to 1 Sep 13 18:39:39 localhost NetworkManager[740]: (wlan0): supplicant interface state: inactive -> scanning Sep 13 18:39:41 localhost wpa_supplicant[1082]: Trying to authenticate with 00:12:17:bd:36:b6 (SSID='XXVLG' freq=2447 MHz) Sep 13 18:39:41 localhost kernel: [46546.031918] wlan0: authenticate with 00:12:17:bd:36:b6 (try 1) Sep 13 18:39:41 localhost wpa_supplicant[1082]: Trying to associate with 00:12:17:bd:36:b6 (SSID='XXVLG' freq=2447 MHz) Sep 13 18:39:41 localhost kernel: [46546.033748] wlan0: authenticated Sep 13 18:39:41 localhost kernel: [46546.034035] wlan0: associate with 00:12:17:bd:36:b6 (try 1) Sep 13 18:39:41 localhost NetworkManager[740]: (wlan0): supplicant interface state: scanning -> associating Sep 13 18:39:41 localhost kernel: [46546.036896] wlan0: RX AssocResp from 00:12:17:bd:36:b6 (capab=0x411 status=0 aid=1) Sep 13 18:39:41 localhost kernel: [46546.036905] wlan0: associated Sep 13 18:39:41 localhost kernel: [46546.062894] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready Sep 13 18:39:41 localhost wpa_supplicant[1082]: Associated with 00:12:17:bd:36:b6 Sep 13 18:39:41 localhost wpa_supplicant[1082]: CTRL-EVENT-CONNECTED - Connection to 00:12:17:bd:36:b6 completed (auth) [id=0 id_str=] Sep 13 18:39:41 localhost NetworkManager[740]: (wlan0): supplicant interface state: associating -> completed Sep 13 18:39:41 localhost NetworkManager[740]: Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'XXVLG'. Sep 13 18:39:41 localhost NetworkManager[740]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. Sep 13 18:39:41 localhost NetworkManager[740]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... Sep 13 18:39:41 localhost NetworkManager[740]: (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] Sep 13 18:39:41 localhost NetworkManager[740]: Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) Sep 13 18:39:41 localhost NetworkManager[740]: dhclient started with pid 12177 Sep 13 18:39:41 localhost NetworkManager[740]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. Sep 13 18:39:41 localhost dhclient: Internet Systems Consortium DHCP Client 4.1.1-P1 Sep 13 18:39:41 localhost dhclient: Copyright 2004-2010 Internet Systems Consortium. Sep 13 18:39:41 localhost dhclient: All rights reserved. Sep 13 18:39:41 localhost dhclient: For info, please visit https://www.isc.org/software/dhcp/ Sep 13 18:39:41 localhost dhclient: Sep 13 18:39:41 localhost NetworkManager[740]: (wlan0): DHCPv4 state changed nbi -> preinit Sep 13 18:39:41 localhost dhclient: Listening on LPF/wlan0/00:1d:e0:02:90:5d Sep 13 18:39:41 localhost dhclient: Sending on LPF/wlan0/00:1d:e0:02:90:5d Sep 13 18:39:41 localhost dhclient: Sending on Socket/fallback Sep 13 18:39:41 localhost dhclient: DHCPREQUEST of 10.0.0.111 on wlan0 to 255.255.255.255 port 67 Sep 13 18:39:41 localhost dhclient: DHCPACK of 10.0.0.111 from 10.0.0.5 Sep 13 18:39:41 localhost dhclient: bound to 10.0.0.111 -- renewal in 265589 seconds. Sep 13 18:39:41 localhost NetworkManager[740]: (wlan0): DHCPv4 state changed preinit -> reboot Sep 13 18:39:41 localhost NetworkManager[740]: Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) scheduled... Sep 13 18:39:41 localhost NetworkManager[740]: Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) started... Sep 13 18:39:41 localhost NetworkManager[740]: address 10.0.0.111 Sep 13 18:39:41 localhost NetworkManager[740]: prefix 24 (255.255.255.0) Sep 13 18:39:41 localhost NetworkManager[740]: gateway 10.0.0.5 Sep 13 18:39:41 localhost NetworkManager[740]: hostname 'schwartz-wifi' Sep 13 18:39:41 localhost NetworkManager[740]: nameserver '10.0.0.5' Sep 13 18:39:41 localhost NetworkManager[740]: domain name 'SLADEN' Sep 13 18:39:41 localhost NetworkManager[740]: wins '10.0.0.5' Sep 13 18:39:41 localhost NetworkManager[740]: Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started... Sep 13 18:39:42 localhost NetworkManager[740]: (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0] Sep 13 18:39:42 localhost NetworkManager[740]: (wlan0): roamed from BSSID 00:12:17:07:D0:8E (XXVLG) to 00:12:17:BD:36:B6 (XXVLG) Sep 13 18:39:42 localhost NetworkManager[740]: Policy set 'Auto XXVLG' (wlan0) as default for IPv4 routing and DNS. Sep 13 18:39:42 localhost NetworkManager[740]: Activation (wlan0) successful, device activated. Sep 13 18:39:42 localhost NetworkManager[740]: Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete. Sep 13 18:39:42 localhost NetworkManager[740]: Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) complete. Sep 13 18:39:52 localhost kernel: [46556.640038] wlan0: no IPv6 routers present Sep 13 18:41:48 localhost kernel: [46672.748468] telepathy-idle[12245]: segfault at 24 ip 08061406 sp bfe6b8c0 error 4 in telepathy-idle[8048000+25000] Sep 13 19:03:48 localhost NetworkManager[740]: sleep requested (sleeping: no enabled: yes) Sep 13 19:03:48 localhost NetworkManager[740]: sleeping or disabling... Sep 13 19:03:48 localhost NetworkManager[740]: (eth0): now unmanaged Sep 13 19:03:48 localhost NetworkManager[740]: (eth0): device state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37] Sep 13 19:03:48 localhost NetworkManager[740]: (eth0): cleaning up... Sep 13 19:03:48 localhost NetworkManager[740]: (eth0): taking down device. Sep 13 19:03:48 localhost NetworkManager[740]: (wlan0): now unmanaged Sep 13 19:03:48 localhost NetworkManager[740]: (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37] Sep 13 19:03:48 localhost NetworkManager[740]: (wlan0): deactivating device (reason: 37). Sep 13 19:03:48 localhost NetworkManager[740]: (wlan0): canceled DHCP transaction, DHCP client pid 12177 Sep 13 19:03:49 localhost kernel: [47993.570785] wlan0: deauthenticating from 00:12:17:bd:36:b6 by local choice (reason=3) Sep 13 19:03:49 localhost NetworkManager[740]: (wlan0): cleaning up... Sep 13 19:03:49 localhost kernel: [47993.577704] cfg80211: All devices are disconnected, going to restore regulatory settings Sep 13 19:03:49 localhost kernel: [47993.577715] cfg80211: Restoring regulatory settings Sep 13 19:03:49 localhost kernel: [47993.577732] cfg80211: Calling CRDA to update world regulatory domain Sep 13 19:03:49 localhost wpa_supplicant[1082]: CTRL-EVENT-DISCONNECTED bssid=00:00:00:00:00:00 reason=3 Sep 13 19:03:49 localhost NetworkManager[740]: (wlan0): taking down device. Sep 13 19:03:49 localhost kernel: [47993.588088] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain Sep 13 19:03:49 localhost kernel: [47993.588097] cfg80211: World regulatory domain updated: Sep 13 19:03:49 localhost kernel: [47993.588103] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) Sep 13 19:03:49 localhost kernel: [47993.588112] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 13 19:03:49 localhost kernel: [47993.588120] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 13 19:03:49 localhost kernel: [47993.588127] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 13 19:03:49 localhost kernel: [47993.588135] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 13 19:03:49 localhost kernel: [47993.588142] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 13 19:03:49 localhost kernel: [47994.302673] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 13 19:03:49 localhost kernel: [47994.404836] EXT4-fs (sda5): re-mounted. Opts: commit=0 Sep 13 19:03:51 localhost kernel: [47995.608237] usb 3-2: USB disconnect, device number 7 Sep 13 19:03:51 localhost kernel: [47995.608674] btusb_intr_complete: hci0 urb ebc1d980 failed to resubmit (19) Sep 13 19:03:51 localhost kernel: [47995.608686] btusb_bulk_complete: hci0 urb ebc1d000 failed to resubmit (19) Sep 13 19:03:51 localhost kernel: [47995.609676] btusb_bulk_complete: hci0 urb ebc1db80 failed to resubmit (19) Sep 13 19:03:51 localhost kernel: [47995.609713] btusb_send_frame: hci0 urb f1af2b80 submission failed Sep 13 19:03:51 localhost kernel: [47996.347320] PM: Syncing filesystems ... done. Sep 13 19:03:51 localhost kernel: [47996.444187] PM: Preparing system for mem sleep Sep 13 19:14:49 localhost kernel: [47996.632325] Freezing user space processes ... (elapsed 0.01 seconds) done. Sep 13 19:14:49 localhost kernel: [47996.648077] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. Sep 13 19:14:49 localhost kernel: [47996.664063] PM: Entering mem sleep Sep 13 19:14:49 localhost kernel: [47996.664100] Suspending console(s) (use no_console_suspend to debug) Sep 13 19:14:49 localhost kernel: [47996.664763] sd 2:0:0:0: [sda] Synchronizing SCSI cache Sep 13 19:14:49 localhost kernel: [47996.668799] sd 2:0:0:0: [sda] Stopping disk Sep 13 19:14:49 localhost kernel: [47996.681424] serial 00:0a: disabled Sep 13 19:14:49 localhost kernel: [47996.681812] ata_piix 0000:00:1f.1: PCI INT C disabled Sep 13 19:14:49 localhost kernel: [47996.682886] ACPI handle has no context! Sep 13 19:14:49 localhost kernel: [47996.682894] sdhci-pci 0000:05:00.2: PCI INT C disabled Sep 13 19:14:49 localhost kernel: [47996.682903] ACPI handle has no context! Sep 13 19:14:49 localhost kernel: [47996.682932] ehci_hcd 0000:00:1d.7: PCI INT D disabled Sep 13 19:14:49 localhost kernel: [47996.682949] uhci_hcd 0000:00:1d.1: PCI INT B disabled Sep 13 19:14:49 localhost kernel: [47996.682972] uhci_hcd 0000:00:1d.0: PCI INT A disabled Sep 13 19:14:49 localhost kernel: [47996.682985] pciehp 0000:00:1c.1:pcie04: pciehp_suspend ENTRY Sep 13 19:14:49 localhost kernel: [47996.682990] pciehp 0000:00:1c.0:pcie04: pciehp_suspend ENTRY Sep 13 19:14:49 localhost kernel: [47996.683009] ehci_hcd 0000:00:1a.7: PCI INT C disabled Sep 13 19:14:49 localhost kernel: [47996.683022] uhci_hcd 0000:00:1a.1: PCI INT B disabled Sep 13 19:14:49 localhost kernel: [47996.683035] uhci_hcd 0000:00:1a.0: PCI INT A disabled Sep 13 19:14:49 localhost kernel: [47996.684580] e1000e 0000:00:19.0: PME# enabled Sep 13 19:14:49 localhost kernel: [47996.684590] e1000e 0000:00:19.0: wake-up capability enabled by ACPI Sep 13 19:14:49 localhost kernel: [47996.688073] ACPI handle has no context! Sep 13 19:14:49 localhost kernel: [47996.700038] i915 0000:00:02.0: power state changed by ACPI to D3 Sep 13 19:14:49 localhost kernel: [47996.784331] HDA Intel 0000:00:1b.0: PCI INT B disabled Sep 13 19:14:49 localhost kernel: [47996.800022] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 117.027 msecs Sep 13 19:14:49 localhost kernel: [47996.800045] PM: suspend of drv: dev:pci0000:00 complete after 115.616 msecs Sep 13 19:14:49 localhost kernel: [47996.800061] PM: suspend of devices complete after 135.509 msecs Sep 13 19:14:49 localhost kernel: [47996.800064] PM: suspend devices took 0.136 seconds Sep 13 19:14:49 localhost kernel: [47996.832035] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 Sep 13 19:14:49 localhost kernel: [47996.832184] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 Sep 13 19:14:49 localhost kernel: [47996.848031] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D3 Sep 13 19:14:49 localhost kernel: [47996.848113] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D3 Sep 13 19:14:49 localhost kernel: [47996.848348] PM: late suspend of devices complete after 48.279 msecs Sep 13 19:14:49 localhost kernel: [47996.848886] ACPI: Preparing to enter system sleep state S3 Sep 13 19:14:49 localhost kernel: [47997.040063] PM: Saving platform NVS memory Sep 13 19:14:49 localhost kernel: [47997.040404] Disabling non-boot CPUs ... Sep 13 19:14:49 localhost kernel: [47997.144039] CPU 1 is now offline Sep 13 19:14:49 localhost kernel: [47997.144458] Extended CMOS year: 2000 Sep 13 19:14:49 localhost kernel: [47997.144458] ACPI: Low-level resume complete Sep 13 19:14:49 localhost kernel: [47997.144458] PM: Restoring platform NVS memory Sep 13 19:14:49 localhost kernel: [47997.144458] Extended CMOS year: 2000 Sep 13 19:14:49 localhost kernel: [47997.144458] Enabling non-boot CPUs ... Sep 13 19:14:49 localhost kernel: [47997.144458] Booting Node 0 Processor 1 APIC 0x1 Sep 13 19:14:49 localhost kernel: [47997.144458] smpboot cpu 1: start_ip = 99000 Sep 13 19:14:49 localhost kernel: [47997.041874] Initializing CPU#1 Sep 13 19:14:49 localhost kernel: [47997.236027] Switched to NOHz mode on CPU #1 Sep 13 19:14:49 localhost kernel: [47997.268077] CPU1 is up Sep 13 19:14:49 localhost kernel: [47997.269770] ACPI: Waking up from system sleep state S3 Sep 13 19:14:49 localhost kernel: [47997.764276] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) Sep 13 19:14:49 localhost kernel: [47997.764314] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) Sep 13 19:14:49 localhost kernel: [47997.764498] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Sep 13 19:14:49 localhost kernel: [47997.764523] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.764527] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.764590] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Sep 13 19:14:49 localhost kernel: [47997.764607] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.764610] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.764695] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) Sep 13 19:14:49 localhost kernel: [47997.764723] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.764731] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.764839] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) Sep 13 19:14:49 localhost kernel: [47997.764975] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) Sep 13 19:14:49 localhost kernel: [47997.765155] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) Sep 13 19:14:49 localhost kernel: [47997.765250] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.765254] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.765319] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Sep 13 19:14:49 localhost kernel: [47997.765335] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.765339] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.765405] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Sep 13 19:14:49 localhost kernel: [47997.765510] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) Sep 13 19:14:49 localhost kernel: [47997.765546] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.765554] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.765639] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007) Sep 13 19:14:49 localhost kernel: [47997.765919] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) Sep 13 19:14:49 localhost kernel: [47997.766184] iwl4965 0000:03:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) Sep 13 19:14:49 localhost kernel: [47997.780027] firewire_ohci 0000:05:00.1: BAR 0: set to [mem 0xd7efe800-0xd7efefff] (PCI address [0xd7efe800-0xd7efefff]) Sep 13 19:14:49 localhost kernel: [47997.780068] firewire_ohci 0000:05:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) Sep 13 19:14:49 localhost kernel: [47997.780079] firewire_ohci 0000:05:00.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) Sep 13 19:14:49 localhost kernel: [47997.796024] sdhci-pci 0000:05:00.2: BAR 0: set to [mem 0xd7efe400-0xd7efe4ff] (PCI address [0xd7efe400-0xd7efe4ff]) Sep 13 19:14:49 localhost kernel: [47997.796066] sdhci-pci 0000:05:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) Sep 13 19:14:49 localhost kernel: [47997.796076] sdhci-pci 0000:05:00.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) Sep 13 19:14:49 localhost kernel: [47997.796797] PM: early resume of devices complete after 32.745 msecs Sep 13 19:14:49 localhost kernel: [47997.796901] i915 0000:00:02.0: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.796907] i915 0000:00:02.0: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.796916] i915 0000:00:02.0: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.797031] e1000e 0000:00:19.0: wake-up capability disabled by ACPI Sep 13 19:14:49 localhost kernel: [47997.797043] e1000e 0000:00:19.0: PME# disabled Sep 13 19:14:49 localhost kernel: [47997.799102] e1000e 0000:00:19.0: irq 42 for MSI/MSI-X Sep 13 19:14:49 localhost kernel: [47997.809740] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 Sep 13 19:14:49 localhost kernel: [47997.809749] uhci_hcd 0000:00:1a.0: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.809778] usb usb3: root hub lost power or was reset Sep 13 19:14:49 localhost kernel: [47997.809795] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.809799] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.809805] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 Sep 13 19:14:49 localhost kernel: [47997.809814] uhci_hcd 0000:00:1a.1: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.809842] usb usb4: root hub lost power or was reset Sep 13 19:14:49 localhost kernel: [47997.809859] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.809865] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.809873] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 22 (level, low) -> IRQ 22 Sep 13 19:14:49 localhost kernel: [47997.809881] ehci_hcd 0000:00:1a.7: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.809933] HDA Intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Sep 13 19:14:49 localhost kernel: [47997.809941] HDA Intel 0000:00:1b.0: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.809994] HDA Intel 0000:00:1b.0: irq 46 for MSI/MSI-X Sep 13 19:14:49 localhost kernel: [47997.810051] pciehp 0000:00:1c.0:pcie04: pciehp_resume ENTRY Sep 13 19:14:49 localhost kernel: [47997.810066] pciehp 0000:00:1c.1:pcie04: pciehp_resume ENTRY Sep 13 19:14:49 localhost kernel: [47997.810075] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.810079] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.810085] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 Sep 13 19:14:49 localhost kernel: [47997.810094] uhci_hcd 0000:00:1d.0: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.810122] usb usb5: root hub lost power or was reset Sep 13 19:14:49 localhost kernel: [47997.810139] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Sep 13 19:14:49 localhost kernel: [47997.810147] uhci_hcd 0000:00:1d.1: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.810175] usb usb6: root hub lost power or was reset Sep 13 19:14:49 localhost kernel: [47997.810191] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.810197] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 Sep 13 19:14:49 localhost kernel: [47997.810205] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 Sep 13 19:14:49 localhost kernel: [47997.810214] ehci_hcd 0000:00:1d.7: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.810261] pci 0000:00:1e.0: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.810279] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16 Sep 13 19:14:49 localhost kernel: [47997.810286] ata_piix 0000:00:1f.1: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.810313] ahci 0000:00:1f.2: setting latency timer to 64 Sep 13 19:14:49 localhost kernel: [47997.810763] sdhci-pci 0000:05:00.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 Sep 13 19:14:49 localhost kernel: [47997.810767] sdhci-pci 0000:05:00.2: Will use DMA mode even though HW doesn't fully claim to support it. Sep 13 19:14:49 localhost kernel: [47997.811392] ata2: port disabled. ignoring. Sep 13 19:14:49 localhost kernel: [47997.812376] sd 2:0:0:0: [sda] Starting disk Sep 13 19:14:49 localhost kernel: [47997.847333] serial 00:0a: activated Sep 13 19:14:49 localhost kernel: [47997.850952] Extended CMOS year: 2000 Sep 13 19:14:49 localhost kernel: [47997.872124] firewire_core: skipped bus generations, destroying all nodes Sep 13 19:14:49 localhost kernel: [47997.928132] PM: resume of drv:hub dev:4-0:1.0 complete after 116.357 msecs Sep 13 19:14:49 localhost kernel: [47997.928142] PM: resume of drv: dev:ep_00 complete after 116.326 msecs Sep 13 19:14:49 localhost kernel: [47997.928149] PM: resume of drv:hub dev:5-0:1.0 complete after 116.272 msecs Sep 13 19:14:49 localhost kernel: [47997.928158] PM: resume of drv: dev:ep_00 complete after 116.235 msecs Sep 13 19:14:49 localhost kernel: [47997.928165] PM: resume of drv:hub dev:6-0:1.0 complete after 116.194 msecs Sep 13 19:14:49 localhost kernel: [47997.928174] PM: resume of drv: dev:ep_00 complete after 116.062 msecs Sep 13 19:14:49 localhost kernel: [47997.928181] PM: resume of drv: dev:ep_81 complete after 116.387 msecs Sep 13 19:14:49 localhost kernel: [47997.928188] PM: resume of drv: dev:ep_81 complete after 116.288 msecs Sep 13 19:14:49 localhost kernel: [47997.928194] PM: resume of drv: dev:ep_81 complete after 116.106 msecs Sep 13 19:14:49 localhost kernel: [47997.956069] PM: resume of drv: dev:ep_00 complete after 144.659 msecs Sep 13 19:14:49 localhost kernel: [47997.956079] PM: resume of drv:hub dev:1-0:1.0 complete after 145.228 msecs Sep 13 19:14:49 localhost kernel: [47997.956102] PM: resume of drv: dev:ep_81 complete after 144.729 msecs Sep 13 19:14:49 localhost kernel: [47998.016545] PM: resume of drv:i915 dev:0000:00:02.0 complete after 219.658 msecs Sep 13 19:14:49 localhost kernel: [47998.032072] PM: resume of drv: dev:ep_00 complete after 220.398 msecs Sep 13 19:14:49 localhost kernel: [47998.032078] PM: resume of drv:hub dev:3-0:1.0 complete after 220.441 msecs Sep 13 19:14:49 localhost kernel: [47998.032100] PM: resume of drv: dev:ep_81 complete after 220.445 msecs Sep 13 19:14:49 localhost kernel: [47998.144069] usb 3-1: reset full speed USB device number 2 using uhci_hcd Sep 13 19:14:49 localhost kernel: [47998.149922] PM: resume of drv:e1000e dev:0000:00:19.0 complete after 352.896 msecs Sep 13 19:14:49 localhost kernel: [47998.149949] PM: resume of drv:net dev:eth0 complete after 298.952 msecs Sep 13 19:14:49 localhost kernel: [47998.293660] PM: resume of drv: dev:ep_00 complete after 481.357 msecs Sep 13 19:14:49 localhost kernel: [47998.293667] PM: resume of drv:usb dev:3-1:1.0 complete after 481.510 msecs Sep 13 19:14:49 localhost kernel: [47998.293685] PM: resume of drv: dev:ep_83 complete after 481.405 msecs Sep 13 19:14:49 localhost kernel: [47998.293692] PM: resume of drv: dev:ep_02 complete after 481.489 msecs Sep 13 19:14:49 localhost kernel: [47998.293699] PM: resume of drv: dev:ep_81 complete after 481.520 msecs Sep 13 19:14:49 localhost kernel: [47998.372072] firewire_core: rediscovered device fw0 Sep 13 19:14:49 localhost kernel: [47999.528074] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 13 19:14:49 localhost kernel: [47999.529314] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 13 19:14:49 localhost kernel: [47999.529321] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 13 19:14:49 localhost kernel: [47999.529994] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 13 19:14:49 localhost kernel: [47999.529999] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 13 19:14:49 localhost kernel: [47999.530296] ata3.00: configured for UDMA/100 Sep 13 19:14:49 localhost kernel: [47999.544117] PM: resume of drv:sd dev:2:0:0:0 complete after 1731.742 msecs Sep 13 19:14:49 localhost kernel: [47999.544129] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 1731.706 msecs Sep 13 19:14:49 localhost kernel: [47999.544145] PM: resume of drv:scsi_disk dev:2:0:0:0 complete after 1394.054 msecs Sep 13 19:14:49 localhost kernel: [47999.684128] PM: resume of devices complete after 1887.278 msecs Sep 13 19:14:49 localhost kernel: [47999.684332] PM: resume devices took 1.888 seconds Sep 13 19:14:49 localhost kernel: [47999.684368] PM: Finishing wakeup. Sep 13 19:14:49 localhost kernel: [47999.684370] Restarting tasks ... done. Sep 13 19:14:49 localhost kernel: [47999.728353] video LNXVIDEO:00: Restoring backlight state Sep 13 19:14:49 localhost kernel: [47999.751589] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id Sep 13 19:14:49 localhost kernel: [48000.560067] usb 3-2: new full speed USB device number 8 using uhci_hcd Sep 13 19:14:50 localhost kernel: [48001.207043] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 13 19:14:50 localhost kernel: [48001.266691] EXT4-fs (sda5): re-mounted. Opts: commit=0 Sep 13 19:14:50 localhost NetworkManager[740]: wake requested (sleeping: yes enabled: yes) Sep 13 19:14:50 localhost NetworkManager[740]: waking up and re-enabling... Sep 13 19:14:50 localhost NetworkManager[740]: (eth0): now managed Sep 13 19:14:50 localhost NetworkManager[740]: (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 13 19:14:50 localhost NetworkManager[740]: (eth0): bringing up device. Sep 13 19:14:50 localhost kernel: [48001.565407] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 13 19:14:51 localhost kernel: [48001.599289] EXT4-fs (sda5): re-mounted. Opts: commit=0 Sep 13 19:14:51 localhost kernel: [48001.672324] e1000e 0000:00:19.0: irq 42 for MSI/MSI-X Sep 13 19:14:51 localhost NetworkManager[740]: (eth0): preparing device. Sep 13 19:14:51 localhost NetworkManager[740]: (eth0): deactivating device (reason: 2). Sep 13 19:14:51 localhost NetworkManager[740]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Sep 13 19:14:51 localhost NetworkManager[740]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Sep 13 19:14:51 localhost NetworkManager[740]: (wlan0): now managed Sep 13 19:14:51 localhost NetworkManager[740]: (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 13 19:14:51 localhost NetworkManager[740]: (wlan0): bringing up device. Sep 13 19:14:51 localhost kernel: [48001.728116] e1000e 0000:00:19.0: irq 42 for MSI/MSI-X Sep 13 19:14:51 localhost kernel: [48001.728431] ADDRCONF(NETDEV_UP): eth0: link is not ready Sep 13 19:14:51 localhost NetworkManager[740]: (wlan0): preparing device. Sep 13 19:14:51 localhost NetworkManager[740]: (wlan0): deactivating device (reason: 2). Sep 13 19:14:51 localhost kernel: [48001.973148] ADDRCONF(NETDEV_UP): wlan0: link is not ready Sep 13 19:14:51 localhost NetworkManager[740]: (wlan0): supplicant interface state: starting -> ready Sep 13 19:14:51 localhost NetworkManager[740]: (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] Sep 13 19:14:51 localhost NetworkManager[740]: (wlan0): supplicant interface state: ready -> inactive Sep 13 19:14:55 localhost NetworkManager[740]: Auto-activating connection 'Auto XXVLG'. Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) starting connection 'Auto XXVLG' Sep 13 19:14:55 localhost NetworkManager[740]: (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 13 19:14:55 localhost NetworkManager[740]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0/wireless): access point 'Auto XXVLG' has security, but secrets are required. Sep 13 19:14:55 localhost NetworkManager[740]: (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0] Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 13 19:14:55 localhost NetworkManager[740]: (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0] Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 13 19:14:55 localhost NetworkManager[740]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0/wireless): connection 'Auto XXVLG' has security, and secrets exist. No new secrets needed. Sep 13 19:14:55 localhost NetworkManager[740]: Config: added 'ssid' value 'XXVLG' Sep 13 19:14:55 localhost NetworkManager[740]: Config: added 'scan_ssid' value '1' Sep 13 19:14:55 localhost NetworkManager[740]: Config: added 'key_mgmt' value 'NONE' Sep 13 19:14:55 localhost NetworkManager[740]: Config: added 'auth_alg' value 'OPEN' Sep 13 19:14:55 localhost NetworkManager[740]: Config: added 'wep_key0' value '' Sep 13 19:14:55 localhost NetworkManager[740]: Config: added 'wep_tx_keyidx' value '0' Sep 13 19:14:55 localhost NetworkManager[740]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 13 19:14:55 localhost NetworkManager[740]: Config: set interface ap_scan to 1 Sep 13 19:14:55 localhost NetworkManager[740]: (wlan0): supplicant interface state: inactive -> scanning Sep 13 19:14:57 localhost wpa_supplicant[1082]: Trying to authenticate with 00:12:17:bd:36:b6 (SSID='XXVLG' freq=2447 MHz) Sep 13 19:14:57 localhost kernel: [48008.135987] wlan0: authenticate with 00:12:17:bd:36:b6 (try 1) Sep 13 19:14:57 localhost wpa_supplicant[1082]: Trying to associate with 00:12:17:bd:36:b6 (SSID='XXVLG' freq=2447 MHz) Sep 13 19:14:57 localhost kernel: [48008.137849] wlan0: authenticated Sep 13 19:14:57 localhost kernel: [48008.138152] wlan0: associate with 00:12:17:bd:36:b6 (try 1) Sep 13 19:14:57 localhost NetworkManager[740]: (wlan0): supplicant interface state: scanning -> associating Sep 13 19:14:57 localhost kernel: [48008.140311] wlan0: RX AssocResp from 00:12:17:bd:36:b6 (capab=0x411 status=0 aid=1) Sep 13 19:14:57 localhost kernel: [48008.140320] wlan0: associated Sep 13 19:14:57 localhost kernel: [48008.167738] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready Sep 13 19:14:57 localhost wpa_supplicant[1082]: Associated with 00:12:17:bd:36:b6 Sep 13 19:14:57 localhost wpa_supplicant[1082]: CTRL-EVENT-CONNECTED - Connection to 00:12:17:bd:36:b6 completed (auth) [id=0 id_str=] Sep 13 19:14:57 localhost NetworkManager[740]: (wlan0): supplicant interface state: associating -> completed Sep 13 19:14:57 localhost NetworkManager[740]: Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'XXVLG'. Sep 13 19:14:57 localhost NetworkManager[740]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. Sep 13 19:14:57 localhost NetworkManager[740]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... Sep 13 19:14:57 localhost NetworkManager[740]: (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] Sep 13 19:14:57 localhost NetworkManager[740]: Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) Sep 13 19:14:57 localhost dhclient: Internet Systems Consortium DHCP Client 4.1.1-P1 Sep 13 19:14:57 localhost NetworkManager[740]: dhclient started with pid 13065 Sep 13 19:14:57 localhost NetworkManager[740]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. Sep 13 19:14:57 localhost dhclient: Copyright 2004-2010 Internet Systems Consortium. Sep 13 19:14:57 localhost dhclient: All rights reserved. Sep 13 19:14:57 localhost dhclient: For info, please visit https://www.isc.org/software/dhcp/ Sep 13 19:14:57 localhost dhclient: Sep 13 19:14:57 localhost NetworkManager[740]: (wlan0): DHCPv4 state changed nbi -> preinit Sep 13 19:14:57 localhost dhclient: Listening on LPF/wlan0/00:1d:e0:02:90:5d Sep 13 19:14:57 localhost dhclient: Sending on LPF/wlan0/00:1d:e0:02:90:5d Sep 13 19:14:57 localhost dhclient: Sending on Socket/fallback Sep 13 19:14:57 localhost dhclient: DHCPREQUEST of 10.0.0.111 on wlan0 to 255.255.255.255 port 67 Sep 13 19:14:57 localhost dhclient: DHCPACK of 10.0.0.111 from 10.0.0.5 Sep 13 19:14:57 localhost dhclient: bound to 10.0.0.111 -- renewal in 289027 seconds. Sep 13 19:14:57 localhost NetworkManager[740]: (wlan0): DHCPv4 state changed preinit -> reboot Sep 13 19:14:57 localhost NetworkManager[740]: Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) scheduled... Sep 13 19:14:57 localhost NetworkManager[740]: Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) started... Sep 13 19:14:57 localhost NetworkManager[740]: address 10.0.0.111 Sep 13 19:14:57 localhost NetworkManager[740]: prefix 24 (255.255.255.0) Sep 13 19:14:57 localhost NetworkManager[740]: gateway 10.0.0.5 Sep 13 19:14:57 localhost NetworkManager[740]: hostname 'schwartz-wifi' Sep 13 19:14:57 localhost NetworkManager[740]: nameserver '10.0.0.5' Sep 13 19:14:57 localhost NetworkManager[740]: domain name 'SLADEN' Sep 13 19:14:57 localhost NetworkManager[740]: wins '10.0.0.5' Sep 13 19:14:57 localhost NetworkManager[740]: Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started... Sep 13 19:14:58 localhost NetworkManager[740]: (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0] Sep 13 19:14:58 localhost NetworkManager[740]: (wlan0): roamed from BSSID 00:12:17:07:D0:8E (XXVLG) to 00:12:17:BD:36:B6 (XXVLG) Sep 13 19:14:58 localhost NetworkManager[740]: Policy set 'Auto XXVLG' (wlan0) as default for IPv4 routing and DNS. Sep 13 19:14:58 localhost NetworkManager[740]: Activation (wlan0) successful, device activated. Sep 13 19:14:58 localhost NetworkManager[740]: Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete. Sep 13 19:14:58 localhost NetworkManager[740]: Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) complete. Sep 13 19:15:07 localhost kernel: [48017.976091] usb 2-1: new high speed USB device number 2 using ehci_hcd Sep 13 19:15:07 localhost kernel: [48018.354836] usbcore: registered new interface driver uas Sep 13 19:15:07 localhost kernel: [48018.358885] Initializing USB Mass Storage driver... Sep 13 19:15:07 localhost kernel: [48018.359183] scsi5 : usb-storage 2-1:1.0 Sep 13 19:15:07 localhost kernel: [48018.359538] usbcore: registered new interface driver usb-storage Sep 13 19:15:07 localhost kernel: [48018.359544] USB Mass Storage support registered. Sep 13 19:15:07 localhost kernel: [48018.376056] wlan0: no IPv6 routers present Sep 13 19:15:08 localhost kernel: [48019.361955] scsi 5:0:0:0: CD-ROM HUAWEI Mass storage ffff PQ: 0 ANSI: 2 Sep 13 19:15:08 localhost kernel: [48019.431520] sr0: scsi-1 drive Sep 13 19:15:08 localhost kernel: [48019.431530] cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 13 19:15:08 localhost kernel: [48019.431902] sr 5:0:0:0: Attached scsi CD-ROM sr0 Sep 13 19:15:08 localhost kernel: [48019.432122] sr 5:0:0:0: Attached scsi generic sg1 type 5 Sep 13 19:22:43 localhost kernel: [48473.866728] telepathy-idle[13198]: segfault at 24 ip 08061406 sp bff815a0 error 4 in telepathy-idle[8048000+25000]