Sep 09 21:10:31 thinker kernel: CPU0 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys cpuset Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys cpu Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys cpuacct Sep 09 21:10:31 thinker kernel: Linux version 3.19.0-28-generic (buildd@lgw01-03) (gcc version 4.9.2 (Ubuntu 4.9.2-10ubuntu13) ) #30-Ubuntu SMP Mon Aug 31 15:52:51 UTC 2015 (Ubuntu 3.19.0-28.30-generic 3.19.8-ckt5) Sep 09 21:10:31 thinker kernel: Command line: BOOT_IMAGE=/boot/vmlinuz-3.19.0-28-generic root=UUID=6113f906-aaea-4e54-abf5-3722066a6a6d ro quiet splash Sep 09 21:10:31 thinker kernel: KERNEL supported cpus: Sep 09 21:10:31 thinker kernel: Intel GenuineIntel Sep 09 21:10:31 thinker kernel: AMD AuthenticAMD Sep 09 21:10:31 thinker kernel: Centaur CentaurHauls Sep 09 21:10:31 thinker kernel: Disabled fast string operations Sep 09 21:10:31 thinker kernel: e820: BIOS-provided physical RAM map: Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009d7ff] usable Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x000000000009d800-0x000000000009ffff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000ba99efff] usable Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000ba99f000-0x00000000bae9efff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000bae9f000-0x00000000baf9efff] ACPI NVS Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000baf9f000-0x00000000baffefff] ACPI data Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000bafff000-0x00000000baffffff] usable Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000bb000000-0x00000000bf9fffff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000f8000000-0x00000000fbffffff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000fed08000-0x00000000fed08fff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000fed10000-0x00000000fed19fff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x00000000ffd20000-0x00000000ffffffff] reserved Sep 09 21:10:31 thinker kernel: BIOS-e820: [mem 0x0000000100000000-0x000000033e5fffff] usable Sep 09 21:10:31 thinker kernel: NX (Execute Disable) protection: active Sep 09 21:10:31 thinker kernel: SMBIOS 2.6 present. Sep 09 21:10:31 thinker kernel: DMI: LENOVO 4239CTO/4239CTO, BIOS 8AET49WW (1.29 ) 07/11/2011 Sep 09 21:10:31 thinker kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 09 21:10:31 thinker kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 09 21:10:31 thinker kernel: AGP: No AGP bridge found Sep 09 21:10:31 thinker kernel: e820: last_pfn = 0x33e600 max_arch_pfn = 0x400000000 Sep 09 21:10:31 thinker kernel: MTRR default type: uncachable Sep 09 21:10:31 thinker kernel: MTRR fixed ranges enabled: Sep 09 21:10:31 thinker kernel: 00000-9FFFF write-back Sep 09 21:10:31 thinker kernel: A0000-BFFFF uncachable Sep 09 21:10:31 thinker kernel: C0000-FFFFF write-protect Sep 09 21:10:31 thinker kernel: MTRR variable ranges enabled: Sep 09 21:10:31 thinker kernel: 0 base 000000000 mask F80000000 write-back Sep 09 21:10:31 thinker kernel: 1 base 080000000 mask FC0000000 write-back Sep 09 21:10:31 thinker kernel: 2 base 0BC000000 mask FFC000000 uncachable Sep 09 21:10:31 thinker kernel: 3 base 0BB000000 mask FFF000000 uncachable Sep 09 21:10:31 thinker kernel: 4 base 100000000 mask F00000000 write-back Sep 09 21:10:31 thinker kernel: 5 base 200000000 mask F00000000 write-back Sep 09 21:10:31 thinker kernel: 6 base 300000000 mask FC0000000 write-back Sep 09 21:10:31 thinker kernel: 7 base 33F000000 mask FFF000000 uncachable Sep 09 21:10:31 thinker kernel: 8 base 33E800000 mask FFF800000 uncachable Sep 09 21:10:31 thinker kernel: 9 base 33E600000 mask FFFE00000 uncachable Sep 09 21:10:31 thinker kernel: PAT configuration [0-7]: WB WC UC- UC WB WC UC- UC Sep 09 21:10:31 thinker kernel: original variable MTRRs Sep 09 21:10:31 thinker kernel: reg 0, base: 0GB, range: 2GB, type WB Sep 09 21:10:31 thinker kernel: reg 1, base: 2GB, range: 1GB, type WB Sep 09 21:10:31 thinker kernel: reg 2, base: 3008MB, range: 64MB, type UC Sep 09 21:10:31 thinker kernel: reg 3, base: 2992MB, range: 16MB, type UC Sep 09 21:10:31 thinker kernel: reg 4, base: 4GB, range: 4GB, type WB Sep 09 21:10:31 thinker kernel: reg 5, base: 8GB, range: 4GB, type WB Sep 09 21:10:31 thinker kernel: reg 6, base: 12GB, range: 1GB, type WB Sep 09 21:10:31 thinker kernel: reg 7, base: 13296MB, range: 16MB, type UC Sep 09 21:10:31 thinker kernel: reg 8, base: 13288MB, range: 8MB, type UC Sep 09 21:10:31 thinker kernel: reg 9, base: 13286MB, range: 2MB, type UC Sep 09 21:10:31 thinker kernel: total RAM covered: 12182M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 64K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 128K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 256K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 512K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 1M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 2M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 4M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 8M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 16M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 64K chunk_size: 32M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 64K chunk_size: 64M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 128M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 256M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 512M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 64K chunk_size: 1G num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 64K chunk_size: 2G num_reg: 10 lose cover RAM: -1G Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 128K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 256K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 512K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 1M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 2M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 4M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 8M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 16M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 128K chunk_size: 32M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 128K chunk_size: 64M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 128M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 256M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 512M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 128K chunk_size: 1G num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 128K chunk_size: 2G num_reg: 10 lose cover RAM: -1G Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 256K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 512K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 1M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 2M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 4M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 8M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 16M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 256K chunk_size: 32M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 256K chunk_size: 64M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 128M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 256M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 512M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 256K chunk_size: 1G num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 256K chunk_size: 2G num_reg: 10 lose cover RAM: -1G Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 512K num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 1M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 2M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 4M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 8M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 16M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 512K chunk_size: 32M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 512K chunk_size: 64M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 128M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 256M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 512M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 512K chunk_size: 1G num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 512K chunk_size: 2G num_reg: 10 lose cover RAM: -1G Sep 09 21:10:31 thinker kernel: gran_size: 1M chunk_size: 1M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 1M chunk_size: 2M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 1M chunk_size: 4M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 1M chunk_size: 8M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 1M chunk_size: 16M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 1M chunk_size: 32M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 1M chunk_size: 64M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: gran_size: 1M chunk_size: 128M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 1M chunk_size: 256M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 1M chunk_size: 512M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 1M chunk_size: 1G num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 1M chunk_size: 2G num_reg: 10 lose cover RAM: -1G Sep 09 21:10:31 thinker kernel: gran_size: 2M chunk_size: 2M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 2M chunk_size: 4M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 2M chunk_size: 8M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 2M chunk_size: 16M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 2M chunk_size: 32M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 2M chunk_size: 64M num_reg: 10 lose cover RAM: -24M Sep 09 21:10:31 thinker kernel: gran_size: 2M chunk_size: 128M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 2M chunk_size: 256M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 2M chunk_size: 512M num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: gran_size: 2M chunk_size: 1G num_reg: 10 lose cover RAM: 0G Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 2M chunk_size: 2G num_reg: 10 lose cover RAM: -1G Sep 09 21:10:31 thinker kernel: gran_size: 4M chunk_size: 4M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 4M chunk_size: 8M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 4M chunk_size: 16M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 4M chunk_size: 32M num_reg: 10 lose cover RAM: -22M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 4M chunk_size: 64M num_reg: 10 lose cover RAM: -22M Sep 09 21:10:31 thinker kernel: gran_size: 4M chunk_size: 128M num_reg: 10 lose cover RAM: 2M Sep 09 21:10:31 thinker kernel: gran_size: 4M chunk_size: 256M num_reg: 10 lose cover RAM: 2M Sep 09 21:10:31 thinker kernel: gran_size: 4M chunk_size: 512M num_reg: 10 lose cover RAM: 2M Sep 09 21:10:31 thinker kernel: gran_size: 4M chunk_size: 1G num_reg: 10 lose cover RAM: 2M Sep 09 21:10:31 thinker kernel: *BAD*gran_size: 4M chunk_size: 2G num_reg: 10 lose cover RAM: -1022M Sep 09 21:10:31 thinker kernel: gran_size: 8M chunk_size: 8M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 8M chunk_size: 16M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 8M chunk_size: 32M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 8M chunk_size: 64M num_reg: 10 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 8M chunk_size: 128M num_reg: 8 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 8M chunk_size: 256M num_reg: 8 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 8M chunk_size: 512M num_reg: 8 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 8M chunk_size: 1G num_reg: 8 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 8M chunk_size: 2G num_reg: 9 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 16M chunk_size: 16M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 16M chunk_size: 32M num_reg: 10 lose cover RAM: 230M Sep 09 21:10:31 thinker kernel: gran_size: 16M chunk_size: 64M num_reg: 10 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 16M chunk_size: 128M num_reg: 8 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 16M chunk_size: 256M num_reg: 8 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 16M chunk_size: 512M num_reg: 8 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 16M chunk_size: 1G num_reg: 8 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 16M chunk_size: 2G num_reg: 9 lose cover RAM: 6M Sep 09 21:10:31 thinker kernel: gran_size: 32M chunk_size: 32M num_reg: 10 lose cover RAM: 118M Sep 09 21:10:31 thinker kernel: gran_size: 32M chunk_size: 64M num_reg: 10 lose cover RAM: 22M Sep 09 21:10:31 thinker kernel: gran_size: 32M chunk_size: 128M num_reg: 8 lose cover RAM: 22M Sep 09 21:10:31 thinker kernel: gran_size: 32M chunk_size: 256M num_reg: 8 lose cover RAM: 22M Sep 09 21:10:31 thinker kernel: gran_size: 32M chunk_size: 512M num_reg: 8 lose cover RAM: 22M Sep 09 21:10:31 thinker kernel: gran_size: 32M chunk_size: 1G num_reg: 8 lose cover RAM: 22M Sep 09 21:10:31 thinker kernel: gran_size: 32M chunk_size: 2G num_reg: 9 lose cover RAM: 22M Sep 09 21:10:31 thinker kernel: gran_size: 64M chunk_size: 64M num_reg: 10 lose cover RAM: 86M Sep 09 21:10:31 thinker kernel: gran_size: 64M chunk_size: 128M num_reg: 8 lose cover RAM: 86M Sep 09 21:10:31 thinker kernel: gran_size: 64M chunk_size: 256M num_reg: 7 lose cover RAM: 86M Sep 09 21:10:31 thinker kernel: gran_size: 64M chunk_size: 512M num_reg: 7 lose cover RAM: 86M Sep 09 21:10:31 thinker kernel: gran_size: 64M chunk_size: 1G num_reg: 7 lose cover RAM: 86M Sep 09 21:10:31 thinker kernel: gran_size: 64M chunk_size: 2G num_reg: 8 lose cover RAM: 86M Sep 09 21:10:31 thinker kernel: gran_size: 128M chunk_size: 128M num_reg: 9 lose cover RAM: 150M Sep 09 21:10:31 thinker kernel: gran_size: 128M chunk_size: 256M num_reg: 7 lose cover RAM: 150M Sep 09 21:10:31 thinker kernel: gran_size: 128M chunk_size: 512M num_reg: 7 lose cover RAM: 150M Sep 09 21:10:31 thinker kernel: gran_size: 128M chunk_size: 1G num_reg: 7 lose cover RAM: 150M Sep 09 21:10:31 thinker kernel: gran_size: 128M chunk_size: 2G num_reg: 8 lose cover RAM: 150M Sep 09 21:10:31 thinker kernel: gran_size: 256M chunk_size: 256M num_reg: 7 lose cover RAM: 406M Sep 09 21:10:31 thinker kernel: gran_size: 256M chunk_size: 512M num_reg: 7 lose cover RAM: 406M Sep 09 21:10:31 thinker kernel: gran_size: 256M chunk_size: 1G num_reg: 7 lose cover RAM: 406M Sep 09 21:10:31 thinker kernel: gran_size: 256M chunk_size: 2G num_reg: 8 lose cover RAM: 406M Sep 09 21:10:31 thinker kernel: gran_size: 512M chunk_size: 512M num_reg: 5 lose cover RAM: 918M Sep 09 21:10:31 thinker kernel: gran_size: 512M chunk_size: 1G num_reg: 7 lose cover RAM: 918M Sep 09 21:10:31 thinker kernel: gran_size: 512M chunk_size: 2G num_reg: 8 lose cover RAM: 918M Sep 09 21:10:31 thinker kernel: gran_size: 1G chunk_size: 1G num_reg: 3 lose cover RAM: 1942M Sep 09 21:10:31 thinker kernel: gran_size: 1G chunk_size: 2G num_reg: 3 lose cover RAM: 1942M Sep 09 21:10:31 thinker kernel: gran_size: 2G chunk_size: 2G num_reg: 3 lose cover RAM: 1942M Sep 09 21:10:31 thinker kernel: mtrr_cleanup: can not find optimal value Sep 09 21:10:31 thinker kernel: please specify mtrr_gran_size/mtrr_chunk_size Sep 09 21:10:31 thinker kernel: e820: update [mem 0xbb000000-0xffffffff] usable ==> reserved Sep 09 21:10:31 thinker kernel: e820: last_pfn = 0xbb000 max_arch_pfn = 0x400000000 Sep 09 21:10:31 thinker kernel: Scanning 1 areas for low memory corruption Sep 09 21:10:31 thinker kernel: Base memory trampoline at [ffff880000097000] 97000 size 24576 Sep 09 21:10:31 thinker kernel: reserving inaccessible SNB gfx pages Sep 09 21:10:31 thinker kernel: init_memory_mapping: [mem 0x00000000-0x000fffff] Sep 09 21:10:31 thinker kernel: [mem 0x00000000-0x000fffff] page 4k Sep 09 21:10:31 thinker kernel: BRK [0x01fe5000, 0x01fe5fff] PGTABLE Sep 09 21:10:31 thinker kernel: BRK [0x01fe6000, 0x01fe6fff] PGTABLE Sep 09 21:10:31 thinker kernel: BRK [0x01fe7000, 0x01fe7fff] PGTABLE Sep 09 21:10:31 thinker kernel: init_memory_mapping: [mem 0x33e400000-0x33e5fffff] Sep 09 21:10:31 thinker kernel: [mem 0x33e400000-0x33e5fffff] page 2M Sep 09 21:10:31 thinker kernel: BRK [0x01fe8000, 0x01fe8fff] PGTABLE Sep 09 21:10:31 thinker kernel: init_memory_mapping: [mem 0x320000000-0x33e3fffff] Sep 09 21:10:31 thinker kernel: [mem 0x320000000-0x33e3fffff] page 2M Sep 09 21:10:31 thinker kernel: init_memory_mapping: [mem 0x300000000-0x31fffffff] Sep 09 21:10:31 thinker kernel: [mem 0x300000000-0x31fffffff] page 2M Sep 09 21:10:31 thinker kernel: init_memory_mapping: [mem 0x00100000-0xba99efff] Sep 09 21:10:31 thinker kernel: [mem 0x00100000-0x001fffff] page 4k Sep 09 21:10:31 thinker kernel: [mem 0x00200000-0xba7fffff] page 2M Sep 09 21:10:31 thinker kernel: [mem 0xba800000-0xba99efff] page 4k Sep 09 21:10:31 thinker kernel: init_memory_mapping: [mem 0xbafff000-0xbaffffff] Sep 09 21:10:31 thinker kernel: [mem 0xbafff000-0xbaffffff] page 4k Sep 09 21:10:31 thinker kernel: BRK [0x01fe9000, 0x01fe9fff] PGTABLE Sep 09 21:10:31 thinker kernel: init_memory_mapping: [mem 0x100000000-0x2ffffffff] Sep 09 21:10:31 thinker kernel: [mem 0x100000000-0x2ffffffff] page 2M Sep 09 21:10:31 thinker kernel: BRK [0x01fea000, 0x01feafff] PGTABLE Sep 09 21:10:31 thinker kernel: RAMDISK: [mem 0x35816000-0x36c02fff] Sep 09 21:10:31 thinker kernel: ACPI: Early table checksum verification disabled Sep 09 21:10:31 thinker kernel: ACPI: RSDP 0x00000000000F00E0 000024 (v02 LENOVO) Sep 09 21:10:31 thinker kernel: ACPI: XSDT 0x00000000BAFFE120 0000AC (v01 LENOVO TP-8A 00001290 PTEC 00000002) Sep 09 21:10:31 thinker kernel: ACPI: FACP 0x00000000BAFE9000 0000F4 (v04 LENOVO TP-8A 00001290 PTL 00000002) Sep 09 21:10:31 thinker kernel: ACPI: DSDT 0x00000000BAFEC000 00DFE6 (v01 LENOVO TP-8A 00001290 INTL 20061109) Sep 09 21:10:31 thinker kernel: ACPI: FACS 0x00000000BAF2D000 000040 Sep 09 21:10:31 thinker kernel: ACPI: FACS 0x00000000BAF2D000 000040 Sep 09 21:10:31 thinker kernel: ACPI: SLIC 0x00000000BAFFD000 000176 (v01 LENOVO TP-8A 00001290 PTEC 00000001) Sep 09 21:10:31 thinker kernel: ACPI: SSDT 0x00000000BAFFC000 000249 (v01 LENOVO TP-SSDT2 00000200 INTL 20061109) Sep 09 21:10:31 thinker kernel: ACPI: SSDT 0x00000000BAFFB000 000033 (v01 LENOVO TP-SSDT1 00000100 INTL 20061109) Sep 09 21:10:31 thinker kernel: ACPI: SSDT 0x00000000BAFFA000 000797 (v01 LENOVO SataAhci 00001000 INTL 20061109) Sep 09 21:10:31 thinker kernel: ACPI: HPET 0x00000000BAFE8000 000038 (v01 LENOVO TP-8A 00001290 PTL 00000002) Sep 09 21:10:31 thinker kernel: ACPI: APIC 0x00000000BAFE7000 000098 (v01 LENOVO TP-8A 00001290 PTL 00000002) Sep 09 21:10:31 thinker kernel: ACPI: MCFG 0x00000000BAFE6000 00003C (v01 LENOVO TP-8A 00001290 PTL 00000002) Sep 09 21:10:31 thinker kernel: ACPI: ECDT 0x00000000BAFE5000 000052 (v01 LENOVO TP-8A 00001290 PTL 00000002) Sep 09 21:10:31 thinker kernel: ACPI: ASF! 0x00000000BAFEB000 0000A5 (v32 LENOVO TP-8A 00001290 PTL 00000002) Sep 09 21:10:31 thinker kernel: ACPI: TCPA 0x00000000BAFE4000 000032 (v02 PTL LENOVO 06040000 LNVO 00000001) Sep 09 21:10:31 thinker kernel: ACPI: SSDT 0x00000000BAFE3000 000B71 (v01 PmRef Cpu0Ist 00003000 INTL 20061109) Sep 09 21:10:31 thinker kernel: ACPI: SSDT 0x00000000BAFE2000 000996 (v01 PmRef CpuPm 00003000 INTL 20061109) Sep 09 21:10:31 thinker kernel: ACPI: DMAR 0x00000000BAFE1000 0000E8 (v01 INTEL SNB 00000001 INTL 00000001) Sep 09 21:10:31 thinker kernel: ACPI: UEFI 0x00000000BAFE0000 00003E (v01 LENOVO TP-8A 00001290 PTL 00000002) Sep 09 21:10:31 thinker kernel: ACPI: UEFI 0x00000000BAFDF000 000042 (v01 PTL COMBUF 00000001 PTL 00000001) Sep 09 21:10:31 thinker kernel: ACPI: UEFI 0x00000000BAFDE000 00027E (v01 LENOVO TP-8A 00001290 PTL 00000002) Sep 09 21:10:31 thinker kernel: ACPI: Local APIC address 0xfee00000 Sep 09 21:10:31 thinker kernel: No NUMA configuration found Sep 09 21:10:31 thinker kernel: Faking a node at [mem 0x0000000000000000-0x000000033e5fffff] Sep 09 21:10:31 thinker kernel: NODE_DATA(0) allocated [mem 0x33e5f1000-0x33e5f5fff] Sep 09 21:10:31 thinker kernel: [ffffea0000000000-ffffea000cffffff] PMD -> [ffff880331c00000-ffff88033dbfffff] on node 0 Sep 09 21:10:31 thinker kernel: Zone ranges: Sep 09 21:10:31 thinker kernel: DMA [mem 0x00001000-0x00ffffff] Sep 09 21:10:31 thinker kernel: DMA32 [mem 0x01000000-0xffffffff] Sep 09 21:10:31 thinker kernel: Normal [mem 0x100000000-0x33e5fffff] Sep 09 21:10:31 thinker kernel: Movable zone start for each node Sep 09 21:10:31 thinker kernel: Early memory node ranges Sep 09 21:10:31 thinker kernel: node 0: [mem 0x00001000-0x0009cfff] Sep 09 21:10:31 thinker kernel: node 0: [mem 0x00100000-0xba99efff] Sep 09 21:10:31 thinker kernel: node 0: [mem 0xbafff000-0xbaffffff] Sep 09 21:10:31 thinker kernel: node 0: [mem 0x100000000-0x33e5fffff] Sep 09 21:10:31 thinker kernel: Initmem setup node 0 [mem 0x00001000-0x33e5fffff] Sep 09 21:10:31 thinker kernel: On node 0 totalpages: 3116860 Sep 09 21:10:31 thinker kernel: DMA zone: 64 pages used for memmap Sep 09 21:10:31 thinker kernel: DMA zone: 156 pages reserved Sep 09 21:10:31 thinker kernel: DMA zone: 3996 pages, LIFO batch:0 Sep 09 21:10:31 thinker kernel: DMA32 zone: 11879 pages used for memmap Sep 09 21:10:31 thinker kernel: DMA32 zone: 760224 pages, LIFO batch:31 Sep 09 21:10:31 thinker kernel: Normal zone: 36760 pages used for memmap Sep 09 21:10:31 thinker kernel: Normal zone: 2352640 pages, LIFO batch:31 Sep 09 21:10:31 thinker kernel: Reserving Intel graphics stolen memory at 0xbba00000-0xbf9fffff Sep 09 21:10:31 thinker kernel: ACPI: PM-Timer IO Port: 0x408 Sep 09 21:10:31 thinker kernel: ACPI: Local APIC address 0xfee00000 Sep 09 21:10:31 thinker kernel: ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled) Sep 09 21:10:31 thinker kernel: ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled) Sep 09 21:10:31 thinker kernel: ACPI: LAPIC (acpi_id[0x03] lapic_id[0x02] enabled) Sep 09 21:10:31 thinker kernel: ACPI: LAPIC (acpi_id[0x04] lapic_id[0x03] enabled) Sep 09 21:10:31 thinker kernel: ACPI: LAPIC (acpi_id[0x05] lapic_id[0x04] enabled) Sep 09 21:10:31 thinker kernel: ACPI: LAPIC (acpi_id[0x06] lapic_id[0x05] enabled) Sep 09 21:10:31 thinker kernel: ACPI: LAPIC (acpi_id[0x07] lapic_id[0x06] enabled) Sep 09 21:10:31 thinker kernel: ACPI: LAPIC (acpi_id[0x08] lapic_id[0x07] enabled) Sep 09 21:10:31 thinker kernel: ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1]) Sep 09 21:10:31 thinker kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1]) Sep 09 21:10:31 thinker kernel: ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0]) Sep 09 21:10:31 thinker kernel: IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23 Sep 09 21:10:31 thinker kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Sep 09 21:10:31 thinker kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 09 21:10:31 thinker kernel: ACPI: IRQ0 used by override. Sep 09 21:10:31 thinker kernel: ACPI: IRQ9 used by override. Sep 09 21:10:31 thinker kernel: Using ACPI (MADT) for SMP configuration information Sep 09 21:10:31 thinker kernel: ACPI: HPET id: 0x8086a301 base: 0xfed00000 Sep 09 21:10:31 thinker kernel: smpboot: Allowing 8 CPUs, 0 hotplug CPUs Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0x00000000-0x00000fff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0x0009d000-0x0009dfff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0x0009e000-0x0009ffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0x000a0000-0x000dffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0x000e0000-0x000fffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xba99f000-0xbae9efff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xbae9f000-0xbaf9efff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xbaf9f000-0xbaffefff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xbb000000-0xbf9fffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xbfa00000-0xf7ffffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xf8000000-0xfbffffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfc000000-0xfebfffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfec00000-0xfec00fff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfec01000-0xfed07fff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfed08000-0xfed08fff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfed09000-0xfed0ffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfed10000-0xfed19fff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfed1a000-0xfed1bfff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfed1c000-0xfed1ffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfed20000-0xfedfffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfee00000-0xfee00fff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xfee01000-0xffd1ffff] Sep 09 21:10:31 thinker kernel: PM: Registered nosave memory: [mem 0xffd20000-0xffffffff] Sep 09 21:10:31 thinker kernel: e820: [mem 0xbfa00000-0xf7ffffff] available for PCI devices Sep 09 21:10:31 thinker kernel: Booting paravirtualized kernel on bare hardware Sep 09 21:10:31 thinker kernel: setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:8 nr_node_ids:1 Sep 09 21:10:31 thinker kernel: PERCPU: Embedded 31 pages/cpu @ffff88033e200000 s87104 r8192 d31680 u262144 Sep 09 21:10:31 thinker kernel: pcpu-alloc: s87104 r8192 d31680 u262144 alloc=1*2097152 Sep 09 21:10:31 thinker kernel: pcpu-alloc: [0] 0 1 2 3 4 5 6 7 Sep 09 21:10:31 thinker kernel: Built 1 zonelists in Node order, mobility grouping on. Total pages: 3068001 Sep 09 21:10:31 thinker kernel: Policy zone: Normal Sep 09 21:10:31 thinker kernel: Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.19.0-28-generic root=UUID=6113f906-aaea-4e54-abf5-3722066a6a6d ro quiet splash Sep 09 21:10:31 thinker kernel: PID hash table entries: 4096 (order: 3, 32768 bytes) Sep 09 21:10:31 thinker kernel: xsave: enabled xstate_bv 0x7, cntxt size 0x340 using standard form Sep 09 21:10:31 thinker kernel: AGP: Checking aperture... Sep 09 21:10:31 thinker kernel: AGP: No AGP bridge found Sep 09 21:10:31 thinker kernel: Calgary: detecting Calgary via BIOS EBDA area Sep 09 21:10:31 thinker kernel: Calgary: Unable to locate Rio Grande table in EBDA - bailing! Sep 09 21:10:31 thinker kernel: Memory: 12166128K/12467440K available (8002K kernel code, 1234K rwdata, 3764K rodata, 1408K init, 1300K bss, 301312K reserved, 0K cma-reserved) Sep 09 21:10:31 thinker kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1 Sep 09 21:10:31 thinker kernel: Hierarchical RCU implementation. Sep 09 21:10:31 thinker kernel: RCU dyntick-idle grace-period acceleration is enabled. Sep 09 21:10:31 thinker kernel: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=8. Sep 09 21:10:31 thinker kernel: RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8 Sep 09 21:10:31 thinker kernel: NR_IRQS:16640 nr_irqs:488 16 Sep 09 21:10:31 thinker kernel: Offload RCU callbacks from all CPUs Sep 09 21:10:31 thinker kernel: Offload RCU callbacks from CPUs: 0-7. Sep 09 21:10:31 thinker kernel: Console: colour VGA+ 80x25 Sep 09 21:10:31 thinker kernel: console [tty0] enabled Sep 09 21:10:31 thinker kernel: hpet clockevent registered Sep 09 21:10:31 thinker kernel: tsc: Fast TSC calibration using PIT Sep 09 21:10:31 thinker kernel: tsc: Detected 2193.025 MHz processor Sep 09 21:10:31 thinker kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4386.05 BogoMIPS (lpj=8772100) Sep 09 21:10:31 thinker kernel: pid_max: default: 32768 minimum: 301 Sep 09 21:10:31 thinker kernel: ACPI: Core revision 20141107 Sep 09 21:10:31 thinker kernel: ACPI: All ACPI Tables successfully acquired Sep 09 21:10:31 thinker kernel: Security Framework initialized Sep 09 21:10:31 thinker kernel: AppArmor: AppArmor initialized Sep 09 21:10:31 thinker kernel: Yama: becoming mindful. Sep 09 21:10:31 thinker kernel: Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes) Sep 09 21:10:31 thinker kernel: Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes) Sep 09 21:10:31 thinker kernel: Mount-cache hash table entries: 32768 (order: 6, 262144 bytes) Sep 09 21:10:31 thinker kernel: Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes) Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys memory Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys devices Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys freezer Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys net_cls Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys blkio Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys perf_event Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys net_prio Sep 09 21:10:31 thinker kernel: Initializing cgroup subsys hugetlb Sep 09 21:10:31 thinker kernel: Disabled fast string operations Sep 09 21:10:31 thinker kernel: CPU: Physical Processor ID: 0 Sep 09 21:10:31 thinker kernel: CPU: Processor Core ID: 0 Sep 09 21:10:31 thinker kernel: ENERGY_PERF_BIAS: Set to 'normal', was 'performance' Sep 09 21:10:31 thinker kernel: mce: CPU supports 9 MCE banks Sep 09 21:10:31 thinker kernel: CPU0: Thermal monitoring enabled (TM1) Sep 09 21:10:31 thinker kernel: process: using mwait in idle threads Sep 09 21:10:31 thinker kernel: Last level iTLB entries: 4KB 512, 2MB 8, 4MB 8 Sep 09 21:10:31 thinker kernel: Freeing SMP alternatives memory: 32K (ffffffff81e96000 - ffffffff81e9e000) Sep 09 21:10:31 thinker kernel: ftrace: allocating 30112 entries in 118 pages Sep 09 21:10:31 thinker kernel: dmar: Host address width 36 Sep 09 21:10:31 thinker kernel: dmar: DRHD base: 0x000000fed90000 flags: 0x0 Sep 09 21:10:31 thinker kernel: dmar: IOMMU 0: reg_base_addr fed90000 ver 1:0 cap c0000020e60262 ecap f0101a Sep 09 21:10:31 thinker kernel: dmar: DRHD base: 0x000000fed91000 flags: 0x1 Sep 09 21:10:31 thinker kernel: dmar: IOMMU 1: reg_base_addr fed91000 ver 1:0 cap c9008020660262 ecap f0105a Sep 09 21:10:31 thinker kernel: dmar: RMRR base: 0x000000bacd5000 end: 0x000000bacebfff Sep 09 21:10:31 thinker kernel: dmar: RMRR base: 0x000000bb800000 end: 0x000000bf9fffff Sep 09 21:10:31 thinker kernel: IOAPIC id 2 under DRHD base 0xfed91000 IOMMU 1 Sep 09 21:10:31 thinker kernel: HPET id 0 under DRHD base 0xfed91000 Sep 09 21:10:31 thinker kernel: Queued invalidation will be enabled to support x2apic and Intr-remapping. Sep 09 21:10:31 thinker kernel: Enabled IRQ remapping in x2apic mode Sep 09 21:10:31 thinker kernel: Enabling x2apic Sep 09 21:10:31 thinker kernel: Enabled x2apic Sep 09 21:10:31 thinker kernel: Switched APIC routing to cluster x2apic. Sep 09 21:10:31 thinker kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Sep 09 21:10:31 thinker kernel: smpboot: CPU0: Intel(R) Core(TM) i7-2720QM CPU @ 2.20GHz (fam: 06, model: 2a, stepping: 07) Sep 09 21:10:31 thinker kernel: TSC deadline timer enabled Sep 09 21:10:31 thinker kernel: Performance Events: PEBS fmt1+, 16-deep LBR, SandyBridge events, full-width counters, Intel PMU driver. Sep 09 21:10:31 thinker kernel: ... version: 3 Sep 09 21:10:31 thinker kernel: ... bit width: 48 Sep 09 21:10:31 thinker kernel: ... generic registers: 4 Sep 09 21:10:31 thinker kernel: ... value mask: 0000ffffffffffff Sep 09 21:10:31 thinker kernel: ... max period: 0000ffffffffffff Sep 09 21:10:31 thinker kernel: ... fixed-purpose events: 3 Sep 09 21:10:31 thinker kernel: ... event mask: 000000070000000f Sep 09 21:10:31 thinker kernel: x86: Booting SMP configuration: Sep 09 21:10:31 thinker kernel: .... node #0, CPUs: #1 Sep 09 21:10:31 thinker kernel: Disabled fast string operations Sep 09 21:10:31 thinker kernel: NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter. Sep 09 21:10:31 thinker kernel: #2 Sep 09 21:10:31 thinker kernel: CPU2 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:10:31 thinker kernel: Disabled fast string operations Sep 09 21:10:31 thinker kernel: #3 Sep 09 21:10:31 thinker kernel: Disabled fast string operations Sep 09 21:10:31 thinker kernel: #4 Sep 09 21:10:31 thinker kernel: CPU4 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:10:31 thinker kernel: Disabled fast string operations Sep 09 21:10:31 thinker kernel: #5 Sep 09 21:10:31 thinker kernel: Disabled fast string operations Sep 09 21:10:31 thinker kernel: #6 Sep 09 21:10:31 thinker kernel: CPU6 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:10:31 thinker kernel: Disabled fast string operations Sep 09 21:10:31 thinker kernel: #7 Sep 09 21:10:31 thinker kernel: Disabled fast string operations Sep 09 21:10:31 thinker kernel: x86: Booted up 1 node, 8 CPUs Sep 09 21:10:31 thinker kernel: smpboot: Total of 8 processors activated (35088.40 BogoMIPS) Sep 09 21:10:31 thinker kernel: devtmpfs: initialized Sep 09 21:10:31 thinker kernel: evm: security.selinux Sep 09 21:10:31 thinker kernel: evm: security.SMACK64 Sep 09 21:10:31 thinker kernel: evm: security.SMACK64EXEC Sep 09 21:10:31 thinker kernel: evm: security.SMACK64TRANSMUTE Sep 09 21:10:31 thinker kernel: evm: security.SMACK64MMAP Sep 09 21:10:31 thinker kernel: evm: security.ima Sep 09 21:10:31 thinker kernel: evm: security.capability Sep 09 21:10:31 thinker kernel: PM: Registering ACPI NVS region [mem 0xbae9f000-0xbaf9efff] (1048576 bytes) Sep 09 21:10:31 thinker kernel: pinctrl core: initialized pinctrl subsystem Sep 09 21:10:31 thinker kernel: RTC time: 21:10:17, date: 09/09/15 Sep 09 21:10:31 thinker kernel: NET: Registered protocol family 16 Sep 09 21:10:31 thinker kernel: cpuidle: using governor ladder Sep 09 21:10:31 thinker kernel: cpuidle: using governor menu Sep 09 21:10:31 thinker kernel: ACPI FADT declares the system doesn't support PCIe ASPM, so disable it Sep 09 21:10:31 thinker kernel: ACPI: bus type PCI registered Sep 09 21:10:31 thinker kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 09 21:10:31 thinker kernel: PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xf8000000-0xfbffffff] (base 0xf8000000) Sep 09 21:10:31 thinker kernel: PCI: MMCONFIG at [mem 0xf8000000-0xfbffffff] reserved in E820 Sep 09 21:10:31 thinker kernel: PCI: Using configuration type 1 for base access Sep 09 21:10:31 thinker kernel: ACPI: Added _OSI(Module Device) Sep 09 21:10:31 thinker kernel: ACPI: Added _OSI(Processor Device) Sep 09 21:10:31 thinker kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Sep 09 21:10:31 thinker kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 09 21:10:31 thinker kernel: ACPI : EC: EC description table is found, configuring boot EC Sep 09 21:10:31 thinker kernel: [Firmware Bug]: ACPI: BIOS _OSI(Linux) query ignored Sep 09 21:10:31 thinker kernel: ACPI: Dynamic OEM Table Load: Sep 09 21:10:31 thinker kernel: ACPI: SSDT 0xFFFF88032F5F1000 0008C0 (v01 PmRef Cpu0Cst 00003001 INTL 20061109) Sep 09 21:10:31 thinker kernel: ACPI: Dynamic OEM Table Load: Sep 09 21:10:31 thinker kernel: ACPI: SSDT 0xFFFF88032F53D000 000303 (v01 PmRef ApIst 00003000 INTL 20061109) Sep 09 21:10:31 thinker kernel: ACPI: Dynamic OEM Table Load: Sep 09 21:10:31 thinker kernel: ACPI: SSDT 0xFFFF88032F527600 000119 (v01 PmRef ApCst 00003000 INTL 20061109) Sep 09 21:10:31 thinker kernel: ACPI: Interpreter enabled Sep 09 21:10:31 thinker kernel: ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20141107/hwxface-580) Sep 09 21:10:31 thinker kernel: ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20141107/hwxface-580) Sep 09 21:10:31 thinker kernel: ACPI: (supports S0 S3 S4 S5) Sep 09 21:10:31 thinker kernel: ACPI: Using IOAPIC for interrupt routing Sep 09 21:10:31 thinker kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 09 21:10:31 thinker kernel: ACPI: Power Resource [PUBS] (on) Sep 09 21:10:31 thinker kernel: acpi PNP0C0A:01: ACPI dock station (docks/bays count: 1) Sep 09 21:10:31 thinker kernel: acpi LNXIOBAY:00: ACPI dock station (docks/bays count: 2) Sep 09 21:10:31 thinker kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 9 10 *11) Sep 09 21:10:31 thinker kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 *7 9 10 11) Sep 09 21:10:31 thinker kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 9 10 *11) Sep 09 21:10:31 thinker kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 10 *11) Sep 09 21:10:31 thinker kernel: ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 9 *10 11) Sep 09 21:10:31 thinker kernel: ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 9 10 11) *0, disabled. Sep 09 21:10:31 thinker kernel: ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 *7 9 10 11) Sep 09 21:10:31 thinker kernel: ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 9 *10 11) Sep 09 21:10:31 thinker kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-fe]) Sep 09 21:10:31 thinker kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI] Sep 09 21:10:31 thinker kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeCapability] Sep 09 21:10:31 thinker kernel: acpi PNP0A08:00: _OSC: not requesting control; platform does not support [PCIeCapability] Sep 09 21:10:31 thinker kernel: acpi PNP0A08:00: _OSC: OS requested [PCIeHotplug PME AER PCIeCapability] Sep 09 21:10:31 thinker kernel: acpi PNP0A08:00: _OSC: platform willing to grant [PCIeHotplug PME AER] Sep 09 21:10:31 thinker kernel: acpi PNP0A08:00: _OSC failed (AE_SUPPORT); disabling ASPM Sep 09 21:10:31 thinker kernel: acpi PNP0A08:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge Sep 09 21:10:31 thinker kernel: PCI host bridge to bus 0000:00 Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: root bus resource [bus 00-fe] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: root bus resource [mem 0xbfa00000-0xfebfffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: root bus resource [mem 0xfed40000-0xfed4bfff] Sep 09 21:10:31 thinker kernel: pci 0000:00:00.0: [8086:0104] type 00 class 0x060000 Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: [8086:0101] type 01 class 0x060400 Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:02.0: [8086:0126] type 00 class 0x030000 Sep 09 21:10:31 thinker kernel: pci 0000:00:02.0: reg 0x10: [mem 0xf1400000-0xf17fffff 64bit] Sep 09 21:10:31 thinker kernel: pci 0000:00:02.0: reg 0x18: [mem 0xe0000000-0xefffffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci 0000:00:02.0: reg 0x20: [io 0x6000-0x603f] Sep 09 21:10:31 thinker kernel: pci 0000:00:16.0: [8086:1c3a] type 00 class 0x078000 Sep 09 21:10:31 thinker kernel: pci 0000:00:16.0: reg 0x10: [mem 0xf3a25000-0xf3a2500f 64bit] Sep 09 21:10:31 thinker kernel: pci 0000:00:16.0: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:16.3: [8086:1c3d] type 00 class 0x070002 Sep 09 21:10:31 thinker kernel: pci 0000:00:16.3: reg 0x10: [io 0x60b0-0x60b7] Sep 09 21:10:31 thinker kernel: pci 0000:00:16.3: reg 0x14: [mem 0xf3a2c000-0xf3a2cfff] Sep 09 21:10:31 thinker kernel: pci 0000:00:19.0: [8086:1502] type 00 class 0x020000 Sep 09 21:10:31 thinker kernel: pci 0000:00:19.0: reg 0x10: [mem 0xf3a00000-0xf3a1ffff] Sep 09 21:10:31 thinker kernel: pci 0000:00:19.0: reg 0x14: [mem 0xf3a2b000-0xf3a2bfff] Sep 09 21:10:31 thinker kernel: pci 0000:00:19.0: reg 0x18: [io 0x6080-0x609f] Sep 09 21:10:31 thinker kernel: pci 0000:00:19.0: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:19.0: System wakeup disabled by ACPI Sep 09 21:10:31 thinker kernel: pci 0000:00:1a.0: [8086:1c2d] type 00 class 0x0c0320 Sep 09 21:10:31 thinker kernel: pci 0000:00:1a.0: reg 0x10: [mem 0xf3a2a000-0xf3a2a3ff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1a.0: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:1a.0: System wakeup disabled by ACPI Sep 09 21:10:31 thinker kernel: pci 0000:00:1b.0: [8086:1c20] type 00 class 0x040300 Sep 09 21:10:31 thinker kernel: pci 0000:00:1b.0: reg 0x10: [mem 0xf3a20000-0xf3a23fff 64bit] Sep 09 21:10:31 thinker kernel: pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:1b.0: System wakeup disabled by ACPI Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.0: [8086:1c10] type 01 class 0x060400 Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.1: [8086:1c12] type 01 class 0x060400 Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: [8086:1c16] type 01 class 0x060400 Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: System wakeup disabled by ACPI Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: [8086:1c18] type 01 class 0x060400 Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:1d.0: [8086:1c26] type 00 class 0x0c0320 Sep 09 21:10:31 thinker kernel: pci 0000:00:1d.0: reg 0x10: [mem 0xf3a29000-0xf3a293ff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:1d.0: System wakeup disabled by ACPI Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.0: [8086:1c4f] type 00 class 0x060100 Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.2: [8086:1c03] type 00 class 0x010601 Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.2: reg 0x10: [io 0x60a8-0x60af] Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.2: reg 0x14: [io 0x60bc-0x60bf] Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.2: reg 0x18: [io 0x60a0-0x60a7] Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.2: reg 0x1c: [io 0x60b8-0x60bb] Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.2: reg 0x20: [io 0x6060-0x607f] Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xf3a28000-0xf3a287ff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.2: PME# supported from D3hot Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.3: [8086:1c22] type 00 class 0x0c0500 Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.3: reg 0x10: [mem 0xf3a24000-0xf3a240ff 64bit] Sep 09 21:10:31 thinker kernel: pci 0000:00:1f.3: reg 0x20: [io 0xefa0-0xefbf] Sep 09 21:10:31 thinker kernel: pci 0000:01:00.0: [10de:1057] type 00 class 0x030000 Sep 09 21:10:31 thinker kernel: pci 0000:01:00.0: reg 0x10: [mem 0xf0000000-0xf0ffffff] Sep 09 21:10:31 thinker kernel: pci 0000:01:00.0: reg 0x14: [mem 0xc0000000-0xcfffffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci 0000:01:00.0: reg 0x1c: [mem 0xd0000000-0xd1ffffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci 0000:01:00.0: reg 0x24: [io 0x5000-0x507f] Sep 09 21:10:31 thinker kernel: pci 0000:01:00.0: reg 0x30: [mem 0xfff80000-0xffffffff pref] Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: PCI bridge to [bus 01] Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: bridge window [io 0x5000-0x5fff] Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: bridge window [mem 0xf0000000-0xf10fffff] Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: bridge window [mem 0xc0000000-0xd1ffffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.0: PCI bridge to [bus 02] Sep 09 21:10:31 thinker kernel: pci 0000:03:00.0: [8086:0085] type 00 class 0x028000 Sep 09 21:10:31 thinker kernel: pci 0000:03:00.0: reg 0x10: [mem 0xf3900000-0xf3901fff 64bit] Sep 09 21:10:31 thinker kernel: pci 0000:03:00.0: PME# supported from D0 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.1: PCI bridge to [bus 03] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.1: bridge window [mem 0xf3900000-0xf39fffff] Sep 09 21:10:31 thinker kernel: acpiphp: Slot [1] registered Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: PCI bridge to [bus 05-0c] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: bridge window [io 0x4000-0x4fff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: bridge window [mem 0xf3100000-0xf38fffff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: bridge window [mem 0xf1800000-0xf1ffffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci 0000:0d:00.0: [1180:e823] type 00 class 0x088001 Sep 09 21:10:31 thinker kernel: pci 0000:0d:00.0: MMC controller base frequency changed to 50Mhz. Sep 09 21:10:31 thinker kernel: pci 0000:0d:00.0: reg 0x10: [mem 0xf2801000-0xf28010ff] Sep 09 21:10:31 thinker kernel: pci 0000:0d:00.0: supports D1 D2 Sep 09 21:10:31 thinker kernel: pci 0000:0d:00.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:0d:00.3: [1180:e832] type 00 class 0x0c0010 Sep 09 21:10:31 thinker kernel: pci 0000:0d:00.3: reg 0x10: [mem 0xf2800000-0xf28007ff] Sep 09 21:10:31 thinker kernel: pci 0000:0d:00.3: supports D1 D2 Sep 09 21:10:31 thinker kernel: pci 0000:0d:00.3: PME# supported from D0 D1 D2 D3hot D3cold Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: PCI bridge to [bus 0d] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: bridge window [io 0x3000-0x3fff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: bridge window [mem 0xf2800000-0xf30fffff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: bridge window [mem 0xf2000000-0xf27fffff 64bit pref] Sep 09 21:10:31 thinker kernel: ACPI: Enabled 4 GPEs in block 00 to 3F Sep 09 21:10:31 thinker kernel: ACPI : EC: GPE = 0x11, I/O: command/status = 0x66, data = 0x62 Sep 09 21:10:31 thinker kernel: vgaarb: setting as boot device: PCI:0000:00:02.0 Sep 09 21:10:31 thinker kernel: vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none Sep 09 21:10:31 thinker kernel: vgaarb: device added: PCI:0000:01:00.0,decodes=io+mem,owns=none,locks=none Sep 09 21:10:31 thinker kernel: vgaarb: loaded Sep 09 21:10:31 thinker kernel: vgaarb: bridge control possible 0000:01:00.0 Sep 09 21:10:31 thinker kernel: vgaarb: no bridge control possible 0000:00:02.0 Sep 09 21:10:31 thinker kernel: SCSI subsystem initialized Sep 09 21:10:31 thinker kernel: libata version 3.00 loaded. Sep 09 21:10:31 thinker kernel: ACPI: bus type USB registered Sep 09 21:10:31 thinker kernel: usbcore: registered new interface driver usbfs Sep 09 21:10:31 thinker kernel: usbcore: registered new interface driver hub Sep 09 21:10:31 thinker kernel: usbcore: registered new device driver usb Sep 09 21:10:31 thinker kernel: PCI: Using ACPI for IRQ routing Sep 09 21:10:31 thinker kernel: PCI: pci_cache_line_size set to 64 bytes Sep 09 21:10:31 thinker kernel: e820: reserve RAM buffer [mem 0x0009d800-0x0009ffff] Sep 09 21:10:31 thinker kernel: e820: reserve RAM buffer [mem 0xba99f000-0xbbffffff] Sep 09 21:10:31 thinker kernel: e820: reserve RAM buffer [mem 0xbb000000-0xbbffffff] Sep 09 21:10:31 thinker kernel: e820: reserve RAM buffer [mem 0x33e600000-0x33fffffff] Sep 09 21:10:31 thinker kernel: NetLabel: Initializing Sep 09 21:10:31 thinker kernel: NetLabel: domain hash size = 128 Sep 09 21:10:31 thinker kernel: NetLabel: protocols = UNLABELED CIPSOv4 Sep 09 21:10:31 thinker kernel: NetLabel: unlabeled traffic allowed by default Sep 09 21:10:31 thinker kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0 Sep 09 21:10:31 thinker kernel: hpet0: 8 comparators, 64-bit 14.318180 MHz counter Sep 09 21:10:31 thinker kernel: Switched to clocksource hpet Sep 09 21:10:31 thinker kernel: AppArmor: AppArmor Filesystem Enabled Sep 09 21:10:31 thinker kernel: pnp: PnP ACPI init Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x00000000-0x0009ffff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000c0000-0x000c3fff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000c4000-0x000c7fff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000c8000-0x000cbfff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000cc000-0x000cffff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000d0000-0x000d3fff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000d4000-0x000d7fff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000d8000-0x000dbfff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000dc000-0x000dffff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000e0000-0x000e3fff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000e4000-0x000e7fff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000e8000-0x000ebfff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000ec000-0x000effff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x000f0000-0x000fffff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0x00100000-0xbf9fffff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0xfec00000-0xfed3ffff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: [mem 0xfed4c000-0xffffffff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c01 (active) Sep 09 21:10:31 thinker kernel: system 00:01: [io 0x0400-0x047f] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:01: [io 0x0500-0x057f] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: [io 0x0800-0x080f] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: [io 0x15e0-0x15ef] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: [io 0x1600-0x167f] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: [mem 0xf8000000-0xfbffffff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: [mem 0x00000000-0x00000fff] could not be reserved Sep 09 21:10:31 thinker kernel: system 00:01: [mem 0xfed1c000-0xfed1ffff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: [mem 0xfed10000-0xfed13fff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: [mem 0xfed18000-0xfed18fff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: [mem 0xfed19000-0xfed19fff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: [mem 0xfed45000-0xfed4bfff] has been reserved Sep 09 21:10:31 thinker kernel: system 00:01: Plug and Play ACPI device, IDs PNP0c02 (active) Sep 09 21:10:31 thinker kernel: pnp 00:02: Plug and Play ACPI device, IDs PNP0b00 (active) Sep 09 21:10:31 thinker kernel: pnp 00:03: Plug and Play ACPI device, IDs PNP0303 (active) Sep 09 21:10:31 thinker kernel: pnp 00:04: Plug and Play ACPI device, IDs LEN0015 PNP0f13 (active) Sep 09 21:10:31 thinker kernel: pnp 00:05: Plug and Play ACPI device, IDs SMO1200 PNP0c31 (active) Sep 09 21:10:31 thinker kernel: pnp: PnP ACPI: found 6 devices Sep 09 21:10:31 thinker kernel: pci 0000:01:00.0: can't claim BAR 6 [mem 0xfff80000-0xffffffff pref]: no compatible bridge window Sep 09 21:10:31 thinker kernel: pci 0000:01:00.0: BAR 6: assigned [mem 0xf1000000-0xf107ffff pref] Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: PCI bridge to [bus 01] Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: bridge window [io 0x5000-0x5fff] Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: bridge window [mem 0xf0000000-0xf10fffff] Sep 09 21:10:31 thinker kernel: pci 0000:00:01.0: bridge window [mem 0xc0000000-0xd1ffffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.0: PCI bridge to [bus 02] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.1: PCI bridge to [bus 03] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.1: bridge window [mem 0xf3900000-0xf39fffff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: PCI bridge to [bus 05-0c] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: bridge window [io 0x4000-0x4fff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: bridge window [mem 0xf3100000-0xf38fffff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.3: bridge window [mem 0xf1800000-0xf1ffffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: PCI bridge to [bus 0d] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: bridge window [io 0x3000-0x3fff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: bridge window [mem 0xf2800000-0xf30fffff] Sep 09 21:10:31 thinker kernel: pci 0000:00:1c.4: bridge window [mem 0xf2000000-0xf27fffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: resource 7 [mem 0xbfa00000-0xfebfffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:00: resource 8 [mem 0xfed40000-0xfed4bfff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:01: resource 0 [io 0x5000-0x5fff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:01: resource 1 [mem 0xf0000000-0xf10fffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:01: resource 2 [mem 0xc0000000-0xd1ffffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci_bus 0000:03: resource 1 [mem 0xf3900000-0xf39fffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:05: resource 0 [io 0x4000-0x4fff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:05: resource 1 [mem 0xf3100000-0xf38fffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:05: resource 2 [mem 0xf1800000-0xf1ffffff 64bit pref] Sep 09 21:10:31 thinker kernel: pci_bus 0000:0d: resource 0 [io 0x3000-0x3fff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:0d: resource 1 [mem 0xf2800000-0xf30fffff] Sep 09 21:10:31 thinker kernel: pci_bus 0000:0d: resource 2 [mem 0xf2000000-0xf27fffff 64bit pref] Sep 09 21:10:31 thinker kernel: NET: Registered protocol family 2 Sep 09 21:10:31 thinker kernel: TCP established hash table entries: 131072 (order: 8, 1048576 bytes) Sep 09 21:10:31 thinker kernel: TCP bind hash table entries: 65536 (order: 8, 1048576 bytes) Sep 09 21:10:31 thinker kernel: TCP: Hash tables configured (established 131072 bind 65536) Sep 09 21:10:31 thinker kernel: TCP: reno registered Sep 09 21:10:31 thinker kernel: UDP hash table entries: 8192 (order: 6, 262144 bytes) Sep 09 21:10:31 thinker kernel: UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes) Sep 09 21:10:31 thinker kernel: NET: Registered protocol family 1 Sep 09 21:10:31 thinker kernel: pci 0000:00:02.0: Video device with shadowed ROM Sep 09 21:10:31 thinker kernel: PCI: CLS 64 bytes, default 64 Sep 09 21:10:31 thinker kernel: Trying to unpack rootfs image as initramfs... Sep 09 21:10:31 thinker kernel: Freeing initrd memory: 20404K (ffff880035816000 - ffff880036c03000) Sep 09 21:10:31 thinker kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Sep 09 21:10:31 thinker kernel: software IO TLB [mem 0xb699f000-0xba99f000] (64MB) mapped at [ffff8800b699f000-ffff8800ba99efff] Sep 09 21:10:31 thinker kernel: RAPL PMU detected, hw unit 2^-16 Joules, API unit is 2^-32 Joules, 3 fixed counters 163840 ms ovfl timer Sep 09 21:10:31 thinker kernel: microcode: CPU0 sig=0x206a7, pf=0x10, revision=0x29 Sep 09 21:10:31 thinker kernel: microcode: CPU1 sig=0x206a7, pf=0x10, revision=0x29 Sep 09 21:10:31 thinker kernel: microcode: CPU2 sig=0x206a7, pf=0x10, revision=0x29 Sep 09 21:10:31 thinker kernel: microcode: CPU3 sig=0x206a7, pf=0x10, revision=0x29 Sep 09 21:10:31 thinker kernel: microcode: CPU4 sig=0x206a7, pf=0x10, revision=0x29 Sep 09 21:10:31 thinker kernel: microcode: CPU5 sig=0x206a7, pf=0x10, revision=0x29 Sep 09 21:10:31 thinker kernel: microcode: CPU6 sig=0x206a7, pf=0x10, revision=0x29 Sep 09 21:10:31 thinker kernel: microcode: CPU7 sig=0x206a7, pf=0x10, revision=0x29 Sep 09 21:10:31 thinker kernel: microcode: Microcode Update Driver: v2.00 , Peter Oruba Sep 09 21:10:31 thinker kernel: Scanning for low memory corruption every 60 seconds Sep 09 21:10:31 thinker kernel: futex hash table entries: 2048 (order: 5, 131072 bytes) Sep 09 21:10:31 thinker kernel: Initialise system trusted keyring Sep 09 21:10:31 thinker kernel: audit: initializing netlink subsys (disabled) Sep 09 21:10:31 thinker kernel: audit: type=2000 audit(1441833017.608:1): initialized Sep 09 21:10:31 thinker kernel: HugeTLB registered 2 MB page size, pre-allocated 0 pages Sep 09 21:10:31 thinker kernel: zpool: loaded Sep 09 21:10:31 thinker kernel: zbud: loaded Sep 09 21:10:31 thinker kernel: VFS: Disk quotas dquot_6.5.2 Sep 09 21:10:31 thinker kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 09 21:10:31 thinker kernel: fuse init (API version 7.23) Sep 09 21:10:31 thinker kernel: Key type big_key registered Sep 09 21:10:31 thinker kernel: Key type asymmetric registered Sep 09 21:10:31 thinker kernel: Asymmetric key parser 'x509' registered Sep 09 21:10:31 thinker kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Sep 09 21:10:31 thinker kernel: io scheduler noop registered Sep 09 21:10:31 thinker kernel: io scheduler deadline registered (default) Sep 09 21:10:31 thinker kernel: io scheduler cfq registered Sep 09 21:10:31 thinker kernel: pci_hotplug: PCI Hot Plug PCI Core version: 0.5 Sep 09 21:10:31 thinker kernel: pciehp: PCI Express Hot Plug Controller Driver version: 0.4 Sep 09 21:10:31 thinker kernel: intel_idle: MWAIT substates: 0x21120 Sep 09 21:10:31 thinker kernel: intel_idle: v0.4 model 0x2A Sep 09 21:10:31 thinker kernel: intel_idle: lapic_timer_reliable_states 0xffffffff Sep 09 21:10:31 thinker kernel: ACPI: AC Adapter [AC] (on-line) Sep 09 21:10:31 thinker kernel: input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input0 Sep 09 21:10:31 thinker kernel: ACPI: Lid Switch [LID] Sep 09 21:10:31 thinker kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Sep 09 21:10:31 thinker kernel: ACPI: Sleep Button [SLPB] Sep 09 21:10:31 thinker kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Sep 09 21:10:31 thinker kernel: ACPI: Power Button [PWRF] Sep 09 21:10:31 thinker kernel: thermal LNXTHERM:00: registered as thermal_zone0 Sep 09 21:10:31 thinker kernel: ACPI: Thermal Zone [THM0] (53 C) Sep 09 21:10:31 thinker kernel: GHES: HEST is not enabled! Sep 09 21:10:31 thinker kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Sep 09 21:10:31 thinker kernel: ACPI: Battery Slot [BAT0] (battery present) Sep 09 21:10:31 thinker kernel: 0000:00:16.3: ttyS4 at I/O 0x60b0 (irq = 19, base_baud = 115200) is a 16550A Sep 09 21:10:31 thinker kernel: Linux agpgart interface v0.103 Sep 09 21:10:31 thinker kernel: tpm_tis 00:05: 1.2 TPM (device-id 0x0, rev-id 78) Sep 09 21:10:31 thinker kernel: tpm_tis 00:05: TPM is disabled/deactivated (0x6) Sep 09 21:10:31 thinker kernel: brd: module loaded Sep 09 21:10:31 thinker kernel: loop: module loaded Sep 09 21:10:31 thinker kernel: libphy: Fixed MDIO Bus: probed Sep 09 21:10:31 thinker kernel: tun: Universal TUN/TAP device driver, 1.6 Sep 09 21:10:31 thinker kernel: tun: (C) 1999-2004 Max Krasnyansky Sep 09 21:10:31 thinker kernel: PPP generic driver version 2.4.2 Sep 09 21:10:31 thinker kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Sep 09 21:10:31 thinker kernel: ehci-pci: EHCI PCI platform driver Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1a.0: EHCI Host Controller Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1a.0: new USB bus registered, assigned bus number 1 Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1a.0: debug port 2 Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1a.0: cache line size of 64 is not supported Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1a.0: irq 16, io mem 0xf3a2a000 Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1a.0: USB 2.0 started, EHCI 1.00 Sep 09 21:10:31 thinker kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Sep 09 21:10:31 thinker kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Sep 09 21:10:31 thinker kernel: usb usb1: Product: EHCI Host Controller Sep 09 21:10:31 thinker kernel: usb usb1: Manufacturer: Linux 3.19.0-28-generic ehci_hcd Sep 09 21:10:31 thinker kernel: usb usb1: SerialNumber: 0000:00:1a.0 Sep 09 21:10:31 thinker kernel: hub 1-0:1.0: USB hub found Sep 09 21:10:31 thinker kernel: hub 1-0:1.0: 3 ports detected Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1d.0: EHCI Host Controller Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1d.0: new USB bus registered, assigned bus number 2 Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1d.0: debug port 2 Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1d.0: cache line size of 64 is not supported Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1d.0: irq 23, io mem 0xf3a29000 Sep 09 21:10:31 thinker kernel: ehci-pci 0000:00:1d.0: USB 2.0 started, EHCI 1.00 Sep 09 21:10:31 thinker kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0002 Sep 09 21:10:31 thinker kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Sep 09 21:10:31 thinker kernel: usb usb2: Product: EHCI Host Controller Sep 09 21:10:31 thinker kernel: usb usb2: Manufacturer: Linux 3.19.0-28-generic ehci_hcd Sep 09 21:10:31 thinker kernel: usb usb2: SerialNumber: 0000:00:1d.0 Sep 09 21:10:31 thinker kernel: hub 2-0:1.0: USB hub found Sep 09 21:10:31 thinker kernel: hub 2-0:1.0: 3 ports detected Sep 09 21:10:31 thinker kernel: ehci-platform: EHCI generic platform driver Sep 09 21:10:31 thinker kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Sep 09 21:10:31 thinker kernel: ohci-pci: OHCI PCI platform driver Sep 09 21:10:31 thinker kernel: ohci-platform: OHCI generic platform driver Sep 09 21:10:31 thinker kernel: uhci_hcd: USB Universal Host Controller Interface driver Sep 09 21:10:31 thinker kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Sep 09 21:10:31 thinker kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Sep 09 21:10:31 thinker kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Sep 09 21:10:31 thinker kernel: mousedev: PS/2 mouse device common for all mice Sep 09 21:10:31 thinker kernel: rtc_cmos 00:02: RTC can wake from S4 Sep 09 21:10:31 thinker kernel: rtc_cmos 00:02: rtc core: registered rtc_cmos as rtc0 Sep 09 21:10:31 thinker kernel: rtc_cmos 00:02: alarms up to one month, y3k, 114 bytes nvram, hpet irqs Sep 09 21:10:31 thinker kernel: i2c /dev entries driver Sep 09 21:10:31 thinker kernel: device-mapper: uevent: version 1.0.3 Sep 09 21:10:31 thinker kernel: device-mapper: ioctl: 4.29.0-ioctl (2014-10-28) initialised: dm-devel@redhat.com Sep 09 21:10:31 thinker kernel: Intel P-state driver initializing. Sep 09 21:10:31 thinker kernel: Consider also installing thermald for improved thermal control. Sep 09 21:10:31 thinker kernel: ledtrig-cpu: registered to indicate activity on CPUs Sep 09 21:10:31 thinker kernel: PCCT header not found. Sep 09 21:10:31 thinker kernel: ACPI PCC probe failed. Sep 09 21:10:31 thinker kernel: TCP: cubic registered Sep 09 21:10:31 thinker kernel: NET: Registered protocol family 10 Sep 09 21:10:31 thinker kernel: NET: Registered protocol family 17 Sep 09 21:10:31 thinker kernel: Key type dns_resolver registered Sep 09 21:10:31 thinker kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input3 Sep 09 21:10:31 thinker kernel: Loading compiled-in X.509 certificates Sep 09 21:10:31 thinker kernel: Loaded X.509 cert 'Magrathea: Glacier signing key: 99112ef1a6ba85be992582e9fef3a23f1a888175' Sep 09 21:10:31 thinker kernel: registered taskstats version 1 Sep 09 21:10:31 thinker kernel: Key type trusted registered Sep 09 21:10:31 thinker kernel: Key type encrypted registered Sep 09 21:10:31 thinker kernel: AppArmor: AppArmor sha1 policy hashing enabled Sep 09 21:10:31 thinker kernel: tpm_tis 00:05: A TPM error (6) occurred attempting to read a pcr value Sep 09 21:10:31 thinker kernel: ima: No TPM chip found, activating TPM-bypass! Sep 09 21:10:31 thinker kernel: evm: HMAC attrs: 0x1 Sep 09 21:10:31 thinker kernel: Magic number: 15:538:196 Sep 09 21:10:31 thinker kernel: rtc_cmos 00:02: setting system clock to 2015-09-09 21:10:17 UTC (1441833017) Sep 09 21:10:31 thinker kernel: BIOS EDD facility v0.16 2004-Jun-25, 0 devices found Sep 09 21:10:31 thinker kernel: EDD information not available. Sep 09 21:10:31 thinker kernel: PM: Hibernation image not present or could not be loaded. Sep 09 21:10:31 thinker kernel: Freeing unused kernel memory: 1408K (ffffffff81d36000 - ffffffff81e96000) Sep 09 21:10:31 thinker kernel: Write protecting the kernel read-only data: 12288k Sep 09 21:10:31 thinker kernel: Freeing unused kernel memory: 176K (ffff8800017d4000 - ffff880001800000) Sep 09 21:10:31 thinker kernel: Freeing unused kernel memory: 332K (ffff880001bad000 - ffff880001c00000) Sep 09 21:10:31 thinker kernel: random: systemd-udevd urandom read with 13 bits of entropy available Sep 09 21:10:31 thinker kernel: pps_core: LinuxPPS API ver. 1 registered Sep 09 21:10:31 thinker kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 09 21:10:31 thinker kernel: PTP clock support registered Sep 09 21:10:31 thinker kernel: sdhci: Secure Digital Host Controller Interface driver Sep 09 21:10:31 thinker kernel: sdhci: Copyright(c) Pierre Ossman Sep 09 21:10:31 thinker kernel: sdhci-pci 0000:0d:00.0: SDHCI controller found [1180:e823] (rev 5) Sep 09 21:10:31 thinker kernel: sdhci-pci 0000:0d:00.0: No vmmc regulator found Sep 09 21:10:31 thinker kernel: sdhci-pci 0000:0d:00.0: No vqmmc regulator found Sep 09 21:10:31 thinker kernel: ahci 0000:00:1f.2: version 3.0 Sep 09 21:10:31 thinker kernel: ahci 0000:00:1f.2: SSS flag set, parallel bus scan disabled Sep 09 21:10:31 thinker kernel: mmc0: SDHCI controller on PCI [0000:0d:00.0] using DMA Sep 09 21:10:31 thinker kernel: e1000e: Intel(R) PRO/1000 Network Driver - 2.3.2-k Sep 09 21:10:31 thinker kernel: e1000e: Copyright(c) 1999 - 2014 Intel Corporation. Sep 09 21:10:31 thinker kernel: ahci 0000:00:1f.2: AHCI 0001.0300 32 slots 6 ports 6 Gbps 0x1b impl SATA mode Sep 09 21:10:31 thinker kernel: ahci 0000:00:1f.2: flags: 64bit ncq sntf ilck stag pm led clo pio slum part ems sxs apst Sep 09 21:10:31 thinker kernel: scsi host0: ahci Sep 09 21:10:31 thinker kernel: scsi host1: ahci Sep 09 21:10:31 thinker kernel: scsi host2: ahci Sep 09 21:10:31 thinker kernel: scsi host3: ahci Sep 09 21:10:31 thinker kernel: scsi host4: ahci Sep 09 21:10:31 thinker kernel: scsi host5: ahci Sep 09 21:10:31 thinker kernel: ata1: SATA max UDMA/133 abar m2048@0xf3a28000 port 0xf3a28100 irq 27 Sep 09 21:10:31 thinker kernel: ata2: SATA max UDMA/133 abar m2048@0xf3a28000 port 0xf3a28180 irq 27 Sep 09 21:10:31 thinker kernel: ata3: DUMMY Sep 09 21:10:31 thinker kernel: ata4: SATA max UDMA/133 abar m2048@0xf3a28000 port 0xf3a28280 irq 27 Sep 09 21:10:31 thinker kernel: ata5: SATA max UDMA/133 abar m2048@0xf3a28000 port 0xf3a28300 irq 27 Sep 09 21:10:31 thinker kernel: ata6: DUMMY Sep 09 21:10:31 thinker kernel: e1000e 0000:00:19.0: Interrupt Throttling Rate (ints/sec) set to dynamic conservative mode Sep 09 21:10:31 thinker kernel: firewire_ohci 0000:0d:00.3: added OHCI v1.10 device as card 0, 4 IR + 4 IT contexts, quirks 0x11 Sep 09 21:10:31 thinker kernel: usb 1-1: new high-speed USB device number 2 using ehci-pci Sep 09 21:10:31 thinker kernel: e1000e 0000:00:19.0 eth0: registered PHC clock Sep 09 21:10:31 thinker kernel: e1000e 0000:00:19.0 eth0: (PCI Express:2.5GT/s:Width x1) f0:de:f1:78:3b:6c Sep 09 21:10:31 thinker kernel: e1000e 0000:00:19.0 eth0: Intel(R) PRO/1000 Network Connection Sep 09 21:10:31 thinker kernel: e1000e 0000:00:19.0 eth0: MAC: 10, PHY: 11, PBA No: 1000FF-0FF Sep 09 21:10:31 thinker kernel: usb 2-1: new high-speed USB device number 2 using ehci-pci Sep 09 21:10:31 thinker kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) Sep 09 21:10:31 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:10:31 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:10:31 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:10:31 thinker kernel: ata1.00: ATA-9: WDC WD10JPVX-22JC3T0, 01.01A01, max UDMA/133 Sep 09 21:10:31 thinker kernel: ata1.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 31/32), AA Sep 09 21:10:31 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:10:31 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:10:31 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:10:31 thinker kernel: ata1.00: configured for UDMA/133 Sep 09 21:10:31 thinker kernel: scsi 0:0:0:0: Direct-Access ATA WDC WD10JPVX-22J 1A01 PQ: 0 ANSI: 5 Sep 09 21:10:31 thinker kernel: sd 0:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/931 GiB) Sep 09 21:10:31 thinker kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Sep 09 21:10:31 thinker kernel: sd 0:0:0:0: [sda] Write Protect is off Sep 09 21:10:31 thinker kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 Sep 09 21:10:31 thinker kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Sep 09 21:10:31 thinker kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Sep 09 21:10:31 thinker kernel: usb 1-1: New USB device found, idVendor=8087, idProduct=0024 Sep 09 21:10:31 thinker kernel: usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Sep 09 21:10:31 thinker kernel: hub 1-1:1.0: USB hub found Sep 09 21:10:31 thinker kernel: hub 1-1:1.0: 6 ports detected Sep 09 21:10:31 thinker kernel: usb 2-1: New USB device found, idVendor=8087, idProduct=0024 Sep 09 21:10:31 thinker kernel: usb 2-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Sep 09 21:10:31 thinker kernel: hub 2-1:1.0: USB hub found Sep 09 21:10:31 thinker kernel: hub 2-1:1.0: 8 ports detected Sep 09 21:10:31 thinker kernel: sda: sda1 sda2 sda3 sda4 < sda5 sda6 > Sep 09 21:10:31 thinker kernel: sd 0:0:0:0: [sda] Attached SCSI disk Sep 09 21:10:31 thinker kernel: firewire_core 0000:0d:00.3: created device fw0: GUID f0def1ff783b6cff, S400 Sep 09 21:10:31 thinker kernel: usb 1-1.2: new full-speed USB device number 3 using ehci-pci Sep 09 21:10:31 thinker kernel: ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 09 21:10:31 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:10:31 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:10:31 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:10:31 thinker kernel: ata2.00: ATAPI: HL-DT-STDVDRAM GT33N, LT22, max UDMA/66 Sep 09 21:10:31 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:10:31 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:10:31 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:10:31 thinker kernel: ata2.00: configured for UDMA/66 Sep 09 21:10:31 thinker kernel: scsi 1:0:0:0: CD-ROM HL-DT-ST DVDRAM GT33N LT22 PQ: 0 ANSI: 5 Sep 09 21:10:31 thinker kernel: sr 1:0:0:0: [sr0] scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray Sep 09 21:10:31 thinker kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 09 21:10:31 thinker kernel: sr 1:0:0:0: Attached scsi CD-ROM sr0 Sep 09 21:10:31 thinker kernel: sr 1:0:0:0: Attached scsi generic sg1 type 5 Sep 09 21:10:31 thinker kernel: usb 1-1.2: New USB device found, idVendor=046d, idProduct=c52b Sep 09 21:10:31 thinker kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Sep 09 21:10:31 thinker kernel: usb 1-1.2: Product: USB Receiver Sep 09 21:10:31 thinker kernel: usb 1-1.2: Manufacturer: Logitech Sep 09 21:10:31 thinker kernel: hidraw: raw HID events driver (C) Jiri Kosina Sep 09 21:10:31 thinker kernel: usbcore: registered new interface driver usbhid Sep 09 21:10:31 thinker kernel: usbhid: USB HID core driver Sep 09 21:10:31 thinker kernel: logitech-djreceiver 0003:046D:C52B.0003: hiddev0,hidraw0: USB HID v1.11 Device [Logitech USB Receiver] on usb-0000:00:1a.0-1.2/input2 Sep 09 21:10:31 thinker kernel: usb 1-1.4: new full-speed USB device number 4 using ehci-pci Sep 09 21:10:31 thinker kernel: tsc: Refined TSC clocksource calibration: 2192.877 MHz Sep 09 21:10:31 thinker kernel: usb 1-1.4: New USB device found, idVendor=0a5c, idProduct=217f Sep 09 21:10:31 thinker kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Sep 09 21:10:31 thinker kernel: usb 1-1.4: Product: Broadcom Bluetooth Device Sep 09 21:10:31 thinker kernel: usb 1-1.4: Manufacturer: Broadcom Corp Sep 09 21:10:31 thinker kernel: usb 1-1.4: SerialNumber: 402CF456C711 Sep 09 21:10:31 thinker kernel: psmouse serio1: synaptics: queried max coordinates: x [..5888], y [..4820] Sep 09 21:10:31 thinker kernel: usb 1-1.5: new high-speed USB device number 5 using ehci-pci Sep 09 21:10:31 thinker kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 09 21:10:31 thinker kernel: psmouse serio1: synaptics: Touchpad model: 1, fw: 7.2, id: 0x1c0b1, caps: 0xd047b3/0xb40000/0xa0000, board id: 0, fw id: 578367 Sep 09 21:10:31 thinker kernel: psmouse serio1: synaptics: serio: Synaptics pass-through port at isa0060/serio1/input0 Sep 09 21:10:31 thinker kernel: usb 1-1.5: New USB device found, idVendor=17ef, idProduct=100a Sep 09 21:10:31 thinker kernel: usb 1-1.5: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Sep 09 21:10:31 thinker kernel: hub 1-1.5:1.0: USB hub found Sep 09 21:10:31 thinker kernel: hub 1-1.5:1.0: 6 ports detected Sep 09 21:10:31 thinker kernel: input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input5 Sep 09 21:10:31 thinker kernel: usb 1-1.6: new high-speed USB device number 6 using ehci-pci Sep 09 21:10:31 thinker kernel: usb 1-1.6: New USB device found, idVendor=04f2, idProduct=b217 Sep 09 21:10:31 thinker kernel: usb 1-1.6: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Sep 09 21:10:31 thinker kernel: usb 1-1.6: Product: Integrated Camera Sep 09 21:10:31 thinker kernel: usb 1-1.6: Manufacturer: Chicony Electronics Co., Ltd. Sep 09 21:10:31 thinker kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 09 21:10:31 thinker kernel: usb 1-1.5.4: new full-speed USB device number 7 using ehci-pci Sep 09 21:10:31 thinker kernel: Switched to clocksource tsc Sep 09 21:10:31 thinker kernel: usb 1-1.5.4: config 1 has an invalid interface number: 4 but max is 3 Sep 09 21:10:31 thinker kernel: usb 1-1.5.4: config 1 has no interface number 3 Sep 09 21:10:31 thinker kernel: usb 1-1.5.4: New USB device found, idVendor=1210, idProduct=000a Sep 09 21:10:31 thinker kernel: usb 1-1.5.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Sep 09 21:10:31 thinker kernel: usb 1-1.5.4: Product: Lexicon Alpha Sep 09 21:10:31 thinker kernel: usb 1-1.5.4: Manufacturer: Lexicon Sep 09 21:10:31 thinker kernel: random: nonblocking pool is initialized Sep 09 21:10:31 thinker kernel: psmouse serio2: trackpoint: IBM TrackPoint firmware: 0x0e, buttons: 3/3 Sep 09 21:10:31 thinker kernel: input: TPPS/2 IBM TrackPoint as /devices/platform/i8042/serio1/serio2/input/input6 Sep 09 21:10:31 thinker kernel: PM: Marking nosave pages: [mem 0x00000000-0x00000fff] Sep 09 21:10:31 thinker kernel: PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] Sep 09 21:10:31 thinker kernel: PM: Marking nosave pages: [mem 0xba99f000-0xbaffefff] Sep 09 21:10:31 thinker kernel: PM: Marking nosave pages: [mem 0xbb000000-0xffffffff] Sep 09 21:10:31 thinker kernel: PM: Basic memory bitmaps created Sep 09 21:10:31 thinker kernel: PM: Basic memory bitmaps freed Sep 09 21:10:31 thinker kernel: EXT4-fs (sda5): mounted filesystem with ordered data mode. Opts: (null) Sep 09 21:10:31 thinker kernel: lp: driver loaded but no devices found Sep 09 21:10:31 thinker kernel: ppdev: user-space parallel port driver Sep 09 21:10:34 thinker kernel: wmi: Mapper loaded Sep 09 21:10:34 thinker kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Sep 09 21:10:34 thinker kernel: ACPI Warning: SystemIO range 0x0000000000000428-0x000000000000042f conflicts with OpRegion 0x0000000000000400-0x000000000000047f (\_SB_.PCI0.LPC_.PMIO) (20141107/utaddress-258) Sep 09 21:10:34 thinker kernel: ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver Sep 09 21:10:34 thinker kernel: ACPI Warning: SystemIO range 0x0000000000000540-0x000000000000054f conflicts with OpRegion 0x0000000000000500-0x000000000000057f (\_SB_.PCI0.LPC_.LPIO) (20141107/utaddress-258) Sep 09 21:10:34 thinker kernel: ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver Sep 09 21:10:34 thinker kernel: ACPI Warning: SystemIO range 0x0000000000000530-0x000000000000053f conflicts with OpRegion 0x0000000000000500-0x000000000000057f (\_SB_.PCI0.LPC_.LPIO) (20141107/utaddress-258) Sep 09 21:10:34 thinker kernel: ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver Sep 09 21:10:34 thinker kernel: ACPI Warning: SystemIO range 0x0000000000000500-0x000000000000052f conflicts with OpRegion 0x0000000000000500-0x000000000000057f (\_SB_.PCI0.LPC_.LPIO) (20141107/utaddress-258) Sep 09 21:10:34 thinker kernel: ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver Sep 09 21:10:34 thinker kernel: lpc_ich: Resource conflict(s) found affecting gpio_ich Sep 09 21:10:35 thinker kernel: Non-volatile memory driver v1.3 Sep 09 21:10:35 thinker kernel: thinkpad_acpi: ThinkPad ACPI Extras v0.25 Sep 09 21:10:35 thinker kernel: thinkpad_acpi: http://ibm-acpi.sf.net/ Sep 09 21:10:35 thinker kernel: thinkpad_acpi: ThinkPad BIOS 8AET49WW (1.29 ), EC unknown Sep 09 21:10:35 thinker kernel: thinkpad_acpi: Lenovo ThinkPad T520, model 4239CTO Sep 09 21:10:35 thinker kernel: thinkpad_acpi: detected a 16-level brightness capable ThinkPad Sep 09 21:10:35 thinker kernel: thinkpad_acpi: radio switch found; radios are enabled Sep 09 21:10:35 thinker kernel: thinkpad_acpi: This ThinkPad has standard ACPI backlight brightness control, supported by the ACPI video driver Sep 09 21:10:35 thinker kernel: thinkpad_acpi: Disabling thinkpad-acpi brightness events by default... Sep 09 21:10:35 thinker kernel: thinkpad_acpi: rfkill switch tpacpi_bluetooth_sw: radio is unblocked Sep 09 21:10:35 thinker kernel: thinkpad_acpi: Standard ACPI backlight interface available, not loading native one Sep 09 21:10:35 thinker kernel: input: ThinkPad Extra Buttons as /devices/platform/thinkpad_acpi/input/input7 Sep 09 21:10:35 thinker kernel: cfg80211: Calling CRDA to update world regulatory domain Sep 09 21:10:35 thinker kernel: [drm] Initialized drm 1.1.0 20060810 Sep 09 21:10:36 thinker kernel: AVX version of gcm_enc/dec engaged. Sep 09 21:10:36 thinker kernel: AES CTR mode by8 optimization enabled Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: CX20590: BIOS auto-probing. Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: autoconfig: line_outs=1 (0x1f/0x0/0x0/0x0/0x0) type:speaker Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: hp_outs=2 (0x1c/0x19/0x0/0x0/0x0) Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: mono: mono_out=0x0 Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: inputs: Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: Internal Mic=0x23 Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: Mic=0x1b Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: Dock Mic=0x1a Sep 09 21:10:36 thinker kernel: sound hdaudioC0D0: Enable sync_write for stable communication Sep 09 21:10:36 thinker kernel: input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input8 Sep 09 21:10:36 thinker kernel: input: HDA Intel PCH Dock Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input9 Sep 09 21:10:36 thinker kernel: input: HDA Intel PCH Dock Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card0/input10 Sep 09 21:10:36 thinker kernel: input: HDA Intel PCH Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card0/input11 Sep 09 21:10:36 thinker kernel: [drm] Memory usable by graphics device = 2048M Sep 09 21:10:36 thinker kernel: [drm] Replacing VGA console driver Sep 09 21:10:36 thinker kernel: Console: switching to colour dummy device 80x25 Sep 09 21:10:36 thinker kernel: [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). Sep 09 21:10:36 thinker kernel: [drm] Driver supports precise vblank timestamp query. Sep 09 21:10:36 thinker kernel: vgaarb: device changed decodes: PCI:0000:00:02.0,olddecodes=io+mem,decodes=none:owns=io+mem Sep 09 21:10:36 thinker kernel: ACPI: Video Device [VID] (multi-head: yes rom: no post: no) Sep 09 21:10:36 thinker kernel: acpi device:00: registered as cooling_device8 Sep 09 21:10:36 thinker kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input12 Sep 09 21:10:36 thinker kernel: ACPI: Video Device [VID1] (multi-head: yes rom: yes post: no) Sep 09 21:10:36 thinker kernel: acpi device:0a: registered as cooling_device9 Sep 09 21:10:36 thinker kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/device:09/LNXVIDEO:01/input/input13 Sep 09 21:10:36 thinker kernel: [drm] Initialized i915 1.6.0 20141121 for 0000:00:02.0 on minor 0 Sep 09 21:10:37 thinker kernel: fbcon: inteldrmfb (fb0) is primary device Sep 09 21:10:37 thinker kernel: Intel(R) Wireless WiFi driver for Linux, in-tree: Sep 09 21:10:37 thinker kernel: Copyright(c) 2003- 2014 Intel Corporation Sep 09 21:10:37 thinker kernel: iwlwifi 0000:03:00.0: can't disable ASPM; OS doesn't have ASPM control Sep 09 21:10:37 thinker kernel: input: Logitech M315/M235 as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.2/1-1.2:1.2/0003:046D:C52B.0003/0003:046D:4009.0004/input/input14 Sep 09 21:10:37 thinker kernel: logitech-hidpp-device 0003:046D:4009.0004: input,hidraw1: USB HID v1.11 Mouse [Logitech M315/M235] on usb-0000:00:1a.0-1.2:1 Sep 09 21:10:37 thinker kernel: input: Logitech M570 as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.2/1-1.2:1.2/0003:046D:C52B.0003/0003:046D:1028.0005/input/input15 Sep 09 21:10:37 thinker kernel: logitech-hidpp-device 0003:046D:1028.0005: input,hidraw2: USB HID v1.11 Mouse [Logitech M570] on usb-0000:00:1a.0-1.2:3 Sep 09 21:10:37 thinker kernel: input: Logitech K350 as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.2/1-1.2:1.2/0003:046D:C52B.0003/0003:046D:200A.0006/input/input16 Sep 09 21:10:37 thinker kernel: logitech-hidpp-device 0003:046D:200A.0006: input,hidraw3: USB HID v1.11 Keyboard [Logitech K350] on usb-0000:00:1a.0-1.2:4 Sep 09 21:10:37 thinker kernel: cfg80211: World regulatory domain updated: Sep 09 21:10:37 thinker kernel: cfg80211: DFS Master region: unset Sep 09 21:10:37 thinker kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Sep 09 21:10:37 thinker kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:10:37 thinker kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:10:37 thinker kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:10:37 thinker kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Sep 09 21:10:37 thinker kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Sep 09 21:10:37 thinker kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Sep 09 21:10:37 thinker kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:10:37 thinker kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Sep 09 21:10:37 thinker kernel: media: Linux media interface: v0.10 Sep 09 21:10:37 thinker kernel: nvidia: module license 'NVIDIA' taints kernel. Sep 09 21:10:37 thinker kernel: Disabling lock debugging due to kernel taint Sep 09 21:10:37 thinker kernel: nvidia: module verification failed: signature and/or required key missing - tainting kernel Sep 09 21:10:37 thinker kernel: nvidia 0000:01:00.0: enabling device (0000 -> 0003) Sep 09 21:10:37 thinker kernel: vgaarb: device changed decodes: PCI:0000:01:00.0,olddecodes=io+mem,decodes=none:owns=none Sep 09 21:10:37 thinker kernel: NVLINK: Nvlink Core is being initialized, major device number 245 Sep 09 21:10:37 thinker kernel: [drm] Initialized nvidia-drm 0.0.0 20150116 for 0000:01:00.0 on minor 1 Sep 09 21:10:37 thinker kernel: NVRM: loading NVIDIA UNIX x86_64 Kernel Module 355.06 Tue Jul 28 21:26:50 PDT 2015 Sep 09 21:10:37 thinker kernel: iwlwifi 0000:03:00.0: loaded firmware version 18.168.6.1 op_mode iwldvm Sep 09 21:10:37 thinker kernel: Linux video capture interface: v2.00 Sep 09 21:10:37 thinker kernel: intel_rapl: Found RAPL domain package Sep 09 21:10:37 thinker kernel: intel_rapl: Found RAPL domain core Sep 09 21:10:37 thinker kernel: intel_rapl: Found RAPL domain uncore Sep 09 21:10:37 thinker kernel: Console: switching to colour frame buffer device 240x67 Sep 09 21:10:37 thinker kernel: i915 0000:00:02.0: fb0: inteldrmfb frame buffer device Sep 09 21:10:37 thinker kernel: i915 0000:00:02.0: registered panic notifier Sep 09 21:10:37 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:10:37 thinker kernel: usb 1-1.5.4: 1:2: cannot get freq at ep 0x1 Sep 09 21:10:37 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:10:37 thinker kernel: usb 1-1.5.4: 2:2: cannot get freq at ep 0x82 Sep 09 21:10:37 thinker kernel: usbcore: registered new interface driver snd-usb-audio Sep 09 21:10:38 thinker kernel: uvcvideo: Found UVC 1.00 device Integrated Camera (04f2:b217) Sep 09 21:10:38 thinker kernel: input: Integrated Camera as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6:1.0/input/input17 Sep 09 21:10:38 thinker kernel: usbcore: registered new interface driver uvcvideo Sep 09 21:10:38 thinker kernel: USB Video Class driver (1.1.1) Sep 09 21:10:38 thinker kernel: Bluetooth: Core ver 2.20 Sep 09 21:10:38 thinker kernel: NET: Registered protocol family 31 Sep 09 21:10:38 thinker kernel: Bluetooth: HCI device and connection manager initialized Sep 09 21:10:38 thinker kernel: Bluetooth: HCI socket layer initialized Sep 09 21:10:38 thinker kernel: Bluetooth: L2CAP socket layer initialized Sep 09 21:10:38 thinker kernel: Bluetooth: SCO socket layer initialized Sep 09 21:10:38 thinker kernel: iwlwifi 0000:03:00.0: CONFIG_IWLWIFI_DEBUG disabled Sep 09 21:10:38 thinker kernel: iwlwifi 0000:03:00.0: CONFIG_IWLWIFI_DEBUGFS enabled Sep 09 21:10:38 thinker kernel: iwlwifi 0000:03:00.0: CONFIG_IWLWIFI_DEVICE_TRACING enabled Sep 09 21:10:38 thinker kernel: iwlwifi 0000:03:00.0: Detected Intel(R) Centrino(R) Advanced-N 6205 AGN, REV=0xB0 Sep 09 21:10:38 thinker kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Disabled Sep 09 21:10:38 thinker kernel: ieee80211 phy0: Selected rate control algorithm 'iwl-agn-rs' Sep 09 21:10:39 thinker kernel: Adding 19529724k swap on /dev/sda6. Priority:-1 extents:1 across:19529724k FS Sep 09 21:10:39 thinker kernel: usbcore: registered new interface driver btusb Sep 09 21:10:45 thinker kernel: EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro Sep 09 21:10:47 thinker kernel: audit: type=1400 audit(1441851047.842:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/sbin/dhclient" pid=658 comm="apparmor_parser" Sep 09 21:10:47 thinker kernel: audit: type=1400 audit(1441851047.842:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=658 comm="apparmor_parser" Sep 09 21:10:47 thinker kernel: audit: type=1400 audit(1441851047.842:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-helper" pid=658 comm="apparmor_parser" Sep 09 21:10:47 thinker kernel: audit: type=1400 audit(1441851047.842:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/connman/scripts/dhclient-script" pid=658 comm="apparmor_parser" Sep 09 21:10:48 thinker kernel: audit: type=1400 audit(1441851048.134:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/evince" pid=658 comm="apparmor_parser" Sep 09 21:10:48 thinker kernel: audit: type=1400 audit(1441851048.134:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="sanitized_helper" pid=658 comm="apparmor_parser" Sep 09 21:10:48 thinker kernel: audit: type=1400 audit(1441851048.134:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/evince-previewer" pid=658 comm="apparmor_parser" Sep 09 21:10:48 thinker kernel: audit: type=1400 audit(1441851048.134:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="sanitized_helper" pid=658 comm="apparmor_parser" Sep 09 21:10:48 thinker kernel: audit: type=1400 audit(1441851048.134:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/evince-thumbnailer" pid=658 comm="apparmor_parser" Sep 09 21:10:48 thinker kernel: audit: type=1400 audit(1441851048.134:11): apparmor="STATUS" operation="profile_load" profile="unconfined" name="sanitized_helper" pid=658 comm="apparmor_parser" Sep 09 21:10:52 thinker NetworkManager[784]: NetworkManager (version 0.9.10.0) is starting... Sep 09 21:10:52 thinker NetworkManager[784]: Read config: /etc/NetworkManager/NetworkManager.conf Sep 09 21:10:52 thinker NetworkManager[784]: WEXT support is enabled Sep 09 21:10:53 thinker NetworkManager[784]: VPN: loaded org.freedesktop.NetworkManager.openvpn Sep 09 21:10:53 thinker NetworkManager[784]: VPN: loaded org.freedesktop.NetworkManager.pptp Sep 09 21:10:53 thinker NetworkManager[784]: DNS: loaded plugin dnsmasq Sep 09 21:10:53 thinker kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Sep 09 21:10:53 thinker kernel: Bluetooth: BNEP filters: protocol multicast Sep 09 21:10:53 thinker kernel: Bluetooth: BNEP socket layer initialized Sep 09 21:10:54 thinker kernel: Bluetooth: RFCOMM TTY layer initialized Sep 09 21:10:54 thinker kernel: Bluetooth: RFCOMM socket layer initialized Sep 09 21:10:54 thinker kernel: Bluetooth: RFCOMM ver 1.11 Sep 09 21:10:55 thinker NetworkManager[784]: init! Sep 09 21:10:55 thinker NetworkManager[784]: update_system_hostname Sep 09 21:10:55 thinker NetworkManager[784]: interface-parser: parsing file /etc/network/interfaces Sep 09 21:10:55 thinker NetworkManager[784]: interface-parser: finished parsing file /etc/network/interfaces Sep 09 21:10:55 thinker NetworkManager[784]: management mode: unmanaged Sep 09 21:10:55 thinker NetworkManager[784]: devices added (path: /sys/devices/pci0000:00/0000:00:19.0/net/eth0, iface: eth0) Sep 09 21:10:55 thinker NetworkManager[784]: device added (path: /sys/devices/pci0000:00/0000:00:19.0/net/eth0, iface: eth0): no ifupdown configuration found. Sep 09 21:10:55 thinker NetworkManager[784]: devices added (path: /sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/net/wlan0, iface: wlan0) Sep 09 21:10:55 thinker NetworkManager[784]: device added (path: /sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/net/wlan0, iface: wlan0): no ifupdown configuration found. Sep 09 21:10:55 thinker NetworkManager[784]: devices added (path: /sys/devices/virtual/net/lo, iface: lo) Sep 09 21:10:55 thinker NetworkManager[784]: device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found. Sep 09 21:10:55 thinker NetworkManager[784]: end _init. Sep 09 21:10:55 thinker NetworkManager[784]: Loaded plugin ifupdown: (C) 2008 Canonical Ltd. To report bugs please use the NetworkManager mailing list. Sep 09 21:10:55 thinker NetworkManager[784]: Loaded plugin keyfile: (c) 2007 - 2013 Red Hat, Inc. To report bugs please use the NetworkManager mailing list. Sep 09 21:10:55 thinker NetworkManager[784]: SCPlugin-Ofono: Acquired D-Bus service com.canonical.NMOfono Sep 09 21:10:55 thinker NetworkManager[784]: SCPlugin-Ofono: init! Sep 09 21:10:55 thinker NetworkManager[784]: SCPlugin-Ofono: end _init. Sep 09 21:10:55 thinker NetworkManager[784]: Loaded plugin ofono: (C) 2013 Canonical Ltd. To report bugs please use the NetworkManager mailing list. Sep 09 21:10:55 thinker NetworkManager[784]: (30644768) ... get_connections. Sep 09 21:10:55 thinker NetworkManager[784]: (30644768) ... get_connections (managed=false): return empty list. Sep 09 21:10:55 thinker NetworkManager[784]: (NetworkManager:784): GLib-CRITICAL **: g_dir_read_name: assertion 'dir != NULL' failed Sep 09 21:10:55 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/Glidden-Guest Sep 09 21:10:55 thinker kernel: PM: Syncing filesystems ... done. Sep 09 21:10:55 thinker kernel: PM: Preparing system for mem sleep Sep 09 21:11:11 thinker kernel: Freezing user space processes ... (elapsed 0.089 seconds) done. Sep 09 21:11:11 thinker kernel: Freezing remaining freezable tasks ... (elapsed 0.000 seconds) done. Sep 09 21:11:11 thinker kernel: PM: Entering mem sleep Sep 09 21:11:11 thinker kernel: Suspending console(s) (use no_console_suspend to debug) Sep 09 21:11:11 thinker kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Sep 09 21:11:11 thinker kernel: sd 0:0:0:0: [sda] Stopping disk Sep 09 21:11:11 thinker kernel: e1000e: EEE TX LPI TIMER: 00000011 Sep 09 21:11:11 thinker kernel: PM: suspend of devices complete after 895.864 msecs Sep 09 21:11:11 thinker kernel: PM: late suspend of devices complete after 16.030 msecs Sep 09 21:11:11 thinker kernel: ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI Sep 09 21:11:11 thinker kernel: ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI Sep 09 21:11:11 thinker kernel: e1000e 0000:00:19.0: System wakeup enabled by ACPI Sep 09 21:11:11 thinker kernel: PM: noirq suspend of devices complete after 15.908 msecs Sep 09 21:11:11 thinker kernel: ACPI: Preparing to enter system sleep state S3 Sep 09 21:11:11 thinker kernel: PM: Saving platform NVS memory Sep 09 21:11:11 thinker kernel: Disabling non-boot CPUs ... Sep 09 21:11:11 thinker kernel: intel_pstate CPU 1 exiting Sep 09 21:11:11 thinker kernel: kvm: disabling virtualization on CPU1 Sep 09 21:11:11 thinker kernel: smpboot: CPU 1 is now offline Sep 09 21:11:11 thinker kernel: intel_pstate CPU 2 exiting Sep 09 21:11:11 thinker kernel: kvm: disabling virtualization on CPU2 Sep 09 21:11:11 thinker kernel: smpboot: CPU 2 is now offline Sep 09 21:11:11 thinker kernel: intel_pstate CPU 3 exiting Sep 09 21:11:11 thinker kernel: kvm: disabling virtualization on CPU3 Sep 09 21:11:11 thinker kernel: smpboot: CPU 3 is now offline Sep 09 21:11:11 thinker kernel: intel_pstate CPU 4 exiting Sep 09 21:11:11 thinker kernel: kvm: disabling virtualization on CPU4 Sep 09 21:11:11 thinker kernel: smpboot: CPU 4 is now offline Sep 09 21:11:11 thinker kernel: intel_pstate CPU 5 exiting Sep 09 21:11:11 thinker kernel: kvm: disabling virtualization on CPU5 Sep 09 21:11:11 thinker kernel: smpboot: CPU 5 is now offline Sep 09 21:11:11 thinker kernel: intel_pstate CPU 6 exiting Sep 09 21:11:11 thinker kernel: kvm: disabling virtualization on CPU6 Sep 09 21:11:11 thinker kernel: smpboot: CPU 6 is now offline Sep 09 21:11:11 thinker kernel: intel_pstate CPU 7 exiting Sep 09 21:11:11 thinker kernel: kvm: disabling virtualization on CPU7 Sep 09 21:11:11 thinker kernel: smpboot: CPU 7 is now offline Sep 09 21:11:11 thinker kernel: ACPI: Low-level resume complete Sep 09 21:11:11 thinker kernel: PM: Restoring platform NVS memory Sep 09 21:11:11 thinker kernel: CPU0 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:11:11 thinker kernel: Enabling non-boot CPUs ... Sep 09 21:11:11 thinker kernel: x86: Booting SMP configuration: Sep 09 21:11:11 thinker kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1 Sep 09 21:11:11 thinker kernel: Disabled fast string operations Sep 09 21:11:11 thinker kernel: kvm: enabling virtualization on CPU1 Sep 09 21:11:11 thinker kernel: CPU1 is up Sep 09 21:11:11 thinker kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2 Sep 09 21:11:11 thinker kernel: CPU2 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:11:11 thinker kernel: Disabled fast string operations Sep 09 21:11:11 thinker kernel: kvm: enabling virtualization on CPU2 Sep 09 21:11:11 thinker kernel: CPU2 is up Sep 09 21:11:11 thinker kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3 Sep 09 21:11:11 thinker kernel: Disabled fast string operations Sep 09 21:11:11 thinker kernel: kvm: enabling virtualization on CPU3 Sep 09 21:11:11 thinker kernel: CPU3 is up Sep 09 21:11:11 thinker kernel: smpboot: Booting Node 0 Processor 4 APIC 0x4 Sep 09 21:11:11 thinker kernel: CPU4 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:11:11 thinker kernel: Disabled fast string operations Sep 09 21:11:11 thinker kernel: kvm: enabling virtualization on CPU4 Sep 09 21:11:11 thinker kernel: CPU4 is up Sep 09 21:11:11 thinker kernel: smpboot: Booting Node 0 Processor 5 APIC 0x5 Sep 09 21:11:11 thinker kernel: Disabled fast string operations Sep 09 21:11:11 thinker kernel: kvm: enabling virtualization on CPU5 Sep 09 21:11:11 thinker kernel: CPU5 is up Sep 09 21:11:11 thinker kernel: smpboot: Booting Node 0 Processor 6 APIC 0x6 Sep 09 21:11:11 thinker kernel: CPU6 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:11:11 thinker kernel: Disabled fast string operations Sep 09 21:11:11 thinker kernel: kvm: enabling virtualization on CPU6 Sep 09 21:11:11 thinker kernel: CPU6 is up Sep 09 21:11:11 thinker kernel: smpboot: Booting Node 0 Processor 7 APIC 0x7 Sep 09 21:11:11 thinker kernel: Disabled fast string operations Sep 09 21:11:11 thinker kernel: kvm: enabling virtualization on CPU7 Sep 09 21:11:11 thinker kernel: CPU7 is up Sep 09 21:11:11 thinker kernel: ACPI: Waking up from system sleep state S3 Sep 09 21:11:11 thinker kernel: ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI Sep 09 21:11:11 thinker kernel: ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI Sep 09 21:11:11 thinker kernel: sdhci-pci 0000:0d:00.0: MMC controller base frequency changed to 50Mhz. Sep 09 21:11:11 thinker kernel: PM: noirq resume of devices complete after 18.718 msecs Sep 09 21:11:11 thinker kernel: PM: early resume of devices complete after 0.325 msecs Sep 09 21:11:11 thinker kernel: e1000e 0000:00:19.0: System wakeup disabled by ACPI Sep 09 21:11:11 thinker kernel: rtc_cmos 00:02: System wakeup disabled by ACPI Sep 09 21:11:11 thinker kernel: sd 0:0:0:0: [sda] Starting disk Sep 09 21:11:11 thinker kernel: tpm_tis 00:05: TPM is disabled/deactivated (0x6) Sep 09 21:11:11 thinker kernel: usb 1-1.6: reset high-speed USB device number 6 using ehci-pci Sep 09 21:11:11 thinker kernel: ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 09 21:11:11 thinker kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) Sep 09 21:11:11 thinker kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 09 21:11:11 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:11:11 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:11:11 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:11:11 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:11:11 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:11:11 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:11:11 thinker kernel: ata1.00: configured for UDMA/133 Sep 09 21:11:11 thinker kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 09 21:11:11 thinker kernel: usb 1-1.4: reset full-speed USB device number 4 using ehci-pci Sep 09 21:11:11 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:11:11 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:11:11 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:11:11 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:11:11 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:11:11 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:11:11 thinker kernel: ata2.00: configured for UDMA/66 Sep 09 21:11:11 thinker kernel: firewire_core 0000:0d:00.3: rediscovered device fw0 Sep 09 21:11:11 thinker kernel: usb 1-1.5: reset high-speed USB device number 5 using ehci-pci Sep 09 21:11:11 thinker kernel: usb 1-1.2: reset full-speed USB device number 3 using ehci-pci Sep 09 21:11:11 thinker kernel: psmouse serio1: synaptics: queried max coordinates: x [..5888], y [..4820] Sep 09 21:11:11 thinker kernel: PM: resume of devices complete after 885.845 msecs Sep 09 21:11:11 thinker kernel: PM: Finishing wakeup. Sep 09 21:11:11 thinker kernel: Restarting tasks ... Sep 09 21:11:11 thinker kernel: ACPI: \_SB_.PCI0.LPC_.EC__.BAT1: docking Sep 09 21:11:11 thinker kernel: done. Sep 09 21:11:11 thinker kernel: ACPI: \_SB_.PCI0.LPC_.EC__.BAT1: Unable to dock! Sep 09 21:11:11 thinker kernel: usb 1-1.5.4: USB disconnect, device number 7 Sep 09 21:11:11 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/vasc1 Sep 09 21:11:11 thinker kernel: video LNXVIDEO:00: Restoring backlight state Sep 09 21:11:11 thinker kernel: video LNXVIDEO:01: Restoring backlight state Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/McDonalds Free WiFi Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/thismuch5 Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: new full-speed USB device number 8 using ehci-pci Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/Forte Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/JerrysWirelessNetwork Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/Home Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/Culvers Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/T-Mobile guest Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/RMS Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: new full-speed USB device number 9 using ehci-pci Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/thismuchmobile Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/thismuch Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: config 1 has an invalid interface number: 4 but max is 3 Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: config 1 has no interface number 3 Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: New USB device found, idVendor=1210, idProduct=000a Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: Product: Lexicon Alpha Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: Manufacturer: Lexicon Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: 1:2: cannot get freq at ep 0x1 Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:12 thinker kernel: usb 1-1.5.4: 2:2: cannot get freq at ep 0x82 Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/Taco Bell WiFi Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/NHLC(2.4GHz) Sep 09 21:11:12 thinker NetworkManager[784]: new connection /etc/NetworkManager/system-connections/Forte-Guest Sep 09 21:11:12 thinker NetworkManager[784]: SCPlugin-Ofono: (30451296) ... get_connections. Sep 09 21:11:12 thinker NetworkManager[784]: SCPlugin-Ofono: (30451296) connections count: 0 Sep 09 21:11:12 thinker NetworkManager[784]: get unmanaged devices count: 0 Sep 09 21:11:12 thinker NetworkManager[784]: monitoring kernel firmware directory '/lib/firmware'. Sep 09 21:11:12 thinker NetworkManager[784]: monitoring ifupdown state file '/run/network/ifstate'. Sep 09 21:11:13 thinker NetworkManager[784]: rfkill1: found WiFi radio killswitch (at /sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/ieee80211/phy0/rfkill1) (driver iwlwifi) Sep 09 21:11:13 thinker NetworkManager[784]: Loaded device plugin: /usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-adsl.so Sep 09 21:11:13 thinker NetworkManager[784]: Loaded device plugin: /usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-bluetooth.so Sep 09 21:11:13 thinker NetworkManager[784]: Loaded device plugin: /usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-wwan.so Sep 09 21:11:13 thinker NetworkManager[784]: Loaded device plugin: /usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-wifi.so Sep 09 21:11:13 thinker NetworkManager[784]: WiFi enabled by radio killswitch; enabled by state file Sep 09 21:11:13 thinker NetworkManager[784]: WWAN enabled by radio killswitch; enabled by state file Sep 09 21:11:13 thinker NetworkManager[784]: WiMAX enabled by radio killswitch; enabled by state file Sep 09 21:11:13 thinker NetworkManager[784]: Networking is enabled by state file Sep 09 21:11:13 thinker NetworkManager[784]: nm_device_get_device_type: assertion 'NM_IS_DEVICE (self)' failed Sep 09 21:11:13 thinker NetworkManager[784]: (lo): link connected Sep 09 21:11:13 thinker NetworkManager[784]: (lo): carrier is ON Sep 09 21:11:13 thinker NetworkManager[784]: (lo): new Generic device (driver: 'unknown' ifindex: 1) Sep 09 21:11:13 thinker NetworkManager[784]: (lo): exported as /org/freedesktop/NetworkManager/Devices/0 Sep 09 21:11:13 thinker NetworkManager[784]: nm_device_get_device_type: assertion 'NM_IS_DEVICE (self)' failed Sep 09 21:11:13 thinker NetworkManager[784]: (eth0): carrier is OFF Sep 09 21:11:13 thinker NetworkManager[784]: (eth0): new Ethernet device (driver: 'e1000e' ifindex: 2) Sep 09 21:11:13 thinker NetworkManager[784]: (eth0): exported as /org/freedesktop/NetworkManager/Devices/1 Sep 09 21:11:13 thinker NetworkManager[784]: (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 09 21:11:13 thinker NetworkManager[784]: (eth0): preparing device Sep 09 21:11:13 thinker NetworkManager[784]: (eth0): created default wired connection 'Wired connection 1' Sep 09 21:11:13 thinker NetworkManager[784]: (wlan0): using nl80211 for WiFi device control Sep 09 21:11:13 thinker NetworkManager[784]: (wlan0): driver supports Access Point (AP) mode Sep 09 21:11:13 thinker NetworkManager[784]: (wlan0): new 802.11 WiFi device (driver: 'iwlwifi' ifindex: 3) Sep 09 21:11:13 thinker NetworkManager[784]: (wlan0): exported as /org/freedesktop/NetworkManager/Devices/2 Sep 09 21:11:13 thinker NetworkManager[784]: (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 09 21:11:13 thinker kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Disabled Sep 09 21:11:13 thinker kernel: iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0 Sep 09 21:11:13 thinker kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Disabled Sep 09 21:11:13 thinker kernel: iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0 Sep 09 21:11:13 thinker NetworkManager[784]: (wlan0): preparing device Sep 09 21:11:13 thinker NetworkManager[784]: urfkill disappeared from the bus Sep 09 21:11:13 thinker NetworkManager[784]: use BlueZ version 4 Sep 09 21:11:13 thinker NetworkManager[784]: ModemManager available in the bus Sep 09 21:11:14 thinker NetworkManager[784]: wpa_supplicant started Sep 09 21:11:14 thinker wpa_supplicant[1109]: Successfully initialized wpa_supplicant Sep 09 21:11:14 thinker wpa_supplicant[1109]: dbus: wpa_dbus_get_object_properties: failed to get object properties: (none) none Sep 09 21:11:14 thinker wpa_supplicant[1109]: dbus: Failed to construct signal Sep 09 21:11:14 thinker NetworkManager[784]: could not get interface properties: No readable properties in this interface. Sep 09 21:11:14 thinker NetworkManager[784]: (wlan0): supplicant interface state: starting -> ready Sep 09 21:11:14 thinker NetworkManager[784]: (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] Sep 09 21:11:14 thinker NetworkManager[784]: could not get interface properties: No readable properties in this interface. Sep 09 21:11:14 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-SCAN-STARTED Sep 09 21:11:17 thinker NetworkManager[784]: Auto-activating connection 'thismuch5'. Sep 09 21:11:17 thinker NetworkManager[784]: Activation (wlan0) starting connection 'thismuch5' Sep 09 21:11:17 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 09 21:11:17 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 09 21:11:17 thinker NetworkManager[784]: (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 09 21:11:17 thinker NetworkManager[784]: NetworkManager state is now CONNECTING Sep 09 21:11:17 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 09 21:11:17 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 09 21:11:17 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 09 21:11:17 thinker NetworkManager[784]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 09 21:11:17 thinker NetworkManager[784]: Activation (wlan0/wireless): connection 'thismuch5' has security, and secrets exist. No new secrets needed. Sep 09 21:11:17 thinker NetworkManager[784]: Config: added 'ssid' value 'thismuch5' Sep 09 21:11:17 thinker NetworkManager[784]: Config: added 'scan_ssid' value '1' Sep 09 21:11:17 thinker NetworkManager[784]: Config: added 'key_mgmt' value 'WPA-PSK' Sep 09 21:11:17 thinker NetworkManager[784]: Config: added 'auth_alg' value 'OPEN' Sep 09 21:11:17 thinker NetworkManager[784]: Config: added 'psk' value '' Sep 09 21:11:17 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 09 21:11:17 thinker NetworkManager[784]: (wlan0): supplicant interface state: ready -> inactive Sep 09 21:11:17 thinker NetworkManager[784]: Config: set interface ap_scan to 1 Sep 09 21:11:17 thinker wpa_supplicant[1109]: wlan0: SME: Trying to authenticate with 60:a4:4c:29:0a:24 (SSID='thismuch5' freq=5745 MHz) Sep 09 21:11:17 thinker kernel: wlan0: authenticate with 60:a4:4c:29:0a:24 Sep 09 21:11:17 thinker kernel: wlan0: send auth to 60:a4:4c:29:0a:24 (try 1/3) Sep 09 21:11:17 thinker NetworkManager[784]: (wlan0): supplicant interface state: inactive -> authenticating Sep 09 21:11:17 thinker wpa_supplicant[1109]: wlan0: Trying to associate with 60:a4:4c:29:0a:24 (SSID='thismuch5' freq=5745 MHz) Sep 09 21:11:17 thinker kernel: wlan0: authenticated Sep 09 21:11:17 thinker kernel: wlan0: waiting for beacon from 60:a4:4c:29:0a:24 Sep 09 21:11:17 thinker NetworkManager[784]: (wlan0): supplicant interface state: authenticating -> associating Sep 09 21:11:17 thinker kernel: wlan0: associate with 60:a4:4c:29:0a:24 (try 1/3) Sep 09 21:11:17 thinker kernel: wlan0: RX AssocResp from 60:a4:4c:29:0a:24 (capab=0x11 status=0 aid=3) Sep 09 21:11:17 thinker kernel: wlan0: associated Sep 09 21:11:17 thinker wpa_supplicant[1109]: wlan0: Associated with 60:a4:4c:29:0a:24 Sep 09 21:11:17 thinker NetworkManager[784]: (wlan0): supplicant interface state: associating -> associated Sep 09 21:11:17 thinker NetworkManager[784]: (wlan0): supplicant interface state: associated -> 4-way handshake Sep 09 21:11:21 thinker wpa_supplicant[1109]: wlan0: WPA: Key negotiation completed with 60:a4:4c:29:0a:24 [PTK=CCMP GTK=CCMP] Sep 09 21:11:21 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-CONNECTED - Connection to 60:a4:4c:29:0a:24 completed [id=0 id_str=] Sep 09 21:11:21 thinker NetworkManager[784]: (wlan0): supplicant interface state: 4-way handshake -> completed Sep 09 21:11:21 thinker NetworkManager[784]: Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'thismuch5'. Sep 09 21:11:21 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. Sep 09 21:11:21 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... Sep 09 21:11:21 thinker NetworkManager[784]: (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] Sep 09 21:11:22 thinker NetworkManager[784]: Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) Sep 09 21:11:23 thinker NetworkManager[784]: dhclient started with pid 1137 Sep 09 21:11:23 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. Sep 09 21:11:23 thinker NetworkManager[784]: WiFi hardware radio set enabled Sep 09 21:11:23 thinker NetworkManager[784]: WWAN hardware radio set enabled Sep 09 21:11:24 thinker NetworkManager[784]: (wlan0): DHCPv4 state changed nbi -> preinit Sep 09 21:11:24 thinker dhclient[1137]: DHCPREQUEST of 192.168.1.98 on wlan0 to 255.255.255.255 port 67 (xid=0x6173e97d) Sep 09 21:11:24 thinker dhclient[1137]: DHCPACK of 192.168.1.98 from 192.168.1.1 Sep 09 21:11:24 thinker NetworkManager[784]: (wlan0): DHCPv4 state changed preinit -> reboot Sep 09 21:11:24 thinker NetworkManager[784]: address 192.168.1.98 Sep 09 21:11:24 thinker NetworkManager[784]: plen 24 (255.255.255.0) Sep 09 21:11:24 thinker NetworkManager[784]: gateway 192.168.1.1 Sep 09 21:11:24 thinker NetworkManager[784]: server identifier 192.168.1.1 Sep 09 21:11:24 thinker NetworkManager[784]: lease time 86400 Sep 09 21:11:24 thinker NetworkManager[784]: hostname 'thinker' Sep 09 21:11:24 thinker NetworkManager[784]: nameserver '192.168.1.1' Sep 09 21:11:24 thinker NetworkManager[784]: domain name 'thismuch.net' Sep 09 21:11:24 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled... Sep 09 21:11:24 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started... Sep 09 21:11:24 thinker NetworkManager[784]: (wlan0): device state change: ip-config -> ip-check (reason 'none') [70 80 0] Sep 09 21:11:24 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete. Sep 09 21:11:24 thinker NetworkManager[784]: (wlan0): device state change: ip-check -> secondaries (reason 'none') [80 90 0] Sep 09 21:11:24 thinker NetworkManager[784]: (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0] Sep 09 21:11:24 thinker NetworkManager[784]: NetworkManager state is now CONNECTED_LOCAL Sep 09 21:11:24 thinker dhclient[1137]: bound to 192.168.1.98 -- renewal in 39282 seconds. Sep 09 21:11:24 thinker NetworkManager[784]: NetworkManager state is now CONNECTED_GLOBAL Sep 09 21:11:24 thinker NetworkManager[784]: Policy set 'thismuch5' (wlan0) as default for IPv4 routing and DNS. Sep 09 21:11:24 thinker NetworkManager[784]: DNS: starting dnsmasq... Sep 09 21:11:24 thinker NetworkManager[784]: dnsmasq not available on the bus, can't update servers. Sep 09 21:11:24 thinker NetworkManager[784]: [1441851084.348652] [dns-manager/nm-dns-dnsmasq.c:398] update(): dnsmasq owner not found on bus: Could not get owner of name 'org.freedesktop.NetworkManager.dnsmasq': no such name Sep 09 21:11:24 thinker NetworkManager[784]: DNS: plugin dnsmasq update failed Sep 09 21:11:24 thinker NetworkManager[784]: Writing DNS information to /sbin/resolvconf Sep 09 21:11:25 thinker NetworkManager[784]: Activation (wlan0) successful, device activated. Sep 09 21:11:25 thinker NetworkManager[784]: startup complete Sep 09 21:11:25 thinker NetworkManager[784]: dnsmasq appeared on DBus: :1.19 Sep 09 21:11:25 thinker NetworkManager[784]: Writing DNS information to /sbin/resolvconf Sep 09 21:11:25 thinker kernel: vboxdrv: Found 8 processor cores. Sep 09 21:11:25 thinker kernel: vboxdrv: fAsync=0 offMin=0x25c offMax=0x126b0 Sep 09 21:11:25 thinker kernel: vboxdrv: TSC mode is 'synchronous', kernel timer mode is 'normal'. Sep 09 21:11:25 thinker kernel: vboxdrv: Successfully loaded version 4.3.26_Ubuntu (interface 0x001a000a). Sep 09 21:11:25 thinker kernel: vboxpci: IOMMU not found (not registered) Sep 09 21:11:29 thinker kernel: bbswitch: version 0.7 Sep 09 21:11:29 thinker kernel: bbswitch: Found integrated VGA device 0000:00:02.0: \_SB_.PCI0.VID_ Sep 09 21:11:29 thinker kernel: bbswitch: Found discrete VGA device 0000:01:00.0: \_SB_.PCI0.PEG_.VID_ Sep 09 21:11:29 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:29 thinker kernel: bbswitch: detected an Optimus _DSM function Sep 09 21:11:29 thinker kernel: bbswitch: Succesfully loaded. Discrete card 0000:01:00.0 is on Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:30 thinker kernel: ACPI Warning: \_SB_.PCI0.PEG_.VID_._DSM: Argument #4 type mismatch - Found [Buffer], ACPI requires [Package] (20141107/nsarguments-95) Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:36 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:37 thinker NetworkManager[784]: sleep requested (sleeping: no enabled: yes) Sep 09 21:11:37 thinker NetworkManager[784]: sleeping... Sep 09 21:11:37 thinker NetworkManager[784]: (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37] Sep 09 21:11:37 thinker NetworkManager[784]: (wlan0): deactivating device (reason 'sleeping') [37] Sep 09 21:11:37 thinker NetworkManager[784]: (wlan0): canceled DHCP transaction, DHCP client pid 1137 Sep 09 21:11:37 thinker NetworkManager[784]: _nl_get_vtable: assertion 'vtable.handle' failed Sep 09 21:11:37 thinker kernel: wlan0: deauthenticating from 60:a4:4c:29:0a:24 by local choice (Reason: 3=DEAUTH_LEAVING) Sep 09 21:11:37 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-DISCONNECTED bssid=60:a4:4c:29:0a:24 reason=3 locally_generated=1 Sep 09 21:11:37 thinker NetworkManager[784]: Writing DNS information to /sbin/resolvconf Sep 09 21:11:37 thinker kernel: cfg80211: Calling CRDA to update world regulatory domain Sep 09 21:11:37 thinker kernel: cfg80211: World regulatory domain updated: Sep 09 21:11:37 thinker kernel: cfg80211: DFS Master region: unset Sep 09 21:11:37 thinker kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Sep 09 21:11:37 thinker kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:11:37 thinker kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:11:37 thinker kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:11:37 thinker kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Sep 09 21:11:37 thinker kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Sep 09 21:11:37 thinker kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Sep 09 21:11:37 thinker kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:11:37 thinker kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Sep 09 21:11:37 thinker NetworkManager[784]: NetworkManager state is now ASLEEP Sep 09 21:11:37 thinker kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready Sep 09 21:11:40 thinker kernel: PM: Syncing filesystems ... done. Sep 09 21:11:40 thinker kernel: PM: Preparing system for mem sleep Sep 09 21:11:54 thinker kernel: Freezing user space processes ... (elapsed 0.013 seconds) done. Sep 09 21:11:54 thinker kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. Sep 09 21:11:54 thinker kernel: PM: Entering mem sleep Sep 09 21:11:54 thinker kernel: Suspending console(s) (use no_console_suspend to debug) Sep 09 21:11:54 thinker kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Sep 09 21:11:54 thinker kernel: sd 0:0:0:0: [sda] Stopping disk Sep 09 21:11:54 thinker kernel: e1000e: EEE TX LPI TIMER: 00000011 Sep 09 21:11:54 thinker kernel: PM: suspend of devices complete after 801.357 msecs Sep 09 21:11:54 thinker kernel: PM: late suspend of devices complete after 13.236 msecs Sep 09 21:11:54 thinker kernel: ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI Sep 09 21:11:54 thinker kernel: ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI Sep 09 21:11:54 thinker kernel: e1000e 0000:00:19.0: System wakeup enabled by ACPI Sep 09 21:11:54 thinker kernel: PM: noirq suspend of devices complete after 16.036 msecs Sep 09 21:11:54 thinker kernel: ACPI: Preparing to enter system sleep state S3 Sep 09 21:11:54 thinker kernel: PM: Saving platform NVS memory Sep 09 21:11:54 thinker kernel: Disabling non-boot CPUs ... Sep 09 21:11:54 thinker kernel: intel_pstate CPU 1 exiting Sep 09 21:11:54 thinker kernel: kvm: disabling virtualization on CPU1 Sep 09 21:11:54 thinker kernel: smpboot: CPU 1 is now offline Sep 09 21:11:54 thinker kernel: intel_pstate CPU 2 exiting Sep 09 21:11:54 thinker kernel: Broke affinity for irq 32 Sep 09 21:11:54 thinker kernel: kvm: disabling virtualization on CPU2 Sep 09 21:11:54 thinker kernel: smpboot: CPU 2 is now offline Sep 09 21:11:54 thinker kernel: intel_pstate CPU 3 exiting Sep 09 21:11:54 thinker kernel: Broke affinity for irq 23 Sep 09 21:11:54 thinker kernel: kvm: disabling virtualization on CPU3 Sep 09 21:11:54 thinker kernel: smpboot: CPU 3 is now offline Sep 09 21:11:54 thinker kernel: intel_pstate CPU 4 exiting Sep 09 21:11:54 thinker kernel: kvm: disabling virtualization on CPU4 Sep 09 21:11:54 thinker kernel: smpboot: CPU 4 is now offline Sep 09 21:11:54 thinker kernel: intel_pstate CPU 5 exiting Sep 09 21:11:54 thinker kernel: Broke affinity for irq 16 Sep 09 21:11:54 thinker kernel: Broke affinity for irq 27 Sep 09 21:11:54 thinker kernel: kvm: disabling virtualization on CPU5 Sep 09 21:11:54 thinker kernel: smpboot: CPU 5 is now offline Sep 09 21:11:54 thinker kernel: intel_pstate CPU 6 exiting Sep 09 21:11:54 thinker kernel: kvm: disabling virtualization on CPU6 Sep 09 21:11:54 thinker kernel: smpboot: CPU 6 is now offline Sep 09 21:11:54 thinker kernel: intel_pstate CPU 7 exiting Sep 09 21:11:54 thinker kernel: kvm: disabling virtualization on CPU7 Sep 09 21:11:54 thinker kernel: smpboot: CPU 7 is now offline Sep 09 21:11:54 thinker kernel: ACPI: Low-level resume complete Sep 09 21:11:54 thinker kernel: PM: Restoring platform NVS memory Sep 09 21:11:54 thinker kernel: CPU0 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:11:54 thinker kernel: Enabling non-boot CPUs ... Sep 09 21:11:54 thinker kernel: x86: Booting SMP configuration: Sep 09 21:11:54 thinker kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1 Sep 09 21:11:54 thinker kernel: Disabled fast string operations Sep 09 21:11:54 thinker kernel: kvm: enabling virtualization on CPU1 Sep 09 21:11:54 thinker kernel: CPU1 is up Sep 09 21:11:54 thinker kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2 Sep 09 21:11:54 thinker kernel: CPU2 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:11:54 thinker kernel: Disabled fast string operations Sep 09 21:11:54 thinker kernel: kvm: enabling virtualization on CPU2 Sep 09 21:11:54 thinker kernel: CPU2 is up Sep 09 21:11:54 thinker kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3 Sep 09 21:11:54 thinker kernel: Disabled fast string operations Sep 09 21:11:54 thinker kernel: kvm: enabling virtualization on CPU3 Sep 09 21:11:54 thinker kernel: CPU3 is up Sep 09 21:11:54 thinker kernel: smpboot: Booting Node 0 Processor 4 APIC 0x4 Sep 09 21:11:54 thinker kernel: CPU4 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:11:54 thinker kernel: Disabled fast string operations Sep 09 21:11:54 thinker kernel: kvm: enabling virtualization on CPU4 Sep 09 21:11:54 thinker kernel: CPU4 is up Sep 09 21:11:54 thinker kernel: smpboot: Booting Node 0 Processor 5 APIC 0x5 Sep 09 21:11:54 thinker kernel: Disabled fast string operations Sep 09 21:11:54 thinker kernel: kvm: enabling virtualization on CPU5 Sep 09 21:11:54 thinker kernel: CPU5 is up Sep 09 21:11:54 thinker kernel: smpboot: Booting Node 0 Processor 6 APIC 0x6 Sep 09 21:11:54 thinker kernel: CPU6 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:11:54 thinker kernel: Disabled fast string operations Sep 09 21:11:54 thinker kernel: kvm: enabling virtualization on CPU6 Sep 09 21:11:54 thinker kernel: CPU6 is up Sep 09 21:11:54 thinker kernel: smpboot: Booting Node 0 Processor 7 APIC 0x7 Sep 09 21:11:54 thinker kernel: Disabled fast string operations Sep 09 21:11:54 thinker kernel: kvm: enabling virtualization on CPU7 Sep 09 21:11:54 thinker kernel: CPU7 is up Sep 09 21:11:54 thinker kernel: ACPI: Waking up from system sleep state S3 Sep 09 21:11:54 thinker kernel: ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI Sep 09 21:11:54 thinker kernel: ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI Sep 09 21:11:54 thinker kernel: sdhci-pci 0000:0d:00.0: MMC controller base frequency changed to 50Mhz. Sep 09 21:11:54 thinker kernel: PM: noirq resume of devices complete after 20.401 msecs Sep 09 21:11:54 thinker kernel: PM: early resume of devices complete after 0.322 msecs Sep 09 21:11:54 thinker kernel: e1000e 0000:00:19.0: System wakeup disabled by ACPI Sep 09 21:11:54 thinker kernel: mei_me 0000:00:16.0: less data available than length=00000002. Sep 09 21:11:54 thinker kernel: rtc_cmos 00:02: System wakeup disabled by ACPI Sep 09 21:11:54 thinker kernel: sd 0:0:0:0: [sda] Starting disk Sep 09 21:11:54 thinker kernel: tpm_tis 00:05: TPM is disabled/deactivated (0x6) Sep 09 21:11:54 thinker kernel: usb 1-1.6: reset high-speed USB device number 6 using ehci-pci Sep 09 21:11:54 thinker kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 09 21:11:54 thinker kernel: ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 09 21:11:54 thinker kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) Sep 09 21:11:54 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:11:54 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:11:54 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:11:54 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:11:54 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:11:54 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:11:54 thinker kernel: ata1.00: configured for UDMA/133 Sep 09 21:11:54 thinker kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 09 21:11:54 thinker kernel: usb 1-1.2: reset full-speed USB device number 3 using ehci-pci Sep 09 21:11:54 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:11:54 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:11:54 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:11:54 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:11:54 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:11:54 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:11:54 thinker kernel: ata2.00: configured for UDMA/66 Sep 09 21:11:54 thinker kernel: firewire_core 0000:0d:00.3: rediscovered device fw0 Sep 09 21:11:54 thinker kernel: usb 1-1.5: reset high-speed USB device number 5 using ehci-pci Sep 09 21:11:54 thinker kernel: usb 1-1.4: reset full-speed USB device number 4 using ehci-pci Sep 09 21:11:54 thinker kernel: PM: resume of devices complete after 822.030 msecs Sep 09 21:11:54 thinker kernel: PM: Finishing wakeup. Sep 09 21:11:54 thinker kernel: Restarting tasks ... Sep 09 21:11:54 thinker kernel: usb 1-1.5.4: USB disconnect, device number 9 Sep 09 21:11:54 thinker kernel: done. Sep 09 21:11:54 thinker kernel: video LNXVIDEO:00: Restoring backlight state Sep 09 21:11:54 thinker kernel: video LNXVIDEO:01: Restoring backlight state Sep 09 21:11:54 thinker kernel: psmouse serio1: synaptics: queried max coordinates: x [..5888], y [..4820] Sep 09 21:11:54 thinker NetworkManager[784]: wake requested (sleeping: yes enabled: yes) Sep 09 21:11:54 thinker NetworkManager[784]: waking up... Sep 09 21:11:54 thinker NetworkManager[784]: (eth0): device state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37] Sep 09 21:11:55 thinker kernel: e1000e: eth0 NIC Link is Down Sep 09 21:11:55 thinker NetworkManager[784]: (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 09 21:11:55 thinker kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Sep 09 21:11:55 thinker NetworkManager[784]: (eth0): preparing device Sep 09 21:11:55 thinker NetworkManager[784]: (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 09 21:11:55 thinker kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Disabled Sep 09 21:11:55 thinker kernel: iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: new full-speed USB device number 10 using ehci-pci Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: config 1 has an invalid interface number: 4 but max is 3 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: config 1 has no interface number 3 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: New USB device found, idVendor=1210, idProduct=000a Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: Product: Lexicon Alpha Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: Manufacturer: Lexicon Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 1:2: cannot get freq at ep 0x1 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:2: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Disabled Sep 09 21:11:55 thinker kernel: iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker NetworkManager[784]: (wlan0): preparing device Sep 09 21:11:55 thinker NetworkManager[784]: NetworkManager state is now DISCONNECTED Sep 09 21:11:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:11:55 thinker kernel: audit_printk_skb: 33 callbacks suppressed Sep 09 21:11:55 thinker kernel: audit: type=1400 audit(1441851115.705:23): apparmor="DENIED" operation="open" profile="/usr/lib/telepathy/mission-control-5" name="/usr/share/dconf/profile/gdm" pid=1763 comm="mission-control" requested_mask="r" denied_mask="r" fsuid=116 ouid=0 Sep 09 21:11:55 thinker wpa_supplicant[1109]: dbus: wpa_dbus_get_object_properties: failed to get object properties: (none) none Sep 09 21:11:55 thinker wpa_supplicant[1109]: dbus: Failed to construct signal Sep 09 21:11:55 thinker NetworkManager[784]: could not get interface properties: No readable properties in this interface. Sep 09 21:11:55 thinker NetworkManager[784]: (wlan0): supplicant interface state: starting -> ready Sep 09 21:11:55 thinker NetworkManager[784]: (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] Sep 09 21:11:55 thinker NetworkManager[784]: could not get interface properties: No readable properties in this interface. Sep 09 21:11:55 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-SCAN-STARTED Sep 09 21:11:58 thinker NetworkManager[784]: Auto-activating connection 'thismuch5'. Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) starting connection 'thismuch5' Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 09 21:11:58 thinker NetworkManager[784]: NetworkManager state is now CONNECTING Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0/wireless): access point 'thismuch5' has security, but secrets are required. Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0] Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): supplicant interface state: ready -> inactive Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0] Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0/wireless): connection 'thismuch5' has security, and secrets exist. No new secrets needed. Sep 09 21:11:58 thinker NetworkManager[784]: Config: added 'ssid' value 'thismuch5' Sep 09 21:11:58 thinker NetworkManager[784]: Config: added 'scan_ssid' value '1' Sep 09 21:11:58 thinker NetworkManager[784]: Config: added 'key_mgmt' value 'WPA-PSK' Sep 09 21:11:58 thinker NetworkManager[784]: Config: added 'auth_alg' value 'OPEN' Sep 09 21:11:58 thinker NetworkManager[784]: Config: added 'psk' value '' Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 09 21:11:58 thinker NetworkManager[784]: Config: set interface ap_scan to 1 Sep 09 21:11:58 thinker wpa_supplicant[1109]: wlan0: SME: Trying to authenticate with 60:a4:4c:29:0a:24 (SSID='thismuch5' freq=5745 MHz) Sep 09 21:11:58 thinker kernel: wlan0: authenticate with 60:a4:4c:29:0a:24 Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): supplicant interface state: inactive -> authenticating Sep 09 21:11:58 thinker kernel: wlan0: send auth to 60:a4:4c:29:0a:24 (try 1/3) Sep 09 21:11:58 thinker wpa_supplicant[1109]: wlan0: Trying to associate with 60:a4:4c:29:0a:24 (SSID='thismuch5' freq=5745 MHz) Sep 09 21:11:58 thinker kernel: wlan0: authenticated Sep 09 21:11:58 thinker kernel: wlan0: associate with 60:a4:4c:29:0a:24 (try 1/3) Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): supplicant interface state: authenticating -> associating Sep 09 21:11:58 thinker kernel: wlan0: RX AssocResp from 60:a4:4c:29:0a:24 (capab=0x11 status=0 aid=3) Sep 09 21:11:58 thinker kernel: wlan0: associated Sep 09 21:11:58 thinker wpa_supplicant[1109]: wlan0: Associated with 60:a4:4c:29:0a:24 Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): supplicant interface state: associating -> 4-way handshake Sep 09 21:11:58 thinker wpa_supplicant[1109]: wlan0: WPA: Key negotiation completed with 60:a4:4c:29:0a:24 [PTK=CCMP GTK=CCMP] Sep 09 21:11:58 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-CONNECTED - Connection to 60:a4:4c:29:0a:24 completed [id=0 id_str=] Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): supplicant interface state: 4-way handshake -> completed Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'thismuch5'. Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) Sep 09 21:11:58 thinker NetworkManager[784]: dhclient started with pid 1845 Sep 09 21:11:58 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. Sep 09 21:11:58 thinker NetworkManager[784]: (wlan0): DHCPv4 state changed nbi -> preinit Sep 09 21:11:58 thinker dhclient[1845]: DHCPREQUEST of 192.168.1.98 on wlan0 to 255.255.255.255 port 67 (xid=0x572389a8) Sep 09 21:12:01 thinker dhclient[1845]: DHCPREQUEST of 192.168.1.98 on wlan0 to 255.255.255.255 port 67 (xid=0x572389a8) Sep 09 21:12:01 thinker dhclient[1845]: DHCPACK of 192.168.1.98 from 192.168.1.1 Sep 09 21:12:01 thinker NetworkManager[784]: (wlan0): DHCPv4 state changed preinit -> reboot Sep 09 21:12:01 thinker NetworkManager[784]: address 192.168.1.98 Sep 09 21:12:01 thinker NetworkManager[784]: plen 24 (255.255.255.0) Sep 09 21:12:01 thinker NetworkManager[784]: gateway 192.168.1.1 Sep 09 21:12:01 thinker NetworkManager[784]: server identifier 192.168.1.1 Sep 09 21:12:01 thinker NetworkManager[784]: lease time 86400 Sep 09 21:12:01 thinker NetworkManager[784]: hostname 'thinker' Sep 09 21:12:01 thinker NetworkManager[784]: nameserver '192.168.1.1' Sep 09 21:12:01 thinker NetworkManager[784]: domain name 'thismuch.net' Sep 09 21:12:01 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled... Sep 09 21:12:01 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started... Sep 09 21:12:01 thinker NetworkManager[784]: (wlan0): device state change: ip-config -> ip-check (reason 'none') [70 80 0] Sep 09 21:12:01 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete. Sep 09 21:12:01 thinker NetworkManager[784]: (wlan0): device state change: ip-check -> secondaries (reason 'none') [80 90 0] Sep 09 21:12:01 thinker NetworkManager[784]: (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0] Sep 09 21:12:01 thinker NetworkManager[784]: NetworkManager state is now CONNECTED_LOCAL Sep 09 21:12:01 thinker dhclient[1845]: bound to 192.168.1.98 -- renewal in 36170 seconds. Sep 09 21:12:01 thinker NetworkManager[784]: NetworkManager state is now CONNECTED_GLOBAL Sep 09 21:12:01 thinker NetworkManager[784]: Policy set 'thismuch5' (wlan0) as default for IPv4 routing and DNS. Sep 09 21:12:01 thinker NetworkManager[784]: Writing DNS information to /sbin/resolvconf Sep 09 21:12:01 thinker NetworkManager[784]: Activation (wlan0) successful, device activated. Sep 09 21:12:37 thinker NetworkManager[784]: sleep requested (sleeping: no enabled: yes) Sep 09 21:12:37 thinker NetworkManager[784]: sleeping... Sep 09 21:12:37 thinker NetworkManager[784]: (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37] Sep 09 21:12:37 thinker NetworkManager[784]: (wlan0): deactivating device (reason 'sleeping') [37] Sep 09 21:12:37 thinker NetworkManager[784]: (wlan0): canceled DHCP transaction, DHCP client pid 1845 Sep 09 21:12:37 thinker kernel: wlan0: deauthenticating from 60:a4:4c:29:0a:24 by local choice (Reason: 3=DEAUTH_LEAVING) Sep 09 21:12:37 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-DISCONNECTED bssid=60:a4:4c:29:0a:24 reason=3 locally_generated=1 Sep 09 21:12:37 thinker NetworkManager[784]: Writing DNS information to /sbin/resolvconf Sep 09 21:12:37 thinker kernel: cfg80211: Calling CRDA to update world regulatory domain Sep 09 21:12:37 thinker kernel: cfg80211: World regulatory domain updated: Sep 09 21:12:37 thinker kernel: cfg80211: DFS Master region: unset Sep 09 21:12:37 thinker kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Sep 09 21:12:37 thinker kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:12:37 thinker kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:12:37 thinker kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:12:37 thinker kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Sep 09 21:12:37 thinker kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Sep 09 21:12:37 thinker kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Sep 09 21:12:37 thinker kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:12:37 thinker kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Sep 09 21:12:37 thinker NetworkManager[784]: NetworkManager state is now ASLEEP Sep 09 21:12:37 thinker kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready Sep 09 21:12:38 thinker kernel: PM: Syncing filesystems ... done. Sep 09 21:12:38 thinker kernel: PM: Preparing system for mem sleep Sep 09 21:12:49 thinker kernel: Freezing user space processes ... (elapsed 0.001 seconds) done. Sep 09 21:12:49 thinker kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. Sep 09 21:12:49 thinker kernel: PM: Entering mem sleep Sep 09 21:12:49 thinker kernel: Suspending console(s) (use no_console_suspend to debug) Sep 09 21:12:49 thinker kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Sep 09 21:12:49 thinker kernel: sd 0:0:0:0: [sda] Stopping disk Sep 09 21:12:49 thinker kernel: e1000e: EEE TX LPI TIMER: 00000011 Sep 09 21:12:49 thinker kernel: PM: suspend of devices complete after 822.335 msecs Sep 09 21:12:49 thinker kernel: PM: late suspend of devices complete after 14.573 msecs Sep 09 21:12:49 thinker kernel: ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI Sep 09 21:12:49 thinker kernel: ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI Sep 09 21:12:49 thinker kernel: e1000e 0000:00:19.0: System wakeup enabled by ACPI Sep 09 21:12:49 thinker kernel: PM: noirq suspend of devices complete after 19.778 msecs Sep 09 21:12:49 thinker kernel: ACPI: Preparing to enter system sleep state S3 Sep 09 21:12:49 thinker kernel: PM: Saving platform NVS memory Sep 09 21:12:49 thinker kernel: Disabling non-boot CPUs ... Sep 09 21:12:49 thinker kernel: intel_pstate CPU 1 exiting Sep 09 21:12:49 thinker kernel: kvm: disabling virtualization on CPU1 Sep 09 21:12:49 thinker kernel: smpboot: CPU 1 is now offline Sep 09 21:12:49 thinker kernel: intel_pstate CPU 2 exiting Sep 09 21:12:49 thinker kernel: kvm: disabling virtualization on CPU2 Sep 09 21:12:49 thinker kernel: smpboot: CPU 2 is now offline Sep 09 21:12:49 thinker kernel: intel_pstate CPU 3 exiting Sep 09 21:12:49 thinker kernel: Broke affinity for irq 16 Sep 09 21:12:49 thinker kernel: Broke affinity for irq 27 Sep 09 21:12:49 thinker kernel: kvm: disabling virtualization on CPU3 Sep 09 21:12:49 thinker kernel: smpboot: CPU 3 is now offline Sep 09 21:12:49 thinker kernel: intel_pstate CPU 4 exiting Sep 09 21:12:49 thinker kernel: kvm: disabling virtualization on CPU4 Sep 09 21:12:49 thinker kernel: smpboot: CPU 4 is now offline Sep 09 21:12:49 thinker kernel: intel_pstate CPU 5 exiting Sep 09 21:12:49 thinker kernel: kvm: disabling virtualization on CPU5 Sep 09 21:12:49 thinker kernel: smpboot: CPU 5 is now offline Sep 09 21:12:49 thinker kernel: intel_pstate CPU 6 exiting Sep 09 21:12:49 thinker kernel: kvm: disabling virtualization on CPU6 Sep 09 21:12:49 thinker kernel: smpboot: CPU 6 is now offline Sep 09 21:12:49 thinker kernel: intel_pstate CPU 7 exiting Sep 09 21:12:49 thinker kernel: kvm: disabling virtualization on CPU7 Sep 09 21:12:49 thinker kernel: smpboot: CPU 7 is now offline Sep 09 21:12:49 thinker kernel: ACPI: Low-level resume complete Sep 09 21:12:49 thinker kernel: PM: Restoring platform NVS memory Sep 09 21:12:49 thinker kernel: CPU0 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:12:49 thinker kernel: Enabling non-boot CPUs ... Sep 09 21:12:49 thinker kernel: x86: Booting SMP configuration: Sep 09 21:12:49 thinker kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1 Sep 09 21:12:49 thinker kernel: Disabled fast string operations Sep 09 21:12:49 thinker kernel: kvm: enabling virtualization on CPU1 Sep 09 21:12:49 thinker kernel: CPU1 is up Sep 09 21:12:49 thinker kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2 Sep 09 21:12:49 thinker kernel: CPU2 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:12:49 thinker kernel: Disabled fast string operations Sep 09 21:12:49 thinker kernel: kvm: enabling virtualization on CPU2 Sep 09 21:12:49 thinker kernel: CPU2 is up Sep 09 21:12:49 thinker kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3 Sep 09 21:12:49 thinker kernel: Disabled fast string operations Sep 09 21:12:49 thinker kernel: kvm: enabling virtualization on CPU3 Sep 09 21:12:49 thinker kernel: CPU3 is up Sep 09 21:12:49 thinker kernel: smpboot: Booting Node 0 Processor 4 APIC 0x4 Sep 09 21:12:49 thinker kernel: CPU4 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:12:49 thinker kernel: Disabled fast string operations Sep 09 21:12:49 thinker kernel: kvm: enabling virtualization on CPU4 Sep 09 21:12:49 thinker kernel: CPU4 is up Sep 09 21:12:49 thinker kernel: smpboot: Booting Node 0 Processor 5 APIC 0x5 Sep 09 21:12:49 thinker kernel: Disabled fast string operations Sep 09 21:12:49 thinker kernel: kvm: enabling virtualization on CPU5 Sep 09 21:12:49 thinker kernel: CPU5 is up Sep 09 21:12:49 thinker kernel: smpboot: Booting Node 0 Processor 6 APIC 0x6 Sep 09 21:12:49 thinker kernel: CPU6 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:12:49 thinker kernel: Disabled fast string operations Sep 09 21:12:49 thinker kernel: kvm: enabling virtualization on CPU6 Sep 09 21:12:49 thinker kernel: CPU6 is up Sep 09 21:12:49 thinker kernel: smpboot: Booting Node 0 Processor 7 APIC 0x7 Sep 09 21:12:49 thinker kernel: Disabled fast string operations Sep 09 21:12:49 thinker kernel: kvm: enabling virtualization on CPU7 Sep 09 21:12:49 thinker kernel: CPU7 is up Sep 09 21:12:49 thinker kernel: ACPI: Waking up from system sleep state S3 Sep 09 21:12:49 thinker kernel: ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI Sep 09 21:12:49 thinker kernel: ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI Sep 09 21:12:49 thinker kernel: sdhci-pci 0000:0d:00.0: MMC controller base frequency changed to 50Mhz. Sep 09 21:12:49 thinker kernel: PM: noirq resume of devices complete after 18.210 msecs Sep 09 21:12:49 thinker kernel: PM: early resume of devices complete after 0.275 msecs Sep 09 21:12:49 thinker kernel: e1000e 0000:00:19.0: System wakeup disabled by ACPI Sep 09 21:12:49 thinker kernel: rtc_cmos 00:02: System wakeup disabled by ACPI Sep 09 21:12:49 thinker kernel: sd 0:0:0:0: [sda] Starting disk Sep 09 21:12:49 thinker kernel: tpm_tis 00:05: TPM is disabled/deactivated (0x6) Sep 09 21:12:49 thinker kernel: usb 1-1.4: reset full-speed USB device number 4 using ehci-pci Sep 09 21:12:49 thinker kernel: ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 09 21:12:49 thinker kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) Sep 09 21:12:49 thinker kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 09 21:12:49 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:12:49 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:12:49 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:12:49 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:12:49 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:12:49 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:12:49 thinker kernel: ata1.00: configured for UDMA/133 Sep 09 21:12:49 thinker kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 09 21:12:49 thinker kernel: usb 1-1.5: reset high-speed USB device number 5 using ehci-pci Sep 09 21:12:49 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:12:49 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:12:49 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:12:49 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:12:49 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:12:49 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:12:49 thinker kernel: ata2.00: configured for UDMA/66 Sep 09 21:12:49 thinker kernel: firewire_core 0000:0d:00.3: rediscovered device fw0 Sep 09 21:12:49 thinker kernel: usb 1-1.2: reset full-speed USB device number 3 using ehci-pci Sep 09 21:12:49 thinker kernel: usb 1-1.6: reset high-speed USB device number 6 using ehci-pci Sep 09 21:12:49 thinker kernel: PM: resume of devices complete after 827.845 msecs Sep 09 21:12:49 thinker kernel: PM: Finishing wakeup. Sep 09 21:12:49 thinker kernel: Restarting tasks ... done. Sep 09 21:12:49 thinker kernel: usb 1-1.5.4: USB disconnect, device number 10 Sep 09 21:12:49 thinker kernel: video LNXVIDEO:00: Restoring backlight state Sep 09 21:12:49 thinker kernel: video LNXVIDEO:01: Restoring backlight state Sep 09 21:12:49 thinker NetworkManager[784]: wake requested (sleeping: yes enabled: yes) Sep 09 21:12:49 thinker NetworkManager[784]: waking up... Sep 09 21:12:49 thinker NetworkManager[784]: (eth0): device state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37] Sep 09 21:12:49 thinker kernel: psmouse serio1: synaptics: queried max coordinates: x [..5888], y [..4820] Sep 09 21:12:50 thinker NetworkManager[784]: (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 09 21:12:50 thinker kernel: e1000e: eth0 NIC Link is Down Sep 09 21:12:50 thinker kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Sep 09 21:12:50 thinker NetworkManager[784]: (eth0): preparing device Sep 09 21:12:50 thinker NetworkManager[784]: (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 09 21:12:50 thinker kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Disabled Sep 09 21:12:50 thinker kernel: iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0 Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: new full-speed USB device number 12 using ehci-pci Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: config 1 has an invalid interface number: 4 but max is 3 Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: config 1 has no interface number 3 Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: New USB device found, idVendor=1210, idProduct=000a Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: Product: Lexicon Alpha Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: Manufacturer: Lexicon Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: 1:2: cannot get freq at ep 0x1 Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:12:50 thinker kernel: usb 1-1.5.4: 2:2: cannot get freq at ep 0x82 Sep 09 21:12:50 thinker kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Disabled Sep 09 21:12:50 thinker kernel: iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0 Sep 09 21:12:50 thinker NetworkManager[784]: (wlan0): preparing device Sep 09 21:12:50 thinker NetworkManager[784]: NetworkManager state is now DISCONNECTED Sep 09 21:12:50 thinker wpa_supplicant[1109]: dbus: wpa_dbus_get_object_properties: failed to get object properties: (none) none Sep 09 21:12:50 thinker wpa_supplicant[1109]: dbus: Failed to construct signal Sep 09 21:12:50 thinker NetworkManager[784]: could not get interface properties: No readable properties in this interface. Sep 09 21:12:50 thinker NetworkManager[784]: (wlan0): supplicant interface state: starting -> ready Sep 09 21:12:50 thinker NetworkManager[784]: (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] Sep 09 21:12:50 thinker NetworkManager[784]: could not get interface properties: No readable properties in this interface. Sep 09 21:12:50 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-SCAN-STARTED Sep 09 21:12:53 thinker NetworkManager[784]: Auto-activating connection 'thismuch5'. Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) starting connection 'thismuch5' Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 09 21:12:53 thinker NetworkManager[784]: NetworkManager state is now CONNECTING Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0/wireless): access point 'thismuch5' has security, but secrets are required. Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0] Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): supplicant interface state: ready -> inactive Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0] Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0/wireless): connection 'thismuch5' has security, and secrets exist. No new secrets needed. Sep 09 21:12:53 thinker NetworkManager[784]: Config: added 'ssid' value 'thismuch5' Sep 09 21:12:53 thinker NetworkManager[784]: Config: added 'scan_ssid' value '1' Sep 09 21:12:53 thinker NetworkManager[784]: Config: added 'key_mgmt' value 'WPA-PSK' Sep 09 21:12:53 thinker NetworkManager[784]: Config: added 'auth_alg' value 'OPEN' Sep 09 21:12:53 thinker NetworkManager[784]: Config: added 'psk' value '' Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 09 21:12:53 thinker NetworkManager[784]: Config: set interface ap_scan to 1 Sep 09 21:12:53 thinker wpa_supplicant[1109]: wlan0: SME: Trying to authenticate with 60:a4:4c:29:0a:24 (SSID='thismuch5' freq=5745 MHz) Sep 09 21:12:53 thinker kernel: wlan0: authenticate with 60:a4:4c:29:0a:24 Sep 09 21:12:53 thinker kernel: wlan0: send auth to 60:a4:4c:29:0a:24 (try 1/3) Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): supplicant interface state: inactive -> authenticating Sep 09 21:12:53 thinker wpa_supplicant[1109]: wlan0: Trying to associate with 60:a4:4c:29:0a:24 (SSID='thismuch5' freq=5745 MHz) Sep 09 21:12:53 thinker kernel: wlan0: authenticated Sep 09 21:12:53 thinker kernel: wlan0: associate with 60:a4:4c:29:0a:24 (try 1/3) Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): supplicant interface state: authenticating -> associating Sep 09 21:12:53 thinker kernel: wlan0: RX AssocResp from 60:a4:4c:29:0a:24 (capab=0x11 status=0 aid=3) Sep 09 21:12:53 thinker wpa_supplicant[1109]: wlan0: Associated with 60:a4:4c:29:0a:24 Sep 09 21:12:53 thinker kernel: wlan0: associated Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): supplicant interface state: associating -> associated Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): supplicant interface state: associated -> 4-way handshake Sep 09 21:12:53 thinker wpa_supplicant[1109]: wlan0: WPA: Key negotiation completed with 60:a4:4c:29:0a:24 [PTK=CCMP GTK=CCMP] Sep 09 21:12:53 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-CONNECTED - Connection to 60:a4:4c:29:0a:24 completed [id=0 id_str=] Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): supplicant interface state: 4-way handshake -> completed Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'thismuch5'. Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) Sep 09 21:12:53 thinker NetworkManager[784]: dhclient started with pid 2341 Sep 09 21:12:53 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. Sep 09 21:12:53 thinker NetworkManager[784]: (wlan0): DHCPv4 state changed nbi -> preinit Sep 09 21:12:53 thinker dhclient[2341]: DHCPREQUEST of 192.168.1.98 on wlan0 to 255.255.255.255 port 67 (xid=0x129e78c0) Sep 09 21:12:56 thinker dhclient[2341]: DHCPREQUEST of 192.168.1.98 on wlan0 to 255.255.255.255 port 67 (xid=0x129e78c0) Sep 09 21:12:56 thinker dhclient[2341]: DHCPACK of 192.168.1.98 from 192.168.1.1 Sep 09 21:12:56 thinker NetworkManager[784]: (wlan0): DHCPv4 state changed preinit -> reboot Sep 09 21:12:56 thinker NetworkManager[784]: address 192.168.1.98 Sep 09 21:12:56 thinker NetworkManager[784]: plen 24 (255.255.255.0) Sep 09 21:12:56 thinker NetworkManager[784]: gateway 192.168.1.1 Sep 09 21:12:56 thinker NetworkManager[784]: server identifier 192.168.1.1 Sep 09 21:12:56 thinker NetworkManager[784]: lease time 86400 Sep 09 21:12:56 thinker NetworkManager[784]: hostname 'thinker' Sep 09 21:12:56 thinker NetworkManager[784]: nameserver '192.168.1.1' Sep 09 21:12:56 thinker NetworkManager[784]: domain name 'thismuch.net' Sep 09 21:12:56 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled... Sep 09 21:12:56 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started... Sep 09 21:12:56 thinker NetworkManager[784]: (wlan0): device state change: ip-config -> ip-check (reason 'none') [70 80 0] Sep 09 21:12:56 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete. Sep 09 21:12:56 thinker NetworkManager[784]: (wlan0): device state change: ip-check -> secondaries (reason 'none') [80 90 0] Sep 09 21:12:56 thinker NetworkManager[784]: (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0] Sep 09 21:12:56 thinker NetworkManager[784]: NetworkManager state is now CONNECTED_LOCAL Sep 09 21:12:56 thinker dhclient[2341]: bound to 192.168.1.98 -- renewal in 40012 seconds. Sep 09 21:12:56 thinker NetworkManager[784]: NetworkManager state is now CONNECTED_GLOBAL Sep 09 21:12:56 thinker NetworkManager[784]: Policy set 'thismuch5' (wlan0) as default for IPv4 routing and DNS. Sep 09 21:12:56 thinker NetworkManager[784]: Writing DNS information to /sbin/resolvconf Sep 09 21:12:56 thinker NetworkManager[784]: Activation (wlan0) successful, device activated. Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:14 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:27 thinker NetworkManager[784]: sleep requested (sleeping: no enabled: yes) Sep 09 21:13:27 thinker NetworkManager[784]: sleeping... Sep 09 21:13:27 thinker NetworkManager[784]: (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37] Sep 09 21:13:27 thinker NetworkManager[784]: (wlan0): deactivating device (reason 'sleeping') [37] Sep 09 21:13:27 thinker NetworkManager[784]: (wlan0): canceled DHCP transaction, DHCP client pid 2341 Sep 09 21:13:27 thinker kernel: wlan0: deauthenticating from 60:a4:4c:29:0a:24 by local choice (Reason: 3=DEAUTH_LEAVING) Sep 09 21:13:27 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-DISCONNECTED bssid=60:a4:4c:29:0a:24 reason=3 locally_generated=1 Sep 09 21:13:27 thinker NetworkManager[784]: Writing DNS information to /sbin/resolvconf Sep 09 21:13:27 thinker kernel: cfg80211: Calling CRDA to update world regulatory domain Sep 09 21:13:27 thinker kernel: cfg80211: World regulatory domain updated: Sep 09 21:13:27 thinker kernel: cfg80211: DFS Master region: unset Sep 09 21:13:27 thinker kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Sep 09 21:13:27 thinker kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:13:27 thinker kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:13:27 thinker kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:13:27 thinker kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Sep 09 21:13:27 thinker kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Sep 09 21:13:27 thinker kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Sep 09 21:13:27 thinker kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Sep 09 21:13:27 thinker kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Sep 09 21:13:27 thinker NetworkManager[784]: NetworkManager state is now ASLEEP Sep 09 21:13:27 thinker kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready Sep 09 21:13:28 thinker kernel: PM: Syncing filesystems ... done. Sep 09 21:13:28 thinker kernel: PM: Preparing system for mem sleep Sep 09 21:13:47 thinker kernel: Freezing user space processes ... (elapsed 0.001 seconds) done. Sep 09 21:13:47 thinker kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. Sep 09 21:13:47 thinker kernel: PM: Entering mem sleep Sep 09 21:13:47 thinker kernel: Suspending console(s) (use no_console_suspend to debug) Sep 09 21:13:47 thinker kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Sep 09 21:13:47 thinker kernel: sd 0:0:0:0: [sda] Stopping disk Sep 09 21:13:47 thinker kernel: e1000e: EEE TX LPI TIMER: 00000011 Sep 09 21:13:47 thinker kernel: PM: suspend of devices complete after 810.915 msecs Sep 09 21:13:47 thinker kernel: PM: late suspend of devices complete after 13.916 msecs Sep 09 21:13:47 thinker kernel: ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI Sep 09 21:13:47 thinker kernel: ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI Sep 09 21:13:47 thinker kernel: e1000e 0000:00:19.0: System wakeup enabled by ACPI Sep 09 21:13:47 thinker kernel: PM: noirq suspend of devices complete after 16.022 msecs Sep 09 21:13:47 thinker kernel: ACPI: Preparing to enter system sleep state S3 Sep 09 21:13:47 thinker kernel: PM: Saving platform NVS memory Sep 09 21:13:47 thinker kernel: Disabling non-boot CPUs ... Sep 09 21:13:47 thinker kernel: intel_pstate CPU 1 exiting Sep 09 21:13:47 thinker kernel: kvm: disabling virtualization on CPU1 Sep 09 21:13:47 thinker kernel: smpboot: CPU 1 is now offline Sep 09 21:13:47 thinker kernel: intel_pstate CPU 2 exiting Sep 09 21:13:47 thinker kernel: kvm: disabling virtualization on CPU2 Sep 09 21:13:47 thinker kernel: smpboot: CPU 2 is now offline Sep 09 21:13:47 thinker kernel: intel_pstate CPU 3 exiting Sep 09 21:13:47 thinker kernel: Broke affinity for irq 16 Sep 09 21:13:47 thinker kernel: kvm: disabling virtualization on CPU3 Sep 09 21:13:47 thinker kernel: smpboot: CPU 3 is now offline Sep 09 21:13:47 thinker kernel: intel_pstate CPU 4 exiting Sep 09 21:13:47 thinker kernel: kvm: disabling virtualization on CPU4 Sep 09 21:13:47 thinker kernel: smpboot: CPU 4 is now offline Sep 09 21:13:47 thinker kernel: intel_pstate CPU 5 exiting Sep 09 21:13:47 thinker kernel: kvm: disabling virtualization on CPU5 Sep 09 21:13:47 thinker kernel: smpboot: CPU 5 is now offline Sep 09 21:13:47 thinker kernel: intel_pstate CPU 6 exiting Sep 09 21:13:47 thinker kernel: kvm: disabling virtualization on CPU6 Sep 09 21:13:47 thinker kernel: smpboot: CPU 6 is now offline Sep 09 21:13:47 thinker kernel: intel_pstate CPU 7 exiting Sep 09 21:13:47 thinker kernel: kvm: disabling virtualization on CPU7 Sep 09 21:13:47 thinker kernel: smpboot: CPU 7 is now offline Sep 09 21:13:47 thinker kernel: ACPI: Low-level resume complete Sep 09 21:13:47 thinker kernel: PM: Restoring platform NVS memory Sep 09 21:13:47 thinker kernel: CPU0 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:13:47 thinker kernel: Enabling non-boot CPUs ... Sep 09 21:13:47 thinker kernel: x86: Booting SMP configuration: Sep 09 21:13:47 thinker kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1 Sep 09 21:13:47 thinker kernel: Disabled fast string operations Sep 09 21:13:47 thinker kernel: kvm: enabling virtualization on CPU1 Sep 09 21:13:47 thinker kernel: CPU1 is up Sep 09 21:13:47 thinker kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2 Sep 09 21:13:47 thinker kernel: CPU2 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:13:47 thinker kernel: Disabled fast string operations Sep 09 21:13:47 thinker kernel: kvm: enabling virtualization on CPU2 Sep 09 21:13:47 thinker kernel: CPU2 is up Sep 09 21:13:47 thinker kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3 Sep 09 21:13:47 thinker kernel: Disabled fast string operations Sep 09 21:13:47 thinker kernel: kvm: enabling virtualization on CPU3 Sep 09 21:13:47 thinker kernel: CPU3 is up Sep 09 21:13:47 thinker kernel: smpboot: Booting Node 0 Processor 4 APIC 0x4 Sep 09 21:13:47 thinker kernel: CPU4 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:13:47 thinker kernel: Disabled fast string operations Sep 09 21:13:47 thinker kernel: kvm: enabling virtualization on CPU4 Sep 09 21:13:47 thinker kernel: CPU4 is up Sep 09 21:13:47 thinker kernel: smpboot: Booting Node 0 Processor 5 APIC 0x5 Sep 09 21:13:47 thinker kernel: Disabled fast string operations Sep 09 21:13:47 thinker kernel: kvm: enabling virtualization on CPU5 Sep 09 21:13:47 thinker kernel: CPU5 is up Sep 09 21:13:47 thinker kernel: smpboot: Booting Node 0 Processor 6 APIC 0x6 Sep 09 21:13:47 thinker kernel: CPU6 microcode updated early to revision 0x29, date = 2013-06-12 Sep 09 21:13:47 thinker kernel: Disabled fast string operations Sep 09 21:13:47 thinker kernel: kvm: enabling virtualization on CPU6 Sep 09 21:13:47 thinker kernel: CPU6 is up Sep 09 21:13:47 thinker kernel: smpboot: Booting Node 0 Processor 7 APIC 0x7 Sep 09 21:13:47 thinker kernel: Disabled fast string operations Sep 09 21:13:47 thinker kernel: kvm: enabling virtualization on CPU7 Sep 09 21:13:47 thinker kernel: CPU7 is up Sep 09 21:13:47 thinker kernel: ACPI: Waking up from system sleep state S3 Sep 09 21:13:47 thinker kernel: ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI Sep 09 21:13:47 thinker kernel: ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI Sep 09 21:13:47 thinker kernel: sdhci-pci 0000:0d:00.0: MMC controller base frequency changed to 50Mhz. Sep 09 21:13:47 thinker kernel: PM: noirq resume of devices complete after 19.624 msecs Sep 09 21:13:47 thinker kernel: PM: early resume of devices complete after 0.316 msecs Sep 09 21:13:47 thinker kernel: e1000e 0000:00:19.0: System wakeup disabled by ACPI Sep 09 21:13:47 thinker kernel: rtc_cmos 00:02: System wakeup disabled by ACPI Sep 09 21:13:47 thinker kernel: sd 0:0:0:0: [sda] Starting disk Sep 09 21:13:47 thinker kernel: tpm_tis 00:05: TPM is disabled/deactivated (0x6) Sep 09 21:13:47 thinker kernel: usb 1-1.5: reset high-speed USB device number 5 using ehci-pci Sep 09 21:13:47 thinker kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 09 21:13:47 thinker kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) Sep 09 21:13:47 thinker kernel: ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 09 21:13:47 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:13:47 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:13:47 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:13:47 thinker kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded Sep 09 21:13:47 thinker kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Sep 09 21:13:47 thinker kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:13:47 thinker kernel: ata1.00: configured for UDMA/133 Sep 09 21:13:47 thinker kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 09 21:13:47 thinker kernel: usb 1-1.4: reset full-speed USB device number 4 using ehci-pci Sep 09 21:13:47 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:13:47 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:13:47 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:13:47 thinker kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded Sep 09 21:13:47 thinker kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded Sep 09 21:13:47 thinker kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out Sep 09 21:13:47 thinker kernel: ata2.00: configured for UDMA/66 Sep 09 21:13:47 thinker kernel: firewire_core 0000:0d:00.3: rediscovered device fw0 Sep 09 21:13:47 thinker kernel: usb 1-1.6: reset high-speed USB device number 6 using ehci-pci Sep 09 21:13:47 thinker kernel: usb 1-1.2: reset full-speed USB device number 3 using ehci-pci Sep 09 21:13:47 thinker kernel: psmouse serio1: synaptics: queried max coordinates: x [..5888], y [..4820] Sep 09 21:13:47 thinker kernel: PM: resume of devices complete after 888.992 msecs Sep 09 21:13:47 thinker kernel: PM: Finishing wakeup. Sep 09 21:13:47 thinker kernel: Restarting tasks ... done. Sep 09 21:13:47 thinker kernel: usb 1-1.5.4: USB disconnect, device number 12 Sep 09 21:13:47 thinker kernel: video LNXVIDEO:00: Restoring backlight state Sep 09 21:13:47 thinker kernel: video LNXVIDEO:01: Restoring backlight state Sep 09 21:13:48 thinker NetworkManager[784]: wake requested (sleeping: yes enabled: yes) Sep 09 21:13:48 thinker NetworkManager[784]: waking up... Sep 09 21:13:48 thinker NetworkManager[784]: (eth0): device state change: unavailable -> unmanaged (reason 'sleeping') [20 10 37] Sep 09 21:13:48 thinker NetworkManager[784]: (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 09 21:13:48 thinker kernel: e1000e: eth0 NIC Link is Down Sep 09 21:13:48 thinker kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: new full-speed USB device number 13 using ehci-pci Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: config 1 has an invalid interface number: 4 but max is 3 Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: config 1 has no interface number 3 Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: New USB device found, idVendor=1210, idProduct=000a Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: Product: Lexicon Alpha Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: Manufacturer: Lexicon Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: 1:2: cannot get freq at ep 0x1 Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:48 thinker kernel: usb 1-1.5.4: 2:2: cannot get freq at ep 0x82 Sep 09 21:13:48 thinker NetworkManager[784]: (eth0): preparing device Sep 09 21:13:48 thinker NetworkManager[784]: (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Sep 09 21:13:48 thinker kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Disabled Sep 09 21:13:48 thinker kernel: iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0 Sep 09 21:13:48 thinker kernel: iwlwifi 0000:03:00.0: L1 Enabled - LTR Disabled Sep 09 21:13:48 thinker kernel: iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0 Sep 09 21:13:48 thinker NetworkManager[784]: (wlan0): preparing device Sep 09 21:13:48 thinker NetworkManager[784]: NetworkManager state is now DISCONNECTED Sep 09 21:13:48 thinker wpa_supplicant[1109]: dbus: wpa_dbus_get_object_properties: failed to get object properties: (none) none Sep 09 21:13:48 thinker wpa_supplicant[1109]: dbus: Failed to construct signal Sep 09 21:13:48 thinker NetworkManager[784]: could not get interface properties: No readable properties in this interface. Sep 09 21:13:48 thinker NetworkManager[784]: (wlan0): supplicant interface state: starting -> ready Sep 09 21:13:48 thinker NetworkManager[784]: (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] Sep 09 21:13:48 thinker NetworkManager[784]: could not get interface properties: No readable properties in this interface. Sep 09 21:13:48 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-SCAN-STARTED Sep 09 21:13:51 thinker NetworkManager[784]: Auto-activating connection 'thismuch5'. Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) starting connection 'thismuch5' Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 09 21:13:51 thinker NetworkManager[784]: NetworkManager state is now CONNECTING Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0/wireless): access point 'thismuch5' has security, but secrets are required. Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0] Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) started... Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0] Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) starting... Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0/wireless): connection 'thismuch5' has security, and secrets exist. No new secrets needed. Sep 09 21:13:51 thinker NetworkManager[784]: Config: added 'ssid' value 'thismuch5' Sep 09 21:13:51 thinker NetworkManager[784]: Config: added 'scan_ssid' value '1' Sep 09 21:13:51 thinker NetworkManager[784]: Config: added 'key_mgmt' value 'WPA-PSK' Sep 09 21:13:51 thinker NetworkManager[784]: Config: added 'auth_alg' value 'OPEN' Sep 09 21:13:51 thinker NetworkManager[784]: Config: added 'psk' value '' Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 2 of 5 (Device Configure) complete. Sep 09 21:13:51 thinker NetworkManager[784]: Config: set interface ap_scan to 1 Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): supplicant interface state: ready -> inactive Sep 09 21:13:51 thinker wpa_supplicant[1109]: wlan0: SME: Trying to authenticate with 60:a4:4c:29:0a:24 (SSID='thismuch5' freq=5745 MHz) Sep 09 21:13:51 thinker kernel: wlan0: authenticate with 60:a4:4c:29:0a:24 Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): supplicant interface state: inactive -> authenticating Sep 09 21:13:51 thinker kernel: wlan0: send auth to 60:a4:4c:29:0a:24 (try 1/3) Sep 09 21:13:51 thinker wpa_supplicant[1109]: wlan0: Trying to associate with 60:a4:4c:29:0a:24 (SSID='thismuch5' freq=5745 MHz) Sep 09 21:13:51 thinker kernel: wlan0: authenticated Sep 09 21:13:51 thinker kernel: wlan0: associate with 60:a4:4c:29:0a:24 (try 1/3) Sep 09 21:13:51 thinker wpa_supplicant[1109]: wlan0: Associated with 60:a4:4c:29:0a:24 Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): supplicant interface state: authenticating -> associating Sep 09 21:13:51 thinker kernel: wlan0: RX AssocResp from 60:a4:4c:29:0a:24 (capab=0x11 status=0 aid=3) Sep 09 21:13:51 thinker kernel: wlan0: associated Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): supplicant interface state: associating -> associated Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): supplicant interface state: associated -> 4-way handshake Sep 09 21:13:51 thinker wpa_supplicant[1109]: wlan0: WPA: Key negotiation completed with 60:a4:4c:29:0a:24 [PTK=CCMP GTK=CCMP] Sep 09 21:13:51 thinker wpa_supplicant[1109]: wlan0: CTRL-EVENT-CONNECTED - Connection to 60:a4:4c:29:0a:24 completed [id=0 id_str=] Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): supplicant interface state: 4-way handshake -> completed Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'thismuch5'. Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) Sep 09 21:13:51 thinker NetworkManager[784]: dhclient started with pid 2911 Sep 09 21:13:51 thinker NetworkManager[784]: Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. Sep 09 21:13:51 thinker NetworkManager[784]: (wlan0): DHCPv4 state changed nbi -> preinit Sep 09 21:13:51 thinker dhclient[2911]: DHCPREQUEST of 192.168.1.98 on wlan0 to 255.255.255.255 port 67 (xid=0x1b38babb) Sep 09 21:13:54 thinker dhclient[2911]: DHCPREQUEST of 192.168.1.98 on wlan0 to 255.255.255.255 port 67 (xid=0x1b38babb) Sep 09 21:13:54 thinker dhclient[2911]: DHCPACK of 192.168.1.98 from 192.168.1.1 Sep 09 21:13:54 thinker NetworkManager[784]: (wlan0): DHCPv4 state changed preinit -> reboot Sep 09 21:13:54 thinker NetworkManager[784]: address 192.168.1.98 Sep 09 21:13:54 thinker NetworkManager[784]: plen 24 (255.255.255.0) Sep 09 21:13:54 thinker NetworkManager[784]: gateway 192.168.1.1 Sep 09 21:13:54 thinker NetworkManager[784]: server identifier 192.168.1.1 Sep 09 21:13:54 thinker NetworkManager[784]: lease time 86400 Sep 09 21:13:54 thinker NetworkManager[784]: hostname 'thinker' Sep 09 21:13:54 thinker NetworkManager[784]: nameserver '192.168.1.1' Sep 09 21:13:54 thinker NetworkManager[784]: domain name 'thismuch.net' Sep 09 21:13:54 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled... Sep 09 21:13:54 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started... Sep 09 21:13:54 thinker NetworkManager[784]: (wlan0): device state change: ip-config -> ip-check (reason 'none') [70 80 0] Sep 09 21:13:54 thinker NetworkManager[784]: Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete. Sep 09 21:13:54 thinker NetworkManager[784]: (wlan0): device state change: ip-check -> secondaries (reason 'none') [80 90 0] Sep 09 21:13:54 thinker NetworkManager[784]: (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0] Sep 09 21:13:54 thinker NetworkManager[784]: NetworkManager state is now CONNECTED_LOCAL Sep 09 21:13:54 thinker dhclient[2911]: bound to 192.168.1.98 -- renewal in 36938 seconds. Sep 09 21:13:54 thinker NetworkManager[784]: NetworkManager state is now CONNECTED_GLOBAL Sep 09 21:13:54 thinker NetworkManager[784]: Policy set 'thismuch5' (wlan0) as default for IPv4 routing and DNS. Sep 09 21:13:54 thinker NetworkManager[784]: Writing DNS information to /sbin/resolvconf Sep 09 21:13:55 thinker NetworkManager[784]: Activation (wlan0) successful, device activated. Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:55 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:56 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:56 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:13:56 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:13:56 thinker kernel: usb 1-1.5.4: 2:1: cannot get freq at ep 0x82 Sep 09 21:18:40 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:18:40 thinker kernel: usb 1-1.5.4: 1:1: cannot get freq at ep 0x1 Sep 09 21:19:01 thinker NetworkManager[784]: Starting VPN service 'openvpn'... Sep 09 21:19:01 thinker NetworkManager[784]: VPN service 'openvpn' started (org.freedesktop.NetworkManager.openvpn), PID 4346 Sep 09 21:19:01 thinker NetworkManager[784]: VPN service 'openvpn' appeared; activating connections Sep 09 21:19:02 thinker NetworkManager[784]: VPN plugin state changed: starting (3) Sep 09 21:19:02 thinker NetworkManager[784]: nm-openvpn-Message: openvpn started with pid 4351 Sep 09 21:19:02 thinker NetworkManager[784]: VPN connection 'Forte' (ConnectInteractive) reply received. Sep 09 21:19:05 thinker NetworkManager[784]: nm_device_get_device_type: assertion 'NM_IS_DEVICE (self)' failed Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): carrier is OFF Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): new Tun device (driver: 'unknown' ifindex: 4) Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): exported as /org/freedesktop/NetworkManager/Devices/3 Sep 09 21:19:05 thinker NetworkManager[784]: devices added (path: /sys/devices/virtual/net/tun0, iface: tun0) Sep 09 21:19:05 thinker NetworkManager[784]: device added (path: /sys/devices/virtual/net/tun0, iface: tun0): no ifupdown configuration found. Sep 09 21:19:05 thinker NetworkManager[784]: VPN connection 'Forte' (IP Config Get) reply received. Sep 09 21:19:05 thinker NetworkManager[784]: VPN connection 'Forte' (IP4 Config Get) reply received. Sep 09 21:19:05 thinker NetworkManager[784]: VPN Gateway: 71.87.10.194 Sep 09 21:19:05 thinker NetworkManager[784]: Tunnel Device: tun0 Sep 09 21:19:05 thinker NetworkManager[784]: IPv4 configuration: Sep 09 21:19:05 thinker NetworkManager[784]: Internal Gateway: 192.168.246.101 Sep 09 21:19:05 thinker NetworkManager[784]: Internal Address: 192.168.246.102 Sep 09 21:19:05 thinker NetworkManager[784]: Internal Prefix: 32 Sep 09 21:19:05 thinker NetworkManager[784]: Internal Point-to-Point Address: 192.168.246.101 Sep 09 21:19:05 thinker NetworkManager[784]: Maximum Segment Size (MSS): 0 Sep 09 21:19:05 thinker NetworkManager[784]: Static Route: 172.16.0.0/23 Next Hop: 192.168.246.101 Sep 09 21:19:05 thinker NetworkManager[784]: Static Route: 172.16.2.0/23 Next Hop: 192.168.246.101 Sep 09 21:19:05 thinker NetworkManager[784]: Static Route: 172.16.6.0/23 Next Hop: 192.168.246.101 Sep 09 21:19:05 thinker NetworkManager[784]: Static Route: 192.168.20.0/24 Next Hop: 192.168.246.101 Sep 09 21:19:05 thinker NetworkManager[784]: Static Route: 23.253.177.19/32 Next Hop: 192.168.246.101 Sep 09 21:19:05 thinker NetworkManager[784]: Static Route: 192.168.246.1/32 Next Hop: 192.168.246.101 Sep 09 21:19:05 thinker NetworkManager[784]: Forbid Default Route: yes Sep 09 21:19:05 thinker NetworkManager[784]: Internal DNS: 172.16.0.20 Sep 09 21:19:05 thinker NetworkManager[784]: Internal DNS: 172.16.0.21 Sep 09 21:19:05 thinker NetworkManager[784]: DNS Domain: 'forteresearch.com' Sep 09 21:19:05 thinker NetworkManager[784]: No IPv6 configuration Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): link connected Sep 09 21:19:05 thinker NetworkManager[784]: VPN connection 'Forte' (IP Config Get) complete. Sep 09 21:19:05 thinker NetworkManager[784]: VPN plugin state changed: started (4) Sep 09 21:19:05 thinker NetworkManager[784]: Writing DNS information to /sbin/resolvconf Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): device state change: unmanaged -> unavailable (reason 'connection-assumed') [10 20 41] Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): device state change: unavailable -> disconnected (reason 'connection-assumed') [20 30 41] Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) starting connection 'tun0' Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 1 of 5 (Device Prepare) scheduled... Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 1 of 5 (Device Prepare) started... Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): device state change: disconnected -> prepare (reason 'none') [30 40 0] Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 2 of 5 (Device Configure) scheduled... Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 1 of 5 (Device Prepare) complete. Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 2 of 5 (Device Configure) starting... Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): device state change: prepare -> config (reason 'none') [40 50 0] Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 2 of 5 (Device Configure) successful. Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 3 of 5 (IP Configure Start) scheduled. Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 2 of 5 (Device Configure) complete. Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 3 of 5 (IP Configure Start) started... Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): device state change: config -> ip-config (reason 'none') [50 70 0] Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 5 of 5 (IPv4 Configure Commit) scheduled... Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 3 of 5 (IP Configure Start) complete. Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 5 of 5 (IPv4 Commit) started... Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): device state change: ip-config -> ip-check (reason 'none') [70 80 0] Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) Stage 5 of 5 (IPv4 Commit) complete. Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): device state change: ip-check -> secondaries (reason 'none') [80 90 0] Sep 09 21:19:05 thinker NetworkManager[784]: (tun0): device state change: secondaries -> activated (reason 'none') [90 100 0] Sep 09 21:19:05 thinker NetworkManager[784]: Activation (tun0) successful, device activated.