Nov 21 12:42:02 localhost kernel: [222937.124209] EXT4-fs (sda3): re-mounted. Opts: errors=remount-ro,commit=600 Nov 21 12:42:03 localhost kernel: [222938.331483] EXT4-fs (sda6): re-mounted. Opts: commit=600 Nov 21 12:42:04 localhost NetworkManager[2765]: sleep requested (sleeping: no enabled: yes) Nov 21 12:42:04 localhost NetworkManager[2765]: sleeping or disabling... Nov 21 12:42:04 localhost NetworkManager[2765]: (eth0): now unmanaged Nov 21 12:42:04 localhost NetworkManager[2765]: (eth0): device state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37] Nov 21 12:42:04 localhost NetworkManager[2765]: (eth0): cleaning up... Nov 21 12:42:04 localhost NetworkManager[2765]: (eth0): taking down device. Nov 21 12:42:04 localhost NetworkManager[2765]: (wlan0): now unmanaged Nov 21 12:42:04 localhost NetworkManager[2765]: (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37] Nov 21 12:42:04 localhost kernel: [222938.908597] sky2 0000:01:00.0: eth0: disabling interface Nov 21 12:42:04 localhost NetworkManager[2765]: (wlan0): deactivating device (reason 'sleeping') [37] Nov 21 12:42:04 localhost NetworkManager[2765]: (wlan0): canceled DHCP transaction, DHCP client pid 10801 Nov 21 12:42:04 localhost NetworkManager[2765]: (wlan0): cleaning up... Nov 21 12:42:04 localhost NetworkManager[2765]: (wlan0): taking down device. Nov 21 12:42:04 localhost kernel: [222939.181835] wlan0: deauthenticating from 00:ff:ff:00:00:01 by local choice (reason=3) Nov 21 12:42:04 localhost kernel: [222939.216261] cfg80211: All devices are disconnected, going to restore regulatory settings Nov 21 12:42:04 localhost kernel: [222939.216268] cfg80211: Restoring regulatory settings Nov 21 12:42:04 localhost kernel: [222939.216274] cfg80211: Calling CRDA to update world regulatory domain Nov 21 12:42:06 localhost kernel: [222940.610731] cfg80211: Updating information on frequency 2412 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610737] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610741] cfg80211: Updating information on frequency 2417 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610746] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610749] cfg80211: Updating information on frequency 2422 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610753] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610756] cfg80211: Updating information on frequency 2427 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610761] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610764] cfg80211: Updating information on frequency 2432 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610768] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610771] cfg80211: Updating information on frequency 2437 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610775] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610779] cfg80211: Updating information on frequency 2442 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610783] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610786] cfg80211: Updating information on frequency 2447 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610791] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610794] cfg80211: Updating information on frequency 2452 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610798] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610801] cfg80211: Updating information on frequency 2457 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610805] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610809] cfg80211: Updating information on frequency 2462 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610813] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610816] cfg80211: Updating information on frequency 2467 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610820] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610824] cfg80211: Updating information on frequency 2472 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610828] cfg80211: 2402000 KHz - 2482000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610831] cfg80211: Disabling freq 2484 MHz Nov 21 12:42:06 localhost kernel: [222940.610834] cfg80211: Updating information on frequency 5180 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610838] cfg80211: 5170000 KHz - 5250000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610842] cfg80211: Updating information on frequency 5200 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610846] cfg80211: 5170000 KHz - 5250000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610849] cfg80211: Updating information on frequency 5220 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610853] cfg80211: 5170000 KHz - 5250000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610856] cfg80211: Updating information on frequency 5240 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610861] cfg80211: 5170000 KHz - 5250000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610864] cfg80211: Updating information on frequency 5260 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610868] cfg80211: 5250000 KHz - 5330000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610871] cfg80211: Updating information on frequency 5280 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610876] cfg80211: 5250000 KHz - 5330000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610879] cfg80211: Updating information on frequency 5300 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610883] cfg80211: 5250000 KHz - 5330000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610886] cfg80211: Updating information on frequency 5320 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610890] cfg80211: 5250000 KHz - 5330000 KHz @ KHz), (N/A mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.610894] cfg80211: Updating information on frequency 5500 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610898] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610901] cfg80211: Updating information on frequency 5520 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610906] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610909] cfg80211: Updating information on frequency 5540 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610913] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610916] cfg80211: Updating information on frequency 5560 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610920] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610924] cfg80211: Updating information on frequency 5580 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610928] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610931] cfg80211: Updating information on frequency 5600 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610935] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610938] cfg80211: Updating information on frequency 5620 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610943] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610946] cfg80211: Updating information on frequency 5640 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610950] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610953] cfg80211: Updating information on frequency 5660 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610957] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610960] cfg80211: Updating information on frequency 5680 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610965] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610968] cfg80211: Updating information on frequency 5700 MHz for a 20 MHz width channel with regulatory rule: Nov 21 12:42:06 localhost kernel: [222940.610972] cfg80211: 5490000 KHz - 5710000 KHz @ KHz), (N/A mBi, 2700 mBm) Nov 21 12:42:06 localhost kernel: [222940.610975] cfg80211: Disabling freq 5745 MHz Nov 21 12:42:06 localhost kernel: [222940.610977] cfg80211: Disabling freq 5765 MHz Nov 21 12:42:06 localhost kernel: [222940.610980] cfg80211: Disabling freq 5785 MHz Nov 21 12:42:06 localhost kernel: [222940.610982] cfg80211: Disabling freq 5805 MHz Nov 21 12:42:06 localhost kernel: [222940.610984] cfg80211: Disabling freq 5825 MHz Nov 21 12:42:06 localhost kernel: [222940.610992] cfg80211: World regulatory domain updated: Nov 21 12:42:06 localhost kernel: [222940.610994] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) Nov 21 12:42:06 localhost kernel: [222940.610998] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.611002] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.611006] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.611010] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Nov 21 12:42:06 localhost kernel: [222940.611014] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Nov 21 12:42:07 localhost kernel: [222941.570984] EXT4-fs (sda3): re-mounted. Opts: errors=remount-ro,commit=0 Nov 21 12:42:07 localhost kernel: [222941.913212] EXT4-fs (sda6): re-mounted. Opts: commit=0 Nov 21 12:42:08 localhost kernel: [222943.349727] PM: Syncing filesystems ... done. Nov 21 12:42:08 localhost kernel: [222943.380902] PM: Preparing system for mem sleep Nov 21 13:04:39 localhost kernel: [222943.812361] Freezing user space processes ... (elapsed 0.01 seconds) done. Nov 21 13:04:39 localhost kernel: [222943.828168] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. Nov 21 13:04:39 localhost kernel: [222943.844159] PM: Entering mem sleep Nov 21 13:04:39 localhost kernel: [222943.844577] Suspending console(s) (use no_console_suspend to debug) Nov 21 13:04:39 localhost kernel: [222943.845766] sd 2:0:1:0: [sda] Synchronizing SCSI cache Nov 21 13:04:39 localhost kernel: [222943.848637] ata_piix 0000:00:1f.1: PCI INT A disabled Nov 21 13:04:39 localhost kernel: [222943.848709] ata_piix 0000:00:1f.1: power state changed by ACPI to D3 Nov 21 13:04:39 localhost kernel: [222943.848756] uhci_hcd 0000:00:1d.1: PCI INT B disabled Nov 21 13:04:39 localhost kernel: [222943.848801] pciehp 0000:00:1c.1:pcie04: pciehp_suspend ENTRY Nov 21 13:04:39 localhost kernel: [222943.848817] pciehp 0000:00:1c.0:pcie04: pciehp_suspend ENTRY Nov 21 13:04:39 localhost kernel: [222943.849525] i915 0000:00:02.0: PCI INT A disabled Nov 21 13:04:39 localhost kernel: [222943.860064] uhci_hcd 0000:00:1d.2: PCI INT C disabled Nov 21 13:04:39 localhost kernel: [222943.864071] uhci_hcd 0000:00:1d.0: PCI INT A disabled Nov 21 13:04:39 localhost kernel: [222943.864076] uhci_hcd 0000:00:1d.3: PCI INT D disabled Nov 21 13:04:39 localhost kernel: [222943.876033] ehci_hcd 0000:00:1d.7: PCI INT A disabled Nov 21 13:04:39 localhost kernel: [222943.887874] sd 2:0:1:0: [sda] Stopping disk Nov 21 13:04:39 localhost kernel: [222943.952258] snd_hda_intel 0000:00:1b.0: PCI INT A disabled Nov 21 13:04:39 localhost kernel: [222943.968023] PM: suspend of drv:snd_hda_intel dev:0000:00:1b.0 complete after 119.190 msecs Nov 21 13:04:39 localhost kernel: [222946.063344] PM: suspend of drv:sd dev:2:0:1:0 complete after 2217.587 msecs Nov 21 13:04:39 localhost kernel: [222946.063362] PM: suspend of drv:scsi dev:target2:0:1 complete after 2217.479 msecs Nov 21 13:04:39 localhost kernel: [222946.063376] PM: suspend of drv:scsi dev:host2 complete after 2217.197 msecs Nov 21 13:04:39 localhost kernel: [222946.063483] ata_piix 0000:00:1f.2: PCI INT B disabled Nov 21 13:04:39 localhost kernel: [222946.076023] PM: suspend of drv:ata_piix dev:0000:00:1f.2 complete after 2227.549 msecs Nov 21 13:04:39 localhost kernel: [222946.076043] PM: suspend of drv: dev:pci0000:00 complete after 2227.093 msecs Nov 21 13:04:39 localhost kernel: [222946.076057] PM: suspend of devices complete after 2231.124 msecs Nov 21 13:04:39 localhost kernel: [222946.076059] PM: suspend devices took 2.232 seconds Nov 21 13:04:39 localhost kernel: [222946.092088] sky2 0000:01:00.0: PME# enabled Nov 21 13:04:39 localhost kernel: [222946.092095] sky2 0000:01:00.0: wake-up capability enabled by ACPI Nov 21 13:04:39 localhost kernel: [222946.248019] PM: late suspend of drv:sky2 dev:0000:01:00.0 complete after 155.995 msecs Nov 21 13:04:39 localhost kernel: [222946.264370] PM: late suspend of devices complete after 188.312 msecs Nov 21 13:04:39 localhost kernel: [222946.264835] ACPI: Preparing to enter system sleep state S3 Nov 21 13:04:39 localhost kernel: [222946.296062] PM: Saving platform NVS memory Nov 21 13:04:39 localhost kernel: [222946.301353] Disabling non-boot CPUs ... Nov 21 13:04:39 localhost kernel: [222946.404050] CPU 1 is now offline Nov 21 13:04:39 localhost kernel: [222946.404550] Extended CMOS year: 2000 Nov 21 13:04:39 localhost kernel: [222946.404550] ACPI: Low-level resume complete Nov 21 13:04:39 localhost kernel: [222946.404550] PM: Restoring platform NVS memory Nov 21 13:04:39 localhost kernel: [222946.404550] Extended CMOS year: 2000 Nov 21 13:04:39 localhost kernel: [222946.404550] microcode: CPU0 updated to revision 0xd1, date = 2010-10-01 Nov 21 13:04:39 localhost kernel: [222946.404550] Enabling non-boot CPUs ... Nov 21 13:04:39 localhost kernel: [222946.404550] Booting Node 0 Processor 1 APIC 0x1 Nov 21 13:04:39 localhost kernel: [222946.404550] smpboot cpu 1: start_ip = 9a000 Nov 21 13:04:39 localhost kernel: [222946.302779] Calibrating delay loop (skipped) already calibrated this CPU Nov 21 13:04:39 localhost kernel: [222946.417009] microcode: CPU1 updated to revision 0xd1, date = 2010-10-01 Nov 21 13:04:39 localhost kernel: [222946.420019] Switched to NOHz mode on CPU #1 Nov 21 13:04:39 localhost kernel: [222946.420079] CPU1 is up Nov 21 13:04:39 localhost kernel: [222946.422500] ACPI: Waking up from system sleep state S3 Nov 21 13:04:39 localhost kernel: [222946.680200] i915 0000:00:02.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) Nov 21 13:04:39 localhost kernel: [222946.680208] i915 0000:00:02.0: restoring config space at offset 0x7 (was 0x0, writing 0xb0400000) Nov 21 13:04:39 localhost kernel: [222946.680212] i915 0000:00:02.0: restoring config space at offset 0x6 (was 0x8, writing 0xa0000008) Nov 21 13:04:39 localhost kernel: [222946.680216] i915 0000:00:02.0: restoring config space at offset 0x5 (was 0x1, writing 0x20e1) Nov 21 13:04:39 localhost kernel: [222946.680237] pci 0000:00:02.1: restoring config space at offset 0x4 (was 0x0, writing 0xb0300000) Nov 21 13:04:39 localhost kernel: [222946.680242] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) Nov 21 13:04:39 localhost kernel: [222946.680253] pci 0000:00:07.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) Nov 21 13:04:39 localhost kernel: [222946.680263] pci 0000:00:07.0: restoring config space at offset 0x4 (was 0x0, writing 0xb0444000) Nov 21 13:04:39 localhost kernel: [222946.680267] pci 0000:00:07.0: restoring config space at offset 0x1 (was 0xb00000, writing 0xb00002) Nov 21 13:04:39 localhost kernel: [222946.680291] snd_hda_intel 0000:00:1b.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) Nov 21 13:04:39 localhost kernel: [222946.680310] snd_hda_intel 0000:00:1b.0: restoring config space at offset 0x4 (was 0x4, writing 0xb0440004) Nov 21 13:04:39 localhost kernel: [222946.680316] snd_hda_intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x40) Nov 21 13:04:39 localhost kernel: [222946.680322] snd_hda_intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) Nov 21 13:04:39 localhost kernel: [222946.680363] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xb0a1b081) Nov 21 13:04:39 localhost kernel: [222946.680369] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xb020b020) Nov 21 13:04:39 localhost kernel: [222946.680374] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20000000, writing 0x1010) Nov 21 13:04:39 localhost kernel: [222946.680383] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810040) Nov 21 13:04:39 localhost kernel: [222946.680390] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) Nov 21 13:04:39 localhost kernel: [222946.680451] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xb071b061) Nov 21 13:04:39 localhost kernel: [222946.680456] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xb010b010) Nov 21 13:04:39 localhost kernel: [222946.680461] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20000000, writing 0x3030) Nov 21 13:04:39 localhost kernel: [222946.680471] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810040) Nov 21 13:04:39 localhost kernel: [222946.680477] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) Nov 21 13:04:39 localhost kernel: [222946.680672] pci 0000:00:1e.0: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.680674] pci 0000:00:1e.0: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.680692] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) Nov 21 13:04:39 localhost kernel: [222946.680697] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xb000b000) Nov 21 13:04:39 localhost kernel: [222946.680703] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x228000f0) Nov 21 13:04:39 localhost kernel: [222946.680715] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) Nov 21 13:04:39 localhost kernel: [222946.680788] ata_piix 0000:00:1f.1: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.680791] ata_piix 0000:00:1f.1: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.680796] ata_piix 0000:00:1f.1: restoring config space at offset 0xf (was 0x100, writing 0x10b) Nov 21 13:04:39 localhost kernel: [222946.680820] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800001, writing 0x2800005) Nov 21 13:04:39 localhost kernel: [222946.680837] ata_piix 0000:00:1f.2: restoring config space at offset 0xf (was 0x200, writing 0x20b) Nov 21 13:04:39 localhost kernel: [222946.680860] ata_piix 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00003, writing 0x2b00007) Nov 21 13:04:39 localhost kernel: [222946.680937] sky2 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) Nov 21 13:04:39 localhost kernel: [222946.680948] sky2 0000:01:00.0: restoring config space at offset 0xc (was 0x0, writing 0xfffe0000) Nov 21 13:04:39 localhost kernel: [222946.680965] sky2 0000:01:00.0: restoring config space at offset 0x6 (was 0x1, writing 0x1001) Nov 21 13:04:39 localhost kernel: [222946.680973] sky2 0000:01:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xb0200004) Nov 21 13:04:39 localhost kernel: [222946.680979] sky2 0000:01:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x40) Nov 21 13:04:39 localhost kernel: [222946.680988] sky2 0000:01:00.0: restoring config space at offset 0x1 (was 0x40100000, writing 0x100407) Nov 21 13:04:39 localhost kernel: [222946.681064] ath9k 0000:02:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x10b) Nov 21 13:04:39 localhost kernel: [222946.681091] ath9k 0000:02:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xb0100004) Nov 21 13:04:39 localhost kernel: [222946.681097] ath9k 0000:02:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x40) Nov 21 13:04:39 localhost kernel: [222946.681106] ath9k 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) Nov 21 13:04:39 localhost kernel: [222946.681145] firewire_ohci 0000:03:03.0: restoring config space at offset 0xf (was 0x180c0100, writing 0x180c010b) Nov 21 13:04:39 localhost kernel: [222946.681166] firewire_ohci 0000:03:03.0: restoring config space at offset 0x4 (was 0x0, writing 0xb0000000) Nov 21 13:04:39 localhost kernel: [222946.681172] firewire_ohci 0000:03:03.0: restoring config space at offset 0x3 (was 0x0, writing 0xf810) Nov 21 13:04:39 localhost kernel: [222946.681179] firewire_ohci 0000:03:03.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900216) Nov 21 13:04:39 localhost kernel: [222946.681758] PM: early resume of devices complete after 1.738 msecs Nov 21 13:04:39 localhost kernel: [222946.681877] i915 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 Nov 21 13:04:39 localhost kernel: [222946.681881] i915 0000:00:02.0: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.682239] snd_hda_intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 Nov 21 13:04:39 localhost kernel: [222946.682270] snd_hda_intel 0000:00:1b.0: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.684432] snd_hda_intel 0000:00:1b.0: irq 43 for MSI/MSI-X Nov 21 13:04:39 localhost kernel: [222946.684485] pciehp 0000:00:1c.0:pcie04: pciehp_resume ENTRY Nov 21 13:04:39 localhost kernel: [222946.684497] pciehp 0000:00:1c.1:pcie04: pciehp_resume ENTRY Nov 21 13:04:39 localhost kernel: [222946.684507] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 Nov 21 13:04:39 localhost kernel: [222946.684513] uhci_hcd 0000:00:1d.0: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.684542] usb usb2: root hub lost power or was reset Nov 21 13:04:39 localhost kernel: [222946.684558] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 Nov 21 13:04:39 localhost kernel: [222946.684565] uhci_hcd 0000:00:1d.1: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.684590] usb usb3: root hub lost power or was reset Nov 21 13:04:39 localhost kernel: [222946.684605] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 Nov 21 13:04:39 localhost kernel: [222946.684611] uhci_hcd 0000:00:1d.2: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.684637] usb usb4: root hub lost power or was reset Nov 21 13:04:39 localhost kernel: [222946.684651] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16 Nov 21 13:04:39 localhost kernel: [222946.684657] uhci_hcd 0000:00:1d.3: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.684683] usb usb5: root hub lost power or was reset Nov 21 13:04:39 localhost kernel: [222946.684699] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 21 (level, low) -> IRQ 21 Nov 21 13:04:39 localhost kernel: [222946.684706] ehci_hcd 0000:00:1d.7: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.684758] pci 0000:00:1e.0: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.684760] pci 0000:00:1e.0: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.684767] pci 0000:00:1e.0: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.684778] ata_piix 0000:00:1f.1: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.684781] ata_piix 0000:00:1f.1: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.684785] ata_piix 0000:00:1f.1: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.684788] ata_piix 0000:00:1f.1: power state changed by ACPI to D0 Nov 21 13:04:39 localhost kernel: [222946.684792] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18 Nov 21 13:04:39 localhost kernel: [222946.684797] ata_piix 0000:00:1f.1: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.684938] sky2 0000:01:00.0: wake-up capability disabled by ACPI Nov 21 13:04:39 localhost kernel: [222946.684945] sky2 0000:01:00.0: PME# disabled Nov 21 13:04:39 localhost kernel: [222946.688685] ata_piix 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19 Nov 21 13:04:39 localhost kernel: [222946.688693] ata_piix 0000:00:1f.2: setting latency timer to 64 Nov 21 13:04:39 localhost kernel: [222946.691682] sd 2:0:1:0: [sda] Starting disk Nov 21 13:04:39 localhost kernel: [222946.744196] firewire_core: skipped bus generations, destroying all nodes Nov 21 13:04:39 localhost kernel: [222946.758580] Extended CMOS year: 2000 Nov 21 13:04:39 localhost kernel: [222946.808168] PM: resume of drv: dev:ep_00 complete after 116.563 msecs Nov 21 13:04:39 localhost kernel: [222946.808182] PM: resume of drv:hub dev:3-0:1.0 complete after 116.587 msecs Nov 21 13:04:39 localhost kernel: [222946.808196] PM: resume of drv: dev:ep_81 complete after 116.599 msecs Nov 21 13:04:39 localhost kernel: [222946.847762] PM: resume of drv:i915 dev:0000:00:02.0 complete after 165.947 msecs Nov 21 13:04:39 localhost kernel: [222946.856523] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out Nov 21 13:04:39 localhost kernel: [222946.856526] ata1.00: ACPI cmd ef/03:44:00:00:00:a0 (SET FEATURES) filtered out Nov 21 13:04:39 localhost kernel: [222946.872531] ata1.00: configured for UDMA/66 Nov 21 13:04:39 localhost kernel: [222946.912171] PM: resume of drv: dev:ep_00 complete after 220.592 msecs Nov 21 13:04:39 localhost kernel: [222946.912197] PM: resume of drv: dev:ep_00 complete after 220.498 msecs Nov 21 13:04:39 localhost kernel: [222946.912206] PM: resume of drv:hub dev:2-0:1.0 complete after 220.629 msecs Nov 21 13:04:39 localhost kernel: [222946.912244] PM: resume of drv:hub dev:5-0:1.0 complete after 220.600 msecs Nov 21 13:04:39 localhost kernel: [222946.912252] PM: resume of drv:hub dev:4-0:1.0 complete after 220.629 msecs Nov 21 13:04:39 localhost kernel: [222946.912262] PM: resume of drv: dev:ep_00 complete after 220.637 msecs Nov 21 13:04:39 localhost kernel: [222946.912274] PM: resume of drv: dev:ep_81 complete after 220.703 msecs Nov 21 13:04:39 localhost kernel: [222946.912284] PM: resume of drv: dev:ep_81 complete after 220.637 msecs Nov 21 13:04:39 localhost kernel: [222946.912293] PM: resume of drv: dev:ep_81 complete after 220.665 msecs Nov 21 13:04:39 localhost kernel: [222947.024148] usb 5-1: reset full speed USB device number 7 using uhci_hcd Nov 21 13:04:39 localhost kernel: [222947.088188] PM: resume of drv:usb dev:5-1:1.2 complete after 395.776 msecs Nov 21 13:04:39 localhost kernel: [222947.088199] PM: resume of drv:btusb dev:5-1:1.1 complete after 395.837 msecs Nov 21 13:04:39 localhost kernel: [222947.088204] PM: resume of drv: dev:ep_00 complete after 395.769 msecs Nov 21 13:04:39 localhost kernel: [222947.088219] PM: resume of drv:btusb dev:5-1:1.0 complete after 395.957 msecs Nov 21 13:04:39 localhost kernel: [222947.088235] PM: resume of drv: dev:ep_83 complete after 395.845 msecs Nov 21 13:04:39 localhost kernel: [222947.088242] PM: resume of drv: dev:ep_81 complete after 395.962 msecs Nov 21 13:04:39 localhost kernel: [222947.088246] PM: resume of drv: dev:ep_03 complete after 395.876 msecs Nov 21 13:04:39 localhost kernel: [222947.088254] PM: resume of drv: dev:ep_02 complete after 395.945 msecs Nov 21 13:04:39 localhost kernel: [222947.088272] PM: resume of drv: dev:ep_82 complete after 395.942 msecs Nov 21 13:04:39 localhost kernel: [222947.200141] usb 2-2: reset full speed USB device number 2 using uhci_hcd Nov 21 13:04:39 localhost kernel: [222947.244149] firewire_core: rediscovered device fw0 Nov 21 13:04:39 localhost kernel: [222947.358603] appletouch: Geyser mode initialized. Nov 21 13:04:39 localhost kernel: [222947.359639] PM: resume of drv: dev:ep_00 complete after 667.522 msecs Nov 21 13:04:39 localhost kernel: [222947.359651] PM: resume of drv:usbhid dev:2-2:1.2 complete after 667.685 msecs Nov 21 13:04:39 localhost kernel: [222947.359665] PM: resume of drv:appletouch dev:2-2:1.1 complete after 667.747 msecs Nov 21 13:04:39 localhost kernel: [222947.359678] PM: resume of drv:usbhid dev:2-2:1.0 complete after 667.797 msecs Nov 21 13:04:39 localhost kernel: [222947.359694] PM: resume of drv: dev:ep_84 complete after 667.606 msecs Nov 21 13:04:39 localhost kernel: [222947.359707] PM: resume of drv: dev:ep_83 complete after 667.809 msecs Nov 21 13:04:39 localhost kernel: [222947.359716] PM: resume of drv: dev:ep_81 complete after 667.772 msecs Nov 21 13:04:39 localhost kernel: [222947.448138] usb 4-2: reset full speed USB device number 2 using uhci_hcd Nov 21 13:04:39 localhost kernel: [222947.598685] PM: resume of drv: dev:ep_00 complete after 906.461 msecs Nov 21 13:04:39 localhost kernel: [222947.598695] PM: resume of drv:usbhid dev:4-2:1.0 complete after 906.539 msecs Nov 21 13:04:39 localhost kernel: [222947.598729] PM: resume of drv: dev:ep_83 complete after 906.524 msecs Nov 21 13:04:39 localhost kernel: [222948.488336] ata3.01: ACPI cmd ef/03:0c:00:00:00:b0 (SET FEATURES) filtered out Nov 21 13:04:39 localhost kernel: [222948.488343] ata3.01: ACPI cmd ef/03:45:00:00:00:b0 (SET FEATURES) filtered out Nov 21 13:04:39 localhost kernel: [222948.504490] ata3.01: configured for UDMA/133 Nov 21 13:04:39 localhost kernel: [222948.517227] PM: resume of drv:sd dev:2:0:1:0 complete after 1825.491 msecs Nov 21 13:04:39 localhost kernel: [222948.517269] PM: resume of drv:scsi_disk dev:2:0:1:0 complete after 1758.635 msecs Nov 21 13:04:39 localhost kernel: [222948.517439] PM: resume of drv:scsi_device dev:2:0:1:0 complete after 1825.658 msecs Nov 21 13:04:39 localhost kernel: [222948.518072] PM: resume of devices complete after 1836.252 msecs Nov 21 13:04:39 localhost kernel: [222948.518254] PM: resume devices took 1.836 seconds Nov 21 13:04:39 localhost kernel: [222948.518289] PM: Finishing wakeup. Nov 21 13:04:39 localhost kernel: [222948.518290] Restarting tasks ... done. Nov 21 13:04:39 localhost kernel: [222948.609759] video LNXVIDEO:00: Restoring backlight state Nov 21 13:04:39 localhost kernel: [222948.756151] usb 5-1: USB disconnect, device number 7 Nov 21 13:04:39 localhost kernel: [222949.022305] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id Nov 21 13:04:39 localhost kernel: [222949.248094] usb 5-1: new full speed USB device number 8 using uhci_hcd Nov 21 13:04:40 localhost kernel: [222949.461768] input: HID 05ac:1000 as /devices/pci0000:00/0000:00:1d.3/usb5/5-1/5-1:1.0/input/input18 Nov 21 13:04:40 localhost kernel: [222949.461967] generic-usb 0003:05AC:1000.000A: input,hidraw3: USB HID v1.11 Keyboard [HID 05ac:1000] on usb-0000:00:1d.3-1/input0 Nov 21 13:04:40 localhost kernel: [222949.494740] input: HID 05ac:1000 as /devices/pci0000:00/0000:00:1d.3/usb5/5-1/5-1:1.1/input/input19 Nov 21 13:04:40 localhost kernel: [222949.494877] generic-usb 0003:05AC:1000.000B: input,hidraw4: USB HID v1.11 Mouse [HID 05ac:1000] on usb-0000:00:1d.3-1/input1 Nov 21 13:04:40 localhost kernel: [222949.873327] usb 5-1: usbfs: USBDEVFS_CONTROL failed cmd hid2hci rqt 64 rq 0 len 0 ret -71 Nov 21 13:04:40 localhost kernel: [222950.148094] usb 5-1: USB disconnect, device number 8 Nov 21 13:04:41 localhost kernel: [222950.492120] usb 5-1: new full speed USB device number 9 using uhci_hcd Nov 21 13:04:50 localhost kernel: [222959.709840] EXT4-fs (sda3): re-mounted. Opts: errors=remount-ro,commit=600 Nov 21 13:04:50 localhost kernel: [222960.112236] EXT4-fs (sda6): re-mounted. Opts: commit=600 Nov 21 13:04:50 localhost NetworkManager[2765]: wake requested (sleeping: yes enabled: yes) Nov 21 13:04:50 localhost NetworkManager[2765]: waking up and re-enabling... Nov 21 13:04:50 localhost NetworkManager[2765]: (eth0): now managed Nov 21 13:04:51 localhost NetworkManager[2765]: (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 21 13:04:51 localhost NetworkManager[2765]: (eth0): bringing up device. Nov 21 13:04:51 localhost NetworkManager[2765]: (eth0): preparing device. Nov 21 13:04:51 localhost NetworkManager[2765]: (eth0): deactivating device (reason 'managed') [2] Nov 21 13:04:51 localhost NetworkManager[2765]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Nov 21 13:04:51 localhost NetworkManager[2765]: Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889) Nov 21 13:04:51 localhost NetworkManager[2765]: (wlan0): now managed Nov 21 13:04:51 localhost NetworkManager[2765]: (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Nov 21 13:04:51 localhost NetworkManager[2765]: (wlan0): bringing up device. Nov 21 13:04:51 localhost kernel: [222960.564261] sky2 0000:01:00.0: eth0: enabling interface Nov 21 13:04:51 localhost kernel: [222960.564792] ADDRCONF(NETDEV_UP): eth0: link is not ready Nov 21 13:04:51 localhost NetworkManager[2765]: (wlan0): preparing device. Nov 21 13:04:51 localhost NetworkManager[2765]: (wlan0): deactivating device (reason 'managed') [2] Nov 21 13:04:51 localhost kernel: [222960.573558] ADDRCONF(NETDEV_UP): wlan0: link is not ready Nov 21 13:04:52 localhost NetworkManager[2765]: (wlan0): supplicant interface state: starting -> ready Nov 21 13:04:52 localhost NetworkManager[2765]: (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] Nov 21 13:04:52 localhost NetworkManager[2765]: (wlan0): supplicant interface state: ready -> inactive Nov 21 13:04:53 localhost kernel: [222963.313833] cfg80211: Found new beacon on frequency: 2472 MHz (Ch 13) on phy1 Nov 21 13:04:54 localhost kernel: [222963.786831] cfg80211: Found new beacon on frequency: 5220 MHz (Ch 44) on phy1 Nov 21 13:04:56 localhost NetworkManager[2765]: Auto-activating connection 'Auto cs'. Nov 21 13:04:56 localhost NetworkManager[2765]: Activation (wlan0) starting connection 'Auto cs' Nov 21 13:04:56 localhost NetworkManager[2765]: (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 21 13:04:56 localhost NetworkManager[2765]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Nov 21 13:04:56 localhost NetworkManager[2765]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Nov 21 13:04:56 localhost NetworkManager[2765]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Nov 21 13:04:56 localhost NetworkManager[2765]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Nov 21 13:04:56 localhost NetworkManager[2765]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Nov 21 13:04:56 localhost NetworkManager[2765]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Nov 21 13:04:56 localhost NetworkManager[2765]: Activation (wlan0/wireless): connection 'Auto cs' has security, and secrets exist. No new secrets needed. Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'ssid' value 'cs' Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'scan_ssid' value '1' Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'key_mgmt' value 'WPA-EAP' Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'password' value '' Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'eap' value 'PEAP' Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'fragment_size' value '1300' Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'phase2' value 'auth=MSCHAPV2' Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'ca_cert' value '/etc/ssl/cs-ca.crt' Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'identity' value 'srivera' Nov 21 13:04:56 localhost NetworkManager[2765]: Config: added 'bgscan' value 'simple:30:-45:300' Nov 21 13:04:56 localhost NetworkManager[2765]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Nov 21 13:04:56 localhost NetworkManager[2765]: Config: set interface ap_scan to 1 Nov 21 13:04:56 localhost NetworkManager[2765]: (wlan0): supplicant interface state: inactive -> scanning Nov 21 13:04:58 localhost kernel: [222968.159712] EXT4-fs (sda3): re-mounted. Opts: errors=remount-ro,commit=0 Nov 21 13:04:59 localhost kernel: [222968.537335] EXT4-fs (sda6): re-mounted. Opts: commit=0 Nov 21 13:04:59 localhost wpa_supplicant[1088]: Trying to authenticate with 44:e4:d9:aa:43:f0 (SSID='cs' freq=2447 MHz) Nov 21 13:04:59 localhost NetworkManager[2765]: (wlan0): supplicant interface state: scanning -> authenticating Nov 21 13:04:59 localhost kernel: [222968.840673] wlan0: authenticate with 44:e4:d9:aa:43:f0 (try 1) Nov 21 13:04:59 localhost kernel: [222968.844193] wlan0: authenticated Nov 21 13:04:59 localhost wpa_supplicant[1088]: Trying to associate with 44:e4:d9:aa:43:f0 (SSID='cs' freq=2447 MHz) Nov 21 13:04:59 localhost NetworkManager[2765]: (wlan0): supplicant interface state: authenticating -> associating Nov 21 13:04:59 localhost kernel: [222968.851678] wlan0: associate with 44:e4:d9:aa:43:f0 (try 1) Nov 21 13:04:59 localhost kernel: [222968.855457] wlan0: RX AssocResp from 44:e4:d9:aa:43:f0 (capab=0x431 status=0 aid=4) Nov 21 13:04:59 localhost kernel: [222968.855466] wlan0: associated Nov 21 13:04:59 localhost kernel: [222968.859702] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready Nov 21 13:04:59 localhost wpa_supplicant[1088]: Associated with 44:e4:d9:aa:43:f0 Nov 21 13:04:59 localhost wpa_supplicant[1088]: CTRL-EVENT-EAP-STARTED EAP authentication started Nov 21 13:04:59 localhost NetworkManager[2765]: (wlan0): supplicant interface state: associating -> associated Nov 21 13:04:59 localhost wpa_supplicant[1088]: CTRL-EVENT-EAP-PROPOSED-METHOD vendor=0 method=4 -> NAK Nov 21 13:04:59 localhost wpa_supplicant[1088]: CTRL-EVENT-EAP-PROPOSED-METHOD vendor=0 method=25 Nov 21 13:04:59 localhost wpa_supplicant[1088]: CTRL-EVENT-EAP-METHOD EAP vendor 0 method 25 (PEAP) selected Nov 21 13:04:59 localhost wpa_supplicant[1088]: CTRL-EVENT-EAP-PEER-CERT depth=1 subject='/C=ZA/ST=Western Cape/L=Cape Town/O=University of Cape Town/OU=Department of Computer Science/CN=Computer Science Certificate Authority/emailAddress=ca@cs.uct.ac.za' Nov 21 13:04:59 localhost wpa_supplicant[1088]: CTRL-EVENT-EAP-PEER-CERT depth=0 subject='/C=ZA/ST=Western Cape/L=Cape Town/O=University of Cape Town/OU=Department of Computer Science/CN=auth3.cs.uct.ac.za/emailAddress=help@cs.uct.ac.za' Nov 21 13:05:00 localhost wpa_supplicant[1088]: EAP-MSCHAPV2: Authentication succeeded Nov 21 13:05:00 localhost wpa_supplicant[1088]: EAP-TLV: TLV Result - Success - EAP-TLV/Phase2 Completed Nov 21 13:05:00 localhost wpa_supplicant[1088]: CTRL-EVENT-EAP-SUCCESS EAP authentication completed successfully Nov 21 13:05:00 localhost NetworkManager[2765]: (wlan0): supplicant interface state: associated -> 4-way handshake Nov 21 13:05:00 localhost wpa_supplicant[1088]: WPA: Key negotiation completed with 44:e4:d9:aa:43:f0 [PTK=CCMP GTK=TKIP] Nov 21 13:05:00 localhost wpa_supplicant[1088]: CTRL-EVENT-CONNECTED - Connection to 44:e4:d9:aa:43:f0 completed (auth) [id=0 id_str=] Nov 21 13:05:00 localhost NetworkManager[2765]: (wlan0): supplicant interface state: 4-way handshake -> completed Nov 21 13:05:00 localhost NetworkManager[2765]: Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'cs'. Nov 21 13:05:00 localhost NetworkManager[2765]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. Nov 21 13:05:00 localhost NetworkManager[2765]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... Nov 21 13:05:00 localhost NetworkManager[2765]: (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] Nov 21 13:05:00 localhost NetworkManager[2765]: Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) Nov 21 13:05:00 localhost NetworkManager[2765]: dhclient started with pid 3414 Nov 21 13:05:00 localhost NetworkManager[2765]: Activation (wlan0) Beginning IP6 addrconf. Nov 21 13:05:00 localhost NetworkManager[2765]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. Nov 21 13:05:00 localhost dhclient: Internet Systems Consortium DHCP Client 4.1.1-P1 Nov 21 13:05:00 localhost dhclient: Copyright 2004-2010 Internet Systems Consortium. Nov 21 13:05:00 localhost dhclient: All rights reserved. Nov 21 13:05:00 localhost dhclient: For info, please visit https://www.isc.org/software/dhcp/ Nov 21 13:05:00 localhost dhclient: Nov 21 13:05:00 localhost NetworkManager[2765]: (wlan0): DHCPv4 state changed nbi -> preinit Nov 21 13:05:00 localhost dhclient: Listening on LPF/wlan0/00:1b:63:c8:0d:e5 Nov 21 13:05:00 localhost dhclient: Sending on LPF/wlan0/00:1b:63:c8:0d:e5 Nov 21 13:05:00 localhost dhclient: Sending on Socket/fallback Nov 21 13:05:00 localhost dhclient: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 3 Nov 21 13:05:01 localhost dhclient: DHCPOFFER of 137.158.62.113 from 137.158.62.1 Nov 21 13:05:01 localhost dhclient: DHCPREQUEST of 137.158.62.113 on wlan0 to 255.255.255.255 port 67 Nov 21 13:05:01 localhost dhclient: DHCPACK of 137.158.62.113 from 137.158.62.1 Nov 21 13:05:01 localhost dhclient: bound to 137.158.62.113 -- renewal in 16443 seconds. Nov 21 13:05:01 localhost NetworkManager[2765]: (wlan0): DHCPv4 state changed preinit -> bound Nov 21 13:05:01 localhost NetworkManager[2765]: Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) scheduled... Nov 21 13:05:01 localhost NetworkManager[2765]: Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) started... Nov 21 13:05:01 localhost NetworkManager[2765]: address 137.158.62.113 Nov 21 13:05:01 localhost NetworkManager[2765]: prefix 25 (255.255.255.128) Nov 21 13:05:01 localhost NetworkManager[2765]: gateway 137.158.62.1 Nov 21 13:05:01 localhost NetworkManager[2765]: hostname 'srivera-2.cs.uct.ac.za' Nov 21 13:05:01 localhost NetworkManager[2765]: nameserver '137.158.152.240' Nov 21 13:05:01 localhost NetworkManager[2765]: nameserver '137.158.153.130' Nov 21 13:05:01 localhost NetworkManager[2765]: nameserver '137.158.153.146' Nov 21 13:05:01 localhost NetworkManager[2765]: domain name 'cs.uct.ac.za' Nov 21 13:05:01 localhost NetworkManager[2765]: wins '137.158.59.11' Nov 21 13:05:01 localhost NetworkManager[2765]: wins '137.158.59.7' Nov 21 13:05:01 localhost NetworkManager[2765]: Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started... Nov 21 13:05:02 localhost NetworkManager[2765]: (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0] Nov 21 13:05:02 localhost NetworkManager[2765]: (wlan0): roamed from BSSID 04:C5:A4:8C:3B:A0 (cs) to 44:E4:D9:AA:43:F0 (cs) Nov 21 13:05:02 localhost NetworkManager[2765]: Policy set 'Auto cs' (wlan0) as default for IPv4 routing and DNS. Nov 21 13:05:02 localhost NetworkManager[2765]: Activation (wlan0) successful, device activated. Nov 21 13:05:02 localhost NetworkManager[2765]: Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete. Nov 21 13:05:02 localhost NetworkManager[2765]: Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) complete. Nov 21 13:05:05 localhost NetworkManager[2765]: SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/teredo, iface: teredo) Nov 21 13:05:05 localhost NetworkManager[2765]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/teredo, iface: teredo) Nov 21 13:05:05 localhost NetworkManager[2765]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/teredo, iface: teredo): no ifupdown configuration found. Nov 21 13:05:07 localhost kernel: [222976.458711] sky2 0000:01:00.0: eth0: Link is up at 100 Mbps, full duplex, flow control rx Nov 21 13:05:07 localhost kernel: [222976.459609] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 21 13:05:07 localhost NetworkManager[2765]: (eth0): carrier now ON (device state 20) Nov 21 13:05:07 localhost NetworkManager[2765]: (eth0): device state change: unavailable -> disconnected (reason 'carrier-changed') [20 30 40] Nov 21 13:05:07 localhost NetworkManager[2765]: Auto-activating connection 'Auto eth0'. Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) starting connection 'Auto eth0' Nov 21 13:05:07 localhost NetworkManager[2765]: (eth0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled... Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 1 of 5 (Device Prepare) started... Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 2 of 5 (Device Configure) scheduled... Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 1 of 5 (Device Prepare) complete. Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 2 of 5 (Device Configure) starting... Nov 21 13:05:07 localhost NetworkManager[2765]: (eth0): device state change: prepare -> config (reason 'none') [40 50 0] Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 2 of 5 (Device Configure) successful. Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled. Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 2 of 5 (Device Configure) complete. Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 3 of 5 (IP Configure Start) started... Nov 21 13:05:07 localhost NetworkManager[2765]: (eth0): device state change: config -> ip-config (reason 'none') [50 70 0] Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Beginning DHCPv4 transaction (timeout in 45 seconds) Nov 21 13:05:07 localhost NetworkManager[2765]: dhclient started with pid 3622 Nov 21 13:05:07 localhost NetworkManager[2765]: Activation (eth0) Stage 3 of 5 (IP Configure Start) complete. Nov 21 13:05:07 localhost dhclient: Internet Systems Consortium DHCP Client 4.1.1-P1 Nov 21 13:05:07 localhost dhclient: Copyright 2004-2010 Internet Systems Consortium. Nov 21 13:05:07 localhost dhclient: All rights reserved. Nov 21 13:05:07 localhost dhclient: For info, please visit https://www.isc.org/software/dhcp/ Nov 21 13:05:07 localhost dhclient: Nov 21 13:05:07 localhost NetworkManager[2765]: (eth0): DHCPv4 state changed nbi -> preinit Nov 21 13:05:07 localhost dhclient: Listening on LPF/eth0/00:19:e3:40:27:db Nov 21 13:05:07 localhost dhclient: Sending on LPF/eth0/00:19:e3:40:27:db Nov 21 13:05:07 localhost dhclient: Sending on Socket/fallback Nov 21 13:05:07 localhost dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 3 Nov 21 13:05:10 localhost dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 6 Nov 21 13:05:10 localhost dhclient: DHCPOFFER of 137.158.60.69 from 137.158.60.65 Nov 21 13:05:10 localhost dhclient: DHCPREQUEST of 137.158.60.69 on eth0 to 255.255.255.255 port 67 Nov 21 13:05:10 localhost dhclient: DHCPACK of 137.158.60.69 from 137.158.60.65 Nov 21 13:05:10 localhost dhclient: bound to 137.158.60.69 -- renewal in 17395 seconds. Nov 21 13:05:10 localhost NetworkManager[2765]: (eth0): DHCPv4 state changed preinit -> bound Nov 21 13:05:10 localhost NetworkManager[2765]: Activation (eth0) Stage 4 of 5 (IP4 Configure Get) scheduled... Nov 21 13:05:10 localhost NetworkManager[2765]: Activation (eth0) Stage 4 of 5 (IP4 Configure Get) started... Nov 21 13:05:10 localhost NetworkManager[2765]: address 137.158.60.69 Nov 21 13:05:10 localhost NetworkManager[2765]: prefix 27 (255.255.255.224) Nov 21 13:05:10 localhost NetworkManager[2765]: gateway 137.158.60.65 Nov 21 13:05:10 localhost NetworkManager[2765]: hostname 'beethoven.cs.uct.ac.za' Nov 21 13:05:10 localhost NetworkManager[2765]: nameserver '137.158.152.240' Nov 21 13:05:10 localhost NetworkManager[2765]: nameserver '137.158.153.130' Nov 21 13:05:10 localhost NetworkManager[2765]: nameserver '137.158.153.146' Nov 21 13:05:10 localhost NetworkManager[2765]: domain name 'cs.uct.ac.za' Nov 21 13:05:10 localhost NetworkManager[2765]: wins '137.158.59.11' Nov 21 13:05:10 localhost NetworkManager[2765]: wins '137.158.59.7' Nov 21 13:05:10 localhost NetworkManager[2765]: Activation (eth0) Stage 5 of 5 (IP Configure Commit) started... Nov 21 13:05:10 localhost kernel: [222979.776060] wlan0: no IPv6 routers present Nov 21 13:05:11 localhost NetworkManager[2765]: Policy set 'Auto cs' (wlan0) as default for IPv4 routing and DNS. Nov 21 13:05:11 localhost NetworkManager[2765]: (eth0): device state change: ip-config -> activated (reason 'none') [70 100 0] Nov 21 13:05:11 localhost NetworkManager[2765]: Policy set 'Auto eth0' (eth0) as default for IPv4 routing and DNS. Nov 21 13:05:11 localhost NetworkManager[2765]: Activation (eth0) successful, device activated. Nov 21 13:05:11 localhost NetworkManager[2765]: Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete. Nov 21 13:05:11 localhost NetworkManager[2765]: Activation (eth0) Stage 4 of 5 (IP4 Configure Get) complete. Nov 21 13:05:11 localhost NetworkManager[2765]: SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/teredo, iface: teredo) Nov 21 13:05:11 localhost NetworkManager[2765]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/teredo, iface: teredo) Nov 21 13:05:11 localhost NetworkManager[2765]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/teredo, iface: teredo): no ifupdown configuration found. Nov 21 13:05:17 localhost kernel: [222986.832093] eth0: no IPv6 routers present Nov 21 13:05:20 localhost NetworkManager[2765]: (wlan0): IP6 addrconf timed out or failed. Nov 21 13:05:20 localhost NetworkManager[2765]: Activation (wlan0) Stage 4 of 5 (IP6 Configure Timeout) scheduled... Nov 21 13:05:20 localhost NetworkManager[2765]: Activation (wlan0) Stage 4 of 5 (IP6 Configure Timeout) started... Nov 21 13:05:20 localhost NetworkManager[2765]: Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started... Nov 21 13:05:20 localhost NetworkManager[2765]: Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete. Nov 21 13:05:20 localhost NetworkManager[2765]: Activation (wlan0) Stage 4 of 5 (IP6 Configure Timeout) complete. Nov 21 13:05:20 localhost kernel: [222990.264067] teredo: no IPv6 routers present Nov 21 13:23:45 localhost kernel: [224095.137842] Linux video capture interface: v2.00 Nov 21 13:23:45 localhost kernel: [224095.144629] usbcore: registered new interface driver uvcvideo Nov 21 13:23:45 localhost kernel: [224095.144633] USB Video Class driver (1.1.1) Nov 21 13:24:04 localhost kernel: [224114.370304] usbcore: deregistering interface driver uvcvideo Nov 21 13:25:42 localhost kernel: [224211.503853] hfs: write access to a journaled filesystem is not supported, use the force option at your own risk, mounting read-only. Nov 21 13:25:51 localhost kernel: [224221.348302] ift-extract[4893] trap int3 ip:7fcc9ad552c3 sp:7fff36a41ec0 error:0 Nov 21 13:26:10 localhost NetworkManager[2765]: kernel firmware directory '/lib/firmware' changed Nov 21 13:26:22 localhost kernel: [224251.446997] usbcore: registered new interface driver uvcvideo Nov 21 13:26:22 localhost kernel: [224251.447002] USB Video Class driver (1.1.1) Nov 21 13:26:52 localhost kernel: [224281.834714] usbcore: deregistering interface driver uvcvideo Nov 21 13:26:55 localhost kernel: [224284.414525] usbcore: deregistering interface driver isight_firmware Nov 21 13:27:02 localhost kernel: [224291.821600] usbcore: registered new interface driver isight_firmware Nov 21 13:27:02 localhost kernel: [224291.962019] usb 1-4: USB disconnect, device number 3 Nov 21 13:27:04 localhost kernel: [224293.724183] usb 1-4: new high speed USB device number 13 using ehci_hcd Nov 21 13:27:04 localhost kernel: [224293.969546] uvcvideo: Found UVC 1.00 device Built-in iSight (05ac:8501) Nov 21 13:27:04 localhost kernel: [224293.971904] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround. Nov 21 13:27:04 localhost kernel: [224293.972517] usbcore: registered new interface driver uvcvideo Nov 21 13:27:04 localhost kernel: [224293.972522] USB Video Class driver (1.1.1)